builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0038 starttime: 1467866761.29 results: success (0) buildid: 20160706193622 builduid: 041331d3b3814245a20f3f7d8ae8a679 revision: c0e2702226bbb18cc6f907e0a6c41e2bc3727e74 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 21:46:01.294322) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 21:46:01.294763) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-07-06 21:46:01.295041) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-07-06 21:46:02.619050) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 21:46:02.619378) ========= 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.JEDmEnxpGQ/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.euPzo002s7/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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-06 21:46:02-- 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% 24.7M=0s 2016-07-06 21:46:02 (24.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132936 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 21:46:02.778883) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 21:46:02.779207) ========= 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.JEDmEnxpGQ/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.euPzo002s7/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.030654 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 21:46:02.830607) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 21:46:02.830970) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c0e2702226bbb18cc6f907e0a6c41e2bc3727e74 --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 c0e2702226bbb18cc6f907e0a6c41e2bc3727e74 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JEDmEnxpGQ/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.euPzo002s7/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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-06 21:46:02,905 truncating revision to first 12 chars 2016-07-06 21:46:02,905 Setting DEBUG logging. 2016-07-06 21:46:02,905 attempt 1/10 2016-07-06 21:46:02,905 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c0e2702226bb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 21:46:03,988 unpacking tar archive at: fx-team-c0e2702226bb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.365324 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 21:46:04.248324) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 21:46:04.248691) ========= script_repo_revision: c0e2702226bbb18cc6f907e0a6c41e2bc3727e74 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 21:46:04.249117) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 21:46:04.249401) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 21:46:04.273472) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-07-06 21:46:04.273822) ========= /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.JEDmEnxpGQ/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.euPzo002s7/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 21:46:04 INFO - MultiFileLogger online at 20160706 21:46:04 in /builds/slave/test 21:46:04 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 21:46:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:46:04 INFO - {'append_to_log': False, 21:46:04 INFO - 'base_work_dir': '/builds/slave/test', 21:46:04 INFO - 'blob_upload_branch': 'Fx-Team', 21:46:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:46:04 INFO - 'branch': 'Fx-Team', 21:46:04 INFO - 'buildbot_json_path': 'buildprops.json', 21:46:04 INFO - 'config_files': ('talos/mac_config.py',), 21:46:04 INFO - 'default_actions': ('clobber', 21:46:04 INFO - 'read-buildbot-config', 21:46:04 INFO - 'download-and-extract', 21:46:04 INFO - 'populate-webroot', 21:46:04 INFO - 'create-virtualenv', 21:46:04 INFO - 'install', 21:46:04 INFO - 'run-tests'), 21:46:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:46:04 INFO - 'download_minidump_stackwalk': True, 21:46:04 INFO - 'download_symbols': 'ondemand', 21:46:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:46:04 INFO - 'tooltool.py': '/tools/tooltool.py', 21:46:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:46:04 INFO - '/tools/misc-python/virtualenv.py')}, 21:46:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:46:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:46:04 INFO - 'installer_path': 'installer.exe', 21:46:04 INFO - 'log_level': 'info', 21:46:04 INFO - 'log_name': 'talos', 21:46:04 INFO - 'log_to_console': True, 21:46:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:46:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:46:04 INFO - 'opt_config_files': (), 21:46:04 INFO - 'pip_index': False, 21:46:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:46:04 INFO - 'cmd': ('bash', 21:46:04 INFO - '-c', 21:46:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:46:04 INFO - 'enabled': True, 21:46:04 INFO - 'halt_on_failure': False, 21:46:04 INFO - 'name': 'check_screen_resolution'},), 21:46:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:46:04 INFO - 'cmd': ('bash', 21:46:04 INFO - '-c', 21:46:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:46:04 INFO - 'enabled': True, 21:46:04 INFO - 'halt_on_failure': False, 21:46:04 INFO - 'name': 'check_screen_resolution'},), 21:46:04 INFO - 'run_cmd_checks_enabled': True, 21:46:04 INFO - 'sps_profile': False, 21:46:04 INFO - 'sps_profile_interval': 0, 21:46:04 INFO - 'suite': 'dromaeojs', 21:46:04 INFO - 'system_bits': '32', 21:46:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:46:04 INFO - 'title': 't-yosemite-r7-0038', 21:46:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:46:04 INFO - 'use_talos_json': True, 21:46:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:46:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:46:04 INFO - 'work_dir': 'build'} 21:46:04 INFO - ##### 21:46:04 INFO - ##### Running clobber step. 21:46:04 INFO - ##### 21:46:04 INFO - Running pre-action listener: _resource_record_pre_action 21:46:04 INFO - Running main action method: clobber 21:46:04 INFO - rmtree: /builds/slave/test/build 21:46:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:46:06 INFO - Running post-action listener: _resource_record_post_action 21:46:06 INFO - ##### 21:46:06 INFO - ##### Finished clobber step (success) 21:46:06 INFO - ##### 21:46:06 INFO - ##### 21:46:06 INFO - ##### Running read-buildbot-config step. 21:46:06 INFO - ##### 21:46:06 INFO - Running pre-action listener: _resource_record_pre_action 21:46:06 INFO - Running main action method: read_buildbot_config 21:46:06 INFO - Using buildbot properties: 21:46:06 INFO - { 21:46:06 INFO - "project": "", 21:46:06 INFO - "product": "firefox", 21:46:06 INFO - "script_repo_revision": "production", 21:46:06 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 21:46:06 INFO - "repository": "", 21:46:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 21:46:06 INFO - "buildid": "20160706193622", 21:46:06 INFO - "pgo_build": "False", 21:46:06 INFO - "basedir": "/builds/slave/test", 21:46:06 INFO - "buildnumber": 91, 21:46:06 INFO - "slavename": "t-yosemite-r7-0038", 21:46:06 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 21:46:06 INFO - "platform": "yosemite_r7", 21:46:06 INFO - "scheduler": "tests-fx-team-macosx64-talos", 21:46:06 INFO - "branch": "fx-team", 21:46:06 INFO - "repo_path": "integration/fx-team", 21:46:06 INFO - "revision": "c0e2702226bbb18cc6f907e0a6c41e2bc3727e74", 21:46:06 INFO - "stage_platform": "macosx64", 21:46:06 INFO - "builduid": "041331d3b3814245a20f3f7d8ae8a679", 21:46:06 INFO - "slavebuilddir": "test" 21:46:06 INFO - } 21:46:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/RlfCi6KMRZG1EKtcF73ryA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 21:46:06 INFO - Running post-action listener: _resource_record_post_action 21:46:06 INFO - ##### 21:46:06 INFO - ##### Finished read-buildbot-config step (success) 21:46:06 INFO - ##### 21:46:06 INFO - ##### 21:46:06 INFO - ##### Running download-and-extract step. 21:46:06 INFO - ##### 21:46:06 INFO - Running pre-action listener: _resource_record_pre_action 21:46:06 INFO - Running main action method: download_and_extract 21:46:06 INFO - mkdir: /builds/slave/test/build/tests 21:46:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:06 INFO - https://queue.taskcluster.net/v1/task/RlfCi6KMRZG1EKtcF73ryA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 21:46:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlfCi6KMRZG1EKtcF73ryA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 21:46:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlfCi6KMRZG1EKtcF73ryA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 21:46:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlfCi6KMRZG1EKtcF73ryA/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 21:46:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlfCi6KMRZG1EKtcF73ryA/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 21:46:07 INFO - Downloaded 1199 bytes. 21:46:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 21:46:07 INFO - Using the following test package requirements: 21:46:07 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 21:46:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 21:46:07 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 21:46:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 21:46:07 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 21:46:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 21:46:07 INFO - u'jsshell-mac.zip'], 21:46:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 21:46:07 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 21:46:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 21:46:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 21:46:07 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 21:46:07 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 21:46:07 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 21:46:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 21:46:07 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 21:46:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 21:46:07 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 21:46:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:46:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:07 INFO - https://queue.taskcluster.net/v1/task/RlfCi6KMRZG1EKtcF73ryA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:46:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlfCi6KMRZG1EKtcF73ryA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 21:46:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlfCi6KMRZG1EKtcF73ryA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 21:46:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlfCi6KMRZG1EKtcF73ryA/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 21:46:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlfCi6KMRZG1EKtcF73ryA/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 21:46:09 INFO - Downloaded 18804832 bytes. 21:46:09 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'] 21:46:09 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 21:46:13 INFO - Return code: 0 21:46:13 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 21:46:13 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')]} 21:46:13 INFO - https://queue.taskcluster.net/v1/task/RlfCi6KMRZG1EKtcF73ryA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:46:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlfCi6KMRZG1EKtcF73ryA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 21:46:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlfCi6KMRZG1EKtcF73ryA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 21:46:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlfCi6KMRZG1EKtcF73ryA/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 21:46:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlfCi6KMRZG1EKtcF73ryA/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 21:46:14 INFO - Downloaded 18804832 bytes. 21:46:14 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'] 21:46:14 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 21:46:17 INFO - Return code: 0 21:46: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')]} 21:46:17 INFO - https://queue.taskcluster.net/v1/task/RlfCi6KMRZG1EKtcF73ryA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 21:46:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlfCi6KMRZG1EKtcF73ryA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 21:46:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlfCi6KMRZG1EKtcF73ryA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 21:46:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlfCi6KMRZG1EKtcF73ryA/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 21:46:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlfCi6KMRZG1EKtcF73ryA/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 21:46:19 INFO - Downloaded 14403333 bytes. 21:46:19 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'] 21:46:19 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 21:46:19 INFO - Return code: 0 21:46:19 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')]} 21:46:19 INFO - https://queue.taskcluster.net/v1/task/RlfCi6KMRZG1EKtcF73ryA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 21:46:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlfCi6KMRZG1EKtcF73ryA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 21:46:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlfCi6KMRZG1EKtcF73ryA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 21:46:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlfCi6KMRZG1EKtcF73ryA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 21:46:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlfCi6KMRZG1EKtcF73ryA/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 21:46:22 INFO - Downloaded 112391509 bytes. 21:46:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RlfCi6KMRZG1EKtcF73ryA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 21:46:22 INFO - mkdir: /builds/slave/test/properties 21:46:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:46:22 INFO - Writing to file /builds/slave/test/properties/build_url 21:46:22 INFO - Contents: 21:46:22 INFO - build_url:https://queue.taskcluster.net/v1/task/RlfCi6KMRZG1EKtcF73ryA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 21:46:23 INFO - Running post-action listener: _resource_record_post_action 21:46:23 INFO - Running post-action listener: set_extra_try_arguments 21:46:23 INFO - ##### 21:46:23 INFO - ##### Finished download-and-extract step (success) 21:46:23 INFO - ##### 21:46:23 INFO - ##### 21:46:23 INFO - ##### Running populate-webroot step. 21:46:23 INFO - ##### 21:46:23 INFO - Running pre-action listener: _resource_record_pre_action 21:46:23 INFO - Running main action method: populate_webroot 21:46:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:46:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:46:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:46:23 INFO - '--tppagecycles', 21:46:23 INFO - '7'], 21:46:23 INFO - 'tests': ['tsvgm']}}, 21:46:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:46:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:46:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:46:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:46:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:46:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:46:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:23 INFO - 'talos_options': ['--disable-e10s'], 21:46:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:46:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:46:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:23 INFO - 'talos_options': ['--disable-e10s'], 21:46:23 INFO - 'tests': ['damp', 'tps']}, 21:46:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:23 INFO - 'tests': ['damp', 'tps']}, 21:46:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:46:23 INFO - 'tests': ['dromaeo_dom']}, 21:46:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:46:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:46:23 INFO - 'tests': ['basic_compositor_video']}, 21:46:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:46:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:46:23 INFO - 'tests': ['a11yr', 21:46:23 INFO - 'ts_paint', 21:46:23 INFO - 'tpaint', 21:46:23 INFO - 'sessionrestore', 21:46:23 INFO - 'sessionrestore_no_auto_restore', 21:46:23 INFO - 'tabpaint']}, 21:46:23 INFO - 'other-e10s': {'tests': ['a11yr', 21:46:23 INFO - 'ts_paint', 21:46:23 INFO - 'tpaint', 21:46:23 INFO - 'sessionrestore', 21:46:23 INFO - 'sessionrestore_no_auto_restore', 21:46:23 INFO - 'tabpaint']}, 21:46:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:46:23 INFO - 'ts_paint', 21:46:23 INFO - 'tpaint', 21:46:23 INFO - 'sessionrestore', 21:46:23 INFO - 'sessionrestore_no_auto_restore', 21:46:23 INFO - 'tabpaint']}, 21:46:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:46:23 INFO - 'ts_paint', 21:46:23 INFO - 'tpaint', 21:46:23 INFO - 'sessionrestore', 21:46:23 INFO - 'sessionrestore_no_auto_restore', 21:46:23 INFO - 'tabpaint']}, 21:46:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:46:23 INFO - 'tests': ['a11yr', 21:46:23 INFO - 'ts_paint', 21:46:23 INFO - 'tpaint', 21:46:23 INFO - 'sessionrestore', 21:46:23 INFO - 'sessionrestore_no_auto_restore', 21:46:23 INFO - 'tabpaint']}, 21:46:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:46:23 INFO - 'tests': ['a11yr', 21:46:23 INFO - 'ts_paint', 21:46:23 INFO - 'tpaint', 21:46:23 INFO - 'sessionrestore', 21:46:23 INFO - 'sessionrestore_no_auto_restore', 21:46:23 INFO - 'tabpaint']}, 21:46:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:46:23 INFO - 'tests': ['tsvgx', 21:46:23 INFO - 'tsvgr_opacity', 21:46:23 INFO - 'tart', 21:46:23 INFO - 'tscrollx', 21:46:23 INFO - 'cart']}, 21:46:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:46:23 INFO - 'tsvgr_opacity', 21:46:23 INFO - 'tart', 21:46:23 INFO - 'tscrollx', 21:46:23 INFO - 'cart']}, 21:46:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:23 INFO - 'talos_options': ['--disable-e10s'], 21:46:23 INFO - 'tests': ['tp5o']}, 21:46:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:23 INFO - 'tests': ['tp5o']}, 21:46:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:23 INFO - 'talos_options': ['--disable-e10s', 21:46:23 INFO - '--xperf_path', 21:46:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:46:23 INFO - 'tests': ['tp5n']}, 21:46:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:23 INFO - 'talos_options': ['--xperf_path', 21:46:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:46:23 INFO - 'tests': ['tp5n']}}, 21:46:23 INFO - 'talos.zip': {'path': '', 21:46:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:46:23 INFO - Running post-action listener: _resource_record_post_action 21:46:23 INFO - ##### 21:46:23 INFO - ##### Finished populate-webroot step (success) 21:46:23 INFO - ##### 21:46:23 INFO - ##### 21:46:23 INFO - ##### Running create-virtualenv step. 21:46:23 INFO - ##### 21:46:23 INFO - Running pre-action listener: _resource_record_pre_action 21:46:23 INFO - Running main action method: create_virtualenv 21:46:23 INFO - Creating virtualenv /builds/slave/test/build/venv 21:46:23 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 21:46:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:46:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:46:23 INFO - Using real prefix '/tools/python27' 21:46:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:46:24 INFO - Installing distribute.............................................................................................................................................................................................done. 21:46:27 INFO - Installing pip.................done. 21:46:27 INFO - Return code: 0 21:46:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:46:27 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')]} 21:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:27 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')]} 21:46:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:27 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 0x10ba7ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb11618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb67954d330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9e0d30>, '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 0x10b745db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9d8b20>, '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.JEDmEnxpGQ/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.euPzo002s7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 21:46:27 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 21:46:27 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 21:46:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JEDmEnxpGQ/Render', 21:46:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:46:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:27 INFO - 'HOME': '/Users/cltbld', 21:46:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:46:27 INFO - 'LOGNAME': 'cltbld', 21:46:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:27 INFO - 'MOZ_NO_REMOTE': '1', 21:46:27 INFO - 'NO_EM_RESTART': '1', 21:46:27 INFO - 'PAGER': '/bin/cat', 21:46:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:46:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:27 INFO - 'PWD': '/builds/slave/test', 21:46:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:46:27 INFO - 'SHELL': '/bin/bash', 21:46:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euPzo002s7/Listeners', 21:46:27 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 21:46:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:46:27 INFO - 'USER': 'cltbld', 21:46:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:46:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:46:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:27 INFO - 'XPC_FLAGS': '0x0', 21:46:27 INFO - 'XPC_SERVICE_NAME': '0', 21:46:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:46:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:27 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 21:46:27 INFO - Cleaning up... 21:46:27 INFO - Return code: 0 21:46:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:46:27 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')]} 21:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:27 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')]} 21:46:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:27 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 0x10ba7ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb11618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb67954d330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9e0d30>, '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 0x10b745db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9d8b20>, '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.JEDmEnxpGQ/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.euPzo002s7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 21:46:27 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 21:46:27 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 21:46:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JEDmEnxpGQ/Render', 21:46:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:46:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:27 INFO - 'HOME': '/Users/cltbld', 21:46:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:46:27 INFO - 'LOGNAME': 'cltbld', 21:46:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:27 INFO - 'MOZ_NO_REMOTE': '1', 21:46:27 INFO - 'NO_EM_RESTART': '1', 21:46:27 INFO - 'PAGER': '/bin/cat', 21:46:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:46:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:27 INFO - 'PWD': '/builds/slave/test', 21:46:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:46:27 INFO - 'SHELL': '/bin/bash', 21:46:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euPzo002s7/Listeners', 21:46:27 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 21:46:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:46:27 INFO - 'USER': 'cltbld', 21:46:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:46:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:46:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:27 INFO - 'XPC_FLAGS': '0x0', 21:46:27 INFO - 'XPC_SERVICE_NAME': '0', 21:46:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:46:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:27 INFO - Downloading/unpacking psutil>=3.1.1 21:46:27 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 21:46:27 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 21:46:27 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 21:46:27 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 21:46:27 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 21:46:27 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 21:46:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:46:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:46:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:46:30 INFO - Installing collected packages: psutil 21:46:30 INFO - Running setup.py install for psutil 21:46:30 INFO - building 'psutil._psutil_osx' extension 21:46:30 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 21:46:31 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 21:46:31 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 21:46:31 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 21:46:31 INFO - building 'psutil._psutil_posix' extension 21:46:31 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 21:46:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:46:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:46:31 INFO - ^ 21:46:31 INFO - 1 warning generated. 21:46:31 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 21:46:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:46:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:46:31 INFO - Successfully installed psutil 21:46:31 INFO - Cleaning up... 21:46:31 INFO - Return code: 0 21:46:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:46:31 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')]} 21:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:31 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')]} 21:46:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:31 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 0x10ba7ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb11618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb67954d330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9e0d30>, '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 0x10b745db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9d8b20>, '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.JEDmEnxpGQ/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.euPzo002s7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 21:46:31 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 21:46:31 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 21:46:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JEDmEnxpGQ/Render', 21:46:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:46:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:31 INFO - 'HOME': '/Users/cltbld', 21:46:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:46:31 INFO - 'LOGNAME': 'cltbld', 21:46:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:31 INFO - 'MOZ_NO_REMOTE': '1', 21:46:31 INFO - 'NO_EM_RESTART': '1', 21:46:31 INFO - 'PAGER': '/bin/cat', 21:46:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:46:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:31 INFO - 'PWD': '/builds/slave/test', 21:46:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:46:31 INFO - 'SHELL': '/bin/bash', 21:46:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euPzo002s7/Listeners', 21:46:31 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 21:46:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:46:31 INFO - 'USER': 'cltbld', 21:46:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:46:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:46:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:31 INFO - 'XPC_FLAGS': '0x0', 21:46:31 INFO - 'XPC_SERVICE_NAME': '0', 21:46:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:46:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:46:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:46:34 INFO - Installing collected packages: mozsystemmonitor 21:46:34 INFO - Running setup.py install for mozsystemmonitor 21:46:34 INFO - Successfully installed mozsystemmonitor 21:46:34 INFO - Cleaning up... 21:46:34 INFO - Return code: 0 21:46:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:46:34 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')]} 21:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:34 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')]} 21:46:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:34 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 0x10ba7ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb11618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb67954d330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9e0d30>, '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 0x10b745db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9d8b20>, '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.JEDmEnxpGQ/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.euPzo002s7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 21:46:34 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 21:46:34 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 21:46:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JEDmEnxpGQ/Render', 21:46:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:46:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:34 INFO - 'HOME': '/Users/cltbld', 21:46:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:46:34 INFO - 'LOGNAME': 'cltbld', 21:46:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:34 INFO - 'MOZ_NO_REMOTE': '1', 21:46:34 INFO - 'NO_EM_RESTART': '1', 21:46:34 INFO - 'PAGER': '/bin/cat', 21:46:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:46:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:34 INFO - 'PWD': '/builds/slave/test', 21:46:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:46:34 INFO - 'SHELL': '/bin/bash', 21:46:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euPzo002s7/Listeners', 21:46:34 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 21:46:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:46:34 INFO - 'USER': 'cltbld', 21:46:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:46:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:46:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:34 INFO - 'XPC_FLAGS': '0x0', 21:46:34 INFO - 'XPC_SERVICE_NAME': '0', 21:46:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:46:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:35 INFO - Downloading/unpacking jsonschema==2.5.1 21:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:46:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:46:37 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 21:46:37 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 21:46:37 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 21:46:37 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 21:46:37 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 21:46:37 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 21:46:38 INFO - Downloading functools32-3.2.3-2.tar.gz 21:46:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:46:38 INFO - warning: no files found matching '*.txt' 21:46:38 INFO - no previously-included directories found matching 'build' 21:46:38 INFO - no previously-included directories found matching 'dist' 21:46:38 INFO - no previously-included directories found matching '.git*' 21:46:38 INFO - Installing collected packages: jsonschema, functools32 21:46:38 INFO - Running setup.py install for functools32 21:46:38 INFO - warning: no files found matching '*.txt' 21:46:38 INFO - no previously-included directories found matching 'build' 21:46:38 INFO - no previously-included directories found matching 'dist' 21:46:38 INFO - no previously-included directories found matching '.git*' 21:46:38 INFO - Successfully installed jsonschema functools32 21:46:38 INFO - Cleaning up... 21:46:38 INFO - Return code: 0 21:46:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:46: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')]} 21:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46: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')]} 21:46:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:38 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 0x10ba7ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb11618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb67954d330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9e0d30>, '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 0x10b745db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9d8b20>, '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.JEDmEnxpGQ/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.euPzo002s7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 21:46:38 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 21:46:38 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 21:46:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JEDmEnxpGQ/Render', 21:46:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:46:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:38 INFO - 'HOME': '/Users/cltbld', 21:46:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:46:38 INFO - 'LOGNAME': 'cltbld', 21:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:38 INFO - 'MOZ_NO_REMOTE': '1', 21:46:38 INFO - 'NO_EM_RESTART': '1', 21:46:38 INFO - 'PAGER': '/bin/cat', 21:46:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:38 INFO - 'PWD': '/builds/slave/test', 21:46:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:46:38 INFO - 'SHELL': '/bin/bash', 21:46:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euPzo002s7/Listeners', 21:46:38 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 21:46:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:46:38 INFO - 'USER': 'cltbld', 21:46:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:46:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:38 INFO - 'XPC_FLAGS': '0x0', 21:46:38 INFO - 'XPC_SERVICE_NAME': '0', 21:46:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:38 INFO - Downloading/unpacking blobuploader==1.2.4 21:46:38 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 21:46:38 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 21:46:38 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 21:46:38 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 21:46:38 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 21:46:38 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 21:46:41 INFO - Downloading blobuploader-1.2.4.tar.gz 21:46:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:46:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:46:41 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 21:46:41 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 21:46:41 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 21:46:41 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 21:46:41 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 21:46:41 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 21:46:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:46:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:46:41 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 21:46:41 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 21:46:41 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 21:46:41 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 21:46:41 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 21:46:41 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 21:46:42 INFO - Downloading docopt-0.6.1.tar.gz 21:46:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:46:42 INFO - Installing collected packages: blobuploader, requests, docopt 21:46:42 INFO - Running setup.py install for blobuploader 21:46:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:46:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:46:42 INFO - Running setup.py install for requests 21:46:43 INFO - Running setup.py install for docopt 21:46:43 INFO - Successfully installed blobuploader requests docopt 21:46:43 INFO - Cleaning up... 21:46:43 INFO - Return code: 0 21:46:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:46: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')]} 21:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46: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')]} 21:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:43 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 0x10ba7ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb11618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb67954d330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9e0d30>, '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 0x10b745db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9d8b20>, '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.JEDmEnxpGQ/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.euPzo002s7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 21:46:43 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 21:46:43 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 21:46:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JEDmEnxpGQ/Render', 21:46:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:46:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:43 INFO - 'HOME': '/Users/cltbld', 21:46:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:46:43 INFO - 'LOGNAME': 'cltbld', 21:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:43 INFO - 'MOZ_NO_REMOTE': '1', 21:46:43 INFO - 'NO_EM_RESTART': '1', 21:46:43 INFO - 'PAGER': '/bin/cat', 21:46:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:43 INFO - 'PWD': '/builds/slave/test', 21:46:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:46:43 INFO - 'SHELL': '/bin/bash', 21:46:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euPzo002s7/Listeners', 21:46:43 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 21:46:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:46:43 INFO - 'USER': 'cltbld', 21:46:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:46:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:43 INFO - 'XPC_FLAGS': '0x0', 21:46:43 INFO - 'XPC_SERVICE_NAME': '0', 21:46:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:46:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:46:43 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-qRA9Tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:46:43 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-GsjwtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:46:43 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-VlV03J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:46:43 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-WVzLIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:46:43 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-4fZTS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:46:44 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-onvDAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:46:44 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-6GLxqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:46:44 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-Z8vkcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:46:44 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-axFg6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:46:44 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-LbE4Fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:46:44 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-RLD7i2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:46:44 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-4jJuhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:46:44 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-NHMwyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:46:44 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-LaVXxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:45 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-tyoJw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:46:45 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-h7XuJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:46:45 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-0fp3SW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:46:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:46:45 INFO - Running setup.py install for manifestparser 21:46:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:46:45 INFO - Running setup.py install for mozcrash 21:46:45 INFO - Running setup.py install for mozdebug 21:46:45 INFO - Running setup.py install for mozdevice 21:46:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:46:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:46:45 INFO - Running setup.py install for mozfile 21:46:46 INFO - Running setup.py install for mozhttpd 21:46:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:46:46 INFO - Running setup.py install for mozinfo 21:46:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:46:46 INFO - Running setup.py install for mozInstall 21:46:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:46:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:46:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:46:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:46:46 INFO - Running setup.py install for mozleak 21:46:46 INFO - Running setup.py install for mozlog 21:46:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:46:46 INFO - Running setup.py install for moznetwork 21:46:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:46:46 INFO - Running setup.py install for mozprocess 21:46:47 INFO - Running setup.py install for mozprofile 21:46:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:46:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:46:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:46:47 INFO - Running setup.py install for mozrunner 21:46:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:46:47 INFO - Running setup.py install for mozscreenshot 21:46:47 INFO - Running setup.py install for moztest 21:46:47 INFO - Running setup.py install for mozversion 21:46:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:46:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:46:47 INFO - Cleaning up... 21:46:47 INFO - Return code: 0 21:46:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:46:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:47 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 0x10ba7ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb11618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb67954d330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9e0d30>, '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 0x10b745db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9d8b20>, '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.JEDmEnxpGQ/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.euPzo002s7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 21:46:47 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 21:46:47 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 21:46:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JEDmEnxpGQ/Render', 21:46:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:46:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:47 INFO - 'HOME': '/Users/cltbld', 21:46:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:46:47 INFO - 'LOGNAME': 'cltbld', 21:46:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:47 INFO - 'MOZ_NO_REMOTE': '1', 21:46:47 INFO - 'NO_EM_RESTART': '1', 21:46:47 INFO - 'PAGER': '/bin/cat', 21:46:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:46:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:47 INFO - 'PWD': '/builds/slave/test', 21:46:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:46:47 INFO - 'SHELL': '/bin/bash', 21:46:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euPzo002s7/Listeners', 21:46:47 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 21:46:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:46:47 INFO - 'USER': 'cltbld', 21:46:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:46:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:46:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:47 INFO - 'XPC_FLAGS': '0x0', 21:46:47 INFO - 'XPC_SERVICE_NAME': '0', 21:46:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:46:48 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-aZ4nLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:46:48 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)) 21:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:46:48 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-PSHVqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:46:48 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)) 21:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:46:48 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-h0ukWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:46:48 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)) 21:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:46:48 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-R6T4AD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:46:48 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)) 21:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:46:48 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-7Si5Z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:46:48 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)) 21:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:46:48 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-13CDDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:46:48 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)) 21:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:46:48 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-T2fmt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:46:48 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)) 21:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:46:48 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-iqcvs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:46:49 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)) 21:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:46:49 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-d0xTkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:46:49 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)) 21:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:46:49 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-5h2Nsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:46:49 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)) 21:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:46:49 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-QltiR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:46:49 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)) 21:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:46:49 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-PelYbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:46:49 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)) 21:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:46:49 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-J8l771-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:46:49 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)) 21:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:46:49 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-TE0Wv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:46:49 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)) 21:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:49 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-qI5ubh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:49 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)) 21:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:46:49 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-Rf7M_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:46:49 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)) 21:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:46:49 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-0nar3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:46:49 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)) 21:46:49 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)) 21:46:49 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)) 21:46:49 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)) 21:46:49 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)) 21:46:49 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)) 21:46:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:46:50 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 21:46:50 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 21:46:50 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 21:46:50 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 21:46:50 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 21:46:50 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 21:46:52 INFO - Downloading blessings-1.6.tar.gz 21:46:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:46:52 INFO - Installing collected packages: blessings 21:46:52 INFO - Running setup.py install for blessings 21:46:52 INFO - Successfully installed blessings 21:46:52 INFO - Cleaning up... 21:46:52 INFO - Return code: 0 21:46:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:46:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:46:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:46:53 INFO - Reading from file tmpfile_stdout 21:46:53 INFO - Current package versions: 21:46:53 INFO - blessings == 1.6 21:46:53 INFO - blobuploader == 1.2.4 21:46:53 INFO - docopt == 0.6.1 21:46:53 INFO - functools32 == 3.2.3-2 21:46:53 INFO - jsonschema == 2.5.1 21:46:53 INFO - manifestparser == 1.1 21:46:53 INFO - mozInstall == 1.12 21:46:53 INFO - mozcrash == 0.17 21:46:53 INFO - mozdebug == 0.1 21:46:53 INFO - mozdevice == 0.48 21:46:53 INFO - mozfile == 1.2 21:46:53 INFO - mozhttpd == 0.7 21:46:53 INFO - mozinfo == 0.9 21:46:53 INFO - mozleak == 0.1 21:46:53 INFO - mozlog == 3.2 21:46:53 INFO - moznetwork == 0.27 21:46:53 INFO - mozprocess == 0.23 21:46:53 INFO - mozprofile == 0.28 21:46:53 INFO - mozrunner == 6.12 21:46:53 INFO - mozscreenshot == 0.1 21:46:53 INFO - mozsystemmonitor == 0.3 21:46:53 INFO - moztest == 0.7 21:46:53 INFO - mozversion == 1.4 21:46:53 INFO - psutil == 3.1.1 21:46:53 INFO - requests == 1.2.3 21:46:53 INFO - wsgiref == 0.1.2 21:46:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:53 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 0x10ba7ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb11618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb67954d330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9e0d30>, '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 0x10b745db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9d8b20>, '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.JEDmEnxpGQ/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.euPzo002s7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 21:46:53 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 21:46:53 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 21:46:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JEDmEnxpGQ/Render', 21:46:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:46:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:53 INFO - 'HOME': '/Users/cltbld', 21:46:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:46:53 INFO - 'LOGNAME': 'cltbld', 21:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:53 INFO - 'MOZ_NO_REMOTE': '1', 21:46:53 INFO - 'NO_EM_RESTART': '1', 21:46:53 INFO - 'PAGER': '/bin/cat', 21:46:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:53 INFO - 'PWD': '/builds/slave/test', 21:46:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:46:53 INFO - 'SHELL': '/bin/bash', 21:46:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euPzo002s7/Listeners', 21:46:53 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 21:46:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:46:53 INFO - 'USER': 'cltbld', 21:46:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:46:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:53 INFO - 'XPC_FLAGS': '0x0', 21:46:53 INFO - 'XPC_SERVICE_NAME': '0', 21:46:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:54 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)) 21:46:54 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)) 21:46:54 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)) 21:46:54 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)) 21:46:54 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)) 21:46:54 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)) 21:46:54 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)) 21:46:54 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)) 21:46:54 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)) 21:46:54 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)) 21:46:54 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)) 21:46:54 INFO - Cleaning up... 21:46:54 INFO - Return code: 0 21:46:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:54 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 0x10ba7ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb11618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb67954d330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9e0d30>, '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 0x10b745db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9d8b20>, '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.JEDmEnxpGQ/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.euPzo002s7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 21:46:54 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 21:46:54 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 21:46:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JEDmEnxpGQ/Render', 21:46:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:46:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:54 INFO - 'HOME': '/Users/cltbld', 21:46:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:46:54 INFO - 'LOGNAME': 'cltbld', 21:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:54 INFO - 'MOZ_NO_REMOTE': '1', 21:46:54 INFO - 'NO_EM_RESTART': '1', 21:46:54 INFO - 'PAGER': '/bin/cat', 21:46:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:54 INFO - 'PWD': '/builds/slave/test', 21:46:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:46:54 INFO - 'SHELL': '/bin/bash', 21:46:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euPzo002s7/Listeners', 21:46:54 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 21:46:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:46:54 INFO - 'USER': 'cltbld', 21:46:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:46:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:54 INFO - 'XPC_FLAGS': '0x0', 21:46:54 INFO - 'XPC_SERVICE_NAME': '0', 21:46:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:46:54 INFO - Cleaning up... 21:46:54 INFO - Return code: 0 21:46:54 INFO - Running post-action listener: _resource_record_post_action 21:46:54 INFO - Running post-action listener: _start_resource_monitoring 21:46:54 INFO - Starting resource monitoring. 21:46:54 INFO - ##### 21:46:54 INFO - ##### Finished create-virtualenv step (success) 21:46:54 INFO - ##### 21:46:54 INFO - ##### 21:46:54 INFO - ##### Running install step. 21:46:54 INFO - ##### 21:46:54 INFO - Running pre-action listener: _resource_record_pre_action 21:46:54 INFO - Running main action method: install 21:46:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:46:54 INFO - Reading from file tmpfile_stdout 21:46:54 INFO - Detecting whether we're running mozinstall >=1.0... 21:46:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:46:54 INFO - Reading from file tmpfile_stdout 21:46:54 INFO - Output received: 21:46:54 INFO - Usage: mozinstall [options] installer 21:46:54 INFO - Options: 21:46:54 INFO - -h, --help show this help message and exit 21:46:54 INFO - -d DEST, --destination=DEST 21:46:54 INFO - Directory to install application into. [default: 21:46:54 INFO - "/builds/slave/test"] 21:46:54 INFO - --app=APP Application being installed. [default: firefox] 21:46:54 INFO - mkdir: /builds/slave/test/build/application 21:46:54 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'] 21:46:54 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 21:47:29 INFO - Reading from file tmpfile_stdout 21:47:29 INFO - Output received: 21:47:29 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:47:29 INFO - Running post-action listener: _resource_record_post_action 21:47:29 INFO - ##### 21:47:29 INFO - ##### Finished install step (success) 21:47:29 INFO - ##### 21:47:29 INFO - ##### 21:47:29 INFO - ##### Running run-tests step. 21:47:29 INFO - ##### 21:47:29 INFO - Running pre-action listener: _resource_record_pre_action 21:47:29 INFO - Running main action method: run_tests 21:47:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:47:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:47:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:47:29 INFO - 2016-07-06 21:47:29.574 screenresolution[1636:7665] starting screenresolution argv=screenresolution get 21:47:29 INFO - 2016-07-06 21:47:29.576 screenresolution[1636:7665] Display 0: 1600x1200x32@60 21:47:29 INFO - 2016-07-06 21:47:29.581 screenresolution[1637:7667] starting screenresolution argv=screenresolution list 21:47:29 INFO - Available Modes on Display 0 21:47:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:47:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:47:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:47:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:47:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:47:29 INFO - Intel Iris: 21:47:29 INFO - Chipset Model: Intel Iris 21:47:29 INFO - Type: GPU 21:47:29 INFO - Bus: Built-In 21:47:29 INFO - VRAM (Dynamic, Max): 1536 MB 21:47:29 INFO - Vendor: Intel (0x8086) 21:47:29 INFO - Device ID: 0x0a2e 21:47:29 INFO - Revision ID: 0x0009 21:47:29 INFO - Displays: 21:47:29 INFO - Display: 21:47:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:47:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:47:29 INFO - Display Serial Number: 1600x1200 60 21:47:29 INFO - Main Display: Yes 21:47:29 INFO - Mirror: Off 21:47:29 INFO - Online: Yes 21:47:29 INFO - Rotation: Supported 21:47:29 INFO - Return code: 0 21:47:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:47:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:47:29 INFO - Python 2.7.3 21:47:29 INFO - Return code: 0 21:47:29 INFO - grabbing minidump binary from tooltool 21:47:29 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')]} 21:47:29 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 0x10b9e0d30>, '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 0x10b745db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9d8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:47:29 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 21:47:29 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 21:47:29 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 21:47:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:47:29 INFO - Return code: 0 21:47:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:47:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:47:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:47:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:47:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:47:29 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/RlfCi6KMRZG1EKtcF73ryA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--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 21:47:29 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/RlfCi6KMRZG1EKtcF73ryA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0038 --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 21:47:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JEDmEnxpGQ/Render', 21:47:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:29 INFO - 'HOME': '/Users/cltbld', 21:47:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:29 INFO - 'LOGNAME': 'cltbld', 21:47:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:47:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:47:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:29 INFO - 'MOZ_NO_REMOTE': '1', 21:47:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:47:29 INFO - 'NO_EM_RESTART': '1', 21:47:29 INFO - 'PAGER': '/bin/cat', 21:47:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:29 INFO - 'PWD': '/builds/slave/test', 21:47:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:47:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:29 INFO - 'SHELL': '/bin/bash', 21:47:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euPzo002s7/Listeners', 21:47:29 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 21:47:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:29 INFO - 'USER': 'cltbld', 21:47:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:29 INFO - 'XPC_FLAGS': '0x0', 21:47:29 INFO - 'XPC_SERVICE_NAME': '0', 21:47:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:29 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/RlfCi6KMRZG1EKtcF73ryA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--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 21:47:30 INFO - mozversion application_buildid: 20160706193622 21:47:30 INFO - mozversion application_changeset: c0e2702226bbb18cc6f907e0a6c41e2bc3727e74 21:47:30 INFO - mozversion application_display_name: Nightly 21:47:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:47:30 INFO - mozversion application_name: Firefox 21:47:30 INFO - mozversion application_remotingname: firefox 21:47:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:47:30 INFO - mozversion application_vendor: Mozilla 21:47:30 INFO - mozversion application_version: 50.0a1 21:47:30 INFO - mozversion platform_buildid: 20160706193622 21:47:30 INFO - mozversion platform_changeset: c0e2702226bbb18cc6f907e0a6c41e2bc3727e74 21:47:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:47:30 INFO - mozversion platform_version: 50.0a1 21:47:30 INFO - using testdate: 1467866850 21:47:30 INFO - actual date: 1467866850 21:47:30 INFO - starting webserver on 'localhost:49271' 21:47:30 INFO - SUITE-START | Running 2 tests 21:47:30 INFO - TEST-START | dromaeo_css 21:47:30 INFO - operating with platform_type : mac_ 21:47:30 INFO - Initialising browser for dromaeo_css test... 21:47:30 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpCT4tCF/profile http://localhost:49271/getInfo.html) 21:47:32 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 21:47:32 INFO - PROCESS | 1647 | colorDepth:24 21:47:32 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 21:47:32 INFO - PROCESS | 1647 | __metrics 21:47:32 INFO - PROCESS | 1647 | 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" 21:47:32 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:47:33 INFO - TEST-INFO | 1647: exit 0 21:47:33 INFO - Browser initialized. 21:47:33 INFO - Running cycle 1/1 for dromaeo_css test... 21:47:33 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpCT4tCF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:47:45 INFO - PROCESS | 1649 | RSS: Main: 243593216 21:47:45 INFO - PROCESS | 1649 | 21:48:36 INFO - PROCESS | 1649 | 1467866916814 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] 21:50:46 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 21:50:48 INFO - PROCESS | 1649 | RSS: Main: 441892864 21:50:48 INFO - PROCESS | 1649 | 21:53:52 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 21:53:53 INFO - PROCESS | 1649 | RSS: Main: 380137472 21:53:53 INFO - PROCESS | 1649 | 21:56:55 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 21:56:55 INFO - PROCESS | 1649 | RSS: Main: 370044928 21:56:55 INFO - PROCESS | 1649 | 21:59:58 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 21:59:58 INFO - PROCESS | 1649 | RSS: Main: 371318784 21:59:58 INFO - PROCESS | 1649 | 22:03:02 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 22:03:03 INFO - PROCESS | 1649 | RSS: Main: 341929984 22:03:03 INFO - PROCESS | 1649 | 22:06:06 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 22:06:06 INFO - PROCESS | 1649 | RSS: Main: 433225728 22:06:06 INFO - PROCESS | 1649 | 22:06:06 INFO - PROCESS | 1649 | __start_tp_report 22:06:06 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 22:06:06 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 22:06:06 INFO - PROCESS | 1649 | |i|pagename|runs| 22:06:06 INFO - PROCESS | 1649 | |0;dojo.html;3325.6674332566745;3327;3335.483000134979;3370.359631669981;3388.15296175956;5680.9715951420185;5727.742251598677;5763.423657634235;5786.884262314757;5801.564882633809;5708.743106560204;5714.971425142869;5869;5884.0879663652095;5908.9113663294975;5145.228215767627;5151.356080489939;5192.948070519303;5216.8174113906025;5224.947750522503;5305;5321.547668448186;5336.17289320156;5353.143497040474;5354.089804733185;5152.819651312186;5159.871003224912;5200.687958722451;5211.244369566411;5248.422673505911;5094.7197904115255;5126.333576635051;5132.486751324875;5184.222366644995;5282.603804714623;5133.974330128325;5139.049275883974;5171.560417364529;5181.974090129525;5239.423663397023;4771.212749896263;5648.971755141239;5670.68811215383;5673.546116310727;5762.683052432115;6204.689765511706;6254.499640028786;6268.498520118425;6271.466925311354;6272.498200144023;6285.120083188357;6311.810645680637;6369.267534233576;6373.649449280288;6396.3283855194995;4970.478099799505;5737.082066869322;5787.334456537468;5842.357340692521;5862.355140934494;6314.55798094129;6322.620642761449;6329.335419780857;6331.366863313632;6333.20834895638;6165.969170154121;6198.535109866778;6217.036359364306;6221.097940798559;6222.906656400158;6129.23653806838;6186.628802271878;6259.3427690091885;6272.1219029335925;6310.305866354697;6212.099245609361;6265.592736472115;6266.592671476339;6269.811905642838;6277.246730392382;6115;6222.315545290015;6262.874742505124;6269.341719119518;6312.116303717483;4268.338407546835;4905.656604037755;4942.9619779846635;4959.528844759742;4967.82612608557;4436.622887054572;4461.330800379969;4464.419625448671;4474;4501.594856462934;5601.5238704710555;5666.923284575917;5679.062954612526;5700.344460387026;5751.1373294006235;6189.102580125947;6222.844428889314;6233.844153896189;6309.589876658094;6374.521910856612;5704.429557044263;5706.885862282814;5723.942760572424;5725.8568535786935;5744.913826292609;5319.388270348882;5421.891562168814;5437.211604317431;5445.346558413015;5453.454654534515;6210.472109870621;6260.718267677874;6261.499080073492;6288.717007734663;6317.241930968313;6278.717457714505;6317.873642527215;6324.683765811599;6342.556021078481;6346.492280617632;6244.157038799885;6282.937170628235;6294.874102517832;6308.779192728232;6314.905276420765;6108.251008765869;6139.693015349304;6152.138700582012;6163.982942814386;6173;6191.19514463135;6304.936950630435;6314.305426403183;6336.58812177207;6357.110004599267;6118.235220597426;6134.38656134383;6139.938600613937;6143.955527560236;6153.446189842935;5985.760569577168;5988.820335389945;6030.095485677183;6136.785212517719;6142.692865356804;5879.73541190656;5925.674087925206;5936.584439089395;5952.0179170436395;5989.670568118795;5999.940000600112;6105.389461053859;6134.693490130915;6139;6168.691565421801;5775.884482310246;5887.882242355215;5898.292204935264;5949;5970.223870896929 22:06:06 INFO - PROCESS | 1649 | |1;ext.html;487.2447706055613;489.53005115089525;494.8124501197129;497.0804012576734;515.6390526631359;26621.068262610814;42336;42596.36105458413;43013.13973720524;43165.78417107914;42653.93365165872;43077.7846110769;44764.77617611916;44952.77523612385;45015.54984450155;8877.46735195887;9809.215262778978;9951.601935922554;9976.90023099767;9982.201423886072;11860;12065.698357541043;12095.334756588383;12244.877551224507;12267.202631828903;10294.794104117913;12010.63968080959;12092.33492157931;12127.211731237441;12134.757304853898;11989.640310790646;12079.335636539987;12095.818562721566;12109.818352724717;12121.27272363661;11868.465919033579;11950.402479876058;11967.82048269268;11971.281723096643;11992.400379980965;41868;42214.577854221374;42227.155456891;42260.36609450861;42324;3609.2781443711365;3995.839730573016;4044.635982761536;4297.97851010746;4439.778011099432;32795;32934.83532582322;33113;33684.83157584196;33872.661273387195;3303.306305675811;3317.7345812335197;3334.3164651246434;3345.5818022747158;3449.1721986723005;516865;517460;520411;520783.39608301717;521738;63385;63632.36367636264;63713.681431593475;63771.043434348525;63783.36216637867;66017.66991165014;66160.6691966537;66205;66222;66258;16828;17016.744748828776;17025.31898724062;17034.31862725502;17062.573435664206;10780.191485638608;10858.185636077325;10866.185036122322;11051.447427628586;11053.723656908482;16624.418145364853;16992.405265815883;17006.064666443464;17255.91372043157;17305.913470432566;4948.406191257072;5295.464315348583;5895.41045895407;6221.844453888689;6237.500999919996;954.6396385151132;986.4673076538733;1043.7234132954773;1070.2561719604955;1125.6116639759434;23428.531429371316;30851.69148308488;30990;31328.843355783076;31490.37019259602;1054.314695447965;1069.8662667166604;1080.9729756755987;1107.4960892793758;1174.9530018799323;16181.757273640906;16315.83684163167;16353.918230408772;16568.334837232054;16586.419475318307;634640;635687;636893;638531.8073409696;640455;52808;62285.68857155685;62902.370976289654;63130.684346577975;63131;1273.1151849464534;1396.7904814277736;1404.4452441285634;1437.4034775568023;1441.5891470930735;26647.33381665474;31095.37809243757;32035;32449.188770279987;32687.50968735423;42849.785751071046;51387.48612513827;52121;52274.21588676249;52601;564514;565755;567418;570027;570072;36026;41016.384754228115;41178.58821411747;42118.57881421147;42162;50100;50915.74542127266;51092.48907511026;51586.74206628943;51701.48298517117;40529;40782.79608601938;40821;41672.79163604163;42650;40777.38833917553;40952.1809563813;41293.58706412897;42051.57948420477;42400.78799605982;40089.997750056486;40571.188576227716;40784.79607601943;40791.592084079966;41033.58966410417;34885;35123.82438087793;35474.467882982295;36059.91820245397;36145.27709445744;23098.76901230966;25082.725024506715;25754;26371.60442593324;26510.867445662647 22:06:06 INFO - PROCESS | 1649 | |2;jquery.html;355.1511886591046;375.57184809317374;382.96553310202086;385.1776457263741;401.83926429428226;16047.191741445258;16348.937319074266;21794.673079903794;21801.90990450479;21913.452163695914;21532;21890.01494932728;22637.320880373572;22923.083076676914;23102.88448557759;6018.458338749511;6048.1834952281315;6187.5668703190795;6213.130161777355;6213.8135855924165;4178.853740119096;4390.1878152541885;6052.909206361886;6171.783987560436;6583.703733332011;6840;6920;6922.58464492132;6928.2725313842075;6944.131983502062;6575.506836987245;6846.281140480228;6847.1783385994;6853.554518956302;6855.006024126524;5694.4590263924865;5924.437178468039;5943.138244954501;5977.940220597782;5985.670788106696;23889.641655375184;24020.879895600585;26552.60171097435;27689;28225.15324540267;2245.427416008907;2255.988720056406;2359.823013273994;2516.7357427470033;2558.066305798389;14499.202543860083;15091.849081509265;16569.6686066278;16996.83003169965;17515.03667298298;1869.3923226025606;1894.1476335648874;1901.6767149584605;1939.7769256535537;1945.7081437784304;124390.37804811008;129269;130352.99999999905;131103.34448327794;132454;10939.83590246147;11160.274582152135;11388.088952883749;11579.247348922294;11613;14326.212058336683;14432;14442.350094245785;14482.710345793235;14483;8639.740807775777;8688.218060374596;9027.63889444428;9050.366474346863;9086.54567271647;9189.90810091904;9193.724188274362;9207.40151890125;9322.906770932204;9350.111739384747;6563.849352310917;6599.175103112111;6974.26770189133;7093.680784364716;7103.218645948941;1696.7454881767587;1719.5701074731317;1883.4726276642562;1894.9810501894804;1937.4381429385603;875.935738078238;960.5485421851719;983.7491439682835;1039.8336266197373;1042.358949246208;21084.578308433745;23097.769022309898;23950.52098958046;23969.28092157238;24035.27894163178;929.4887811703671;1026.645807196516;1043.1029314789428;1062.9787404251872;1082.821334479802;11898.810118988033;12371.505139794308;12533.498660053496;12630.863222309852;12659.240445573296;623274;631095;636785;641708;642413;106323.4683826576;133189.3340533291;134142;139028;148684.25657871642;951.2817822544073;967.2793768642266;982.5087456271864;985.6648739428485;1008.3798463944768;18607.255709771456;20929.790702093393;21376.893115534323;21668.469132972074;21856.562868742854;47129.764351179394;56447.306580802644;57888;60081.39918600933;61124;64015.759448419085;82660.34679306501;84192.15807841843;85187.14812851792;88771.0106090455;6763.93236067633;7252.746153884589;7603.391728661583;8126.431149819692;8448.704295349633;12987.870121298665;13619.659508512366;13710.24593647359;14037.578872633838;14038.298085095908;11809.291442513133;11900.583479578174;12046.819297710366;12166.817497737718;12196.512139514674;11589.24669896454;11698;11766.941165294118;11862.110341724232;11901.166918315635;11900.642980710592;11989.22070065443;11998.540663998034;12176.512939482322;12180.330081845583;7593.544387336778;7685.538867667958;7695.769126926201;7723.53658780475;7868;9883.654072107729;11974;12014.399280035788;12112.757744844877;12120.151589388659 22:06:06 INFO - PROCESS | 1649 | |3;mootools.html;1558.7973563436751;1591.403223791078;1780.4925596205076;1894.753682021337;1917.3864363403716;8709.651613935443;8952.91047089529;9127.269818414528;9129.771755706111;9141.542922853847;7952.085510166333;8214.630341634625;8217;8282.710105146321;8934.865977010333;1829.8353148216625;1986.9701954470622;1993.3521605478204;2163.9504840152513;2423.8545687258734;2390.5816482115647;2394.6527753475734;2411.360989337827;2414.4326083370393;2416.915407960722;2085.551606404623;2106.1891171898774;2333.53329334133;2392.581298272804;2411.6141417373224;2157.751858536265;2174.097749433983;2174.902129404165;2290.415943934303;2382.344855164826;2372.774586414288;2380.9285721428387;2385.666006759055;2393.796527295182;2398.2805158452393;9013.549322533847;9089.81820363589;9094.363394562382;9099.1810737034;9118.452892826452;5287.127623942045;5454.645448045864;5454.863628409282;5457;5459.563234941234;3582.5880023797076;3659.0852286928266;3764.8305826237884;3771.151490914522;3776.055986003499;1098.5441041967574;1108.5842808946645;1112.3881864974312;1133.8355938388888;1134.2400591603646;12015.279083255033;12048.216865903689;12049.397530123459;12055.397230138546;12080.637580872588;4653.767311634405;4691.390119284471;4906.55840974314;4909.165441874889;4911.631627627942;10197.694069177936;10210.489475526194;10214.182865370753;10245.334053286513;10252.43611601369;5422.864428389322;5428.4842939920645;5445.019896418604;5447.101228297366;5452.700101494376;4506.549345065533;4914;4972.5276098770555;4984.850454486371;4990.600751939836;3780.8487660493824;3927;3929.332013557702;3937.2125574885135;3939.6454319111417;1259.785836407813;1304.4064950447523;1308.4373719300793;1311.8753718396738;1332.054241488554;839.5130824121994;947.2989987409268;949.8242825077383;950.6862735297335;982.759223990127;6046.244219472566;6100.908486372708;6189.907151392733;6211.81364559064;6220.409061139275;971.6307803034802;997.4962643864802;997.9900200998043;1003.5985605757755;1028.0285130551706;4101.26177288085;4106.815193316308;4114.938275925863;4197;4210.789460526961;10242.897571024194;10612.628558000433;10652.573897044187;10664;10699.679009629723;10572.101371383365;10582;10588.311759735592;10598.735031624272;10611.575536978435;7876.133625301212;8256.009278886451;8265.421420500628;8359.414840961075;8365.958170209231;5978.3423823378525;6171.6297022178815;6217.316095229431;6302.905456418066;6404.967975160281;9944;10145.391276523136;10392.116670083127;10419.958004199823;10438.425886576311;10473.528691208761;10496.422696751752;10503.42231177262;10520.368777873353;10535.841962370723;7471.178170401143;7636.350910172475;7740.3420709240345;7763.650635721293;7834.843303134019;7892.526448413114;8166.060902996232;8546.188112129337;8597.914020859962;8632.525211113449;6516.934830651822;7797.259260370256;7947.44367894265;7951.681932722858;7957.164497727887;7451.552906825608;7601.695932162652;7617.047869016373;7761.262680045386;7783.260590243918;7210.639468026473;7229.530080544748;7303.598302093435;7305.634718263959;7316.268373162641;4998.775055122455;5145.511176438233;5167.069927413102;5231.8168864089575;5251.159814429826;5166.354205724285;5240.71176085319;5255.290535777621;5305.973470132624;5353.812616558402 22:06:06 INFO - PROCESS | 1649 | |4;prototype.html;305.55389131867486;308.6604734791729;318.5333486442361;323.4953472582771;325.93807176636454;4597.77011149442;5172.379314482263;5209.583233341333;5386.569074474042;5468.7812487500505;4424.247877860764;5061.721605311706;5342.91985620216;5362.865928351784;5398.514133727964;3941.1623630985787;4124.340105583107;4143.218416081084;4154.667626589873;4176.1230141670285;3243.6594157613463;3606.6213047630013;4031.798410079499;4130.566290539495;4155.501339839224;3618.3667858124854;3824.9617503825025;3875.767453952758;4124.896877578055;4140.772257525835;3397.371486275022;3474.4614584739406;3800.916738729463;3920.9607903920883;4096.344584866437;3588.5825099085714;3597.6402359764074;3602.711783057375;3608.1520842601967;3621.4567814827724;4107.650849677781;4854.490278520775;4988.900221995576;5226.346706661668;5320;4201.873943781691;4342.348647702838;4457.748836837376;4588.715159755274;4614.261718125117;4893.8254818843225;5348.384935732402;5353.518183363516;5476.91784623231;5616.9157462638095;3268.5750852389274;3819.1406933439753;3840.9039774005596;3850.652271704881;3854.325493038707;4967.627427942919;5103.234514822732;5446.836594902159;5669.971650141723;5851.912221316684;3404.9489257661153;3519.5776506819348;3712.3132220539287;3881.029742564359;3902.804859757001;3344.963061450958;3981.7212795104642;3986.421968814506;3988.726425937246;3994.2810294147334;3894.3184942634925;4277.0539404570845;4440.666949978699;4627.5603817637275;4681.789319480631;4747.667663263607;5670.347909990322;5675.290588676416;5677.659340439587;5680;1192.7614477104614;1297.8060184630162;1310.6723319170208;1338.3642769684323;1341.0411555737694;731.4185222747928;809.5345176523523;823.8434697407473;826.6114925984778;828.1180542721982;3605.8737944171826;3875.918644677432;3955.6044395560216;4180;4395.472543294825;4311.628604267703;4322.935155972663;4494.865154045384;4827.710337379768;4934.4572097069295;3742.55089389275;3810.447485114643;4003.619656132663;4349.933297025589;4418.889527761831;2300.7124109486313;2333.4749681321905;2397.3287479505766;2474.2206205045354;2570.9742902570733;4968.385274785709;4989.750512474362;4997.675151115166;5003.449620541737;5032.949670503322;4296;4968.801247950114;4969.167574482511;4998.450170481244;5079.790291223329;4301.698881078294;5441.32297270371;6079.604825686316;6108.908366374597;6128.295246046672;4539.341795439709;5325;5897.675627840338;5907.881842363043;5918.644881307136;4724.598409135262;5644.604877658525;5855.677937713466;5880.882382352414;5885.529157667462;5148.613853960893;5716.54267658578;5933.643981361132;5995.991342900177;6083.866808593666;3881.476000739864;3885.86399476017;3913.412988051815;3929.626685464876;3956.8615098471414;5155.896882062413;5872.618279811799;5878.118282257525;5894.233749612523;5935.228420305332;5344.9732751336;5693.24613947342;5699.772009119589;5724.713764311851;5783.479486846204;4743.596794272526;4929.556339929423;5340.341865821924;5671.100181439264;5671.347795003462;4924.65527413092;5559.8888022240135;5562.634606063435;5602.52378547828;5613.242212301287;5167.948320516897;5482.39693633708;5640.689762062962;5675.8864822704145;5697.977218087519;5079.466656001066;5551.361593416647;5569.10894256917;5577.944220557904;5586.636868603528 22:06:06 INFO - PROCESS | 1649 | |5;yui.html;743.3978477433279;753.8153152477647;770.6416516319911;781.5261164125461;848.3150827630548;11913.642590722282;16433.99999999997;16469.588260293483;16491;16509.504714858544;14834.03578767382;14970.401183952656;14975.925120374382;14999;15004.624884377896;677.5088061155648;724.7572063358755;757.2389748302948;889.5196593839352;894.6376717429436;904.8552231642939;919.5080631861955;919.6965001549472;923.3905622289291;923.6720964057763;956.077385323163;957.3681370295607;958.0371726414978;961.4231461123305;961.8172547216042;751.5265382808823;932.5803388475214;951.6764300137952;971.5676523946846;972.4311277902435;721.588694444167;723.5080145501057;725.6879541797025;725.9237780033073;725.9382952449048;15156.242187890672;15204.16377099259;15220.162891040989;15258.313375898;15275.38898444061;13879.444822207099;14052.227127507984;14168.937329700211;14184.574462766133;14387.92806035963;12770.74458510834;12775.74448511034;12835.422405991752;13071.281079540622;13309.866901331057;4547.113312903985;4569.520200378979;4715.127701375257;4735.905281894377;4810.7113573185725;111101.88898110997;113250;113295.43352283185;117892.41053794677;117976;11218.046466050313;11251.606193783178;11273.436328183558;11400.600978965862;11803.468843902045;18699.626007479776;22327.330180094625;22369.76966266871;22376.440588985406;22631.547369052856;8008.119106898236;8016.7194148204535;8101.797455063553;8201.71294004707;8274.917250827535;4444.511103778582;4514.909701805946;4553.294239392833;4568.908621827612;4650.023495066006;3495.807730574843;3618.800965946898;3620.511230983836;3620.6741393274733;3624.347617428888;656.0716586030809;660.9107770451023;671.2951401028901;671.5366397185926;680.3196803196803;563.138398250669;602.3193791016124;602.668532307238;616.5437576193584;668.1514476614672;8464;8656.307495400353;8846;8909.331800115016;9154.26765858743;598.7934162713857;608.8264844519291;647.834802125455;649.217692680319;652.6932341799346;4422.29243321067;4491.865244042684;4495.2582823834355;4495.752733599618;4576.839810606612;148009;151583;152883;154129;157556;132706;136610;136903.31548342193;137837;140174;109658;113632;114515.99999999833;115134;115894.42052789681;7510.8497830042;8584.914150858662;8588.26999705032;8647.870281945901;8840.867386989072;43972.56027439813;44645;52208;62095;64304.67847660732;85284.72072918787;88061.55969220113;90021;90921.09078909391;94646.52676736572;11937.883048705397;13925.373358199107;13934.860651393356;13967.860321396656;14178.574642760734;15516.534503964898;15664.451744188898;16047.277872495531;16055.919720401324;16163.111028893523;14449.711005780036;14480.927595361956;14505.129692218501;14612.196329201995;15061.096334219981;13545;14178.220197888802;14280.9466170544;14303.785443218569;14341.64145896361;13625.114367566077;14071.788923166365;14494.275286235435;14503.854961450672;14647.267636617913;9975.50122493887;11344.577592864729;11527.942360288145;11557.595484158013;11732.237404568676;10310.690679279334;11296.943515282699;11408.657740267805;11459.25514841566;11552.537898483966 22:06:06 INFO - PROCESS | 1649 | __end_tp_report 22:06:06 INFO - PROCESS | 1649 | __start_cc_report 22:06:06 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,2364 22:06:06 INFO - PROCESS | 1649 | __end_cc_report 22:06:06 INFO - PROCESS | 1649 | __startTimestamp1467867966414__endTimestamp 22:06:06 INFO - PROCESS | 1649 | 22:06:06 INFO - PROCESS | 1649 | ------- Summary: start ------- 22:06:06 INFO - PROCESS | 1649 | Number of tests: 6 22:06:06 INFO - PROCESS | 1649 | 22:06:06 INFO - PROCESS | 1649 | [#0] dojo.html Cycles:165 Average:5751.47 Median:5952.02 stddev:659.56 (11.1%) stddev-sans-first:633.53 22:06:06 INFO - PROCESS | 1649 | Values: 3325.7 3327.0 3335.5 3370.4 3388.2 5681.0 5727.7 5763.4 5786.9 5801.6 5708.7 5715.0 5869.0 5884.1 5908.9 5145.2 5151.4 5192.9 5216.8 5224.9 5305.0 5321.5 5336.2 5353.1 5354.1 5152.8 5159.9 5200.7 5211.2 5248.4 5094.7 5126.3 5132.5 5184.2 5282.6 5134.0 5139.0 5171.6 5182.0 5239.4 4771.2 5649.0 5670.7 5673.5 5762.7 6204.7 6254.5 6268.5 6271.5 6272.5 6285.1 6311.8 6369.3 6373.6 6396.3 4970.5 5737.1 5787.3 5842.4 5862.4 6314.6 6322.6 6329.3 6331.4 6333.2 6166.0 6198.5 6217.0 6221.1 6222.9 6129.2 6186.6 6259.3 6272.1 6310.3 6212.1 6265.6 6266.6 6269.8 6277.2 6115.0 6222.3 6262.9 6269.3 6312.1 4268.3 4905.7 4943.0 4959.5 4967.8 4436.6 4461.3 4464.4 4474.0 4501.6 5601.5 5666.9 5679.1 5700.3 5751.1 6189.1 6222.8 6233.8 6309.6 6374.5 5704.4 5706.9 5723.9 5725.9 5744.9 5319.4 5421.9 5437.2 5445.3 5453.5 6210.5 6260.7 6261.5 6288.7 6317.2 6278.7 6317.9 6324.7 6342.6 6346.5 6244.2 6282.9 6294.9 6308.8 6314.9 6108.3 6139.7 6152.1 6164.0 6173.0 6191.2 6304.9 6314.3 6336.6 6357.1 6118.2 6134.4 6139.9 6144.0 6153.4 5985.8 5988.8 6030.1 6136.8 6142.7 5879.7 5925.7 5936.6 5952.0 5989.7 5999.9 6105.4 6134.7 6139.0 6168.7 5775.9 5887.9 5898.3 5949.0 5970.2 22:06:06 INFO - PROCESS | 1649 | 22:06:06 INFO - PROCESS | 1649 | [#1] ext.html Cycles:180 Average:72136.33 Median:40674.29 stddev:153782.12 (378.1%) stddev-sans-first:154119.43 22:06:06 INFO - PROCESS | 1649 | Values: 487.2 489.5 494.8 497.1 515.6 26621.1 42336.0 42596.4 43013.1 43165.8 42653.9 43077.8 44764.8 44952.8 45015.5 8877.5 9809.2 9951.6 9976.9 9982.2 11860.0 12065.7 12095.3 12244.9 12267.2 10294.8 12010.6 12092.3 12127.2 12134.8 11989.6 12079.3 12095.8 12109.8 12121.3 11868.5 11950.4 11967.8 11971.3 11992.4 41868.0 42214.6 42227.2 42260.4 42324.0 3609.3 3995.8 4044.6 4298.0 4439.8 32795.0 32934.8 33113.0 33684.8 33872.7 3303.3 3317.7 3334.3 3345.6 3449.2 516865.0 517460.0 520411.0 520783.4 521738.0 63385.0 63632.4 63713.7 63771.0 63783.4 66017.7 66160.7 66205.0 66222.0 66258.0 16828.0 17016.7 17025.3 17034.3 17062.6 10780.2 10858.2 10866.2 11051.4 11053.7 16624.4 16992.4 17006.1 17255.9 17305.9 4948.4 5295.5 5895.4 6221.8 6237.5 954.6 986.5 1043.7 1070.3 1125.6 23428.5 30851.7 30990.0 31328.8 31490.4 1054.3 1069.9 1081.0 1107.5 1175.0 16181.8 16315.8 16353.9 16568.3 16586.4 634640.0 635687.0 636893.0 638531.8 640455.0 52808.0 62285.7 62902.4 63130.7 63131.0 1273.1 1396.8 1404.4 1437.4 1441.6 26647.3 31095.4 32035.0 32449.2 32687.5 42849.8 51387.5 52121.0 52274.2 52601.0 564514.0 565755.0 567418.0 570027.0 570072.0 36026.0 41016.4 41178.6 42118.6 42162.0 50100.0 50915.7 51092.5 51586.7 51701.5 40529.0 40782.8 40821.0 41672.8 42650.0 40777.4 40952.2 41293.6 42051.6 42400.8 40090.0 40571.2 40784.8 40791.6 41033.6 34885.0 35123.8 35474.5 36059.9 36145.3 23098.8 25082.7 25754.0 26371.6 26510.9 22:06:06 INFO - PROCESS | 1649 | 22:06:06 INFO - PROCESS | 1649 | [#2] jquery.html Cycles:180 Average:37307.67 Median:13124.73 stddev:105989.71 (807.6%) stddev-sans-first:106250.73 22:06:06 INFO - PROCESS | 1649 | Values: 355.2 375.6 383.0 385.2 401.8 16047.2 16348.9 21794.7 21801.9 21913.5 21532.0 21890.0 22637.3 22923.1 23102.9 6018.5 6048.2 6187.6 6213.1 6213.8 4178.9 4390.2 6052.9 6171.8 6583.7 6840.0 6920.0 6922.6 6928.3 6944.1 6575.5 6846.3 6847.2 6853.6 6855.0 5694.5 5924.4 5943.1 5977.9 5985.7 23889.6 24020.9 26552.6 27689.0 28225.2 2245.4 2256.0 2359.8 2516.7 2558.1 14499.2 15091.8 16569.7 16996.8 17515.0 1869.4 1894.1 1901.7 1939.8 1945.7 124390.4 129269.0 130353.0 131103.3 132454.0 10939.8 11160.3 11388.1 11579.2 11613.0 14326.2 14432.0 14442.4 14482.7 14483.0 8639.7 8688.2 9027.6 9050.4 9086.5 9189.9 9193.7 9207.4 9322.9 9350.1 6563.8 6599.2 6974.3 7093.7 7103.2 1696.7 1719.6 1883.5 1895.0 1937.4 875.9 960.5 983.7 1039.8 1042.4 21084.6 23097.8 23950.5 23969.3 24035.3 929.5 1026.6 1043.1 1063.0 1082.8 11898.8 12371.5 12533.5 12630.9 12659.2 623274.0 631095.0 636785.0 641708.0 642413.0 106323.5 133189.3 134142.0 139028.0 148684.3 951.3 967.3 982.5 985.7 1008.4 18607.3 20929.8 21376.9 21668.5 21856.6 47129.8 56447.3 57888.0 60081.4 61124.0 64015.8 82660.3 84192.2 85187.1 88771.0 6763.9 7252.7 7603.4 8126.4 8448.7 12987.9 13619.7 13710.2 14037.6 14038.3 11809.3 11900.6 12046.8 12166.8 12196.5 11589.2 11698.0 11766.9 11862.1 11901.2 11900.6 11989.2 11998.5 12176.5 12180.3 7593.5 7685.5 7695.8 7723.5 7868.0 9883.7 11974.0 12014.4 12112.8 12120.2 22:06:06 INFO - PROCESS | 1649 | 22:06:06 INFO - PROCESS | 1649 | [#3] mootools.html Cycles:180 Average:5834.38 Median:4910.40 stddev:3262.32 (66.4%) stddev-sans-first:3255.65 22:06:06 INFO - PROCESS | 1649 | Values: 1558.8 1591.4 1780.5 1894.8 1917.4 8709.7 8952.9 9127.3 9129.8 9141.5 7952.1 8214.6 8217.0 8282.7 8934.9 1829.8 1987.0 1993.4 2164.0 2423.9 2390.6 2394.7 2411.4 2414.4 2416.9 2085.6 2106.2 2333.5 2392.6 2411.6 2157.8 2174.1 2174.9 2290.4 2382.3 2372.8 2380.9 2385.7 2393.8 2398.3 9013.5 9089.8 9094.4 9099.2 9118.5 5287.1 5454.6 5454.9 5457.0 5459.6 3582.6 3659.1 3764.8 3771.2 3776.1 1098.5 1108.6 1112.4 1133.8 1134.2 12015.3 12048.2 12049.4 12055.4 12080.6 4653.8 4691.4 4906.6 4909.2 4911.6 10197.7 10210.5 10214.2 10245.3 10252.4 5422.9 5428.5 5445.0 5447.1 5452.7 4506.5 4914.0 4972.5 4984.9 4990.6 3780.8 3927.0 3929.3 3937.2 3939.6 1259.8 1304.4 1308.4 1311.9 1332.1 839.5 947.3 949.8 950.7 982.8 6046.2 6100.9 6189.9 6211.8 6220.4 971.6 997.5 998.0 1003.6 1028.0 4101.3 4106.8 4114.9 4197.0 4210.8 10242.9 10612.6 10652.6 10664.0 10699.7 10572.1 10582.0 10588.3 10598.7 10611.6 7876.1 8256.0 8265.4 8359.4 8366.0 5978.3 6171.6 6217.3 6302.9 6405.0 9944.0 10145.4 10392.1 10420.0 10438.4 10473.5 10496.4 10503.4 10520.4 10535.8 7471.2 7636.4 7740.3 7763.7 7834.8 7892.5 8166.1 8546.2 8597.9 8632.5 6516.9 7797.3 7947.4 7951.7 7957.2 7451.6 7601.7 7617.0 7761.3 7783.3 7210.6 7229.5 7303.6 7305.6 7316.3 4998.8 5145.5 5167.1 5231.8 5251.2 5166.4 5240.7 5255.3 5306.0 5353.8 22:06:06 INFO - PROCESS | 1649 | 22:06:06 INFO - PROCESS | 1649 | [#4] prototype.html Cycles:180 Average:4377.72 Median:4745.63 stddev:1382.68 (29.1%) stddev-sans-first:1352.36 22:06:06 INFO - PROCESS | 1649 | Values: 305.6 308.7 318.5 323.5 325.9 4597.8 5172.4 5209.6 5386.6 5468.8 4424.2 5061.7 5342.9 5362.9 5398.5 3941.2 4124.3 4143.2 4154.7 4176.1 3243.7 3606.6 4031.8 4130.6 4155.5 3618.4 3825.0 3875.8 4124.9 4140.8 3397.4 3474.5 3800.9 3921.0 4096.3 3588.6 3597.6 3602.7 3608.2 3621.5 4107.7 4854.5 4988.9 5226.3 5320.0 4201.9 4342.3 4457.7 4588.7 4614.3 4893.8 5348.4 5353.5 5476.9 5616.9 3268.6 3819.1 3840.9 3850.7 3854.3 4967.6 5103.2 5446.8 5670.0 5851.9 3404.9 3519.6 3712.3 3881.0 3902.8 3345.0 3981.7 3986.4 3988.7 3994.3 3894.3 4277.1 4440.7 4627.6 4681.8 4747.7 5670.3 5675.3 5677.7 5680.0 1192.8 1297.8 1310.7 1338.4 1341.0 731.4 809.5 823.8 826.6 828.1 3605.9 3875.9 3955.6 4180.0 4395.5 4311.6 4322.9 4494.9 4827.7 4934.5 3742.6 3810.4 4003.6 4349.9 4418.9 2300.7 2333.5 2397.3 2474.2 2571.0 4968.4 4989.8 4997.7 5003.4 5032.9 4296.0 4968.8 4969.2 4998.5 5079.8 4301.7 5441.3 6079.6 6108.9 6128.3 4539.3 5325.0 5897.7 5907.9 5918.6 4724.6 5644.6 5855.7 5880.9 5885.5 5148.6 5716.5 5933.6 5996.0 6083.9 3881.5 3885.9 3913.4 3929.6 3956.9 5155.9 5872.6 5878.1 5894.2 5935.2 5345.0 5693.2 5699.8 5724.7 5783.5 4743.6 4929.6 5340.3 5671.1 5671.3 4924.7 5559.9 5562.6 5602.5 5613.2 5167.9 5482.4 5640.7 5675.9 5698.0 5079.5 5551.4 5569.1 5577.9 5586.6 22:06:06 INFO - PROCESS | 1649 | 22:06:06 INFO - PROCESS | 1649 | [#5] yui.html Cycles:180 Average:25330.12 Median:3619.66 stddev:40729.51 (1125.2%) stddev-sans-first:40801.93 22:06:06 INFO - PROCESS | 1649 | Values: 743.4 753.8 770.6 781.5 848.3 11913.6 16434.0 16469.6 16491.0 16509.5 14834.0 14970.4 14975.9 14999.0 15004.6 677.5 724.8 757.2 889.5 894.6 904.9 919.5 919.7 923.4 923.7 956.1 957.4 958.0 961.4 961.8 751.5 932.6 951.7 971.6 972.4 721.6 723.5 725.7 725.9 725.9 15156.2 15204.2 15220.2 15258.3 15275.4 13879.4 14052.2 14168.9 14184.6 14387.9 12770.7 12775.7 12835.4 13071.3 13309.9 4547.1 4569.5 4715.1 4735.9 4810.7 111101.9 113250.0 113295.4 117892.4 117976.0 11218.0 11251.6 11273.4 11400.6 11803.5 18699.6 22327.3 22369.8 22376.4 22631.5 8008.1 8016.7 8101.8 8201.7 8274.9 4444.5 4514.9 4553.3 4568.9 4650.0 3495.8 3618.8 3620.5 3620.7 3624.3 656.1 660.9 671.3 671.5 680.3 563.1 602.3 602.7 616.5 668.2 8464.0 8656.3 8846.0 8909.3 9154.3 598.8 608.8 647.8 649.2 652.7 4422.3 4491.9 4495.3 4495.8 4576.8 148009.0 151583.0 152883.0 154129.0 157556.0 132706.0 136610.0 136903.3 137837.0 140174.0 109658.0 113632.0 114516.0 115134.0 115894.4 7510.8 8584.9 8588.3 8647.9 8840.9 43972.6 44645.0 52208.0 62095.0 64304.7 85284.7 88061.6 90021.0 90921.1 94646.5 11937.9 13925.4 13934.9 13967.9 14178.6 15516.5 15664.5 16047.3 16055.9 16163.1 14449.7 14480.9 14505.1 14612.2 15061.1 13545.0 14178.2 14280.9 14303.8 14341.6 13625.1 14071.8 14494.3 14503.9 14647.3 9975.5 11344.6 11527.9 11557.6 11732.2 10310.7 11296.9 11408.7 11459.3 11552.5 22:06:06 INFO - PROCESS | 1649 | -------- Summary: end -------- 22:06:06 INFO - PROCESS | 1649 | 22:06:06 INFO - TEST-INFO | 1649: exit 0 22:06:07 INFO - TEST-OK | dromaeo_css | took 1116837ms 22:06:07 INFO - TEST-START | kraken 22:06:07 INFO - operating with platform_type : mac_ 22:06:07 INFO - Initialising browser for kraken test... 22:06:07 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpMSJA1J/profile http://localhost:49271/getInfo.html) 22:06:09 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 22:06:09 INFO - PROCESS | 1655 | colorDepth:24 22:06:09 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 22:06:09 INFO - PROCESS | 1655 | __metrics 22:06:09 INFO - PROCESS | 1655 | 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" 22:06:09 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:06:10 INFO - TEST-INFO | 1655: exit 0 22:06:10 INFO - Browser initialized. 22:06:10 INFO - Running cycle 1/1 for kraken test... 22:06:10 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpMSJA1J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:06:22 INFO - PROCESS | 1656 | RSS: Main: 243376128 22:06:22 INFO - PROCESS | 1656 | 22:06:24 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 22:06:25 INFO - PROCESS | 1656 | RSS: Main: 294035456 22:06:25 INFO - PROCESS | 1656 | 22:06:28 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 22:06:28 INFO - PROCESS | 1656 | RSS: Main: 304025600 22:06:28 INFO - PROCESS | 1656 | 22:06:32 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 22:06:32 INFO - PROCESS | 1656 | RSS: Main: 388702208 22:06:32 INFO - PROCESS | 1656 | 22:06:34 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 22:06:35 INFO - PROCESS | 1656 | RSS: Main: 289714176 22:06:35 INFO - PROCESS | 1656 | 22:06:37 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:06:38 INFO - PROCESS | 1656 | RSS: Main: 293593088 22:06:38 INFO - PROCESS | 1656 | 22:06:40 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 22:06:41 INFO - PROCESS | 1656 | RSS: Main: 331386880 22:06:41 INFO - PROCESS | 1656 | 22:06:44 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 22:06:45 INFO - PROCESS | 1656 | RSS: Main: 332759040 22:06:45 INFO - PROCESS | 1656 | 22:06:48 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 22:06:48 INFO - PROCESS | 1656 | RSS: Main: 331939840 22:06:48 INFO - PROCESS | 1656 | 22:06:50 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:06:50 INFO - PROCESS | 1656 | RSS: Main: 311201792 22:06:50 INFO - PROCESS | 1656 | 22:06:52 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:06:53 INFO - PROCESS | 1656 | RSS: Main: 318226432 22:06:53 INFO - PROCESS | 1656 | 22:06:55 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:06:56 INFO - PROCESS | 1656 | RSS: Main: 315707392 22:06:56 INFO - PROCESS | 1656 | 22:06:59 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:06:59 INFO - PROCESS | 1656 | RSS: Main: 325386240 22:06:59 INFO - PROCESS | 1656 | 22:07:02 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:07:03 INFO - PROCESS | 1656 | RSS: Main: 327868416 22:07:03 INFO - PROCESS | 1656 | 22:07:05 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 22:07:05 INFO - PROCESS | 1656 | RSS: Main: 371273728 22:07:05 INFO - PROCESS | 1656 | 22:07:05 INFO - PROCESS | 1656 | __start_tp_report 22:07:05 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 22:07:05 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 22:07:05 INFO - PROCESS | 1656 | |i|pagename|runs| 22:07:05 INFO - PROCESS | 1656 | |0;ai-astar;101;113;113;112;113;112;113;112;112;112 22:07:05 INFO - PROCESS | 1656 | |1;audio-beat-detection;146;105;106;169;134;137;109;128;145;106 22:07:05 INFO - PROCESS | 1656 | |2;audio-dft;178;184;184;186;185;182;179;183;181;182 22:07:05 INFO - PROCESS | 1656 | |3;audio-fft;79;74;56;105;57;56;63;64;93;57 22:07:05 INFO - PROCESS | 1656 | |4;audio-oscillator;83;83;90;70;71;68;95;71;67;97 22:07:05 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;118;127;88;85;88;84;88;85;88;84 22:07:05 INFO - PROCESS | 1656 | |6;imaging-darkroom;93;92;94;93;93;93;95;93;93;93 22:07:05 INFO - PROCESS | 1656 | |7;imaging-desaturate;88;83;86;84;115;137;133;84;84;104 22:07:05 INFO - PROCESS | 1656 | |8;json-parse-financial;55;51;54;55;53;54;55;53;53;56 22:07:05 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;64;66;71;75;70;69;68;69;68;69 22:07:05 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;85;85;83;83;85;81;79;82;82;87 22:07:05 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;156;137;165;148;150;136;137;141;237;146 22:07:05 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;161;162;162;162;161;163;162;162;174;159 22:07:05 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;64;65;68;66;83;65;64;89;66;66 22:07:05 INFO - PROCESS | 1656 | __end_tp_report 22:07:05 INFO - PROCESS | 1656 | __start_cc_report 22:07:05 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,1997 22:07:05 INFO - PROCESS | 1656 | __end_cc_report 22:07:05 INFO - PROCESS | 1656 | __startTimestamp1467868025332__endTimestamp 22:07:05 INFO - PROCESS | 1656 | 22:07:05 INFO - PROCESS | 1656 | ------- Summary: start ------- 22:07:05 INFO - PROCESS | 1656 | Number of tests: 14 22:07:05 INFO - PROCESS | 1656 | 22:07:05 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.50 stddev:3.65 (3.2%) stddev-sans-first:0.53 22:07:05 INFO - PROCESS | 1656 | Values: 101.0 113.0 113.0 112.0 113.0 112.0 113.0 112.0 112.0 112.0 22:07:05 INFO - PROCESS | 1656 | 22:07:05 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:128.50 Median:135.50 stddev:21.77 (16.1%) stddev-sans-first:22.15 22:07:05 INFO - PROCESS | 1656 | Values: 146.0 105.0 106.0 169.0 134.0 137.0 109.0 128.0 145.0 106.0 22:07:05 INFO - PROCESS | 1656 | 22:07:05 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:182.40 Median:183.50 stddev:2.55 (1.4%) stddev-sans-first:2.15 22:07:05 INFO - PROCESS | 1656 | Values: 178.0 184.0 184.0 186.0 185.0 182.0 179.0 183.0 181.0 182.0 22:07:05 INFO - PROCESS | 1656 | 22:07:05 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:70.40 Median:63.50 stddev:17.21 (27.1%) stddev-sans-first:17.97 22:07:05 INFO - PROCESS | 1656 | Values: 79.0 74.0 56.0 105.0 57.0 56.0 63.0 64.0 93.0 57.0 22:07:05 INFO - PROCESS | 1656 | 22:07:05 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:79.50 Median:83.00 stddev:11.57 (13.9%) stddev-sans-first:12.20 22:07:05 INFO - PROCESS | 1656 | Values: 83.0 83.0 90.0 70.0 71.0 68.0 95.0 71.0 67.0 97.0 22:07:05 INFO - PROCESS | 1656 | 22:07:05 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:93.50 Median:86.50 stddev:15.52 (17.9%) stddev-sans-first:13.70 22:07:05 INFO - PROCESS | 1656 | Values: 118.0 127.0 88.0 85.0 88.0 84.0 88.0 85.0 88.0 84.0 22:07:05 INFO - PROCESS | 1656 | 22:07:05 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:93.20 Median:93.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 22:07:05 INFO - PROCESS | 1656 | Values: 93.0 92.0 94.0 93.0 93.0 93.0 95.0 93.0 93.0 93.0 22:07:05 INFO - PROCESS | 1656 | 22:07:05 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:99.80 Median:84.00 stddev:21.33 (25.4%) stddev-sans-first:22.19 22:07:05 INFO - PROCESS | 1656 | Values: 88.0 83.0 86.0 84.0 115.0 137.0 133.0 84.0 84.0 104.0 22:07:05 INFO - PROCESS | 1656 | 22:07:05 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.50 stddev:1.45 (2.7%) stddev-sans-first:1.48 22:07:05 INFO - PROCESS | 1656 | Values: 55.0 51.0 54.0 55.0 53.0 54.0 55.0 53.0 53.0 56.0 22:07:05 INFO - PROCESS | 1656 | 22:07:05 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:2.92 (4.2%) stddev-sans-first:2.51 22:07:05 INFO - PROCESS | 1656 | Values: 64.0 66.0 71.0 75.0 70.0 69.0 68.0 69.0 68.0 69.0 22:07:05 INFO - PROCESS | 1656 | 22:07:05 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:84.00 stddev:2.35 (2.8%) stddev-sans-first:2.40 22:07:05 INFO - PROCESS | 1656 | Values: 85.0 85.0 83.0 83.0 85.0 81.0 79.0 82.0 82.0 87.0 22:07:05 INFO - PROCESS | 1656 | 22:07:05 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:155.30 Median:149.00 stddev:30.16 (20.2%) stddev-sans-first:31.98 22:07:05 INFO - PROCESS | 1656 | Values: 156.0 137.0 165.0 148.0 150.0 136.0 137.0 141.0 237.0 146.0 22:07:05 INFO - PROCESS | 1656 | 22:07:05 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.80 Median:162.00 stddev:4.08 (2.5%) stddev-sans-first:4.27 22:07:05 INFO - PROCESS | 1656 | Values: 161.0 162.0 162.0 162.0 161.0 163.0 162.0 162.0 174.0 159.0 22:07:05 INFO - PROCESS | 1656 | 22:07:05 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:66.00 stddev:8.83 (13.4%) stddev-sans-first:9.13 22:07:05 INFO - PROCESS | 1656 | Values: 64.0 65.0 68.0 66.0 83.0 65.0 64.0 89.0 66.0 66.0 22:07:05 INFO - PROCESS | 1656 | -------- Summary: end -------- 22:07:05 INFO - PROCESS | 1656 | 22:07:06 INFO - TEST-INFO | 1656: exit 0 22:07:06 INFO - TEST-OK | kraken | took 59133ms 22:07:06 INFO - SUITE-END | took 1175s 22:07:06 INFO - Completed test suite (00:19:36) 22:07:06 INFO - javascript benchmark 22:07:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3325.6674332566745, 3327.0, 3335.483000134979, 3370.359631669981, 3388.15296175956, 5680.9715951420185, 5727.742251598677, 5763.423657634235, 5786.884262314757, 5801.564882633809, 5708.743106560204, 5714.971425142869, 5869.0, 5884.0879663652095, 5908.9113663294975, 5145.228215767627, 5151.356080489939, 5192.948070519303, 5216.8174113906025, 5224.947750522503, 5305.0, 5321.547668448186, 5336.17289320156, 5353.143497040474, 5354.089804733185, 5152.819651312186, 5159.871003224912, 5200.687958722451, 5211.244369566411, 5248.422673505911, 5094.7197904115255, 5126.333576635051, 5132.486751324875, 5184.222366644995, 5282.603804714623, 5133.974330128325, 5139.049275883974, 5171.560417364529, 5181.974090129525, 5239.423663397023, 4771.212749896263, 5648.971755141239, 5670.68811215383, 5673.546116310727, 5762.683052432115, 6204.689765511706, 6254.499640028786, 6268.498520118425, 6271.466925311354, 6272.498200144023, 6285.120083188357, 6311.810645680637, 6369.267534233576, 6373.649449280288, 6396.3283855194995, 4970.478099799505, 5737.082066869322, 5787.334456537468, 5842.357340692521, 5862.355140934494, 6314.55798094129, 6322.620642761449, 6329.335419780857, 6331.366863313632, 6333.20834895638, 6165.969170154121, 6198.535109866778, 6217.036359364306, 6221.097940798559, 6222.906656400158, 6129.23653806838, 6186.628802271878, 6259.3427690091885, 6272.1219029335925, 6310.305866354697, 6212.099245609361, 6265.592736472115, 6266.592671476339, 6269.811905642838, 6277.246730392382, 6115.0, 6222.315545290015, 6262.874742505124, 6269.341719119518, 6312.116303717483, 4268.338407546835, 4905.656604037755, 4942.9619779846635, 4959.528844759742, 4967.82612608557, 4436.622887054572, 4461.330800379969, 4464.419625448671, 4474.0, 4501.594856462934, 5601.5238704710555, 5666.923284575917, 5679.062954612526, 5700.344460387026, 5751.1373294006235, 6189.102580125947, 6222.844428889314, 6233.844153896189, 6309.589876658094, 6374.521910856612, 5704.429557044263, 5706.885862282814, 5723.942760572424, 5725.8568535786935, 5744.913826292609, 5319.388270348882, 5421.891562168814, 5437.211604317431, 5445.346558413015, 5453.454654534515, 6210.472109870621, 6260.718267677874, 6261.499080073492, 6288.717007734663, 6317.241930968313, 6278.717457714505, 6317.873642527215, 6324.683765811599, 6342.556021078481, 6346.492280617632, 6244.157038799885, 6282.937170628235, 6294.874102517832, 6308.779192728232, 6314.905276420765, 6108.251008765869, 6139.693015349304, 6152.138700582012, 6163.982942814386, 6173.0, 6191.19514463135, 6304.936950630435, 6314.305426403183, 6336.58812177207, 6357.110004599267, 6118.235220597426, 6134.38656134383, 6139.938600613937, 6143.955527560236, 6153.446189842935, 5985.760569577168, 5988.820335389945, 6030.095485677183, 6136.785212517719, 6142.692865356804, 5879.73541190656, 5925.674087925206, 5936.584439089395, 5952.0179170436395, 5989.670568118795, 5999.940000600112, 6105.389461053859, 6134.693490130915, 6139.0, 6168.691565421801, 5775.884482310246, 5887.882242355215, 5898.292204935264, 5949.0, 5970.223870896929], "value": 5708.029652711099, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.2447706055613, 489.53005115089525, 494.8124501197129, 497.0804012576734, 515.6390526631359, 26621.068262610814, 42336.0, 42596.36105458413, 43013.13973720524, 43165.78417107914, 42653.93365165872, 43077.7846110769, 44764.77617611916, 44952.77523612385, 45015.54984450155, 8877.46735195887, 9809.215262778978, 9951.601935922554, 9976.90023099767, 9982.201423886072, 11860.0, 12065.698357541043, 12095.334756588383, 12244.877551224507, 12267.202631828903, 10294.794104117913, 12010.63968080959, 12092.33492157931, 12127.211731237441, 12134.757304853898, 11989.640310790646, 12079.335636539987, 12095.818562721566, 12109.818352724717, 12121.27272363661, 11868.465919033579, 11950.402479876058, 11967.82048269268, 11971.281723096643, 11992.400379980965, 41868.0, 42214.577854221374, 42227.155456891, 42260.36609450861, 42324.0, 3609.2781443711365, 3995.839730573016, 4044.635982761536, 4297.97851010746, 4439.778011099432, 32795.0, 32934.83532582322, 33113.0, 33684.83157584196, 33872.661273387195, 3303.306305675811, 3317.7345812335197, 3334.3164651246434, 3345.5818022747158, 3449.1721986723005, 516865.0, 517460.0, 520411.0, 520783.39608301717, 521738.0, 63385.0, 63632.36367636264, 63713.681431593475, 63771.043434348525, 63783.36216637867, 66017.66991165014, 66160.6691966537, 66205.0, 66222.0, 66258.0, 16828.0, 17016.744748828776, 17025.31898724062, 17034.31862725502, 17062.573435664206, 10780.191485638608, 10858.185636077325, 10866.185036122322, 11051.447427628586, 11053.723656908482, 16624.418145364853, 16992.405265815883, 17006.064666443464, 17255.91372043157, 17305.913470432566, 4948.406191257072, 5295.464315348583, 5895.41045895407, 6221.844453888689, 6237.500999919996, 954.6396385151132, 986.4673076538733, 1043.7234132954773, 1070.2561719604955, 1125.6116639759434, 23428.531429371316, 30851.69148308488, 30990.0, 31328.843355783076, 31490.37019259602, 1054.314695447965, 1069.8662667166604, 1080.9729756755987, 1107.4960892793758, 1174.9530018799323, 16181.757273640906, 16315.83684163167, 16353.918230408772, 16568.334837232054, 16586.419475318307, 634640.0, 635687.0, 636893.0, 638531.8073409696, 640455.0, 52808.0, 62285.68857155685, 62902.370976289654, 63130.684346577975, 63131.0, 1273.1151849464534, 1396.7904814277736, 1404.4452441285634, 1437.4034775568023, 1441.5891470930735, 26647.33381665474, 31095.37809243757, 32035.0, 32449.188770279987, 32687.50968735423, 42849.785751071046, 51387.48612513827, 52121.0, 52274.21588676249, 52601.0, 564514.0, 565755.0, 567418.0, 570027.0, 570072.0, 36026.0, 41016.384754228115, 41178.58821411747, 42118.57881421147, 42162.0, 50100.0, 50915.74542127266, 51092.48907511026, 51586.74206628943, 51701.48298517117, 40529.0, 40782.79608601938, 40821.0, 41672.79163604163, 42650.0, 40777.38833917553, 40952.1809563813, 41293.58706412897, 42051.57948420477, 42400.78799605982, 40089.997750056486, 40571.188576227716, 40784.79607601943, 40791.592084079966, 41033.58966410417, 34885.0, 35123.82438087793, 35474.467882982295, 36059.91820245397, 36145.27709445744, 23098.76901230966, 25082.725024506715, 25754.0, 26371.60442593324, 26510.867445662647], "value": 21071.745669085925, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.1511886591046, 375.57184809317374, 382.96553310202086, 385.1776457263741, 401.83926429428226, 16047.191741445258, 16348.937319074266, 21794.673079903794, 21801.90990450479, 21913.452163695914, 21532.0, 21890.01494932728, 22637.320880373572, 22923.083076676914, 23102.88448557759, 6018.458338749511, 6048.1834952281315, 6187.5668703190795, 6213.130161777355, 6213.8135855924165, 4178.853740119096, 4390.1878152541885, 6052.909206361886, 6171.783987560436, 6583.703733332011, 6840.0, 6920.0, 6922.58464492132, 6928.2725313842075, 6944.131983502062, 6575.506836987245, 6846.281140480228, 6847.1783385994, 6853.554518956302, 6855.006024126524, 5694.4590263924865, 5924.437178468039, 5943.138244954501, 5977.940220597782, 5985.670788106696, 23889.641655375184, 24020.879895600585, 26552.60171097435, 27689.0, 28225.15324540267, 2245.427416008907, 2255.988720056406, 2359.823013273994, 2516.7357427470033, 2558.066305798389, 14499.202543860083, 15091.849081509265, 16569.6686066278, 16996.83003169965, 17515.03667298298, 1869.3923226025606, 1894.1476335648874, 1901.6767149584605, 1939.7769256535537, 1945.7081437784304, 124390.37804811008, 129269.0, 130352.99999999905, 131103.34448327794, 132454.0, 10939.83590246147, 11160.274582152135, 11388.088952883749, 11579.247348922294, 11613.0, 14326.212058336683, 14432.0, 14442.350094245785, 14482.710345793235, 14483.0, 8639.740807775777, 8688.218060374596, 9027.63889444428, 9050.366474346863, 9086.54567271647, 9189.90810091904, 9193.724188274362, 9207.40151890125, 9322.906770932204, 9350.111739384747, 6563.849352310917, 6599.175103112111, 6974.26770189133, 7093.680784364716, 7103.218645948941, 1696.7454881767587, 1719.5701074731317, 1883.4726276642562, 1894.9810501894804, 1937.4381429385603, 875.935738078238, 960.5485421851719, 983.7491439682835, 1039.8336266197373, 1042.358949246208, 21084.578308433745, 23097.769022309898, 23950.52098958046, 23969.28092157238, 24035.27894163178, 929.4887811703671, 1026.645807196516, 1043.1029314789428, 1062.9787404251872, 1082.821334479802, 11898.810118988033, 12371.505139794308, 12533.498660053496, 12630.863222309852, 12659.240445573296, 623274.0, 631095.0, 636785.0, 641708.0, 642413.0, 106323.4683826576, 133189.3340533291, 134142.0, 139028.0, 148684.25657871642, 951.2817822544073, 967.2793768642266, 982.5087456271864, 985.6648739428485, 1008.3798463944768, 18607.255709771456, 20929.790702093393, 21376.893115534323, 21668.469132972074, 21856.562868742854, 47129.764351179394, 56447.306580802644, 57888.0, 60081.39918600933, 61124.0, 64015.759448419085, 82660.34679306501, 84192.15807841843, 85187.14812851792, 88771.0106090455, 6763.93236067633, 7252.746153884589, 7603.391728661583, 8126.431149819692, 8448.704295349633, 12987.870121298665, 13619.659508512366, 13710.24593647359, 14037.578872633838, 14038.298085095908, 11809.291442513133, 11900.583479578174, 12046.819297710366, 12166.817497737718, 12196.512139514674, 11589.24669896454, 11698.0, 11766.941165294118, 11862.110341724232, 11901.166918315635, 11900.642980710592, 11989.22070065443, 11998.540663998034, 12176.512939482322, 12180.330081845583, 7593.544387336778, 7685.538867667958, 7695.769126926201, 7723.53658780475, 7868.0, 9883.654072107729, 11974.0, 12014.399280035788, 12112.757744844877, 12120.151589388659], "value": 10246.00487233151, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1558.7973563436751, 1591.403223791078, 1780.4925596205076, 1894.753682021337, 1917.3864363403716, 8709.651613935443, 8952.91047089529, 9127.269818414528, 9129.771755706111, 9141.542922853847, 7952.085510166333, 8214.630341634625, 8217.0, 8282.710105146321, 8934.865977010333, 1829.8353148216625, 1986.9701954470622, 1993.3521605478204, 2163.9504840152513, 2423.8545687258734, 2390.5816482115647, 2394.6527753475734, 2411.360989337827, 2414.4326083370393, 2416.915407960722, 2085.551606404623, 2106.1891171898774, 2333.53329334133, 2392.581298272804, 2411.6141417373224, 2157.751858536265, 2174.097749433983, 2174.902129404165, 2290.415943934303, 2382.344855164826, 2372.774586414288, 2380.9285721428387, 2385.666006759055, 2393.796527295182, 2398.2805158452393, 9013.549322533847, 9089.81820363589, 9094.363394562382, 9099.1810737034, 9118.452892826452, 5287.127623942045, 5454.645448045864, 5454.863628409282, 5457.0, 5459.563234941234, 3582.5880023797076, 3659.0852286928266, 3764.8305826237884, 3771.151490914522, 3776.055986003499, 1098.5441041967574, 1108.5842808946645, 1112.3881864974312, 1133.8355938388888, 1134.2400591603646, 12015.279083255033, 12048.216865903689, 12049.397530123459, 12055.397230138546, 12080.637580872588, 4653.767311634405, 4691.390119284471, 4906.55840974314, 4909.165441874889, 4911.631627627942, 10197.694069177936, 10210.489475526194, 10214.182865370753, 10245.334053286513, 10252.43611601369, 5422.864428389322, 5428.4842939920645, 5445.019896418604, 5447.101228297366, 5452.700101494376, 4506.549345065533, 4914.0, 4972.5276098770555, 4984.850454486371, 4990.600751939836, 3780.8487660493824, 3927.0, 3929.332013557702, 3937.2125574885135, 3939.6454319111417, 1259.785836407813, 1304.4064950447523, 1308.4373719300793, 1311.8753718396738, 1332.054241488554, 839.5130824121994, 947.2989987409268, 949.8242825077383, 950.6862735297335, 982.759223990127, 6046.244219472566, 6100.908486372708, 6189.907151392733, 6211.81364559064, 6220.409061139275, 971.6307803034802, 997.4962643864802, 997.9900200998043, 1003.5985605757755, 1028.0285130551706, 4101.26177288085, 4106.815193316308, 4114.938275925863, 4197.0, 4210.789460526961, 10242.897571024194, 10612.628558000433, 10652.573897044187, 10664.0, 10699.679009629723, 10572.101371383365, 10582.0, 10588.311759735592, 10598.735031624272, 10611.575536978435, 7876.133625301212, 8256.009278886451, 8265.421420500628, 8359.414840961075, 8365.958170209231, 5978.3423823378525, 6171.6297022178815, 6217.316095229431, 6302.905456418066, 6404.967975160281, 9944.0, 10145.391276523136, 10392.116670083127, 10419.958004199823, 10438.425886576311, 10473.528691208761, 10496.422696751752, 10503.42231177262, 10520.368777873353, 10535.841962370723, 7471.178170401143, 7636.350910172475, 7740.3420709240345, 7763.650635721293, 7834.843303134019, 7892.526448413114, 8166.060902996232, 8546.188112129337, 8597.914020859962, 8632.525211113449, 6516.934830651822, 7797.259260370256, 7947.44367894265, 7951.681932722858, 7957.164497727887, 7451.552906825608, 7601.695932162652, 7617.047869016373, 7761.262680045386, 7783.260590243918, 7210.639468026473, 7229.530080544748, 7303.598302093435, 7305.634718263959, 7316.268373162641, 4998.775055122455, 5145.511176438233, 5167.069927413102, 5231.8168864089575, 5251.159814429826, 5166.354205724285, 5240.71176085319, 5255.290535777621, 5305.973470132624, 5353.812616558402], "value": 4686.751321285032, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.55389131867486, 308.6604734791729, 318.5333486442361, 323.4953472582771, 325.93807176636454, 4597.77011149442, 5172.379314482263, 5209.583233341333, 5386.569074474042, 5468.7812487500505, 4424.247877860764, 5061.721605311706, 5342.91985620216, 5362.865928351784, 5398.514133727964, 3941.1623630985787, 4124.340105583107, 4143.218416081084, 4154.667626589873, 4176.1230141670285, 3243.6594157613463, 3606.6213047630013, 4031.798410079499, 4130.566290539495, 4155.501339839224, 3618.3667858124854, 3824.9617503825025, 3875.767453952758, 4124.896877578055, 4140.772257525835, 3397.371486275022, 3474.4614584739406, 3800.916738729463, 3920.9607903920883, 4096.344584866437, 3588.5825099085714, 3597.6402359764074, 3602.711783057375, 3608.1520842601967, 3621.4567814827724, 4107.650849677781, 4854.490278520775, 4988.900221995576, 5226.346706661668, 5320.0, 4201.873943781691, 4342.348647702838, 4457.748836837376, 4588.715159755274, 4614.261718125117, 4893.8254818843225, 5348.384935732402, 5353.518183363516, 5476.91784623231, 5616.9157462638095, 3268.5750852389274, 3819.1406933439753, 3840.9039774005596, 3850.652271704881, 3854.325493038707, 4967.627427942919, 5103.234514822732, 5446.836594902159, 5669.971650141723, 5851.912221316684, 3404.9489257661153, 3519.5776506819348, 3712.3132220539287, 3881.029742564359, 3902.804859757001, 3344.963061450958, 3981.7212795104642, 3986.421968814506, 3988.726425937246, 3994.2810294147334, 3894.3184942634925, 4277.0539404570845, 4440.666949978699, 4627.5603817637275, 4681.789319480631, 4747.667663263607, 5670.347909990322, 5675.290588676416, 5677.659340439587, 5680.0, 1192.7614477104614, 1297.8060184630162, 1310.6723319170208, 1338.3642769684323, 1341.0411555737694, 731.4185222747928, 809.5345176523523, 823.8434697407473, 826.6114925984778, 828.1180542721982, 3605.8737944171826, 3875.918644677432, 3955.6044395560216, 4180.0, 4395.472543294825, 4311.628604267703, 4322.935155972663, 4494.865154045384, 4827.710337379768, 4934.4572097069295, 3742.55089389275, 3810.447485114643, 4003.619656132663, 4349.933297025589, 4418.889527761831, 2300.7124109486313, 2333.4749681321905, 2397.3287479505766, 2474.2206205045354, 2570.9742902570733, 4968.385274785709, 4989.750512474362, 4997.675151115166, 5003.449620541737, 5032.949670503322, 4296.0, 4968.801247950114, 4969.167574482511, 4998.450170481244, 5079.790291223329, 4301.698881078294, 5441.32297270371, 6079.604825686316, 6108.908366374597, 6128.295246046672, 4539.341795439709, 5325.0, 5897.675627840338, 5907.881842363043, 5918.644881307136, 4724.598409135262, 5644.604877658525, 5855.677937713466, 5880.882382352414, 5885.529157667462, 5148.613853960893, 5716.54267658578, 5933.643981361132, 5995.991342900177, 6083.866808593666, 3881.476000739864, 3885.86399476017, 3913.412988051815, 3929.626685464876, 3956.8615098471414, 5155.896882062413, 5872.618279811799, 5878.118282257525, 5894.233749612523, 5935.228420305332, 5344.9732751336, 5693.24613947342, 5699.772009119589, 5724.713764311851, 5783.479486846204, 4743.596794272526, 4929.556339929423, 5340.341865821924, 5671.100181439264, 5671.347795003462, 4924.65527413092, 5559.8888022240135, 5562.634606063435, 5602.52378547828, 5613.242212301287, 5167.948320516897, 5482.39693633708, 5640.689762062962, 5675.8864822704145, 5697.977218087519, 5079.466656001066, 5551.361593416647, 5569.10894256917, 5577.944220557904, 5586.636868603528], "value": 3943.107727466432, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.3978477433279, 753.8153152477647, 770.6416516319911, 781.5261164125461, 848.3150827630548, 11913.642590722282, 16433.99999999997, 16469.588260293483, 16491.0, 16509.504714858544, 14834.03578767382, 14970.401183952656, 14975.925120374382, 14999.0, 15004.624884377896, 677.5088061155648, 724.7572063358755, 757.2389748302948, 889.5196593839352, 894.6376717429436, 904.8552231642939, 919.5080631861955, 919.6965001549472, 923.3905622289291, 923.6720964057763, 956.077385323163, 957.3681370295607, 958.0371726414978, 961.4231461123305, 961.8172547216042, 751.5265382808823, 932.5803388475214, 951.6764300137952, 971.5676523946846, 972.4311277902435, 721.588694444167, 723.5080145501057, 725.6879541797025, 725.9237780033073, 725.9382952449048, 15156.242187890672, 15204.16377099259, 15220.162891040989, 15258.313375898, 15275.38898444061, 13879.444822207099, 14052.227127507984, 14168.937329700211, 14184.574462766133, 14387.92806035963, 12770.74458510834, 12775.74448511034, 12835.422405991752, 13071.281079540622, 13309.866901331057, 4547.113312903985, 4569.520200378979, 4715.127701375257, 4735.905281894377, 4810.7113573185725, 111101.88898110997, 113250.0, 113295.43352283185, 117892.41053794677, 117976.0, 11218.046466050313, 11251.606193783178, 11273.436328183558, 11400.600978965862, 11803.468843902045, 18699.626007479776, 22327.330180094625, 22369.76966266871, 22376.440588985406, 22631.547369052856, 8008.119106898236, 8016.7194148204535, 8101.797455063553, 8201.71294004707, 8274.917250827535, 4444.511103778582, 4514.909701805946, 4553.294239392833, 4568.908621827612, 4650.023495066006, 3495.807730574843, 3618.800965946898, 3620.511230983836, 3620.6741393274733, 3624.347617428888, 656.0716586030809, 660.9107770451023, 671.2951401028901, 671.5366397185926, 680.3196803196803, 563.138398250669, 602.3193791016124, 602.668532307238, 616.5437576193584, 668.1514476614672, 8464.0, 8656.307495400353, 8846.0, 8909.331800115016, 9154.26765858743, 598.7934162713857, 608.8264844519291, 647.834802125455, 649.217692680319, 652.6932341799346, 4422.29243321067, 4491.865244042684, 4495.2582823834355, 4495.752733599618, 4576.839810606612, 148009.0, 151583.0, 152883.0, 154129.0, 157556.0, 132706.0, 136610.0, 136903.31548342193, 137837.0, 140174.0, 109658.0, 113632.0, 114515.99999999833, 115134.0, 115894.42052789681, 7510.8497830042, 8584.914150858662, 8588.26999705032, 8647.870281945901, 8840.867386989072, 43972.56027439813, 44645.0, 52208.0, 62095.0, 64304.67847660732, 85284.72072918787, 88061.55969220113, 90021.0, 90921.09078909391, 94646.52676736572, 11937.883048705397, 13925.373358199107, 13934.860651393356, 13967.860321396656, 14178.574642760734, 15516.534503964898, 15664.451744188898, 16047.277872495531, 16055.919720401324, 16163.111028893523, 14449.711005780036, 14480.927595361956, 14505.129692218501, 14612.196329201995, 15061.096334219981, 13545.0, 14178.220197888802, 14280.9466170544, 14303.785443218569, 14341.64145896361, 13625.114367566077, 14071.788923166365, 14494.275286235435, 14503.854961450672, 14647.267636617913, 9975.50122493887, 11344.577592864729, 11527.942360288145, 11557.595484158013, 11732.237404568676, 10310.690679279334, 11296.943515282699, 11408.657740267805, 11459.25514841566, 11552.537898483966], "value": 8000.656871552216, "unit": "score"}], "name": "dromaeo_css", "value": 7529.58885824775, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 113.0, 112.0, 113.0, 112.0, 113.0, 112.0, 112.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 105.0, 106.0, 169.0, 134.0, 137.0, 109.0, 128.0, 145.0, 106.0], "value": 128.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 184.0, 184.0, 186.0, 185.0, 182.0, 179.0, 183.0, 181.0, 182.0], "value": 182.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 74.0, 56.0, 105.0, 57.0, 56.0, 63.0, 64.0, 93.0, 57.0], "value": 70.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 90.0, 70.0, 71.0, 68.0, 95.0, 71.0, 67.0, 97.0], "value": 79.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 127.0, 88.0, 85.0, 88.0, 84.0, 88.0, 85.0, 88.0, 84.0], "value": 93.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 94.0, 93.0, 93.0, 93.0, 95.0, 93.0, 93.0, 93.0], "value": 93.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 83.0, 86.0, 84.0, 115.0, 137.0, 133.0, 84.0, 84.0, 104.0], "value": 99.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 51.0, 54.0, 55.0, 53.0, 54.0, 55.0, 53.0, 53.0, 56.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 71.0, 75.0, 70.0, 69.0, 68.0, 69.0, 68.0, 69.0], "value": 68.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 83.0, 83.0, 85.0, 81.0, 79.0, 82.0, 82.0, 87.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 137.0, 165.0, 148.0, 150.0, 136.0, 137.0, 141.0, 237.0, 146.0], "value": 155.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 162.0, 161.0, 163.0, 162.0, 162.0, 174.0, 159.0], "value": 162.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 68.0, 66.0, 83.0, 65.0, 64.0, 89.0, 66.0, 66.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1452.2999999999997, "alertThreshold": 2.0}]} 22:07:06 INFO - Return code: 0 22:07:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:07:06 INFO - # TBPL SUCCESS # 22:07:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:07:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:07:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:07:06 INFO - 2016-07-06 22:07:06.649 screenresolution[1660:9810] starting screenresolution argv=screenresolution get 22:07:06 INFO - 2016-07-06 22:07:06.652 screenresolution[1660:9810] Display 0: 1600x1200x32@60 22:07:06 INFO - 2016-07-06 22:07:06.658 screenresolution[1661:9813] starting screenresolution argv=screenresolution list 22:07:06 INFO - Available Modes on Display 0 22:07:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:07:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:07:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:07:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:07:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:07:06 INFO - Intel Iris: 22:07:06 INFO - Chipset Model: Intel Iris 22:07:06 INFO - Type: GPU 22:07:06 INFO - Bus: Built-In 22:07:06 INFO - VRAM (Dynamic, Max): 1536 MB 22:07:06 INFO - Vendor: Intel (0x8086) 22:07:06 INFO - Device ID: 0x0a2e 22:07:06 INFO - Revision ID: 0x0009 22:07:06 INFO - Displays: 22:07:06 INFO - Display: 22:07:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:07:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:07:06 INFO - Display Serial Number: 1600x1200 60 22:07:06 INFO - Main Display: Yes 22:07:06 INFO - Mirror: Off 22:07:06 INFO - Online: Yes 22:07:06 INFO - Rotation: Supported 22:07:06 INFO - Return code: 0 22:07:06 INFO - Running post-action listener: _resource_record_post_action 22:07:06 INFO - ##### 22:07:06 INFO - ##### Finished run-tests step (success) 22:07:06 INFO - ##### 22:07:06 INFO - Running post-run listener: _resource_record_post_run 22:07:06 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 38024704; Write bytes: 705391104; Read time: 390; Write time: 1929 22:07:06 INFO - TinderboxPrint: CPU usage
53.6% 22:07:06 INFO - TinderboxPrint: I/O read bytes / time
38,024,704 / 390 22:07:06 INFO - TinderboxPrint: I/O write bytes / time
705,391,104 / 1,929 22:07:06 INFO - TinderboxPrint: CPU idle
2,251.7 (46.4%) 22:07:06 INFO - TinderboxPrint: CPU system
968.6 (20.0%) 22:07:06 INFO - TinderboxPrint: CPU user
1,629.4 (33.6%) 22:07:06 INFO - TinderboxPrint: Swap in / out
444,645,376 / 0 22:07:06 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 412099072; Write bytes: 401655808; Read time: 30935; Write time: 716 22:07:06 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 29171200; Write bytes: 294126080; Read time: 278; Write time: 1181 22:07:07 INFO - Running post-run listener: _upload_blobber_files 22:07:07 INFO - Blob upload gear active. 22:07:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:07:07 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 22:07:07 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'] 22:07:07 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 22:07:07 INFO - (blobuploader) - INFO - Open directory for files ... 22:07:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:07:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:07:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:07:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:07:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:07:08 INFO - (blobuploader) - INFO - Done attempting. 22:07:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:07:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:07:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:07:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:07:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:07:09 INFO - (blobuploader) - INFO - Done attempting. 22:07:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:07:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:07:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:07:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:07:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:07:12 INFO - (blobuploader) - INFO - Done attempting. 22:07:12 INFO - (blobuploader) - INFO - Iteration through files over. 22:07:12 INFO - Return code: 0 22:07:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:07:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:07:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14949df754b7ed6924cc53bb3ca0963a9f7b6c9ad6363f93c6a889844eb565cadd4098ae0f18e7840840ba6f618004a7422748a6bfca35feba1f952a5159c5a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e26341db9cf08a23a0b67c754e15eb182a15da81bd5739991c1aa770212b79c76a563741f73f87b32792f4aeb8d6e2c6a8e491cfbf1a1ad1673d22f694c34c82", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d74c61f1fa3e77bf42880a892789c896a877633d46ff561cc579ff439bc615c10ab28a4293c98566a6f8c3e01cee0eb0153464f00edf5944023d78e85468715c"} 22:07:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:07:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:07:12 INFO - Contents: 22:07:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14949df754b7ed6924cc53bb3ca0963a9f7b6c9ad6363f93c6a889844eb565cadd4098ae0f18e7840840ba6f618004a7422748a6bfca35feba1f952a5159c5a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e26341db9cf08a23a0b67c754e15eb182a15da81bd5739991c1aa770212b79c76a563741f73f87b32792f4aeb8d6e2c6a8e491cfbf1a1ad1673d22f694c34c82", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d74c61f1fa3e77bf42880a892789c896a877633d46ff561cc579ff439bc615c10ab28a4293c98566a6f8c3e01cee0eb0153464f00edf5944023d78e85468715c"} 22:07:12 INFO - Running post-run listener: copy_logs_to_upload_dir 22:07:12 INFO - Copying logs to upload dir... 22:07:12 INFO - mkdir: /builds/slave/test/build/upload/logs 22:07:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.482992 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-07-06 22:07:12.794954) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 22:07:12.798146) ========= 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.JEDmEnxpGQ/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.euPzo002s7/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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/14949df754b7ed6924cc53bb3ca0963a9f7b6c9ad6363f93c6a889844eb565cadd4098ae0f18e7840840ba6f618004a7422748a6bfca35feba1f952a5159c5a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e26341db9cf08a23a0b67c754e15eb182a15da81bd5739991c1aa770212b79c76a563741f73f87b32792f4aeb8d6e2c6a8e491cfbf1a1ad1673d22f694c34c82", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d74c61f1fa3e77bf42880a892789c896a877633d46ff561cc579ff439bc615c10ab28a4293c98566a6f8c3e01cee0eb0153464f00edf5944023d78e85468715c"} build_url:https://queue.taskcluster.net/v1/task/RlfCi6KMRZG1EKtcF73ryA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011124 build_url: 'https://queue.taskcluster.net/v1/task/RlfCi6KMRZG1EKtcF73ryA/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/14949df754b7ed6924cc53bb3ca0963a9f7b6c9ad6363f93c6a889844eb565cadd4098ae0f18e7840840ba6f618004a7422748a6bfca35feba1f952a5159c5a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e26341db9cf08a23a0b67c754e15eb182a15da81bd5739991c1aa770212b79c76a563741f73f87b32792f4aeb8d6e2c6a8e491cfbf1a1ad1673d22f694c34c82", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d74c61f1fa3e77bf42880a892789c896a877633d46ff561cc579ff439bc615c10ab28a4293c98566a6f8c3e01cee0eb0153464f00edf5944023d78e85468715c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 22:07:12.831261) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 22:07:12.831623) ========= 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.JEDmEnxpGQ/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.euPzo002s7/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.005012 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 22:07:12.880927) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 22:07:12.881266) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 22:07:12.881645) ========= ========= Total master_lag: 0.20 =========