builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0198 starttime: 1473259687.17 results: success (0) buildid: 20160907060716 builduid: 67bf85123fe14c16a2150b395afe11a8 revision: 68d9ee3993176dfbf39afd7a757b09dd2677d997 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-07 07:48:07.165728) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-07 07:48:07.166373) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-07 07:48:07.166695) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-07 07:48:07.549537) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 07:48:07.549861) ========= 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.TpiQ3JIMCh/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.ulLWCjBUcl/Listeners TMPDIR=/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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-09-07 07:48:07-- 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% 15.1M=0.001s 2016-09-07 07:48:07 (15.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.231087 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 07:48:07.808018) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 07:48:07.808348) ========= 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.TpiQ3JIMCh/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.ulLWCjBUcl/Listeners TMPDIR=/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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.028478 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 07:48:07.863866) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-07 07:48:07.864289) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 68d9ee3993176dfbf39afd7a757b09dd2677d997 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 68d9ee3993176dfbf39afd7a757b09dd2677d997 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TpiQ3JIMCh/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.ulLWCjBUcl/Listeners TMPDIR=/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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-09-07 07:48:07,939 truncating revision to first 12 chars 2016-09-07 07:48:07,940 Setting DEBUG logging. 2016-09-07 07:48:07,940 attempt 1/10 2016-09-07 07:48:07,940 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/68d9ee399317?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-07 07:48:09,530 unpacking tar archive at: autoland-68d9ee399317/testing/mozharness/ program finished with exit code 0 elapsedTime=1.863035 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-07 07:48:09.753679) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-07 07:48:09.754436) ========= script_repo_revision: 68d9ee3993176dfbf39afd7a757b09dd2677d997 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-07 07:48:09.755344) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-07 07:48:09.755983) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-07 07:48:09.777281) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-07 07:48:09.777928) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TpiQ3JIMCh/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.ulLWCjBUcl/Listeners TMPDIR=/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 07:48:09 INFO - MultiFileLogger online at 20160907 07:48:09 in /builds/slave/test 07:48:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 07:48:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:48:09 INFO - {'append_to_log': False, 07:48:09 INFO - 'base_work_dir': '/builds/slave/test', 07:48:09 INFO - 'blob_upload_branch': 'Autoland', 07:48:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:48:09 INFO - 'branch': 'Autoland', 07:48:09 INFO - 'buildbot_json_path': 'buildprops.json', 07:48:09 INFO - 'config_files': ('talos/mac_config.py',), 07:48:09 INFO - 'default_actions': ('clobber', 07:48:09 INFO - 'read-buildbot-config', 07:48:09 INFO - 'download-and-extract', 07:48:09 INFO - 'populate-webroot', 07:48:09 INFO - 'create-virtualenv', 07:48:09 INFO - 'install', 07:48:09 INFO - 'run-tests'), 07:48:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:48:09 INFO - 'download_minidump_stackwalk': True, 07:48:09 INFO - 'download_symbols': 'ondemand', 07:48:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:48:09 INFO - 'tooltool.py': '/tools/tooltool.py', 07:48:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:48:09 INFO - '/tools/misc-python/virtualenv.py')}, 07:48:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:48:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:48:09 INFO - 'installer_path': 'installer.exe', 07:48:09 INFO - 'log_level': 'info', 07:48:09 INFO - 'log_name': 'talos', 07:48:09 INFO - 'log_to_console': True, 07:48:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:48:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:48:09 INFO - 'opt_config_files': (), 07:48:09 INFO - 'pip_index': False, 07:48:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:48:09 INFO - 'cmd': ('bash', 07:48:09 INFO - '-c', 07:48:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:48:09 INFO - 'enabled': True, 07:48:09 INFO - 'halt_on_failure': False, 07:48:09 INFO - 'name': 'check_screen_resolution'},), 07:48:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:48:09 INFO - 'cmd': ('bash', 07:48:09 INFO - '-c', 07:48:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:48:09 INFO - 'enabled': True, 07:48:09 INFO - 'halt_on_failure': False, 07:48:09 INFO - 'name': 'check_screen_resolution'},), 07:48:09 INFO - 'run_cmd_checks_enabled': True, 07:48:09 INFO - 'sps_profile': False, 07:48:09 INFO - 'sps_profile_interval': 0, 07:48:09 INFO - 'suite': 'dromaeojs', 07:48:09 INFO - 'system_bits': '32', 07:48:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:48:09 INFO - 'title': 't-yosemite-r7-0198', 07:48:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:48:09 INFO - 'use_talos_json': True, 07:48:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:48:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:48:09 INFO - 'work_dir': 'build'} 07:48:09 INFO - [mozharness: 2016-09-07 14:48:09.974251Z] Running clobber step. 07:48:09 INFO - Running pre-action listener: _resource_record_pre_action 07:48:09 INFO - Running main action method: clobber 07:48:09 INFO - rmtree: /builds/slave/test/build 07:48:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:48:12 INFO - Running post-action listener: _resource_record_post_action 07:48:12 INFO - [mozharness: 2016-09-07 14:48:12.134312Z] Finished clobber step (success) 07:48:12 INFO - [mozharness: 2016-09-07 14:48:12.134445Z] Running read-buildbot-config step. 07:48:12 INFO - Running pre-action listener: _resource_record_pre_action 07:48:12 INFO - Running main action method: read_buildbot_config 07:48:12 INFO - Using buildbot properties: 07:48:12 INFO - { 07:48:12 INFO - "project": "", 07:48:12 INFO - "product": "firefox", 07:48:12 INFO - "script_repo_revision": "production", 07:48:12 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 07:48:12 INFO - "repository": "", 07:48:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 07:48:12 INFO - "buildid": "20160907060716", 07:48:12 INFO - "pgo_build": "False", 07:48:12 INFO - "basedir": "/builds/slave/test", 07:48:12 INFO - "buildnumber": 164, 07:48:12 INFO - "slavename": "t-yosemite-r7-0198", 07:48:12 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 07:48:12 INFO - "platform": "yosemite_r7", 07:48:12 INFO - "scheduler": "tests-autoland-macosx64-talos", 07:48:12 INFO - "branch": "autoland", 07:48:12 INFO - "repo_path": "integration/autoland", 07:48:12 INFO - "revision": "68d9ee3993176dfbf39afd7a757b09dd2677d997", 07:48:12 INFO - "stage_platform": "macosx64", 07:48:12 INFO - "builduid": "67bf85123fe14c16a2150b395afe11a8", 07:48:12 INFO - "slavebuilddir": "test" 07:48:12 INFO - } 07:48:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/CnKSNF00T8KO8V_ml5ia1Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 07:48:12 INFO - Running post-action listener: _resource_record_post_action 07:48:12 INFO - [mozharness: 2016-09-07 14:48:12.137810Z] Finished read-buildbot-config step (success) 07:48:12 INFO - [mozharness: 2016-09-07 14:48:12.137908Z] Running download-and-extract step. 07:48:12 INFO - Running pre-action listener: _resource_record_pre_action 07:48:12 INFO - Running main action method: download_and_extract 07:48:12 INFO - mkdir: /builds/slave/test/build/tests 07:48:12 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:12 INFO - trying https://queue.taskcluster.net/v1/task/CnKSNF00T8KO8V_ml5ia1Q/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 07:48:12 INFO - Downloading https://queue.taskcluster.net/v1/task/CnKSNF00T8KO8V_ml5ia1Q/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 07:48:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CnKSNF00T8KO8V_ml5ia1Q/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 07:48:13 INFO - Downloaded 1199 bytes. 07:48:13 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 07:48:13 INFO - Using the following test package requirements: 07:48:13 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 07:48:13 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:48:13 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 07:48:13 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:48:13 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 07:48:13 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:48:13 INFO - u'jsshell-mac.zip'], 07:48:13 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:48:13 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 07:48:13 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 07:48:13 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:48:13 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 07:48:13 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:48:13 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 07:48:13 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:48:13 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 07:48:13 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:48:13 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 07:48:13 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:48:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CnKSNF00T8KO8V_ml5ia1Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 07:48:13 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 07:48:20 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:48:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CnKSNF00T8KO8V_ml5ia1Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 07:48:21 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 07:48:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CnKSNF00T8KO8V_ml5ia1Q/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 07:48:29 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 07:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:30 INFO - trying https://queue.taskcluster.net/v1/task/CnKSNF00T8KO8V_ml5ia1Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:48:30 INFO - Downloading https://queue.taskcluster.net/v1/task/CnKSNF00T8KO8V_ml5ia1Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 07:48:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CnKSNF00T8KO8V_ml5ia1Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 07:48:33 INFO - Downloaded 111514225 bytes. 07:48:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CnKSNF00T8KO8V_ml5ia1Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:48:33 INFO - mkdir: /builds/slave/test/properties 07:48:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:48:33 INFO - Writing to file /builds/slave/test/properties/build_url 07:48:33 INFO - Contents: 07:48:33 INFO - build_url:https://queue.taskcluster.net/v1/task/CnKSNF00T8KO8V_ml5ia1Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:48:33 INFO - Running post-action listener: _resource_record_post_action 07:48:33 INFO - Running post-action listener: set_extra_try_arguments 07:48:33 INFO - [mozharness: 2016-09-07 14:48:33.792050Z] Finished download-and-extract step (success) 07:48:33 INFO - [mozharness: 2016-09-07 14:48:33.792167Z] Running populate-webroot step. 07:48:33 INFO - Running pre-action listener: _resource_record_pre_action 07:48:33 INFO - Running main action method: populate_webroot 07:48:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:48:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:48:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:48:33 INFO - '--tppagecycles', 07:48:33 INFO - '7'], 07:48:33 INFO - 'tests': ['tsvgm']}}, 07:48:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:48:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:48:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:48:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:48:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:48:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:48:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:33 INFO - 'talos_options': ['--disable-e10s'], 07:48:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:48:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:48:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:33 INFO - 'talos_options': ['--disable-e10s'], 07:48:33 INFO - 'tests': ['damp', 'tps']}, 07:48:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:33 INFO - 'tests': ['damp', 'tps']}, 07:48:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:48:33 INFO - 'tests': ['dromaeo_dom']}, 07:48:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:48:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:48:33 INFO - 'tests': ['basic_compositor_video']}, 07:48:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:48:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:48:33 INFO - 'tests': ['a11yr', 07:48:33 INFO - 'ts_paint', 07:48:33 INFO - 'tpaint', 07:48:33 INFO - 'sessionrestore', 07:48:33 INFO - 'sessionrestore_no_auto_restore', 07:48:33 INFO - 'tabpaint']}, 07:48:33 INFO - 'other-e10s': {'tests': ['a11yr', 07:48:33 INFO - 'ts_paint', 07:48:33 INFO - 'tpaint', 07:48:33 INFO - 'sessionrestore', 07:48:33 INFO - 'sessionrestore_no_auto_restore', 07:48:33 INFO - 'tabpaint']}, 07:48:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:48:33 INFO - 'ts_paint', 07:48:33 INFO - 'tpaint', 07:48:33 INFO - 'sessionrestore', 07:48:33 INFO - 'sessionrestore_no_auto_restore', 07:48:33 INFO - 'tabpaint']}, 07:48:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:48:33 INFO - 'ts_paint', 07:48:33 INFO - 'tpaint', 07:48:33 INFO - 'sessionrestore', 07:48:33 INFO - 'sessionrestore_no_auto_restore', 07:48:33 INFO - 'tabpaint']}, 07:48:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:48:33 INFO - 'tests': ['a11yr', 07:48:33 INFO - 'ts_paint', 07:48:33 INFO - 'tpaint', 07:48:33 INFO - 'sessionrestore', 07:48:33 INFO - 'sessionrestore_no_auto_restore', 07:48:33 INFO - 'tabpaint']}, 07:48:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:48:33 INFO - 'tests': ['a11yr', 07:48:33 INFO - 'ts_paint', 07:48:33 INFO - 'tpaint', 07:48:33 INFO - 'sessionrestore', 07:48:33 INFO - 'sessionrestore_no_auto_restore', 07:48:33 INFO - 'tabpaint']}, 07:48:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:48:33 INFO - 'tests': ['tsvgx', 07:48:33 INFO - 'tsvgr_opacity', 07:48:33 INFO - 'tart', 07:48:33 INFO - 'tscrollx', 07:48:33 INFO - 'cart']}, 07:48:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:48:33 INFO - 'tsvgr_opacity', 07:48:33 INFO - 'tart', 07:48:33 INFO - 'tscrollx', 07:48:33 INFO - 'cart']}, 07:48:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:33 INFO - 'talos_options': ['--disable-e10s'], 07:48:33 INFO - 'tests': ['tp5o']}, 07:48:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:33 INFO - 'tests': ['tp5o']}, 07:48:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:33 INFO - 'talos_options': ['--disable-e10s', 07:48:33 INFO - '--xperf_path', 07:48:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:48:33 INFO - 'tests': ['tp5n']}, 07:48:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:33 INFO - 'talos_options': ['--xperf_path', 07:48:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:48:33 INFO - 'tests': ['tp5n']}}, 07:48:33 INFO - 'talos.zip': {'path': '', 07:48:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:48:33 INFO - Running post-action listener: _resource_record_post_action 07:48:33 INFO - [mozharness: 2016-09-07 14:48:33.811160Z] Finished populate-webroot step (success) 07:48:33 INFO - [mozharness: 2016-09-07 14:48:33.811300Z] Running create-virtualenv step. 07:48:33 INFO - Running pre-action listener: _resource_record_pre_action 07:48:33 INFO - Running main action method: create_virtualenv 07:48:33 INFO - Creating virtualenv /builds/slave/test/build/venv 07:48:33 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 07:48:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:48:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:48:33 INFO - Using real prefix '/tools/python27' 07:48:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:48:34 INFO - Installing distribute.............................................................................................................................................................................................done. 07:48:37 INFO - Installing pip.................done. 07:48:37 INFO - Return code: 0 07:48:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:48:37 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:37 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:37 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 0x10a308a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a39d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e049aaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a26cd30>, '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 0x109fd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a264b20>, '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.TpiQ3JIMCh/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.ulLWCjBUcl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 07:48:37 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 07:48:37 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 07:48:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TpiQ3JIMCh/Render', 07:48:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:37 INFO - 'HOME': '/Users/cltbld', 07:48:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:37 INFO - 'LOGNAME': 'cltbld', 07:48:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:37 INFO - 'MOZ_NO_REMOTE': '1', 07:48:37 INFO - 'NO_EM_RESTART': '1', 07:48:37 INFO - 'PAGER': '/bin/cat', 07:48:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:37 INFO - 'PWD': '/builds/slave/test', 07:48:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:37 INFO - 'SHELL': '/bin/bash', 07:48:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ulLWCjBUcl/Listeners', 07:48:37 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 07:48:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:37 INFO - 'USER': 'cltbld', 07:48:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:37 INFO - 'XPC_FLAGS': '0x0', 07:48:37 INFO - 'XPC_SERVICE_NAME': '0', 07:48:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:37 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 07:48:37 INFO - Cleaning up... 07:48:37 INFO - Return code: 0 07:48:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:48:37 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:37 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:37 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 0x10a308a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a39d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e049aaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a26cd30>, '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 0x109fd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a264b20>, '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.TpiQ3JIMCh/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.ulLWCjBUcl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 07:48:37 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 07:48:37 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 07:48:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TpiQ3JIMCh/Render', 07:48:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:37 INFO - 'HOME': '/Users/cltbld', 07:48:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:37 INFO - 'LOGNAME': 'cltbld', 07:48:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:37 INFO - 'MOZ_NO_REMOTE': '1', 07:48:37 INFO - 'NO_EM_RESTART': '1', 07:48:37 INFO - 'PAGER': '/bin/cat', 07:48:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:37 INFO - 'PWD': '/builds/slave/test', 07:48:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:37 INFO - 'SHELL': '/bin/bash', 07:48:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ulLWCjBUcl/Listeners', 07:48:37 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 07:48:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:37 INFO - 'USER': 'cltbld', 07:48:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:37 INFO - 'XPC_FLAGS': '0x0', 07:48:37 INFO - 'XPC_SERVICE_NAME': '0', 07:48:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:38 INFO - Downloading/unpacking psutil>=3.1.1 07:48: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 07:48: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 07:48: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 07:48: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 07:48: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 07:48: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 07:48:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:48:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:48:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:48:41 INFO - Installing collected packages: psutil 07:48:41 INFO - Running setup.py install for psutil 07:48:41 INFO - building 'psutil._psutil_osx' extension 07:48:41 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 07:48:42 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 07:48:42 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 07:48:42 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 07:48:42 INFO - building 'psutil._psutil_posix' extension 07:48:42 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 07:48:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:48:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:48:42 INFO - ^ 07:48:42 INFO - 1 warning generated. 07:48:42 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 07:48:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:48:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:48:42 INFO - Successfully installed psutil 07:48:42 INFO - Cleaning up... 07:48:42 INFO - Return code: 0 07:48:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:42 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 0x10a308a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a39d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e049aaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a26cd30>, '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 0x109fd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a264b20>, '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.TpiQ3JIMCh/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.ulLWCjBUcl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 07:48:42 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 07:48:42 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 07:48:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TpiQ3JIMCh/Render', 07:48:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:42 INFO - 'HOME': '/Users/cltbld', 07:48:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:42 INFO - 'LOGNAME': 'cltbld', 07:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:42 INFO - 'MOZ_NO_REMOTE': '1', 07:48:42 INFO - 'NO_EM_RESTART': '1', 07:48:42 INFO - 'PAGER': '/bin/cat', 07:48:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:42 INFO - 'PWD': '/builds/slave/test', 07:48:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:42 INFO - 'SHELL': '/bin/bash', 07:48:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ulLWCjBUcl/Listeners', 07:48:42 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 07:48:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:42 INFO - 'USER': 'cltbld', 07:48:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:42 INFO - 'XPC_FLAGS': '0x0', 07:48:42 INFO - 'XPC_SERVICE_NAME': '0', 07:48:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:48:42 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 07:48:42 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 07:48:42 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 07:48:42 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 07:48:42 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 07:48:42 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 07:48:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:48:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:48:45 INFO - Installing collected packages: mozsystemmonitor 07:48:45 INFO - Running setup.py install for mozsystemmonitor 07:48:45 INFO - Successfully installed mozsystemmonitor 07:48:45 INFO - Cleaning up... 07:48:45 INFO - Return code: 0 07:48:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:45 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 0x10a308a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a39d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e049aaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a26cd30>, '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 0x109fd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a264b20>, '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.TpiQ3JIMCh/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.ulLWCjBUcl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 07:48:45 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 07:48:45 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 07:48:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TpiQ3JIMCh/Render', 07:48:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:45 INFO - 'HOME': '/Users/cltbld', 07:48:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:45 INFO - 'LOGNAME': 'cltbld', 07:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:45 INFO - 'MOZ_NO_REMOTE': '1', 07:48:45 INFO - 'NO_EM_RESTART': '1', 07:48:45 INFO - 'PAGER': '/bin/cat', 07:48:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:45 INFO - 'PWD': '/builds/slave/test', 07:48:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:45 INFO - 'SHELL': '/bin/bash', 07:48:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ulLWCjBUcl/Listeners', 07:48:45 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 07:48:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:45 INFO - 'USER': 'cltbld', 07:48:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:45 INFO - 'XPC_FLAGS': '0x0', 07:48:45 INFO - 'XPC_SERVICE_NAME': '0', 07:48:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:45 INFO - Downloading/unpacking jsonschema==2.5.1 07:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:48:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:48:48 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 07:48:48 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 07:48:48 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 07:48:48 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 07:48:48 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 07:48:48 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 07:48:48 INFO - Downloading functools32-3.2.3-2.tar.gz 07:48:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:48:48 INFO - warning: no files found matching '*.txt' 07:48:48 INFO - no previously-included directories found matching 'build' 07:48:48 INFO - no previously-included directories found matching 'dist' 07:48:48 INFO - no previously-included directories found matching '.git*' 07:48:48 INFO - Installing collected packages: jsonschema, functools32 07:48:48 INFO - Running setup.py install for functools32 07:48:48 INFO - warning: no files found matching '*.txt' 07:48:48 INFO - no previously-included directories found matching 'build' 07:48:48 INFO - no previously-included directories found matching 'dist' 07:48:48 INFO - no previously-included directories found matching '.git*' 07:48:49 INFO - Successfully installed jsonschema functools32 07:48:49 INFO - Cleaning up... 07:48:49 INFO - Return code: 0 07:48:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a308a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a39d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e049aaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a26cd30>, '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 0x109fd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a264b20>, '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.TpiQ3JIMCh/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.ulLWCjBUcl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 07:48:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:48:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TpiQ3JIMCh/Render', 07:48:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:49 INFO - 'HOME': '/Users/cltbld', 07:48:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:49 INFO - 'LOGNAME': 'cltbld', 07:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:49 INFO - 'MOZ_NO_REMOTE': '1', 07:48:49 INFO - 'NO_EM_RESTART': '1', 07:48:49 INFO - 'PAGER': '/bin/cat', 07:48:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:49 INFO - 'PWD': '/builds/slave/test', 07:48:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:49 INFO - 'SHELL': '/bin/bash', 07:48:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ulLWCjBUcl/Listeners', 07:48:49 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 07:48:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:49 INFO - 'USER': 'cltbld', 07:48:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:49 INFO - 'XPC_FLAGS': '0x0', 07:48:49 INFO - 'XPC_SERVICE_NAME': '0', 07:48:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:48:49 INFO - Cleaning up... 07:48:49 INFO - Return code: 0 07:48:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a308a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a39d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e049aaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a26cd30>, '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 0x109fd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a264b20>, '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.TpiQ3JIMCh/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.ulLWCjBUcl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 07:48:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:48:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TpiQ3JIMCh/Render', 07:48:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:49 INFO - 'HOME': '/Users/cltbld', 07:48:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:49 INFO - 'LOGNAME': 'cltbld', 07:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:49 INFO - 'MOZ_NO_REMOTE': '1', 07:48:49 INFO - 'NO_EM_RESTART': '1', 07:48:49 INFO - 'PAGER': '/bin/cat', 07:48:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:49 INFO - 'PWD': '/builds/slave/test', 07:48:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:49 INFO - 'SHELL': '/bin/bash', 07:48:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ulLWCjBUcl/Listeners', 07:48:49 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 07:48:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:49 INFO - 'USER': 'cltbld', 07:48:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:49 INFO - 'XPC_FLAGS': '0x0', 07:48:49 INFO - 'XPC_SERVICE_NAME': '0', 07:48:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:49 INFO - Downloading/unpacking blobuploader==1.2.4 07:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:52 INFO - Downloading blobuploader-1.2.4.tar.gz 07:48:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:48:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:48:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:53 INFO - Downloading docopt-0.6.1.tar.gz 07:48:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:48:53 INFO - Installing collected packages: blobuploader, requests, docopt 07:48:53 INFO - Running setup.py install for blobuploader 07:48:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:48:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:48:53 INFO - Running setup.py install for requests 07:48:54 INFO - Running setup.py install for docopt 07:48:54 INFO - Successfully installed blobuploader requests docopt 07:48:54 INFO - Cleaning up... 07:48:54 INFO - Return code: 0 07:48:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:48: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:54 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 0x10a308a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a39d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e049aaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a26cd30>, '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 0x109fd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a264b20>, '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.TpiQ3JIMCh/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.ulLWCjBUcl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 07:48:54 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 07:48:54 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 07:48:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TpiQ3JIMCh/Render', 07:48:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:54 INFO - 'HOME': '/Users/cltbld', 07:48:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:54 INFO - 'LOGNAME': 'cltbld', 07:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:54 INFO - 'MOZ_NO_REMOTE': '1', 07:48:54 INFO - 'NO_EM_RESTART': '1', 07:48:54 INFO - 'PAGER': '/bin/cat', 07:48:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:54 INFO - 'PWD': '/builds/slave/test', 07:48:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:54 INFO - 'SHELL': '/bin/bash', 07:48:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ulLWCjBUcl/Listeners', 07:48:54 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 07:48:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:54 INFO - 'USER': 'cltbld', 07:48:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:54 INFO - 'XPC_FLAGS': '0x0', 07:48:54 INFO - 'XPC_SERVICE_NAME': '0', 07:48:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:48:54 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-9PkV7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:48:54 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-ggaXpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:48:54 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-VShZ_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:48:54 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-snZLTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:48:54 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-9OPLCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:48:55 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-hzhvDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:48:55 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-6ASXEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:48:55 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-cb7A4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:48:55 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-yh5Y1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:48:55 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-gkD9h7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:48:55 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-_WbtOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:48:55 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-YD0zq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:48:55 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-ihgkj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:48:55 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-ARJTjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:55 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-5nMT0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:48:56 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-aBYgRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:48:56 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-ggy0uQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:48:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:48:56 INFO - Running setup.py install for manifestparser 07:48:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:48:56 INFO - Running setup.py install for mozcrash 07:48:56 INFO - Running setup.py install for mozdebug 07:48:56 INFO - Running setup.py install for mozdevice 07:48:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:48:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:48:56 INFO - Running setup.py install for mozfile 07:48:57 INFO - Running setup.py install for mozhttpd 07:48:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:48:57 INFO - Running setup.py install for mozinfo 07:48:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:48:57 INFO - Running setup.py install for mozInstall 07:48:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:48:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:48:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:48:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:48:57 INFO - Running setup.py install for mozleak 07:48:57 INFO - Running setup.py install for mozlog 07:48:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:48:57 INFO - Running setup.py install for moznetwork 07:48:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:48:57 INFO - Running setup.py install for mozprocess 07:48:58 INFO - Running setup.py install for mozprofile 07:48:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:48:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:48:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:48:58 INFO - Running setup.py install for mozrunner 07:48:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:48:58 INFO - Running setup.py install for mozscreenshot 07:48:58 INFO - Running setup.py install for moztest 07:48:58 INFO - Running setup.py install for mozversion 07:48:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:48:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:48:58 INFO - Cleaning up... 07:48:58 INFO - Return code: 0 07:48:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:48:58 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:58 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:58 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 0x10a308a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a39d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e049aaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a26cd30>, '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 0x109fd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a264b20>, '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.TpiQ3JIMCh/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.ulLWCjBUcl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 07:48:58 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 07:48:58 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 07:48:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TpiQ3JIMCh/Render', 07:48:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:58 INFO - 'HOME': '/Users/cltbld', 07:48:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:58 INFO - 'LOGNAME': 'cltbld', 07:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:58 INFO - 'MOZ_NO_REMOTE': '1', 07:48:58 INFO - 'NO_EM_RESTART': '1', 07:48:58 INFO - 'PAGER': '/bin/cat', 07:48:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:58 INFO - 'PWD': '/builds/slave/test', 07:48:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:58 INFO - 'SHELL': '/bin/bash', 07:48:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ulLWCjBUcl/Listeners', 07:48:58 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 07:48:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:58 INFO - 'USER': 'cltbld', 07:48:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:58 INFO - 'XPC_FLAGS': '0x0', 07:48:58 INFO - 'XPC_SERVICE_NAME': '0', 07:48:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:48:59 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-UEVDhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:48:59 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)) 07:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:48:59 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-K0Uqot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:48:59 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)) 07:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:48:59 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-mLbLYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:48:59 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)) 07:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:48:59 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-znmcnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:48:59 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)) 07:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:48:59 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-h2zhQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:48:59 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)) 07:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:48:59 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-Rdq8Oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:48:59 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)) 07:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:48:59 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-0JUXiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:48:59 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)) 07:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:48:59 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-9JSX0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:48:59 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)) 07:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:48:59 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-CIyNqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:49:00 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)) 07:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:49:00 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-EjcUWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:49:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 07:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:49:00 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-TV0A3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:49:00 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)) 07:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:49:00 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-9iq3gC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:49:00 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)) 07:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:49:00 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-pT2BoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:49:00 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)) 07:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:49:00 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-IdmTP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:49:00 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)) 07:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:49:00 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-XcLzLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:49:00 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)) 07:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:49:00 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-SVcWjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:49:00 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)) 07:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:49:00 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-VnkUGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:49:00 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)) 07:49:00 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)) 07:49:00 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)) 07:49:00 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)) 07:49:00 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)) 07:49:00 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)) 07:49:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:49:00 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 07:49:00 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 07:49:00 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 07:49:00 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 07:49:00 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 07:49:00 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 07:49:03 INFO - Downloading blessings-1.6.tar.gz 07:49:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:49:03 INFO - Installing collected packages: blessings 07:49:03 INFO - Running setup.py install for blessings 07:49:03 INFO - Successfully installed blessings 07:49:03 INFO - Cleaning up... 07:49:03 INFO - Return code: 0 07:49:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:49:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:49:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:49:04 INFO - Reading from file tmpfile_stdout 07:49:04 INFO - Current package versions: 07:49:04 INFO - blessings == 1.6 07:49:04 INFO - blobuploader == 1.2.4 07:49:04 INFO - docopt == 0.6.1 07:49:04 INFO - functools32 == 3.2.3-2 07:49:04 INFO - jsonschema == 2.5.1 07:49:04 INFO - manifestparser == 1.1 07:49:04 INFO - mozInstall == 1.12 07:49:04 INFO - mozcrash == 0.17 07:49:04 INFO - mozdebug == 0.1 07:49:04 INFO - mozdevice == 0.48 07:49:04 INFO - mozfile == 1.2 07:49:04 INFO - mozhttpd == 0.7 07:49:04 INFO - mozinfo == 0.9 07:49:04 INFO - mozleak == 0.1 07:49:04 INFO - mozlog == 3.3 07:49:04 INFO - moznetwork == 0.27 07:49:04 INFO - mozprocess == 0.23 07:49:04 INFO - mozprofile == 0.28 07:49:04 INFO - mozrunner == 6.12 07:49:04 INFO - mozscreenshot == 0.1 07:49:04 INFO - mozsystemmonitor == 0.3 07:49:04 INFO - moztest == 0.7 07:49:04 INFO - mozversion == 1.4 07:49:04 INFO - psutil == 3.1.1 07:49:04 INFO - requests == 1.2.3 07:49:04 INFO - wsgiref == 0.1.2 07:49:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:49:04 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:04 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:04 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 0x10a308a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a39d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e049aaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a26cd30>, '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 0x109fd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a264b20>, '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.TpiQ3JIMCh/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.ulLWCjBUcl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 07:49:04 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 07:49:04 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 07:49:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TpiQ3JIMCh/Render', 07:49:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:49:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:49:04 INFO - 'HOME': '/Users/cltbld', 07:49:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:49:04 INFO - 'LOGNAME': 'cltbld', 07:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:04 INFO - 'MOZ_NO_REMOTE': '1', 07:49:04 INFO - 'NO_EM_RESTART': '1', 07:49:04 INFO - 'PAGER': '/bin/cat', 07:49:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:04 INFO - 'PWD': '/builds/slave/test', 07:49:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:49:04 INFO - 'SHELL': '/bin/bash', 07:49:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ulLWCjBUcl/Listeners', 07:49:04 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 07:49:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:49:04 INFO - 'USER': 'cltbld', 07:49:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:49:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:04 INFO - 'XPC_FLAGS': '0x0', 07:49:04 INFO - 'XPC_SERVICE_NAME': '0', 07:49:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:49:04 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)) 07:49:04 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)) 07:49:04 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)) 07:49:04 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)) 07:49:04 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)) 07:49:04 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)) 07:49:04 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)) 07:49:04 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)) 07:49:04 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)) 07:49:04 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)) 07:49:04 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)) 07:49:04 INFO - Cleaning up... 07:49:04 INFO - Return code: 0 07:49:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:49:04 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:04 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:04 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 0x10a308a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a39d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e049aaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a26cd30>, '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 0x109fd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a264b20>, '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.TpiQ3JIMCh/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.ulLWCjBUcl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 07:49:04 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 07:49:04 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 07:49:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TpiQ3JIMCh/Render', 07:49:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:49:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:49:04 INFO - 'HOME': '/Users/cltbld', 07:49:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:49:04 INFO - 'LOGNAME': 'cltbld', 07:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:04 INFO - 'MOZ_NO_REMOTE': '1', 07:49:04 INFO - 'NO_EM_RESTART': '1', 07:49:04 INFO - 'PAGER': '/bin/cat', 07:49:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:04 INFO - 'PWD': '/builds/slave/test', 07:49:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:49:04 INFO - 'SHELL': '/bin/bash', 07:49:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ulLWCjBUcl/Listeners', 07:49:04 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 07:49:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:49:04 INFO - 'USER': 'cltbld', 07:49:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:49:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:04 INFO - 'XPC_FLAGS': '0x0', 07:49:04 INFO - 'XPC_SERVICE_NAME': '0', 07:49:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:49:04 INFO - Cleaning up... 07:49:04 INFO - Return code: 0 07:49:04 INFO - Running post-action listener: _resource_record_post_action 07:49:04 INFO - Running post-action listener: _start_resource_monitoring 07:49:04 INFO - Starting resource monitoring. 07:49:04 INFO - [mozharness: 2016-09-07 14:49:04.608296Z] Finished create-virtualenv step (success) 07:49:04 INFO - [mozharness: 2016-09-07 14:49:04.609302Z] Running install step. 07:49:04 INFO - Running pre-action listener: _resource_record_pre_action 07:49:04 INFO - Running main action method: install 07:49:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:49:04 INFO - Reading from file tmpfile_stdout 07:49:04 INFO - Detecting whether we're running mozinstall >=1.0... 07:49:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:49:04 INFO - Reading from file tmpfile_stdout 07:49:04 INFO - Output received: 07:49:04 INFO - Usage: mozinstall [options] installer 07:49:04 INFO - Options: 07:49:04 INFO - -h, --help show this help message and exit 07:49:04 INFO - -d DEST, --destination=DEST 07:49:04 INFO - Directory to install application into. [default: 07:49:04 INFO - "/builds/slave/test"] 07:49:04 INFO - --app=APP Application being installed. [default: firefox] 07:49:04 INFO - mkdir: /builds/slave/test/build/application 07:49:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:49:38 INFO - Reading from file tmpfile_stdout 07:49:38 INFO - Output received: 07:49:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:49:38 INFO - Running post-action listener: _resource_record_post_action 07:49:38 INFO - [mozharness: 2016-09-07 14:49:38.981887Z] Finished install step (success) 07:49:38 INFO - [mozharness: 2016-09-07 14:49:38.982017Z] Running run-tests step. 07:49:38 INFO - Running pre-action listener: _resource_record_pre_action 07:49:38 INFO - Running main action method: run_tests 07:49:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:49:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:49:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:49:38 INFO - 2016-09-07 07:49:38.997 screenresolution[1649:8719] starting screenresolution argv=screenresolution get 07:49:38 INFO - 2016-09-07 07:49:38.999 screenresolution[1649:8719] Display 0: 1600x1200x32@60 07:49:39 INFO - 2016-09-07 07:49:39.005 screenresolution[1650:8722] starting screenresolution argv=screenresolution list 07:49:39 INFO - Available Modes on Display 0 07:49:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:49:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:49:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:49:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:49:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:49:39 INFO - Intel Iris: 07:49:39 INFO - Chipset Model: Intel Iris 07:49:39 INFO - Type: GPU 07:49:39 INFO - Bus: Built-In 07:49:39 INFO - VRAM (Dynamic, Max): 1536 MB 07:49:39 INFO - Vendor: Intel (0x8086) 07:49:39 INFO - Device ID: 0x0a2e 07:49:39 INFO - Revision ID: 0x0009 07:49:39 INFO - Displays: 07:49:39 INFO - Display: 07:49:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:49:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:49:39 INFO - Display Serial Number: 1600x1200 60 07:49:39 INFO - Main Display: Yes 07:49:39 INFO - Mirror: Off 07:49:39 INFO - Online: Yes 07:49:39 INFO - Rotation: Supported 07:49:39 INFO - Return code: 0 07:49:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:49:39 INFO - Python 2.7.3 07:49:39 INFO - Return code: 0 07:49:39 INFO - grabbing minidump binary from tooltool 07:49:39 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:49:39 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 0x10a26cd30>, '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 0x109fd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a264b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:49:39 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 07:49:39 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 07:49:39 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 07:49:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:49:39 INFO - Return code: 0 07:49:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:49:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:49:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:49:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:49:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:49:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CnKSNF00T8KO8V_ml5ia1Q/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0198', '--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 07:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CnKSNF00T8KO8V_ml5ia1Q/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0198 --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 07:49:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TpiQ3JIMCh/Render', 07:49:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:49:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:49:39 INFO - 'HOME': '/Users/cltbld', 07:49:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:49:39 INFO - 'LOGNAME': 'cltbld', 07:49:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:49:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:39 INFO - 'MOZ_NO_REMOTE': '1', 07:49:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:49:39 INFO - 'NO_EM_RESTART': '1', 07:49:39 INFO - 'PAGER': '/bin/cat', 07:49:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:39 INFO - 'PWD': '/builds/slave/test', 07:49:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:49:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:49:39 INFO - 'SHELL': '/bin/bash', 07:49:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ulLWCjBUcl/Listeners', 07:49:39 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 07:49:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:49:39 INFO - 'USER': 'cltbld', 07:49:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:49:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:39 INFO - 'XPC_FLAGS': '0x0', 07:49:39 INFO - 'XPC_SERVICE_NAME': '0', 07:49:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:49:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CnKSNF00T8KO8V_ml5ia1Q/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0198', '--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 07:49:39 INFO - mozversion application_buildid: 20160907060716 07:49:39 INFO - mozversion application_changeset: 68d9ee3993176dfbf39afd7a757b09dd2677d997 07:49:39 INFO - mozversion application_display_name: Nightly 07:49:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:49:39 INFO - mozversion application_name: Firefox 07:49:39 INFO - mozversion application_remotingname: firefox 07:49:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 07:49:39 INFO - mozversion application_vendor: Mozilla 07:49:39 INFO - mozversion application_version: 51.0a1 07:49:39 INFO - mozversion platform_buildid: 20160907060716 07:49:39 INFO - mozversion platform_changeset: 68d9ee3993176dfbf39afd7a757b09dd2677d997 07:49:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 07:49:39 INFO - mozversion platform_version: 51.0a1 07:49:39 INFO - using testdate: 1473259779 07:49:39 INFO - actual date: 1473259779 07:49:39 INFO - starting webserver on 'localhost:49274' 07:49:39 INFO - SUITE-START | Running 2 tests 07:49:39 INFO - TEST-START | dromaeo_css 07:49:39 INFO - operating with platform_type : mac_ 07:49:39 INFO - Initialising browser for dromaeo_css test... 07:49:39 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/tmpsYueKo/profile http://localhost:49274/getInfo.html) 07:49:42 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 07:49:42 INFO - PROCESS | 1660 | colorDepth:24 07:49:42 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 07:49:42 INFO - PROCESS | 1660 | __metrics 07:49:42 INFO - PROCESS | 1660 | 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" 07:49:42 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:49:43 INFO - TEST-INFO | 1660: exit 0 07:49:43 INFO - Browser initialized. 07:49:43 INFO - Running cycle 1/1 for dromaeo_css test... 07:49:43 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/tmpsYueKo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:49:55 INFO - PROCESS | 1663 | RSS: Main: 232128512 07:49:55 INFO - PROCESS | 1663 | 07:50:46 INFO - PROCESS | 1663 | 1473259846797 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] 07:52:58 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 07:52:59 INFO - PROCESS | 1663 | RSS: Main: 366931968 07:52:59 INFO - PROCESS | 1663 | 07:56:02 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 07:56:02 INFO - PROCESS | 1663 | RSS: Main: 369131520 07:56:02 INFO - PROCESS | 1663 | 07:59:05 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 07:59:06 INFO - PROCESS | 1663 | RSS: Main: 334589952 07:59:06 INFO - PROCESS | 1663 | 08:02:08 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 08:02:08 INFO - PROCESS | 1663 | RSS: Main: 353054720 08:02:08 INFO - PROCESS | 1663 | 08:05:12 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 08:05:12 INFO - PROCESS | 1663 | RSS: Main: 324116480 08:05:12 INFO - PROCESS | 1663 | 08:08:16 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 08:08:16 INFO - PROCESS | 1663 | RSS: Main: 399491072 08:08:16 INFO - PROCESS | 1663 | 08:08:16 INFO - PROCESS | 1663 | __start_tp_report 08:08:16 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 08:08:16 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 08:08:16 INFO - PROCESS | 1663 | |i|pagename|runs| 08:08:16 INFO - PROCESS | 1663 | |0;dojo.html;3116.797408168469;3318.187044174177;3357.949630755539;3386.3565922474745;3414.6585341465843;4658.697184682997;5296.258523806665;5601.971990140044;5732.398098199692;5746.798862039825;5707.086866101425;5722.998475266822;5757.971210143944;5791.21818554495;5831.446012628793;4218.683598730092;5184.948150518484;5185.481451854803;5236.581073514129;5333.519983201511;5309.73451327434;5323.334583177103;5329;5349.144136938091;5357.116075847481;5177.870553236199;5195.428502864682;5214.322138122057;5260.658057226268;5270.4729527047375;5243.318368612094;5256.658317209407;5260.815871444519;5266.104762190437;5287.154055351164;5172.948270517284;5187.118189907725;5197.766100525448;5200.5059519345605;5276.551493123089;5746.367899531048;5762.308522977228;5771;5781.161731548902;5783.987802134651;6113.572049956505;6139.614800607363;6288.276848162474;6305.810825675191;6318;6199.721012554446;6286.088517165032;6297.464715499143;6319.810405687791;6327.27236367819;5775.278090238762;5776.220210271644;5780.479756821906;5782.537397008229;5785.1611516329895;6165.445109940038;6216.4405203531;6249.843753906189;6294.181756371642;6311.715972781236;6169.259688837278;6194.938050619436;6198.597091189058;6207.472364849038;6210.565260431817;6310.1481300024825;6310.716017779211;6312.936870631327;6329.398707122816;6332.208473940757;5125.743712814345;6100.1270446244;6112.07796728157;6270.996640537492;6294.15028971083;6203.906941395882;6230.906536401958;6257.311695713468;6263.404976527223;6268.623882567061;4974.676646017997;4975.900481990412;4984.177610694267;4984.37695288089;4998.075356059141;4439.511653718088;4441.555844415597;4442.133783912106;4483.21543729846;4488.506264310923;5692.14617807324;5706.229658996065;5716.485516303553;5717.342505611825;5728.198052272685;6225.906611400833;6249.0938813871735;6260.029695397221;6272.247330320391;6292.150559674477;5748.6838223898085;5762.9135562966585;5783.421657834183;5818.389069147764;5835.854103647358;5405.7567409466665;5441.374241962146;5451.073317535949;5451.318585176853;5472.589555783332;6194.194754681863;6207.720652570555;6217.502599791916;6296.905546416808;6317.115603815378;6103.216452666926;6115.94015414234;6120.938790612036;6128.601640893327;6144.678894037804;6163.8991543066395;6287.622742635456;6289.245290565162;6292.1505596743855;6297.338779428094;5814.8866281533565;5819.6508209507565;5964.135200396005;6041.093835924647;6084.269887613515;6318.557700960889;6342.52431067681;6344.651044192614;6354.1104245406605;6372.681365931778;6009.909851352146;6011.549133814894;6020.638761674313;6022.45797878193;6034.909476357946;5821.883562328814;5947.197128387786;5947.6431414115295;6015.097735339734;6049.618225558098;5677.432256774289;5782.624129431573;5820.621659592113;5831.008728516078;5889.852753681193;5941.643501389931;5968.791092311748;5986.132010858314;5994.31065427464;6002.669853158118;4730.455997560324;5661.547076233974;5726.942730572808;5821.592488525932;5847.093700476433 08:08:16 INFO - PROCESS | 1663 | |1;ext.html;475.5577313098818;482.50061186671803;524.143026152241;528.4055437632663;558.9245451863998;30994.535081973787;41429.96425089374;42608.93477663056;42658.57341426585;44113.117737645305;43742;44190;44192;44194.33708494367;44261.336079958826;8840.823183536326;9722.562484688171;9908.900910990906;9911.976847061644;9917.603295868157;8853;9032.187103160713;9033.864492032591;9052.547372631376;11989.40052997351;12218.633440996784;12283.754324913496;12300.507979680802;12317.568885089024;12342.197757145801;10268.178545716324;12266.080043996646;12276.815847762291;12278.57025004125;12280.385980700928;12051.096167787451;12130.57542986;12130.939345303217;12144.210626309261;12147.817782733266;32860;40961.79519102415;41411.96470088242;41416;41472.37791433101;3378.6114596821435;3443.3113377324635;3916.353801622729;4085.9591404085877;4100.938485922714;30285.43253163861;31124.066278011695;31395.529067064013;31477.84261078703;31677;3220.0983724556927;3308.338332333543;3350.3634309481363;3350.597928248626;3401.4387626041676;498058.5097074491;498644;498659;499981;500915;61712;62055;62090.68954655198;62107.2051757672;62135.067973980425;63475;63801;63877.68061159757;63891.04163437552;63944;15808.762868556982;16247.350105995627;16259;16261.349546018027;16271.267792949346;12503.187292825936;12587.74824503523;12597.433115509824;12598.622041338775;12615.053870959715;15233.923830380778;15610.843891560939;17424.215910284067;17837.910810445865;18340.358087466873;5894.17481552583;6475.348786059525;6542.247641521286;6629.502787290972;6659.633720145439;797.8843067755259;882.6601758323092;930.4507994189598;973.5667627905656;978.8727465429448;28316.90674753636;29898.701012989593;29947.101586952427;30371.848140759153;30762.84618576893;1000.1698590170141;1057.069778594847;1075.3118004477142;1076.4671487613525;1088.8312311591717;15544.922275388551;15585;15676.529704108894;15891.205439728199;15976;674960;680122.5993870097;680483;680571.3457221556;681104;49652;57991.420085799444;58018.8396232073;58113;62160;1196.9945245993233;1313.5993521975888;1319.4392383237087;1337.2444568818587;1364.3723887012086;30842.383152337276;31731.841340793148;31914.68085319117;32486.512702309956;32489;47603.5239647613;49615.75192124016;52466.213006805694;52960.735196323774;53003;603240;606779;606909;607492;607949;40585.79707101446;40718.9820254496;41331.58668413277;41533.58466415418;41556;47164.528354716014;47597.76201118972;47799.5220047809;48446.27330589973;48639.02721945471;39452.40821387624;39700.60299396969;39714.40428393634;40791;41080;29427.852860736417;39473.80263098666;40190.794276171764;40844.38733419061;41168.38247426231;38288.42567361548;38852.61147388603;39081.413778792776;39239.60760392359;39271.60728392794;30918.27844572279;31989.04032879017;34611.653883460844;34765.9570212894;35084.47373289454;25401.364965876;25433.10984115547;25434.872825635754;25486.362840929127;26153.869230653723 08:08:16 INFO - PROCESS | 1663 | |2;jquery.html;356.0724313164209;375.76514678326043;377.59597230962873;387.5911063284959;409.92621328160936;15127.470538531154;16465;20941.47646308843;21099.57800843982;21157.04793284302;18802.717959230624;19664.41006769799;19954.401367958948;20639.277625283117;20982.8459434731;5907.645541267516;5912.645241285515;6141.447269745744;6233.812985610439;6234.750609975618;4243.681723870706;6115.052166914135;6232.252129744437;6237.999999999977;6239.220097487814;6024.578279520413;6627.867442651144;6839.350261725153;6904.1714994200765;6946.861062778741;6782.982552617123;6815.454763618948;6883.8967415488805;6935.271796461399;6942.965285173567;5781.82654520365;5962.373950735154;5964.701764911737;5966.940330596725;5969.164316995624;25887.870560647076;26336.473270534483;26461.3384665383;26614;26796.464070718477;2203.922862699798;2269.5347453771938;2271.3980795089315;2445.3519817248443;2924.1519959211805;15711.371545138181;15755.548829200696;16286.104264265461;16444.588885277964;16475.83524164755;1883.4161409962956;1887.3205645967441;1903.6858918278467;1922.644310802492;1988.1550341105117;125577;128816;129721;131076.0338594922;131957.3402132993;10667.626633067805;10821;11311.321320720619;11336.886631133582;11572.59495917639;14175.078619889675;14201.85798142026;14207.857921420653;14212.573622791333;14214.796706510508;6910.550814197161;8684.95657521721;8698.608562614698;8854.424462410052;8870.334724895529;8698.173673501007;8708.608112634947;8728.869066964;8891.73324800257;8897.866532002025;6771.4582833373215;6880.105586273752;6889.724411023503;6903.620300883399;6905.413039891666;1673.0212825496976;1802.9098545072693;1883.6515244679504;1885.679434496139;1887.0470412441903;860.3891237221643;869.8594689278951;898.9056149104381;918.6417297254076;984.2568860510269;21907.890460547595;22905.31284061481;23268.06927722906;23403.88298058499;23465.306938612004;755.8412733326063;764.6024067484876;912.3567884641444;925.5372313843078;938.5964035464816;10999.955004274581;11248.775024499464;12003.51985920571;12205.38973051344;12273.202241854251;568336;586842;599628;616048;625447;79366;93393.53303233441;109121.54103053416;129487;138575.6142438583;959.7024922273978;968.4092703450889;1001.639409812467;1003.6236411345745;1005.6681295172575;16188.190590470194;18297.26810927548;18355.990420527;19106.713399298744;19147.234110635418;38146;46785.766071169426;46895.29657055079;51542.226866596284;54762.17856732073;65478;73754.63122684353;75691;77617;77802.61098694471;7015.298470152944;7901.565413902291;8076.71731489395;8142.389320801082;8322.750317490485;11945.581904633296;12643.114981951176;12845.871541284467;13044.152130111512;13109.410076546388;9161;11274.098072154373;11337.433128343386;11348.205625606128;11372.772544548898;10863.891361086287;10864.348139111678;10938.398388088732;11077.335359878432;11426.314421134759;11331.263467874562;11468.770624587629;11470.139739519736;11533.365664888512;11536.307821530734;7286.380657643947;7628.80927976805;7921.841563168589;8276.131006244499;8305.916940830515;10330.225233107698;10943.343399396063;11301.886981130083;11346.659600212008;11375.31748095117 08:08:16 INFO - PROCESS | 1663 | |3;mootools.html;1535.8694510966568;1562.1642421304603;1777.8311060449253;1898.3640480439053;1919.8752081114717;8414.242718155365;8933.865992010116;8937.910620893788;8944.0161582226;8958.238549723264;7820.882686759704;8008.239217274364;8502.064772874994;8688.218060374566;8696.652133914637;1807.8282563156479;2358.2453614843216;2397.3646983549374;2398.364433425144;2398.8440751351195;2358.1982126077132;2380.976190238093;2405.518896220754;2405.8075353971726;2418.5767490689145;2373.1812524679044;2387.913499357788;2393.6768536247646;2405.218304051182;2405.398650337416;2343.086196383412;2366.301940927422;2369.218158007853;2375.9881200593973;2394.6288325309606;2359.893804778789;2375.8336916415856;2377.0372998935286;2380.9880950595134;2382.6902502674543;8745.650173993032;8852.734417967471;8867.113288671146;8870.290376769843;8888.822223555557;5233.188855727369;5380;5382.434844341327;5390.056740070472;5400.054990376669;3001.429728351606;3672.9081772955624;3695.6489133532273;3725.9068523286865;3734.8319325630414;1092.093562343253;1100.6367898593444;1104.5636973395544;1118.882517335676;1130.2314426190187;11673.124515661275;11761.294322340602;11786.58746943853;11788.823167652492;11806.99640530556;4550.49944506104;4650.581447669726;4829.13075646387;4847.2729090635985;4872.585830204473;9772.951135244279;9792.020797920293;9837.508124593742;9972.650957216463;10001.49992500372;5375.220593013991;5400.810971615974;5403.675779453245;5409.621326507186;5416.458354164552;4357.215701173819;4424.358468022118;4570.223062079454;4869.756512174448;4944.777485013111;3370.342783157261;3912.941305880414;3930.9213815723524;4065.4105154752397;4094.5700701426517;1088.2110469909253;1312.1405479411;1314.1195399082637;1326.9004824637998;1328.249539010456;808.5552945879742;825.0439144303081;903.2954295649273;926.972190834276;949.9857502137473;5815.2149459822385;5850.8537286567325;5859.589828712034;5986.431289027535;6061.962528039379;379.8528444098806;432.5501478462427;444.05194908869794;444.18492067056667;445.0231741327819;3827.13889374894;3928.9784655989647;3965.72239943207;4070.7354021988476;4104.445899803548;8893.688720894737;10395.116415104801;10752.978467045617;10777.892221077846;10827.187960902964;10684.732881678021;10699.73250668724;10699.83950240747;10725.356478611307;10743.194260430499;8084.7574572762915;8157.79605509867;8172.877406838902;8184.918150818535;8191.812187232817;5626.381098079126;5726.312842458931;5867.853303667443;5932.881342373042;5940.376260492586;9960.900390995997;9960.900390996287;10031.54858031405;10036.397816131055;10071.798564028824;9834.803303934024;10171.898281017095;10260.025297596716;10272.22958278147;10293.74265643365;6859.416949559144;7070.858582828418;7077.398421134261;7432.479726419098;7525.9463675084435;7888.802779930547;7975.96312479374;8023.1976802319305;8282.751517454486;8302.252797248277;7299.8540029200185;7494.213107623839;7520.962395187989;7615.7334493292465;7658.119316278699;7288.672009759467;7288.744893928687;7378.225286344857;7414.332710056121;7439.8140046499275;6887.173539175331;7019.649017549;7020.368166865007;7022.824429389102;7044.8591028178125;4846.345743324606;4890.193118135468;4945.2582112683385;5016.749162541932;5142.871428214175;3990.900227494336;4910.06708725341;4999.275105109811;5040.924386134137;5072.163093089599 08:08:16 INFO - PROCESS | 1663 | |4;prototype.html;300.55367778848404;302.76838218762634;306.91252992897023;312.49064025638205;315.98104113753163;4288.3567464880325;4526.7962941667665;5176.818811341604;5288.545649946262;5350.170723537848;4388.407564978727;4611.492735799059;4997.950430409618;5238.292830467885;5245.632805703603;3544.8936531904083;4069.9593004070025;4074.6943979201606;4077.857274995376;4086.8160932758096;3506.3863823830857;3543.802842237816;3938.8030598470104;4055.918881622366;4078.7348822326603;3687.723420743455;3844.5578758442716;4038.495188101487;4043.6158564936286;4058.289799285128;3017.290936629879;4053.581246563679;4056.8843568018738;4058.411530328086;4102.733322334038;2771.9168424947284;2914.854257287127;3084.6144231971;3532.8341647256602;3549.378858699743;4887.778055486128;5072.568831649314;5128.102622018548;5147.073526765181;5152.278680984665;4624.953750462486;4651.976740116312;4663.114008338439;4666.32338310943;4698.718076915396;4851.369321988154;5349.652272602308;5540.750666220029;5636;5702.6293290935955;3751.211503847145;3798.2148390256534;3868.4777555030273;3889.7082718796205;3909.9413508797393;4360.760158191299;4597.517260687647;5595.964746521907;5807.5063619591965;5809.7095145242565;3641.5448068991377;3783.2622638585763;3906.847479993409;3919.510061242345;3932.07596214895;3993.780342081155;4002.7398219115667;4024.939625905614;4029.3553031514816;4047.919041619151;4308.67684923632;4617.168909596305;4651.790669419885;4653.581177693956;4661.091087238024;5356.464353564613;5753.741081651336;5774.711264436762;5819.418058194146;5851;1159.3391766693073;1232.8534462949542;1299.857015728288;1303.4069498378215;1334.0994828490923;765.3226894198674;771.9231671817895;806.479820515764;808.8705807070841;826.9586520673943;4329.964916489245;4357.281048627005;4364.607185353333;4394.868153955386;4407.360932664746;4143.461350024478;4307.978460107742;4311.361682560607;4831.227003679394;4900.202343184061;4570.771461426915;4901.877453063702;5305.522502974751;5311.097113490716;5407.918881216785;2538.6065159900245;3022.259546411143;3030.3939212157215;3047.6647568767416;3082.8766849326225;4992.726854652041;6079.544034197453;6098.573099882966;6110.083487476914;6120.846978825565;6080.422359875804;6102.633841969496;6104.359042300494;6109.20580324555;6139.171211886427;5565.749541270652;6034.336223015464;6086.3305036446845;6108.297545782203;6134.938650613437;5535.982889325408;5809.443844708315;5827.193569993316;5831.620944638755;5846.766129354948;5536.557075434036;5710.457506536873;5742.827715168552;5758.827235182951;5759.280089988752;5488.142993450745;5734.75986067887;5827.329857066492;5940.198073260228;6057.545684073624;3957.5357117865424;3992.640662340403;4013.097053163132;4019.733783858075;4041.2321658884716;5043.949560504348;5731.5701322400155;5860.853478663067;5899.764009439746;5929.673867937305;5115.462876397924;5511.118221084607;5518.862028449321;5610.559406658117;5702.600817942704;5284.445133260952;5439;5513.779448822002;5592.832215033555;5597.5521958242425;4856.344393506832;4971.328870602567;5200.2199670049795;5401.432849550741;5403.648762830403;5550.500454959073;5590.161475778503;5591.692456914909;5636.323641162922;5666.688332141772;4838.346823178967;5273.709945953009;5494.752736126804;5536.944630553643;5547.389787123494 08:08:16 INFO - PROCESS | 1663 | |5;yui.html;712.9536580122295;751.0724255544403;762.6491813765667;771.178694690155;772.8608850406924;12233.755324893496;15438.922805385957;16013.839861601395;16014.119223442705;16195.757063644025;14420.134791912493;14736;14739.263036848142;14767.630809229775;14910.179940103317;695.7043256615918;716.2944499667849;853.1894700034976;874.7944233105216;874.8294082653885;852.8848605438279;882.2280504558511;883.4346018548134;884.062893333069;890.1543533643065;897.7890195804014;900.1178844732167;901.4591245252861;902.8826252587154;903.7830920579047;715.0811207598264;885.4731434796286;895.6506962284747;900.1448623807377;901.6708901251062;685.4105469296401;686.2965460403077;687.0312858868971;687.656171914043;688.2429327739496;14827.703445931022;14885.776713349309;14886.213654361438;14887.553373398816;14946.775798363033;13530.18818870871;13584.588945286006;13863.376148073361;13916.791248131287;14115.929420352935;12319.59663529935;12350.691232719164;12356.62930112098;12435.875641243561;12794.168379055332;4477.552244775529;4513.52607976161;4536.302380287876;4577.542245775429;4623.0984957933215;88725.55637221773;112738;113548;113813.4309328448;113911.2913306301;9086.409383390059;10505.369677819355;10695.62565310226;10802.405867677353;10832.350058996486;21900.342989710334;21905.780942190373;21943;21953.121875124816;21970.34088977333;7627.54234745917;7663.042119735033;7668.65491052904;7889.644965976545;7898.091719452222;4316.870493885189;4399.36209249657;4426.247537918562;4439.844605438794;4490.820367185342;3456.4296891013205;3560.1989552350515;3561.928761424757;3566.358055549974;3572.035550401429;642.4218203616689;642.5245318464302;651.2543138106936;668.0713807807152;669.9464042876558;509.6967304453844;535.7803300646716;600.3996003996004;606.4844881850391;615.2463232540102;8430.578471076422;8645.870311945326;8899.599518021705;8915.28677705782;8926.68756593516;537.787573908304;556.6687820746649;617.3826173826174;623.2832242920678;627.5105417774143;4123.525794533667;4300.91398172041;4325.956740432618;4342.696011279243;4362.716423432466;132550;143597.76826780854;155710;155766;157454;125458;126746.36626816807;127930;128259.35870320589;130305;110367;112025.87974120154;112444;113270;113630;8279.751607451786;8285.792855178668;8385.454945428528;8398.916010839814;8612.61243244043;58160.70919645375;58539;61125.08312375229;61997.380026199164;62566.435839104386;78524.21475785397;88387;94232.52883735538;95779;96033;11308.151888608552;11370.43147842588;11501;11815.172937894265;11843.763124737628;12088.274703517465;12177.147599668293;12352.814707779211;12605.74788504243;12610.43253053633;11643.76712465729;11651.59219427316;11789.41052947332;11803.763924721628;12185.69535761613;10533.4733263335;10937;11411.315321080761;11481.368524730886;11846.170768046153;9195.494247816434;11294.378809165575;11351;11468.770624587294;11850.703732406759;9856.704298871045;9938.254630902567;10059.446730429896;10097.949510252402;10128.442935638315;7823.178566250689;8296.83406331858;9016.323775716717;9372.34393592442;9725.708228753148 08:08:16 INFO - PROCESS | 1663 | __end_tp_report 08:08:16 INFO - PROCESS | 1663 | __start_cc_report 08:08:16 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1127 08:08:16 INFO - PROCESS | 1663 | __end_cc_report 08:08:16 INFO - PROCESS | 1663 | __startTimestamp1473260896276__endTimestamp 08:08:16 INFO - PROCESS | 1663 | 08:08:16 INFO - PROCESS | 1663 | ------- Summary: start ------- 08:08:16 INFO - PROCESS | 1663 | Number of tests: 6 08:08:16 INFO - PROCESS | 1663 | 08:08:16 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5711.87 Median:5821.59 stddev:646.15 (11.1%) stddev-sans-first:615.22 08:08:16 INFO - PROCESS | 1663 | Values: 3116.8 3318.2 3357.9 3386.4 3414.7 4658.7 5296.3 5602.0 5732.4 5746.8 5707.1 5723.0 5758.0 5791.2 5831.4 4218.7 5184.9 5185.5 5236.6 5333.5 5309.7 5323.3 5329.0 5349.1 5357.1 5177.9 5195.4 5214.3 5260.7 5270.5 5243.3 5256.7 5260.8 5266.1 5287.2 5172.9 5187.1 5197.8 5200.5 5276.6 5746.4 5762.3 5771.0 5781.2 5784.0 6113.6 6139.6 6288.3 6305.8 6318.0 6199.7 6286.1 6297.5 6319.8 6327.3 5775.3 5776.2 5780.5 5782.5 5785.2 6165.4 6216.4 6249.8 6294.2 6311.7 6169.3 6194.9 6198.6 6207.5 6210.6 6310.1 6310.7 6312.9 6329.4 6332.2 5125.7 6100.1 6112.1 6271.0 6294.2 6203.9 6230.9 6257.3 6263.4 6268.6 4974.7 4975.9 4984.2 4984.4 4998.1 4439.5 4441.6 4442.1 4483.2 4488.5 5692.1 5706.2 5716.5 5717.3 5728.2 6225.9 6249.1 6260.0 6272.2 6292.2 5748.7 5762.9 5783.4 5818.4 5835.9 5405.8 5441.4 5451.1 5451.3 5472.6 6194.2 6207.7 6217.5 6296.9 6317.1 6103.2 6115.9 6120.9 6128.6 6144.7 6163.9 6287.6 6289.2 6292.2 6297.3 5814.9 5819.7 5964.1 6041.1 6084.3 6318.6 6342.5 6344.7 6354.1 6372.7 6009.9 6011.5 6020.6 6022.5 6034.9 5821.9 5947.2 5947.6 6015.1 6049.6 5677.4 5782.6 5820.6 5831.0 5889.9 5941.6 5968.8 5986.1 5994.3 6002.7 4730.5 5661.5 5726.9 5821.6 5847.1 08:08:16 INFO - PROCESS | 1663 | 08:08:16 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:73223.83 Median:39952.60 stddev:160273.37 (401.2%) stddev-sans-first:160629.90 08:08:16 INFO - PROCESS | 1663 | Values: 475.6 482.5 524.1 528.4 558.9 30994.5 41430.0 42608.9 42658.6 44113.1 43742.0 44190.0 44192.0 44194.3 44261.3 8840.8 9722.6 9908.9 9912.0 9917.6 8853.0 9032.2 9033.9 9052.5 11989.4 12218.6 12283.8 12300.5 12317.6 12342.2 10268.2 12266.1 12276.8 12278.6 12280.4 12051.1 12130.6 12130.9 12144.2 12147.8 32860.0 40961.8 41412.0 41416.0 41472.4 3378.6 3443.3 3916.4 4086.0 4100.9 30285.4 31124.1 31395.5 31477.8 31677.0 3220.1 3308.3 3350.4 3350.6 3401.4 498058.5 498644.0 498659.0 499981.0 500915.0 61712.0 62055.0 62090.7 62107.2 62135.1 63475.0 63801.0 63877.7 63891.0 63944.0 15808.8 16247.4 16259.0 16261.3 16271.3 12503.2 12587.7 12597.4 12598.6 12615.1 15233.9 15610.8 17424.2 17837.9 18340.4 5894.2 6475.3 6542.2 6629.5 6659.6 797.9 882.7 930.5 973.6 978.9 28316.9 29898.7 29947.1 30371.8 30762.8 1000.2 1057.1 1075.3 1076.5 1088.8 15544.9 15585.0 15676.5 15891.2 15976.0 674960.0 680122.6 680483.0 680571.3 681104.0 49652.0 57991.4 58018.8 58113.0 62160.0 1197.0 1313.6 1319.4 1337.2 1364.4 30842.4 31731.8 31914.7 32486.5 32489.0 47603.5 49615.8 52466.2 52960.7 53003.0 603240.0 606779.0 606909.0 607492.0 607949.0 40585.8 40719.0 41331.6 41533.6 41556.0 47164.5 47597.8 47799.5 48446.3 48639.0 39452.4 39700.6 39714.4 40791.0 41080.0 29427.9 39473.8 40190.8 40844.4 41168.4 38288.4 38852.6 39081.4 39239.6 39271.6 30918.3 31989.0 34611.7 34766.0 35084.5 25401.4 25433.1 25434.9 25486.4 26153.9 08:08:16 INFO - PROCESS | 1663 | 08:08:16 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:34941.02 Median:26398.91 stddev:99855.16 (378.3%) stddev-sans-first:100101.51 08:08:16 INFO - PROCESS | 1663 | Values: 356.1 375.8 377.6 387.6 409.9 15127.5 16465.0 20941.5 21099.6 21157.0 18802.7 19664.4 19954.4 20639.3 20982.8 5907.6 5912.6 6141.4 6233.8 6234.8 4243.7 6115.1 6232.3 6238.0 6239.2 6024.6 6627.9 6839.4 6904.2 6946.9 6783.0 6815.5 6883.9 6935.3 6943.0 5781.8 5962.4 5964.7 5966.9 5969.2 25887.9 26336.5 26461.3 26614.0 26796.5 2203.9 2269.5 2271.4 2445.4 2924.2 15711.4 15755.5 16286.1 16444.6 16475.8 1883.4 1887.3 1903.7 1922.6 1988.2 125577.0 128816.0 129721.0 131076.0 131957.3 10667.6 10821.0 11311.3 11336.9 11572.6 14175.1 14201.9 14207.9 14212.6 14214.8 6910.6 8685.0 8698.6 8854.4 8870.3 8698.2 8708.6 8728.9 8891.7 8897.9 6771.5 6880.1 6889.7 6903.6 6905.4 1673.0 1802.9 1883.7 1885.7 1887.0 860.4 869.9 898.9 918.6 984.3 21907.9 22905.3 23268.1 23403.9 23465.3 755.8 764.6 912.4 925.5 938.6 11000.0 11248.8 12003.5 12205.4 12273.2 568336.0 586842.0 599628.0 616048.0 625447.0 79366.0 93393.5 109121.5 129487.0 138575.6 959.7 968.4 1001.6 1003.6 1005.7 16188.2 18297.3 18356.0 19106.7 19147.2 38146.0 46785.8 46895.3 51542.2 54762.2 65478.0 73754.6 75691.0 77617.0 77802.6 7015.3 7901.6 8076.7 8142.4 8322.8 11945.6 12643.1 12845.9 13044.2 13109.4 9161.0 11274.1 11337.4 11348.2 11372.8 10863.9 10864.3 10938.4 11077.3 11426.3 11331.3 11468.8 11470.1 11533.4 11536.3 7286.4 7628.8 7921.8 8276.1 8305.9 10330.2 10943.3 11301.9 11346.7 11375.3 08:08:16 INFO - PROCESS | 1663 | 08:08:16 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5680.91 Median:4858.51 stddev:3200.70 (65.9%) stddev-sans-first:3194.52 08:08:16 INFO - PROCESS | 1663 | Values: 1535.9 1562.2 1777.8 1898.4 1919.9 8414.2 8933.9 8937.9 8944.0 8958.2 7820.9 8008.2 8502.1 8688.2 8696.7 1807.8 2358.2 2397.4 2398.4 2398.8 2358.2 2381.0 2405.5 2405.8 2418.6 2373.2 2387.9 2393.7 2405.2 2405.4 2343.1 2366.3 2369.2 2376.0 2394.6 2359.9 2375.8 2377.0 2381.0 2382.7 8745.7 8852.7 8867.1 8870.3 8888.8 5233.2 5380.0 5382.4 5390.1 5400.1 3001.4 3672.9 3695.6 3725.9 3734.8 1092.1 1100.6 1104.6 1118.9 1130.2 11673.1 11761.3 11786.6 11788.8 11807.0 4550.5 4650.6 4829.1 4847.3 4872.6 9773.0 9792.0 9837.5 9972.7 10001.5 5375.2 5400.8 5403.7 5409.6 5416.5 4357.2 4424.4 4570.2 4869.8 4944.8 3370.3 3912.9 3930.9 4065.4 4094.6 1088.2 1312.1 1314.1 1326.9 1328.2 808.6 825.0 903.3 927.0 950.0 5815.2 5850.9 5859.6 5986.4 6062.0 379.9 432.6 444.1 444.2 445.0 3827.1 3929.0 3965.7 4070.7 4104.4 8893.7 10395.1 10753.0 10777.9 10827.2 10684.7 10699.7 10699.8 10725.4 10743.2 8084.8 8157.8 8172.9 8184.9 8191.8 5626.4 5726.3 5867.9 5932.9 5940.4 9960.9 9960.9 10031.5 10036.4 10071.8 9834.8 10171.9 10260.0 10272.2 10293.7 6859.4 7070.9 7077.4 7432.5 7525.9 7888.8 7976.0 8023.2 8282.8 8302.3 7299.9 7494.2 7521.0 7615.7 7658.1 7288.7 7288.7 7378.2 7414.3 7439.8 6887.2 7019.6 7020.4 7022.8 7044.9 4846.3 4890.2 4945.3 5016.7 5142.9 3990.9 4910.1 4999.3 5040.9 5072.2 08:08:16 INFO - PROCESS | 1663 | 08:08:16 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:4507.90 Median:4901.04 stddev:1418.22 (28.9%) stddev-sans-first:1386.59 08:08:16 INFO - PROCESS | 1663 | Values: 300.6 302.8 306.9 312.5 316.0 4288.4 4526.8 5176.8 5288.5 5350.2 4388.4 4611.5 4998.0 5238.3 5245.6 3544.9 4070.0 4074.7 4077.9 4086.8 3506.4 3543.8 3938.8 4055.9 4078.7 3687.7 3844.6 4038.5 4043.6 4058.3 3017.3 4053.6 4056.9 4058.4 4102.7 2771.9 2914.9 3084.6 3532.8 3549.4 4887.8 5072.6 5128.1 5147.1 5152.3 4625.0 4652.0 4663.1 4666.3 4698.7 4851.4 5349.7 5540.8 5636.0 5702.6 3751.2 3798.2 3868.5 3889.7 3909.9 4360.8 4597.5 5596.0 5807.5 5809.7 3641.5 3783.3 3906.8 3919.5 3932.1 3993.8 4002.7 4024.9 4029.4 4047.9 4308.7 4617.2 4651.8 4653.6 4661.1 5356.5 5753.7 5774.7 5819.4 5851.0 1159.3 1232.9 1299.9 1303.4 1334.1 765.3 771.9 806.5 808.9 827.0 4330.0 4357.3 4364.6 4394.9 4407.4 4143.5 4308.0 4311.4 4831.2 4900.2 4570.8 4901.9 5305.5 5311.1 5407.9 2538.6 3022.3 3030.4 3047.7 3082.9 4992.7 6079.5 6098.6 6110.1 6120.8 6080.4 6102.6 6104.4 6109.2 6139.2 5565.7 6034.3 6086.3 6108.3 6134.9 5536.0 5809.4 5827.2 5831.6 5846.8 5536.6 5710.5 5742.8 5758.8 5759.3 5488.1 5734.8 5827.3 5940.2 6057.5 3957.5 3992.6 4013.1 4019.7 4041.2 5043.9 5731.6 5860.9 5899.8 5929.7 5115.5 5511.1 5518.9 5610.6 5702.6 5284.4 5439.0 5513.8 5592.8 5597.6 4856.3 4971.3 5200.2 5401.4 5403.6 5550.5 5590.2 5591.7 5636.3 5666.7 4838.3 5273.7 5494.8 5536.9 5547.4 08:08:16 INFO - PROCESS | 1663 | 08:08:16 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:24371.20 Median:4381.04 stddev:39690.02 (905.9%) stddev-sans-first:39761.61 08:08:16 INFO - PROCESS | 1663 | Values: 713.0 751.1 762.6 771.2 772.9 12233.8 15438.9 16013.8 16014.1 16195.8 14420.1 14736.0 14739.3 14767.6 14910.2 695.7 716.3 853.2 874.8 874.8 852.9 882.2 883.4 884.1 890.2 897.8 900.1 901.5 902.9 903.8 715.1 885.5 895.7 900.1 901.7 685.4 686.3 687.0 687.7 688.2 14827.7 14885.8 14886.2 14887.6 14946.8 13530.2 13584.6 13863.4 13916.8 14115.9 12319.6 12350.7 12356.6 12435.9 12794.2 4477.6 4513.5 4536.3 4577.5 4623.1 88725.6 112738.0 113548.0 113813.4 113911.3 9086.4 10505.4 10695.6 10802.4 10832.4 21900.3 21905.8 21943.0 21953.1 21970.3 7627.5 7663.0 7668.7 7889.6 7898.1 4316.9 4399.4 4426.2 4439.8 4490.8 3456.4 3560.2 3561.9 3566.4 3572.0 642.4 642.5 651.3 668.1 669.9 509.7 535.8 600.4 606.5 615.2 8430.6 8645.9 8899.6 8915.3 8926.7 537.8 556.7 617.4 623.3 627.5 4123.5 4300.9 4326.0 4342.7 4362.7 132550.0 143597.8 155710.0 155766.0 157454.0 125458.0 126746.4 127930.0 128259.4 130305.0 110367.0 112025.9 112444.0 113270.0 113630.0 8279.8 8285.8 8385.5 8398.9 8612.6 58160.7 58539.0 61125.1 61997.4 62566.4 78524.2 88387.0 94232.5 95779.0 96033.0 11308.2 11370.4 11501.0 11815.2 11843.8 12088.3 12177.1 12352.8 12605.7 12610.4 11643.8 11651.6 11789.4 11803.8 12185.7 10533.5 10937.0 11411.3 11481.4 11846.2 9195.5 11294.4 11351.0 11468.8 11850.7 9856.7 9938.3 10059.4 10097.9 10128.4 7823.2 8296.8 9016.3 9372.3 9725.7 08:08:16 INFO - PROCESS | 1663 | -------- Summary: end -------- 08:08:16 INFO - PROCESS | 1663 | 08:08:16 INFO - TEST-INFO | 1663: exit 0 08:08:16 INFO - TEST-OK | dromaeo_css | took 1117284ms 08:08:16 INFO - TEST-START | kraken 08:08:16 INFO - operating with platform_type : mac_ 08:08:16 INFO - Initialising browser for kraken test... 08:08:16 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/tmpIt32eb/profile http://localhost:49274/getInfo.html) 08:08:19 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 08:08:19 INFO - PROCESS | 1669 | colorDepth:24 08:08:19 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 08:08:19 INFO - PROCESS | 1669 | __metrics 08:08:19 INFO - PROCESS | 1669 | 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" 08:08:19 INFO - PROCESS | 1669 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:08:20 INFO - TEST-INFO | 1669: exit 0 08:08:20 INFO - Browser initialized. 08:08:20 INFO - Running cycle 1/1 for kraken test... 08:08:20 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/tmpIt32eb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:08:32 INFO - PROCESS | 1670 | RSS: Main: 232312832 08:08:32 INFO - PROCESS | 1670 | 08:08:34 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 08:08:35 INFO - PROCESS | 1670 | RSS: Main: 291262464 08:08:35 INFO - PROCESS | 1670 | 08:08:38 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 08:08:39 INFO - PROCESS | 1670 | RSS: Main: 287805440 08:08:39 INFO - PROCESS | 1670 | 08:08:42 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 08:08:43 INFO - PROCESS | 1670 | RSS: Main: 378101760 08:08:43 INFO - PROCESS | 1670 | 08:08:45 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 08:08:46 INFO - PROCESS | 1670 | RSS: Main: 278859776 08:08:46 INFO - PROCESS | 1670 | 08:08:48 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:08:48 INFO - PROCESS | 1670 | RSS: Main: 284143616 08:08:48 INFO - PROCESS | 1670 | 08:08:51 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 08:08:52 INFO - PROCESS | 1670 | RSS: Main: 323375104 08:08:52 INFO - PROCESS | 1670 | 08:08:54 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 08:08:55 INFO - PROCESS | 1670 | RSS: Main: 323551232 08:08:55 INFO - PROCESS | 1670 | 08:08:58 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 08:08:58 INFO - PROCESS | 1670 | RSS: Main: 323227648 08:08:58 INFO - PROCESS | 1670 | 08:09:00 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:09:01 INFO - PROCESS | 1670 | RSS: Main: 298016768 08:09:01 INFO - PROCESS | 1670 | 08:09:02 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:09:03 INFO - PROCESS | 1670 | RSS: Main: 303947776 08:09:03 INFO - PROCESS | 1670 | 08:09:05 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:09:06 INFO - PROCESS | 1670 | RSS: Main: 301219840 08:09:06 INFO - PROCESS | 1670 | 08:09:09 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:09:10 INFO - PROCESS | 1670 | RSS: Main: 320335872 08:09:10 INFO - PROCESS | 1670 | 08:09:13 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:09:13 INFO - PROCESS | 1670 | RSS: Main: 315789312 08:09:13 INFO - PROCESS | 1670 | 08:09:15 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 08:09:15 INFO - PROCESS | 1670 | RSS: Main: 359706624 08:09:15 INFO - PROCESS | 1670 | 08:09:15 INFO - PROCESS | 1670 | __start_tp_report 08:09:15 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 08:09:15 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 08:09:15 INFO - PROCESS | 1670 | |i|pagename|runs| 08:09:15 INFO - PROCESS | 1670 | |0;ai-astar;115;114;117;110;114;148;163;147;114;124 08:09:15 INFO - PROCESS | 1670 | |1;audio-beat-detection;172;144;119;172;102;151;159;92;181;135 08:09:15 INFO - PROCESS | 1670 | |2;audio-dft;185;184;187;184;185;182;256;203;181;179 08:09:15 INFO - PROCESS | 1670 | |3;audio-fft;78;73;77;155;57;57;60;80;160;67 08:09:15 INFO - PROCESS | 1670 | |4;audio-oscillator;81;83;135;70;72;74;119;68;70;118 08:09:15 INFO - PROCESS | 1670 | |5;imaging-gaussian-blur;88;85;89;85;88;84;87;85;88;84 08:09:15 INFO - PROCESS | 1670 | |6;imaging-darkroom;94;93;94;94;93;95;94;93;94;93 08:09:15 INFO - PROCESS | 1670 | |7;imaging-desaturate;84;87;83;86;83;85;87;83;86;84 08:09:15 INFO - PROCESS | 1670 | |8;json-parse-financial;56;56;55;52;51;55;55;56;55;52 08:09:15 INFO - PROCESS | 1670 | |9;json-stringify-tinderbox;67;66;72;71;83;74;70;69;70;72 08:09:15 INFO - PROCESS | 1670 | |10;stanford-crypto-aes;85;85;98;105;105;80;85;86;86;88 08:09:15 INFO - PROCESS | 1670 | |11;stanford-crypto-ccm;139;141;138;139;146;160;141;140;196;157 08:09:15 INFO - PROCESS | 1670 | |12;stanford-crypto-pbkdf2;169;171;171;169;167;172;168;185;234;185 08:09:15 INFO - PROCESS | 1670 | |13;stanford-crypto-sha256-iterative;67;66;70;66;93;68;67;68;66;67 08:09:15 INFO - PROCESS | 1670 | __end_tp_report 08:09:15 INFO - PROCESS | 1670 | __start_cc_report 08:09:15 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,2000 08:09:15 INFO - PROCESS | 1670 | __end_cc_report 08:09:15 INFO - PROCESS | 1670 | __startTimestamp1473260955711__endTimestamp 08:09:15 INFO - PROCESS | 1670 | 08:09:15 INFO - PROCESS | 1670 | ------- Summary: start ------- 08:09:15 INFO - PROCESS | 1670 | Number of tests: 14 08:09:15 INFO - PROCESS | 1670 | 08:09:15 INFO - PROCESS | 1670 | [#0] ai-astar Cycles:10 Average:126.60 Median:120.50 stddev:18.81 (15.6%) stddev-sans-first:19.48 08:09:15 INFO - PROCESS | 1670 | Values: 115.0 114.0 117.0 110.0 114.0 148.0 163.0 147.0 114.0 124.0 08:09:15 INFO - PROCESS | 1670 | 08:09:15 INFO - PROCESS | 1670 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:165.50 stddev:30.49 (18.4%) stddev-sans-first:30.44 08:09:15 INFO - PROCESS | 1670 | Values: 172.0 144.0 119.0 172.0 102.0 151.0 159.0 92.0 181.0 135.0 08:09:15 INFO - PROCESS | 1670 | 08:09:15 INFO - PROCESS | 1670 | [#2] audio-dft Cycles:10 Average:192.60 Median:185.00 stddev:23.22 (12.6%) stddev-sans-first:24.47 08:09:15 INFO - PROCESS | 1670 | Values: 185.0 184.0 187.0 184.0 185.0 182.0 256.0 203.0 181.0 179.0 08:09:15 INFO - PROCESS | 1670 | 08:09:15 INFO - PROCESS | 1670 | [#3] audio-fft Cycles:10 Average:86.40 Median:70.00 stddev:38.45 (54.9%) stddev-sans-first:40.66 08:09:15 INFO - PROCESS | 1670 | Values: 78.0 73.0 77.0 155.0 57.0 57.0 60.0 80.0 160.0 67.0 08:09:15 INFO - PROCESS | 1670 | 08:09:15 INFO - PROCESS | 1670 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:71.00 stddev:25.02 (35.2%) stddev-sans-first:26.37 08:09:15 INFO - PROCESS | 1670 | Values: 81.0 83.0 135.0 70.0 72.0 74.0 119.0 68.0 70.0 118.0 08:09:15 INFO - PROCESS | 1670 | 08:09:15 INFO - PROCESS | 1670 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:87.50 stddev:1.89 (2.2%) stddev-sans-first:1.90 08:09:15 INFO - PROCESS | 1670 | Values: 88.0 85.0 89.0 85.0 88.0 84.0 87.0 85.0 88.0 84.0 08:09:15 INFO - PROCESS | 1670 | 08:09:15 INFO - PROCESS | 1670 | [#6] imaging-darkroom Cycles:10 Average:93.70 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 08:09:15 INFO - PROCESS | 1670 | Values: 94.0 93.0 94.0 94.0 93.0 95.0 94.0 93.0 94.0 93.0 08:09:15 INFO - PROCESS | 1670 | 08:09:15 INFO - PROCESS | 1670 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.50 stddev:1.62 (1.9%) stddev-sans-first:1.69 08:09:15 INFO - PROCESS | 1670 | Values: 84.0 87.0 83.0 86.0 83.0 85.0 87.0 83.0 86.0 84.0 08:09:15 INFO - PROCESS | 1670 | 08:09:15 INFO - PROCESS | 1670 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:55.00 stddev:1.89 (3.4%) stddev-sans-first:1.90 08:09:15 INFO - PROCESS | 1670 | Values: 56.0 56.0 55.0 52.0 51.0 55.0 55.0 56.0 55.0 52.0 08:09:15 INFO - PROCESS | 1670 | 08:09:15 INFO - PROCESS | 1670 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:71.50 stddev:4.72 (6.6%) stddev-sans-first:4.73 08:09:15 INFO - PROCESS | 1670 | Values: 67.0 66.0 72.0 71.0 83.0 74.0 70.0 69.0 70.0 72.0 08:09:15 INFO - PROCESS | 1670 | 08:09:15 INFO - PROCESS | 1670 | [#10] stanford-crypto-aes Cycles:10 Average:90.30 Median:85.50 stddev:8.97 (10.5%) stddev-sans-first:9.31 08:09:15 INFO - PROCESS | 1670 | Values: 85.0 85.0 98.0 105.0 105.0 80.0 85.0 86.0 86.0 88.0 08:09:15 INFO - PROCESS | 1670 | 08:09:15 INFO - PROCESS | 1670 | [#11] stanford-crypto-ccm Cycles:10 Average:149.70 Median:143.50 stddev:18.04 (12.6%) stddev-sans-first:18.71 08:09:15 INFO - PROCESS | 1670 | Values: 139.0 141.0 138.0 139.0 146.0 160.0 141.0 140.0 196.0 157.0 08:09:15 INFO - PROCESS | 1670 | 08:09:15 INFO - PROCESS | 1670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.10 Median:171.50 stddev:20.38 (11.9%) stddev-sans-first:21.29 08:09:15 INFO - PROCESS | 1670 | Values: 169.0 171.0 171.0 169.0 167.0 172.0 168.0 185.0 234.0 185.0 08:09:15 INFO - PROCESS | 1670 | 08:09:15 INFO - PROCESS | 1670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:67.50 stddev:8.24 (12.2%) stddev-sans-first:8.68 08:09:15 INFO - PROCESS | 1670 | Values: 67.0 66.0 70.0 66.0 93.0 68.0 67.0 68.0 66.0 67.0 08:09:15 INFO - PROCESS | 1670 | -------- Summary: end -------- 08:09:15 INFO - PROCESS | 1670 | 08:09:16 INFO - TEST-INFO | 1670: exit 0 08:09:16 INFO - TEST-OK | kraken | took 59661ms 08:09:16 INFO - SUITE-END | took 1176s 08:09:16 INFO - Completed test suite (00:19:37) 08:09:16 INFO - javascript benchmark 08:09:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3116.797408168469, 3318.187044174177, 3357.949630755539, 3386.3565922474745, 3414.6585341465843, 4658.697184682997, 5296.258523806665, 5601.971990140044, 5732.398098199692, 5746.798862039825, 5707.086866101425, 5722.998475266822, 5757.971210143944, 5791.21818554495, 5831.446012628793, 4218.683598730092, 5184.948150518484, 5185.481451854803, 5236.581073514129, 5333.519983201511, 5309.73451327434, 5323.334583177103, 5329.0, 5349.144136938091, 5357.116075847481, 5177.870553236199, 5195.428502864682, 5214.322138122057, 5260.658057226268, 5270.4729527047375, 5243.318368612094, 5256.658317209407, 5260.815871444519, 5266.104762190437, 5287.154055351164, 5172.948270517284, 5187.118189907725, 5197.766100525448, 5200.5059519345605, 5276.551493123089, 5746.367899531048, 5762.308522977228, 5771.0, 5781.161731548902, 5783.987802134651, 6113.572049956505, 6139.614800607363, 6288.276848162474, 6305.810825675191, 6318.0, 6199.721012554446, 6286.088517165032, 6297.464715499143, 6319.810405687791, 6327.27236367819, 5775.278090238762, 5776.220210271644, 5780.479756821906, 5782.537397008229, 5785.1611516329895, 6165.445109940038, 6216.4405203531, 6249.843753906189, 6294.181756371642, 6311.715972781236, 6169.259688837278, 6194.938050619436, 6198.597091189058, 6207.472364849038, 6210.565260431817, 6310.1481300024825, 6310.716017779211, 6312.936870631327, 6329.398707122816, 6332.208473940757, 5125.743712814345, 6100.1270446244, 6112.07796728157, 6270.996640537492, 6294.15028971083, 6203.906941395882, 6230.906536401958, 6257.311695713468, 6263.404976527223, 6268.623882567061, 4974.676646017997, 4975.900481990412, 4984.177610694267, 4984.37695288089, 4998.075356059141, 4439.511653718088, 4441.555844415597, 4442.133783912106, 4483.21543729846, 4488.506264310923, 5692.14617807324, 5706.229658996065, 5716.485516303553, 5717.342505611825, 5728.198052272685, 6225.906611400833, 6249.0938813871735, 6260.029695397221, 6272.247330320391, 6292.150559674477, 5748.6838223898085, 5762.9135562966585, 5783.421657834183, 5818.389069147764, 5835.854103647358, 5405.7567409466665, 5441.374241962146, 5451.073317535949, 5451.318585176853, 5472.589555783332, 6194.194754681863, 6207.720652570555, 6217.502599791916, 6296.905546416808, 6317.115603815378, 6103.216452666926, 6115.94015414234, 6120.938790612036, 6128.601640893327, 6144.678894037804, 6163.8991543066395, 6287.622742635456, 6289.245290565162, 6292.1505596743855, 6297.338779428094, 5814.8866281533565, 5819.6508209507565, 5964.135200396005, 6041.093835924647, 6084.269887613515, 6318.557700960889, 6342.52431067681, 6344.651044192614, 6354.1104245406605, 6372.681365931778, 6009.909851352146, 6011.549133814894, 6020.638761674313, 6022.45797878193, 6034.909476357946, 5821.883562328814, 5947.197128387786, 5947.6431414115295, 6015.097735339734, 6049.618225558098, 5677.432256774289, 5782.624129431573, 5820.621659592113, 5831.008728516078, 5889.852753681193, 5941.643501389931, 5968.791092311748, 5986.132010858314, 5994.31065427464, 6002.669853158118, 4730.455997560324, 5661.547076233974, 5726.942730572808, 5821.592488525932, 5847.093700476433], "value": 5670.877905008546, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.5577313098818, 482.50061186671803, 524.143026152241, 528.4055437632663, 558.9245451863998, 30994.535081973787, 41429.96425089374, 42608.93477663056, 42658.57341426585, 44113.117737645305, 43742.0, 44190.0, 44192.0, 44194.33708494367, 44261.336079958826, 8840.823183536326, 9722.562484688171, 9908.900910990906, 9911.976847061644, 9917.603295868157, 8853.0, 9032.187103160713, 9033.864492032591, 9052.547372631376, 11989.40052997351, 12218.633440996784, 12283.754324913496, 12300.507979680802, 12317.568885089024, 12342.197757145801, 10268.178545716324, 12266.080043996646, 12276.815847762291, 12278.57025004125, 12280.385980700928, 12051.096167787451, 12130.57542986, 12130.939345303217, 12144.210626309261, 12147.817782733266, 32860.0, 40961.79519102415, 41411.96470088242, 41416.0, 41472.37791433101, 3378.6114596821435, 3443.3113377324635, 3916.353801622729, 4085.9591404085877, 4100.938485922714, 30285.43253163861, 31124.066278011695, 31395.529067064013, 31477.84261078703, 31677.0, 3220.0983724556927, 3308.338332333543, 3350.3634309481363, 3350.597928248626, 3401.4387626041676, 498058.5097074491, 498644.0, 498659.0, 499981.0, 500915.0, 61712.0, 62055.0, 62090.68954655198, 62107.2051757672, 62135.067973980425, 63475.0, 63801.0, 63877.68061159757, 63891.04163437552, 63944.0, 15808.762868556982, 16247.350105995627, 16259.0, 16261.349546018027, 16271.267792949346, 12503.187292825936, 12587.74824503523, 12597.433115509824, 12598.622041338775, 12615.053870959715, 15233.923830380778, 15610.843891560939, 17424.215910284067, 17837.910810445865, 18340.358087466873, 5894.17481552583, 6475.348786059525, 6542.247641521286, 6629.502787290972, 6659.633720145439, 797.8843067755259, 882.6601758323092, 930.4507994189598, 973.5667627905656, 978.8727465429448, 28316.90674753636, 29898.701012989593, 29947.101586952427, 30371.848140759153, 30762.84618576893, 1000.1698590170141, 1057.069778594847, 1075.3118004477142, 1076.4671487613525, 1088.8312311591717, 15544.922275388551, 15585.0, 15676.529704108894, 15891.205439728199, 15976.0, 674960.0, 680122.5993870097, 680483.0, 680571.3457221556, 681104.0, 49652.0, 57991.420085799444, 58018.8396232073, 58113.0, 62160.0, 1196.9945245993233, 1313.5993521975888, 1319.4392383237087, 1337.2444568818587, 1364.3723887012086, 30842.383152337276, 31731.841340793148, 31914.68085319117, 32486.512702309956, 32489.0, 47603.5239647613, 49615.75192124016, 52466.213006805694, 52960.735196323774, 53003.0, 603240.0, 606779.0, 606909.0, 607492.0, 607949.0, 40585.79707101446, 40718.9820254496, 41331.58668413277, 41533.58466415418, 41556.0, 47164.528354716014, 47597.76201118972, 47799.5220047809, 48446.27330589973, 48639.02721945471, 39452.40821387624, 39700.60299396969, 39714.40428393634, 40791.0, 41080.0, 29427.852860736417, 39473.80263098666, 40190.794276171764, 40844.38733419061, 41168.38247426231, 38288.42567361548, 38852.61147388603, 39081.413778792776, 39239.60760392359, 39271.60728392794, 30918.27844572279, 31989.04032879017, 34611.653883460844, 34765.9570212894, 35084.47373289454, 25401.364965876, 25433.10984115547, 25434.872825635754, 25486.362840929127, 26153.869230653723], "value": 20697.317217891487, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.0724313164209, 375.76514678326043, 377.59597230962873, 387.5911063284959, 409.92621328160936, 15127.470538531154, 16465.0, 20941.47646308843, 21099.57800843982, 21157.04793284302, 18802.717959230624, 19664.41006769799, 19954.401367958948, 20639.277625283117, 20982.8459434731, 5907.645541267516, 5912.645241285515, 6141.447269745744, 6233.812985610439, 6234.750609975618, 4243.681723870706, 6115.052166914135, 6232.252129744437, 6237.999999999977, 6239.220097487814, 6024.578279520413, 6627.867442651144, 6839.350261725153, 6904.1714994200765, 6946.861062778741, 6782.982552617123, 6815.454763618948, 6883.8967415488805, 6935.271796461399, 6942.965285173567, 5781.82654520365, 5962.373950735154, 5964.701764911737, 5966.940330596725, 5969.164316995624, 25887.870560647076, 26336.473270534483, 26461.3384665383, 26614.0, 26796.464070718477, 2203.922862699798, 2269.5347453771938, 2271.3980795089315, 2445.3519817248443, 2924.1519959211805, 15711.371545138181, 15755.548829200696, 16286.104264265461, 16444.588885277964, 16475.83524164755, 1883.4161409962956, 1887.3205645967441, 1903.6858918278467, 1922.644310802492, 1988.1550341105117, 125577.0, 128816.0, 129721.0, 131076.0338594922, 131957.3402132993, 10667.626633067805, 10821.0, 11311.321320720619, 11336.886631133582, 11572.59495917639, 14175.078619889675, 14201.85798142026, 14207.857921420653, 14212.573622791333, 14214.796706510508, 6910.550814197161, 8684.95657521721, 8698.608562614698, 8854.424462410052, 8870.334724895529, 8698.173673501007, 8708.608112634947, 8728.869066964, 8891.73324800257, 8897.866532002025, 6771.4582833373215, 6880.105586273752, 6889.724411023503, 6903.620300883399, 6905.413039891666, 1673.0212825496976, 1802.9098545072693, 1883.6515244679504, 1885.679434496139, 1887.0470412441903, 860.3891237221643, 869.8594689278951, 898.9056149104381, 918.6417297254076, 984.2568860510269, 21907.890460547595, 22905.31284061481, 23268.06927722906, 23403.88298058499, 23465.306938612004, 755.8412733326063, 764.6024067484876, 912.3567884641444, 925.5372313843078, 938.5964035464816, 10999.955004274581, 11248.775024499464, 12003.51985920571, 12205.38973051344, 12273.202241854251, 568336.0, 586842.0, 599628.0, 616048.0, 625447.0, 79366.0, 93393.53303233441, 109121.54103053416, 129487.0, 138575.6142438583, 959.7024922273978, 968.4092703450889, 1001.639409812467, 1003.6236411345745, 1005.6681295172575, 16188.190590470194, 18297.26810927548, 18355.990420527, 19106.713399298744, 19147.234110635418, 38146.0, 46785.766071169426, 46895.29657055079, 51542.226866596284, 54762.17856732073, 65478.0, 73754.63122684353, 75691.0, 77617.0, 77802.61098694471, 7015.298470152944, 7901.565413902291, 8076.71731489395, 8142.389320801082, 8322.750317490485, 11945.581904633296, 12643.114981951176, 12845.871541284467, 13044.152130111512, 13109.410076546388, 9161.0, 11274.098072154373, 11337.433128343386, 11348.205625606128, 11372.772544548898, 10863.891361086287, 10864.348139111678, 10938.398388088732, 11077.335359878432, 11426.314421134759, 11331.263467874562, 11468.770624587629, 11470.139739519736, 11533.365664888512, 11536.307821530734, 7286.380657643947, 7628.80927976805, 7921.841563168589, 8276.131006244499, 8305.916940830515, 10330.225233107698, 10943.343399396063, 11301.886981130083, 11346.659600212008, 11375.31748095117], "value": 9839.47583636641, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1535.8694510966568, 1562.1642421304603, 1777.8311060449253, 1898.3640480439053, 1919.8752081114717, 8414.242718155365, 8933.865992010116, 8937.910620893788, 8944.0161582226, 8958.238549723264, 7820.882686759704, 8008.239217274364, 8502.064772874994, 8688.218060374566, 8696.652133914637, 1807.8282563156479, 2358.2453614843216, 2397.3646983549374, 2398.364433425144, 2398.8440751351195, 2358.1982126077132, 2380.976190238093, 2405.518896220754, 2405.8075353971726, 2418.5767490689145, 2373.1812524679044, 2387.913499357788, 2393.6768536247646, 2405.218304051182, 2405.398650337416, 2343.086196383412, 2366.301940927422, 2369.218158007853, 2375.9881200593973, 2394.6288325309606, 2359.893804778789, 2375.8336916415856, 2377.0372998935286, 2380.9880950595134, 2382.6902502674543, 8745.650173993032, 8852.734417967471, 8867.113288671146, 8870.290376769843, 8888.822223555557, 5233.188855727369, 5380.0, 5382.434844341327, 5390.056740070472, 5400.054990376669, 3001.429728351606, 3672.9081772955624, 3695.6489133532273, 3725.9068523286865, 3734.8319325630414, 1092.093562343253, 1100.6367898593444, 1104.5636973395544, 1118.882517335676, 1130.2314426190187, 11673.124515661275, 11761.294322340602, 11786.58746943853, 11788.823167652492, 11806.99640530556, 4550.49944506104, 4650.581447669726, 4829.13075646387, 4847.2729090635985, 4872.585830204473, 9772.951135244279, 9792.020797920293, 9837.508124593742, 9972.650957216463, 10001.49992500372, 5375.220593013991, 5400.810971615974, 5403.675779453245, 5409.621326507186, 5416.458354164552, 4357.215701173819, 4424.358468022118, 4570.223062079454, 4869.756512174448, 4944.777485013111, 3370.342783157261, 3912.941305880414, 3930.9213815723524, 4065.4105154752397, 4094.5700701426517, 1088.2110469909253, 1312.1405479411, 1314.1195399082637, 1326.9004824637998, 1328.249539010456, 808.5552945879742, 825.0439144303081, 903.2954295649273, 926.972190834276, 949.9857502137473, 5815.2149459822385, 5850.8537286567325, 5859.589828712034, 5986.431289027535, 6061.962528039379, 379.8528444098806, 432.5501478462427, 444.05194908869794, 444.18492067056667, 445.0231741327819, 3827.13889374894, 3928.9784655989647, 3965.72239943207, 4070.7354021988476, 4104.445899803548, 8893.688720894737, 10395.116415104801, 10752.978467045617, 10777.892221077846, 10827.187960902964, 10684.732881678021, 10699.73250668724, 10699.83950240747, 10725.356478611307, 10743.194260430499, 8084.7574572762915, 8157.79605509867, 8172.877406838902, 8184.918150818535, 8191.812187232817, 5626.381098079126, 5726.312842458931, 5867.853303667443, 5932.881342373042, 5940.376260492586, 9960.900390995997, 9960.900390996287, 10031.54858031405, 10036.397816131055, 10071.798564028824, 9834.803303934024, 10171.898281017095, 10260.025297596716, 10272.22958278147, 10293.74265643365, 6859.416949559144, 7070.858582828418, 7077.398421134261, 7432.479726419098, 7525.9463675084435, 7888.802779930547, 7975.96312479374, 8023.1976802319305, 8282.751517454486, 8302.252797248277, 7299.8540029200185, 7494.213107623839, 7520.962395187989, 7615.7334493292465, 7658.119316278699, 7288.672009759467, 7288.744893928687, 7378.225286344857, 7414.332710056121, 7439.8140046499275, 6887.173539175331, 7019.649017549, 7020.368166865007, 7022.824429389102, 7044.8591028178125, 4846.345743324606, 4890.193118135468, 4945.2582112683385, 5016.749162541932, 5142.871428214175, 3990.900227494336, 4910.06708725341, 4999.275105109811, 5040.924386134137, 5072.163093089599], "value": 4492.6517314163275, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.55367778848404, 302.76838218762634, 306.91252992897023, 312.49064025638205, 315.98104113753163, 4288.3567464880325, 4526.7962941667665, 5176.818811341604, 5288.545649946262, 5350.170723537848, 4388.407564978727, 4611.492735799059, 4997.950430409618, 5238.292830467885, 5245.632805703603, 3544.8936531904083, 4069.9593004070025, 4074.6943979201606, 4077.857274995376, 4086.8160932758096, 3506.3863823830857, 3543.802842237816, 3938.8030598470104, 4055.918881622366, 4078.7348822326603, 3687.723420743455, 3844.5578758442716, 4038.495188101487, 4043.6158564936286, 4058.289799285128, 3017.290936629879, 4053.581246563679, 4056.8843568018738, 4058.411530328086, 4102.733322334038, 2771.9168424947284, 2914.854257287127, 3084.6144231971, 3532.8341647256602, 3549.378858699743, 4887.778055486128, 5072.568831649314, 5128.102622018548, 5147.073526765181, 5152.278680984665, 4624.953750462486, 4651.976740116312, 4663.114008338439, 4666.32338310943, 4698.718076915396, 4851.369321988154, 5349.652272602308, 5540.750666220029, 5636.0, 5702.6293290935955, 3751.211503847145, 3798.2148390256534, 3868.4777555030273, 3889.7082718796205, 3909.9413508797393, 4360.760158191299, 4597.517260687647, 5595.964746521907, 5807.5063619591965, 5809.7095145242565, 3641.5448068991377, 3783.2622638585763, 3906.847479993409, 3919.510061242345, 3932.07596214895, 3993.780342081155, 4002.7398219115667, 4024.939625905614, 4029.3553031514816, 4047.919041619151, 4308.67684923632, 4617.168909596305, 4651.790669419885, 4653.581177693956, 4661.091087238024, 5356.464353564613, 5753.741081651336, 5774.711264436762, 5819.418058194146, 5851.0, 1159.3391766693073, 1232.8534462949542, 1299.857015728288, 1303.4069498378215, 1334.0994828490923, 765.3226894198674, 771.9231671817895, 806.479820515764, 808.8705807070841, 826.9586520673943, 4329.964916489245, 4357.281048627005, 4364.607185353333, 4394.868153955386, 4407.360932664746, 4143.461350024478, 4307.978460107742, 4311.361682560607, 4831.227003679394, 4900.202343184061, 4570.771461426915, 4901.877453063702, 5305.522502974751, 5311.097113490716, 5407.918881216785, 2538.6065159900245, 3022.259546411143, 3030.3939212157215, 3047.6647568767416, 3082.8766849326225, 4992.726854652041, 6079.544034197453, 6098.573099882966, 6110.083487476914, 6120.846978825565, 6080.422359875804, 6102.633841969496, 6104.359042300494, 6109.20580324555, 6139.171211886427, 5565.749541270652, 6034.336223015464, 6086.3305036446845, 6108.297545782203, 6134.938650613437, 5535.982889325408, 5809.443844708315, 5827.193569993316, 5831.620944638755, 5846.766129354948, 5536.557075434036, 5710.457506536873, 5742.827715168552, 5758.827235182951, 5759.280089988752, 5488.142993450745, 5734.75986067887, 5827.329857066492, 5940.198073260228, 6057.545684073624, 3957.5357117865424, 3992.640662340403, 4013.097053163132, 4019.733783858075, 4041.2321658884716, 5043.949560504348, 5731.5701322400155, 5860.853478663067, 5899.764009439746, 5929.673867937305, 5115.462876397924, 5511.118221084607, 5518.862028449321, 5610.559406658117, 5702.600817942704, 5284.445133260952, 5439.0, 5513.779448822002, 5592.832215033555, 5597.5521958242425, 4856.344393506832, 4971.328870602567, 5200.2199670049795, 5401.432849550741, 5403.648762830403, 5550.500454959073, 5590.161475778503, 5591.692456914909, 5636.323641162922, 5666.688332141772, 4838.346823178967, 5273.709945953009, 5494.752736126804, 5536.944630553643, 5547.389787123494], "value": 4049.4581635660115, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.9536580122295, 751.0724255544403, 762.6491813765667, 771.178694690155, 772.8608850406924, 12233.755324893496, 15438.922805385957, 16013.839861601395, 16014.119223442705, 16195.757063644025, 14420.134791912493, 14736.0, 14739.263036848142, 14767.630809229775, 14910.179940103317, 695.7043256615918, 716.2944499667849, 853.1894700034976, 874.7944233105216, 874.8294082653885, 852.8848605438279, 882.2280504558511, 883.4346018548134, 884.062893333069, 890.1543533643065, 897.7890195804014, 900.1178844732167, 901.4591245252861, 902.8826252587154, 903.7830920579047, 715.0811207598264, 885.4731434796286, 895.6506962284747, 900.1448623807377, 901.6708901251062, 685.4105469296401, 686.2965460403077, 687.0312858868971, 687.656171914043, 688.2429327739496, 14827.703445931022, 14885.776713349309, 14886.213654361438, 14887.553373398816, 14946.775798363033, 13530.18818870871, 13584.588945286006, 13863.376148073361, 13916.791248131287, 14115.929420352935, 12319.59663529935, 12350.691232719164, 12356.62930112098, 12435.875641243561, 12794.168379055332, 4477.552244775529, 4513.52607976161, 4536.302380287876, 4577.542245775429, 4623.0984957933215, 88725.55637221773, 112738.0, 113548.0, 113813.4309328448, 113911.2913306301, 9086.409383390059, 10505.369677819355, 10695.62565310226, 10802.405867677353, 10832.350058996486, 21900.342989710334, 21905.780942190373, 21943.0, 21953.121875124816, 21970.34088977333, 7627.54234745917, 7663.042119735033, 7668.65491052904, 7889.644965976545, 7898.091719452222, 4316.870493885189, 4399.36209249657, 4426.247537918562, 4439.844605438794, 4490.820367185342, 3456.4296891013205, 3560.1989552350515, 3561.928761424757, 3566.358055549974, 3572.035550401429, 642.4218203616689, 642.5245318464302, 651.2543138106936, 668.0713807807152, 669.9464042876558, 509.6967304453844, 535.7803300646716, 600.3996003996004, 606.4844881850391, 615.2463232540102, 8430.578471076422, 8645.870311945326, 8899.599518021705, 8915.28677705782, 8926.68756593516, 537.787573908304, 556.6687820746649, 617.3826173826174, 623.2832242920678, 627.5105417774143, 4123.525794533667, 4300.91398172041, 4325.956740432618, 4342.696011279243, 4362.716423432466, 132550.0, 143597.76826780854, 155710.0, 155766.0, 157454.0, 125458.0, 126746.36626816807, 127930.0, 128259.35870320589, 130305.0, 110367.0, 112025.87974120154, 112444.0, 113270.0, 113630.0, 8279.751607451786, 8285.792855178668, 8385.454945428528, 8398.916010839814, 8612.61243244043, 58160.70919645375, 58539.0, 61125.08312375229, 61997.380026199164, 62566.435839104386, 78524.21475785397, 88387.0, 94232.52883735538, 95779.0, 96033.0, 11308.151888608552, 11370.43147842588, 11501.0, 11815.172937894265, 11843.763124737628, 12088.274703517465, 12177.147599668293, 12352.814707779211, 12605.74788504243, 12610.43253053633, 11643.76712465729, 11651.59219427316, 11789.41052947332, 11803.763924721628, 12185.69535761613, 10533.4733263335, 10937.0, 11411.315321080761, 11481.368524730886, 11846.170768046153, 9195.494247816434, 11294.378809165575, 11351.0, 11468.770624587294, 11850.703732406759, 9856.704298871045, 9938.254630902567, 10059.446730429896, 10097.949510252402, 10128.442935638315, 7823.178566250689, 8296.83406331858, 9016.323775716717, 9372.34393592442, 9725.708228753148], "value": 7514.250778926868, "unit": "score"}], "name": "dromaeo_css", "value": 7351.824073282863, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 117.0, 110.0, 114.0, 148.0, 163.0, 147.0, 114.0, 124.0], "value": 126.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 144.0, 119.0, 172.0, 102.0, 151.0, 159.0, 92.0, 181.0, 135.0], "value": 142.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 187.0, 184.0, 185.0, 182.0, 256.0, 203.0, 181.0, 179.0], "value": 192.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 73.0, 77.0, 155.0, 57.0, 57.0, 60.0, 80.0, 160.0, 67.0], "value": 86.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 135.0, 70.0, 72.0, 74.0, 119.0, 68.0, 70.0, 118.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 89.0, 85.0, 88.0, 84.0, 87.0, 85.0, 88.0, 84.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 93.0, 95.0, 94.0, 93.0, 94.0, 93.0], "value": 93.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 83.0, 86.0, 83.0, 85.0, 87.0, 83.0, 86.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 52.0, 51.0, 55.0, 55.0, 56.0, 55.0, 52.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 72.0, 71.0, 83.0, 74.0, 70.0, 69.0, 70.0, 72.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 98.0, 105.0, 105.0, 80.0, 85.0, 86.0, 86.0, 88.0], "value": 90.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 141.0, 138.0, 139.0, 146.0, 160.0, 141.0, 140.0, 196.0, 157.0], "value": 149.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 171.0, 169.0, 167.0, 172.0, 168.0, 185.0, 234.0, 185.0], "value": 179.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 70.0, 66.0, 93.0, 68.0, 67.0, 68.0, 66.0, 67.0], "value": 69.8, "unit": "score"}], "name": "kraken", "value": 1516.6999999999998, "alertThreshold": 2.0}]} 08:09:16 INFO - Return code: 0 08:09:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:09:17 INFO - # TBPL SUCCESS # 08:09:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:09:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:09:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:09:17 INFO - 2016-09-07 08:09:17.044 screenresolution[1676:11002] starting screenresolution argv=screenresolution get 08:09:17 INFO - 2016-09-07 08:09:17.046 screenresolution[1676:11002] Display 0: 1600x1200x32@60 08:09:17 INFO - 2016-09-07 08:09:17.053 screenresolution[1677:11004] starting screenresolution argv=screenresolution list 08:09:17 INFO - Available Modes on Display 0 08:09:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:09:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:09:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:09:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:09:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:09:17 INFO - Intel Iris: 08:09:17 INFO - Chipset Model: Intel Iris 08:09:17 INFO - Type: GPU 08:09:17 INFO - Bus: Built-In 08:09:17 INFO - VRAM (Dynamic, Max): 1536 MB 08:09:17 INFO - Vendor: Intel (0x8086) 08:09:17 INFO - Device ID: 0x0a2e 08:09:17 INFO - Revision ID: 0x0009 08:09:17 INFO - Displays: 08:09:17 INFO - Display: 08:09:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:09:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:09:17 INFO - Display Serial Number: 1600x1200 60 08:09:17 INFO - Main Display: Yes 08:09:17 INFO - Mirror: Off 08:09:17 INFO - Online: Yes 08:09:17 INFO - Rotation: Supported 08:09:17 INFO - Return code: 0 08:09:17 INFO - Running post-action listener: _resource_record_post_action 08:09:17 INFO - [mozharness: 2016-09-07 15:09:17.288454Z] Finished run-tests step (success) 08:09:17 INFO - Running post-run listener: _resource_record_post_run 08:09:17 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 32734208; Write bytes: 705857024; Read time: 324; Write time: 1939 08:09:17 INFO - TinderboxPrint: CPU usage
53.5% 08:09:17 INFO - TinderboxPrint: I/O read bytes / time
32,734,208 / 324 08:09:17 INFO - TinderboxPrint: I/O write bytes / time
705,857,024 / 1,939 08:09:17 INFO - TinderboxPrint: CPU idle
2,256.9 (46.5%) 08:09:17 INFO - TinderboxPrint: CPU system
964.1 (19.9%) 08:09:17 INFO - TinderboxPrint: CPU user
1,628.6 (33.6%) 08:09:17 INFO - TinderboxPrint: Swap in / out
434,827,264 / 0 08:09:17 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 400413184; Write bytes: 394749440; Read time: 29854; Write time: 764 08:09:17 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 30661632; Write bytes: 296304640; Read time: 301; Write time: 1141 08:09:17 INFO - Running post-run listener: _upload_blobber_files 08:09:17 INFO - Blob upload gear active. 08:09:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:09:17 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 08:09:17 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:09:17 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:09:18 INFO - (blobuploader) - INFO - Open directory for files ... 08:09:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:09:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:09:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:09:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:09:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:09:19 INFO - (blobuploader) - INFO - Done attempting. 08:09:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:09:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:09:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:09:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:09:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:09:20 INFO - (blobuploader) - INFO - Done attempting. 08:09:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:09:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:09:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:09:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:09:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:09:22 INFO - (blobuploader) - INFO - Done attempting. 08:09:22 INFO - (blobuploader) - INFO - Iteration through files over. 08:09:22 INFO - Return code: 0 08:09:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:09:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:09:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9f218bdcc36f760995c34b8b1654fcc9a52d733b0fdfca04ca7af8a56c3e0892ca39ce0b06327b2e0f4f95d171a7aed060eb1c2b0233cbbd4f51ad4cc271e28d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a6d5d1177ce8fda310d744a24dfd8d710cf52ceaa445e4edb2718767e8a4cfae665b05e5834615f0f7487d94f4034ad9808c80d39a01a5534e8b75fd81465f93", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/08e8b7c49dbb31f10bfb48b80dea5e15fba86ad2376d6207483d279b849c0e3ec16bd888044268fd5ba60906ed24fda785cebea307f590aa82f22c93f38e91b8"} 08:09:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:09:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:09:22 INFO - Contents: 08:09:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9f218bdcc36f760995c34b8b1654fcc9a52d733b0fdfca04ca7af8a56c3e0892ca39ce0b06327b2e0f4f95d171a7aed060eb1c2b0233cbbd4f51ad4cc271e28d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a6d5d1177ce8fda310d744a24dfd8d710cf52ceaa445e4edb2718767e8a4cfae665b05e5834615f0f7487d94f4034ad9808c80d39a01a5534e8b75fd81465f93", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/08e8b7c49dbb31f10bfb48b80dea5e15fba86ad2376d6207483d279b849c0e3ec16bd888044268fd5ba60906ed24fda785cebea307f590aa82f22c93f38e91b8"} 08:09:22 INFO - Running post-run listener: copy_logs_to_upload_dir 08:09:22 INFO - Copying logs to upload dir... 08:09:22 INFO - mkdir: /builds/slave/test/build/upload/logs 08:09:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.765341 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-07 08:09:22.587866) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-07 08:09:22.591222) ========= 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.TpiQ3JIMCh/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.ulLWCjBUcl/Listeners TMPDIR=/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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/Autoland/sha512/9f218bdcc36f760995c34b8b1654fcc9a52d733b0fdfca04ca7af8a56c3e0892ca39ce0b06327b2e0f4f95d171a7aed060eb1c2b0233cbbd4f51ad4cc271e28d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a6d5d1177ce8fda310d744a24dfd8d710cf52ceaa445e4edb2718767e8a4cfae665b05e5834615f0f7487d94f4034ad9808c80d39a01a5534e8b75fd81465f93", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/08e8b7c49dbb31f10bfb48b80dea5e15fba86ad2376d6207483d279b849c0e3ec16bd888044268fd5ba60906ed24fda785cebea307f590aa82f22c93f38e91b8"} build_url:https://queue.taskcluster.net/v1/task/CnKSNF00T8KO8V_ml5ia1Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010781 build_url: 'https://queue.taskcluster.net/v1/task/CnKSNF00T8KO8V_ml5ia1Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9f218bdcc36f760995c34b8b1654fcc9a52d733b0fdfca04ca7af8a56c3e0892ca39ce0b06327b2e0f4f95d171a7aed060eb1c2b0233cbbd4f51ad4cc271e28d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a6d5d1177ce8fda310d744a24dfd8d710cf52ceaa445e4edb2718767e8a4cfae665b05e5834615f0f7487d94f4034ad9808c80d39a01a5534e8b75fd81465f93", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/08e8b7c49dbb31f10bfb48b80dea5e15fba86ad2376d6207483d279b849c0e3ec16bd888044268fd5ba60906ed24fda785cebea307f590aa82f22c93f38e91b8"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-07 08:09:22.635460) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 08:09:22.635811) ========= 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.TpiQ3JIMCh/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.ulLWCjBUcl/Listeners TMPDIR=/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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.005151 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 08:09:22.690975) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-07 08:09:22.691942) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-07 08:09:22.692564) ========= ========= Total master_lag: 0.21 =========