builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0263 starttime: 1467923990.8 results: success (0) buildid: 20160707105522 builduid: 80f48615b4a74cf39f5d06b6be577303 revision: 8be08b36d5d8ba576aca59a1994ddbdaed116d74 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 13:39:50.805188) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 13:39:50.805605) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 13:39:50.805896) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 13:39:50.829884) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 13:39:50.830147) ========= 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.VbohmCL0WJ/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.HLkaDJSNOv/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-07 13:39:50-- 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% 25.4M=0s 2016-07-07 13:39:50 (25.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123154 ========= master_lag: 0.93 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 13:39:51.879418) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 13:39:51.879748) ========= 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.VbohmCL0WJ/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.HLkaDJSNOv/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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.026483 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 13:39:51.926471) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 13:39:51.927256) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8be08b36d5d8ba576aca59a1994ddbdaed116d74 --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 8be08b36d5d8ba576aca59a1994ddbdaed116d74 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VbohmCL0WJ/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.HLkaDJSNOv/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-07 13:39:52,006 truncating revision to first 12 chars 2016-07-07 13:39:52,006 Setting DEBUG logging. 2016-07-07 13:39:52,006 attempt 1/10 2016-07-07 13:39:52,006 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8be08b36d5d8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 13:39:53,588 unpacking tar archive at: fx-team-8be08b36d5d8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.856951 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 13:39:53.807074) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 13:39:53.807422) ========= script_repo_revision: 8be08b36d5d8ba576aca59a1994ddbdaed116d74 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 13:39:53.807906) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 13:39:53.808251) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 13:39:53.827828) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-07-07 13:39:53.828458) ========= /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.VbohmCL0WJ/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.HLkaDJSNOv/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 13:39:54 INFO - MultiFileLogger online at 20160707 13:39:54 in /builds/slave/test 13:39:54 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 13:39:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:39:54 INFO - {'append_to_log': False, 13:39:54 INFO - 'base_work_dir': '/builds/slave/test', 13:39:54 INFO - 'blob_upload_branch': 'Fx-Team', 13:39:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:39:54 INFO - 'branch': 'Fx-Team', 13:39:54 INFO - 'buildbot_json_path': 'buildprops.json', 13:39:54 INFO - 'config_files': ('talos/mac_config.py',), 13:39:54 INFO - 'default_actions': ('clobber', 13:39:54 INFO - 'read-buildbot-config', 13:39:54 INFO - 'download-and-extract', 13:39:54 INFO - 'populate-webroot', 13:39:54 INFO - 'create-virtualenv', 13:39:54 INFO - 'install', 13:39:54 INFO - 'run-tests'), 13:39:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:39:54 INFO - 'download_minidump_stackwalk': True, 13:39:54 INFO - 'download_symbols': 'ondemand', 13:39:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:39:54 INFO - 'tooltool.py': '/tools/tooltool.py', 13:39:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:39:54 INFO - '/tools/misc-python/virtualenv.py')}, 13:39:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:39:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:39:54 INFO - 'installer_path': 'installer.exe', 13:39:54 INFO - 'log_level': 'info', 13:39:54 INFO - 'log_name': 'talos', 13:39:54 INFO - 'log_to_console': True, 13:39:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:39:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:39:54 INFO - 'opt_config_files': (), 13:39:54 INFO - 'pip_index': False, 13:39:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:39:54 INFO - 'cmd': ('bash', 13:39:54 INFO - '-c', 13:39:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:39:54 INFO - 'enabled': True, 13:39:54 INFO - 'halt_on_failure': False, 13:39:54 INFO - 'name': 'check_screen_resolution'},), 13:39:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:39:54 INFO - 'cmd': ('bash', 13:39:54 INFO - '-c', 13:39:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:39:54 INFO - 'enabled': True, 13:39:54 INFO - 'halt_on_failure': False, 13:39:54 INFO - 'name': 'check_screen_resolution'},), 13:39:54 INFO - 'run_cmd_checks_enabled': True, 13:39:54 INFO - 'sps_profile': False, 13:39:54 INFO - 'sps_profile_interval': 0, 13:39:54 INFO - 'suite': 'dromaeojs', 13:39:54 INFO - 'system_bits': '32', 13:39:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:39:54 INFO - 'title': 't-yosemite-r7-0263', 13:39:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:39:54 INFO - 'use_talos_json': True, 13:39:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:39:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:39:54 INFO - 'work_dir': 'build'} 13:39:54 INFO - ##### 13:39:54 INFO - ##### Running clobber step. 13:39:54 INFO - ##### 13:39:54 INFO - Running pre-action listener: _resource_record_pre_action 13:39:54 INFO - Running main action method: clobber 13:39:54 INFO - rmtree: /builds/slave/test/build 13:39:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:39:55 INFO - Running post-action listener: _resource_record_post_action 13:39:55 INFO - ##### 13:39:55 INFO - ##### Finished clobber step (success) 13:39:55 INFO - ##### 13:39:55 INFO - ##### 13:39:55 INFO - ##### Running read-buildbot-config step. 13:39:55 INFO - ##### 13:39:55 INFO - Running pre-action listener: _resource_record_pre_action 13:39:55 INFO - Running main action method: read_buildbot_config 13:39:55 INFO - Using buildbot properties: 13:39:55 INFO - { 13:39:55 INFO - "project": "", 13:39:55 INFO - "product": "firefox", 13:39:55 INFO - "script_repo_revision": "production", 13:39:55 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 13:39:55 INFO - "repository": "", 13:39:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 13:39:55 INFO - "buildid": "20160707105522", 13:39:55 INFO - "pgo_build": "False", 13:39:55 INFO - "basedir": "/builds/slave/test", 13:39:55 INFO - "buildnumber": 82, 13:39:55 INFO - "slavename": "t-yosemite-r7-0263", 13:39:55 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 13:39:55 INFO - "platform": "yosemite_r7", 13:39:55 INFO - "scheduler": "tests-fx-team-macosx64-talos", 13:39:55 INFO - "branch": "fx-team", 13:39:55 INFO - "repo_path": "integration/fx-team", 13:39:55 INFO - "revision": "8be08b36d5d8ba576aca59a1994ddbdaed116d74", 13:39:55 INFO - "stage_platform": "macosx64", 13:39:55 INFO - "builduid": "80f48615b4a74cf39f5d06b6be577303", 13:39:55 INFO - "slavebuilddir": "test" 13:39:55 INFO - } 13:39:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 13:39:55 INFO - Running post-action listener: _resource_record_post_action 13:39:55 INFO - ##### 13:39:55 INFO - ##### Finished read-buildbot-config step (success) 13:39:55 INFO - ##### 13:39:55 INFO - ##### 13:39:55 INFO - ##### Running download-and-extract step. 13:39:55 INFO - ##### 13:39:55 INFO - Running pre-action listener: _resource_record_pre_action 13:39:55 INFO - Running main action method: download_and_extract 13:39:55 INFO - mkdir: /builds/slave/test/build/tests 13:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:39:55 INFO - https://queue.taskcluster.net/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:39:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 13:39:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 13:39:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 13:39:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 13:39:57 INFO - Downloaded 1199 bytes. 13:39:57 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 13:39:57 INFO - Using the following test package requirements: 13:39:57 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 13:39:57 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:39:57 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 13:39:57 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:39:57 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 13:39:57 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:39:57 INFO - u'jsshell-mac.zip'], 13:39:57 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:39:57 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 13:39:57 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 13:39:57 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:39:57 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 13:39:57 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:39:57 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 13:39:57 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:39:57 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 13:39:57 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:39:57 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 13:39:57 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:39:57 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')]} 13:39:57 INFO - https://queue.taskcluster.net/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:39:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:39:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:39:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:39:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:39:58 INFO - Downloaded 18806294 bytes. 13:39:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:39:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:40:01 INFO - Return code: 0 13:40:01 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:40:01 INFO - https://queue.taskcluster.net/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:40:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:40:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:40:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:40:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:40:04 INFO - Downloaded 18806294 bytes. 13:40:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:40:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:40:08 INFO - Return code: 0 13:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:40:08 INFO - https://queue.taskcluster.net/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:40:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 13:40:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 13:40:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 13:40:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:40:09 INFO - Downloaded 14403333 bytes. 13:40:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:40:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 13:40:09 INFO - Return code: 0 13:40:09 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')]} 13:40:09 INFO - https://queue.taskcluster.net/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 13:40:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:40:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:40:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 13:40:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 13:40:12 INFO - Downloaded 112425023 bytes. 13:40:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:40:12 INFO - mkdir: /builds/slave/test/properties 13:40:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:40:12 INFO - Writing to file /builds/slave/test/properties/build_url 13:40:12 INFO - Contents: 13:40:12 INFO - build_url:https://queue.taskcluster.net/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:40:14 INFO - Running post-action listener: _resource_record_post_action 13:40:14 INFO - Running post-action listener: set_extra_try_arguments 13:40:14 INFO - ##### 13:40:14 INFO - ##### Finished download-and-extract step (success) 13:40:14 INFO - ##### 13:40:14 INFO - ##### 13:40:14 INFO - ##### Running populate-webroot step. 13:40:14 INFO - ##### 13:40:14 INFO - Running pre-action listener: _resource_record_pre_action 13:40:14 INFO - Running main action method: populate_webroot 13:40:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:40:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:40:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:40:14 INFO - '--tppagecycles', 13:40:14 INFO - '7'], 13:40:14 INFO - 'tests': ['tsvgm']}}, 13:40:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:40:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:40:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:40:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:40:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:40:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:40:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:40:14 INFO - 'talos_options': ['--disable-e10s'], 13:40:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:40:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:40:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:40:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:40:14 INFO - 'talos_options': ['--disable-e10s'], 13:40:14 INFO - 'tests': ['damp', 'tps']}, 13:40:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:40:14 INFO - 'tests': ['damp', 'tps']}, 13:40:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:40:14 INFO - 'tests': ['dromaeo_dom']}, 13:40:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:40:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:40:14 INFO - 'tests': ['basic_compositor_video']}, 13:40:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:40:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:40:14 INFO - 'tests': ['a11yr', 13:40:14 INFO - 'ts_paint', 13:40:14 INFO - 'tpaint', 13:40:14 INFO - 'sessionrestore', 13:40:14 INFO - 'sessionrestore_no_auto_restore', 13:40:14 INFO - 'tabpaint']}, 13:40:14 INFO - 'other-e10s': {'tests': ['a11yr', 13:40:14 INFO - 'ts_paint', 13:40:14 INFO - 'tpaint', 13:40:14 INFO - 'sessionrestore', 13:40:14 INFO - 'sessionrestore_no_auto_restore', 13:40:14 INFO - 'tabpaint']}, 13:40:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:40:14 INFO - 'ts_paint', 13:40:14 INFO - 'tpaint', 13:40:14 INFO - 'sessionrestore', 13:40:14 INFO - 'sessionrestore_no_auto_restore', 13:40:14 INFO - 'tabpaint']}, 13:40:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:40:14 INFO - 'ts_paint', 13:40:14 INFO - 'tpaint', 13:40:14 INFO - 'sessionrestore', 13:40:14 INFO - 'sessionrestore_no_auto_restore', 13:40:14 INFO - 'tabpaint']}, 13:40:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:40:14 INFO - 'tests': ['a11yr', 13:40:14 INFO - 'ts_paint', 13:40:14 INFO - 'tpaint', 13:40:14 INFO - 'sessionrestore', 13:40:14 INFO - 'sessionrestore_no_auto_restore', 13:40:14 INFO - 'tabpaint']}, 13:40:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:40:14 INFO - 'tests': ['a11yr', 13:40:14 INFO - 'ts_paint', 13:40:14 INFO - 'tpaint', 13:40:14 INFO - 'sessionrestore', 13:40:14 INFO - 'sessionrestore_no_auto_restore', 13:40:14 INFO - 'tabpaint']}, 13:40:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:40:14 INFO - 'tests': ['tsvgx', 13:40:14 INFO - 'tsvgr_opacity', 13:40:14 INFO - 'tart', 13:40:14 INFO - 'tscrollx', 13:40:14 INFO - 'cart']}, 13:40:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:40:14 INFO - 'tsvgr_opacity', 13:40:14 INFO - 'tart', 13:40:14 INFO - 'tscrollx', 13:40:14 INFO - 'cart']}, 13:40:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:40:14 INFO - 'talos_options': ['--disable-e10s'], 13:40:14 INFO - 'tests': ['tp5o']}, 13:40:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:40:14 INFO - 'tests': ['tp5o']}, 13:40:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:40:14 INFO - 'talos_options': ['--disable-e10s', 13:40:14 INFO - '--xperf_path', 13:40:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:40:14 INFO - 'tests': ['tp5n']}, 13:40:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:40:14 INFO - 'talos_options': ['--xperf_path', 13:40:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:40:14 INFO - 'tests': ['tp5n']}}, 13:40:14 INFO - 'talos.zip': {'path': '', 13:40:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:40:14 INFO - Running post-action listener: _resource_record_post_action 13:40:14 INFO - ##### 13:40:14 INFO - ##### Finished populate-webroot step (success) 13:40:14 INFO - ##### 13:40:14 INFO - ##### 13:40:14 INFO - ##### Running create-virtualenv step. 13:40:14 INFO - ##### 13:40:14 INFO - Running pre-action listener: _resource_record_pre_action 13:40:14 INFO - Running main action method: create_virtualenv 13:40:14 INFO - Creating virtualenv /builds/slave/test/build/venv 13:40:14 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 13:40:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:40:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:40:14 INFO - Using real prefix '/tools/python27' 13:40:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:40:15 INFO - Installing distribute.............................................................................................................................................................................................done. 13:40:17 INFO - Installing pip.................done. 13:40:17 INFO - Return code: 0 13:40:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:40:17 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')]} 13:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:40:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:17 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')]} 13:40:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:40:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:17 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 0x10e88fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e924618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3cac8a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7f3d30>, '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 0x10e558db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ebb20>, '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.VbohmCL0WJ/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.HLkaDJSNOv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 13:40:17 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 13:40:17 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 13:40:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VbohmCL0WJ/Render', 13:40:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:40:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:40:17 INFO - 'HOME': '/Users/cltbld', 13:40:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:40:17 INFO - 'LOGNAME': 'cltbld', 13:40:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:40:17 INFO - 'MOZ_NO_REMOTE': '1', 13:40:17 INFO - 'NO_EM_RESTART': '1', 13:40:17 INFO - 'PAGER': '/bin/cat', 13:40:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:40:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:40:17 INFO - 'PWD': '/builds/slave/test', 13:40:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:40:17 INFO - 'SHELL': '/bin/bash', 13:40:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HLkaDJSNOv/Listeners', 13:40:17 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 13:40:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:40:17 INFO - 'USER': 'cltbld', 13:40:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:40:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:40:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:40:17 INFO - 'XPC_FLAGS': '0x0', 13:40:17 INFO - 'XPC_SERVICE_NAME': '0', 13:40:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:40:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:40:18 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 13:40:18 INFO - Cleaning up... 13:40:18 INFO - Return code: 0 13:40:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:40:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:40:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:40:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:40:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e88fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e924618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3cac8a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7f3d30>, '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 0x10e558db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ebb20>, '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.VbohmCL0WJ/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.HLkaDJSNOv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 13:40:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:40:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:40:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VbohmCL0WJ/Render', 13:40:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:40:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:40:18 INFO - 'HOME': '/Users/cltbld', 13:40:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:40:18 INFO - 'LOGNAME': 'cltbld', 13:40:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:40:18 INFO - 'MOZ_NO_REMOTE': '1', 13:40:18 INFO - 'NO_EM_RESTART': '1', 13:40:18 INFO - 'PAGER': '/bin/cat', 13:40:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:40:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:40:18 INFO - 'PWD': '/builds/slave/test', 13:40:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:40:18 INFO - 'SHELL': '/bin/bash', 13:40:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HLkaDJSNOv/Listeners', 13:40:18 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 13:40:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:40:18 INFO - 'USER': 'cltbld', 13:40:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:40:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:40:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:40:18 INFO - 'XPC_FLAGS': '0x0', 13:40:18 INFO - 'XPC_SERVICE_NAME': '0', 13:40:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:40:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:40:18 INFO - Downloading/unpacking psutil>=3.1.1 13:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:40:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:40:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:40:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:40:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:40:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:40:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:40:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:40:21 INFO - Installing collected packages: psutil 13:40:21 INFO - Running setup.py install for psutil 13:40:21 INFO - building 'psutil._psutil_osx' extension 13:40:21 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 13:40:21 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 13:40:22 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 13:40:22 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 13:40:22 INFO - building 'psutil._psutil_posix' extension 13:40:22 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 13:40:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:40:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:40:22 INFO - ^ 13:40:22 INFO - 1 warning generated. 13:40:22 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 13:40:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:40:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:40:22 INFO - Successfully installed psutil 13:40:22 INFO - Cleaning up... 13:40:22 INFO - Return code: 0 13:40:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:40:22 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')]} 13:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:40:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:22 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')]} 13:40:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:40:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e88fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e924618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3cac8a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7f3d30>, '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 0x10e558db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ebb20>, '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.VbohmCL0WJ/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.HLkaDJSNOv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 13:40:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:40:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:40:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VbohmCL0WJ/Render', 13:40:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:40:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:40:22 INFO - 'HOME': '/Users/cltbld', 13:40:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:40:22 INFO - 'LOGNAME': 'cltbld', 13:40:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:40:22 INFO - 'MOZ_NO_REMOTE': '1', 13:40:22 INFO - 'NO_EM_RESTART': '1', 13:40:22 INFO - 'PAGER': '/bin/cat', 13:40:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:40:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:40:22 INFO - 'PWD': '/builds/slave/test', 13:40:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:40:22 INFO - 'SHELL': '/bin/bash', 13:40:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HLkaDJSNOv/Listeners', 13:40:22 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 13:40:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:40:22 INFO - 'USER': 'cltbld', 13:40:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:40:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:40:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:40:22 INFO - 'XPC_FLAGS': '0x0', 13:40:22 INFO - 'XPC_SERVICE_NAME': '0', 13:40:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:40:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:40:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:40: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 13:40: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 13:40: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 13:40: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 13:40: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 13:40: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 13:40:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:40:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:40:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:40:25 INFO - Installing collected packages: mozsystemmonitor 13:40:25 INFO - Running setup.py install for mozsystemmonitor 13:40:25 INFO - Successfully installed mozsystemmonitor 13:40:25 INFO - Cleaning up... 13:40:25 INFO - Return code: 0 13:40:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:40: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')]} 13:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:40:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40: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')]} 13:40:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:40:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e88fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e924618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3cac8a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7f3d30>, '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 0x10e558db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ebb20>, '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.VbohmCL0WJ/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.HLkaDJSNOv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 13:40: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==2.5.1'] in /builds/slave/test/build 13:40: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==2.5.1 13:40:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VbohmCL0WJ/Render', 13:40:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:40:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:40:25 INFO - 'HOME': '/Users/cltbld', 13:40:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:40:25 INFO - 'LOGNAME': 'cltbld', 13:40:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:40:25 INFO - 'MOZ_NO_REMOTE': '1', 13:40:25 INFO - 'NO_EM_RESTART': '1', 13:40:25 INFO - 'PAGER': '/bin/cat', 13:40:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:40:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:40:25 INFO - 'PWD': '/builds/slave/test', 13:40:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:40:25 INFO - 'SHELL': '/bin/bash', 13:40:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HLkaDJSNOv/Listeners', 13:40:25 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 13:40:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:40:25 INFO - 'USER': 'cltbld', 13:40:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:40:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:40:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:40:25 INFO - 'XPC_FLAGS': '0x0', 13:40:25 INFO - 'XPC_SERVICE_NAME': '0', 13:40:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:40:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:40:25 INFO - Downloading/unpacking jsonschema==2.5.1 13:40: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 13:40: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 13:40: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 13:40: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 13:40: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 13:40: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 13:40:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:40:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:40: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 13:40: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 13:40: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 13:40: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 13:40: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 13:40: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 13:40:28 INFO - Downloading functools32-3.2.3-2.tar.gz 13:40:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:40:28 INFO - warning: no files found matching '*.txt' 13:40:28 INFO - no previously-included directories found matching 'build' 13:40:28 INFO - no previously-included directories found matching 'dist' 13:40:28 INFO - no previously-included directories found matching '.git*' 13:40:28 INFO - Installing collected packages: jsonschema, functools32 13:40:28 INFO - Running setup.py install for functools32 13:40:28 INFO - warning: no files found matching '*.txt' 13:40:28 INFO - no previously-included directories found matching 'build' 13:40:28 INFO - no previously-included directories found matching 'dist' 13:40:28 INFO - no previously-included directories found matching '.git*' 13:40:28 INFO - Successfully installed jsonschema functools32 13:40:28 INFO - Cleaning up... 13:40:28 INFO - Return code: 0 13:40:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:40: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')]} 13:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:40:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40: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')]} 13:40:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:40:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40: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', '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 0x10e88fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e924618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3cac8a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7f3d30>, '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 0x10e558db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ebb20>, '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.VbohmCL0WJ/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.HLkaDJSNOv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 13:40: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:40: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 blobuploader==1.2.4 13:40:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VbohmCL0WJ/Render', 13:40:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:40:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:40:28 INFO - 'HOME': '/Users/cltbld', 13:40:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:40:28 INFO - 'LOGNAME': 'cltbld', 13:40:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:40:28 INFO - 'MOZ_NO_REMOTE': '1', 13:40:28 INFO - 'NO_EM_RESTART': '1', 13:40:28 INFO - 'PAGER': '/bin/cat', 13:40:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:40:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:40:28 INFO - 'PWD': '/builds/slave/test', 13:40:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:40:28 INFO - 'SHELL': '/bin/bash', 13:40:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HLkaDJSNOv/Listeners', 13:40:28 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 13:40:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:40:28 INFO - 'USER': 'cltbld', 13:40:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:40:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:40:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:40:28 INFO - 'XPC_FLAGS': '0x0', 13:40:28 INFO - 'XPC_SERVICE_NAME': '0', 13:40:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:40:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:40:29 INFO - Downloading/unpacking blobuploader==1.2.4 13:40: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 13:40: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 13:40: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 13:40: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 13:40: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 13:40: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 13:40:31 INFO - Downloading blobuploader-1.2.4.tar.gz 13:40:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:40:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:40: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 13:40: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 13:40: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 13:40: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 13:40: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 13:40: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 13:40:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:40:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:40: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 13:40: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 13:40: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 13:40: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 13:40: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 13:40: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 13:40:32 INFO - Downloading docopt-0.6.1.tar.gz 13:40:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:40:32 INFO - Installing collected packages: blobuploader, requests, docopt 13:40:32 INFO - Running setup.py install for blobuploader 13:40:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:40:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:40:33 INFO - Running setup.py install for requests 13:40:33 INFO - Running setup.py install for docopt 13:40:33 INFO - Successfully installed blobuploader requests docopt 13:40:33 INFO - Cleaning up... 13:40:33 INFO - Return code: 0 13:40:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:40:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:40:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:40:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:33 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 0x10e88fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e924618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3cac8a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7f3d30>, '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 0x10e558db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ebb20>, '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.VbohmCL0WJ/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.HLkaDJSNOv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 13:40:33 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 13:40:33 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 13:40:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VbohmCL0WJ/Render', 13:40:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:40:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:40:33 INFO - 'HOME': '/Users/cltbld', 13:40:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:40:33 INFO - 'LOGNAME': 'cltbld', 13:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:40:33 INFO - 'MOZ_NO_REMOTE': '1', 13:40:33 INFO - 'NO_EM_RESTART': '1', 13:40:33 INFO - 'PAGER': '/bin/cat', 13:40:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:40:33 INFO - 'PWD': '/builds/slave/test', 13:40:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:40:33 INFO - 'SHELL': '/bin/bash', 13:40:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HLkaDJSNOv/Listeners', 13:40:33 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 13:40:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:40:33 INFO - 'USER': 'cltbld', 13:40:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:40:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:40:33 INFO - 'XPC_FLAGS': '0x0', 13:40:33 INFO - 'XPC_SERVICE_NAME': '0', 13:40:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:40:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:40:34 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-00N8I2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:40:34 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-y62RCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:40:34 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-NCSYGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:40:34 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-4jIsrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:40:34 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-pHEibC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:40:34 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-SWkdkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:40:34 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-7n45a6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:40:34 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-EBmTrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:40:34 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-tIbr0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:40:34 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-IvBs9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:40:35 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-vnAiNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:40:35 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-YDNV3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:40:35 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-jTAjgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:40:35 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-2Kr6y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:40:35 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-6qoaMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:40:35 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-JGZwJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:40:35 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-nIglyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:40:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:40:35 INFO - Running setup.py install for manifestparser 13:40:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:40:35 INFO - Running setup.py install for mozcrash 13:40:36 INFO - Running setup.py install for mozdebug 13:40:36 INFO - Running setup.py install for mozdevice 13:40:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:40:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:40:36 INFO - Running setup.py install for mozfile 13:40:36 INFO - Running setup.py install for mozhttpd 13:40:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:40:36 INFO - Running setup.py install for mozinfo 13:40:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:40:36 INFO - Running setup.py install for mozInstall 13:40:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:40:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:40:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:40:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:40:36 INFO - Running setup.py install for mozleak 13:40:37 INFO - Running setup.py install for mozlog 13:40:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:40:37 INFO - Running setup.py install for moznetwork 13:40:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:40:37 INFO - Running setup.py install for mozprocess 13:40:37 INFO - Running setup.py install for mozprofile 13:40:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:40:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:40:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:40:37 INFO - Running setup.py install for mozrunner 13:40:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:40:37 INFO - Running setup.py install for mozscreenshot 13:40:38 INFO - Running setup.py install for moztest 13:40:38 INFO - Running setup.py install for mozversion 13:40:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:40:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:40:38 INFO - Cleaning up... 13:40:38 INFO - Return code: 0 13:40:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:40:38 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')]} 13:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:40:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:38 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')]} 13:40:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:40:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:38 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 0x10e88fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e924618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3cac8a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7f3d30>, '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 0x10e558db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ebb20>, '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.VbohmCL0WJ/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.HLkaDJSNOv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 13:40:38 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 13:40:38 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 13:40:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VbohmCL0WJ/Render', 13:40:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:40:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:40:38 INFO - 'HOME': '/Users/cltbld', 13:40:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:40:38 INFO - 'LOGNAME': 'cltbld', 13:40:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:40:38 INFO - 'MOZ_NO_REMOTE': '1', 13:40:38 INFO - 'NO_EM_RESTART': '1', 13:40:38 INFO - 'PAGER': '/bin/cat', 13:40:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:40:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:40:38 INFO - 'PWD': '/builds/slave/test', 13:40:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:40:38 INFO - 'SHELL': '/bin/bash', 13:40:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HLkaDJSNOv/Listeners', 13:40:38 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 13:40:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:40:38 INFO - 'USER': 'cltbld', 13:40:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:40:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:40:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:40:38 INFO - 'XPC_FLAGS': '0x0', 13:40:38 INFO - 'XPC_SERVICE_NAME': '0', 13:40:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:40:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:40:38 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-7G4xR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:40:38 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)) 13:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:40:38 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-bQh4S_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:40:38 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)) 13:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:40:38 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-HolWob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:40:38 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)) 13:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:40:38 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-tOJJt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:40:39 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)) 13:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:40:39 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-mnv9AS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:40:39 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)) 13:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:40:39 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-pdzAHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:40:39 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)) 13:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:40:39 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-RDOUHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:40:39 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)) 13:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:40:39 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-BkROl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:40:39 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)) 13:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:40:39 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-dXaDFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:40:39 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)) 13:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:40:39 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-cy3MQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:40:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:40:39 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-5deoWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:40:39 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)) 13:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:40:39 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-dzWS8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:40:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:40:39 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-SW20aP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:40:39 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)) 13:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:40:40 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-393XVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:40:40 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-iUuz_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:40:40 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)) 13:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:40:40 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-Wrun8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:40:40 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)) 13:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:40:40 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-cxMrBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:40:40 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)) 13:40:40 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)) 13:40:40 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)) 13:40:40 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)) 13:40:40 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)) 13:40:40 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)) 13:40:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:40:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:40:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:40:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:40:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:40:42 INFO - Downloading blessings-1.6.tar.gz 13:40:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:40:43 INFO - Installing collected packages: blessings 13:40:43 INFO - Running setup.py install for blessings 13:40:43 INFO - Successfully installed blessings 13:40:43 INFO - Cleaning up... 13:40:43 INFO - Return code: 0 13:40:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:40:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:40:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:40:43 INFO - Reading from file tmpfile_stdout 13:40:43 INFO - Current package versions: 13:40:43 INFO - blessings == 1.6 13:40:43 INFO - blobuploader == 1.2.4 13:40:43 INFO - docopt == 0.6.1 13:40:43 INFO - functools32 == 3.2.3-2 13:40:43 INFO - jsonschema == 2.5.1 13:40:43 INFO - manifestparser == 1.1 13:40:43 INFO - mozInstall == 1.12 13:40:43 INFO - mozcrash == 0.17 13:40:43 INFO - mozdebug == 0.1 13:40:43 INFO - mozdevice == 0.48 13:40:43 INFO - mozfile == 1.2 13:40:43 INFO - mozhttpd == 0.7 13:40:43 INFO - mozinfo == 0.9 13:40:43 INFO - mozleak == 0.1 13:40:43 INFO - mozlog == 3.2 13:40:43 INFO - moznetwork == 0.27 13:40:43 INFO - mozprocess == 0.23 13:40:43 INFO - mozprofile == 0.28 13:40:43 INFO - mozrunner == 6.12 13:40:43 INFO - mozscreenshot == 0.1 13:40:43 INFO - mozsystemmonitor == 0.3 13:40:43 INFO - moztest == 0.7 13:40:43 INFO - mozversion == 1.4 13:40:43 INFO - psutil == 3.1.1 13:40:43 INFO - requests == 1.2.3 13:40:43 INFO - wsgiref == 0.1.2 13:40:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:40:43 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')]} 13:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:40:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:43 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')]} 13:40:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:40:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:43 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 0x10e88fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e924618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3cac8a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7f3d30>, '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 0x10e558db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ebb20>, '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.VbohmCL0WJ/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.HLkaDJSNOv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 13:40:43 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 13:40:43 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 13:40:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VbohmCL0WJ/Render', 13:40:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:40:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:40:43 INFO - 'HOME': '/Users/cltbld', 13:40:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:40:43 INFO - 'LOGNAME': 'cltbld', 13:40:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:40:43 INFO - 'MOZ_NO_REMOTE': '1', 13:40:43 INFO - 'NO_EM_RESTART': '1', 13:40:43 INFO - 'PAGER': '/bin/cat', 13:40:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:40:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:40:43 INFO - 'PWD': '/builds/slave/test', 13:40:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:40:43 INFO - 'SHELL': '/bin/bash', 13:40:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HLkaDJSNOv/Listeners', 13:40:43 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 13:40:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:40:43 INFO - 'USER': 'cltbld', 13:40:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:40:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:40:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:40:43 INFO - 'XPC_FLAGS': '0x0', 13:40:43 INFO - 'XPC_SERVICE_NAME': '0', 13:40:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:40:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:40:43 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)) 13:40:43 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)) 13:40:43 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)) 13:40:43 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)) 13:40:43 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)) 13:40:43 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)) 13:40:43 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)) 13:40:43 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)) 13:40:43 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)) 13:40:43 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)) 13:40:43 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)) 13:40:43 INFO - Cleaning up... 13:40:43 INFO - Return code: 0 13:40:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:40:43 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')]} 13:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:40:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:43 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')]} 13:40:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:40:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:43 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 0x10e88fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e924618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3cac8a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7f3d30>, '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 0x10e558db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ebb20>, '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.VbohmCL0WJ/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.HLkaDJSNOv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 13:40:43 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 13:40:43 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 13:40:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VbohmCL0WJ/Render', 13:40:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:40:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:40:43 INFO - 'HOME': '/Users/cltbld', 13:40:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:40:43 INFO - 'LOGNAME': 'cltbld', 13:40:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:40:43 INFO - 'MOZ_NO_REMOTE': '1', 13:40:43 INFO - 'NO_EM_RESTART': '1', 13:40:43 INFO - 'PAGER': '/bin/cat', 13:40:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:40:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:40:43 INFO - 'PWD': '/builds/slave/test', 13:40:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:40:43 INFO - 'SHELL': '/bin/bash', 13:40:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HLkaDJSNOv/Listeners', 13:40:43 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 13:40:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:40:43 INFO - 'USER': 'cltbld', 13:40:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:40:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:40:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:40:43 INFO - 'XPC_FLAGS': '0x0', 13:40:43 INFO - 'XPC_SERVICE_NAME': '0', 13:40:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:40:44 INFO - Cleaning up... 13:40:44 INFO - Return code: 0 13:40:44 INFO - Running post-action listener: _resource_record_post_action 13:40:44 INFO - Running post-action listener: _start_resource_monitoring 13:40:44 INFO - Starting resource monitoring. 13:40:44 INFO - ##### 13:40:44 INFO - ##### Finished create-virtualenv step (success) 13:40:44 INFO - ##### 13:40:44 INFO - ##### 13:40:44 INFO - ##### Running install step. 13:40:44 INFO - ##### 13:40:44 INFO - Running pre-action listener: _resource_record_pre_action 13:40:44 INFO - Running main action method: install 13:40:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:40:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:40:44 INFO - Reading from file tmpfile_stdout 13:40:44 INFO - Detecting whether we're running mozinstall >=1.0... 13:40:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:40:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:40:44 INFO - Reading from file tmpfile_stdout 13:40:44 INFO - Output received: 13:40:44 INFO - Usage: mozinstall [options] installer 13:40:44 INFO - Options: 13:40:44 INFO - -h, --help show this help message and exit 13:40:44 INFO - -d DEST, --destination=DEST 13:40:44 INFO - Directory to install application into. [default: 13:40:44 INFO - "/builds/slave/test"] 13:40:44 INFO - --app=APP Application being installed. [default: firefox] 13:40:44 INFO - mkdir: /builds/slave/test/build/application 13:40:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:40:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:41:18 INFO - Reading from file tmpfile_stdout 13:41:18 INFO - Output received: 13:41:18 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:41:18 INFO - Running post-action listener: _resource_record_post_action 13:41:18 INFO - ##### 13:41:18 INFO - ##### Finished install step (success) 13:41:18 INFO - ##### 13:41:18 INFO - ##### 13:41:18 INFO - ##### Running run-tests step. 13:41:18 INFO - ##### 13:41:18 INFO - Running pre-action listener: _resource_record_pre_action 13:41:18 INFO - Running main action method: run_tests 13:41:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:41:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:41:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:41:18 INFO - 2016-07-07 13:41:18.553 screenresolution[1639:7652] starting screenresolution argv=screenresolution get 13:41:18 INFO - 2016-07-07 13:41:18.556 screenresolution[1639:7652] Display 0: 1600x1200x32@60 13:41:18 INFO - 2016-07-07 13:41:18.562 screenresolution[1640:7654] starting screenresolution argv=screenresolution list 13:41:18 INFO - Available Modes on Display 0 13:41:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:41:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:41:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:41:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:41:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:41:18 INFO - Intel Iris: 13:41:18 INFO - Chipset Model: Intel Iris 13:41:18 INFO - Type: GPU 13:41:18 INFO - Bus: Built-In 13:41:18 INFO - VRAM (Dynamic, Max): 1536 MB 13:41:18 INFO - Vendor: Intel (0x8086) 13:41:18 INFO - Device ID: 0x0a2e 13:41:18 INFO - Revision ID: 0x0009 13:41:18 INFO - Displays: 13:41:18 INFO - Display: 13:41:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:41:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:41:18 INFO - Display Serial Number: 1600x1200 60 13:41:18 INFO - Main Display: Yes 13:41:18 INFO - Mirror: Off 13:41:18 INFO - Online: Yes 13:41:18 INFO - Rotation: Supported 13:41:18 INFO - Return code: 0 13:41:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:41:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:41:18 INFO - Python 2.7.3 13:41:18 INFO - Return code: 0 13:41:18 INFO - grabbing minidump binary from tooltool 13:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:41:18 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7f3d30>, '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 0x10e558db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ebb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:41:18 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 13:41:18 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 13:41:18 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:41:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:41:18 INFO - Return code: 0 13:41:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:41:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:41:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:41:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:41:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:41:18 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/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0263', '--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 13:41:18 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/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0263 --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 13:41:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VbohmCL0WJ/Render', 13:41:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:41:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:41:18 INFO - 'HOME': '/Users/cltbld', 13:41:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:41:18 INFO - 'LOGNAME': 'cltbld', 13:41:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:41:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:41:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:18 INFO - 'MOZ_NO_REMOTE': '1', 13:41:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:41:18 INFO - 'NO_EM_RESTART': '1', 13:41:18 INFO - 'PAGER': '/bin/cat', 13:41:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:41:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:18 INFO - 'PWD': '/builds/slave/test', 13:41:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:41:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:41:18 INFO - 'SHELL': '/bin/bash', 13:41:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HLkaDJSNOv/Listeners', 13:41:18 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 13:41:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:41:18 INFO - 'USER': 'cltbld', 13:41:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:41:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:41:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:18 INFO - 'XPC_FLAGS': '0x0', 13:41:18 INFO - 'XPC_SERVICE_NAME': '0', 13:41:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:41:18 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/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0263', '--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 13:41:19 INFO - mozversion application_buildid: 20160707105522 13:41:19 INFO - mozversion application_changeset: 8be08b36d5d8ba576aca59a1994ddbdaed116d74 13:41:19 INFO - mozversion application_display_name: Nightly 13:41:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:41:19 INFO - mozversion application_name: Firefox 13:41:19 INFO - mozversion application_remotingname: firefox 13:41:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:41:19 INFO - mozversion application_vendor: Mozilla 13:41:19 INFO - mozversion application_version: 50.0a1 13:41:19 INFO - mozversion platform_buildid: 20160707105522 13:41:19 INFO - mozversion platform_changeset: 8be08b36d5d8ba576aca59a1994ddbdaed116d74 13:41:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:41:19 INFO - mozversion platform_version: 50.0a1 13:41:19 INFO - using testdate: 1467924079 13:41:19 INFO - actual date: 1467924079 13:41:19 INFO - starting webserver on 'localhost:49267' 13:41:19 INFO - SUITE-START | Running 2 tests 13:41:19 INFO - TEST-START | dromaeo_css 13:41:19 INFO - operating with platform_type : mac_ 13:41:19 INFO - Initialising browser for dromaeo_css test... 13:41:19 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmpdVKytB/profile http://localhost:49267/getInfo.html) 13:41:21 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 13:41:21 INFO - PROCESS | 1650 | colorDepth:24 13:41:21 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 13:41:21 INFO - PROCESS | 1650 | __metrics 13:41:21 INFO - PROCESS | 1650 | 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" 13:41:21 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:41:22 INFO - TEST-INFO | 1650: exit 0 13:41:22 INFO - Browser initialized. 13:41:22 INFO - Running cycle 1/1 for dromaeo_css test... 13:41:22 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmpdVKytB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:41:34 INFO - PROCESS | 1652 | RSS: Main: 243392512 13:41:34 INFO - PROCESS | 1652 | 13:42:25 INFO - PROCESS | 1652 | 1467924145163 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] 13:44:36 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 13:44:38 INFO - PROCESS | 1652 | RSS: Main: 356745216 13:44:38 INFO - PROCESS | 1652 | 13:47:41 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 13:47:41 INFO - PROCESS | 1652 | RSS: Main: 386326528 13:47:41 INFO - PROCESS | 1652 | 13:50:44 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 13:50:44 INFO - PROCESS | 1652 | RSS: Main: 374693888 13:50:44 INFO - PROCESS | 1652 | 13:53:47 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 13:53:47 INFO - PROCESS | 1652 | RSS: Main: 372207616 13:53:47 INFO - PROCESS | 1652 | 13:56:51 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 13:56:52 INFO - PROCESS | 1652 | RSS: Main: 335278080 13:56:52 INFO - PROCESS | 1652 | 13:59:54 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 13:59:55 INFO - PROCESS | 1652 | RSS: Main: 425578496 13:59:55 INFO - PROCESS | 1652 | 13:59:55 INFO - PROCESS | 1652 | __start_tp_report 13:59:55 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 13:59:55 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 13:59:55 INFO - PROCESS | 1652 | |i|pagename|runs| 13:59:55 INFO - PROCESS | 1652 | |0;dojo.html;3336.2660214752755;3349.9665003349974;3352.09493436772;3394.4059789536823;3403.2682973160768;4990.825321113762;5329.280547126137;5623.550115990721;5683.062294721366;5745.827625171241;5606.411326810688;5684.175794509793;5684.37471878093;5691.601587888849;5707.429257074291;4416.293393057112;5106.591472682195;5252.737363131847;5325;5325.254464374991;5282.154855223165;5312.867178320554;5314.335708036496;5328.973355133219;5332.626716129873;5222.608304377168;5231.398389185235;5238.633295669305;5256.26412302278;5323.547498462635;5310.628256022099;5346.064438723247;5363.544098751572;5371.355437347544;5389.326334208224;4176.853810116661;4720.787564559603;4807.062622788558;5272.1300985337375;5272.340957380327;5625.212470254168;5664.943350566483;5685.204071429962;5717.828465146053;5736.426357364272;6176.197094377747;6189;6249.40630640093;6257.436830685215;6281.748730050793;5241.475852414766;6088.96955515224;6267.310595834455;6283.5287353448675;6287.937120628781;5698.914516282301;5714.200011998323;5730.025895597759;5753.597248192586;5759.971200143972;6293.811185664437;6335.873282534416;6340.270868850142;6340.365963403715;6353.5234857385885;6057.895835196564;6064.467318374618;6087.494018184669;6088.695565221721;6100.233019163243;6084.963234199661;6111.713288451782;6146.323904370515;6166.105914642441;6177.042558403455;6101.962666346732;6136.9079463808075;6164.137020817089;6165.10605962133;6197.349278325801;6185.072239164161;6212.596181248205;6214.502839772807;6216.533759968021;6224.688765561704;4874.780634871439;4917.852464426073;4919.7540122993705;4921.729304888194;4966.850994470172;4387.934180987288;4428.1365133799245;4463.4420697412825;4467.955320446819;4527.547245275512;5626.212330273765;5644.774209031675;5670.971645141748;5680.801171958961;5701.572382071361;6209.441150296495;6249.9062514062325;6253.218347706536;6279.466245369194;6292.276388215322;5518.448155184449;5572.108462645957;5588.357338905997;5634.32388113429;5641.12562552805;5317.282166907496;5372.543333816591;5389.973050134724;5398.568114550826;5413.998410294108;6296.5592408530965;6308.243010838729;6309.053641953744;6310.4636105930595;6319.747210111544;6117.632942023492;6129.785457508966;6151.384861513813;6198.411150940834;6210.254769427697;6280.466160376419;6292.748290068346;6297;6308.779192728232;6308.842278943063;6142.907856382247;6183.96908015457;6192.102145189013;6198.194234749454;6200.968995154995;6127.281156068254;6135.600157732601;6186.845328866814;6214.658193799384;6244.094606282155;5192.818251361185;6027.638341699512;6052.515798736179;6061.452374658986;6106.755729770937;5865.853353666022;6008.789692360921;6068.7269072892705;6076.878462430638;6084.14821924922;5738.254026976467;5851.795187168429;5886.882262354815;5915.733791979285;5941.792037278675;6101.195659204728;6117.401149625572;6132.021279252693;6134.008014331881;6147.415995480422;5736.5410767139365;5951.285845698544;5963.850903727268;5973.074173503114;6008.369121242206 13:59:55 INFO - PROCESS | 1652 | |1;ext.html;475.8263233919618;489.7184119131498;526.3052770343146;533.8158335374296;540.9026375252458;29418.705812941866;29659.25851853702;40536.79731601345;41720;41789.7910510447;42988.355174672324;43213.35179972303;43273.35089973653;43365.61489118097;43372.91567710801;9542.188913942306;9700.854487182698;9724.270679699015;9725.756856078584;9729.270304727139;8542.273906717937;8803.20771130598;11720.589779357724;11937.164398492108;11967.281963082243;11764.529418823236;11839.585614503494;11861.110416718737;11873.406329683525;11879.930806227438;8567.528785916773;11650.592229271977;11684.240524365889;11697;11704.414779261004;8584.8712269316;8759.34304927133;8763.561821908943;11477.311361318347;11791.410429478577;40648;41072.79463602693;41137.588624113676;41157.79421102905;41160.97097572555;3550.414181660023;3570.3751843427294;3600.207954250061;3659.505966694489;4245.97877010613;31031.689683103104;32433.51349729756;32610;32712.182195445068;32980.83509582461;3275.394052100369;3322.302316513535;3337.5494308268317;3355.312161006988;3400.472926696366;522612.3869380629;523159;524702;524994;532698;58509.70745146247;58570;59020.40979590149;59025;59051.704741476016;61386;61435.38564614386;61456;61468;61497.770044599754;15979.440719574759;16486.917565412095;16491.83508164927;16510.257038433298;16548.007119572863;11851.703707407383;12120.45457954394;12984.610461686165;13036.934815325863;13042.804357934638;15057.47298844557;15272.923635381752;15435.459758908384;15649.60875978087;15661.295241713922;5656.812069465376;5898.908701890078;6377.17096777416;6403.655232401248;6441.8434966866835;843.755310959827;935.2891802230354;968.7384406210284;978.5841017567506;1071.9517621707041;28597.428051438856;29410.705892940798;30598.54102188469;31087;31233.843830781156;1005.3917379985149;1088.9564417423214;1098.566066403766;1102.8897110289067;1152.8847115288572;15710.685786284439;15903.52289431319;15941.96377235476;16105.677886442205;16518;681507;686995;688315;688465;693043;59803.401965979785;59869.40130598725;60082;60085.39914600886;60103.098453523235;1262.6022802817267;1378.0629172162826;1422.3599380278915;1425.2303755972073;1439.2443966917451;24200.152994645105;30205.395892082473;30226.395472090873;30448.695513044586;30895.2276193097;43333.3499997494;50226.49773502218;50631;50650.746746266035;50844;582897;583419;583814;585322;586422;22881.65677514872;25614.23157305284;25661.230163095137;25991.350216243987;26066.34834129086;45183.54816451925;45196.77401613102;45832;46064.309035363825;46599;35973.460398094576;37185;37719.24561508809;37994.81002594969;38118;32744.836275818467;37533.43699844559;37893.81053094717;38007.42988855114;38469.61530384772;36917.26165476622;37325.44011839879;37518.2496350066;37604;37687.68093116728;29579.26051848721;30900.690993089782;33563.496547551316;33566.825161119246;33651.83174084212;19967.500812479804;22578;23324.3002709919;24218.394540135934;27960.860195699704 13:59:55 INFO - PROCESS | 1652 | |2;jquery.html;359.86684926577135;375.2326492323199;384.5251114873132;387.2371428286275;402.96776257899353;15789.84210157898;16665.83334166658;21886.781132188713;22311.107555697774;22348;21784.564308713816;21898.671519927215;22514.43713907153;23046.65430018551;23114.653280200768;5924.88150236995;5985.910211346833;6176.72204750785;6186.195794546703;6200.069989501566;3555.9111022224392;5777.1623114648355;6128.233970753656;6471.805845824632;6826.146731658543;6823.965880170617;6825.180978282613;6831.760888368908;6840.179178498587;6855.725770969155;6491.902621460682;6792.184937807495;6809.455243580551;6811.284815094418;6815.386615204656;5639.182318563826;5865.706714664249;5884.70576471179;5950.791722289742;5971.343152253248;28634.570481442795;28733.13800585986;28804;29341;29378.412431751458;2258.7176602924633;2281.4296425893526;2570.974290257092;3072.585200997859;3532.328857517089;16933.899296545686;17957.396177554183;18041.188146533437;18332.63334733298;18371;2026.7365242518379;2032.8576999610034;2056.085042156241;2092.225876425732;2107.694384314266;107829.46085269524;155651;157716.2114189433;158983;161467.1926640371;21657.241996530047;21662.100821851902;21902.23342183016;21910.342689719335;21989.79056151895;32886.68453261843;36356;36403.90566801852;36447;36488.087797804736;10111.64609238673;11314.717132071764;11332.263402878787;11379.260348077349;11428.085753139896;9292.581833817494;9293.72118836436;9299.488528130882;9463.290253231035;9480.194183494343;9712.223022158352;9838.770153730784;9971.601135954626;10015.349002314826;10039.64861229868;3193.7764356495286;3325.334933013407;3667.449882517644;3772.245550889833;3785.886423407302;844.9239568438747;882.1046637662778;886.4238245140581;922.8754118193958;1055.6938487838595;20720.58558828845;21562.46093847635;21604.35186944394;21638.459038523848;21659.566808663738;914.2183433164681;929.6885543343055;935.4434111703525;993.4369327135972;1009.8384258518602;11029.724256893642;11381.089512838953;11386.715332116763;11418.371989540656;11441;601501;611184;624001;624665;626976;140104.299478504;141335.29332353477;144911.27544362211;145906.81139782912;146176.26911865373;943.5706753427174;964.5852283518154;967.032967032967;1032.8244198486275;1035.3011717091083;19195;19802.801971980094;19883.900580497004;19929.00354982274;20041.799582003994;55042.219122458046;58921;60347.69826150841;60509;61305.69347153236;79444;83991.32017359741;84366;84412.73380899415;84777;8294.37792165578;8343.582820859054;8434.409591328547;8458.323334133378;8539.658413663385;13623.931880340535;13685.657858553615;13750.381232844346;13854.307284635526;13870.237136957565;9846.11384975327;11704.648860534198;11838.348890811088;11983.940080299542;11992.940035299767;11682.357470339213;11729.120315976506;11729.824052639387;11893.226940248856;11951.760964780482;8527.445716028686;11782.410879455821;11898.643040708792;12048.819267711167;12287.894089531985;7238.27617238272;7538.208488108889;7545.396368290633;7832.099308579586;8605.784855378666;10645.787084258116;10726.570937162738;11246;12015.399230038289;12063.276203427822 13:59:55 INFO - PROCESS | 1652 | |3;mootools.html;1401.481451862811;1506.645938204522;1554.05202826276;1773.5122841218663;1935.7580302462193;7864.528128312305;8715.389922705413;8958.10418958104;8972.237359824423;8997.46015239086;7300.269973002711;8826.955865220665;8830.426022308562;8842.071582483843;8849.690260840873;2053.917843286274;2139.454439118023;2290.6105961986505;2354.2819440070816;2380.1788383007834;2383.2611890314056;2415.384077060347;2420.721617014048;2421.164698179134;2422.7698368655037;2346.9765302346927;2368.6683864259016;2382.7498112698177;2383.892724827387;2386.8567885926814;2059.907304171308;2258.175765845471;2317.7682231776857;2318.211807985293;2333.393317737392;2335.591271527476;2364.054378248697;2364.2552595932225;2364.4798144408373;2374.584447721642;8797;8865.68970086044;8882.200601945857;8896.555172241362;8899.911000889973;5157.355330583677;5297.549708274802;5304.336957880265;5312.203169524563;5324.813631522917;3411.9934619287123;3486.8779592714386;3581.2837432513343;3610.0433385152955;3615.3311637347174;1019.9013538034851;1037.4397825174472;1047.9109275711573;1052.3265110329319;1059.6238335390979;11768.94079532846;11796.587119450778;11796.882031179664;11811.173217874752;11815.468303926344;4345.196138714348;4574.176648203355;4576.382188404589;4642.234031384851;4805.639577031737;9931.304808663324;9952.303338766216;9963.452010139512;9984.900150998543;9998.15015723657;5382.165764306539;5382.838514844561;5383.919241211385;5387.218853266255;5396.757145928443;4369.366441865912;4535;4745.1221524018165;4868.41579010521;4874.268859671078;3920.2355540669864;3955.307821131348;4021.436998820109;4062.7968601569805;4075.694322925792;1180.9291442513477;1227.5642147037852;1269.8603153653091;1280.6350190195749;1295.0934345957867;793.8293266947519;802.2579114319232;912.2519533982071;914.1589737441569;949.639137127887;6005.579609427298;6036.366181550961;6043.274807023097;6053.909191362133;6055.2430946131735;890.1810334492283;925.1349987761464;951.900050494702;955.2978560757838;973.5132433783108;3996.200759848042;3999.7600143991453;4019.8392064317686;4067.511898572131;4095.24238015968;10477.738056548647;10865.402402867918;10868.619598314179;10899.346039237513;10924.235303528676;9679.806403871884;10370.911054339336;10860.72848178786;10890.618828341128;10899.782004359868;8206.876896846552;8372.497650141011;8384.371172162113;8407.915920840836;8427.241548260687;5779.826605201851;5904.881902361843;5919.763209471573;5986.790462333972;6009.819705408845;8544.615492302986;9907.630582211903;10218.591256349662;10256.538455769658;10272.383656980604;9353;9564.66523671668;10284.948575257076;10464.63373781914;10491.370517768959;7453.366463850633;7462.813429664302;7537.660805263667;7541.622918854145;7541.886871696819;8235.588220589067;8360.331173506227;8371.832563348577;8391.454555453876;8399.950006249219;7486.139094004259;7564.583947882699;7574.128975167926;7604.581748003913;7719.845603088019;7485.4385921055045;7516.436267280085;7583.2416758323725;7625.275598818103;7656.310932016146;6973.12835895513;7154.785356439315;7156.821079473055;7159.534630249017;7165.964170179324;4911.68074075184;4943.530364615356;4978.551930326288;4979.278004689228;5076.6446348755235;4962.157235695027;4996.125678006407;5051.696898186121;5176.534111929794;5193.42872284056 13:59:55 INFO - PROCESS | 1652 | |4;prototype.html;306.3581796137093;312.89987204094683;314.7686450458913;320.1356337887704;322.63864471791595;4551.977240113799;4561.9963608006265;4701.95298047019;5423.755930983105;5469.917951230735;4498.347739577759;4897.265410188474;5149.201873709571;5431.474364420544;5517.779288828442;3314.801111933292;3667.9083022924374;3810.428435734634;4010.218007488541;4108.77401742904;4094.8092770367857;4159.625633692982;4179.2895207814745;4210.852620158295;4243.618074373306;4122.711410201287;4126.896827579305;4129.545749967501;4154.792260386984;4175.686823488235;3590.2819436112622;3883.825227864753;4021.256067627469;4043.8660038470275;4073.6964171465142;3538.2224953411446;3557.946630800514;3572.6427357264324;3582.6238244984424;3594.245208506217;4380.1966741285605;5190.273361729361;5193.428722840485;5256.605754568384;5261.947380526184;4161.91676166475;4519.728816271035;4738.19450693383;4746.620270378396;4753.215719406294;4531.297648864432;5531.474509921551;5587.161925711135;5588.888222235573;5640;3963.960360396388;3973.324534829086;3975.8608448704445;3976.920461590781;3985.5815139410524;5763.423657634203;5954.970225148846;5969.701814693414;6047.15339852421;6077.0276755719315;3715.702743780491;3942.9211415771524;3986.2824691555797;3986.661133803659;4007.6994225432627;3438.3123375325035;4051.5948405159247;4076.898077548085;4121.340585506305;4123.113530590937;4579.793909274091;4650.627949764011;4736.313234580966;4750.572448479654;4789.185838407479;4786.928196077061;5762.476455982034;5768.855778605484;5769.624974376652;5793.826185214451;1247.4137155536882;1255.8320761691532;1351.2230467481238;1373.8282714660668;1422.5092343141807;769.5075151902787;813.4305985809957;850.9617067231866;869.7260362985639;878.4114643189079;4830.951690483121;5210.036143313499;5353.277307563507;5426.937763649867;5439.878447405515;5300.469953004746;5602.907433050516;5667.064934285879;5930.673812940244;5988.730507127189;4490.550944905483;4526.54551265724;5300.602454815904;5316.122839731478;5374.044275648378;2960.86676099576;3096.365245124744;3114.4394009078583;3115.4236466253815;3135.0249342913817;4670.789814458358;5257.737113144328;5532.529734972572;6058.000429929012;6093.293877714247;5459.972700136474;5836.88326233473;5973.551983601247;6031.125486804476;6046.879062418727;4811;5725.456081672234;6039.969800151059;6072.908906366408;6096.829648582712;4899.681520701143;5469.031148786354;5675.971620141873;5817.127430885401;5862.296524417097;4575.816967321403;5783.958887400308;5808.651480911159;5815.86590614826;5833.912491312549;5670.688112153706;6052.061930400795;6055.607210341558;6078.848028799315;6160.507159427146;3475.721942244665;3813.339194373322;4072.6131017553284;4139.758072578275;4144.362976624277;5432.456754324536;5636.140073775562;5981.401859813984;6012.849678757891;6028.367021462684;4317.3594034268035;4894.486078961801;5200.089984252816;5493.945060549503;5619.223659889061;4776.331313616166;5257.106291930305;5502.202180683858;5758.625689330348;5771.68255745938;4718.575328220477;5425.891482170256;5652.095664693629;5698.544116470755;5705.400932902152;5224.451432599522;5676.262085928803;5709.600327977002;5729.187482514708;5855;4652.651051171243;5583.330000399978;5587.860303492445;5610.691411972218;5655.7454914528125 13:59:55 INFO - PROCESS | 1652 | |5;yui.html;752.4131177681409;772.404195039515;779.0028763183124;824.43938122077;842.8549341924798;15086.924565377172;16279.918600406982;16284.83715162848;16285.674286514277;16308.429204977798;14762.704745905075;14971.176585287805;14976.625584360396;14979;14992.850071499282;700.2437367642946;730.0946825935854;860.8192279621287;883.2360008592553;891.2825175733532;875.9605817738185;884.0805562215288;886.9157430044136;887;887.0641473245723;939.3847030195199;939.6006697153716;939.8966113727485;941.0683423410842;945.3477100800426;740.7481456304855;767.0603510699405;768.2509553185655;770.5646309834925;908.6501696846761;700.7967689370076;700.8983697363905;701.1901254051528;701.5685353507556;702.1749444402807;15010.249487525689;15014.549563513003;15052.548423547201;15060.623484412868;15066.698666026618;14112.788308175386;14302.92848535761;14360.066595671247;14378.568642940729;14560.927195364062;13064.804027939588;13095.214287142802;13105.2136871788;13129.737405251937;13506.59480215595;4474.351219073249;4636.3045543168455;4688.437387513486;4711.10489007091;4726.550977657117;125253;126566;126648.73351266554;126705.73294267032;127001.36499317536;11114.833277500844;11284.153688473398;11421.486033128529;11519.942400287944;12031.75936481283;22747.09011639549;22822.42943926415;22847.657285140736;22873.656895146585;22969.540609188058;7805;7900.683972641145;7917.327027202752;7994.960025199837;8060.798480038046;4333.328334108218;4387.319965405367;4390.7585082820115;4399.1641588098155;4548.204064288736;3430.2281986552825;3580.7672501287334;3581.552305961755;3591.174029973121;3602.7838329700303;652.3857827634944;679.4768028617937;713.2297119111347;721.9350258476762;725.7496163823472;552.1331509529999;570.5521165884843;600.2826622186533;606.7467055937819;620.711369213318;9157.496337701357;9520.966722883071;9591.520423978773;9657.090358304598;9871.160951319074;563.4281204577358;618.5824568416301;622.9065640154013;633.9603050996369;681.7375310505491;4564.42944631921;4640.373549570832;4646.233371493666;4652.255639097728;4728.71627702339;88782;144398;144823.82764258544;145959;149263;122775;123242;123937.38031309786;126464;128533;104916.47541762242;107302.99999999844;108764;110530;111938;7799.64901579419;8465;8950.373473856767;8987.46075235488;9161.450312981242;62026.37973620387;62162.44593885189;62886.74226515536;64976.350236497026;65538;82895.17104829116;85558.57220713857;87329;91491;93903;11939.52241910314;12044;12064.336461494702;12224;12741.936290318488;10677;11417.657470275904;12426.502939882303;13497.392617332047;13805.619438056114;12344.197627154206;12862.935685321514;13003.739925201633;13143.14569552976;13146;12333;12697.717040519277;12975.545855894998;13211.933940330237;13308.933455333048;12044.397780111134;12271.687506541326;12407.813882791585;12536.623901282976;12796.936015319863;10593.470326483492;10605.469726513798;10715.892841071802;10727.271822880373;11379.487923043649;9730.41617502952;10090.394576325443;10139.847902281324;10561.89438105609;10588.205884558844 13:59:55 INFO - PROCESS | 1652 | __end_tp_report 13:59:55 INFO - PROCESS | 1652 | __start_cc_report 13:59:55 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1155 13:59:55 INFO - PROCESS | 1652 | __end_cc_report 13:59:55 INFO - PROCESS | 1652 | __startTimestamp1467925195204__endTimestamp 13:59:55 INFO - PROCESS | 1652 | 13:59:55 INFO - PROCESS | 1652 | ------- Summary: start ------- 13:59:55 INFO - PROCESS | 1652 | Number of tests: 6 13:59:55 INFO - PROCESS | 1652 | 13:59:55 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5703.04 Median:5915.73 stddev:647.16 (10.9%) stddev-sans-first:621.94 13:59:55 INFO - PROCESS | 1652 | Values: 3336.3 3350.0 3352.1 3394.4 3403.3 4990.8 5329.3 5623.6 5683.1 5745.8 5606.4 5684.2 5684.4 5691.6 5707.4 4416.3 5106.6 5252.7 5325.0 5325.3 5282.2 5312.9 5314.3 5329.0 5332.6 5222.6 5231.4 5238.6 5256.3 5323.5 5310.6 5346.1 5363.5 5371.4 5389.3 4176.9 4720.8 4807.1 5272.1 5272.3 5625.2 5664.9 5685.2 5717.8 5736.4 6176.2 6189.0 6249.4 6257.4 6281.7 5241.5 6089.0 6267.3 6283.5 6287.9 5698.9 5714.2 5730.0 5753.6 5760.0 6293.8 6335.9 6340.3 6340.4 6353.5 6057.9 6064.5 6087.5 6088.7 6100.2 6085.0 6111.7 6146.3 6166.1 6177.0 6102.0 6136.9 6164.1 6165.1 6197.3 6185.1 6212.6 6214.5 6216.5 6224.7 4874.8 4917.9 4919.8 4921.7 4966.9 4387.9 4428.1 4463.4 4468.0 4527.5 5626.2 5644.8 5671.0 5680.8 5701.6 6209.4 6249.9 6253.2 6279.5 6292.3 5518.4 5572.1 5588.4 5634.3 5641.1 5317.3 5372.5 5390.0 5398.6 5414.0 6296.6 6308.2 6309.1 6310.5 6319.7 6117.6 6129.8 6151.4 6198.4 6210.3 6280.5 6292.7 6297.0 6308.8 6308.8 6142.9 6184.0 6192.1 6198.2 6201.0 6127.3 6135.6 6186.8 6214.7 6244.1 5192.8 6027.6 6052.5 6061.5 6106.8 5865.9 6008.8 6068.7 6076.9 6084.1 5738.3 5851.8 5886.9 5915.7 5941.8 6101.2 6117.4 6132.0 6134.0 6147.4 5736.5 5951.3 5963.9 5973.1 6008.4 13:59:55 INFO - PROCESS | 1652 | 13:59:55 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:72472.96 Median:37421.84 stddev:161408.76 (431.3%) stddev-sans-first:161771.03 13:59:55 INFO - PROCESS | 1652 | Values: 475.8 489.7 526.3 533.8 540.9 29418.7 29659.3 40536.8 41720.0 41789.8 42988.4 43213.4 43273.4 43365.6 43372.9 9542.2 9700.9 9724.3 9725.8 9729.3 8542.3 8803.2 11720.6 11937.2 11967.3 11764.5 11839.6 11861.1 11873.4 11879.9 8567.5 11650.6 11684.2 11697.0 11704.4 8584.9 8759.3 8763.6 11477.3 11791.4 40648.0 41072.8 41137.6 41157.8 41161.0 3550.4 3570.4 3600.2 3659.5 4246.0 31031.7 32433.5 32610.0 32712.2 32980.8 3275.4 3322.3 3337.5 3355.3 3400.5 522612.4 523159.0 524702.0 524994.0 532698.0 58509.7 58570.0 59020.4 59025.0 59051.7 61386.0 61435.4 61456.0 61468.0 61497.8 15979.4 16486.9 16491.8 16510.3 16548.0 11851.7 12120.5 12984.6 13036.9 13042.8 15057.5 15272.9 15435.5 15649.6 15661.3 5656.8 5898.9 6377.2 6403.7 6441.8 843.8 935.3 968.7 978.6 1072.0 28597.4 29410.7 30598.5 31087.0 31233.8 1005.4 1089.0 1098.6 1102.9 1152.9 15710.7 15903.5 15942.0 16105.7 16518.0 681507.0 686995.0 688315.0 688465.0 693043.0 59803.4 59869.4 60082.0 60085.4 60103.1 1262.6 1378.1 1422.4 1425.2 1439.2 24200.2 30205.4 30226.4 30448.7 30895.2 43333.3 50226.5 50631.0 50650.7 50844.0 582897.0 583419.0 583814.0 585322.0 586422.0 22881.7 25614.2 25661.2 25991.4 26066.3 45183.5 45196.8 45832.0 46064.3 46599.0 35973.5 37185.0 37719.2 37994.8 38118.0 32744.8 37533.4 37893.8 38007.4 38469.6 36917.3 37325.4 37518.2 37604.0 37687.7 29579.3 30900.7 33563.5 33566.8 33651.8 19967.5 22578.0 23324.3 24218.4 27960.9 13:59:55 INFO - PROCESS | 1652 | 13:59:55 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:38907.99 Median:29359.71 stddev:103949.15 (354.1%) stddev-sans-first:104200.46 13:59:55 INFO - PROCESS | 1652 | Values: 359.9 375.2 384.5 387.2 403.0 15789.8 16665.8 21886.8 22311.1 22348.0 21784.6 21898.7 22514.4 23046.7 23114.7 5924.9 5985.9 6176.7 6186.2 6200.1 3555.9 5777.2 6128.2 6471.8 6826.1 6824.0 6825.2 6831.8 6840.2 6855.7 6491.9 6792.2 6809.5 6811.3 6815.4 5639.2 5865.7 5884.7 5950.8 5971.3 28634.6 28733.1 28804.0 29341.0 29378.4 2258.7 2281.4 2571.0 3072.6 3532.3 16933.9 17957.4 18041.2 18332.6 18371.0 2026.7 2032.9 2056.1 2092.2 2107.7 107829.5 155651.0 157716.2 158983.0 161467.2 21657.2 21662.1 21902.2 21910.3 21989.8 32886.7 36356.0 36403.9 36447.0 36488.1 10111.6 11314.7 11332.3 11379.3 11428.1 9292.6 9293.7 9299.5 9463.3 9480.2 9712.2 9838.8 9971.6 10015.3 10039.6 3193.8 3325.3 3667.4 3772.2 3785.9 844.9 882.1 886.4 922.9 1055.7 20720.6 21562.5 21604.4 21638.5 21659.6 914.2 929.7 935.4 993.4 1009.8 11029.7 11381.1 11386.7 11418.4 11441.0 601501.0 611184.0 624001.0 624665.0 626976.0 140104.3 141335.3 144911.3 145906.8 146176.3 943.6 964.6 967.0 1032.8 1035.3 19195.0 19802.8 19883.9 19929.0 20041.8 55042.2 58921.0 60347.7 60509.0 61305.7 79444.0 83991.3 84366.0 84412.7 84777.0 8294.4 8343.6 8434.4 8458.3 8539.7 13623.9 13685.7 13750.4 13854.3 13870.2 9846.1 11704.6 11838.3 11983.9 11992.9 11682.4 11729.1 11729.8 11893.2 11951.8 8527.4 11782.4 11898.6 12048.8 12287.9 7238.3 7538.2 7545.4 7832.1 8605.8 10645.8 10726.6 11246.0 12015.4 12063.3 13:59:55 INFO - PROCESS | 1652 | 13:59:55 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5736.31 Median:5023.91 stddev:3217.71 (64.0%) stddev-sans-first:3210.25 13:59:55 INFO - PROCESS | 1652 | Values: 1401.5 1506.6 1554.1 1773.5 1935.8 7864.5 8715.4 8958.1 8972.2 8997.5 7300.3 8827.0 8830.4 8842.1 8849.7 2053.9 2139.5 2290.6 2354.3 2380.2 2383.3 2415.4 2420.7 2421.2 2422.8 2347.0 2368.7 2382.7 2383.9 2386.9 2059.9 2258.2 2317.8 2318.2 2333.4 2335.6 2364.1 2364.3 2364.5 2374.6 8797.0 8865.7 8882.2 8896.6 8899.9 5157.4 5297.5 5304.3 5312.2 5324.8 3412.0 3486.9 3581.3 3610.0 3615.3 1019.9 1037.4 1047.9 1052.3 1059.6 11768.9 11796.6 11796.9 11811.2 11815.5 4345.2 4574.2 4576.4 4642.2 4805.6 9931.3 9952.3 9963.5 9984.9 9998.2 5382.2 5382.8 5383.9 5387.2 5396.8 4369.4 4535.0 4745.1 4868.4 4874.3 3920.2 3955.3 4021.4 4062.8 4075.7 1180.9 1227.6 1269.9 1280.6 1295.1 793.8 802.3 912.3 914.2 949.6 6005.6 6036.4 6043.3 6053.9 6055.2 890.2 925.1 951.9 955.3 973.5 3996.2 3999.8 4019.8 4067.5 4095.2 10477.7 10865.4 10868.6 10899.3 10924.2 9679.8 10370.9 10860.7 10890.6 10899.8 8206.9 8372.5 8384.4 8407.9 8427.2 5779.8 5904.9 5919.8 5986.8 6009.8 8544.6 9907.6 10218.6 10256.5 10272.4 9353.0 9564.7 10284.9 10464.6 10491.4 7453.4 7462.8 7537.7 7541.6 7541.9 8235.6 8360.3 8371.8 8391.5 8400.0 7486.1 7564.6 7574.1 7604.6 7719.8 7485.4 7516.4 7583.2 7625.3 7656.3 6973.1 7154.8 7156.8 7159.5 7166.0 4911.7 4943.5 4978.6 4979.3 5076.6 4962.2 4996.1 5051.7 5176.5 5193.4 13:59:55 INFO - PROCESS | 1652 | 13:59:55 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4591.39 Median:5169.74 stddev:1409.19 (27.3%) stddev-sans-first:1375.95 13:59:55 INFO - PROCESS | 1652 | Values: 306.4 312.9 314.8 320.1 322.6 4552.0 4562.0 4702.0 5423.8 5469.9 4498.3 4897.3 5149.2 5431.5 5517.8 3314.8 3667.9 3810.4 4010.2 4108.8 4094.8 4159.6 4179.3 4210.9 4243.6 4122.7 4126.9 4129.5 4154.8 4175.7 3590.3 3883.8 4021.3 4043.9 4073.7 3538.2 3557.9 3572.6 3582.6 3594.2 4380.2 5190.3 5193.4 5256.6 5261.9 4161.9 4519.7 4738.2 4746.6 4753.2 4531.3 5531.5 5587.2 5588.9 5640.0 3964.0 3973.3 3975.9 3976.9 3985.6 5763.4 5955.0 5969.7 6047.2 6077.0 3715.7 3942.9 3986.3 3986.7 4007.7 3438.3 4051.6 4076.9 4121.3 4123.1 4579.8 4650.6 4736.3 4750.6 4789.2 4786.9 5762.5 5768.9 5769.6 5793.8 1247.4 1255.8 1351.2 1373.8 1422.5 769.5 813.4 851.0 869.7 878.4 4831.0 5210.0 5353.3 5426.9 5439.9 5300.5 5602.9 5667.1 5930.7 5988.7 4490.6 4526.5 5300.6 5316.1 5374.0 2960.9 3096.4 3114.4 3115.4 3135.0 4670.8 5257.7 5532.5 6058.0 6093.3 5460.0 5836.9 5973.6 6031.1 6046.9 4811.0 5725.5 6040.0 6072.9 6096.8 4899.7 5469.0 5676.0 5817.1 5862.3 4575.8 5784.0 5808.7 5815.9 5833.9 5670.7 6052.1 6055.6 6078.8 6160.5 3475.7 3813.3 4072.6 4139.8 4144.4 5432.5 5636.1 5981.4 6012.8 6028.4 4317.4 4894.5 5200.1 5493.9 5619.2 4776.3 5257.1 5502.2 5758.6 5771.7 4718.6 5425.9 5652.1 5698.5 5705.4 5224.5 5676.3 5709.6 5729.2 5855.0 4652.7 5583.3 5587.9 5610.7 5655.7 13:59:55 INFO - PROCESS | 1652 | 13:59:55 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:24679.73 Median:3586.36 stddev:39219.02 (1093.6%) stddev-sans-first:39287.89 13:59:55 INFO - PROCESS | 1652 | Values: 752.4 772.4 779.0 824.4 842.9 15086.9 16279.9 16284.8 16285.7 16308.4 14762.7 14971.2 14976.6 14979.0 14992.9 700.2 730.1 860.8 883.2 891.3 876.0 884.1 886.9 887.0 887.1 939.4 939.6 939.9 941.1 945.3 740.7 767.1 768.3 770.6 908.7 700.8 700.9 701.2 701.6 702.2 15010.2 15014.5 15052.5 15060.6 15066.7 14112.8 14302.9 14360.1 14378.6 14560.9 13064.8 13095.2 13105.2 13129.7 13506.6 4474.4 4636.3 4688.4 4711.1 4726.6 125253.0 126566.0 126648.7 126705.7 127001.4 11114.8 11284.2 11421.5 11519.9 12031.8 22747.1 22822.4 22847.7 22873.7 22969.5 7805.0 7900.7 7917.3 7995.0 8060.8 4333.3 4387.3 4390.8 4399.2 4548.2 3430.2 3580.8 3581.6 3591.2 3602.8 652.4 679.5 713.2 721.9 725.7 552.1 570.6 600.3 606.7 620.7 9157.5 9521.0 9591.5 9657.1 9871.2 563.4 618.6 622.9 634.0 681.7 4564.4 4640.4 4646.2 4652.3 4728.7 88782.0 144398.0 144823.8 145959.0 149263.0 122775.0 123242.0 123937.4 126464.0 128533.0 104916.5 107303.0 108764.0 110530.0 111938.0 7799.6 8465.0 8950.4 8987.5 9161.5 62026.4 62162.4 62886.7 64976.4 65538.0 82895.2 85558.6 87329.0 91491.0 93903.0 11939.5 12044.0 12064.3 12224.0 12741.9 10677.0 11417.7 12426.5 13497.4 13805.6 12344.2 12862.9 13003.7 13143.1 13146.0 12333.0 12697.7 12975.5 13211.9 13308.9 12044.4 12271.7 12407.8 12536.6 12796.9 10593.5 10605.5 10715.9 10727.3 11379.5 9730.4 10090.4 10139.8 10561.9 10588.2 13:59:55 INFO - PROCESS | 1652 | -------- Summary: end -------- 13:59:55 INFO - PROCESS | 1652 | 13:59:55 INFO - TEST-INFO | 1652: exit 0 13:59:55 INFO - TEST-OK | dromaeo_css | took 1116730ms 13:59:55 INFO - TEST-START | kraken 13:59:55 INFO - operating with platform_type : mac_ 13:59:55 INFO - Initialising browser for kraken test... 13:59:55 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmptkmI1F/profile http://localhost:49267/getInfo.html) 13:59:58 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 13:59:58 INFO - PROCESS | 1661 | colorDepth:24 13:59:58 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 13:59:58 INFO - PROCESS | 1661 | __metrics 13:59:58 INFO - PROCESS | 1661 | 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" 13:59:58 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:59:59 INFO - TEST-INFO | 1661: exit 0 13:59:59 INFO - Browser initialized. 13:59:59 INFO - Running cycle 1/1 for kraken test... 13:59:59 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmptkmI1F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:00:11 INFO - PROCESS | 1662 | RSS: Main: 244011008 14:00:11 INFO - PROCESS | 1662 | 14:00:13 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 14:00:14 INFO - PROCESS | 1662 | RSS: Main: 294019072 14:00:14 INFO - PROCESS | 1662 | 14:00:17 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 14:00:17 INFO - PROCESS | 1662 | RSS: Main: 304562176 14:00:17 INFO - PROCESS | 1662 | 14:00:21 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 14:00:22 INFO - PROCESS | 1662 | RSS: Main: 389189632 14:00:22 INFO - PROCESS | 1662 | 14:00:24 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 14:00:24 INFO - PROCESS | 1662 | RSS: Main: 289054720 14:00:24 INFO - PROCESS | 1662 | 14:00:26 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:00:27 INFO - PROCESS | 1662 | RSS: Main: 293064704 14:00:27 INFO - PROCESS | 1662 | 14:00:30 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 14:00:30 INFO - PROCESS | 1662 | RSS: Main: 329523200 14:00:30 INFO - PROCESS | 1662 | 14:00:33 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 14:00:34 INFO - PROCESS | 1662 | RSS: Main: 331165696 14:00:34 INFO - PROCESS | 1662 | 14:00:37 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 14:00:37 INFO - PROCESS | 1662 | RSS: Main: 330256384 14:00:37 INFO - PROCESS | 1662 | 14:00:39 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:00:40 INFO - PROCESS | 1662 | RSS: Main: 311386112 14:00:40 INFO - PROCESS | 1662 | 14:00:41 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:00:42 INFO - PROCESS | 1662 | RSS: Main: 317964288 14:00:42 INFO - PROCESS | 1662 | 14:00:44 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:00:45 INFO - PROCESS | 1662 | RSS: Main: 317939712 14:00:45 INFO - PROCESS | 1662 | 14:00:48 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:00:48 INFO - PROCESS | 1662 | RSS: Main: 325898240 14:00:48 INFO - PROCESS | 1662 | 14:00:51 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:00:52 INFO - PROCESS | 1662 | RSS: Main: 328286208 14:00:52 INFO - PROCESS | 1662 | 14:00:54 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 14:00:54 INFO - PROCESS | 1662 | RSS: Main: 371961856 14:00:54 INFO - PROCESS | 1662 | 14:00:54 INFO - PROCESS | 1662 | __start_tp_report 14:00:54 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 14:00:54 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 14:00:54 INFO - PROCESS | 1662 | |i|pagename|runs| 14:00:54 INFO - PROCESS | 1662 | |0;ai-astar;102;113;115;112;113;113;112;114;114;113 14:00:54 INFO - PROCESS | 1662 | |1;audio-beat-detection;144;113;104;153;107;107;128;105;138;106 14:00:54 INFO - PROCESS | 1662 | |2;audio-dft;184;182;185;182;186;198;257;181;182;182 14:00:54 INFO - PROCESS | 1662 | |3;audio-fft;80;73;58;108;58;57;59;65;99;59 14:00:54 INFO - PROCESS | 1662 | |4;audio-oscillator;84;90;91;71;70;69;97;70;67;102 14:00:54 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;86;85;87;83;87;83;88;83;86;83 14:00:54 INFO - PROCESS | 1662 | |6;imaging-darkroom;93;93;92;93;92;92;93;93;93;92 14:00:54 INFO - PROCESS | 1662 | |7;imaging-desaturate;89;87;91;130;129;83;82;86;87;87 14:00:54 INFO - PROCESS | 1662 | |8;json-parse-financial;57;53;57;56;56;53;62;77;82;81 14:00:54 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;64;70;73;75;71;71;70;69;69;68 14:00:54 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;86;85;83;85;85;84;79;84;82;83 14:00:54 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;137;136;136;141;137;146;117;141;248;146 14:00:54 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;164;162;211;183;164;166;170;216;205;163 14:00:54 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;66;67;68;66;66;65;65;66;65;65 14:00:54 INFO - PROCESS | 1662 | __end_tp_report 14:00:54 INFO - PROCESS | 1662 | __start_cc_report 14:00:54 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,2036 14:00:54 INFO - PROCESS | 1662 | __end_cc_report 14:00:54 INFO - PROCESS | 1662 | __startTimestamp1467925254512__endTimestamp 14:00:54 INFO - PROCESS | 1662 | 14:00:54 INFO - PROCESS | 1662 | ------- Summary: start ------- 14:00:54 INFO - PROCESS | 1662 | Number of tests: 14 14:00:54 INFO - PROCESS | 1662 | 14:00:54 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:3.67 (3.2%) stddev-sans-first:0.97 14:00:54 INFO - PROCESS | 1662 | Values: 102.0 113.0 115.0 112.0 113.0 113.0 112.0 114.0 114.0 113.0 14:00:54 INFO - PROCESS | 1662 | 14:00:54 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:120.50 Median:120.50 stddev:18.60 (15.4%) stddev-sans-first:17.68 14:00:54 INFO - PROCESS | 1662 | Values: 144.0 113.0 104.0 153.0 107.0 107.0 128.0 105.0 138.0 106.0 14:00:54 INFO - PROCESS | 1662 | 14:00:54 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:191.90 Median:184.50 stddev:23.41 (12.7%) stddev-sans-first:24.65 14:00:54 INFO - PROCESS | 1662 | Values: 184.0 182.0 185.0 182.0 186.0 198.0 257.0 181.0 182.0 182.0 14:00:54 INFO - PROCESS | 1662 | 14:00:54 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:71.60 Median:62.00 stddev:18.54 (29.9%) stddev-sans-first:19.41 14:00:54 INFO - PROCESS | 1662 | Values: 80.0 73.0 58.0 108.0 58.0 57.0 59.0 65.0 99.0 59.0 14:00:54 INFO - PROCESS | 1662 | 14:00:54 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:81.10 Median:77.50 stddev:13.20 (17.0%) stddev-sans-first:13.96 14:00:54 INFO - PROCESS | 1662 | Values: 84.0 90.0 91.0 71.0 70.0 69.0 97.0 70.0 67.0 102.0 14:00:54 INFO - PROCESS | 1662 | 14:00:54 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:85.10 Median:86.00 stddev:1.97 (2.3%) stddev-sans-first:2.06 14:00:54 INFO - PROCESS | 1662 | Values: 86.0 85.0 87.0 83.0 87.0 83.0 88.0 83.0 86.0 83.0 14:00:54 INFO - PROCESS | 1662 | 14:00:54 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:92.60 Median:93.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 14:00:54 INFO - PROCESS | 1662 | Values: 93.0 93.0 92.0 93.0 92.0 92.0 93.0 93.0 93.0 92.0 14:00:54 INFO - PROCESS | 1662 | 14:00:54 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:87.00 stddev:18.31 (21.1%) stddev-sans-first:19.29 14:00:54 INFO - PROCESS | 1662 | Values: 89.0 87.0 91.0 130.0 129.0 83.0 82.0 86.0 87.0 87.0 14:00:54 INFO - PROCESS | 1662 | 14:00:54 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:59.50 stddev:11.79 (19.8%) stddev-sans-first:12.27 14:00:54 INFO - PROCESS | 1662 | Values: 57.0 53.0 57.0 56.0 56.0 53.0 62.0 77.0 82.0 81.0 14:00:54 INFO - PROCESS | 1662 | 14:00:54 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:70.50 stddev:2.94 (4.2%) stddev-sans-first:2.18 14:00:54 INFO - PROCESS | 1662 | Values: 64.0 70.0 73.0 75.0 71.0 71.0 70.0 69.0 69.0 68.0 14:00:54 INFO - PROCESS | 1662 | 14:00:54 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.50 stddev:2.01 (2.4%) stddev-sans-first:1.94 14:00:54 INFO - PROCESS | 1662 | Values: 86.0 85.0 83.0 85.0 85.0 84.0 79.0 84.0 82.0 83.0 14:00:54 INFO - PROCESS | 1662 | 14:00:54 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:148.50 Median:141.00 stddev:35.89 (25.5%) stddev-sans-first:37.83 14:00:54 INFO - PROCESS | 1662 | Values: 137.0 136.0 136.0 141.0 137.0 146.0 117.0 141.0 248.0 146.0 14:00:54 INFO - PROCESS | 1662 | 14:00:54 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.40 Median:176.50 stddev:21.88 (12.4%) stddev-sans-first:22.39 14:00:54 INFO - PROCESS | 1662 | Values: 164.0 162.0 211.0 183.0 164.0 166.0 170.0 216.0 205.0 163.0 14:00:54 INFO - PROCESS | 1662 | 14:00:54 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:0.99 (1.5%) stddev-sans-first:1.05 14:00:54 INFO - PROCESS | 1662 | Values: 66.0 67.0 68.0 66.0 66.0 65.0 65.0 66.0 65.0 65.0 14:00:54 INFO - PROCESS | 1662 | -------- Summary: end -------- 14:00:54 INFO - PROCESS | 1662 | 14:00:55 INFO - TEST-INFO | 1662: exit 0 14:00:55 INFO - TEST-OK | kraken | took 59575ms 14:00:55 INFO - SUITE-END | took 1176s 14:00:55 INFO - Completed test suite (00:19:36) 14:00:55 INFO - javascript benchmark 14:00:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3336.2660214752755, 3349.9665003349974, 3352.09493436772, 3394.4059789536823, 3403.2682973160768, 4990.825321113762, 5329.280547126137, 5623.550115990721, 5683.062294721366, 5745.827625171241, 5606.411326810688, 5684.175794509793, 5684.37471878093, 5691.601587888849, 5707.429257074291, 4416.293393057112, 5106.591472682195, 5252.737363131847, 5325.0, 5325.254464374991, 5282.154855223165, 5312.867178320554, 5314.335708036496, 5328.973355133219, 5332.626716129873, 5222.608304377168, 5231.398389185235, 5238.633295669305, 5256.26412302278, 5323.547498462635, 5310.628256022099, 5346.064438723247, 5363.544098751572, 5371.355437347544, 5389.326334208224, 4176.853810116661, 4720.787564559603, 4807.062622788558, 5272.1300985337375, 5272.340957380327, 5625.212470254168, 5664.943350566483, 5685.204071429962, 5717.828465146053, 5736.426357364272, 6176.197094377747, 6189.0, 6249.40630640093, 6257.436830685215, 6281.748730050793, 5241.475852414766, 6088.96955515224, 6267.310595834455, 6283.5287353448675, 6287.937120628781, 5698.914516282301, 5714.200011998323, 5730.025895597759, 5753.597248192586, 5759.971200143972, 6293.811185664437, 6335.873282534416, 6340.270868850142, 6340.365963403715, 6353.5234857385885, 6057.895835196564, 6064.467318374618, 6087.494018184669, 6088.695565221721, 6100.233019163243, 6084.963234199661, 6111.713288451782, 6146.323904370515, 6166.105914642441, 6177.042558403455, 6101.962666346732, 6136.9079463808075, 6164.137020817089, 6165.10605962133, 6197.349278325801, 6185.072239164161, 6212.596181248205, 6214.502839772807, 6216.533759968021, 6224.688765561704, 4874.780634871439, 4917.852464426073, 4919.7540122993705, 4921.729304888194, 4966.850994470172, 4387.934180987288, 4428.1365133799245, 4463.4420697412825, 4467.955320446819, 4527.547245275512, 5626.212330273765, 5644.774209031675, 5670.971645141748, 5680.801171958961, 5701.572382071361, 6209.441150296495, 6249.9062514062325, 6253.218347706536, 6279.466245369194, 6292.276388215322, 5518.448155184449, 5572.108462645957, 5588.357338905997, 5634.32388113429, 5641.12562552805, 5317.282166907496, 5372.543333816591, 5389.973050134724, 5398.568114550826, 5413.998410294108, 6296.5592408530965, 6308.243010838729, 6309.053641953744, 6310.4636105930595, 6319.747210111544, 6117.632942023492, 6129.785457508966, 6151.384861513813, 6198.411150940834, 6210.254769427697, 6280.466160376419, 6292.748290068346, 6297.0, 6308.779192728232, 6308.842278943063, 6142.907856382247, 6183.96908015457, 6192.102145189013, 6198.194234749454, 6200.968995154995, 6127.281156068254, 6135.600157732601, 6186.845328866814, 6214.658193799384, 6244.094606282155, 5192.818251361185, 6027.638341699512, 6052.515798736179, 6061.452374658986, 6106.755729770937, 5865.853353666022, 6008.789692360921, 6068.7269072892705, 6076.878462430638, 6084.14821924922, 5738.254026976467, 5851.795187168429, 5886.882262354815, 5915.733791979285, 5941.792037278675, 6101.195659204728, 6117.401149625572, 6132.021279252693, 6134.008014331881, 6147.415995480422, 5736.5410767139365, 5951.285845698544, 5963.850903727268, 5973.074173503114, 6008.369121242206], "value": 5662.021164139426, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.8263233919618, 489.7184119131498, 526.3052770343146, 533.8158335374296, 540.9026375252458, 29418.705812941866, 29659.25851853702, 40536.79731601345, 41720.0, 41789.7910510447, 42988.355174672324, 43213.35179972303, 43273.35089973653, 43365.61489118097, 43372.91567710801, 9542.188913942306, 9700.854487182698, 9724.270679699015, 9725.756856078584, 9729.270304727139, 8542.273906717937, 8803.20771130598, 11720.589779357724, 11937.164398492108, 11967.281963082243, 11764.529418823236, 11839.585614503494, 11861.110416718737, 11873.406329683525, 11879.930806227438, 8567.528785916773, 11650.592229271977, 11684.240524365889, 11697.0, 11704.414779261004, 8584.8712269316, 8759.34304927133, 8763.561821908943, 11477.311361318347, 11791.410429478577, 40648.0, 41072.79463602693, 41137.588624113676, 41157.79421102905, 41160.97097572555, 3550.414181660023, 3570.3751843427294, 3600.207954250061, 3659.505966694489, 4245.97877010613, 31031.689683103104, 32433.51349729756, 32610.0, 32712.182195445068, 32980.83509582461, 3275.394052100369, 3322.302316513535, 3337.5494308268317, 3355.312161006988, 3400.472926696366, 522612.3869380629, 523159.0, 524702.0, 524994.0, 532698.0, 58509.70745146247, 58570.0, 59020.40979590149, 59025.0, 59051.704741476016, 61386.0, 61435.38564614386, 61456.0, 61468.0, 61497.770044599754, 15979.440719574759, 16486.917565412095, 16491.83508164927, 16510.257038433298, 16548.007119572863, 11851.703707407383, 12120.45457954394, 12984.610461686165, 13036.934815325863, 13042.804357934638, 15057.47298844557, 15272.923635381752, 15435.459758908384, 15649.60875978087, 15661.295241713922, 5656.812069465376, 5898.908701890078, 6377.17096777416, 6403.655232401248, 6441.8434966866835, 843.755310959827, 935.2891802230354, 968.7384406210284, 978.5841017567506, 1071.9517621707041, 28597.428051438856, 29410.705892940798, 30598.54102188469, 31087.0, 31233.843830781156, 1005.3917379985149, 1088.9564417423214, 1098.566066403766, 1102.8897110289067, 1152.8847115288572, 15710.685786284439, 15903.52289431319, 15941.96377235476, 16105.677886442205, 16518.0, 681507.0, 686995.0, 688315.0, 688465.0, 693043.0, 59803.401965979785, 59869.40130598725, 60082.0, 60085.39914600886, 60103.098453523235, 1262.6022802817267, 1378.0629172162826, 1422.3599380278915, 1425.2303755972073, 1439.2443966917451, 24200.152994645105, 30205.395892082473, 30226.395472090873, 30448.695513044586, 30895.2276193097, 43333.3499997494, 50226.49773502218, 50631.0, 50650.746746266035, 50844.0, 582897.0, 583419.0, 583814.0, 585322.0, 586422.0, 22881.65677514872, 25614.23157305284, 25661.230163095137, 25991.350216243987, 26066.34834129086, 45183.54816451925, 45196.77401613102, 45832.0, 46064.309035363825, 46599.0, 35973.460398094576, 37185.0, 37719.24561508809, 37994.81002594969, 38118.0, 32744.836275818467, 37533.43699844559, 37893.81053094717, 38007.42988855114, 38469.61530384772, 36917.26165476622, 37325.44011839879, 37518.2496350066, 37604.0, 37687.68093116728, 29579.26051848721, 30900.690993089782, 33563.496547551316, 33566.825161119246, 33651.83174084212, 19967.500812479804, 22578.0, 23324.3002709919, 24218.394540135934, 27960.860195699704], "value": 20038.210774477007, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.86684926577135, 375.2326492323199, 384.5251114873132, 387.2371428286275, 402.96776257899353, 15789.84210157898, 16665.83334166658, 21886.781132188713, 22311.107555697774, 22348.0, 21784.564308713816, 21898.671519927215, 22514.43713907153, 23046.65430018551, 23114.653280200768, 5924.88150236995, 5985.910211346833, 6176.72204750785, 6186.195794546703, 6200.069989501566, 3555.9111022224392, 5777.1623114648355, 6128.233970753656, 6471.805845824632, 6826.146731658543, 6823.965880170617, 6825.180978282613, 6831.760888368908, 6840.179178498587, 6855.725770969155, 6491.902621460682, 6792.184937807495, 6809.455243580551, 6811.284815094418, 6815.386615204656, 5639.182318563826, 5865.706714664249, 5884.70576471179, 5950.791722289742, 5971.343152253248, 28634.570481442795, 28733.13800585986, 28804.0, 29341.0, 29378.412431751458, 2258.7176602924633, 2281.4296425893526, 2570.974290257092, 3072.585200997859, 3532.328857517089, 16933.899296545686, 17957.396177554183, 18041.188146533437, 18332.63334733298, 18371.0, 2026.7365242518379, 2032.8576999610034, 2056.085042156241, 2092.225876425732, 2107.694384314266, 107829.46085269524, 155651.0, 157716.2114189433, 158983.0, 161467.1926640371, 21657.241996530047, 21662.100821851902, 21902.23342183016, 21910.342689719335, 21989.79056151895, 32886.68453261843, 36356.0, 36403.90566801852, 36447.0, 36488.087797804736, 10111.64609238673, 11314.717132071764, 11332.263402878787, 11379.260348077349, 11428.085753139896, 9292.581833817494, 9293.72118836436, 9299.488528130882, 9463.290253231035, 9480.194183494343, 9712.223022158352, 9838.770153730784, 9971.601135954626, 10015.349002314826, 10039.64861229868, 3193.7764356495286, 3325.334933013407, 3667.449882517644, 3772.245550889833, 3785.886423407302, 844.9239568438747, 882.1046637662778, 886.4238245140581, 922.8754118193958, 1055.6938487838595, 20720.58558828845, 21562.46093847635, 21604.35186944394, 21638.459038523848, 21659.566808663738, 914.2183433164681, 929.6885543343055, 935.4434111703525, 993.4369327135972, 1009.8384258518602, 11029.724256893642, 11381.089512838953, 11386.715332116763, 11418.371989540656, 11441.0, 601501.0, 611184.0, 624001.0, 624665.0, 626976.0, 140104.299478504, 141335.29332353477, 144911.27544362211, 145906.81139782912, 146176.26911865373, 943.5706753427174, 964.5852283518154, 967.032967032967, 1032.8244198486275, 1035.3011717091083, 19195.0, 19802.801971980094, 19883.900580497004, 19929.00354982274, 20041.799582003994, 55042.219122458046, 58921.0, 60347.69826150841, 60509.0, 61305.69347153236, 79444.0, 83991.32017359741, 84366.0, 84412.73380899415, 84777.0, 8294.37792165578, 8343.582820859054, 8434.409591328547, 8458.323334133378, 8539.658413663385, 13623.931880340535, 13685.657858553615, 13750.381232844346, 13854.307284635526, 13870.237136957565, 9846.11384975327, 11704.648860534198, 11838.348890811088, 11983.940080299542, 11992.940035299767, 11682.357470339213, 11729.120315976506, 11729.824052639387, 11893.226940248856, 11951.760964780482, 8527.445716028686, 11782.410879455821, 11898.643040708792, 12048.819267711167, 12287.894089531985, 7238.27617238272, 7538.208488108889, 7545.396368290633, 7832.099308579586, 8605.784855378666, 10645.787084258116, 10726.570937162738, 11246.0, 12015.399230038289, 12063.276203427822], "value": 11190.891231736534, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1401.481451862811, 1506.645938204522, 1554.05202826276, 1773.5122841218663, 1935.7580302462193, 7864.528128312305, 8715.389922705413, 8958.10418958104, 8972.237359824423, 8997.46015239086, 7300.269973002711, 8826.955865220665, 8830.426022308562, 8842.071582483843, 8849.690260840873, 2053.917843286274, 2139.454439118023, 2290.6105961986505, 2354.2819440070816, 2380.1788383007834, 2383.2611890314056, 2415.384077060347, 2420.721617014048, 2421.164698179134, 2422.7698368655037, 2346.9765302346927, 2368.6683864259016, 2382.7498112698177, 2383.892724827387, 2386.8567885926814, 2059.907304171308, 2258.175765845471, 2317.7682231776857, 2318.211807985293, 2333.393317737392, 2335.591271527476, 2364.054378248697, 2364.2552595932225, 2364.4798144408373, 2374.584447721642, 8797.0, 8865.68970086044, 8882.200601945857, 8896.555172241362, 8899.911000889973, 5157.355330583677, 5297.549708274802, 5304.336957880265, 5312.203169524563, 5324.813631522917, 3411.9934619287123, 3486.8779592714386, 3581.2837432513343, 3610.0433385152955, 3615.3311637347174, 1019.9013538034851, 1037.4397825174472, 1047.9109275711573, 1052.3265110329319, 1059.6238335390979, 11768.94079532846, 11796.587119450778, 11796.882031179664, 11811.173217874752, 11815.468303926344, 4345.196138714348, 4574.176648203355, 4576.382188404589, 4642.234031384851, 4805.639577031737, 9931.304808663324, 9952.303338766216, 9963.452010139512, 9984.900150998543, 9998.15015723657, 5382.165764306539, 5382.838514844561, 5383.919241211385, 5387.218853266255, 5396.757145928443, 4369.366441865912, 4535.0, 4745.1221524018165, 4868.41579010521, 4874.268859671078, 3920.2355540669864, 3955.307821131348, 4021.436998820109, 4062.7968601569805, 4075.694322925792, 1180.9291442513477, 1227.5642147037852, 1269.8603153653091, 1280.6350190195749, 1295.0934345957867, 793.8293266947519, 802.2579114319232, 912.2519533982071, 914.1589737441569, 949.639137127887, 6005.579609427298, 6036.366181550961, 6043.274807023097, 6053.909191362133, 6055.2430946131735, 890.1810334492283, 925.1349987761464, 951.900050494702, 955.2978560757838, 973.5132433783108, 3996.200759848042, 3999.7600143991453, 4019.8392064317686, 4067.511898572131, 4095.24238015968, 10477.738056548647, 10865.402402867918, 10868.619598314179, 10899.346039237513, 10924.235303528676, 9679.806403871884, 10370.911054339336, 10860.72848178786, 10890.618828341128, 10899.782004359868, 8206.876896846552, 8372.497650141011, 8384.371172162113, 8407.915920840836, 8427.241548260687, 5779.826605201851, 5904.881902361843, 5919.763209471573, 5986.790462333972, 6009.819705408845, 8544.615492302986, 9907.630582211903, 10218.591256349662, 10256.538455769658, 10272.383656980604, 9353.0, 9564.66523671668, 10284.948575257076, 10464.63373781914, 10491.370517768959, 7453.366463850633, 7462.813429664302, 7537.660805263667, 7541.622918854145, 7541.886871696819, 8235.588220589067, 8360.331173506227, 8371.832563348577, 8391.454555453876, 8399.950006249219, 7486.139094004259, 7564.583947882699, 7574.128975167926, 7604.581748003913, 7719.845603088019, 7485.4385921055045, 7516.436267280085, 7583.2416758323725, 7625.275598818103, 7656.310932016146, 6973.12835895513, 7154.785356439315, 7156.821079473055, 7159.534630249017, 7165.964170179324, 4911.68074075184, 4943.530364615356, 4978.551930326288, 4979.278004689228, 5076.6446348755235, 4962.157235695027, 4996.125678006407, 5051.696898186121, 5176.534111929794, 5193.42872284056], "value": 4597.550208812896, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.3581796137093, 312.89987204094683, 314.7686450458913, 320.1356337887704, 322.63864471791595, 4551.977240113799, 4561.9963608006265, 4701.95298047019, 5423.755930983105, 5469.917951230735, 4498.347739577759, 4897.265410188474, 5149.201873709571, 5431.474364420544, 5517.779288828442, 3314.801111933292, 3667.9083022924374, 3810.428435734634, 4010.218007488541, 4108.77401742904, 4094.8092770367857, 4159.625633692982, 4179.2895207814745, 4210.852620158295, 4243.618074373306, 4122.711410201287, 4126.896827579305, 4129.545749967501, 4154.792260386984, 4175.686823488235, 3590.2819436112622, 3883.825227864753, 4021.256067627469, 4043.8660038470275, 4073.6964171465142, 3538.2224953411446, 3557.946630800514, 3572.6427357264324, 3582.6238244984424, 3594.245208506217, 4380.1966741285605, 5190.273361729361, 5193.428722840485, 5256.605754568384, 5261.947380526184, 4161.91676166475, 4519.728816271035, 4738.19450693383, 4746.620270378396, 4753.215719406294, 4531.297648864432, 5531.474509921551, 5587.161925711135, 5588.888222235573, 5640.0, 3963.960360396388, 3973.324534829086, 3975.8608448704445, 3976.920461590781, 3985.5815139410524, 5763.423657634203, 5954.970225148846, 5969.701814693414, 6047.15339852421, 6077.0276755719315, 3715.702743780491, 3942.9211415771524, 3986.2824691555797, 3986.661133803659, 4007.6994225432627, 3438.3123375325035, 4051.5948405159247, 4076.898077548085, 4121.340585506305, 4123.113530590937, 4579.793909274091, 4650.627949764011, 4736.313234580966, 4750.572448479654, 4789.185838407479, 4786.928196077061, 5762.476455982034, 5768.855778605484, 5769.624974376652, 5793.826185214451, 1247.4137155536882, 1255.8320761691532, 1351.2230467481238, 1373.8282714660668, 1422.5092343141807, 769.5075151902787, 813.4305985809957, 850.9617067231866, 869.7260362985639, 878.4114643189079, 4830.951690483121, 5210.036143313499, 5353.277307563507, 5426.937763649867, 5439.878447405515, 5300.469953004746, 5602.907433050516, 5667.064934285879, 5930.673812940244, 5988.730507127189, 4490.550944905483, 4526.54551265724, 5300.602454815904, 5316.122839731478, 5374.044275648378, 2960.86676099576, 3096.365245124744, 3114.4394009078583, 3115.4236466253815, 3135.0249342913817, 4670.789814458358, 5257.737113144328, 5532.529734972572, 6058.000429929012, 6093.293877714247, 5459.972700136474, 5836.88326233473, 5973.551983601247, 6031.125486804476, 6046.879062418727, 4811.0, 5725.456081672234, 6039.969800151059, 6072.908906366408, 6096.829648582712, 4899.681520701143, 5469.031148786354, 5675.971620141873, 5817.127430885401, 5862.296524417097, 4575.816967321403, 5783.958887400308, 5808.651480911159, 5815.86590614826, 5833.912491312549, 5670.688112153706, 6052.061930400795, 6055.607210341558, 6078.848028799315, 6160.507159427146, 3475.721942244665, 3813.339194373322, 4072.6131017553284, 4139.758072578275, 4144.362976624277, 5432.456754324536, 5636.140073775562, 5981.401859813984, 6012.849678757891, 6028.367021462684, 4317.3594034268035, 4894.486078961801, 5200.089984252816, 5493.945060549503, 5619.223659889061, 4776.331313616166, 5257.106291930305, 5502.202180683858, 5758.625689330348, 5771.68255745938, 4718.575328220477, 5425.891482170256, 5652.095664693629, 5698.544116470755, 5705.400932902152, 5224.451432599522, 5676.262085928803, 5709.600327977002, 5729.187482514708, 5855.0, 4652.651051171243, 5583.330000399978, 5587.860303492445, 5610.691411972218, 5655.7454914528125], "value": 4140.654362500687, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.4131177681409, 772.404195039515, 779.0028763183124, 824.43938122077, 842.8549341924798, 15086.924565377172, 16279.918600406982, 16284.83715162848, 16285.674286514277, 16308.429204977798, 14762.704745905075, 14971.176585287805, 14976.625584360396, 14979.0, 14992.850071499282, 700.2437367642946, 730.0946825935854, 860.8192279621287, 883.2360008592553, 891.2825175733532, 875.9605817738185, 884.0805562215288, 886.9157430044136, 887.0, 887.0641473245723, 939.3847030195199, 939.6006697153716, 939.8966113727485, 941.0683423410842, 945.3477100800426, 740.7481456304855, 767.0603510699405, 768.2509553185655, 770.5646309834925, 908.6501696846761, 700.7967689370076, 700.8983697363905, 701.1901254051528, 701.5685353507556, 702.1749444402807, 15010.249487525689, 15014.549563513003, 15052.548423547201, 15060.623484412868, 15066.698666026618, 14112.788308175386, 14302.92848535761, 14360.066595671247, 14378.568642940729, 14560.927195364062, 13064.804027939588, 13095.214287142802, 13105.2136871788, 13129.737405251937, 13506.59480215595, 4474.351219073249, 4636.3045543168455, 4688.437387513486, 4711.10489007091, 4726.550977657117, 125253.0, 126566.0, 126648.73351266554, 126705.73294267032, 127001.36499317536, 11114.833277500844, 11284.153688473398, 11421.486033128529, 11519.942400287944, 12031.75936481283, 22747.09011639549, 22822.42943926415, 22847.657285140736, 22873.656895146585, 22969.540609188058, 7805.0, 7900.683972641145, 7917.327027202752, 7994.960025199837, 8060.798480038046, 4333.328334108218, 4387.319965405367, 4390.7585082820115, 4399.1641588098155, 4548.204064288736, 3430.2281986552825, 3580.7672501287334, 3581.552305961755, 3591.174029973121, 3602.7838329700303, 652.3857827634944, 679.4768028617937, 713.2297119111347, 721.9350258476762, 725.7496163823472, 552.1331509529999, 570.5521165884843, 600.2826622186533, 606.7467055937819, 620.711369213318, 9157.496337701357, 9520.966722883071, 9591.520423978773, 9657.090358304598, 9871.160951319074, 563.4281204577358, 618.5824568416301, 622.9065640154013, 633.9603050996369, 681.7375310505491, 4564.42944631921, 4640.373549570832, 4646.233371493666, 4652.255639097728, 4728.71627702339, 88782.0, 144398.0, 144823.82764258544, 145959.0, 149263.0, 122775.0, 123242.0, 123937.38031309786, 126464.0, 128533.0, 104916.47541762242, 107302.99999999844, 108764.0, 110530.0, 111938.0, 7799.64901579419, 8465.0, 8950.373473856767, 8987.46075235488, 9161.450312981242, 62026.37973620387, 62162.44593885189, 62886.74226515536, 64976.350236497026, 65538.0, 82895.17104829116, 85558.57220713857, 87329.0, 91491.0, 93903.0, 11939.52241910314, 12044.0, 12064.336461494702, 12224.0, 12741.936290318488, 10677.0, 11417.657470275904, 12426.502939882303, 13497.392617332047, 13805.619438056114, 12344.197627154206, 12862.935685321514, 13003.739925201633, 13143.14569552976, 13146.0, 12333.0, 12697.717040519277, 12975.545855894998, 13211.933940330237, 13308.933455333048, 12044.397780111134, 12271.687506541326, 12407.813882791585, 12536.623901282976, 12796.936015319863, 10593.470326483492, 10605.469726513798, 10715.892841071802, 10727.271822880373, 11379.487923043649, 9730.41617502952, 10090.394576325443, 10139.847902281324, 10561.89438105609, 10588.205884558844], "value": 7811.86013945968, "unit": "score"}], "name": "dromaeo_css", "value": 7574.4107453455645, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 115.0, 112.0, 113.0, 113.0, 112.0, 114.0, 114.0, 113.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 113.0, 104.0, 153.0, 107.0, 107.0, 128.0, 105.0, 138.0, 106.0], "value": 120.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 185.0, 182.0, 186.0, 198.0, 257.0, 181.0, 182.0, 182.0], "value": 191.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 73.0, 58.0, 108.0, 58.0, 57.0, 59.0, 65.0, 99.0, 59.0], "value": 71.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 90.0, 91.0, 71.0, 70.0, 69.0, 97.0, 70.0, 67.0, 102.0], "value": 81.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 87.0, 83.0, 87.0, 83.0, 88.0, 83.0, 86.0, 83.0], "value": 85.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 92.0, 93.0, 92.0, 92.0, 93.0, 93.0, 93.0, 92.0], "value": 92.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 91.0, 130.0, 129.0, 83.0, 82.0, 86.0, 87.0, 87.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 57.0, 56.0, 56.0, 53.0, 62.0, 77.0, 82.0, 81.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 70.0, 73.0, 75.0, 71.0, 71.0, 70.0, 69.0, 69.0, 68.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 83.0, 85.0, 85.0, 84.0, 79.0, 84.0, 82.0, 83.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 136.0, 141.0, 137.0, 146.0, 117.0, 141.0, 248.0, 146.0], "value": 148.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 211.0, 183.0, 164.0, 166.0, 170.0, 216.0, 205.0, 163.0], "value": 180.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 68.0, 66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1461.8000000000002, "alertThreshold": 2.0}]} 14:00:55 INFO - Return code: 0 14:00:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:00:55 INFO - # TBPL SUCCESS # 14:00:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:00:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:00:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:00:55 INFO - 2016-07-07 14:00:55.850 screenresolution[1666:9836] starting screenresolution argv=screenresolution get 14:00:55 INFO - 2016-07-07 14:00:55.852 screenresolution[1666:9836] Display 0: 1600x1200x32@60 14:00:55 INFO - 2016-07-07 14:00:55.859 screenresolution[1667:9839] starting screenresolution argv=screenresolution list 14:00:55 INFO - Available Modes on Display 0 14:00:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:00:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:00:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:00:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:00:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:00:56 INFO - Intel Iris: 14:00:56 INFO - Chipset Model: Intel Iris 14:00:56 INFO - Type: GPU 14:00:56 INFO - Bus: Built-In 14:00:56 INFO - VRAM (Dynamic, Max): 1536 MB 14:00:56 INFO - Vendor: Intel (0x8086) 14:00:56 INFO - Device ID: 0x0a2e 14:00:56 INFO - Revision ID: 0x0009 14:00:56 INFO - Displays: 14:00:56 INFO - Display: 14:00:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:00:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:00:56 INFO - Display Serial Number: 1600x1200 60 14:00:56 INFO - Main Display: Yes 14:00:56 INFO - Mirror: Off 14:00:56 INFO - Online: Yes 14:00:56 INFO - Rotation: Supported 14:00:56 INFO - Return code: 0 14:00:56 INFO - Running post-action listener: _resource_record_post_action 14:00:56 INFO - ##### 14:00:56 INFO - ##### Finished run-tests step (success) 14:00:56 INFO - ##### 14:00:56 INFO - Running post-run listener: _resource_record_post_run 14:00:56 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 36910592; Write bytes: 705440256; Read time: 244; Write time: 1901 14:00:56 INFO - TinderboxPrint: CPU usage
53.4% 14:00:56 INFO - TinderboxPrint: I/O read bytes / time
36,910,592 / 244 14:00:56 INFO - TinderboxPrint: I/O write bytes / time
705,440,256 / 1,901 14:00:56 INFO - TinderboxPrint: CPU idle
2,255.8 (46.6%) 14:00:56 INFO - TinderboxPrint: CPU system
963.5 (19.9%) 14:00:56 INFO - TinderboxPrint: CPU user
1,626.3 (33.6%) 14:00:56 INFO - TinderboxPrint: Swap in / out
443,318,272 / 0 14:00:56 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 400904704; Write bytes: 395363840; Read time: 29425; Write time: 784 14:00:56 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 34797056; Write bytes: 294327296; Read time: 221; Write time: 1077 14:00:56 INFO - Running post-run listener: _upload_blobber_files 14:00:56 INFO - Blob upload gear active. 14:00:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:00:56 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 14:00:56 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'] 14:00:56 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 14:00:56 INFO - (blobuploader) - INFO - Open directory for files ... 14:00:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:00:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:00:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:00:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:00:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:00:58 INFO - (blobuploader) - INFO - Done attempting. 14:00:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:00:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:00:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:00:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:00:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:00:59 INFO - (blobuploader) - INFO - Done attempting. 14:00:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:00:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:00:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:01:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:01:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:01:01 INFO - (blobuploader) - INFO - Done attempting. 14:01:01 INFO - (blobuploader) - INFO - Iteration through files over. 14:01:01 INFO - Return code: 0 14:01:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:01:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:01:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5dcaabfe2ae22acb7607f5c9ec612cafc8bb2760e34e0f55869f1801bfbb9df839e0c00492309081f99e0e430fee3e97bc2aad7bcd9da960bb8a830f0504a217", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa0aadcd5834725b5aa262411ee6639f0e81fdc524653f847a2a4d38040bc2bf530763990bca22a2f6e6b076fdfc72dee6ad3b9a3ffa2988ea49838e44138a36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/681eabad61d25c262e9a54b17e53387838f1107ddeea0b67b9c8dac603c93589c28c0c6c105a3017b12751d6d033fdd8bac54ea3a610bb677d13d3451bf13ca6"} 14:01:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:01:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:01:01 INFO - Contents: 14:01:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5dcaabfe2ae22acb7607f5c9ec612cafc8bb2760e34e0f55869f1801bfbb9df839e0c00492309081f99e0e430fee3e97bc2aad7bcd9da960bb8a830f0504a217", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa0aadcd5834725b5aa262411ee6639f0e81fdc524653f847a2a4d38040bc2bf530763990bca22a2f6e6b076fdfc72dee6ad3b9a3ffa2988ea49838e44138a36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/681eabad61d25c262e9a54b17e53387838f1107ddeea0b67b9c8dac603c93589c28c0c6c105a3017b12751d6d033fdd8bac54ea3a610bb677d13d3451bf13ca6"} 14:01:01 INFO - Running post-run listener: copy_logs_to_upload_dir 14:01:01 INFO - Copying logs to upload dir... 14:01:01 INFO - mkdir: /builds/slave/test/build/upload/logs 14:01:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.668570 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-07-07 14:01:01.569550) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 14:01:01.577234) ========= 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.VbohmCL0WJ/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.HLkaDJSNOv/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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/5dcaabfe2ae22acb7607f5c9ec612cafc8bb2760e34e0f55869f1801bfbb9df839e0c00492309081f99e0e430fee3e97bc2aad7bcd9da960bb8a830f0504a217", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa0aadcd5834725b5aa262411ee6639f0e81fdc524653f847a2a4d38040bc2bf530763990bca22a2f6e6b076fdfc72dee6ad3b9a3ffa2988ea49838e44138a36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/681eabad61d25c262e9a54b17e53387838f1107ddeea0b67b9c8dac603c93589c28c0c6c105a3017b12751d6d033fdd8bac54ea3a610bb677d13d3451bf13ca6"} build_url:https://queue.taskcluster.net/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011144 build_url: 'https://queue.taskcluster.net/v1/task/GE14KEdnQX6CVHQ_iqIYeQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5dcaabfe2ae22acb7607f5c9ec612cafc8bb2760e34e0f55869f1801bfbb9df839e0c00492309081f99e0e430fee3e97bc2aad7bcd9da960bb8a830f0504a217", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa0aadcd5834725b5aa262411ee6639f0e81fdc524653f847a2a4d38040bc2bf530763990bca22a2f6e6b076fdfc72dee6ad3b9a3ffa2988ea49838e44138a36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/681eabad61d25c262e9a54b17e53387838f1107ddeea0b67b9c8dac603c93589c28c0c6c105a3017b12751d6d033fdd8bac54ea3a610bb677d13d3451bf13ca6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 14:01:01.609824) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 14:01:01.610197) ========= 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.VbohmCL0WJ/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.HLkaDJSNOv/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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.005156 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 14:01:01.660144) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 14:01:01.660696) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 14:01:01.661254) ========= ========= Total master_lag: 1.11 =========