builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0147 starttime: 1467244951.59 results: success (0) buildid: 20160629150227 builduid: e7e8e743a1f84dd494aee6616e70cd3d revision: b6ad395da0e5c99a4f4b6a5554d7df03a047393b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 17:02:31.592556) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 17:02:31.593076) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 17:02:31.593418) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 17:02:31.619486) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 17:02:31.620229) ========= 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.IzFGrTPJW1/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.vJCPSeP8DI/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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-06-29 17:02:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 81.0M=0s 2016-06-29 17:02:31 (81.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084231 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 17:02:31.732345) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 17:02:31.733103) ========= 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.IzFGrTPJW1/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.vJCPSeP8DI/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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.020458 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 17:02:31.784681) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-29 17:02:31.785073) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b6ad395da0e5c99a4f4b6a5554d7df03a047393b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b6ad395da0e5c99a4f4b6a5554d7df03a047393b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IzFGrTPJW1/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.vJCPSeP8DI/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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-06-29 17:02:31,855 truncating revision to first 12 chars 2016-06-29 17:02:31,855 Setting DEBUG logging. 2016-06-29 17:02:31,855 attempt 1/10 2016-06-29 17:02:31,855 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b6ad395da0e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 17:02:32,615 unpacking tar archive at: fx-team-b6ad395da0e5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.044779 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-29 17:02:32.856764) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 17:02:32.857616) ========= script_repo_revision: b6ad395da0e5c99a4f4b6a5554d7df03a047393b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 17:02:32.858158) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 17:02:32.858517) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 17:02:32.878747) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-06-29 17:02:32.879534) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IzFGrTPJW1/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.vJCPSeP8DI/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 17:02:33 INFO - MultiFileLogger online at 20160629 17:02:33 in /builds/slave/test 17:02:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:02:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:02:33 INFO - {'append_to_log': False, 17:02:33 INFO - 'base_work_dir': '/builds/slave/test', 17:02:33 INFO - 'blob_upload_branch': 'Fx-Team', 17:02:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:02:33 INFO - 'branch': 'Fx-Team', 17:02:33 INFO - 'buildbot_json_path': 'buildprops.json', 17:02:33 INFO - 'config_files': ('talos/mac_config.py',), 17:02:33 INFO - 'default_actions': ('clobber', 17:02:33 INFO - 'read-buildbot-config', 17:02:33 INFO - 'download-and-extract', 17:02:33 INFO - 'populate-webroot', 17:02:33 INFO - 'create-virtualenv', 17:02:33 INFO - 'install', 17:02:33 INFO - 'run-tests'), 17:02:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:02:33 INFO - 'download_minidump_stackwalk': True, 17:02:33 INFO - 'download_symbols': 'ondemand', 17:02:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:02:33 INFO - 'tooltool.py': '/tools/tooltool.py', 17:02:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:02:33 INFO - '/tools/misc-python/virtualenv.py')}, 17:02:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:02:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:02:33 INFO - 'installer_path': 'installer.exe', 17:02:33 INFO - 'log_level': 'info', 17:02:33 INFO - 'log_name': 'talos', 17:02:33 INFO - 'log_to_console': True, 17:02:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:02:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:02:33 INFO - 'opt_config_files': (), 17:02:33 INFO - 'pip_index': False, 17:02:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:02:33 INFO - 'cmd': ('bash', 17:02:33 INFO - '-c', 17:02:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:02:33 INFO - 'enabled': True, 17:02:33 INFO - 'halt_on_failure': False, 17:02:33 INFO - 'name': 'check_screen_resolution'},), 17:02:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:02:33 INFO - 'cmd': ('bash', 17:02:33 INFO - '-c', 17:02:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:02:33 INFO - 'enabled': True, 17:02:33 INFO - 'halt_on_failure': False, 17:02:33 INFO - 'name': 'check_screen_resolution'},), 17:02:33 INFO - 'run_cmd_checks_enabled': True, 17:02:33 INFO - 'sps_profile': False, 17:02:33 INFO - 'sps_profile_interval': 0, 17:02:33 INFO - 'suite': 'dromaeojs-e10s', 17:02:33 INFO - 'system_bits': '32', 17:02:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:02:33 INFO - 'title': 't-yosemite-r7-0147', 17:02:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:02:33 INFO - 'use_talos_json': True, 17:02:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:02:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:02:33 INFO - 'work_dir': 'build'} 17:02:33 INFO - ##### 17:02:33 INFO - ##### Running clobber step. 17:02:33 INFO - ##### 17:02:33 INFO - Running pre-action listener: _resource_record_pre_action 17:02:33 INFO - Running main action method: clobber 17:02:33 INFO - rmtree: /builds/slave/test/build 17:02:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:02:34 INFO - Running post-action listener: _resource_record_post_action 17:02:34 INFO - ##### 17:02:34 INFO - ##### Finished clobber step (success) 17:02:34 INFO - ##### 17:02:34 INFO - ##### 17:02:34 INFO - ##### Running read-buildbot-config step. 17:02:34 INFO - ##### 17:02:34 INFO - Running pre-action listener: _resource_record_pre_action 17:02:34 INFO - Running main action method: read_buildbot_config 17:02:34 INFO - Using buildbot properties: 17:02:34 INFO - { 17:02:34 INFO - "project": "", 17:02:34 INFO - "product": "firefox", 17:02:34 INFO - "script_repo_revision": "production", 17:02:34 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 17:02:34 INFO - "repository": "", 17:02:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 17:02:34 INFO - "buildid": "20160629150227", 17:02:34 INFO - "pgo_build": "False", 17:02:34 INFO - "basedir": "/builds/slave/test", 17:02:34 INFO - "buildnumber": 62, 17:02:34 INFO - "slavename": "t-yosemite-r7-0147", 17:02:34 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 17:02:34 INFO - "platform": "yosemite_r7", 17:02:34 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 17:02:34 INFO - "branch": "fx-team", 17:02:34 INFO - "repo_path": "integration/fx-team", 17:02:34 INFO - "revision": "b6ad395da0e5c99a4f4b6a5554d7df03a047393b", 17:02:34 INFO - "stage_platform": "macosx64", 17:02:34 INFO - "builduid": "e7e8e743a1f84dd494aee6616e70cd3d", 17:02:34 INFO - "slavebuilddir": "test" 17:02:34 INFO - } 17:02:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 17:02:34 INFO - Running post-action listener: _resource_record_post_action 17:02:34 INFO - ##### 17:02:34 INFO - ##### Finished read-buildbot-config step (success) 17:02:34 INFO - ##### 17:02:34 INFO - ##### 17:02:34 INFO - ##### Running download-and-extract step. 17:02:34 INFO - ##### 17:02:34 INFO - Running pre-action listener: _resource_record_pre_action 17:02:34 INFO - Running main action method: download_and_extract 17:02:34 INFO - mkdir: /builds/slave/test/build/tests 17:02:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:34 INFO - https://queue.taskcluster.net/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:02:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 17:02:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 17:02:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 17:02:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 17:02:36 INFO - Downloaded 1199 bytes. 17:02:36 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 17:02:36 INFO - Using the following test package requirements: 17:02:36 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 17:02:36 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:02:36 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 17:02:36 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:02:36 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 17:02:36 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:02:36 INFO - u'jsshell-mac.zip'], 17:02:36 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:02:36 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 17:02:36 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 17:02:36 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:02:36 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 17:02:36 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:02:36 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 17:02:36 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:02:36 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 17:02:36 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:02:36 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 17:02:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:36 INFO - https://queue.taskcluster.net/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:02:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 17:02:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 17:02:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 17:02:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:02:40 INFO - Downloaded 18788457 bytes. 17:02:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:02:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:02:44 INFO - Return code: 0 17:02:44 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:44 INFO - https://queue.taskcluster.net/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:02:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 17:02:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 17:02:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 17:02:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:02:45 INFO - Downloaded 18788457 bytes. 17:02:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:02:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:02:48 INFO - Return code: 0 17:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:48 INFO - https://queue.taskcluster.net/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:02:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 17:02:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 17:02:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 17:02:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:02:50 INFO - Downloaded 14405245 bytes. 17:02:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:02:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 17:02:50 INFO - Return code: 0 17:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:50 INFO - https://queue.taskcluster.net/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:02:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 17:02:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 17:02:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 17:02:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 17:02:53 INFO - Downloaded 112468300 bytes. 17:02:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 17:02:53 INFO - mkdir: /builds/slave/test/properties 17:02:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:02:53 INFO - Writing to file /builds/slave/test/properties/build_url 17:02:53 INFO - Contents: 17:02:53 INFO - build_url:https://queue.taskcluster.net/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 17:02:55 INFO - Running post-action listener: _resource_record_post_action 17:02:55 INFO - Running post-action listener: set_extra_try_arguments 17:02:55 INFO - ##### 17:02:55 INFO - ##### Finished download-and-extract step (success) 17:02:55 INFO - ##### 17:02:55 INFO - ##### 17:02:55 INFO - ##### Running populate-webroot step. 17:02:55 INFO - ##### 17:02:55 INFO - Running pre-action listener: _resource_record_pre_action 17:02:55 INFO - Running main action method: populate_webroot 17:02:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:02:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:02:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:02:55 INFO - '--tppagecycles', 17:02:55 INFO - '7'], 17:02:55 INFO - 'tests': ['tsvgm']}}, 17:02:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:02:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:02:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:02:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:02:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:02:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:02:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:55 INFO - 'talos_options': ['--disable-e10s'], 17:02:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:02:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:02:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:55 INFO - 'talos_options': ['--disable-e10s'], 17:02:55 INFO - 'tests': ['damp', 'tps']}, 17:02:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:55 INFO - 'tests': ['damp', 'tps']}, 17:02:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:02:55 INFO - 'tests': ['dromaeo_dom']}, 17:02:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:02:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:02:55 INFO - 'tests': ['basic_compositor_video']}, 17:02:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:02:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:02:55 INFO - 'tests': ['a11yr', 17:02:55 INFO - 'ts_paint', 17:02:55 INFO - 'tpaint', 17:02:55 INFO - 'sessionrestore', 17:02:55 INFO - 'sessionrestore_no_auto_restore', 17:02:55 INFO - 'tabpaint']}, 17:02:55 INFO - 'other-e10s': {'tests': ['a11yr', 17:02:55 INFO - 'ts_paint', 17:02:55 INFO - 'tpaint', 17:02:55 INFO - 'sessionrestore', 17:02:55 INFO - 'sessionrestore_no_auto_restore', 17:02:55 INFO - 'tabpaint']}, 17:02:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:02:55 INFO - 'ts_paint', 17:02:55 INFO - 'tpaint', 17:02:55 INFO - 'sessionrestore', 17:02:55 INFO - 'sessionrestore_no_auto_restore', 17:02:55 INFO - 'tabpaint']}, 17:02:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:02:55 INFO - 'ts_paint', 17:02:55 INFO - 'tpaint', 17:02:55 INFO - 'sessionrestore', 17:02:55 INFO - 'sessionrestore_no_auto_restore', 17:02:55 INFO - 'tabpaint']}, 17:02:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:02:55 INFO - 'tests': ['a11yr', 17:02:55 INFO - 'ts_paint', 17:02:55 INFO - 'tpaint', 17:02:55 INFO - 'sessionrestore', 17:02:55 INFO - 'sessionrestore_no_auto_restore', 17:02:55 INFO - 'tabpaint']}, 17:02:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:02:55 INFO - 'tests': ['a11yr', 17:02:55 INFO - 'ts_paint', 17:02:55 INFO - 'tpaint', 17:02:55 INFO - 'sessionrestore', 17:02:55 INFO - 'sessionrestore_no_auto_restore', 17:02:55 INFO - 'tabpaint']}, 17:02:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:02:55 INFO - 'tests': ['tsvgx', 17:02:55 INFO - 'tsvgr_opacity', 17:02:55 INFO - 'tart', 17:02:55 INFO - 'tscrollx', 17:02:55 INFO - 'cart']}, 17:02:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:02:55 INFO - 'tsvgr_opacity', 17:02:55 INFO - 'tart', 17:02:55 INFO - 'tscrollx', 17:02:55 INFO - 'cart']}, 17:02:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:55 INFO - 'talos_options': ['--disable-e10s'], 17:02:55 INFO - 'tests': ['tp5o']}, 17:02:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:55 INFO - 'tests': ['tp5o']}, 17:02:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:55 INFO - 'talos_options': ['--disable-e10s', 17:02:55 INFO - '--xperf_path', 17:02:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:02:55 INFO - 'tests': ['tp5n']}, 17:02:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:55 INFO - 'talos_options': ['--xperf_path', 17:02:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:02:55 INFO - 'tests': ['tp5n']}}, 17:02:55 INFO - 'talos.zip': {'path': '', 17:02:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:02:55 INFO - Running post-action listener: _resource_record_post_action 17:02:55 INFO - ##### 17:02:55 INFO - ##### Finished populate-webroot step (success) 17:02:55 INFO - ##### 17:02:55 INFO - ##### 17:02:55 INFO - ##### Running create-virtualenv step. 17:02:55 INFO - ##### 17:02:55 INFO - Running pre-action listener: _resource_record_pre_action 17:02:55 INFO - Running main action method: create_virtualenv 17:02:55 INFO - Creating virtualenv /builds/slave/test/build/venv 17:02:55 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 17:02:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:02:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:02:55 INFO - Using real prefix '/tools/python27' 17:02:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:02:55 INFO - Installing distribute.............................................................................................................................................................................................done. 17:02:58 INFO - Installing pip.................done. 17:02:58 INFO - Return code: 0 17:02:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:02: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:58 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 0x10e5a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e639618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d8857fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e508d30>, '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 0x10e26ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e500b20>, '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.IzFGrTPJW1/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.vJCPSeP8DI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 17:02:58 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 17:02:58 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 17:02:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IzFGrTPJW1/Render', 17:02:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:02:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:02:58 INFO - 'HOME': '/Users/cltbld', 17:02:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:02:58 INFO - 'LOGNAME': 'cltbld', 17:02:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:58 INFO - 'MOZ_NO_REMOTE': '1', 17:02:58 INFO - 'NO_EM_RESTART': '1', 17:02:58 INFO - 'PAGER': '/bin/cat', 17:02:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:02:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:58 INFO - 'PWD': '/builds/slave/test', 17:02:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:02:58 INFO - 'SHELL': '/bin/bash', 17:02:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vJCPSeP8DI/Listeners', 17:02:58 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 17:02:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:02:58 INFO - 'USER': 'cltbld', 17:02:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:02:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:02:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:58 INFO - 'XPC_FLAGS': '0x0', 17:02:58 INFO - 'XPC_SERVICE_NAME': '0', 17:02:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:02:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:58 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 17:02:58 INFO - Cleaning up... 17:02:58 INFO - Return code: 0 17:02:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:02: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:58 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 0x10e5a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e639618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d8857fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e508d30>, '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 0x10e26ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e500b20>, '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.IzFGrTPJW1/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.vJCPSeP8DI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 17:02:58 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 17:02:58 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 17:02:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IzFGrTPJW1/Render', 17:02:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:02:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:02:58 INFO - 'HOME': '/Users/cltbld', 17:02:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:02:58 INFO - 'LOGNAME': 'cltbld', 17:02:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:58 INFO - 'MOZ_NO_REMOTE': '1', 17:02:58 INFO - 'NO_EM_RESTART': '1', 17:02:58 INFO - 'PAGER': '/bin/cat', 17:02:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:02:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:58 INFO - 'PWD': '/builds/slave/test', 17:02:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:02:58 INFO - 'SHELL': '/bin/bash', 17:02:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vJCPSeP8DI/Listeners', 17:02:58 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 17:02:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:02:58 INFO - 'USER': 'cltbld', 17:02:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:02:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:02:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:58 INFO - 'XPC_FLAGS': '0x0', 17:02:58 INFO - 'XPC_SERVICE_NAME': '0', 17:02:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:59 INFO - Downloading/unpacking psutil>=3.1.1 17:02:59 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 17:02:59 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 17:02:59 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 17:02:59 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 17:02:59 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 17:02:59 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 17:03:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:03:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:03:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:03:01 INFO - Installing collected packages: psutil 17:03:01 INFO - Running setup.py install for psutil 17:03:01 INFO - building 'psutil._psutil_osx' extension 17:03:01 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 17:03:02 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 17:03:02 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 17:03:02 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 17:03:02 INFO - building 'psutil._psutil_posix' extension 17:03:02 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 17:03:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:03:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:03:02 INFO - ^ 17:03:02 INFO - 1 warning generated. 17:03:02 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 17:03:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:03:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:03:02 INFO - Successfully installed psutil 17:03:02 INFO - Cleaning up... 17:03:02 INFO - Return code: 0 17:03:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:02 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 0x10e5a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e639618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d8857fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e508d30>, '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 0x10e26ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e500b20>, '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.IzFGrTPJW1/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.vJCPSeP8DI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 17:03:02 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 17:03:02 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 17:03:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IzFGrTPJW1/Render', 17:03:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:03:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:03:02 INFO - 'HOME': '/Users/cltbld', 17:03:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:03:02 INFO - 'LOGNAME': 'cltbld', 17:03:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:02 INFO - 'MOZ_NO_REMOTE': '1', 17:03:02 INFO - 'NO_EM_RESTART': '1', 17:03:02 INFO - 'PAGER': '/bin/cat', 17:03:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:03:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:02 INFO - 'PWD': '/builds/slave/test', 17:03:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:03:02 INFO - 'SHELL': '/bin/bash', 17:03:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vJCPSeP8DI/Listeners', 17:03:02 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 17:03:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:03:02 INFO - 'USER': 'cltbld', 17:03:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:03:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:03:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:02 INFO - 'XPC_FLAGS': '0x0', 17:03:02 INFO - 'XPC_SERVICE_NAME': '0', 17:03:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:03:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:03:03 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 17:03:03 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 17:03:03 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 17:03:03 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 17:03:03 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 17:03:03 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 17:03:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:03:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:03:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:03:05 INFO - Installing collected packages: mozsystemmonitor 17:03:05 INFO - Running setup.py install for mozsystemmonitor 17:03:05 INFO - Successfully installed mozsystemmonitor 17:03:05 INFO - Cleaning up... 17:03:05 INFO - Return code: 0 17:03:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:05 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 0x10e5a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e639618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d8857fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e508d30>, '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 0x10e26ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e500b20>, '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.IzFGrTPJW1/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.vJCPSeP8DI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 17:03:05 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 17:03:05 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 17:03:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IzFGrTPJW1/Render', 17:03:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:03:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:03:05 INFO - 'HOME': '/Users/cltbld', 17:03:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:03:05 INFO - 'LOGNAME': 'cltbld', 17:03:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:05 INFO - 'MOZ_NO_REMOTE': '1', 17:03:05 INFO - 'NO_EM_RESTART': '1', 17:03:05 INFO - 'PAGER': '/bin/cat', 17:03:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:03:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:05 INFO - 'PWD': '/builds/slave/test', 17:03:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:03:05 INFO - 'SHELL': '/bin/bash', 17:03:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vJCPSeP8DI/Listeners', 17:03:05 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 17:03:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:03:05 INFO - 'USER': 'cltbld', 17:03:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:03:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:03:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:05 INFO - 'XPC_FLAGS': '0x0', 17:03:05 INFO - 'XPC_SERVICE_NAME': '0', 17:03:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:06 INFO - Downloading/unpacking jsonschema==2.5.1 17:03:06 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 17:03:06 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 17:03:06 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 17:03:06 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 17:03:06 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 17:03:06 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 17:03:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:03:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:03:08 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 17:03:08 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 17:03:08 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 17:03:08 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 17:03:08 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 17:03:08 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 17:03:08 INFO - Downloading functools32-3.2.3-2.tar.gz 17:03:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:03:08 INFO - warning: no files found matching '*.txt' 17:03:08 INFO - no previously-included directories found matching 'build' 17:03:08 INFO - no previously-included directories found matching 'dist' 17:03:08 INFO - no previously-included directories found matching '.git*' 17:03:08 INFO - Installing collected packages: jsonschema, functools32 17:03:09 INFO - Running setup.py install for functools32 17:03:09 INFO - warning: no files found matching '*.txt' 17:03:09 INFO - no previously-included directories found matching 'build' 17:03:09 INFO - no previously-included directories found matching 'dist' 17:03:09 INFO - no previously-included directories found matching '.git*' 17:03:09 INFO - Successfully installed jsonschema functools32 17:03:09 INFO - Cleaning up... 17:03:09 INFO - Return code: 0 17:03:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:09 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 0x10e5a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e639618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d8857fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e508d30>, '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 0x10e26ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e500b20>, '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.IzFGrTPJW1/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.vJCPSeP8DI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 17:03:09 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 17:03:09 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 17:03:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IzFGrTPJW1/Render', 17:03:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:03:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:03:09 INFO - 'HOME': '/Users/cltbld', 17:03:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:03:09 INFO - 'LOGNAME': 'cltbld', 17:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:09 INFO - 'MOZ_NO_REMOTE': '1', 17:03:09 INFO - 'NO_EM_RESTART': '1', 17:03:09 INFO - 'PAGER': '/bin/cat', 17:03:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:09 INFO - 'PWD': '/builds/slave/test', 17:03:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:03:09 INFO - 'SHELL': '/bin/bash', 17:03:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vJCPSeP8DI/Listeners', 17:03:09 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 17:03:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:03:09 INFO - 'USER': 'cltbld', 17:03:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:03:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:09 INFO - 'XPC_FLAGS': '0x0', 17:03:09 INFO - 'XPC_SERVICE_NAME': '0', 17:03:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:09 INFO - Downloading/unpacking blobuploader==1.2.4 17:03:09 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 17:03:09 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 17:03:09 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 17:03:09 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 17:03:09 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 17:03:09 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 17:03:11 INFO - Downloading blobuploader-1.2.4.tar.gz 17:03:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:03:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:03:12 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 17:03:12 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 17:03:12 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 17:03:12 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 17:03:12 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 17:03:12 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 17:03:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:03:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:03:12 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 17:03:12 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 17:03:12 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 17:03:12 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 17:03:12 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 17:03:12 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 17:03:13 INFO - Downloading docopt-0.6.1.tar.gz 17:03:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:03:13 INFO - Installing collected packages: blobuploader, requests, docopt 17:03:13 INFO - Running setup.py install for blobuploader 17:03:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:03:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:03:13 INFO - Running setup.py install for requests 17:03:13 INFO - Running setup.py install for docopt 17:03:14 INFO - Successfully installed blobuploader requests docopt 17:03:14 INFO - Cleaning up... 17:03:14 INFO - Return code: 0 17:03:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:03:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:14 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 0x10e5a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e639618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d8857fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e508d30>, '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 0x10e26ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e500b20>, '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.IzFGrTPJW1/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.vJCPSeP8DI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 17:03:14 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 17:03:14 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 17:03:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IzFGrTPJW1/Render', 17:03:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:03:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:03:14 INFO - 'HOME': '/Users/cltbld', 17:03:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:03:14 INFO - 'LOGNAME': 'cltbld', 17:03:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:14 INFO - 'MOZ_NO_REMOTE': '1', 17:03:14 INFO - 'NO_EM_RESTART': '1', 17:03:14 INFO - 'PAGER': '/bin/cat', 17:03:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:03:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:14 INFO - 'PWD': '/builds/slave/test', 17:03:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:03:14 INFO - 'SHELL': '/bin/bash', 17:03:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vJCPSeP8DI/Listeners', 17:03:14 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 17:03:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:03:14 INFO - 'USER': 'cltbld', 17:03:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:03:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:03:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:14 INFO - 'XPC_FLAGS': '0x0', 17:03:14 INFO - 'XPC_SERVICE_NAME': '0', 17:03:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:03:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:03:14 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-QV_HVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:03:14 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-OHJZY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:03:14 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-bFftUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:03:14 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-U2FUsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:03:14 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-ODEd62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:03:14 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-wD7CCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:03:15 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-pFeQiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:03:15 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-7mGlEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:03:15 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-9URG4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:03:15 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-dZLXij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:03:15 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-PFYeEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:03:15 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-Vrh82O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:03:15 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-c01in3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:03:15 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-4oaVPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:03:15 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-8XiGeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:03:15 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-x7SkQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:03:16 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-hilnvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:03:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:03:16 INFO - Running setup.py install for manifestparser 17:03:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:03:16 INFO - Running setup.py install for mozcrash 17:03:16 INFO - Running setup.py install for mozdebug 17:03:16 INFO - Running setup.py install for mozdevice 17:03:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:03:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:03:16 INFO - Running setup.py install for mozfile 17:03:16 INFO - Running setup.py install for mozhttpd 17:03:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:03:17 INFO - Running setup.py install for mozinfo 17:03:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:03:17 INFO - Running setup.py install for mozInstall 17:03:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:03:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:03:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:03:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:03:17 INFO - Running setup.py install for mozleak 17:03:17 INFO - Running setup.py install for mozlog 17:03:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:03:17 INFO - Running setup.py install for moznetwork 17:03:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:03:17 INFO - Running setup.py install for mozprocess 17:03:17 INFO - Running setup.py install for mozprofile 17:03:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:03:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:03:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:03:18 INFO - Running setup.py install for mozrunner 17:03:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:03:18 INFO - Running setup.py install for mozscreenshot 17:03:18 INFO - Running setup.py install for moztest 17:03:18 INFO - Running setup.py install for mozversion 17:03:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:03:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:03:18 INFO - Cleaning up... 17:03:18 INFO - Return code: 0 17:03:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:03:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:18 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 0x10e5a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e639618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d8857fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e508d30>, '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 0x10e26ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e500b20>, '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.IzFGrTPJW1/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.vJCPSeP8DI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 17:03:18 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 17:03:18 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 17:03:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IzFGrTPJW1/Render', 17:03:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:03:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:03:18 INFO - 'HOME': '/Users/cltbld', 17:03:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:03:18 INFO - 'LOGNAME': 'cltbld', 17:03:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:18 INFO - 'MOZ_NO_REMOTE': '1', 17:03:18 INFO - 'NO_EM_RESTART': '1', 17:03:18 INFO - 'PAGER': '/bin/cat', 17:03:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:03:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:18 INFO - 'PWD': '/builds/slave/test', 17:03:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:03:18 INFO - 'SHELL': '/bin/bash', 17:03:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vJCPSeP8DI/Listeners', 17:03:18 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 17:03:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:03:18 INFO - 'USER': 'cltbld', 17:03:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:03:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:03:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:18 INFO - 'XPC_FLAGS': '0x0', 17:03:18 INFO - 'XPC_SERVICE_NAME': '0', 17:03:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:03:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:03:19 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-_8u8WM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:03:19 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)) 17:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:03:19 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-2ssCUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:03:19 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)) 17:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:03:19 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-0vNVMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:03:19 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)) 17:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:03:19 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-ouUUX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:03:19 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)) 17:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:03:19 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-jAuB9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:03:19 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)) 17:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:03:19 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-I0WGc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:03:19 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)) 17:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:03:19 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-w6bPNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:03:19 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)) 17:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:03:19 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-MDAfV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:03:19 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)) 17:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:03:19 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-Z4psqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:03:19 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)) 17:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:03:19 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-EikEMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:03:20 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-4ALL1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:03:20 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)) 17:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:03:20 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-EE0gef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:03:20 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-OgbCGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:03:20 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)) 17:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:03:20 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-warNjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:03:20 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-xcZKaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:03:20 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)) 17:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:03:20 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-xjITS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:03:20 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)) 17:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:03:20 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-BTwOkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:03:20 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)) 17:03:20 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)) 17:03:20 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)) 17:03:20 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)) 17:03:20 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)) 17:03:20 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)) 17:03:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:03:20 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 17:03:20 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 17:03:20 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 17:03:20 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 17:03:20 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 17:03:20 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 17:03:23 INFO - Downloading blessings-1.6.tar.gz 17:03:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:03:23 INFO - Installing collected packages: blessings 17:03:23 INFO - Running setup.py install for blessings 17:03:23 INFO - Successfully installed blessings 17:03:23 INFO - Cleaning up... 17:03:23 INFO - Return code: 0 17:03:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:03:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:03:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:03:23 INFO - Reading from file tmpfile_stdout 17:03:23 INFO - Current package versions: 17:03:23 INFO - blessings == 1.6 17:03:23 INFO - blobuploader == 1.2.4 17:03:23 INFO - docopt == 0.6.1 17:03:23 INFO - functools32 == 3.2.3-2 17:03:23 INFO - jsonschema == 2.5.1 17:03:23 INFO - manifestparser == 1.1 17:03:23 INFO - mozInstall == 1.12 17:03:23 INFO - mozcrash == 0.17 17:03:23 INFO - mozdebug == 0.1 17:03:23 INFO - mozdevice == 0.48 17:03:23 INFO - mozfile == 1.2 17:03:23 INFO - mozhttpd == 0.7 17:03:23 INFO - mozinfo == 0.9 17:03:23 INFO - mozleak == 0.1 17:03:23 INFO - mozlog == 3.2 17:03:23 INFO - moznetwork == 0.27 17:03:23 INFO - mozprocess == 0.22 17:03:23 INFO - mozprofile == 0.28 17:03:23 INFO - mozrunner == 6.11 17:03:23 INFO - mozscreenshot == 0.1 17:03:23 INFO - mozsystemmonitor == 0.3 17:03:23 INFO - moztest == 0.7 17:03:23 INFO - mozversion == 1.4 17:03:23 INFO - psutil == 3.1.1 17:03:23 INFO - requests == 1.2.3 17:03:23 INFO - wsgiref == 0.1.2 17:03:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:03:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:23 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 0x10e5a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e639618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d8857fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e508d30>, '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 0x10e26ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e500b20>, '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.IzFGrTPJW1/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.vJCPSeP8DI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 17:03:23 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 17:03:23 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 17:03:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IzFGrTPJW1/Render', 17:03:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:03:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:03:23 INFO - 'HOME': '/Users/cltbld', 17:03:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:03:23 INFO - 'LOGNAME': 'cltbld', 17:03:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:23 INFO - 'MOZ_NO_REMOTE': '1', 17:03:23 INFO - 'NO_EM_RESTART': '1', 17:03:23 INFO - 'PAGER': '/bin/cat', 17:03:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:03:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:23 INFO - 'PWD': '/builds/slave/test', 17:03:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:03:23 INFO - 'SHELL': '/bin/bash', 17:03:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vJCPSeP8DI/Listeners', 17:03:23 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 17:03:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:03:23 INFO - 'USER': 'cltbld', 17:03:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:03:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:03:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:23 INFO - 'XPC_FLAGS': '0x0', 17:03:23 INFO - 'XPC_SERVICE_NAME': '0', 17:03:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:03:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:24 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)) 17:03:24 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)) 17:03:24 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)) 17:03:24 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)) 17:03:24 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)) 17:03:24 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)) 17:03:24 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)) 17:03:24 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)) 17:03:24 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)) 17:03:24 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)) 17:03:24 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)) 17:03:24 INFO - Cleaning up... 17:03:24 INFO - Return code: 0 17:03:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:03:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:24 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 0x10e5a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e639618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d8857fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e508d30>, '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 0x10e26ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e500b20>, '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.IzFGrTPJW1/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.vJCPSeP8DI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 17:03:24 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 17:03:24 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 17:03:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IzFGrTPJW1/Render', 17:03:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:03:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:03:24 INFO - 'HOME': '/Users/cltbld', 17:03:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:03:24 INFO - 'LOGNAME': 'cltbld', 17:03:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:24 INFO - 'MOZ_NO_REMOTE': '1', 17:03:24 INFO - 'NO_EM_RESTART': '1', 17:03:24 INFO - 'PAGER': '/bin/cat', 17:03:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:03:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:24 INFO - 'PWD': '/builds/slave/test', 17:03:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:03:24 INFO - 'SHELL': '/bin/bash', 17:03:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vJCPSeP8DI/Listeners', 17:03:24 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 17:03:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:03:24 INFO - 'USER': 'cltbld', 17:03:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:03:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:03:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:24 INFO - 'XPC_FLAGS': '0x0', 17:03:24 INFO - 'XPC_SERVICE_NAME': '0', 17:03:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:03:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:03:24 INFO - Cleaning up... 17:03:24 INFO - Return code: 0 17:03:24 INFO - Running post-action listener: _resource_record_post_action 17:03:24 INFO - Running post-action listener: _start_resource_monitoring 17:03:24 INFO - Starting resource monitoring. 17:03:24 INFO - ##### 17:03:24 INFO - ##### Finished create-virtualenv step (success) 17:03:24 INFO - ##### 17:03:24 INFO - ##### 17:03:24 INFO - ##### Running install step. 17:03:24 INFO - ##### 17:03:24 INFO - Running pre-action listener: _resource_record_pre_action 17:03:24 INFO - Running main action method: install 17:03:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:03:24 INFO - Reading from file tmpfile_stdout 17:03:24 INFO - Detecting whether we're running mozinstall >=1.0... 17:03:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:03:24 INFO - Reading from file tmpfile_stdout 17:03:24 INFO - Output received: 17:03:24 INFO - Usage: mozinstall [options] installer 17:03:24 INFO - Options: 17:03:24 INFO - -h, --help show this help message and exit 17:03:24 INFO - -d DEST, --destination=DEST 17:03:24 INFO - Directory to install application into. [default: 17:03:24 INFO - "/builds/slave/test"] 17:03:24 INFO - --app=APP Application being installed. [default: firefox] 17:03:24 INFO - mkdir: /builds/slave/test/build/application 17:03:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:03:59 INFO - Reading from file tmpfile_stdout 17:03:59 INFO - Output received: 17:03:59 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:03:59 INFO - Running post-action listener: _resource_record_post_action 17:03:59 INFO - ##### 17:03:59 INFO - ##### Finished install step (success) 17:03:59 INFO - ##### 17:03:59 INFO - ##### 17:03:59 INFO - ##### Running run-tests step. 17:03:59 INFO - ##### 17:03:59 INFO - Running pre-action listener: _resource_record_pre_action 17:03:59 INFO - Running main action method: run_tests 17:03:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:03:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:03:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:03:59 INFO - 2016-06-29 17:03:59.632 screenresolution[1921:16570] starting screenresolution argv=screenresolution get 17:03:59 INFO - 2016-06-29 17:03:59.635 screenresolution[1921:16570] Display 0: 1600x1200x32@60 17:03:59 INFO - 2016-06-29 17:03:59.641 screenresolution[1922:16573] starting screenresolution argv=screenresolution list 17:03:59 INFO - Available Modes on Display 0 17:03:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:03:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:03:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:03:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:03:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:03:59 INFO - Intel Iris: 17:03:59 INFO - Chipset Model: Intel Iris 17:03:59 INFO - Type: GPU 17:03:59 INFO - Bus: Built-In 17:03:59 INFO - VRAM (Dynamic, Max): 1536 MB 17:03:59 INFO - Vendor: Intel (0x8086) 17:03:59 INFO - Device ID: 0x0a2e 17:03:59 INFO - Revision ID: 0x0009 17:03:59 INFO - Displays: 17:03:59 INFO - Display: 17:03:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:03:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:03:59 INFO - Display Serial Number: 1600x1200 60 17:03:59 INFO - Main Display: Yes 17:03:59 INFO - Mirror: Off 17:03:59 INFO - Online: Yes 17:03:59 INFO - Rotation: Supported 17:03:59 INFO - Return code: 0 17:03:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:03:59 INFO - Python 2.7.3 17:03:59 INFO - Return code: 0 17:03:59 INFO - grabbing minidump binary from tooltool 17:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:59 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 0x10e508d30>, '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 0x10e26ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e500b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:03:59 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 17:03:59 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 17:03:59 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 17:03:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:04:00 INFO - Return code: 0 17:04:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:04:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:04:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:04:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:04:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:04:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0147', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:04:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0147 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:04:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IzFGrTPJW1/Render', 17:04:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:04:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:04:00 INFO - 'HOME': '/Users/cltbld', 17:04:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:04:00 INFO - 'LOGNAME': 'cltbld', 17:04:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:04:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:00 INFO - 'MOZ_NO_REMOTE': '1', 17:04:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:04:00 INFO - 'NO_EM_RESTART': '1', 17:04:00 INFO - 'PAGER': '/bin/cat', 17:04:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:00 INFO - 'PWD': '/builds/slave/test', 17:04:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:04:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:04:00 INFO - 'SHELL': '/bin/bash', 17:04:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vJCPSeP8DI/Listeners', 17:04:00 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 17:04:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:04:00 INFO - 'USER': 'cltbld', 17:04:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:04:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:00 INFO - 'XPC_FLAGS': '0x0', 17:04:00 INFO - 'XPC_SERVICE_NAME': '0', 17:04:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:04:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0147', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:04:00 INFO - mozversion application_buildid: 20160629150227 17:04:00 INFO - mozversion application_changeset: b6ad395da0e5c99a4f4b6a5554d7df03a047393b 17:04:00 INFO - mozversion application_display_name: Nightly 17:04:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:04:00 INFO - mozversion application_name: Firefox 17:04:00 INFO - mozversion application_remotingname: firefox 17:04:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:04:00 INFO - mozversion application_vendor: Mozilla 17:04:00 INFO - mozversion application_version: 50.0a1 17:04:00 INFO - mozversion platform_buildid: 20160629150227 17:04:00 INFO - mozversion platform_changeset: b6ad395da0e5c99a4f4b6a5554d7df03a047393b 17:04:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:04:00 INFO - mozversion platform_version: 50.0a1 17:04:00 INFO - using testdate: 1467245040 17:04:00 INFO - actual date: 1467245040 17:04:00 INFO - starting webserver on 'localhost:52819' 17:04:00 INFO - SUITE-START | Running 2 tests 17:04:00 INFO - TEST-START | dromaeo_css 17:04:00 INFO - operating with platform_type : mac_ 17:04:00 INFO - Initialising browser for dromaeo_css test... 17:04:00 INFO - TEST-INFO | started process 1932 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmpI8qJQv/profile http://localhost:52819/getInfo.html) 17:04:03 INFO - PROCESS | 1932 | __metrics Screen width/height:1600/1200 17:04:03 INFO - PROCESS | 1932 | colorDepth:24 17:04:03 INFO - PROCESS | 1932 | Browser inner width/height: 1024/689 17:04:03 INFO - PROCESS | 1932 | __metrics 17:04:03 ERROR - PROCESS | 1932 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 17:04:04 INFO - TEST-INFO | 1932: exit 0 17:04:04 INFO - Browser initialized. 17:04:04 INFO - Running cycle 1/1 for dromaeo_css test... 17:04:04 INFO - TEST-INFO | started process 1935 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmpI8qJQv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:04:16 INFO - PROCESS | 1935 | RSS: Main: 255795200 17:04:16 INFO - PROCESS | 1935 | 17:05:05 INFO - PROCESS | 1935 | 1467245105712 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] 17:07:16 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:52819/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52819/tests/dromaeo/cssquery-ext.html) 17:07:18 INFO - PROCESS | 1935 | RSS: Main: 267894784 17:07:18 INFO - PROCESS | 1935 | 17:10:20 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:52819/tests/dromaeo/cssquery-ext.html (next: http://localhost:52819/tests/dromaeo/cssquery-jquery.html) 17:10:20 INFO - PROCESS | 1935 | RSS: Main: 276459520 17:10:20 INFO - PROCESS | 1935 | 17:13:22 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:52819/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52819/tests/dromaeo/cssquery-mootools.html) 17:13:23 INFO - PROCESS | 1935 | RSS: Main: 281378816 17:13:23 INFO - PROCESS | 1935 | 17:16:25 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:52819/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52819/tests/dromaeo/cssquery-prototype.html) 17:16:25 INFO - PROCESS | 1935 | RSS: Main: 280580096 17:16:25 INFO - PROCESS | 1935 | 17:19:28 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:52819/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52819/tests/dromaeo/cssquery-yui.html) 17:19:29 INFO - PROCESS | 1935 | RSS: Main: 283959296 17:19:29 INFO - PROCESS | 1935 | 17:22:32 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:52819/tests/dromaeo/cssquery-yui.html (next: http://localhost:52819/tests/dromaeo/cssquery-dojo.html) 17:22:32 INFO - PROCESS | 1935 | RSS: Main: 284332032 17:22:32 INFO - PROCESS | 1935 | 17:22:32 INFO - PROCESS | 1935 | __start_tp_report 17:22:32 INFO - PROCESS | 1935 | _x_x_mozilla_page_load 17:22:32 INFO - PROCESS | 1935 | _x_x_mozilla_page_load_details 17:22:32 INFO - PROCESS | 1935 | |i|pagename|runs| 17:22:32 INFO - PROCESS | 1935 | |0;dojo.html;3416.7608267421274;3431.502432147339;3433.502142189381;3447.293304872501;3451.6203217646053;5779;5907.645541267516;5934;5937.910931336033;5970.164177015221;4848.854534363966;5786.537077033838;5901.793437229698;5917.142014407908;5958.702064896749;5236.266922630834;5297.44376840432;5352.866178345534;5356.089464790975;5417.106177480711;446.2927494210214;5225.790968361261;5242.030224408478;5324.7071411072375;5348.893022139555;4781.235002399634;5259.526642602146;5291.523762861341;5319.867003324948;5339.279197308352;5292.576593872481;5328.440513746078;5332;5343.465653434664;5367.06076436626;5172.586193104543;5215.608829337777;5218.452062533417;5284.682919024833;5289.788408463695;5704.315482142128;5885.735141918624;5889.880922624688;5891.263592050994;5914.822555323347;5456.48163424474;6246.593971391891;6317.4946004319545;6344.968275158641;6346.714397852108;6115.362036198677;6257.280412752546;6270.498360131179;6307.211598550181;6328.303886572473;6012.488938440194;6021.967049425862;6038.30559485656;6042.274927008743;6080.908786368208;6259.874802503924;6384.7126879290545;6428.4214420702365;6429.774957876545;6446.677666116675;6201.81394558164;6228.252609686867;6266.185395898595;6273.18448601688;6288.182536270256;6256.061590761422;6272.090546870678;6329.461995730415;6338.968305158444;6361.268454127835;6276.937230627726;6280.717367718464;6311.842203944938;6336.936630633727;6373.745050198033;6326.49388048955;6327.272363678236;6344.238691357066;6363.745450182034;6381.202349706286;5040.49595040493;5085.237214417867;5102.540771330598;5111.616628752859;5113.079645663742;4447.888802779957;4492.752898590609;4519.231730605805;4537.956270057905;4538.228501154812;4929.482404347564;5805.7387417566315;5917.437843404869;5937.9406205937385;5959.702014899238;6323.083152942798;6324.430801227912;6331.873362532723;6395.136656551399;6635.402813746786;4713.222318317507;5826.242588463558;5928.199693041384;5967.6419414835245;5977.9402205977385;5550.389457159709;5550.72246387679;5578.3584887738425;5587.664740115606;5598.468145526169;5438.7280635968045;6501.187351581052;6514.641694706742;6518.120053792677;6543.607383557001;6229.719662615103;6234.812955611339;6287.30839607652;6304.905426418516;6349.523785715997;6454.160959075478;6476.708548115252;6482.902756458751;6499.252585952676;6521.576097553644;6145.231846019247;6296.33888441707;6335.556511044367;6335.90496142549;6341.365863413806;6254.9687251563455;6257.749690012531;6315.715792789244;6324.430801227912;6339.809805705836;5228.189630607262;6164.506839452743;6271.874562508816;6275.623462592259;6321.747130114744;6099.370313949917;6184.783532576338;6310.7791227306825;6326.082718005955;6355.523335749745;4748.525147485362;5825.94174058271;6078.331383547895;6189.96905015472;6198.845028874314;6315.936840631535;6319.494440444661;6324.968375158095;6334.9366506334345;6343.682815859096;6016.398360163948;6127.050307202391;6140.074827791203;6193.102000210034;6212.316645169119 17:22:32 INFO - PROCESS | 1935 | |1;ext.html;516.251435418643;521.3873698404374;529.4017759931277;531.9441458646842;562.6258538072182;35502.82248588753;39070.8046459768;40784;41843.58156418435;41908.37137442937;41972.37041444381;42515.14969700612;42540.78729606355;42612.3608145878;42657.36013959793;9536.761580960461;9564.569594368253;9747.805043899118;9749.805003899917;9751.12239898409;9695.127438530531;9757.414555126716;9833.31166818323;9863.210943124534;9888.307818452711;9785.657501987433;9785.902140978606;9847.803043939117;9848.261380396463;9893;9799.706008819747;9853;9878.468837330225;9880.505974701236;9884.258680598983;9630;9652.372595781251;9704;9714;9714.465704386255;40443.39334909979;40545;40616;40729.16718747663;41030.58969410328;3076.8307743074124;3313.5029745538122;3400.268942177419;3419.4437784703878;3500.4049311617086;30488.69511304881;30771.538426923613;30895.845520772476;31942.680573194437;32018.839905800556;3252.2682396460846;3294.3246634439884;3309.0900002499266;3374.139594403436;3436.1753179237053;460571;474727;506528;513727.9999999963;519234.4038279822;51458.742706286226;57221.42778572161;61837.69081154565;64141.679291604174;64970.675146623966;28601.284967875552;32248.83875580607;32691;33151.66848331534;66744.6662766683;16547.338106475847;16901.830981690273;16948.322067117177;17032.659346812994;17047.14764261782;12586.993040556734;12921;13035.543755968496;13038.47846086146;13057.869421305855;15901.52295431139;16149.515514534347;19635;19808;19826.810391376563;8113.066997295268;8152.307053900367;8172.754817355489;8201.22088401601;8252.890949983077;731.0970950875665;939.7595174369766;1007.3200589601989;1091.5251865438559;1119.255694962857;30824.383512330078;30888;31101.688983110333;31222;31323.686763132533;1042.9530671119817;1079.5843600213975;1148.718563951837;1157.6642773595731;1178.2282604893808;15782.68434631301;16088.839111608733;16161;16177.352905883869;16475.917620411823;650526;708181;708367;716207;718248;60595;61103;61222;61878.381216188165;61999;1316.6774140335679;1358.0290092583652;1366.5285476510587;1382.3779299315147;1385.1896640465238;30478.542821858133;30588.541171882884;30638.387232254783;31070.37859242848;31481.685183147874;53033.73483132559;53085.20372194343;53321.46678533165;53416.46583534115;53769;592012;599480;603851;604259;605208;25404.872975635004;25643.487130257665;26332.736672633793;26642;27245;48743.75628121837;48989;49259;50124.498755011984;50230.74423139451;40509.39235911405;40760.1847963045;40938.38592421057;41552.376714348706;42321.576784231765;40628;40903.18193636051;41074;41090.58909410987;41824.3726344099;38542;39269.803650981565;39590.40614390844;39646;39738.801305993285;34494;35092.64907350894;35308.11729706778;36156.09609759777;36244.637553624125;21897.562048759253;25972.35069123287;25975.870120649277;26112.8694356527;26670.599941000513 17:22:32 INFO - PROCESS | 1935 | |2;jquery.html;344.8293094918015;366.7029705938192;370.42214145932337;384.1146158105569;388.91443882345874;16122;20685.37943861685;20986.685199722015;21510.247141350035;21617.135314587398;18421.35525256616;20355.59288814223;20433.69349459759;20817.375478735623;21236.150553977823;5651.745671444794;5653.773849046033;5877.2065771121;6045.093236014589;6084.939150608504;5684.4315568443235;6659.766908158215;6731.326867313279;6788.08360871281;6789.049533065375;5565.053940830068;5872.5889187756875;5880.147378630118;5947.6134051286745;6709.094272273253;5733.799317023884;5890.823275301726;5949.018411962021;5956.076808094731;5995.850103747398;5563.942850858324;5630.465105814941;5745.2818397700285;5766.336871259817;5772.913406298909;10527.78944421115;12988.805167922488;17157.79895407322;25242.621360679605;25913.740862591323;2212.933611991643;2320.083566991046;2351.753065928087;2491.4145175883655;2758.2828464599147;9468.715938521855;9474.526273686357;9481.573329200133;9500.287478439144;10084.092431681183;1811.1216060210788;1860.1071485686946;1874.8406385457251;1920.932767353136;1921.1258877210835;103589.96410035879;104654.47672761664;105518.47240763747;115684.99999999916;118578;10658.573657053787;10862.45687715611;11174.608888688857;11189.776204475866;11379.203455758183;11905.642830715093;13681.794773078413;13846;13916.791248131287;13923.443062277598;8254.54599997006;8487.490750554987;8499.532525711022;8554.786130346667;8569.657213711382;7516.849663006709;8318.875216871751;8681.782955426164;8689.913100869036;8765.474071555727;4322.913541729148;4347.695661303742;4441.133978874153;4447.444069491314;4448.288273876165;1841.9079046047643;1848.159087615132;1880.5580688538457;1881.9153138108818;1885.9339923102625;827.9751607451786;865.6191275838611;876.2639382918379;878.433410450256;1016.3190662256306;19950.800491994894;20156;21083.894580527307;21633.675494867588;21680.674789878165;897.8787863638456;922.718570835888;941.0166376136816;945.9054094590485;956.6269155029544;11240.943795280971;11600.143976963815;11608.825867611993;11622.476988535536;11638.941805290919;602494;608653;627911;637339;637404;95670;123490;123888;125077.37461312635;125662;885.6678745470449;943.2312665177996;1014.4724743133529;1019.37308555238;1043.9791204176026;15007;19993.000349982733;20015.09932053032;20153.294634687714;20197.59604807925;55997.72001139968;57194;57826;58311.70844145752;58447.53881153005;64528;84745;86314.56842715746;86347.56826215828;86687;8220.794480137805;8225.5475948821;8245.13426090252;8306.127856574973;8512.659493620185;11378.91900269473;12003.819942700691;12880;12956.28740419286;13744.518941836988;11554.48004839801;11802.468888899848;11810.586629467927;11835.349055802013;11967.760644786882;11428.942855286003;11505.942470287595;11510.53957841677;11611.941940290244;11615.477303521193;11881.287122772661;11910.761784764083;11918.165728398928;11948.880511194777;12144.332061736335;8073.313768329758;8140.715074972348;8294.253517183482;8300.87548686758;8342.749717508485;8168.264856162737;10706.785864282514;11743.941280293544;11770.941145294219;11788.646340609796 17:22:32 INFO - PROCESS | 1935 | |3;mootools.html;1544.4362807575235;1568.8901776875616;1770.628168084702;1860.5999710062326;1927.6337495875791;8011.439199256054;8618.56907154642;8629.741107766762;9041.00548939617;9062.63749450022;8749.99375071867;8770.824583508342;8876.556172191396;8901.19889209971;8907.02022777494;2364.397078744922;2392.509535545209;2395.7125144982538;2399.6160614301716;2403.615421532555;2316.050419328076;2349.9882500587473;2362.208660098869;2380.2621187431864;2390.175389490623;2026.2199053364413;2385.1771138957033;2396.101461951768;2401.1235898896953;2406.217979156781;2330.6154484510207;2376.3821406434276;2392.6171812509915;2397.25685037638;2398.8800559971933;1974.9308774192834;2367.6566897799894;2372.098602531027;2375.8930848111704;2382.094803974496;8883.378163528556;8917;8947.32895032875;9062.501562414065;9080.046595107484;5222.764975576109;5308.654937429054;5317.255584218213;5390.434004429518;5424.267723857308;3533.893983180483;3634.6365363463706;3646.4894914711963;3695.815209239527;3702.629737026303;1051.910587600055;1060.3955745225226;1073.2862646340175;1079.5088234853124;1092.7978324010085;11694.649160525198;11936.761264774743;11940.223885447418;11940.40297985106;11953.820692689616;4621.3068039793625;4629.837955671535;4805.8558243252755;4820.8794780130775;4842.782074806642;10015.799684006279;10082.143017843418;10086.394816311045;10102.898971010196;10109.191264698806;5250.238715386247;5270;5302.416734159239;5337;5365.195220716923;4433.135538570013;4801.759912004386;4886.877828054256;4932.1861892788;4978.6763860348965;3764.0025393270807;3927.273454410943;3995.6403923647013;4041.9797901010893;4084.2648323301496;1195.4261954262004;1285.4151361130664;1285.8714128587253;1300.5513097981182;1303.550275155089;773.8529679360903;904.6302523101394;917.3807679816098;922.3820040572832;933.3140141995627;4871.95128048715;5082.923756143661;5864.853378665567;5911.4975227105315;6036.879262414727;370.48687567718906;410.60190052870024;427.08816676396117;436.8121707665671;439.49019137799996;3433.9828300858835;3951.407288906687;4018;4036.8587099451966;4099.344104943195;9134.314926380548;9742.879568849532;10265.640702575523;10414.739631509121;10933.289336193122;10738.97979691928;10784.514696838662;10898.07366373867;10936.56253749857;10946;8173.386995975326;8334.62494187751;8358.498490090615;8371.665133394717;8450.450720703135;5938.8218353449465;5944.3164036136395;5973.641581505123;6015.338312785502;6066.120412540069;9270;9990.650327238513;10075.647352342632;10223.7444063899;10227.232957528066;8611.354148438766;10114.342567733074;10264.743381415525;10282.280240383401;10312.793744124925;6562.146920900253;7051.753188638373;7527.585982771;7729;7791.454598178073;8515.19105684959;8630.050694423482;8640.56797160127;8712.39013269065;8724.389292749447;6711.228208756055;7561.810954726176;7637.770866874002;7692.730754423568;7693.68740969567;7442.330190282901;7465.6267186641535;7504.474686771873;7629.198934111839;7647.847043059219;6997.510174287954;7012.474064445085;7109.644517774194;7152.570845749272;7173.892391614234;4941.283513890394;5039.697618142924;5106.029854327666;5119.513646203604;5143.382794064736;4747.121782470254;4976.477469865757;5043.87390315245;5143.897122057613;5213.869653258547 17:22:32 INFO - PROCESS | 1935 | |4;prototype.html;295.53748383779384;299;300.5641819361925;303.55983823455995;305.3039070918304;5887.6467411955255;5918.940810591893;5930.377310382412;5930.495907847832;5970.283565972084;5398.16462402783;5533.22534845121;5534.640248383852;5734.942650573493;5797.623154494955;4142.461480007595;4305.440292761937;4334.869953901388;4355.520892701816;4385.14489674512;3619.782813031213;4277.182197566038;4304.870853874373;4328.567143285678;4373.475182978047;4310.547392523787;4337.262665346899;4338.783060846961;4346.4349634547625;4377.824887004516;3719.851205951759;3760.924781504382;3953.4465174875395;4209.957900421018;4325.762083085429;3002.369502404498;3414.931701365984;3602.8198590070656;3665.8533658653623;3665.9104310543003;4661.7902194400995;4729.43246810385;5679.7909181312425;5690.146478028329;5695.77216911323;4012.959870401288;4539.774260949558;4775.856724298276;4924.384451943507;4964.553190212898;5618.747156377973;6093.299270583851;6095.647393933319;6121.693915304217;6128.203333566607;3368.949465758016;3398.5411969384313;4043.1509383029597;4045.5145382553987;4060.6954478414236;5395.541378982791;5817.331006934214;5914.61554998928;6140.662263575501;6436.232420059373;3659.780413175218;4054.8849066506355;4105.876823695294;4114.6091121343425;4123.649489793341;4131.380292956081;4140.399642051946;4146.66826653867;4171.895702607399;4172.5410204877435;4686.81252749893;4874.488908438325;4918.778654960535;4933.531314525115;4950.801967921243;5279.551238144801;5579.218909352694;6140.539459540552;6150.600210986271;6169.598976066542;1210.074293165729;1394.2819447984295;1414.7807089901082;1414.978775318371;1432.9539436211624;854.5513605357237;855.2388374346837;858.8582883824224;892;924.4776701163955;4711.976440117846;5608.69152196625;5631.662100273997;5636.887262254814;5644.463775941279;5715.828525144252;5770.8738252149915;6188.783392581328;6253.093301471261;6274.874502509924;4701.694389864648;5122.795088196505;5148.322872106483;5604.915926261109;5667.829965101054;2761.0198379575363;2785.8717219526125;3216.2792905795286;3299.472084466474;3327.717144042735;6120.888293538722;6293.968530157412;6460.806175814733;6465.741370345228;6525;5325.653832500875;6341.938869867312;6417.74329026843;6443.194600674916;6445.645489498029;5267;5419.756110975016;6417.39034791694;6459.354064593691;6465.77369792055;5205.427402985744;5277.788888444419;5718.818915709512;6061.484773794277;6217.378262173746;4850.80596776125;5106.7446627669215;6018.699065046818;6073.0283154695035;6139.72371243304;5946.791862284799;6236.251649802053;6392.20097487814;6435.938070218362;6519.967400162969;4007.238624661305;4033.979830100831;4045.5233839648904;4058.411530328027;4064.878053658395;5174;5959.642421454727;6189.6286222826775;6192.461090952688;6258.3741625838875;5097.209932460474;5195.610329225247;5813.302403711413;5985.910211346921;6051.697415129314;5677.375488696158;5745.683987380567;5886.146508756292;6019.668918209541;6066.878662426815;4944.505549445027;5795.811858568899;5873.4126587340925;5915.373272350138;5966.67183304905;5316.734163291742;5911.817636472637;6078.845019446468;6091.878162436815;6092.238470191226;5284.286621306228;5956.791512297049;5985.25184351956;5997.460228579449;6038 17:22:32 INFO - PROCESS | 1935 | |5;yui.html;711.3704371631105;740.7518481308765;768.0054329643111;802.1457148137237;830.2444775254518;15067.773983390245;15480.612984675388;15704.842951570496;15728.528144155665;15754.291056902439;15254.694906101899;15957.84042159578;15983.84016159838;16052.75920861188;16324.102174380405;679.9252082270946;725.989110163348;833.6332013913858;864.3906046237419;869.6564856881528;820.3191351178508;837.1001173738225;855.80744332525;858.0389963241179;858.5792961448908;870.5777697816554;898.8831451911242;899.9145081217274;902.8871391076116;904.9864252036225;859.3683642522741;898.838209122361;899.2760827533833;899.482797391496;899.649136836631;637.9202599675041;645.7868903261913;656.7635651165576;661.6394065234459;665.5108495255982;15030.248487575687;15058.924705376512;15181.392744290215;15477.071375717493;15484;14177.220252886087;14274.714505709931;14279.428822847074;14284.142951422948;14311.642208944859;11518.078553715683;11854.940725296405;11864.991475724573;11927.821082683766;12048.97583705386;3678.70570354371;3750.5499340079364;3759.8120093995462;3763.190913953486;3903.4535165076913;109693;110116;110884;111765;112682.30976535441;9214.262858971266;10928;10989.61536346224;11047.83428248577;11075.833862492069;17139.914300428667;18892.622147556973;21521;21525.892370538048;22098.668519972212;7964.681412743541;8098.877383333008;8106.797330066795;8132.512049277062;8214.548199849065;3711.4018691588785;4472.9776351118035;4483.461984561874;4581.770911454414;4708.646851486153;3594.173340131732;3610.5125808016105;3610.6389361064207;3644.6355364463343;3679.988003299114;680.0377465885716;683.7606837606897;692.0588000319561;692.2419950154573;707.9115110611174;608.3551435478407;632.8987362022054;637.8054693318489;657.5922927784804;670.7752902777527;9021.142991415805;9227.90772092284;9402.858957115648;9451.29115316354;9487.810243795224;554.4649413316089;635.5900444213548;653.9699972543264;664.3854434647932;693.8508220732567;4603.723776573416;4674.626029917598;4691.976540117277;4692.882677933079;4711.717296962124;145148;150552;151550;152008;152656.7214630483;117745;122741.38629306796;125776;126176.36911815382;126387;68517.65741171263;100307.49846250722;101253;103232;110303.89696103097;9430.29272804556;9873.160781333667;9960.50197490108;10067;10245.538950747085;62583;63367.36632633799;63727.6813615929;63863.722725546155;64355.67822160859;89295.55352223458;94952.05047949709;96692.54961175447;97059;97763;13243.470261189444;13312.467501300227;13392.732145357233;13580.833580833503;13717.382717777524;15016.624584385041;15033.022853514487;15112.546623601309;15280.235988200768;15624.062556246661;13851.653708657364;14013.719725605635;14015.369308380943;14417;14515.637109072357;13821.723565528835;13942.482527062408;13952.930235348758;14447.191980059368;14545.636359091108;11808.822867657163;13469.12450690702;13570.86429135696;13831.377588008765;14287.928560357132;10132;11141.721456963316;11493.138014649103;11645.708857278636;11917.642470725892;9050.637974480947;11639.068874490189;11644.6506604802;11745.23655962394;11779.352135632622 17:22:32 INFO - PROCESS | 1935 | __end_tp_report 17:22:32 INFO - PROCESS | 1935 | __start_cc_report 17:22:32 INFO - PROCESS | 1935 | _x_x_mozilla_cycle_collect,439 17:22:32 INFO - PROCESS | 1935 | __end_cc_report 17:22:32 INFO - PROCESS | 1935 | __startTimestamp1467246152285__endTimestamp 17:22:32 INFO - PROCESS | 1935 | 17:22:32 INFO - PROCESS | 1935 | ------- Summary: start ------- 17:22:32 INFO - PROCESS | 1935 | Number of tests: 6 17:22:32 INFO - PROCESS | 1935 | 17:22:32 INFO - PROCESS | 1935 | [#0] dojo.html Cycles:165 Average:5804.89 Median:6099.37 stddev:793.00 (13.0%) stddev-sans-first:772.98 17:22:32 INFO - PROCESS | 1935 | Values: 3416.8 3431.5 3433.5 3447.3 3451.6 5779.0 5907.6 5934.0 5937.9 5970.2 4848.9 5786.5 5901.8 5917.1 5958.7 5236.3 5297.4 5352.9 5356.1 5417.1 446.3 5225.8 5242.0 5324.7 5348.9 4781.2 5259.5 5291.5 5319.9 5339.3 5292.6 5328.4 5332.0 5343.5 5367.1 5172.6 5215.6 5218.5 5284.7 5289.8 5704.3 5885.7 5889.9 5891.3 5914.8 5456.5 6246.6 6317.5 6345.0 6346.7 6115.4 6257.3 6270.5 6307.2 6328.3 6012.5 6022.0 6038.3 6042.3 6080.9 6259.9 6384.7 6428.4 6429.8 6446.7 6201.8 6228.3 6266.2 6273.2 6288.2 6256.1 6272.1 6329.5 6339.0 6361.3 6276.9 6280.7 6311.8 6336.9 6373.7 6326.5 6327.3 6344.2 6363.7 6381.2 5040.5 5085.2 5102.5 5111.6 5113.1 4447.9 4492.8 4519.2 4538.0 4538.2 4929.5 5805.7 5917.4 5937.9 5959.7 6323.1 6324.4 6331.9 6395.1 6635.4 4713.2 5826.2 5928.2 5967.6 5977.9 5550.4 5550.7 5578.4 5587.7 5598.5 5438.7 6501.2 6514.6 6518.1 6543.6 6229.7 6234.8 6287.3 6304.9 6349.5 6454.2 6476.7 6482.9 6499.3 6521.6 6145.2 6296.3 6335.6 6335.9 6341.4 6255.0 6257.7 6315.7 6324.4 6339.8 5228.2 6164.5 6271.9 6275.6 6321.7 6099.4 6184.8 6310.8 6326.1 6355.5 4748.5 5825.9 6078.3 6190.0 6198.8 6315.9 6319.5 6325.0 6334.9 6343.7 6016.4 6127.1 6140.1 6193.1 6212.3 17:22:32 INFO - PROCESS | 1935 | 17:22:32 INFO - PROCESS | 1935 | [#1] ext.html Cycles:180 Average:72659.29 Median:40772.09 stddev:161967.99 (397.3%) stddev-sans-first:162331.78 17:22:32 INFO - PROCESS | 1935 | Values: 516.3 521.4 529.4 531.9 562.6 35502.8 39070.8 40784.0 41843.6 41908.4 41972.4 42515.1 42540.8 42612.4 42657.4 9536.8 9564.6 9747.8 9749.8 9751.1 9695.1 9757.4 9833.3 9863.2 9888.3 9785.7 9785.9 9847.8 9848.3 9893.0 9799.7 9853.0 9878.5 9880.5 9884.3 9630.0 9652.4 9704.0 9714.0 9714.5 40443.4 40545.0 40616.0 40729.2 41030.6 3076.8 3313.5 3400.3 3419.4 3500.4 30488.7 30771.5 30895.8 31942.7 32018.8 3252.3 3294.3 3309.1 3374.1 3436.2 460571.0 474727.0 506528.0 513728.0 519234.4 51458.7 57221.4 61837.7 64141.7 64970.7 28601.3 32248.8 32691.0 33151.7 66744.7 16547.3 16901.8 16948.3 17032.7 17047.1 12587.0 12921.0 13035.5 13038.5 13057.9 15901.5 16149.5 19635.0 19808.0 19826.8 8113.1 8152.3 8172.8 8201.2 8252.9 731.1 939.8 1007.3 1091.5 1119.3 30824.4 30888.0 31101.7 31222.0 31323.7 1043.0 1079.6 1148.7 1157.7 1178.2 15782.7 16088.8 16161.0 16177.4 16475.9 650526.0 708181.0 708367.0 716207.0 718248.0 60595.0 61103.0 61222.0 61878.4 61999.0 1316.7 1358.0 1366.5 1382.4 1385.2 30478.5 30588.5 30638.4 31070.4 31481.7 53033.7 53085.2 53321.5 53416.5 53769.0 592012.0 599480.0 603851.0 604259.0 605208.0 25404.9 25643.5 26332.7 26642.0 27245.0 48743.8 48989.0 49259.0 50124.5 50230.7 40509.4 40760.2 40938.4 41552.4 42321.6 40628.0 40903.2 41074.0 41090.6 41824.4 38542.0 39269.8 39590.4 39646.0 39738.8 34494.0 35092.6 35308.1 36156.1 36244.6 21897.6 25972.4 25975.9 26112.9 26670.6 17:22:32 INFO - PROCESS | 1935 | 17:22:32 INFO - PROCESS | 1935 | [#2] jquery.html Cycles:180 Average:35296.96 Median:25578.18 stddev:103469.19 (404.5%) stddev-sans-first:103726.17 17:22:32 INFO - PROCESS | 1935 | Values: 344.8 366.7 370.4 384.1 388.9 16122.0 20685.4 20986.7 21510.2 21617.1 18421.4 20355.6 20433.7 20817.4 21236.2 5651.7 5653.8 5877.2 6045.1 6084.9 5684.4 6659.8 6731.3 6788.1 6789.0 5565.1 5872.6 5880.1 5947.6 6709.1 5733.8 5890.8 5949.0 5956.1 5995.9 5563.9 5630.5 5745.3 5766.3 5772.9 10527.8 12988.8 17157.8 25242.6 25913.7 2212.9 2320.1 2351.8 2491.4 2758.3 9468.7 9474.5 9481.6 9500.3 10084.1 1811.1 1860.1 1874.8 1920.9 1921.1 103590.0 104654.5 105518.5 115685.0 118578.0 10658.6 10862.5 11174.6 11189.8 11379.2 11905.6 13681.8 13846.0 13916.8 13923.4 8254.5 8487.5 8499.5 8554.8 8569.7 7516.8 8318.9 8681.8 8689.9 8765.5 4322.9 4347.7 4441.1 4447.4 4448.3 1841.9 1848.2 1880.6 1881.9 1885.9 828.0 865.6 876.3 878.4 1016.3 19950.8 20156.0 21083.9 21633.7 21680.7 897.9 922.7 941.0 945.9 956.6 11240.9 11600.1 11608.8 11622.5 11638.9 602494.0 608653.0 627911.0 637339.0 637404.0 95670.0 123490.0 123888.0 125077.4 125662.0 885.7 943.2 1014.5 1019.4 1044.0 15007.0 19993.0 20015.1 20153.3 20197.6 55997.7 57194.0 57826.0 58311.7 58447.5 64528.0 84745.0 86314.6 86347.6 86687.0 8220.8 8225.5 8245.1 8306.1 8512.7 11378.9 12003.8 12880.0 12956.3 13744.5 11554.5 11802.5 11810.6 11835.3 11967.8 11428.9 11505.9 11510.5 11611.9 11615.5 11881.3 11910.8 11918.2 11948.9 12144.3 8073.3 8140.7 8294.3 8300.9 8342.7 8168.3 10706.8 11743.9 11770.9 11788.6 17:22:32 INFO - PROCESS | 1935 | 17:22:32 INFO - PROCESS | 1935 | [#3] mootools.html Cycles:180 Average:5727.00 Median:4813.37 stddev:3235.80 (67.2%) stddev-sans-first:3229.61 17:22:32 INFO - PROCESS | 1935 | Values: 1544.4 1568.9 1770.6 1860.6 1927.6 8011.4 8618.6 8629.7 9041.0 9062.6 8750.0 8770.8 8876.6 8901.2 8907.0 2364.4 2392.5 2395.7 2399.6 2403.6 2316.1 2350.0 2362.2 2380.3 2390.2 2026.2 2385.2 2396.1 2401.1 2406.2 2330.6 2376.4 2392.6 2397.3 2398.9 1974.9 2367.7 2372.1 2375.9 2382.1 8883.4 8917.0 8947.3 9062.5 9080.0 5222.8 5308.7 5317.3 5390.4 5424.3 3533.9 3634.6 3646.5 3695.8 3702.6 1051.9 1060.4 1073.3 1079.5 1092.8 11694.6 11936.8 11940.2 11940.4 11953.8 4621.3 4629.8 4805.9 4820.9 4842.8 10015.8 10082.1 10086.4 10102.9 10109.2 5250.2 5270.0 5302.4 5337.0 5365.2 4433.1 4801.8 4886.9 4932.2 4978.7 3764.0 3927.3 3995.6 4042.0 4084.3 1195.4 1285.4 1285.9 1300.6 1303.6 773.9 904.6 917.4 922.4 933.3 4872.0 5082.9 5864.9 5911.5 6036.9 370.5 410.6 427.1 436.8 439.5 3434.0 3951.4 4018.0 4036.9 4099.3 9134.3 9742.9 10265.6 10414.7 10933.3 10739.0 10784.5 10898.1 10936.6 10946.0 8173.4 8334.6 8358.5 8371.7 8450.5 5938.8 5944.3 5973.6 6015.3 6066.1 9270.0 9990.7 10075.6 10223.7 10227.2 8611.4 10114.3 10264.7 10282.3 10312.8 6562.1 7051.8 7527.6 7729.0 7791.5 8515.2 8630.1 8640.6 8712.4 8724.4 6711.2 7561.8 7637.8 7692.7 7693.7 7442.3 7465.6 7504.5 7629.2 7647.8 6997.5 7012.5 7109.6 7152.6 7173.9 4941.3 5039.7 5106.0 5119.5 5143.4 4747.1 4976.5 5043.9 5143.9 5213.9 17:22:32 INFO - PROCESS | 1935 | 17:22:32 INFO - PROCESS | 1935 | [#4] prototype.html Cycles:180 Average:4831.27 Median:5408.96 stddev:1527.24 (28.2%) stddev-sans-first:1493.10 17:22:32 INFO - PROCESS | 1935 | Values: 295.5 299.0 300.6 303.6 305.3 5887.6 5918.9 5930.4 5930.5 5970.3 5398.2 5533.2 5534.6 5734.9 5797.6 4142.5 4305.4 4334.9 4355.5 4385.1 3619.8 4277.2 4304.9 4328.6 4373.5 4310.5 4337.3 4338.8 4346.4 4377.8 3719.9 3760.9 3953.4 4210.0 4325.8 3002.4 3414.9 3602.8 3665.9 3665.9 4661.8 4729.4 5679.8 5690.1 5695.8 4013.0 4539.8 4775.9 4924.4 4964.6 5618.7 6093.3 6095.6 6121.7 6128.2 3368.9 3398.5 4043.2 4045.5 4060.7 5395.5 5817.3 5914.6 6140.7 6436.2 3659.8 4054.9 4105.9 4114.6 4123.6 4131.4 4140.4 4146.7 4171.9 4172.5 4686.8 4874.5 4918.8 4933.5 4950.8 5279.6 5579.2 6140.5 6150.6 6169.6 1210.1 1394.3 1414.8 1415.0 1433.0 854.6 855.2 858.9 892.0 924.5 4712.0 5608.7 5631.7 5636.9 5644.5 5715.8 5770.9 6188.8 6253.1 6274.9 4701.7 5122.8 5148.3 5604.9 5667.8 2761.0 2785.9 3216.3 3299.5 3327.7 6120.9 6294.0 6460.8 6465.7 6525.0 5325.7 6341.9 6417.7 6443.2 6445.6 5267.0 5419.8 6417.4 6459.4 6465.8 5205.4 5277.8 5718.8 6061.5 6217.4 4850.8 5106.7 6018.7 6073.0 6139.7 5946.8 6236.3 6392.2 6435.9 6520.0 4007.2 4034.0 4045.5 4058.4 4064.9 5174.0 5959.6 6189.6 6192.5 6258.4 5097.2 5195.6 5813.3 5985.9 6051.7 5677.4 5745.7 5886.1 6019.7 6066.9 4944.5 5795.8 5873.4 5915.4 5966.7 5316.7 5911.8 6078.8 6091.9 6092.2 5284.3 5956.8 5985.3 5997.5 6038.0 17:22:32 INFO - PROCESS | 1935 | 17:22:32 INFO - PROCESS | 1935 | [#5] yui.html Cycles:180 Average:24660.01 Median:3610.58 stddev:38920.36 (1078.0%) stddev-sans-first:38988.01 17:22:32 INFO - PROCESS | 1935 | Values: 711.4 740.8 768.0 802.1 830.2 15067.8 15480.6 15704.8 15728.5 15754.3 15254.7 15957.8 15983.8 16052.8 16324.1 679.9 726.0 833.6 864.4 869.7 820.3 837.1 855.8 858.0 858.6 870.6 898.9 899.9 902.9 905.0 859.4 898.8 899.3 899.5 899.6 637.9 645.8 656.8 661.6 665.5 15030.2 15058.9 15181.4 15477.1 15484.0 14177.2 14274.7 14279.4 14284.1 14311.6 11518.1 11854.9 11865.0 11927.8 12049.0 3678.7 3750.5 3759.8 3763.2 3903.5 109693.0 110116.0 110884.0 111765.0 112682.3 9214.3 10928.0 10989.6 11047.8 11075.8 17139.9 18892.6 21521.0 21525.9 22098.7 7964.7 8098.9 8106.8 8132.5 8214.5 3711.4 4473.0 4483.5 4581.8 4708.6 3594.2 3610.5 3610.6 3644.6 3680.0 680.0 683.8 692.1 692.2 707.9 608.4 632.9 637.8 657.6 670.8 9021.1 9227.9 9402.9 9451.3 9487.8 554.5 635.6 654.0 664.4 693.9 4603.7 4674.6 4692.0 4692.9 4711.7 145148.0 150552.0 151550.0 152008.0 152656.7 117745.0 122741.4 125776.0 126176.4 126387.0 68517.7 100307.5 101253.0 103232.0 110303.9 9430.3 9873.2 9960.5 10067.0 10245.5 62583.0 63367.4 63727.7 63863.7 64355.7 89295.6 94952.1 96692.5 97059.0 97763.0 13243.5 13312.5 13392.7 13580.8 13717.4 15016.6 15033.0 15112.5 15280.2 15624.1 13851.7 14013.7 14015.4 14417.0 14515.6 13821.7 13942.5 13952.9 14447.2 14545.6 11808.8 13469.1 13570.9 13831.4 14287.9 10132.0 11141.7 11493.1 11645.7 11917.6 9050.6 11639.1 11644.7 11745.2 11779.4 17:22:32 INFO - PROCESS | 1935 | -------- Summary: end -------- 17:22:32 INFO - PROCESS | 1935 | 17:22:32 INFO - TEST-INFO | 1935: exit 0 17:22:32 INFO - TEST-OK | dromaeo_css | took 1112654ms 17:22:32 INFO - TEST-START | kraken 17:22:32 INFO - operating with platform_type : mac_ 17:22:32 INFO - Initialising browser for kraken test... 17:22:32 INFO - TEST-INFO | started process 1940 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmpmYnr0a/profile http://localhost:52819/getInfo.html) 17:22:35 INFO - PROCESS | 1940 | __metrics Screen width/height:1600/1200 17:22:35 INFO - PROCESS | 1940 | colorDepth:24 17:22:35 INFO - PROCESS | 1940 | Browser inner width/height: 1024/689 17:22:35 INFO - PROCESS | 1940 | __metrics 17:22:35 ERROR - PROCESS | 1940 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 17:22:36 INFO - TEST-INFO | 1940: exit 0 17:22:36 INFO - Browser initialized. 17:22:36 INFO - Running cycle 1/1 for kraken test... 17:22:36 INFO - TEST-INFO | started process 1942 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmpmYnr0a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:22:48 INFO - PROCESS | 1942 | RSS: Main: 255758336 17:22:48 INFO - PROCESS | 1942 | 17:22:51 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:52819/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52819/tests/kraken/driver.html?testName=audio-beat-detection) 17:22:52 INFO - PROCESS | 1942 | RSS: Main: 268619776 17:22:52 INFO - PROCESS | 1942 | 17:22:54 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:52819/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52819/tests/kraken/driver.html?testName=audio-dft) 17:22:55 INFO - PROCESS | 1942 | RSS: Main: 272801792 17:22:55 INFO - PROCESS | 1942 | 17:22:59 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:52819/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52819/tests/kraken/driver.html?testName=audio-fft) 17:22:59 INFO - PROCESS | 1942 | RSS: Main: 273076224 17:22:59 INFO - PROCESS | 1942 | 17:23:01 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:52819/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52819/tests/kraken/driver.html?testName=audio-oscillator) 17:23:02 INFO - PROCESS | 1942 | RSS: Main: 274001920 17:23:02 INFO - PROCESS | 1942 | 17:23:04 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:52819/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52819/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:23:04 INFO - PROCESS | 1942 | RSS: Main: 274567168 17:23:04 INFO - PROCESS | 1942 | 17:23:07 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:52819/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52819/tests/kraken/driver.html?testName=imaging-darkroom) 17:23:08 INFO - PROCESS | 1942 | RSS: Main: 274694144 17:23:08 INFO - PROCESS | 1942 | 17:23:11 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:52819/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52819/tests/kraken/driver.html?testName=imaging-desaturate) 17:23:12 INFO - PROCESS | 1942 | RSS: Main: 274726912 17:23:12 INFO - PROCESS | 1942 | 17:23:15 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:52819/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52819/tests/kraken/driver.html?testName=json-parse-financial) 17:23:15 INFO - PROCESS | 1942 | RSS: Main: 274882560 17:23:15 INFO - PROCESS | 1942 | 17:23:17 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:52819/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52819/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:23:18 INFO - PROCESS | 1942 | RSS: Main: 274661376 17:23:18 INFO - PROCESS | 1942 | 17:23:20 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:52819/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52819/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:23:20 INFO - PROCESS | 1942 | RSS: Main: 274788352 17:23:20 INFO - PROCESS | 1942 | 17:23:22 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:52819/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52819/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:23:23 INFO - PROCESS | 1942 | RSS: Main: 275148800 17:23:23 INFO - PROCESS | 1942 | 17:23:26 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:52819/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52819/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:23:27 INFO - PROCESS | 1942 | RSS: Main: 275222528 17:23:27 INFO - PROCESS | 1942 | 17:23:29 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:52819/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52819/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:23:30 INFO - PROCESS | 1942 | RSS: Main: 275410944 17:23:30 INFO - PROCESS | 1942 | 17:23:32 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:52819/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52819/tests/kraken/driver.html?testName=ai-astar) 17:23:32 INFO - PROCESS | 1942 | RSS: Main: 276344832 17:23:32 INFO - PROCESS | 1942 | 17:23:32 INFO - PROCESS | 1942 | __start_tp_report 17:23:32 INFO - PROCESS | 1942 | _x_x_mozilla_page_load 17:23:32 INFO - PROCESS | 1942 | _x_x_mozilla_page_load_details 17:23:32 INFO - PROCESS | 1942 | |i|pagename|runs| 17:23:32 INFO - PROCESS | 1942 | |0;ai-astar;99;115;105;117;117;120;111;114;118;118 17:23:32 INFO - PROCESS | 1942 | |1;audio-beat-detection;148;113;135;154;111;131;129;110;171;138 17:23:32 INFO - PROCESS | 1942 | |2;audio-dft;201;201;201;204;269;272;187;272;272;205 17:23:32 INFO - PROCESS | 1942 | |3;audio-fft;71;84;72;169;86;66;58;63;133;57 17:23:32 INFO - PROCESS | 1942 | |4;audio-oscillator;68;70;115;70;69;81;113;71;75;110 17:23:32 INFO - PROCESS | 1942 | |5;imaging-gaussian-blur;80;129;134;87;90;86;100;114;90;88 17:23:32 INFO - PROCESS | 1942 | |6;imaging-darkroom;96;96;97;97;99;97;98;151;121;97 17:23:32 INFO - PROCESS | 1942 | |7;imaging-desaturate;76;144;140;149;87;137;143;111;93;89 17:23:32 INFO - PROCESS | 1942 | |8;json-parse-financial;57;58;55;58;57;55;59;61;84;61 17:23:32 INFO - PROCESS | 1942 | |9;json-stringify-tinderbox;72;76;67;74;78;76;69;59;66;98 17:23:32 INFO - PROCESS | 1942 | |10;stanford-crypto-aes;88;101;108;81;82;84;83;84;88;94 17:23:32 INFO - PROCESS | 1942 | |11;stanford-crypto-ccm;153;136;135;134;126;147;141;148;184;150 17:23:32 INFO - PROCESS | 1942 | |12;stanford-crypto-pbkdf2;165;164;166;163;165;163;165;162;167;164 17:23:32 INFO - PROCESS | 1942 | |13;stanford-crypto-sha256-iterative;65;70;65;69;66;69;67;68;69;66 17:23:32 INFO - PROCESS | 1942 | __end_tp_report 17:23:32 INFO - PROCESS | 1942 | __start_cc_report 17:23:32 INFO - PROCESS | 1942 | _x_x_mozilla_cycle_collect,1121 17:23:32 INFO - PROCESS | 1942 | __end_cc_report 17:23:32 INFO - PROCESS | 1942 | __startTimestamp1467246212505__endTimestamp 17:23:32 INFO - PROCESS | 1942 | 17:23:32 INFO - PROCESS | 1942 | ------- Summary: start ------- 17:23:32 INFO - PROCESS | 1942 | Number of tests: 14 17:23:32 INFO - PROCESS | 1942 | 17:23:32 INFO - PROCESS | 1942 | [#0] ai-astar Cycles:10 Average:113.40 Median:117.50 stddev:6.65 (5.7%) stddev-sans-first:4.58 17:23:32 INFO - PROCESS | 1942 | Values: 99.0 115.0 105.0 117.0 117.0 120.0 111.0 114.0 118.0 118.0 17:23:32 INFO - PROCESS | 1942 | 17:23:32 INFO - PROCESS | 1942 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:136.50 stddev:19.89 (14.6%) stddev-sans-first:20.45 17:23:32 INFO - PROCESS | 1942 | Values: 148.0 113.0 135.0 154.0 111.0 131.0 129.0 110.0 171.0 138.0 17:23:32 INFO - PROCESS | 1942 | 17:23:32 INFO - PROCESS | 1942 | [#2] audio-dft Cycles:10 Average:228.40 Median:237.00 stddev:37.21 (15.7%) stddev-sans-first:38.12 17:23:32 INFO - PROCESS | 1942 | Values: 201.0 201.0 201.0 204.0 269.0 272.0 187.0 272.0 272.0 205.0 17:23:32 INFO - PROCESS | 1942 | 17:23:32 INFO - PROCESS | 1942 | [#3] audio-fft Cycles:10 Average:85.90 Median:68.50 stddev:36.63 (53.5%) stddev-sans-first:38.45 17:23:32 INFO - PROCESS | 1942 | Values: 71.0 84.0 72.0 169.0 86.0 66.0 58.0 63.0 133.0 57.0 17:23:32 INFO - PROCESS | 1942 | 17:23:32 INFO - PROCESS | 1942 | [#4] audio-oscillator Cycles:10 Average:84.20 Median:70.00 stddev:20.03 (28.6%) stddev-sans-first:20.37 17:23:32 INFO - PROCESS | 1942 | Values: 68.0 70.0 115.0 70.0 69.0 81.0 113.0 71.0 75.0 110.0 17:23:32 INFO - PROCESS | 1942 | 17:23:32 INFO - PROCESS | 1942 | [#5] imaging-gaussian-blur Cycles:10 Average:99.80 Median:86.50 stddev:19.15 (22.1%) stddev-sans-first:18.93 17:23:32 INFO - PROCESS | 1942 | Values: 80.0 129.0 134.0 87.0 90.0 86.0 100.0 114.0 90.0 88.0 17:23:32 INFO - PROCESS | 1942 | 17:23:32 INFO - PROCESS | 1942 | [#6] imaging-darkroom Cycles:10 Average:104.90 Median:97.00 stddev:17.87 (18.4%) stddev-sans-first:18.66 17:23:32 INFO - PROCESS | 1942 | Values: 96.0 96.0 97.0 97.0 99.0 97.0 98.0 151.0 121.0 97.0 17:23:32 INFO - PROCESS | 1942 | 17:23:32 INFO - PROCESS | 1942 | [#7] imaging-desaturate Cycles:10 Average:116.90 Median:112.50 stddev:28.55 (25.4%) stddev-sans-first:26.16 17:23:32 INFO - PROCESS | 1942 | Values: 76.0 144.0 140.0 149.0 87.0 137.0 143.0 111.0 93.0 89.0 17:23:32 INFO - PROCESS | 1942 | 17:23:32 INFO - PROCESS | 1942 | [#8] json-parse-financial Cycles:10 Average:60.50 Median:58.50 stddev:8.51 (14.6%) stddev-sans-first:8.94 17:23:32 INFO - PROCESS | 1942 | Values: 57.0 58.0 55.0 58.0 57.0 55.0 59.0 61.0 84.0 61.0 17:23:32 INFO - PROCESS | 1942 | 17:23:32 INFO - PROCESS | 1942 | [#9] json-stringify-tinderbox Cycles:10 Average:73.50 Median:75.00 stddev:10.35 (13.8%) stddev-sans-first:10.97 17:23:32 INFO - PROCESS | 1942 | Values: 72.0 76.0 67.0 74.0 78.0 76.0 69.0 59.0 66.0 98.0 17:23:32 INFO - PROCESS | 1942 | 17:23:32 INFO - PROCESS | 1942 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:84.00 stddev:9.01 (10.7%) stddev-sans-first:9.54 17:23:32 INFO - PROCESS | 1942 | Values: 88.0 101.0 108.0 81.0 82.0 84.0 83.0 84.0 88.0 94.0 17:23:32 INFO - PROCESS | 1942 | 17:23:32 INFO - PROCESS | 1942 | [#11] stanford-crypto-ccm Cycles:10 Average:145.40 Median:147.50 stddev:15.99 (10.8%) stddev-sans-first:16.72 17:23:32 INFO - PROCESS | 1942 | Values: 153.0 136.0 135.0 134.0 126.0 147.0 141.0 148.0 184.0 150.0 17:23:32 INFO - PROCESS | 1942 | 17:23:32 INFO - PROCESS | 1942 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.40 Median:165.00 stddev:1.51 (0.9%) stddev-sans-first:1.58 17:23:32 INFO - PROCESS | 1942 | Values: 165.0 164.0 166.0 163.0 165.0 163.0 165.0 162.0 167.0 164.0 17:23:32 INFO - PROCESS | 1942 | 17:23:32 INFO - PROCESS | 1942 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.50 stddev:1.84 (2.7%) stddev-sans-first:1.73 17:23:32 INFO - PROCESS | 1942 | Values: 65.0 70.0 65.0 69.0 66.0 69.0 67.0 68.0 69.0 66.0 17:23:32 INFO - PROCESS | 1942 | -------- Summary: end -------- 17:23:32 INFO - PROCESS | 1942 | 17:23:33 INFO - TEST-INFO | 1942: exit 0 17:23:33 INFO - TEST-OK | kraken | took 60405ms 17:23:33 INFO - SUITE-END | took 1173s 17:23:33 INFO - Completed test suite (00:19:33) 17:23:33 INFO - javascript benchmark 17:23:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7451.037759195938, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3416.7608267421274, 3431.502432147339, 3433.502142189381, 3447.293304872501, 3451.6203217646053, 5779.0, 5907.645541267516, 5934.0, 5937.910931336033, 5970.164177015221, 4848.854534363966, 5786.537077033838, 5901.793437229698, 5917.142014407908, 5958.702064896749, 5236.266922630834, 5297.44376840432, 5352.866178345534, 5356.089464790975, 5417.106177480711, 446.2927494210214, 5225.790968361261, 5242.030224408478, 5324.7071411072375, 5348.893022139555, 4781.235002399634, 5259.526642602146, 5291.523762861341, 5319.867003324948, 5339.279197308352, 5292.576593872481, 5328.440513746078, 5332.0, 5343.465653434664, 5367.06076436626, 5172.586193104543, 5215.608829337777, 5218.452062533417, 5284.682919024833, 5289.788408463695, 5704.315482142128, 5885.735141918624, 5889.880922624688, 5891.263592050994, 5914.822555323347, 5456.48163424474, 6246.593971391891, 6317.4946004319545, 6344.968275158641, 6346.714397852108, 6115.362036198677, 6257.280412752546, 6270.498360131179, 6307.211598550181, 6328.303886572473, 6012.488938440194, 6021.967049425862, 6038.30559485656, 6042.274927008743, 6080.908786368208, 6259.874802503924, 6384.7126879290545, 6428.4214420702365, 6429.774957876545, 6446.677666116675, 6201.81394558164, 6228.252609686867, 6266.185395898595, 6273.18448601688, 6288.182536270256, 6256.061590761422, 6272.090546870678, 6329.461995730415, 6338.968305158444, 6361.268454127835, 6276.937230627726, 6280.717367718464, 6311.842203944938, 6336.936630633727, 6373.745050198033, 6326.49388048955, 6327.272363678236, 6344.238691357066, 6363.745450182034, 6381.202349706286, 5040.49595040493, 5085.237214417867, 5102.540771330598, 5111.616628752859, 5113.079645663742, 4447.888802779957, 4492.752898590609, 4519.231730605805, 4537.956270057905, 4538.228501154812, 4929.482404347564, 5805.7387417566315, 5917.437843404869, 5937.9406205937385, 5959.702014899238, 6323.083152942798, 6324.430801227912, 6331.873362532723, 6395.136656551399, 6635.402813746786, 4713.222318317507, 5826.242588463558, 5928.199693041384, 5967.6419414835245, 5977.9402205977385, 5550.389457159709, 5550.72246387679, 5578.3584887738425, 5587.664740115606, 5598.468145526169, 5438.7280635968045, 6501.187351581052, 6514.641694706742, 6518.120053792677, 6543.607383557001, 6229.719662615103, 6234.812955611339, 6287.30839607652, 6304.905426418516, 6349.523785715997, 6454.160959075478, 6476.708548115252, 6482.902756458751, 6499.252585952676, 6521.576097553644, 6145.231846019247, 6296.33888441707, 6335.556511044367, 6335.90496142549, 6341.365863413806, 6254.9687251563455, 6257.749690012531, 6315.715792789244, 6324.430801227912, 6339.809805705836, 5228.189630607262, 6164.506839452743, 6271.874562508816, 6275.623462592259, 6321.747130114744, 6099.370313949917, 6184.783532576338, 6310.7791227306825, 6326.082718005955, 6355.523335749745, 4748.525147485362, 5825.94174058271, 6078.331383547895, 6189.96905015472, 6198.845028874314, 6315.936840631535, 6319.494440444661, 6324.968375158095, 6334.9366506334345, 6343.682815859096, 6016.398360163948, 6127.050307202391, 6140.074827791203, 6193.102000210034, 6212.316645169119], "value": 5757.31797787129, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [516.251435418643, 521.3873698404374, 529.4017759931277, 531.9441458646842, 562.6258538072182, 35502.82248588753, 39070.8046459768, 40784.0, 41843.58156418435, 41908.37137442937, 41972.37041444381, 42515.14969700612, 42540.78729606355, 42612.3608145878, 42657.36013959793, 9536.761580960461, 9564.569594368253, 9747.805043899118, 9749.805003899917, 9751.12239898409, 9695.127438530531, 9757.414555126716, 9833.31166818323, 9863.210943124534, 9888.307818452711, 9785.657501987433, 9785.902140978606, 9847.803043939117, 9848.261380396463, 9893.0, 9799.706008819747, 9853.0, 9878.468837330225, 9880.505974701236, 9884.258680598983, 9630.0, 9652.372595781251, 9704.0, 9714.0, 9714.465704386255, 40443.39334909979, 40545.0, 40616.0, 40729.16718747663, 41030.58969410328, 3076.8307743074124, 3313.5029745538122, 3400.268942177419, 3419.4437784703878, 3500.4049311617086, 30488.69511304881, 30771.538426923613, 30895.845520772476, 31942.680573194437, 32018.839905800556, 3252.2682396460846, 3294.3246634439884, 3309.0900002499266, 3374.139594403436, 3436.1753179237053, 460571.0, 474727.0, 506528.0, 513727.9999999963, 519234.4038279822, 51458.742706286226, 57221.42778572161, 61837.69081154565, 64141.679291604174, 64970.675146623966, 28601.284967875552, 32248.83875580607, 32691.0, 33151.66848331534, 66744.6662766683, 16547.338106475847, 16901.830981690273, 16948.322067117177, 17032.659346812994, 17047.14764261782, 12586.993040556734, 12921.0, 13035.543755968496, 13038.47846086146, 13057.869421305855, 15901.52295431139, 16149.515514534347, 19635.0, 19808.0, 19826.810391376563, 8113.066997295268, 8152.307053900367, 8172.754817355489, 8201.22088401601, 8252.890949983077, 731.0970950875665, 939.7595174369766, 1007.3200589601989, 1091.5251865438559, 1119.255694962857, 30824.383512330078, 30888.0, 31101.688983110333, 31222.0, 31323.686763132533, 1042.9530671119817, 1079.5843600213975, 1148.718563951837, 1157.6642773595731, 1178.2282604893808, 15782.68434631301, 16088.839111608733, 16161.0, 16177.352905883869, 16475.917620411823, 650526.0, 708181.0, 708367.0, 716207.0, 718248.0, 60595.0, 61103.0, 61222.0, 61878.381216188165, 61999.0, 1316.6774140335679, 1358.0290092583652, 1366.5285476510587, 1382.3779299315147, 1385.1896640465238, 30478.542821858133, 30588.541171882884, 30638.387232254783, 31070.37859242848, 31481.685183147874, 53033.73483132559, 53085.20372194343, 53321.46678533165, 53416.46583534115, 53769.0, 592012.0, 599480.0, 603851.0, 604259.0, 605208.0, 25404.872975635004, 25643.487130257665, 26332.736672633793, 26642.0, 27245.0, 48743.75628121837, 48989.0, 49259.0, 50124.498755011984, 50230.74423139451, 40509.39235911405, 40760.1847963045, 40938.38592421057, 41552.376714348706, 42321.576784231765, 40628.0, 40903.18193636051, 41074.0, 41090.58909410987, 41824.3726344099, 38542.0, 39269.803650981565, 39590.40614390844, 39646.0, 39738.801305993285, 34494.0, 35092.64907350894, 35308.11729706778, 36156.09609759777, 36244.637553624125, 21897.562048759253, 25972.35069123287, 25975.870120649277, 26112.8694356527, 26670.599941000513], "value": 20239.403842203526, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.8293094918015, 366.7029705938192, 370.42214145932337, 384.1146158105569, 388.91443882345874, 16122.0, 20685.37943861685, 20986.685199722015, 21510.247141350035, 21617.135314587398, 18421.35525256616, 20355.59288814223, 20433.69349459759, 20817.375478735623, 21236.150553977823, 5651.745671444794, 5653.773849046033, 5877.2065771121, 6045.093236014589, 6084.939150608504, 5684.4315568443235, 6659.766908158215, 6731.326867313279, 6788.08360871281, 6789.049533065375, 5565.053940830068, 5872.5889187756875, 5880.147378630118, 5947.6134051286745, 6709.094272273253, 5733.799317023884, 5890.823275301726, 5949.018411962021, 5956.076808094731, 5995.850103747398, 5563.942850858324, 5630.465105814941, 5745.2818397700285, 5766.336871259817, 5772.913406298909, 10527.78944421115, 12988.805167922488, 17157.79895407322, 25242.621360679605, 25913.740862591323, 2212.933611991643, 2320.083566991046, 2351.753065928087, 2491.4145175883655, 2758.2828464599147, 9468.715938521855, 9474.526273686357, 9481.573329200133, 9500.287478439144, 10084.092431681183, 1811.1216060210788, 1860.1071485686946, 1874.8406385457251, 1920.932767353136, 1921.1258877210835, 103589.96410035879, 104654.47672761664, 105518.47240763747, 115684.99999999916, 118578.0, 10658.573657053787, 10862.45687715611, 11174.608888688857, 11189.776204475866, 11379.203455758183, 11905.642830715093, 13681.794773078413, 13846.0, 13916.791248131287, 13923.443062277598, 8254.54599997006, 8487.490750554987, 8499.532525711022, 8554.786130346667, 8569.657213711382, 7516.849663006709, 8318.875216871751, 8681.782955426164, 8689.913100869036, 8765.474071555727, 4322.913541729148, 4347.695661303742, 4441.133978874153, 4447.444069491314, 4448.288273876165, 1841.9079046047643, 1848.159087615132, 1880.5580688538457, 1881.9153138108818, 1885.9339923102625, 827.9751607451786, 865.6191275838611, 876.2639382918379, 878.433410450256, 1016.3190662256306, 19950.800491994894, 20156.0, 21083.894580527307, 21633.675494867588, 21680.674789878165, 897.8787863638456, 922.718570835888, 941.0166376136816, 945.9054094590485, 956.6269155029544, 11240.943795280971, 11600.143976963815, 11608.825867611993, 11622.476988535536, 11638.941805290919, 602494.0, 608653.0, 627911.0, 637339.0, 637404.0, 95670.0, 123490.0, 123888.0, 125077.37461312635, 125662.0, 885.6678745470449, 943.2312665177996, 1014.4724743133529, 1019.37308555238, 1043.9791204176026, 15007.0, 19993.000349982733, 20015.09932053032, 20153.294634687714, 20197.59604807925, 55997.72001139968, 57194.0, 57826.0, 58311.70844145752, 58447.53881153005, 64528.0, 84745.0, 86314.56842715746, 86347.56826215828, 86687.0, 8220.794480137805, 8225.5475948821, 8245.13426090252, 8306.127856574973, 8512.659493620185, 11378.91900269473, 12003.819942700691, 12880.0, 12956.28740419286, 13744.518941836988, 11554.48004839801, 11802.468888899848, 11810.586629467927, 11835.349055802013, 11967.760644786882, 11428.942855286003, 11505.942470287595, 11510.53957841677, 11611.941940290244, 11615.477303521193, 11881.287122772661, 11910.761784764083, 11918.165728398928, 11948.880511194777, 12144.332061736335, 8073.313768329758, 8140.715074972348, 8294.253517183482, 8300.87548686758, 8342.749717508485, 8168.264856162737, 10706.785864282514, 11743.941280293544, 11770.941145294219, 11788.646340609796], "value": 9533.501299529666, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1544.4362807575235, 1568.8901776875616, 1770.628168084702, 1860.5999710062326, 1927.6337495875791, 8011.439199256054, 8618.56907154642, 8629.741107766762, 9041.00548939617, 9062.63749450022, 8749.99375071867, 8770.824583508342, 8876.556172191396, 8901.19889209971, 8907.02022777494, 2364.397078744922, 2392.509535545209, 2395.7125144982538, 2399.6160614301716, 2403.615421532555, 2316.050419328076, 2349.9882500587473, 2362.208660098869, 2380.2621187431864, 2390.175389490623, 2026.2199053364413, 2385.1771138957033, 2396.101461951768, 2401.1235898896953, 2406.217979156781, 2330.6154484510207, 2376.3821406434276, 2392.6171812509915, 2397.25685037638, 2398.8800559971933, 1974.9308774192834, 2367.6566897799894, 2372.098602531027, 2375.8930848111704, 2382.094803974496, 8883.378163528556, 8917.0, 8947.32895032875, 9062.501562414065, 9080.046595107484, 5222.764975576109, 5308.654937429054, 5317.255584218213, 5390.434004429518, 5424.267723857308, 3533.893983180483, 3634.6365363463706, 3646.4894914711963, 3695.815209239527, 3702.629737026303, 1051.910587600055, 1060.3955745225226, 1073.2862646340175, 1079.5088234853124, 1092.7978324010085, 11694.649160525198, 11936.761264774743, 11940.223885447418, 11940.40297985106, 11953.820692689616, 4621.3068039793625, 4629.837955671535, 4805.8558243252755, 4820.8794780130775, 4842.782074806642, 10015.799684006279, 10082.143017843418, 10086.394816311045, 10102.898971010196, 10109.191264698806, 5250.238715386247, 5270.0, 5302.416734159239, 5337.0, 5365.195220716923, 4433.135538570013, 4801.759912004386, 4886.877828054256, 4932.1861892788, 4978.6763860348965, 3764.0025393270807, 3927.273454410943, 3995.6403923647013, 4041.9797901010893, 4084.2648323301496, 1195.4261954262004, 1285.4151361130664, 1285.8714128587253, 1300.5513097981182, 1303.550275155089, 773.8529679360903, 904.6302523101394, 917.3807679816098, 922.3820040572832, 933.3140141995627, 4871.95128048715, 5082.923756143661, 5864.853378665567, 5911.4975227105315, 6036.879262414727, 370.48687567718906, 410.60190052870024, 427.08816676396117, 436.8121707665671, 439.49019137799996, 3433.9828300858835, 3951.407288906687, 4018.0, 4036.8587099451966, 4099.344104943195, 9134.314926380548, 9742.879568849532, 10265.640702575523, 10414.739631509121, 10933.289336193122, 10738.97979691928, 10784.514696838662, 10898.07366373867, 10936.56253749857, 10946.0, 8173.386995975326, 8334.62494187751, 8358.498490090615, 8371.665133394717, 8450.450720703135, 5938.8218353449465, 5944.3164036136395, 5973.641581505123, 6015.338312785502, 6066.120412540069, 9270.0, 9990.650327238513, 10075.647352342632, 10223.7444063899, 10227.232957528066, 8611.354148438766, 10114.342567733074, 10264.743381415525, 10282.280240383401, 10312.793744124925, 6562.146920900253, 7051.753188638373, 7527.585982771, 7729.0, 7791.454598178073, 8515.19105684959, 8630.050694423482, 8640.56797160127, 8712.39013269065, 8724.389292749447, 6711.228208756055, 7561.810954726176, 7637.770866874002, 7692.730754423568, 7693.68740969567, 7442.330190282901, 7465.6267186641535, 7504.474686771873, 7629.198934111839, 7647.847043059219, 6997.510174287954, 7012.474064445085, 7109.644517774194, 7152.570845749272, 7173.892391614234, 4941.283513890394, 5039.697618142924, 5106.029854327666, 5119.513646203604, 5143.382794064736, 4747.121782470254, 4976.477469865757, 5043.87390315245, 5143.897122057613, 5213.869653258547], "value": 4513.9624373538445, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.53748383779384, 299.0, 300.5641819361925, 303.55983823455995, 305.3039070918304, 5887.6467411955255, 5918.940810591893, 5930.377310382412, 5930.495907847832, 5970.283565972084, 5398.16462402783, 5533.22534845121, 5534.640248383852, 5734.942650573493, 5797.623154494955, 4142.461480007595, 4305.440292761937, 4334.869953901388, 4355.520892701816, 4385.14489674512, 3619.782813031213, 4277.182197566038, 4304.870853874373, 4328.567143285678, 4373.475182978047, 4310.547392523787, 4337.262665346899, 4338.783060846961, 4346.4349634547625, 4377.824887004516, 3719.851205951759, 3760.924781504382, 3953.4465174875395, 4209.957900421018, 4325.762083085429, 3002.369502404498, 3414.931701365984, 3602.8198590070656, 3665.8533658653623, 3665.9104310543003, 4661.7902194400995, 4729.43246810385, 5679.7909181312425, 5690.146478028329, 5695.77216911323, 4012.959870401288, 4539.774260949558, 4775.856724298276, 4924.384451943507, 4964.553190212898, 5618.747156377973, 6093.299270583851, 6095.647393933319, 6121.693915304217, 6128.203333566607, 3368.949465758016, 3398.5411969384313, 4043.1509383029597, 4045.5145382553987, 4060.6954478414236, 5395.541378982791, 5817.331006934214, 5914.61554998928, 6140.662263575501, 6436.232420059373, 3659.780413175218, 4054.8849066506355, 4105.876823695294, 4114.6091121343425, 4123.649489793341, 4131.380292956081, 4140.399642051946, 4146.66826653867, 4171.895702607399, 4172.5410204877435, 4686.81252749893, 4874.488908438325, 4918.778654960535, 4933.531314525115, 4950.801967921243, 5279.551238144801, 5579.218909352694, 6140.539459540552, 6150.600210986271, 6169.598976066542, 1210.074293165729, 1394.2819447984295, 1414.7807089901082, 1414.978775318371, 1432.9539436211624, 854.5513605357237, 855.2388374346837, 858.8582883824224, 892.0, 924.4776701163955, 4711.976440117846, 5608.69152196625, 5631.662100273997, 5636.887262254814, 5644.463775941279, 5715.828525144252, 5770.8738252149915, 6188.783392581328, 6253.093301471261, 6274.874502509924, 4701.694389864648, 5122.795088196505, 5148.322872106483, 5604.915926261109, 5667.829965101054, 2761.0198379575363, 2785.8717219526125, 3216.2792905795286, 3299.472084466474, 3327.717144042735, 6120.888293538722, 6293.968530157412, 6460.806175814733, 6465.741370345228, 6525.0, 5325.653832500875, 6341.938869867312, 6417.74329026843, 6443.194600674916, 6445.645489498029, 5267.0, 5419.756110975016, 6417.39034791694, 6459.354064593691, 6465.77369792055, 5205.427402985744, 5277.788888444419, 5718.818915709512, 6061.484773794277, 6217.378262173746, 4850.80596776125, 5106.7446627669215, 6018.699065046818, 6073.0283154695035, 6139.72371243304, 5946.791862284799, 6236.251649802053, 6392.20097487814, 6435.938070218362, 6519.967400162969, 4007.238624661305, 4033.979830100831, 4045.5233839648904, 4058.411530328027, 4064.878053658395, 5174.0, 5959.642421454727, 6189.6286222826775, 6192.461090952688, 6258.3741625838875, 5097.209932460474, 5195.610329225247, 5813.302403711413, 5985.910211346921, 6051.697415129314, 5677.375488696158, 5745.683987380567, 5886.146508756292, 6019.668918209541, 6066.878662426815, 4944.505549445027, 5795.811858568899, 5873.4126587340925, 5915.373272350138, 5966.67183304905, 5316.734163291742, 5911.817636472637, 6078.845019446468, 6091.878162436815, 6092.238470191226, 5284.286621306228, 5956.791512297049, 5985.25184351956, 5997.460228579449, 6038.0], "value": 4330.993774280201, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.3704371631105, 740.7518481308765, 768.0054329643111, 802.1457148137237, 830.2444775254518, 15067.773983390245, 15480.612984675388, 15704.842951570496, 15728.528144155665, 15754.291056902439, 15254.694906101899, 15957.84042159578, 15983.84016159838, 16052.75920861188, 16324.102174380405, 679.9252082270946, 725.989110163348, 833.6332013913858, 864.3906046237419, 869.6564856881528, 820.3191351178508, 837.1001173738225, 855.80744332525, 858.0389963241179, 858.5792961448908, 870.5777697816554, 898.8831451911242, 899.9145081217274, 902.8871391076116, 904.9864252036225, 859.3683642522741, 898.838209122361, 899.2760827533833, 899.482797391496, 899.649136836631, 637.9202599675041, 645.7868903261913, 656.7635651165576, 661.6394065234459, 665.5108495255982, 15030.248487575687, 15058.924705376512, 15181.392744290215, 15477.071375717493, 15484.0, 14177.220252886087, 14274.714505709931, 14279.428822847074, 14284.142951422948, 14311.642208944859, 11518.078553715683, 11854.940725296405, 11864.991475724573, 11927.821082683766, 12048.97583705386, 3678.70570354371, 3750.5499340079364, 3759.8120093995462, 3763.190913953486, 3903.4535165076913, 109693.0, 110116.0, 110884.0, 111765.0, 112682.30976535441, 9214.262858971266, 10928.0, 10989.61536346224, 11047.83428248577, 11075.833862492069, 17139.914300428667, 18892.622147556973, 21521.0, 21525.892370538048, 22098.668519972212, 7964.681412743541, 8098.877383333008, 8106.797330066795, 8132.512049277062, 8214.548199849065, 3711.4018691588785, 4472.9776351118035, 4483.461984561874, 4581.770911454414, 4708.646851486153, 3594.173340131732, 3610.5125808016105, 3610.6389361064207, 3644.6355364463343, 3679.988003299114, 680.0377465885716, 683.7606837606897, 692.0588000319561, 692.2419950154573, 707.9115110611174, 608.3551435478407, 632.8987362022054, 637.8054693318489, 657.5922927784804, 670.7752902777527, 9021.142991415805, 9227.90772092284, 9402.858957115648, 9451.29115316354, 9487.810243795224, 554.4649413316089, 635.5900444213548, 653.9699972543264, 664.3854434647932, 693.8508220732567, 4603.723776573416, 4674.626029917598, 4691.976540117277, 4692.882677933079, 4711.717296962124, 145148.0, 150552.0, 151550.0, 152008.0, 152656.7214630483, 117745.0, 122741.38629306796, 125776.0, 126176.36911815382, 126387.0, 68517.65741171263, 100307.49846250722, 101253.0, 103232.0, 110303.89696103097, 9430.29272804556, 9873.160781333667, 9960.50197490108, 10067.0, 10245.538950747085, 62583.0, 63367.36632633799, 63727.6813615929, 63863.722725546155, 64355.67822160859, 89295.55352223458, 94952.05047949709, 96692.54961175447, 97059.0, 97763.0, 13243.470261189444, 13312.467501300227, 13392.732145357233, 13580.833580833503, 13717.382717777524, 15016.624584385041, 15033.022853514487, 15112.546623601309, 15280.235988200768, 15624.062556246661, 13851.653708657364, 14013.719725605635, 14015.369308380943, 14417.0, 14515.637109072357, 13821.723565528835, 13942.482527062408, 13952.930235348758, 14447.191980059368, 14545.636359091108, 11808.822867657163, 13469.12450690702, 13570.86429135696, 13831.377588008765, 14287.928560357132, 10132.0, 11141.721456963316, 11493.138014649103, 11645.708857278636, 11917.642470725892, 9050.637974480947, 11639.068874490189, 11644.6506604802, 11745.23655962394, 11779.352135632622], "value": 7878.442969061141, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1568.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 115.0, 105.0, 117.0, 117.0, 120.0, 111.0, 114.0, 118.0, 118.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 113.0, 135.0, 154.0, 111.0, 131.0, 129.0, 110.0, 171.0, 138.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 201.0, 201.0, 204.0, 269.0, 272.0, 187.0, 272.0, 272.0, 205.0], "value": 228.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 84.0, 72.0, 169.0, 86.0, 66.0, 58.0, 63.0, 133.0, 57.0], "value": 85.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 115.0, 70.0, 69.0, 81.0, 113.0, 71.0, 75.0, 110.0], "value": 84.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 129.0, 134.0, 87.0, 90.0, 86.0, 100.0, 114.0, 90.0, 88.0], "value": 99.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 97.0, 99.0, 97.0, 98.0, 151.0, 121.0, 97.0], "value": 104.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 144.0, 140.0, 149.0, 87.0, 137.0, 143.0, 111.0, 93.0, 89.0], "value": 116.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 55.0, 58.0, 57.0, 55.0, 59.0, 61.0, 84.0, 61.0], "value": 60.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 67.0, 74.0, 78.0, 76.0, 69.0, 59.0, 66.0, 98.0], "value": 73.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 101.0, 108.0, 81.0, 82.0, 84.0, 83.0, 84.0, 88.0, 94.0], "value": 89.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 136.0, 135.0, 134.0, 126.0, 147.0, 141.0, 148.0, 184.0, 150.0], "value": 145.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 166.0, 163.0, 165.0, 163.0, 165.0, 162.0, 167.0, 164.0], "value": 164.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 65.0, 69.0, 66.0, 69.0, 67.0, 68.0, 69.0, 66.0], "value": 67.4, "unit": "score"}]}]} 17:23:33 INFO - Return code: 0 17:23:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:23:33 ERROR - # TBPL SUCCESS # 17:23:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:23:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:23:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:23:33 INFO - 2016-06-29 17:23:33.815 screenresolution[1947:19073] starting screenresolution argv=screenresolution get 17:23:33 INFO - 2016-06-29 17:23:33.818 screenresolution[1947:19073] Display 0: 1600x1200x32@60 17:23:33 INFO - 2016-06-29 17:23:33.824 screenresolution[1948:19076] starting screenresolution argv=screenresolution list 17:23:33 INFO - Available Modes on Display 0 17:23:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:23:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:23:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:23:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:23:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:23:34 INFO - Intel Iris: 17:23:34 INFO - Chipset Model: Intel Iris 17:23:34 INFO - Type: GPU 17:23:34 INFO - Bus: Built-In 17:23:34 INFO - VRAM (Dynamic, Max): 1536 MB 17:23:34 INFO - Vendor: Intel (0x8086) 17:23:34 INFO - Device ID: 0x0a2e 17:23:34 INFO - Revision ID: 0x0009 17:23:34 INFO - Displays: 17:23:34 INFO - Display: 17:23:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:23:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:23:34 INFO - Display Serial Number: 1600x1200 60 17:23:34 INFO - Main Display: Yes 17:23:34 INFO - Mirror: Off 17:23:34 INFO - Online: Yes 17:23:34 INFO - Rotation: Supported 17:23:34 INFO - Return code: 0 17:23:34 INFO - Running post-action listener: _resource_record_post_action 17:23:34 INFO - ##### 17:23:34 INFO - ##### Finished run-tests step (success) 17:23:34 INFO - ##### 17:23:34 INFO - Running post-run listener: _resource_record_post_run 17:23:34 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 1122304; Write bytes: 705982464; Read time: 12; Write time: 2038 17:23:34 INFO - TinderboxPrint: CPU usage
54.3% 17:23:34 INFO - TinderboxPrint: I/O read bytes / time
1,122,304 / 12 17:23:34 INFO - TinderboxPrint: I/O write bytes / time
705,982,464 / 2,038 17:23:34 INFO - TinderboxPrint: CPU idle
2,209.5 (45.7%) 17:23:34 INFO - TinderboxPrint: CPU system
978.1 (20.2%) 17:23:34 INFO - TinderboxPrint: CPU user
1,650.0 (34.1%) 17:23:34 INFO - TinderboxPrint: Swap in / out
408,141,824 / 0 17:23:34 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 407632384; Write bytes: 400828416; Read time: 30966; Write time: 874 17:23:34 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 1048576; Write bytes: 295442432; Read time: 11; Write time: 1122 17:23:34 INFO - Running post-run listener: _upload_blobber_files 17:23:34 INFO - Blob upload gear active. 17:23:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:23:34 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 17:23:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:23:34 INFO - (blobuploader) - INFO - Open directory for files ... 17:23:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:23:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:23:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:23:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:23:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:23:35 INFO - (blobuploader) - INFO - Done attempting. 17:23:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:23:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:23:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:23:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:23:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:23:36 INFO - (blobuploader) - INFO - Done attempting. 17:23:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:23:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:23:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:23:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:23:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:23:39 INFO - (blobuploader) - INFO - Done attempting. 17:23:39 INFO - (blobuploader) - INFO - Iteration through files over. 17:23:39 INFO - Return code: 0 17:23:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:23:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:23:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/def5cf6c24c85cd12e9a349aec38790bb9a93bfc1b2df1bc99864ea59abb22a60b59918806a195650f3a07b6582c17a73bfa5fccca1dd56204b456e75c096d5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a9f0acd2eac914192f261946e21bdfe6e2de77f200de858e938c64cf5d0edb02e09bd3c2df4161f10770e7006da13b08847d39c8e70ea74d892450a4105a211", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e373926c7e8e195acd0420a6d9a53b4f2f6a03f4e8c11d8ba5178c45a8ee6e66b82dfc4f05e93f1de3fbd6ef414e356e8c89891fdf089f0d1a73a8f1607a8e1e"} 17:23:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:23:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:23:39 INFO - Contents: 17:23:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/def5cf6c24c85cd12e9a349aec38790bb9a93bfc1b2df1bc99864ea59abb22a60b59918806a195650f3a07b6582c17a73bfa5fccca1dd56204b456e75c096d5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a9f0acd2eac914192f261946e21bdfe6e2de77f200de858e938c64cf5d0edb02e09bd3c2df4161f10770e7006da13b08847d39c8e70ea74d892450a4105a211", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e373926c7e8e195acd0420a6d9a53b4f2f6a03f4e8c11d8ba5178c45a8ee6e66b82dfc4f05e93f1de3fbd6ef414e356e8c89891fdf089f0d1a73a8f1607a8e1e"} 17:23:39 INFO - Running post-run listener: copy_logs_to_upload_dir 17:23:39 INFO - Copying logs to upload dir... 17:23:39 INFO - mkdir: /builds/slave/test/build/upload/logs 17:23:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.728826 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-06-29 17:23:39.648965) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 17:23:39.652606) ========= 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.IzFGrTPJW1/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.vJCPSeP8DI/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/def5cf6c24c85cd12e9a349aec38790bb9a93bfc1b2df1bc99864ea59abb22a60b59918806a195650f3a07b6582c17a73bfa5fccca1dd56204b456e75c096d5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a9f0acd2eac914192f261946e21bdfe6e2de77f200de858e938c64cf5d0edb02e09bd3c2df4161f10770e7006da13b08847d39c8e70ea74d892450a4105a211", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e373926c7e8e195acd0420a6d9a53b4f2f6a03f4e8c11d8ba5178c45a8ee6e66b82dfc4f05e93f1de3fbd6ef414e356e8c89891fdf089f0d1a73a8f1607a8e1e"} build_url:https://queue.taskcluster.net/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011259 build_url: 'https://queue.taskcluster.net/v1/task/Uf0syrceTtGdhpJseBcdyA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/def5cf6c24c85cd12e9a349aec38790bb9a93bfc1b2df1bc99864ea59abb22a60b59918806a195650f3a07b6582c17a73bfa5fccca1dd56204b456e75c096d5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a9f0acd2eac914192f261946e21bdfe6e2de77f200de858e938c64cf5d0edb02e09bd3c2df4161f10770e7006da13b08847d39c8e70ea74d892450a4105a211", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e373926c7e8e195acd0420a6d9a53b4f2f6a03f4e8c11d8ba5178c45a8ee6e66b82dfc4f05e93f1de3fbd6ef414e356e8c89891fdf089f0d1a73a8f1607a8e1e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 17:23:39.686018) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 17:23:39.686378) ========= 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.IzFGrTPJW1/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.vJCPSeP8DI/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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.005120 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 17:23:39.739888) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 17:23:39.740793) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 17:23:39.741494) ========= ========= Total master_lag: 0.20 =========