builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0365 starttime: 1468241865.64 results: success (0) buildid: 20160711024832 builduid: adfde23437bc4ea9866eda05deae5038 revision: 1bee8d2da23ec894980fb14f516210fd83e5b9f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 05:57:45.642562) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 05:57:45.643057) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 05:57:45.643374) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 05:57:45.675133) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 05:57:45.675467) ========= 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.8HnU0mUdeX/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.zp0IUXjzrj/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-11 05:57:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 168M=0s 2016-07-11 05:57:45 (168 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124100 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 05:57:45.826057) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 05:57:45.826819) ========= 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.8HnU0mUdeX/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.zp0IUXjzrj/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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.025549 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 05:57:45.878627) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-11 05:57:45.879375) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1bee8d2da23ec894980fb14f516210fd83e5b9f9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1bee8d2da23ec894980fb14f516210fd83e5b9f9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8HnU0mUdeX/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.zp0IUXjzrj/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-11 05:57:45,963 truncating revision to first 12 chars 2016-07-11 05:57:45,963 Setting DEBUG logging. 2016-07-11 05:57:45,963 attempt 1/10 2016-07-11 05:57:45,963 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1bee8d2da23e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 05:57:46,946 unpacking tar archive at: mozilla-central-1bee8d2da23e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.269940 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-11 05:57:47.177048) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 05:57:47.177950) ========= script_repo_revision: 1bee8d2da23ec894980fb14f516210fd83e5b9f9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 05:57:47.178421) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 05:57:47.178729) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 05:57:47.197718) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-07-11 05:57:47.198073) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8HnU0mUdeX/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.zp0IUXjzrj/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 05:57:47 INFO - MultiFileLogger online at 20160711 05:57:47 in /builds/slave/test 05:57:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:57:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:57:47 INFO - {'append_to_log': False, 05:57:47 INFO - 'base_work_dir': '/builds/slave/test', 05:57:47 INFO - 'blob_upload_branch': 'Firefox', 05:57:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:57:47 INFO - 'branch': 'Firefox', 05:57:47 INFO - 'buildbot_json_path': 'buildprops.json', 05:57:47 INFO - 'config_files': ('talos/mac_config.py',), 05:57:47 INFO - 'default_actions': ('clobber', 05:57:47 INFO - 'read-buildbot-config', 05:57:47 INFO - 'download-and-extract', 05:57:47 INFO - 'populate-webroot', 05:57:47 INFO - 'create-virtualenv', 05:57:47 INFO - 'install', 05:57:47 INFO - 'run-tests'), 05:57:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:57:47 INFO - 'download_minidump_stackwalk': True, 05:57:47 INFO - 'download_symbols': 'ondemand', 05:57:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:57:47 INFO - 'tooltool.py': '/tools/tooltool.py', 05:57:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:57:47 INFO - '/tools/misc-python/virtualenv.py')}, 05:57:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:57:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:57:47 INFO - 'installer_path': 'installer.exe', 05:57:47 INFO - 'log_level': 'info', 05:57:47 INFO - 'log_name': 'talos', 05:57:47 INFO - 'log_to_console': True, 05:57:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:57:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:57:47 INFO - 'opt_config_files': (), 05:57:47 INFO - 'pip_index': False, 05:57:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:57:47 INFO - 'cmd': ('bash', 05:57:47 INFO - '-c', 05:57:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:57:47 INFO - 'enabled': True, 05:57:47 INFO - 'halt_on_failure': False, 05:57:47 INFO - 'name': 'check_screen_resolution'},), 05:57:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:57:47 INFO - 'cmd': ('bash', 05:57:47 INFO - '-c', 05:57:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:57:47 INFO - 'enabled': True, 05:57:47 INFO - 'halt_on_failure': False, 05:57:47 INFO - 'name': 'check_screen_resolution'},), 05:57:47 INFO - 'run_cmd_checks_enabled': True, 05:57:47 INFO - 'sps_profile': False, 05:57:47 INFO - 'sps_profile_interval': 0, 05:57:47 INFO - 'suite': 'dromaeojs', 05:57:47 INFO - 'system_bits': '32', 05:57:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:57:47 INFO - 'title': 't-yosemite-r7-0365', 05:57:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:57:47 INFO - 'use_talos_json': True, 05:57:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:57:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:57:47 INFO - 'work_dir': 'build'} 05:57:47 INFO - ##### 05:57:47 INFO - ##### Running clobber step. 05:57:47 INFO - ##### 05:57:47 INFO - Running pre-action listener: _resource_record_pre_action 05:57:47 INFO - Running main action method: clobber 05:57:47 INFO - rmtree: /builds/slave/test/build 05:57:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:57:49 INFO - Running post-action listener: _resource_record_post_action 05:57:49 INFO - ##### 05:57:49 INFO - ##### Finished clobber step (success) 05:57:49 INFO - ##### 05:57:49 INFO - ##### 05:57:49 INFO - ##### Running read-buildbot-config step. 05:57:49 INFO - ##### 05:57:49 INFO - Running pre-action listener: _resource_record_pre_action 05:57:49 INFO - Running main action method: read_buildbot_config 05:57:49 INFO - Using buildbot properties: 05:57:49 INFO - { 05:57:49 INFO - "project": "", 05:57:49 INFO - "product": "firefox", 05:57:49 INFO - "script_repo_revision": "production", 05:57:49 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:57:49 INFO - "repository": "", 05:57:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:57:49 INFO - "buildid": "20160711024832", 05:57:49 INFO - "pgo_build": "False", 05:57:49 INFO - "basedir": "/builds/slave/test", 05:57:49 INFO - "buildnumber": 7, 05:57:49 INFO - "slavename": "t-yosemite-r7-0365", 05:57:49 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:57:49 INFO - "platform": "yosemite_r7", 05:57:49 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:57:49 INFO - "branch": "mozilla-central", 05:57:49 INFO - "repo_path": "mozilla-central", 05:57:49 INFO - "revision": "1bee8d2da23ec894980fb14f516210fd83e5b9f9", 05:57:49 INFO - "stage_platform": "macosx64", 05:57:49 INFO - "builduid": "adfde23437bc4ea9866eda05deae5038", 05:57:49 INFO - "slavebuilddir": "test" 05:57:49 INFO - } 05:57:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/BNYUPhiKSROGLoiy2sZAyw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 05:57:49 INFO - Running post-action listener: _resource_record_post_action 05:57:49 INFO - ##### 05:57:49 INFO - ##### Finished read-buildbot-config step (success) 05:57:49 INFO - ##### 05:57:49 INFO - ##### 05:57:49 INFO - ##### Running download-and-extract step. 05:57:49 INFO - ##### 05:57:49 INFO - Running pre-action listener: _resource_record_pre_action 05:57:49 INFO - Running main action method: download_and_extract 05:57:49 INFO - mkdir: /builds/slave/test/build/tests 05:57:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:57:49 INFO - https://queue.taskcluster.net/v1/task/BNYUPhiKSROGLoiy2sZAyw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:57:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BNYUPhiKSROGLoiy2sZAyw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 05:57:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BNYUPhiKSROGLoiy2sZAyw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 05:57:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BNYUPhiKSROGLoiy2sZAyw/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 05:57:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BNYUPhiKSROGLoiy2sZAyw/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 05:57:50 INFO - Downloaded 1199 bytes. 05:57:50 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 05:57:50 INFO - Using the following test package requirements: 05:57:50 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 05:57:50 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:57:50 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 05:57:50 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:57:50 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 05:57:50 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:57:50 INFO - u'jsshell-mac.zip'], 05:57:50 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:57:50 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 05:57:50 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 05:57:50 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:57:50 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 05:57:50 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:57:50 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 05:57:50 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:57:50 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 05:57:50 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:57:50 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 05:57:50 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:57: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')]} 05:57:50 INFO - https://queue.taskcluster.net/v1/task/BNYUPhiKSROGLoiy2sZAyw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:57:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BNYUPhiKSROGLoiy2sZAyw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:57:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BNYUPhiKSROGLoiy2sZAyw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:57:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BNYUPhiKSROGLoiy2sZAyw/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 05:57:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BNYUPhiKSROGLoiy2sZAyw/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 05:57:51 INFO - Downloaded 18806882 bytes. 05:57:51 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'] 05:57:51 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 05:57:54 INFO - Return code: 0 05:57:54 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 05:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:54 INFO - https://queue.taskcluster.net/v1/task/BNYUPhiKSROGLoiy2sZAyw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:57:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BNYUPhiKSROGLoiy2sZAyw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:57:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BNYUPhiKSROGLoiy2sZAyw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:57:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BNYUPhiKSROGLoiy2sZAyw/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 05:57:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BNYUPhiKSROGLoiy2sZAyw/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 05:57:57 INFO - Downloaded 18806882 bytes. 05:57:57 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'] 05:57:57 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 05:58:00 INFO - Return code: 0 05:58:00 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')]} 05:58:00 INFO - https://queue.taskcluster.net/v1/task/BNYUPhiKSROGLoiy2sZAyw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:58:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BNYUPhiKSROGLoiy2sZAyw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 05:58:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BNYUPhiKSROGLoiy2sZAyw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 05:58:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BNYUPhiKSROGLoiy2sZAyw/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 05:58:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BNYUPhiKSROGLoiy2sZAyw/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 05:58:01 INFO - Downloaded 14403333 bytes. 05:58:01 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'] 05:58:01 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 05:58:02 INFO - Return code: 0 05:58: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')]} 05:58:02 INFO - https://queue.taskcluster.net/v1/task/BNYUPhiKSROGLoiy2sZAyw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:58:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BNYUPhiKSROGLoiy2sZAyw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:58:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BNYUPhiKSROGLoiy2sZAyw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:58:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BNYUPhiKSROGLoiy2sZAyw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 05:58:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BNYUPhiKSROGLoiy2sZAyw/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 05:58:04 INFO - Downloaded 112368819 bytes. 05:58:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BNYUPhiKSROGLoiy2sZAyw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:58:04 INFO - mkdir: /builds/slave/test/properties 05:58:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:58:04 INFO - Writing to file /builds/slave/test/properties/build_url 05:58:04 INFO - Contents: 05:58:04 INFO - build_url:https://queue.taskcluster.net/v1/task/BNYUPhiKSROGLoiy2sZAyw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:58:06 INFO - Running post-action listener: _resource_record_post_action 05:58:06 INFO - Running post-action listener: set_extra_try_arguments 05:58:06 INFO - ##### 05:58:06 INFO - ##### Finished download-and-extract step (success) 05:58:06 INFO - ##### 05:58:06 INFO - ##### 05:58:06 INFO - ##### Running populate-webroot step. 05:58:06 INFO - ##### 05:58:06 INFO - Running pre-action listener: _resource_record_pre_action 05:58:06 INFO - Running main action method: populate_webroot 05:58:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:58:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:58:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:58:06 INFO - '--tppagecycles', 05:58:06 INFO - '7'], 05:58:06 INFO - 'tests': ['tsvgm']}}, 05:58:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:58:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:58:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:58:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:58:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:58:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:58:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:06 INFO - 'talos_options': ['--disable-e10s'], 05:58:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:06 INFO - 'talos_options': ['--disable-e10s'], 05:58:06 INFO - 'tests': ['damp', 'tps']}, 05:58:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:06 INFO - 'tests': ['damp', 'tps']}, 05:58:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:58:06 INFO - 'tests': ['dromaeo_dom']}, 05:58:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:58:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:58:06 INFO - 'tests': ['basic_compositor_video']}, 05:58:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:58:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:58:06 INFO - 'tests': ['a11yr', 05:58:06 INFO - 'ts_paint', 05:58:06 INFO - 'tpaint', 05:58:06 INFO - 'sessionrestore', 05:58:06 INFO - 'sessionrestore_no_auto_restore', 05:58:06 INFO - 'tabpaint']}, 05:58:06 INFO - 'other-e10s': {'tests': ['a11yr', 05:58:06 INFO - 'ts_paint', 05:58:06 INFO - 'tpaint', 05:58:06 INFO - 'sessionrestore', 05:58:06 INFO - 'sessionrestore_no_auto_restore', 05:58:06 INFO - 'tabpaint']}, 05:58:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:58:06 INFO - 'ts_paint', 05:58:06 INFO - 'tpaint', 05:58:06 INFO - 'sessionrestore', 05:58:06 INFO - 'sessionrestore_no_auto_restore', 05:58:06 INFO - 'tabpaint']}, 05:58:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:58:06 INFO - 'ts_paint', 05:58:06 INFO - 'tpaint', 05:58:06 INFO - 'sessionrestore', 05:58:06 INFO - 'sessionrestore_no_auto_restore', 05:58:06 INFO - 'tabpaint']}, 05:58:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:58:06 INFO - 'tests': ['a11yr', 05:58:06 INFO - 'ts_paint', 05:58:06 INFO - 'tpaint', 05:58:06 INFO - 'sessionrestore', 05:58:06 INFO - 'sessionrestore_no_auto_restore', 05:58:06 INFO - 'tabpaint']}, 05:58:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:58:06 INFO - 'tests': ['a11yr', 05:58:06 INFO - 'ts_paint', 05:58:06 INFO - 'tpaint', 05:58:06 INFO - 'sessionrestore', 05:58:06 INFO - 'sessionrestore_no_auto_restore', 05:58:06 INFO - 'tabpaint']}, 05:58:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:58:06 INFO - 'tests': ['tsvgx', 05:58:06 INFO - 'tsvgr_opacity', 05:58:06 INFO - 'tart', 05:58:06 INFO - 'tscrollx', 05:58:06 INFO - 'cart']}, 05:58:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:58:06 INFO - 'tsvgr_opacity', 05:58:06 INFO - 'tart', 05:58:06 INFO - 'tscrollx', 05:58:06 INFO - 'cart']}, 05:58:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:06 INFO - 'talos_options': ['--disable-e10s'], 05:58:06 INFO - 'tests': ['tp5o']}, 05:58:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:06 INFO - 'tests': ['tp5o']}, 05:58:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:06 INFO - 'talos_options': ['--disable-e10s', 05:58:06 INFO - '--xperf_path', 05:58:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:06 INFO - 'tests': ['tp5n']}, 05:58:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:06 INFO - 'talos_options': ['--xperf_path', 05:58:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:06 INFO - 'tests': ['tp5n']}}, 05:58:06 INFO - 'talos.zip': {'path': '', 05:58:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:58:06 INFO - Running post-action listener: _resource_record_post_action 05:58:06 INFO - ##### 05:58:06 INFO - ##### Finished populate-webroot step (success) 05:58:06 INFO - ##### 05:58:06 INFO - ##### 05:58:06 INFO - ##### Running create-virtualenv step. 05:58:06 INFO - ##### 05:58:06 INFO - Running pre-action listener: _resource_record_pre_action 05:58:06 INFO - Running main action method: create_virtualenv 05:58:06 INFO - Creating virtualenv /builds/slave/test/build/venv 05:58:06 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 05:58:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:58:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:58:06 INFO - Using real prefix '/tools/python27' 05:58:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:58:07 INFO - Installing distribute.............................................................................................................................................................................................done. 05:58:10 INFO - Installing pip.................done. 05:58:10 INFO - Return code: 0 05:58:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10306da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103102618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f8497e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fd1d30>, '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 0x102d36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102fc9b20>, '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.8HnU0mUdeX/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.zp0IUXjzrj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 05:58:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:58:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:58:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8HnU0mUdeX/Render', 05:58:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:10 INFO - 'HOME': '/Users/cltbld', 05:58:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:10 INFO - 'LOGNAME': 'cltbld', 05:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:10 INFO - 'MOZ_NO_REMOTE': '1', 05:58:10 INFO - 'NO_EM_RESTART': '1', 05:58:10 INFO - 'PAGER': '/bin/cat', 05:58:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:10 INFO - 'PWD': '/builds/slave/test', 05:58:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:10 INFO - 'SHELL': '/bin/bash', 05:58:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zp0IUXjzrj/Listeners', 05:58:10 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 05:58:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:10 INFO - 'USER': 'cltbld', 05:58:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:10 INFO - 'XPC_FLAGS': '0x0', 05:58:10 INFO - 'XPC_SERVICE_NAME': '0', 05:58:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:10 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 05:58:10 INFO - Cleaning up... 05:58:10 INFO - Return code: 0 05:58:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10306da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103102618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f8497e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fd1d30>, '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 0x102d36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102fc9b20>, '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.8HnU0mUdeX/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.zp0IUXjzrj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 05:58:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:58:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:58:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8HnU0mUdeX/Render', 05:58:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:10 INFO - 'HOME': '/Users/cltbld', 05:58:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:10 INFO - 'LOGNAME': 'cltbld', 05:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:10 INFO - 'MOZ_NO_REMOTE': '1', 05:58:10 INFO - 'NO_EM_RESTART': '1', 05:58:10 INFO - 'PAGER': '/bin/cat', 05:58:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:10 INFO - 'PWD': '/builds/slave/test', 05:58:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:10 INFO - 'SHELL': '/bin/bash', 05:58:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zp0IUXjzrj/Listeners', 05:58:10 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 05:58:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:10 INFO - 'USER': 'cltbld', 05:58:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:10 INFO - 'XPC_FLAGS': '0x0', 05:58:10 INFO - 'XPC_SERVICE_NAME': '0', 05:58:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:10 INFO - Downloading/unpacking psutil>=3.1.1 05:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:58:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:13 INFO - Installing collected packages: psutil 05:58:13 INFO - Running setup.py install for psutil 05:58:13 INFO - building 'psutil._psutil_osx' extension 05:58:13 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 05:58:14 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 05:58:14 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 05:58:14 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 05:58:14 INFO - building 'psutil._psutil_posix' extension 05:58:14 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 05:58:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:58:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:58:14 INFO - ^ 05:58:14 INFO - 1 warning generated. 05:58:14 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 05:58:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:14 INFO - Successfully installed psutil 05:58:14 INFO - Cleaning up... 05:58:14 INFO - Return code: 0 05:58:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:58: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')]} 05:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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')]} 05:58:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:14 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 0x10306da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103102618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f8497e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fd1d30>, '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 0x102d36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102fc9b20>, '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.8HnU0mUdeX/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.zp0IUXjzrj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 05:58:14 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 05:58:14 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 05:58:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8HnU0mUdeX/Render', 05:58:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:14 INFO - 'HOME': '/Users/cltbld', 05:58:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:14 INFO - 'LOGNAME': 'cltbld', 05:58:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:14 INFO - 'MOZ_NO_REMOTE': '1', 05:58:14 INFO - 'NO_EM_RESTART': '1', 05:58:14 INFO - 'PAGER': '/bin/cat', 05:58:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:14 INFO - 'PWD': '/builds/slave/test', 05:58:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:14 INFO - 'SHELL': '/bin/bash', 05:58:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zp0IUXjzrj/Listeners', 05:58:14 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 05:58:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:14 INFO - 'USER': 'cltbld', 05:58:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:14 INFO - 'XPC_FLAGS': '0x0', 05:58:14 INFO - 'XPC_SERVICE_NAME': '0', 05:58:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:58:15 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 05:58:15 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 05:58:15 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 05:58:15 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 05:58:15 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 05:58:15 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 05:58:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:58:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:58:17 INFO - Installing collected packages: mozsystemmonitor 05:58:17 INFO - Running setup.py install for mozsystemmonitor 05:58:17 INFO - Successfully installed mozsystemmonitor 05:58:17 INFO - Cleaning up... 05:58:17 INFO - Return code: 0 05:58:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10306da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103102618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f8497e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fd1d30>, '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 0x102d36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102fc9b20>, '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.8HnU0mUdeX/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.zp0IUXjzrj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 05:58:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:58:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8HnU0mUdeX/Render', 05:58:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:17 INFO - 'HOME': '/Users/cltbld', 05:58:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:17 INFO - 'LOGNAME': 'cltbld', 05:58:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:17 INFO - 'MOZ_NO_REMOTE': '1', 05:58:17 INFO - 'NO_EM_RESTART': '1', 05:58:17 INFO - 'PAGER': '/bin/cat', 05:58:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:17 INFO - 'PWD': '/builds/slave/test', 05:58:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:17 INFO - 'SHELL': '/bin/bash', 05:58:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zp0IUXjzrj/Listeners', 05:58:17 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 05:58:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:17 INFO - 'USER': 'cltbld', 05:58:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:17 INFO - 'XPC_FLAGS': '0x0', 05:58:17 INFO - 'XPC_SERVICE_NAME': '0', 05:58:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:18 INFO - Downloading/unpacking jsonschema==2.5.1 05:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:58:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:20 INFO - Downloading functools32-3.2.3-2.tar.gz 05:58:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:58:21 INFO - warning: no files found matching '*.txt' 05:58:21 INFO - no previously-included directories found matching 'build' 05:58:21 INFO - no previously-included directories found matching 'dist' 05:58:21 INFO - no previously-included directories found matching '.git*' 05:58:21 INFO - Installing collected packages: jsonschema, functools32 05:58:21 INFO - Running setup.py install for functools32 05:58:21 INFO - warning: no files found matching '*.txt' 05:58:21 INFO - no previously-included directories found matching 'build' 05:58:21 INFO - no previously-included directories found matching 'dist' 05:58:21 INFO - no previously-included directories found matching '.git*' 05:58:21 INFO - Successfully installed jsonschema functools32 05:58:21 INFO - Cleaning up... 05:58:21 INFO - Return code: 0 05:58:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:58:21 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')]} 05:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:21 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')]} 05:58:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:21 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 0x10306da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103102618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f8497e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fd1d30>, '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 0x102d36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102fc9b20>, '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.8HnU0mUdeX/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.zp0IUXjzrj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 05:58:21 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 05:58:21 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 05:58:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8HnU0mUdeX/Render', 05:58:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:21 INFO - 'HOME': '/Users/cltbld', 05:58:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:21 INFO - 'LOGNAME': 'cltbld', 05:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:21 INFO - 'MOZ_NO_REMOTE': '1', 05:58:21 INFO - 'NO_EM_RESTART': '1', 05:58:21 INFO - 'PAGER': '/bin/cat', 05:58:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:21 INFO - 'PWD': '/builds/slave/test', 05:58:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:21 INFO - 'SHELL': '/bin/bash', 05:58:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zp0IUXjzrj/Listeners', 05:58:21 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 05:58:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:21 INFO - 'USER': 'cltbld', 05:58:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:21 INFO - 'XPC_FLAGS': '0x0', 05:58:21 INFO - 'XPC_SERVICE_NAME': '0', 05:58:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:21 INFO - Downloading/unpacking blobuploader==1.2.4 05:58:21 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 05:58:21 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 05:58:21 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 05:58:21 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 05:58:21 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 05:58:21 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 05:58:23 INFO - Downloading blobuploader-1.2.4.tar.gz 05:58:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:58:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:58:24 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 05:58:24 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 05:58:24 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 05:58:24 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 05:58:24 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 05:58:24 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 05:58:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:58:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:58:24 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 05:58:24 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 05:58:24 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 05:58:24 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 05:58:24 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 05:58:24 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 05:58:25 INFO - Downloading docopt-0.6.1.tar.gz 05:58:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:58:25 INFO - Installing collected packages: blobuploader, requests, docopt 05:58:25 INFO - Running setup.py install for blobuploader 05:58:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:58:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:58:25 INFO - Running setup.py install for requests 05:58:26 INFO - Running setup.py install for docopt 05:58:26 INFO - Successfully installed blobuploader requests docopt 05:58:26 INFO - Cleaning up... 05:58:26 INFO - Return code: 0 05:58:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:26 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')]} 05:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:26 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')]} 05:58:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:26 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 0x10306da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103102618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f8497e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fd1d30>, '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 0x102d36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102fc9b20>, '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.8HnU0mUdeX/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.zp0IUXjzrj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 05:58:26 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 05:58:26 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 05:58:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8HnU0mUdeX/Render', 05:58:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:26 INFO - 'HOME': '/Users/cltbld', 05:58:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:26 INFO - 'LOGNAME': 'cltbld', 05:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:26 INFO - 'MOZ_NO_REMOTE': '1', 05:58:26 INFO - 'NO_EM_RESTART': '1', 05:58:26 INFO - 'PAGER': '/bin/cat', 05:58:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:26 INFO - 'PWD': '/builds/slave/test', 05:58:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:26 INFO - 'SHELL': '/bin/bash', 05:58:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zp0IUXjzrj/Listeners', 05:58:26 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 05:58:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:26 INFO - 'USER': 'cltbld', 05:58:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:26 INFO - 'XPC_FLAGS': '0x0', 05:58:26 INFO - 'XPC_SERVICE_NAME': '0', 05:58:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:26 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-sXViXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:26 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-PQE7tR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:26 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-M5yGf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:26 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-M6szcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:26 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-zk87Dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:27 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-EwiRQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:27 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-eIKPKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:27 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-g1ftf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:27 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-H3L4Re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:27 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-_dyMMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:27 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-dGS4Ph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:27 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-0UqqRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:27 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-EcA1rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:27 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-qmNU2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:27 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-WyIITK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:28 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-vMaBoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:28 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-sQC4mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:58:28 INFO - Running setup.py install for manifestparser 05:58:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:58:28 INFO - Running setup.py install for mozcrash 05:58:28 INFO - Running setup.py install for mozdebug 05:58:28 INFO - Running setup.py install for mozdevice 05:58:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:58:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:58:28 INFO - Running setup.py install for mozfile 05:58:29 INFO - Running setup.py install for mozhttpd 05:58:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:58:29 INFO - Running setup.py install for mozinfo 05:58:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:58:29 INFO - Running setup.py install for mozInstall 05:58:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:58:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:58:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:58:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:58:29 INFO - Running setup.py install for mozleak 05:58:29 INFO - Running setup.py install for mozlog 05:58:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:58:29 INFO - Running setup.py install for moznetwork 05:58:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:58:29 INFO - Running setup.py install for mozprocess 05:58:30 INFO - Running setup.py install for mozprofile 05:58:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:58:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:58:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:58:30 INFO - Running setup.py install for mozrunner 05:58:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:58:30 INFO - Running setup.py install for mozscreenshot 05:58:30 INFO - Running setup.py install for moztest 05:58:30 INFO - Running setup.py install for mozversion 05:58:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:58:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:58:30 INFO - Cleaning up... 05:58:30 INFO - Return code: 0 05:58:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:58:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:30 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 0x10306da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103102618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f8497e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fd1d30>, '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 0x102d36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102fc9b20>, '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.8HnU0mUdeX/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.zp0IUXjzrj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 05:58:30 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 05:58:30 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 05:58:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8HnU0mUdeX/Render', 05:58:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:30 INFO - 'HOME': '/Users/cltbld', 05:58:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:30 INFO - 'LOGNAME': 'cltbld', 05:58:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:30 INFO - 'MOZ_NO_REMOTE': '1', 05:58:30 INFO - 'NO_EM_RESTART': '1', 05:58:30 INFO - 'PAGER': '/bin/cat', 05:58:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:30 INFO - 'PWD': '/builds/slave/test', 05:58:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:30 INFO - 'SHELL': '/bin/bash', 05:58:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zp0IUXjzrj/Listeners', 05:58:30 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 05:58:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:30 INFO - 'USER': 'cltbld', 05:58:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:30 INFO - 'XPC_FLAGS': '0x0', 05:58:30 INFO - 'XPC_SERVICE_NAME': '0', 05:58:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:31 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-iQIV39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:31 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)) 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:31 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-zh_Twd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:31 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)) 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:31 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-KTzdTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:31 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)) 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:31 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-8gYrQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:31 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)) 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:31 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-HMopQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:31 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)) 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:31 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-KWWyBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:31 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)) 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:31 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-VBVhhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:31 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)) 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:31 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-2fEaie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:31 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)) 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:31 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-ArHO2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:32 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)) 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:32 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-TuiQjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:32 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)) 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:32 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-mIsjYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:32 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)) 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:32 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-W6xSMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:32 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-Al8n5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:32 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)) 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:32 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-qFF7xH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:32 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-xwA0ZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:32 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)) 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:32 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-kIioay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:32 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)) 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:32 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-3zvM9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:32 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)) 05:58:32 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)) 05:58:32 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)) 05:58:32 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)) 05:58:32 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)) 05:58:32 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)) 05:58:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:35 INFO - Downloading blessings-1.6.tar.gz 05:58:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:58:35 INFO - Installing collected packages: blessings 05:58:35 INFO - Running setup.py install for blessings 05:58:36 INFO - Successfully installed blessings 05:58:36 INFO - Cleaning up... 05:58:36 INFO - Return code: 0 05:58:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:58:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:36 INFO - Reading from file tmpfile_stdout 05:58:36 INFO - Current package versions: 05:58:36 INFO - blessings == 1.6 05:58:36 INFO - blobuploader == 1.2.4 05:58:36 INFO - docopt == 0.6.1 05:58:36 INFO - functools32 == 3.2.3-2 05:58:36 INFO - jsonschema == 2.5.1 05:58:36 INFO - manifestparser == 1.1 05:58:36 INFO - mozInstall == 1.12 05:58:36 INFO - mozcrash == 0.17 05:58:36 INFO - mozdebug == 0.1 05:58:36 INFO - mozdevice == 0.48 05:58:36 INFO - mozfile == 1.2 05:58:36 INFO - mozhttpd == 0.7 05:58:36 INFO - mozinfo == 0.9 05:58:36 INFO - mozleak == 0.1 05:58:36 INFO - mozlog == 3.2 05:58:36 INFO - moznetwork == 0.27 05:58:36 INFO - mozprocess == 0.23 05:58:36 INFO - mozprofile == 0.28 05:58:36 INFO - mozrunner == 6.12 05:58:36 INFO - mozscreenshot == 0.1 05:58:36 INFO - mozsystemmonitor == 0.3 05:58:36 INFO - moztest == 0.7 05:58:36 INFO - mozversion == 1.4 05:58:36 INFO - psutil == 3.1.1 05:58:36 INFO - requests == 1.2.3 05:58:36 INFO - wsgiref == 0.1.2 05:58:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58: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')]} 05:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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')]} 05:58:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:36 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 0x10306da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103102618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f8497e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fd1d30>, '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 0x102d36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102fc9b20>, '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.8HnU0mUdeX/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.zp0IUXjzrj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 05:58:36 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 05:58:36 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 05:58:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8HnU0mUdeX/Render', 05:58:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:36 INFO - 'HOME': '/Users/cltbld', 05:58:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:36 INFO - 'LOGNAME': 'cltbld', 05:58:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:36 INFO - 'MOZ_NO_REMOTE': '1', 05:58:36 INFO - 'NO_EM_RESTART': '1', 05:58:36 INFO - 'PAGER': '/bin/cat', 05:58:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:36 INFO - 'PWD': '/builds/slave/test', 05:58:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:36 INFO - 'SHELL': '/bin/bash', 05:58:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zp0IUXjzrj/Listeners', 05:58:36 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 05:58:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:36 INFO - 'USER': 'cltbld', 05:58:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:36 INFO - 'XPC_FLAGS': '0x0', 05:58:36 INFO - 'XPC_SERVICE_NAME': '0', 05:58:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:37 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)) 05:58:37 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)) 05:58:37 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)) 05:58:37 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)) 05:58:37 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)) 05:58:37 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)) 05:58:37 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)) 05:58:37 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)) 05:58:37 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)) 05:58:37 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)) 05:58:37 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)) 05:58:37 INFO - Cleaning up... 05:58:37 INFO - Return code: 0 05:58:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10306da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103102618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f8497e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fd1d30>, '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 0x102d36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102fc9b20>, '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.8HnU0mUdeX/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.zp0IUXjzrj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 05:58:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:58:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:58:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8HnU0mUdeX/Render', 05:58:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:37 INFO - 'HOME': '/Users/cltbld', 05:58:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:37 INFO - 'LOGNAME': 'cltbld', 05:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:37 INFO - 'MOZ_NO_REMOTE': '1', 05:58:37 INFO - 'NO_EM_RESTART': '1', 05:58:37 INFO - 'PAGER': '/bin/cat', 05:58:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:37 INFO - 'PWD': '/builds/slave/test', 05:58:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:37 INFO - 'SHELL': '/bin/bash', 05:58:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zp0IUXjzrj/Listeners', 05:58:37 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 05:58:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:37 INFO - 'USER': 'cltbld', 05:58:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:37 INFO - 'XPC_FLAGS': '0x0', 05:58:37 INFO - 'XPC_SERVICE_NAME': '0', 05:58:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:58:37 INFO - Cleaning up... 05:58:37 INFO - Return code: 0 05:58:37 INFO - Running post-action listener: _resource_record_post_action 05:58:37 INFO - Running post-action listener: _start_resource_monitoring 05:58:37 INFO - Starting resource monitoring. 05:58:37 INFO - ##### 05:58:37 INFO - ##### Finished create-virtualenv step (success) 05:58:37 INFO - ##### 05:58:37 INFO - ##### 05:58:37 INFO - ##### Running install step. 05:58:37 INFO - ##### 05:58:37 INFO - Running pre-action listener: _resource_record_pre_action 05:58:37 INFO - Running main action method: install 05:58:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:37 INFO - Reading from file tmpfile_stdout 05:58:37 INFO - Detecting whether we're running mozinstall >=1.0... 05:58:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:58:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:58:37 INFO - Reading from file tmpfile_stdout 05:58:37 INFO - Output received: 05:58:37 INFO - Usage: mozinstall [options] installer 05:58:37 INFO - Options: 05:58:37 INFO - -h, --help show this help message and exit 05:58:37 INFO - -d DEST, --destination=DEST 05:58:37 INFO - Directory to install application into. [default: 05:58:37 INFO - "/builds/slave/test"] 05:58:37 INFO - --app=APP Application being installed. [default: firefox] 05:58:37 INFO - mkdir: /builds/slave/test/build/application 05:58:37 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'] 05:58:37 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 05:59:11 INFO - Reading from file tmpfile_stdout 05:59:11 INFO - Output received: 05:59:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:59:11 INFO - Running post-action listener: _resource_record_post_action 05:59:11 INFO - ##### 05:59:11 INFO - ##### Finished install step (success) 05:59:11 INFO - ##### 05:59:11 INFO - ##### 05:59:11 INFO - ##### Running run-tests step. 05:59:11 INFO - ##### 05:59:11 INFO - Running pre-action listener: _resource_record_pre_action 05:59:11 INFO - Running main action method: run_tests 05:59:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:59:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:59:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:59:11 INFO - 2016-07-11 05:59:11.779 screenresolution[1639:7404] starting screenresolution argv=screenresolution get 05:59:11 INFO - 2016-07-11 05:59:11.781 screenresolution[1639:7404] Display 0: 1600x1200x32@60 05:59:11 INFO - 2016-07-11 05:59:11.787 screenresolution[1640:7406] starting screenresolution argv=screenresolution list 05:59:11 INFO - Available Modes on Display 0 05:59:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:59:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:59:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:59:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:59:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:59:12 INFO - Intel Iris: 05:59:12 INFO - Chipset Model: Intel Iris 05:59:12 INFO - Type: GPU 05:59:12 INFO - Bus: Built-In 05:59:12 INFO - VRAM (Dynamic, Max): 1536 MB 05:59:12 INFO - Vendor: Intel (0x8086) 05:59:12 INFO - Device ID: 0x0a2e 05:59:12 INFO - Revision ID: 0x0009 05:59:12 INFO - Displays: 05:59:12 INFO - Display: 05:59:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:59:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:59:12 INFO - Display Serial Number: 1600x1200 60 05:59:12 INFO - Main Display: Yes 05:59:12 INFO - Mirror: Off 05:59:12 INFO - Online: Yes 05:59:12 INFO - Rotation: Supported 05:59:12 INFO - Return code: 0 05:59:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:59:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:59:12 INFO - Python 2.7.3 05:59:12 INFO - Return code: 0 05:59:12 INFO - grabbing minidump binary from tooltool 05:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:59:12 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 0x102fd1d30>, '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 0x102d36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102fc9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:59:12 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 05:59:12 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 05:59:12 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 05:59:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:59:12 INFO - Return code: 0 05:59:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:59:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:59:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:59:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:59:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:59:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BNYUPhiKSROGLoiy2sZAyw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0365', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:59:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BNYUPhiKSROGLoiy2sZAyw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0365 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:59:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8HnU0mUdeX/Render', 05:59:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:12 INFO - 'HOME': '/Users/cltbld', 05:59:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:12 INFO - 'LOGNAME': 'cltbld', 05:59:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:59:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:12 INFO - 'MOZ_NO_REMOTE': '1', 05:59:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:59:12 INFO - 'NO_EM_RESTART': '1', 05:59:12 INFO - 'PAGER': '/bin/cat', 05:59:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:12 INFO - 'PWD': '/builds/slave/test', 05:59:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:59:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:12 INFO - 'SHELL': '/bin/bash', 05:59:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zp0IUXjzrj/Listeners', 05:59:12 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 05:59:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:12 INFO - 'USER': 'cltbld', 05:59:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:12 INFO - 'XPC_FLAGS': '0x0', 05:59:12 INFO - 'XPC_SERVICE_NAME': '0', 05:59:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BNYUPhiKSROGLoiy2sZAyw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0365', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:59:12 INFO - mozversion application_buildid: 20160711024832 05:59:12 INFO - mozversion application_changeset: 1bee8d2da23ec894980fb14f516210fd83e5b9f9 05:59:12 INFO - mozversion application_display_name: Nightly 05:59:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:59:12 INFO - mozversion application_name: Firefox 05:59:12 INFO - mozversion application_remotingname: firefox 05:59:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:59:12 INFO - mozversion application_vendor: Mozilla 05:59:12 INFO - mozversion application_version: 50.0a1 05:59:12 INFO - mozversion platform_buildid: 20160711024832 05:59:12 INFO - mozversion platform_changeset: 1bee8d2da23ec894980fb14f516210fd83e5b9f9 05:59:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:59:12 INFO - mozversion platform_version: 50.0a1 05:59:12 INFO - using testdate: 1468241952 05:59:12 INFO - actual date: 1468241952 05:59:12 INFO - starting webserver on 'localhost:49266' 05:59:12 INFO - SUITE-START | Running 2 tests 05:59:12 INFO - TEST-START | dromaeo_css 05:59:12 INFO - operating with platform_type : mac_ 05:59:12 INFO - Initialising browser for dromaeo_css test... 05:59:12 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmpCM8Oav/profile http://localhost:49266/getInfo.html) 05:59:14 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 05:59:14 INFO - PROCESS | 1650 | colorDepth:24 05:59:14 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 05:59:14 INFO - PROCESS | 1650 | __metrics 05:59:14 INFO - PROCESS | 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:59:14 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:59:15 INFO - TEST-INFO | 1650: exit 0 05:59:15 INFO - Browser initialized. 05:59:15 INFO - Running cycle 1/1 for dromaeo_css test... 05:59:15 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmpCM8Oav/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:27 INFO - PROCESS | 1652 | RSS: Main: 243462144 05:59:27 INFO - PROCESS | 1652 | 06:00:19 INFO - PROCESS | 1652 | 1468242019416 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] 06:02:30 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 06:02:31 INFO - PROCESS | 1652 | RSS: Main: 358834176 06:02:31 INFO - PROCESS | 1652 | 06:05:34 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 06:05:35 INFO - PROCESS | 1652 | RSS: Main: 382205952 06:05:35 INFO - PROCESS | 1652 | 06:08:37 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 06:08:38 INFO - PROCESS | 1652 | RSS: Main: 373956608 06:08:38 INFO - PROCESS | 1652 | 06:11:40 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 06:11:41 INFO - PROCESS | 1652 | RSS: Main: 374837248 06:11:41 INFO - PROCESS | 1652 | 06:14:44 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 06:14:45 INFO - PROCESS | 1652 | RSS: Main: 334893056 06:14:45 INFO - PROCESS | 1652 | 06:17:48 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 06:17:48 INFO - PROCESS | 1652 | RSS: Main: 387371008 06:17:48 INFO - PROCESS | 1652 | 06:17:48 INFO - PROCESS | 1652 | __start_tp_report 06:17:48 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 06:17:48 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 06:17:48 INFO - PROCESS | 1652 | |i|pagename|runs| 06:17:48 INFO - PROCESS | 1652 | |0;dojo.html;3177.285110850059;3221.3235220603674;3247.3342964692242;3319.7178239849613;3377.324535092982;4350.282203436429;5511;5572.665640061594;5638.182463542784;5682.488576028162;5648.802291919784;5668.206451096849;5677.716114194284;5679.346875109353;5687.744051517681;4263.978680106595;5090.134677104901;5148.510891465324;5198;5214.713190774506;5150.2532132840715;5211.3746350438005;5224.712640804754;5225.477452254763;5230.320058392404;5110.131277682803;5127.589792816584;5137.897242055156;5141.845744627667;5213.348331458567;5192.766325515342;5235.816746413895;5249.055170069386;5250.789968401259;5307.097793375096;5037.319961805183;5062.215356619729;5097.057044446789;5152.613553983429;5177.378714554277;5539.2522009529;5556.472135147195;5604.299462567179;5612.522935550483;5661;6167.537434692416;6172.629642221436;6178.196834411543;6196.318404975449;6196.504279657616;6058.606190597641;6111.409422667723;6201;6244.219472565929;6254.249490061176;5804.9419505805245;5814.244148260699;5816.098504731774;5817.156512305692;5820.272465941757;6214.130021796952;6249.468795152372;6273.780417685359;6283.7800676977;6302.369763023753;5057.72182529957;5823.737931793079;5867.178594996619;6006.759729610767;6106.247106899065;6191.442770150708;6196.938030619726;6201.906971395432;6209.348018458088;6210.5652604317265;5129.333186685707;6148.354422785633;6175.62946223219;6185.907211391833;6190.721417536221;6034.969825150934;6035.245594300713;6203.379662033761;6215.782447614311;6226.844328891723;4910.042541704404;4930.778114984834;4935.037667654845;4950.777215025332;4978.178600530944;4410.007748256617;4481.417415735934;4507.481639611421;4510.909781804346;4530.275155975029;4864.586510146606;5724.227229324071;5736.110902810071;5740.827775166752;5743.712814359265;6112.572119951649;6152.2002139722445;6159.599626024294;6169.9383006170265;6491.123698300669;5558.694271815089;5658.207850900795;5661.065924122556;5735.913961290584;5762.193292938992;5442.4829641184815;5451.454854514596;5458.4814442628685;5463.071277882769;5470.5350045245805;6265.780697675559;6287.654179020106;6289.056641503811;6291.96854015727;6297.338779428277;6097.25246653012;6115.113308570143;6137.775380989496;6187.783427580013;6200.7519699211525;6273.686315684106;6273.780417685359;6274.372562743689;6281.874362512815;6285.49716022708;6093.055576385667;6141.986572215713;6150.907736384047;6151.84620384494;6157.630542167484;5401.838604699851;6078.6048906820915;6114.3277820888225;6145.692715364304;6197.03945888388;5988.700564971821;6056.757729690763;6080.331163571915;6092.45167934888;6093.482054025458;4560.1335746208115;5611.242482264842;5880.8235752927485;5897.764089436375;6095.329513753572;5639.577031722555;5852;5864.970675146597;5931;5950.137230101524;5162.019216348882;5821.505172060422;6106.117570898517;6110.572259941761;6121.3572574879;5763.394843541368;5916.615419997686;5921.644701317935;5924.052151655715;5930.911036334544 06:17:48 INFO - PROCESS | 1652 | |1;ext.html;474.7507558531773;492.9950700492996;497.69143131258613;506.9569086627636;509.5935218796123;24792.87603561984;32621.673783262162;32661.346773064524;40976.59023409765;42290.365644515354;43786.12427751443;44178;44255;44294.33558496617;44319.335209971876;9733.51332433379;9904.306698531105;9906.900930990705;9918.90081099187;9936.701898943043;8715.782105447352;8883.289336853068;8895.976962649313;9049.683261085831;9706.174975127122;8908.554572271392;11915.523379064827;12069.517219311261;12075.456604452776;12393.946514546229;12043;12109.757804843943;12115.091368147425;12120.333381664004;12138.757224855497;8626.568671566396;11790.99776518997;11886.821697674543;11907.583234586835;11913.166078374517;40838;41234.9691257721;41325.58674413247;43290.567094328966;43379.78310108429;3718;4272.530021697611;4286.03564198056;4286.699931004831;4389.692721509496;31745.36509269825;32770.344593108006;33038.50442243344;33086.3382732344;33401.49897751536;3256.96743032569;3359.0930448778936;3388.119089036868;3434.8282585870606;3461.2558299965626;486350;487238;488863;492160;496147;60949;61007.38992610017;61285;61384;61425;63808.4905330202;63942.68028659827;63972.36027639757;63979;64081;16675.49973500797;16944.57638559021;16969.0667013313;16978;16978.23597938096;12934;13011;13017.284049377186;13022.674433139058;13032.218066915826;14489.203093829941;14755.63110922214;15357.389243828577;16609;16615.750763738553;7260.6732697028765;7455.9545465872125;7539.359154471931;7570.394368450511;7681.961590192125;914.7621618379269;988.8714467119229;1034.730969947819;1085.9728506787235;1135.8466607008113;30572.69427305743;30580.84709576438;31066.068017959497;31507.36985260282;31519.054428367184;1082.832161015044;1099.3294090604725;1102.2064113838023;1134.359087115777;1246.4266437438698;15536.533903982898;15909.840901591067;16033.679326413407;16307.1031093291;16384.934979226313;588196;593311;593969;594809;597004;51414.74292628588;59394;59893.40106598965;60039.39960600338;60240;1252.8058150986794;1415.971680566383;1426.7645838436542;1440.171901156818;1456.8178977627797;30931.381372372878;31461;32287.192820179684;32398.028059158263;33141.66858331482;51401.7429912848;51686.74156629193;51798.22302665538;51864.74067629638;51948.740256299985;583636;592609;592992;779165;794041;39174;40205.994850128984;40499.59500405076;40685.79657101695;40748.38877416782;47178.64517252586;47412.52587474081;47573.28640070333;48077;48672;38825.223495530496;39125.80437097796;39252.60747392604;39693.80918572447;40241.390344385894;39044.828655140394;39645.40531892081;40050;40154.1969160621;40598.797006015964;37347;37860.81069594635;38389.424158638205;38572;38693.419598706605;28227.15318540447;33099.66900330966;33170.83414582912;34533.654663453046;35474.46788298126;20348.694769578764;21215.68176477385;24868;25524;25605.61591576165 06:17:48 INFO - PROCESS | 1652 | |2;jquery.html;359.6978538028056;381.410720436925;388.8114264581677;393.92318497892904;412.1941604163858;15450;16468;20052.097655605496;21170.68243976338;21697.783022169773;19981.900090499563;20208.797912020877;21201.151953921864;21217.681734773952;21234.681479777817;4571.428571428572;5127.33344665193;5223.216517522383;5225.738713064351;5269.789208431658;3813.504244448218;4265.722728022669;5475.863103422426;6748.223954245275;6753.15585551806;6717.462602991774;6777.627230502345;6788.898166527506;6794.471243970092;6809.897851532206;6446.355364463563;6716.798496045127;6725.39471447572;6733.158355205599;6738.124043874314;3747.344214762433;3919.3141200289833;3968.3452230381954;5522.779088836442;5896.646201227897;13067.673308167277;13520;13520.864791352058;18813.81186188148;26112.216633501026;2018.0918586635926;2018.7375641166554;2125.787421257877;2262.9547409051893;2378.6432035194684;9934.950325248328;9935.56578638231;10031.548580313904;10420;10440.530176142016;1896.4310706788046;1947.8539109566839;1959.5101224693826;1963.5876465942026;1966.9409917702492;111474.88525114807;118450.40774796157;122832.38583807113;126656;127829.36085319513;10278.845817312746;10928.945355273172;11456.140789440658;11512.136589755803;11608.30350178992;12683.429245683967;13439.260840653858;13483.52807651747;13508.662283442993;13517.459301628021;8466.280366168821;8527.147285271423;8677.177792663486;8715.520646364384;8759.912400876037;8610.182032706884;8622.353323500762;8661.090585488559;8779.956100219459;8820.029796722356;4460.955390446054;4525.705829121162;4527.162474942146;4587.38070360497;4605.723656580616;1883.369071361082;1928.951776205578;1931.420573827846;1932.6231384880095;1958.285225892539;890.496869268861;911.4667919267171;928.9210417114485;1021.6117875207374;1053.5733028123623;18831.90584047071;20976.580468390854;21868.01593928277;21887;21931.67102493464;921.6313474610209;933.874681009382;938.1181689212119;970.146271281268;1009.8939611340851;11023.724406889893;11402.771944561062;11461.71345716347;11481;11499.482523286471;602733.9726602766;610372;616971;622734.9769260304;624689;129035.35482322716;129240;129307;131654.34172829075;134054;995.0696099147176;996.6312464388222;1024.6413755185624;1048.2452634103433;1050.9159267258601;18633.81366186321;18781.624367512846;18838.152283147567;18883.339083132574;18995;53104;53486.73256633692;54561;54947;56007.87984240211;82227;83012;83743;84613.7307940369;84829.15170848212;7899.011878325282;7906.723264685938;8000.119986801564;8101.311388531805;8257.876131858147;12341.382930853242;12762.42569084375;12892.48430062787;13147.868521315047;13249.337533123113;9793.118619324296;10533.157347412342;10818.891811081789;11368.943155284502;11373.260738052;8947.239484643618;10959.178061645249;11083.944580277048;11146.49840757184;11399.943000284946;10030.283473166915;11157.163212758913;11292.717682058013;11648.301101933912;11712.180147389941;8041.597920103854;8147.02235731716;8205.425620206528;8205.876911846446;8370.121137280741;10845.891541084487;11253.324800511995;11339.489722962322;11364.772704545698;11496.712582185177 06:17:48 INFO - PROCESS | 1652 | |3;mootools.html;1371.2526672963234;1533.8926275160736;1562.1954693332932;1791.1671072951076;1953.062529985607;7738.613069346538;8333.87499187512;8594.355423343259;8595.097514760946;8613.612387442565;8319.708810191645;8324.542150181738;8507.574621268943;8590.656373745058;8616.052234254226;2307.976920230801;2364.5507353602848;2366.857988520694;2367.4081479630095;2368.3131891751373;2312.387217387394;2340.2394221877958;2362.0197617988515;2367.988160059197;2368.6210206366986;2325.5813953488364;2349;2358.3750306168877;2361.3978435498925;2366.5858474766933;2000.7299014632983;2297.655351697242;2328.592496313147;2340.040583360814;2348.0607756897207;2328.918487852934;2331.813454923602;2332.5101728637005;2339.3449834046496;2339.543788961153;8511.191436813493;8658.264047555966;8733.956330218309;8740.475571465733;8751.037385887546;5149.176131818891;5318.042752304584;5328.786848526054;5329.2006199070065;5332.120200166968;3567.375709250871;3607.8917632471066;3677.3564626190578;3681.1901381695984;3683.8158092095555;1089.9945500272447;1093.278436232083;1096.8354746787966;1102.4212288548497;1108.4734750993293;11354.48904799286;11571.247868888495;11574.016208622277;11585.536578536849;11619.709507262387;4553.225951588238;4570.88572785683;4793;4799.6400269979895;4802.831900883452;10053.296269261082;10056.949715251378;10077.244206684529;10082.546285417175;10085;5380.219868119101;5383.246345511631;5386.434424385383;5386.757595908193;5388.218708287276;4314.331278651814;4361.302191649384;4513.390692256503;4881.194602890483;4909.656324057281;3317.3696997570382;3951.4863067801;3957.1294315250598;4015.13674559971;4085.632293093636;1270.783966725659;1279.3155661720934;1291.0897817038965;1293.2176033499786;1300.8699130086916;794.7456813819522;889.7286327670123;900.5587262241586;912.2063804490136;914.7804526913493;5447.4824891635235;5899.115132730039;5952.7023648817385;6005.489533389711;6103.664298463538;971.8542218667257;988.5205675247499;990.4997976022063;1003.420752565576;1035.0684384054261;3320.5185248138882;3441.5353927219503;3817.751846129993;3939.8621048263744;4073.450084238649;9931.155851752683;10129.392236465836;10286.537105830255;10671.89328106709;10836.620718274822;10780.46097695112;10796.514156862802;10797;10798.190135739851;10798.946005269923;8028.799280018046;8166.918330816616;8178.386621003329;8286.212809783061;8287.378446616527;5763.567732420169;5834.599696072997;5868.4424979626865;5906.468417842415;5929.673867937305;9837.360571562825;10000.24998125129;10029.899701003189;10033.949830250802;10036;9176.40353377055;9596.184324332231;9785.36395134314;10135.64525241613;10326.380417174994;6870.896936546056;7106.182788979127;7110.5022648414115;7172.713091476283;7183.173934997542;7736.994190755166;7882.369410447036;8159;8384.245417912418;8412.831743365221;7435.107787065586;7567.508111972704;7573.734919277799;7632.694692212472;7697.615119243904;7476.887846682195;7500.887486687813;7538.447773657657;7585.279398457138;7616.20029896875;6909.1018167639895;7044.189918159273;7053.153621565445;7053.647317634201;7065.046218760607;4920.483349248278;5064.645474816727;5083.644144909968;5100.056489549445;5179.637425380338;5045.899082018265;5104.3619547556555;5129.79480820763;5132.8460146195675;5275.446078161891 06:17:48 INFO - PROCESS | 1652 | |4;prototype.html;285.7257033248082;299.2682890333135;315.31419163319777;316.60740681554864;317.690252004296;4676.947686770475;4869.685185000048;4941.160002799524;5353.277307563478;5372.973135134319;4818.445878723948;5085.8474245772595;5244.737763111839;5284.682919024852;5392.2181283713835;3355.9496607550786;3527.8236088195617;3918.471006414126;4090.97954510227;4092.283850326196;3940.9802950985204;4092.058826469899;4100.58994100589;4100.692448066392;4108.712390132692;4011.83952641894;4058.289799285128;4067.6339129478342;4074.694397920153;4075.572064933184;3623.2572322673786;3957.2481228566626;4090.427340172378;4090.754554726726;4101.507819061701;3086.876524939;3558.323918455511;3569.214772749991;3577.5349204603235;3581.4090675038588;4422.668299877522;4967.931894642633;5233.764480598382;5255.423372988088;5293.682379057269;4248.044190057243;4381.8528920828885;4679.578837904605;4710.929336059962;4732.82290146533;4689.202835517936;5054.469280725508;5253.737313134367;5656.434356564352;5719.571032172604;3273.9345213095603;3812.218495208476;3872.9806350968065;3915.2561013407644;3958.267720471722;5065;5860.531157507389;5942.841145976537;5963;5965.970170149121;3991.9620898566;3996.980015099906;4004.1991601679197;4009.51885773709;4014.558398576154;3695.519582454264;4001.1797581496307;4049.8380064797666;4051.777152256654;4055.41196526502;3717.665410113103;3899.6880249579967;4622.2835460503675;4645.674802763841;4671.556202160789;4816.54242846929;5064.82273120439;5740.0815869460685;5777.566682498829;5793.536517078624;1169.0997931592797;1303.328785675378;1310.8885744711615;1318.4133060787858;1345.7712188927906;879.3448880584006;890.2744263425287;909.6270529083044;913.794396260836;918.2653876898454;4513.526079761577;4664.854167083112;5242.5281724644965;5363.249145119687;5371.543418809367;4814.831480898222;5459.754311056012;5831.533477321804;5846.8538286542325;5897.262842144732;5091.541761241506;5294.708791016454;5301.496357845998;5302.681839089667;5311.49540793624;2579.651747014129;2594.366717781453;2595.6106584012173;2608.4000679843743;2620.3318153871023;4134.586541345901;4657.765692091599;4674.2988551716835;4786.439254998559;5072.970811675359;5027.698338099725;5052.494750524918;5056.418511871182;5575.4424557544735;6125.571210015256;5087.821926232564;5566.66600003993;6154.230721159855;6162.568620196544;6180.505559555225;5666.773329066956;5946.256717910262;5963.853012915434;5964.612300200473;5982.551308651956;5040;5881.735741587315;5883.176215373248;5895.41045895407;5899;6082.574219804571;6094.786682466092;6107.786227482017;6136.94961325523;6139;3220.4525230710365;3700.333939890738;3945.5265368156006;3956.3867600521967;3966.1869316790567;4792.257200133846;5848.502877255481;5873.911891321548;5890.087036509348;5903;4824.927626085681;5201.791928322825;5628.690422026664;5630.735262529548;5640.71796410186;4809.206480930748;5125;5724.627899186539;5769.336526299529;5776.220210271559;4473.865784026484;4664.300354946649;5167.509086636764;5351.625386222927;5722.799702010409;4566.497685254553;4781.780645935264;5797.5361971041375;5799.681017544076;5801.82594522165;5675;5687.345955215038;5697.373288938131;5699.857503562444;5705.486506214294 06:17:48 INFO - PROCESS | 1652 | |5;yui.html;717.6053170756085;769.2730369800539;790.0164295452163;796.41861441148;818.8976377952756;15560.610984725388;16398.672026559463;16442.83557164428;16448.095354755485;16453;14855.405783768636;15023.32395042223;15042.924785376084;15100.320485578148;15106.622334441618;695.5861262548775;712.9465290103263;864.6930339729399;867.6702852915884;885.2342723544152;865.4504389712515;880.6697488441835;882.1222883231162;882.1399135842535;884.3102380143466;941.1529623338981;943.4433684126365;944.3342443577296;944.4946953379944;945.3193700535603;741.2254194366873;751.6354568034499;756.4137793210251;757.6969212315063;933.5332333833084;568.1960026562409;679.7654809090856;688.3667026335783;691.2154704410531;695.7634404302562;13601.251931143783;13607.387667554984;13622.318884055758;13640.386182621805;13648;13635.38640761168;13963.860361396357;14035.859641403558;14085;14251.144931304156;12843.165194262343;12865.742685146339;12923.15999460032;12947.41736621845;13031.934840325832;4566.315052742082;4633.791479383436;4731.36126622905;4737.857864264078;4740.502247264057;106782;107466.46266768617;117817;117881;118193.40903295514;10926.289791163548;11253.943730281297;11440.027597654127;11569.595064172714;11581.305121692725;21890.671639925415;21895.12419503234;21899.452513686967;21922.561548769256;21957.451063723216;8001.159878212704;8004.799880003046;8082.070561885341;8212.63043163059;8235.95882020586;4403.889902752457;4472.59746622799;4522.773861306921;4589.2886602576655;4759.857204283877;3060.7398371138256;3420.965790342065;3576.3920133577353;3580;3581.7492775505466;642.4667525953447;647.2233320015999;655.6426747422666;661.7220767277755;664.5779929744647;563.184770214663;619.928708198563;626.7524327890458;627.1345543150424;645.8195073150004;8590.441621294596;8885.466871987572;8927.10728927115;9038.322125840588;9083.636654533877;576.3659974028619;603.2820943077811;638.6168299020551;642.9357064293533;647.3979199344654;4338.8047537860875;4376.7811609419405;4390.604845563851;4484.596386325246;4513.684042117086;137863;146369.26815365854;146586.26706866611;147786.26106869397;149651;126040.36979815042;129999;130212.3489382547;130297;132224.422046238;72482.9127563087;89162;108784.4560777191;110890.44554777174;111125.44437277762;8368.874466883124;8810.779730506532;8923.196912277926;9768.169705574821;9787.749910568918;46466;54080.72959635177;56417.8716425661;59988;60593.69703151456;65853;66162.66918665376;66260.55669381918;66527;80879.3824123526;11832.467538960595;13602.387892545057;13659.726805463637;13741.725165496435;14043.36804843805;15609.453669121527;15767.842321576638;15810.288537016091;16085.276162572478;16269.51191464258;12245.87754122483;12311.876881231432;12441.813372799596;12458;14692.016577761866;14016;14364.85635143677;14384.784228236376;14431.711365772415;14486.855131448972;13713.657158570717;14016.29918504091;14051.37728257525;14188.645283867985;14271.857281427052;11183.105351571692;11361.822175285914;11696.35670038156;11821;11875;9039.45763254207;11602.535898563963;11680.357580333164;11851.881481185423;11891.702707432383 06:17:48 INFO - PROCESS | 1652 | __end_tp_report 06:17:48 INFO - PROCESS | 1652 | __start_cc_report 06:17:48 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1169 06:17:48 INFO - PROCESS | 1652 | __end_cc_report 06:17:48 INFO - PROCESS | 1652 | __startTimestamp1468243068565__endTimestamp 06:17:48 INFO - PROCESS | 1652 | 06:17:48 INFO - PROCESS | 1652 | ------- Summary: start ------- 06:17:48 INFO - PROCESS | 1652 | Number of tests: 6 06:17:48 INFO - PROCESS | 1652 | 06:17:48 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5653.00 Median:5820.27 stddev:655.50 (11.3%) stddev-sans-first:628.08 06:17:48 INFO - PROCESS | 1652 | Values: 3177.3 3221.3 3247.3 3319.7 3377.3 4350.3 5511.0 5572.7 5638.2 5682.5 5648.8 5668.2 5677.7 5679.3 5687.7 4264.0 5090.1 5148.5 5198.0 5214.7 5150.3 5211.4 5224.7 5225.5 5230.3 5110.1 5127.6 5137.9 5141.8 5213.3 5192.8 5235.8 5249.1 5250.8 5307.1 5037.3 5062.2 5097.1 5152.6 5177.4 5539.3 5556.5 5604.3 5612.5 5661.0 6167.5 6172.6 6178.2 6196.3 6196.5 6058.6 6111.4 6201.0 6244.2 6254.2 5804.9 5814.2 5816.1 5817.2 5820.3 6214.1 6249.5 6273.8 6283.8 6302.4 5057.7 5823.7 5867.2 6006.8 6106.2 6191.4 6196.9 6201.9 6209.3 6210.6 5129.3 6148.4 6175.6 6185.9 6190.7 6035.0 6035.2 6203.4 6215.8 6226.8 4910.0 4930.8 4935.0 4950.8 4978.2 4410.0 4481.4 4507.5 4510.9 4530.3 4864.6 5724.2 5736.1 5740.8 5743.7 6112.6 6152.2 6159.6 6169.9 6491.1 5558.7 5658.2 5661.1 5735.9 5762.2 5442.5 5451.5 5458.5 5463.1 5470.5 6265.8 6287.7 6289.1 6292.0 6297.3 6097.3 6115.1 6137.8 6187.8 6200.8 6273.7 6273.8 6274.4 6281.9 6285.5 6093.1 6142.0 6150.9 6151.8 6157.6 5401.8 6078.6 6114.3 6145.7 6197.0 5988.7 6056.8 6080.3 6092.5 6093.5 4560.1 5611.2 5880.8 5897.8 6095.3 5639.6 5852.0 5865.0 5931.0 5950.1 5162.0 5821.5 6106.1 6110.6 6121.4 5763.4 5916.6 5921.6 5924.1 5930.9 06:17:48 INFO - PROCESS | 1652 | 06:17:48 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:72230.20 Median:39669.61 stddev:158077.03 (398.5%) stddev-sans-first:158428.68 06:17:48 INFO - PROCESS | 1652 | Values: 474.8 493.0 497.7 507.0 509.6 24792.9 32621.7 32661.3 40976.6 42290.4 43786.1 44178.0 44255.0 44294.3 44319.3 9733.5 9904.3 9906.9 9918.9 9936.7 8715.8 8883.3 8896.0 9049.7 9706.2 8908.6 11915.5 12069.5 12075.5 12393.9 12043.0 12109.8 12115.1 12120.3 12138.8 8626.6 11791.0 11886.8 11907.6 11913.2 40838.0 41235.0 41325.6 43290.6 43379.8 3718.0 4272.5 4286.0 4286.7 4389.7 31745.4 32770.3 33038.5 33086.3 33401.5 3257.0 3359.1 3388.1 3434.8 3461.3 486350.0 487238.0 488863.0 492160.0 496147.0 60949.0 61007.4 61285.0 61384.0 61425.0 63808.5 63942.7 63972.4 63979.0 64081.0 16675.5 16944.6 16969.1 16978.0 16978.2 12934.0 13011.0 13017.3 13022.7 13032.2 14489.2 14755.6 15357.4 16609.0 16615.8 7260.7 7456.0 7539.4 7570.4 7682.0 914.8 988.9 1034.7 1086.0 1135.8 30572.7 30580.8 31066.1 31507.4 31519.1 1082.8 1099.3 1102.2 1134.4 1246.4 15536.5 15909.8 16033.7 16307.1 16384.9 588196.0 593311.0 593969.0 594809.0 597004.0 51414.7 59394.0 59893.4 60039.4 60240.0 1252.8 1416.0 1426.8 1440.2 1456.8 30931.4 31461.0 32287.2 32398.0 33141.7 51401.7 51686.7 51798.2 51864.7 51948.7 583636.0 592609.0 592992.0 779165.0 794041.0 39174.0 40206.0 40499.6 40685.8 40748.4 47178.6 47412.5 47573.3 48077.0 48672.0 38825.2 39125.8 39252.6 39693.8 40241.4 39044.8 39645.4 40050.0 40154.2 40598.8 37347.0 37860.8 38389.4 38572.0 38693.4 28227.2 33099.7 33170.8 34533.7 35474.5 20348.7 21215.7 24868.0 25524.0 25605.6 06:17:48 INFO - PROCESS | 1652 | 06:17:48 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:35588.78 Median:21782.90 stddev:102853.51 (472.2%) stddev-sans-first:103108.02 06:17:48 INFO - PROCESS | 1652 | Values: 359.7 381.4 388.8 393.9 412.2 15450.0 16468.0 20052.1 21170.7 21697.8 19981.9 20208.8 21201.2 21217.7 21234.7 4571.4 5127.3 5223.2 5225.7 5269.8 3813.5 4265.7 5475.9 6748.2 6753.2 6717.5 6777.6 6788.9 6794.5 6809.9 6446.4 6716.8 6725.4 6733.2 6738.1 3747.3 3919.3 3968.3 5522.8 5896.6 13067.7 13520.0 13520.9 18813.8 26112.2 2018.1 2018.7 2125.8 2263.0 2378.6 9935.0 9935.6 10031.5 10420.0 10440.5 1896.4 1947.9 1959.5 1963.6 1966.9 111474.9 118450.4 122832.4 126656.0 127829.4 10278.8 10928.9 11456.1 11512.1 11608.3 12683.4 13439.3 13483.5 13508.7 13517.5 8466.3 8527.1 8677.2 8715.5 8759.9 8610.2 8622.4 8661.1 8780.0 8820.0 4461.0 4525.7 4527.2 4587.4 4605.7 1883.4 1929.0 1931.4 1932.6 1958.3 890.5 911.5 928.9 1021.6 1053.6 18831.9 20976.6 21868.0 21887.0 21931.7 921.6 933.9 938.1 970.1 1009.9 11023.7 11402.8 11461.7 11481.0 11499.5 602734.0 610372.0 616971.0 622735.0 624689.0 129035.4 129240.0 129307.0 131654.3 134054.0 995.1 996.6 1024.6 1048.2 1050.9 18633.8 18781.6 18838.2 18883.3 18995.0 53104.0 53486.7 54561.0 54947.0 56007.9 82227.0 83012.0 83743.0 84613.7 84829.2 7899.0 7906.7 8000.1 8101.3 8257.9 12341.4 12762.4 12892.5 13147.9 13249.3 9793.1 10533.2 10818.9 11368.9 11373.3 8947.2 10959.2 11083.9 11146.5 11399.9 10030.3 11157.2 11292.7 11648.3 11712.2 8041.6 8147.0 8205.4 8205.9 8370.1 10845.9 11253.3 11339.5 11364.8 11496.7 06:17:48 INFO - PROCESS | 1652 | 06:17:48 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5676.50 Median:4895.43 stddev:3159.81 (64.5%) stddev-sans-first:3152.11 06:17:48 INFO - PROCESS | 1652 | Values: 1371.3 1533.9 1562.2 1791.2 1953.1 7738.6 8333.9 8594.4 8595.1 8613.6 8319.7 8324.5 8507.6 8590.7 8616.1 2308.0 2364.6 2366.9 2367.4 2368.3 2312.4 2340.2 2362.0 2368.0 2368.6 2325.6 2349.0 2358.4 2361.4 2366.6 2000.7 2297.7 2328.6 2340.0 2348.1 2328.9 2331.8 2332.5 2339.3 2339.5 8511.2 8658.3 8734.0 8740.5 8751.0 5149.2 5318.0 5328.8 5329.2 5332.1 3567.4 3607.9 3677.4 3681.2 3683.8 1090.0 1093.3 1096.8 1102.4 1108.5 11354.5 11571.2 11574.0 11585.5 11619.7 4553.2 4570.9 4793.0 4799.6 4802.8 10053.3 10056.9 10077.2 10082.5 10085.0 5380.2 5383.2 5386.4 5386.8 5388.2 4314.3 4361.3 4513.4 4881.2 4909.7 3317.4 3951.5 3957.1 4015.1 4085.6 1270.8 1279.3 1291.1 1293.2 1300.9 794.7 889.7 900.6 912.2 914.8 5447.5 5899.1 5952.7 6005.5 6103.7 971.9 988.5 990.5 1003.4 1035.1 3320.5 3441.5 3817.8 3939.9 4073.5 9931.2 10129.4 10286.5 10671.9 10836.6 10780.5 10796.5 10797.0 10798.2 10798.9 8028.8 8166.9 8178.4 8286.2 8287.4 5763.6 5834.6 5868.4 5906.5 5929.7 9837.4 10000.2 10029.9 10033.9 10036.0 9176.4 9596.2 9785.4 10135.6 10326.4 6870.9 7106.2 7110.5 7172.7 7183.2 7737.0 7882.4 8159.0 8384.2 8412.8 7435.1 7567.5 7573.7 7632.7 7697.6 7476.9 7500.9 7538.4 7585.3 7616.2 6909.1 7044.2 7053.2 7053.6 7065.0 4920.5 5064.6 5083.6 5100.1 5179.6 5045.9 5104.4 5129.8 5132.8 5275.4 06:17:48 INFO - PROCESS | 1652 | 06:17:48 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4517.02 Median:4954.55 stddev:1414.06 (28.5%) stddev-sans-first:1381.90 06:17:48 INFO - PROCESS | 1652 | Values: 285.7 299.3 315.3 316.6 317.7 4676.9 4869.7 4941.2 5353.3 5373.0 4818.4 5085.8 5244.7 5284.7 5392.2 3355.9 3527.8 3918.5 4091.0 4092.3 3941.0 4092.1 4100.6 4100.7 4108.7 4011.8 4058.3 4067.6 4074.7 4075.6 3623.3 3957.2 4090.4 4090.8 4101.5 3086.9 3558.3 3569.2 3577.5 3581.4 4422.7 4967.9 5233.8 5255.4 5293.7 4248.0 4381.9 4679.6 4710.9 4732.8 4689.2 5054.5 5253.7 5656.4 5719.6 3273.9 3812.2 3873.0 3915.3 3958.3 5065.0 5860.5 5942.8 5963.0 5966.0 3992.0 3997.0 4004.2 4009.5 4014.6 3695.5 4001.2 4049.8 4051.8 4055.4 3717.7 3899.7 4622.3 4645.7 4671.6 4816.5 5064.8 5740.1 5777.6 5793.5 1169.1 1303.3 1310.9 1318.4 1345.8 879.3 890.3 909.6 913.8 918.3 4513.5 4664.9 5242.5 5363.2 5371.5 4814.8 5459.8 5831.5 5846.9 5897.3 5091.5 5294.7 5301.5 5302.7 5311.5 2579.7 2594.4 2595.6 2608.4 2620.3 4134.6 4657.8 4674.3 4786.4 5073.0 5027.7 5052.5 5056.4 5575.4 6125.6 5087.8 5566.7 6154.2 6162.6 6180.5 5666.8 5946.3 5963.9 5964.6 5982.6 5040.0 5881.7 5883.2 5895.4 5899.0 6082.6 6094.8 6107.8 6136.9 6139.0 3220.5 3700.3 3945.5 3956.4 3966.2 4792.3 5848.5 5873.9 5890.1 5903.0 4824.9 5201.8 5628.7 5630.7 5640.7 4809.2 5125.0 5724.6 5769.3 5776.2 4473.9 4664.3 5167.5 5351.6 5722.8 4566.5 4781.8 5797.5 5799.7 5801.8 5675.0 5687.3 5697.4 5699.9 5705.5 06:17:48 INFO - PROCESS | 1652 | 06:17:48 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:23904.31 Median:3580.87 stddev:37934.28 (1059.4%) stddev-sans-first:38000.75 06:17:48 INFO - PROCESS | 1652 | Values: 717.6 769.3 790.0 796.4 818.9 15560.6 16398.7 16442.8 16448.1 16453.0 14855.4 15023.3 15042.9 15100.3 15106.6 695.6 712.9 864.7 867.7 885.2 865.5 880.7 882.1 882.1 884.3 941.2 943.4 944.3 944.5 945.3 741.2 751.6 756.4 757.7 933.5 568.2 679.8 688.4 691.2 695.8 13601.3 13607.4 13622.3 13640.4 13648.0 13635.4 13963.9 14035.9 14085.0 14251.1 12843.2 12865.7 12923.2 12947.4 13031.9 4566.3 4633.8 4731.4 4737.9 4740.5 106782.0 107466.5 117817.0 117881.0 118193.4 10926.3 11253.9 11440.0 11569.6 11581.3 21890.7 21895.1 21899.5 21922.6 21957.5 8001.2 8004.8 8082.1 8212.6 8236.0 4403.9 4472.6 4522.8 4589.3 4759.9 3060.7 3421.0 3576.4 3580.0 3581.7 642.5 647.2 655.6 661.7 664.6 563.2 619.9 626.8 627.1 645.8 8590.4 8885.5 8927.1 9038.3 9083.6 576.4 603.3 638.6 642.9 647.4 4338.8 4376.8 4390.6 4484.6 4513.7 137863.0 146369.3 146586.3 147786.3 149651.0 126040.4 129999.0 130212.3 130297.0 132224.4 72482.9 89162.0 108784.5 110890.4 111125.4 8368.9 8810.8 8923.2 9768.2 9787.7 46466.0 54080.7 56417.9 59988.0 60593.7 65853.0 66162.7 66260.6 66527.0 80879.4 11832.5 13602.4 13659.7 13741.7 14043.4 15609.5 15767.8 15810.3 16085.3 16269.5 12245.9 12311.9 12441.8 12458.0 14692.0 14016.0 14364.9 14384.8 14431.7 14486.9 13713.7 14016.3 14051.4 14188.6 14271.9 11183.1 11361.8 11696.4 11821.0 11875.0 9039.5 11602.5 11680.4 11851.9 11891.7 06:17:48 INFO - PROCESS | 1652 | -------- Summary: end -------- 06:17:48 INFO - PROCESS | 1652 | 06:17:49 INFO - TEST-INFO | 1652: exit 0 06:17:49 INFO - TEST-OK | dromaeo_css | took 1116834ms 06:17:49 INFO - TEST-START | kraken 06:17:49 INFO - operating with platform_type : mac_ 06:17:49 INFO - Initialising browser for kraken test... 06:17:49 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmppUqcKL/profile http://localhost:49266/getInfo.html) 06:17:51 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 06:17:51 INFO - PROCESS | 1662 | colorDepth:24 06:17:51 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 06:17:51 INFO - PROCESS | 1662 | __metrics 06:17:51 INFO - PROCESS | 1662 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:17:51 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:17:52 INFO - TEST-INFO | 1662: exit 0 06:17:52 INFO - Browser initialized. 06:17:52 INFO - Running cycle 1/1 for kraken test... 06:17:52 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmppUqcKL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:18:04 INFO - PROCESS | 1663 | RSS: Main: 243601408 06:18:04 INFO - PROCESS | 1663 | 06:18:06 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 06:18:07 INFO - PROCESS | 1663 | RSS: Main: 293916672 06:18:07 INFO - PROCESS | 1663 | 06:18:10 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 06:18:11 INFO - PROCESS | 1663 | RSS: Main: 304078848 06:18:11 INFO - PROCESS | 1663 | 06:18:14 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 06:18:15 INFO - PROCESS | 1663 | RSS: Main: 390926336 06:18:15 INFO - PROCESS | 1663 | 06:18:17 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 06:18:18 INFO - PROCESS | 1663 | RSS: Main: 289734656 06:18:18 INFO - PROCESS | 1663 | 06:18:20 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:18:20 INFO - PROCESS | 1663 | RSS: Main: 293306368 06:18:20 INFO - PROCESS | 1663 | 06:18:23 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 06:18:24 INFO - PROCESS | 1663 | RSS: Main: 329756672 06:18:24 INFO - PROCESS | 1663 | 06:18:26 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 06:18:27 INFO - PROCESS | 1663 | RSS: Main: 331280384 06:18:27 INFO - PROCESS | 1663 | 06:18:30 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 06:18:30 INFO - PROCESS | 1663 | RSS: Main: 332013568 06:18:30 INFO - PROCESS | 1663 | 06:18:32 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:18:33 INFO - PROCESS | 1663 | RSS: Main: 311349248 06:18:33 INFO - PROCESS | 1663 | 06:18:35 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:18:35 INFO - PROCESS | 1663 | RSS: Main: 318791680 06:18:35 INFO - PROCESS | 1663 | 06:18:37 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:18:38 INFO - PROCESS | 1663 | RSS: Main: 315768832 06:18:38 INFO - PROCESS | 1663 | 06:18:41 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:18:42 INFO - PROCESS | 1663 | RSS: Main: 330706944 06:18:42 INFO - PROCESS | 1663 | 06:18:44 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:18:45 INFO - PROCESS | 1663 | RSS: Main: 327000064 06:18:45 INFO - PROCESS | 1663 | 06:18:47 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 06:18:47 INFO - PROCESS | 1663 | RSS: Main: 370241536 06:18:47 INFO - PROCESS | 1663 | 06:18:47 INFO - PROCESS | 1663 | __start_tp_report 06:18:47 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 06:18:47 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 06:18:47 INFO - PROCESS | 1663 | |i|pagename|runs| 06:18:47 INFO - PROCESS | 1663 | |0;ai-astar;101;111;112;112;113;111;110;112;111;112 06:18:47 INFO - PROCESS | 1663 | |1;audio-beat-detection;147;112;134;178;107;134;128;108;161;134 06:18:47 INFO - PROCESS | 1663 | |2;audio-dft;183;183;185;183;183;190;260;184;183;184 06:18:47 INFO - PROCESS | 1663 | |3;audio-fft;78;74;57;87;59;58;58;65;98;57 06:18:47 INFO - PROCESS | 1663 | |4;audio-oscillator;88;89;91;71;78;68;96;69;68;101 06:18:47 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;87;84;86;84;86;83;87;84;86;83 06:18:47 INFO - PROCESS | 1663 | |6;imaging-darkroom;93;93;93;93;93;93;92;93;92;92 06:18:47 INFO - PROCESS | 1663 | |7;imaging-desaturate;83;101;114;86;84;86;85;85;84;86 06:18:47 INFO - PROCESS | 1663 | |8;json-parse-financial;55;54;53;57;53;54;55;52;54;55 06:18:47 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;65;70;81;114;106;108;70;70;71;71 06:18:47 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;86;86;80;85;81;83;81;85;83;80 06:18:47 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;136;155;128;138;139;143;143;134;172;140 06:18:47 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;160;163;170;174;161;163;160;160;165;162 06:18:47 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;67;66;68;65;64;67;66;66;67;65 06:18:47 INFO - PROCESS | 1663 | __end_tp_report 06:18:47 INFO - PROCESS | 1663 | __start_cc_report 06:18:47 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,2029 06:18:47 INFO - PROCESS | 1663 | __end_cc_report 06:18:47 INFO - PROCESS | 1663 | __startTimestamp1468243127379__endTimestamp 06:18:47 INFO - PROCESS | 1663 | 06:18:47 INFO - PROCESS | 1663 | ------- Summary: start ------- 06:18:47 INFO - PROCESS | 1663 | Number of tests: 14 06:18:47 INFO - PROCESS | 1663 | 06:18:47 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.44 (3.1%) stddev-sans-first:0.88 06:18:47 INFO - PROCESS | 1663 | Values: 101.0 111.0 112.0 112.0 113.0 111.0 110.0 112.0 111.0 112.0 06:18:47 INFO - PROCESS | 1663 | 06:18:47 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:134.00 stddev:22.99 (17.2%) stddev-sans-first:23.92 06:18:47 INFO - PROCESS | 1663 | Values: 147.0 112.0 134.0 178.0 107.0 134.0 128.0 108.0 161.0 134.0 06:18:47 INFO - PROCESS | 1663 | 06:18:47 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:191.80 Median:184.00 stddev:24.06 (13.1%) stddev-sans-first:25.31 06:18:47 INFO - PROCESS | 1663 | Values: 183.0 183.0 185.0 183.0 183.0 190.0 260.0 184.0 183.0 184.0 06:18:47 INFO - PROCESS | 1663 | 06:18:47 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:69.10 Median:69.50 stddev:14.59 (21.0%) stddev-sans-first:15.12 06:18:47 INFO - PROCESS | 1663 | Values: 78.0 74.0 57.0 87.0 59.0 58.0 58.0 65.0 98.0 57.0 06:18:47 INFO - PROCESS | 1663 | 06:18:47 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:81.90 Median:83.00 stddev:12.56 (15.1%) stddev-sans-first:13.13 06:18:47 INFO - PROCESS | 1663 | Values: 88.0 89.0 91.0 71.0 78.0 68.0 96.0 69.0 68.0 101.0 06:18:47 INFO - PROCESS | 1663 | 06:18:47 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:85.00 Median:86.00 stddev:1.56 (1.8%) stddev-sans-first:1.48 06:18:47 INFO - PROCESS | 1663 | Values: 87.0 84.0 86.0 84.0 86.0 83.0 87.0 84.0 86.0 83.0 06:18:47 INFO - PROCESS | 1663 | 06:18:47 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:92.70 Median:93.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 06:18:47 INFO - PROCESS | 1663 | Values: 93.0 93.0 93.0 93.0 93.0 93.0 92.0 93.0 92.0 92.0 06:18:47 INFO - PROCESS | 1663 | 06:18:47 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:89.40 Median:85.00 stddev:10.07 (11.8%) stddev-sans-first:10.41 06:18:47 INFO - PROCESS | 1663 | Values: 83.0 101.0 114.0 86.0 84.0 86.0 85.0 85.0 84.0 86.0 06:18:47 INFO - PROCESS | 1663 | 06:18:47 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.50 stddev:1.40 (2.6%) stddev-sans-first:1.45 06:18:47 INFO - PROCESS | 1663 | Values: 55.0 54.0 53.0 57.0 53.0 54.0 55.0 52.0 54.0 55.0 06:18:47 INFO - PROCESS | 1663 | 06:18:47 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:82.60 Median:70.00 stddev:18.96 (27.1%) stddev-sans-first:19.01 06:18:47 INFO - PROCESS | 1663 | Values: 65.0 70.0 81.0 114.0 106.0 108.0 70.0 70.0 71.0 71.0 06:18:47 INFO - PROCESS | 1663 | 06:18:47 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:84.00 stddev:2.40 (2.9%) stddev-sans-first:2.29 06:18:47 INFO - PROCESS | 1663 | Values: 86.0 86.0 80.0 85.0 81.0 83.0 81.0 85.0 83.0 80.0 06:18:47 INFO - PROCESS | 1663 | 06:18:47 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:142.80 Median:141.50 stddev:12.43 (8.8%) stddev-sans-first:12.93 06:18:47 INFO - PROCESS | 1663 | Values: 136.0 155.0 128.0 138.0 139.0 143.0 143.0 134.0 172.0 140.0 06:18:47 INFO - PROCESS | 1663 | 06:18:47 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.80 Median:163.00 stddev:4.71 (2.9%) stddev-sans-first:4.79 06:18:47 INFO - PROCESS | 1663 | Values: 160.0 163.0 170.0 174.0 161.0 163.0 160.0 160.0 165.0 162.0 06:18:47 INFO - PROCESS | 1663 | 06:18:47 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:1.20 (1.8%) stddev-sans-first:1.22 06:18:47 INFO - PROCESS | 1663 | Values: 67.0 66.0 68.0 65.0 64.0 67.0 66.0 66.0 67.0 65.0 06:18:47 INFO - PROCESS | 1663 | -------- Summary: end -------- 06:18:47 INFO - PROCESS | 1663 | 06:18:48 INFO - TEST-INFO | 1663: exit 0 06:18:48 INFO - TEST-OK | kraken | took 59079ms 06:18:48 INFO - SUITE-END | took 1175s 06:18:48 INFO - Completed test suite (00:19:36) 06:18:48 INFO - javascript benchmark 06:18:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3177.285110850059, 3221.3235220603674, 3247.3342964692242, 3319.7178239849613, 3377.324535092982, 4350.282203436429, 5511.0, 5572.665640061594, 5638.182463542784, 5682.488576028162, 5648.802291919784, 5668.206451096849, 5677.716114194284, 5679.346875109353, 5687.744051517681, 4263.978680106595, 5090.134677104901, 5148.510891465324, 5198.0, 5214.713190774506, 5150.2532132840715, 5211.3746350438005, 5224.712640804754, 5225.477452254763, 5230.320058392404, 5110.131277682803, 5127.589792816584, 5137.897242055156, 5141.845744627667, 5213.348331458567, 5192.766325515342, 5235.816746413895, 5249.055170069386, 5250.789968401259, 5307.097793375096, 5037.319961805183, 5062.215356619729, 5097.057044446789, 5152.613553983429, 5177.378714554277, 5539.2522009529, 5556.472135147195, 5604.299462567179, 5612.522935550483, 5661.0, 6167.537434692416, 6172.629642221436, 6178.196834411543, 6196.318404975449, 6196.504279657616, 6058.606190597641, 6111.409422667723, 6201.0, 6244.219472565929, 6254.249490061176, 5804.9419505805245, 5814.244148260699, 5816.098504731774, 5817.156512305692, 5820.272465941757, 6214.130021796952, 6249.468795152372, 6273.780417685359, 6283.7800676977, 6302.369763023753, 5057.72182529957, 5823.737931793079, 5867.178594996619, 6006.759729610767, 6106.247106899065, 6191.442770150708, 6196.938030619726, 6201.906971395432, 6209.348018458088, 6210.5652604317265, 5129.333186685707, 6148.354422785633, 6175.62946223219, 6185.907211391833, 6190.721417536221, 6034.969825150934, 6035.245594300713, 6203.379662033761, 6215.782447614311, 6226.844328891723, 4910.042541704404, 4930.778114984834, 4935.037667654845, 4950.777215025332, 4978.178600530944, 4410.007748256617, 4481.417415735934, 4507.481639611421, 4510.909781804346, 4530.275155975029, 4864.586510146606, 5724.227229324071, 5736.110902810071, 5740.827775166752, 5743.712814359265, 6112.572119951649, 6152.2002139722445, 6159.599626024294, 6169.9383006170265, 6491.123698300669, 5558.694271815089, 5658.207850900795, 5661.065924122556, 5735.913961290584, 5762.193292938992, 5442.4829641184815, 5451.454854514596, 5458.4814442628685, 5463.071277882769, 5470.5350045245805, 6265.780697675559, 6287.654179020106, 6289.056641503811, 6291.96854015727, 6297.338779428277, 6097.25246653012, 6115.113308570143, 6137.775380989496, 6187.783427580013, 6200.7519699211525, 6273.686315684106, 6273.780417685359, 6274.372562743689, 6281.874362512815, 6285.49716022708, 6093.055576385667, 6141.986572215713, 6150.907736384047, 6151.84620384494, 6157.630542167484, 5401.838604699851, 6078.6048906820915, 6114.3277820888225, 6145.692715364304, 6197.03945888388, 5988.700564971821, 6056.757729690763, 6080.331163571915, 6092.45167934888, 6093.482054025458, 4560.1335746208115, 5611.242482264842, 5880.8235752927485, 5897.764089436375, 6095.329513753572, 5639.577031722555, 5852.0, 5864.970675146597, 5931.0, 5950.137230101524, 5162.019216348882, 5821.505172060422, 6106.117570898517, 6110.572259941761, 6121.3572574879, 5763.394843541368, 5916.615419997686, 5921.644701317935, 5924.052151655715, 5930.911036334544], "value": 5612.40110256498, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.7507558531773, 492.9950700492996, 497.69143131258613, 506.9569086627636, 509.5935218796123, 24792.87603561984, 32621.673783262162, 32661.346773064524, 40976.59023409765, 42290.365644515354, 43786.12427751443, 44178.0, 44255.0, 44294.33558496617, 44319.335209971876, 9733.51332433379, 9904.306698531105, 9906.900930990705, 9918.90081099187, 9936.701898943043, 8715.782105447352, 8883.289336853068, 8895.976962649313, 9049.683261085831, 9706.174975127122, 8908.554572271392, 11915.523379064827, 12069.517219311261, 12075.456604452776, 12393.946514546229, 12043.0, 12109.757804843943, 12115.091368147425, 12120.333381664004, 12138.757224855497, 8626.568671566396, 11790.99776518997, 11886.821697674543, 11907.583234586835, 11913.166078374517, 40838.0, 41234.9691257721, 41325.58674413247, 43290.567094328966, 43379.78310108429, 3718.0, 4272.530021697611, 4286.03564198056, 4286.699931004831, 4389.692721509496, 31745.36509269825, 32770.344593108006, 33038.50442243344, 33086.3382732344, 33401.49897751536, 3256.96743032569, 3359.0930448778936, 3388.119089036868, 3434.8282585870606, 3461.2558299965626, 486350.0, 487238.0, 488863.0, 492160.0, 496147.0, 60949.0, 61007.38992610017, 61285.0, 61384.0, 61425.0, 63808.4905330202, 63942.68028659827, 63972.36027639757, 63979.0, 64081.0, 16675.49973500797, 16944.57638559021, 16969.0667013313, 16978.0, 16978.23597938096, 12934.0, 13011.0, 13017.284049377186, 13022.674433139058, 13032.218066915826, 14489.203093829941, 14755.63110922214, 15357.389243828577, 16609.0, 16615.750763738553, 7260.6732697028765, 7455.9545465872125, 7539.359154471931, 7570.394368450511, 7681.961590192125, 914.7621618379269, 988.8714467119229, 1034.730969947819, 1085.9728506787235, 1135.8466607008113, 30572.69427305743, 30580.84709576438, 31066.068017959497, 31507.36985260282, 31519.054428367184, 1082.832161015044, 1099.3294090604725, 1102.2064113838023, 1134.359087115777, 1246.4266437438698, 15536.533903982898, 15909.840901591067, 16033.679326413407, 16307.1031093291, 16384.934979226313, 588196.0, 593311.0, 593969.0, 594809.0, 597004.0, 51414.74292628588, 59394.0, 59893.40106598965, 60039.39960600338, 60240.0, 1252.8058150986794, 1415.971680566383, 1426.7645838436542, 1440.171901156818, 1456.8178977627797, 30931.381372372878, 31461.0, 32287.192820179684, 32398.028059158263, 33141.66858331482, 51401.7429912848, 51686.74156629193, 51798.22302665538, 51864.74067629638, 51948.740256299985, 583636.0, 592609.0, 592992.0, 779165.0, 794041.0, 39174.0, 40205.994850128984, 40499.59500405076, 40685.79657101695, 40748.38877416782, 47178.64517252586, 47412.52587474081, 47573.28640070333, 48077.0, 48672.0, 38825.223495530496, 39125.80437097796, 39252.60747392604, 39693.80918572447, 40241.390344385894, 39044.828655140394, 39645.40531892081, 40050.0, 40154.1969160621, 40598.797006015964, 37347.0, 37860.81069594635, 38389.424158638205, 38572.0, 38693.419598706605, 28227.15318540447, 33099.66900330966, 33170.83414582912, 34533.654663453046, 35474.46788298126, 20348.694769578764, 21215.68176477385, 24868.0, 25524.0, 25605.61591576165], "value": 20806.413553901297, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.6978538028056, 381.410720436925, 388.8114264581677, 393.92318497892904, 412.1941604163858, 15450.0, 16468.0, 20052.097655605496, 21170.68243976338, 21697.783022169773, 19981.900090499563, 20208.797912020877, 21201.151953921864, 21217.681734773952, 21234.681479777817, 4571.428571428572, 5127.33344665193, 5223.216517522383, 5225.738713064351, 5269.789208431658, 3813.504244448218, 4265.722728022669, 5475.863103422426, 6748.223954245275, 6753.15585551806, 6717.462602991774, 6777.627230502345, 6788.898166527506, 6794.471243970092, 6809.897851532206, 6446.355364463563, 6716.798496045127, 6725.39471447572, 6733.158355205599, 6738.124043874314, 3747.344214762433, 3919.3141200289833, 3968.3452230381954, 5522.779088836442, 5896.646201227897, 13067.673308167277, 13520.0, 13520.864791352058, 18813.81186188148, 26112.216633501026, 2018.0918586635926, 2018.7375641166554, 2125.787421257877, 2262.9547409051893, 2378.6432035194684, 9934.950325248328, 9935.56578638231, 10031.548580313904, 10420.0, 10440.530176142016, 1896.4310706788046, 1947.8539109566839, 1959.5101224693826, 1963.5876465942026, 1966.9409917702492, 111474.88525114807, 118450.40774796157, 122832.38583807113, 126656.0, 127829.36085319513, 10278.845817312746, 10928.945355273172, 11456.140789440658, 11512.136589755803, 11608.30350178992, 12683.429245683967, 13439.260840653858, 13483.52807651747, 13508.662283442993, 13517.459301628021, 8466.280366168821, 8527.147285271423, 8677.177792663486, 8715.520646364384, 8759.912400876037, 8610.182032706884, 8622.353323500762, 8661.090585488559, 8779.956100219459, 8820.029796722356, 4460.955390446054, 4525.705829121162, 4527.162474942146, 4587.38070360497, 4605.723656580616, 1883.369071361082, 1928.951776205578, 1931.420573827846, 1932.6231384880095, 1958.285225892539, 890.496869268861, 911.4667919267171, 928.9210417114485, 1021.6117875207374, 1053.5733028123623, 18831.90584047071, 20976.580468390854, 21868.01593928277, 21887.0, 21931.67102493464, 921.6313474610209, 933.874681009382, 938.1181689212119, 970.146271281268, 1009.8939611340851, 11023.724406889893, 11402.771944561062, 11461.71345716347, 11481.0, 11499.482523286471, 602733.9726602766, 610372.0, 616971.0, 622734.9769260304, 624689.0, 129035.35482322716, 129240.0, 129307.0, 131654.34172829075, 134054.0, 995.0696099147176, 996.6312464388222, 1024.6413755185624, 1048.2452634103433, 1050.9159267258601, 18633.81366186321, 18781.624367512846, 18838.152283147567, 18883.339083132574, 18995.0, 53104.0, 53486.73256633692, 54561.0, 54947.0, 56007.87984240211, 82227.0, 83012.0, 83743.0, 84613.7307940369, 84829.15170848212, 7899.011878325282, 7906.723264685938, 8000.119986801564, 8101.311388531805, 8257.876131858147, 12341.382930853242, 12762.42569084375, 12892.48430062787, 13147.868521315047, 13249.337533123113, 9793.118619324296, 10533.157347412342, 10818.891811081789, 11368.943155284502, 11373.260738052, 8947.239484643618, 10959.178061645249, 11083.944580277048, 11146.49840757184, 11399.943000284946, 10030.283473166915, 11157.163212758913, 11292.717682058013, 11648.301101933912, 11712.180147389941, 8041.597920103854, 8147.02235731716, 8205.425620206528, 8205.876911846446, 8370.121137280741, 10845.891541084487, 11253.324800511995, 11339.489722962322, 11364.772704545698, 11496.712582185177], "value": 9477.613786733285, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.2526672963234, 1533.8926275160736, 1562.1954693332932, 1791.1671072951076, 1953.062529985607, 7738.613069346538, 8333.87499187512, 8594.355423343259, 8595.097514760946, 8613.612387442565, 8319.708810191645, 8324.542150181738, 8507.574621268943, 8590.656373745058, 8616.052234254226, 2307.976920230801, 2364.5507353602848, 2366.857988520694, 2367.4081479630095, 2368.3131891751373, 2312.387217387394, 2340.2394221877958, 2362.0197617988515, 2367.988160059197, 2368.6210206366986, 2325.5813953488364, 2349.0, 2358.3750306168877, 2361.3978435498925, 2366.5858474766933, 2000.7299014632983, 2297.655351697242, 2328.592496313147, 2340.040583360814, 2348.0607756897207, 2328.918487852934, 2331.813454923602, 2332.5101728637005, 2339.3449834046496, 2339.543788961153, 8511.191436813493, 8658.264047555966, 8733.956330218309, 8740.475571465733, 8751.037385887546, 5149.176131818891, 5318.042752304584, 5328.786848526054, 5329.2006199070065, 5332.120200166968, 3567.375709250871, 3607.8917632471066, 3677.3564626190578, 3681.1901381695984, 3683.8158092095555, 1089.9945500272447, 1093.278436232083, 1096.8354746787966, 1102.4212288548497, 1108.4734750993293, 11354.48904799286, 11571.247868888495, 11574.016208622277, 11585.536578536849, 11619.709507262387, 4553.225951588238, 4570.88572785683, 4793.0, 4799.6400269979895, 4802.831900883452, 10053.296269261082, 10056.949715251378, 10077.244206684529, 10082.546285417175, 10085.0, 5380.219868119101, 5383.246345511631, 5386.434424385383, 5386.757595908193, 5388.218708287276, 4314.331278651814, 4361.302191649384, 4513.390692256503, 4881.194602890483, 4909.656324057281, 3317.3696997570382, 3951.4863067801, 3957.1294315250598, 4015.13674559971, 4085.632293093636, 1270.783966725659, 1279.3155661720934, 1291.0897817038965, 1293.2176033499786, 1300.8699130086916, 794.7456813819522, 889.7286327670123, 900.5587262241586, 912.2063804490136, 914.7804526913493, 5447.4824891635235, 5899.115132730039, 5952.7023648817385, 6005.489533389711, 6103.664298463538, 971.8542218667257, 988.5205675247499, 990.4997976022063, 1003.420752565576, 1035.0684384054261, 3320.5185248138882, 3441.5353927219503, 3817.751846129993, 3939.8621048263744, 4073.450084238649, 9931.155851752683, 10129.392236465836, 10286.537105830255, 10671.89328106709, 10836.620718274822, 10780.46097695112, 10796.514156862802, 10797.0, 10798.190135739851, 10798.946005269923, 8028.799280018046, 8166.918330816616, 8178.386621003329, 8286.212809783061, 8287.378446616527, 5763.567732420169, 5834.599696072997, 5868.4424979626865, 5906.468417842415, 5929.673867937305, 9837.360571562825, 10000.24998125129, 10029.899701003189, 10033.949830250802, 10036.0, 9176.40353377055, 9596.184324332231, 9785.36395134314, 10135.64525241613, 10326.380417174994, 6870.896936546056, 7106.182788979127, 7110.5022648414115, 7172.713091476283, 7183.173934997542, 7736.994190755166, 7882.369410447036, 8159.0, 8384.245417912418, 8412.831743365221, 7435.107787065586, 7567.508111972704, 7573.734919277799, 7632.694692212472, 7697.615119243904, 7476.887846682195, 7500.887486687813, 7538.447773657657, 7585.279398457138, 7616.20029896875, 6909.1018167639895, 7044.189918159273, 7053.153621565445, 7053.647317634201, 7065.046218760607, 4920.483349248278, 5064.645474816727, 5083.644144909968, 5100.056489549445, 5179.637425380338, 5045.899082018265, 5104.3619547556555, 5129.79480820763, 5132.8460146195675, 5275.446078161891], "value": 4577.529235325992, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.7257033248082, 299.2682890333135, 315.31419163319777, 316.60740681554864, 317.690252004296, 4676.947686770475, 4869.685185000048, 4941.160002799524, 5353.277307563478, 5372.973135134319, 4818.445878723948, 5085.8474245772595, 5244.737763111839, 5284.682919024852, 5392.2181283713835, 3355.9496607550786, 3527.8236088195617, 3918.471006414126, 4090.97954510227, 4092.283850326196, 3940.9802950985204, 4092.058826469899, 4100.58994100589, 4100.692448066392, 4108.712390132692, 4011.83952641894, 4058.289799285128, 4067.6339129478342, 4074.694397920153, 4075.572064933184, 3623.2572322673786, 3957.2481228566626, 4090.427340172378, 4090.754554726726, 4101.507819061701, 3086.876524939, 3558.323918455511, 3569.214772749991, 3577.5349204603235, 3581.4090675038588, 4422.668299877522, 4967.931894642633, 5233.764480598382, 5255.423372988088, 5293.682379057269, 4248.044190057243, 4381.8528920828885, 4679.578837904605, 4710.929336059962, 4732.82290146533, 4689.202835517936, 5054.469280725508, 5253.737313134367, 5656.434356564352, 5719.571032172604, 3273.9345213095603, 3812.218495208476, 3872.9806350968065, 3915.2561013407644, 3958.267720471722, 5065.0, 5860.531157507389, 5942.841145976537, 5963.0, 5965.970170149121, 3991.9620898566, 3996.980015099906, 4004.1991601679197, 4009.51885773709, 4014.558398576154, 3695.519582454264, 4001.1797581496307, 4049.8380064797666, 4051.777152256654, 4055.41196526502, 3717.665410113103, 3899.6880249579967, 4622.2835460503675, 4645.674802763841, 4671.556202160789, 4816.54242846929, 5064.82273120439, 5740.0815869460685, 5777.566682498829, 5793.536517078624, 1169.0997931592797, 1303.328785675378, 1310.8885744711615, 1318.4133060787858, 1345.7712188927906, 879.3448880584006, 890.2744263425287, 909.6270529083044, 913.794396260836, 918.2653876898454, 4513.526079761577, 4664.854167083112, 5242.5281724644965, 5363.249145119687, 5371.543418809367, 4814.831480898222, 5459.754311056012, 5831.533477321804, 5846.8538286542325, 5897.262842144732, 5091.541761241506, 5294.708791016454, 5301.496357845998, 5302.681839089667, 5311.49540793624, 2579.651747014129, 2594.366717781453, 2595.6106584012173, 2608.4000679843743, 2620.3318153871023, 4134.586541345901, 4657.765692091599, 4674.2988551716835, 4786.439254998559, 5072.970811675359, 5027.698338099725, 5052.494750524918, 5056.418511871182, 5575.4424557544735, 6125.571210015256, 5087.821926232564, 5566.66600003993, 6154.230721159855, 6162.568620196544, 6180.505559555225, 5666.773329066956, 5946.256717910262, 5963.853012915434, 5964.612300200473, 5982.551308651956, 5040.0, 5881.735741587315, 5883.176215373248, 5895.41045895407, 5899.0, 6082.574219804571, 6094.786682466092, 6107.786227482017, 6136.94961325523, 6139.0, 3220.4525230710365, 3700.333939890738, 3945.5265368156006, 3956.3867600521967, 3966.1869316790567, 4792.257200133846, 5848.502877255481, 5873.911891321548, 5890.087036509348, 5903.0, 4824.927626085681, 5201.791928322825, 5628.690422026664, 5630.735262529548, 5640.71796410186, 4809.206480930748, 5125.0, 5724.627899186539, 5769.336526299529, 5776.220210271559, 4473.865784026484, 4664.300354946649, 5167.509086636764, 5351.625386222927, 5722.799702010409, 4566.497685254553, 4781.780645935264, 5797.5361971041375, 5799.681017544076, 5801.82594522165, 5675.0, 5687.345955215038, 5697.373288938131, 5699.857503562444, 5705.486506214294], "value": 4069.542356925346, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.6053170756085, 769.2730369800539, 790.0164295452163, 796.41861441148, 818.8976377952756, 15560.610984725388, 16398.672026559463, 16442.83557164428, 16448.095354755485, 16453.0, 14855.405783768636, 15023.32395042223, 15042.924785376084, 15100.320485578148, 15106.622334441618, 695.5861262548775, 712.9465290103263, 864.6930339729399, 867.6702852915884, 885.2342723544152, 865.4504389712515, 880.6697488441835, 882.1222883231162, 882.1399135842535, 884.3102380143466, 941.1529623338981, 943.4433684126365, 944.3342443577296, 944.4946953379944, 945.3193700535603, 741.2254194366873, 751.6354568034499, 756.4137793210251, 757.6969212315063, 933.5332333833084, 568.1960026562409, 679.7654809090856, 688.3667026335783, 691.2154704410531, 695.7634404302562, 13601.251931143783, 13607.387667554984, 13622.318884055758, 13640.386182621805, 13648.0, 13635.38640761168, 13963.860361396357, 14035.859641403558, 14085.0, 14251.144931304156, 12843.165194262343, 12865.742685146339, 12923.15999460032, 12947.41736621845, 13031.934840325832, 4566.315052742082, 4633.791479383436, 4731.36126622905, 4737.857864264078, 4740.502247264057, 106782.0, 107466.46266768617, 117817.0, 117881.0, 118193.40903295514, 10926.289791163548, 11253.943730281297, 11440.027597654127, 11569.595064172714, 11581.305121692725, 21890.671639925415, 21895.12419503234, 21899.452513686967, 21922.561548769256, 21957.451063723216, 8001.159878212704, 8004.799880003046, 8082.070561885341, 8212.63043163059, 8235.95882020586, 4403.889902752457, 4472.59746622799, 4522.773861306921, 4589.2886602576655, 4759.857204283877, 3060.7398371138256, 3420.965790342065, 3576.3920133577353, 3580.0, 3581.7492775505466, 642.4667525953447, 647.2233320015999, 655.6426747422666, 661.7220767277755, 664.5779929744647, 563.184770214663, 619.928708198563, 626.7524327890458, 627.1345543150424, 645.8195073150004, 8590.441621294596, 8885.466871987572, 8927.10728927115, 9038.322125840588, 9083.636654533877, 576.3659974028619, 603.2820943077811, 638.6168299020551, 642.9357064293533, 647.3979199344654, 4338.8047537860875, 4376.7811609419405, 4390.604845563851, 4484.596386325246, 4513.684042117086, 137863.0, 146369.26815365854, 146586.26706866611, 147786.26106869397, 149651.0, 126040.36979815042, 129999.0, 130212.3489382547, 130297.0, 132224.422046238, 72482.9127563087, 89162.0, 108784.4560777191, 110890.44554777174, 111125.44437277762, 8368.874466883124, 8810.779730506532, 8923.196912277926, 9768.169705574821, 9787.749910568918, 46466.0, 54080.72959635177, 56417.8716425661, 59988.0, 60593.69703151456, 65853.0, 66162.66918665376, 66260.55669381918, 66527.0, 80879.3824123526, 11832.467538960595, 13602.387892545057, 13659.726805463637, 13741.725165496435, 14043.36804843805, 15609.453669121527, 15767.842321576638, 15810.288537016091, 16085.276162572478, 16269.51191464258, 12245.87754122483, 12311.876881231432, 12441.813372799596, 12458.0, 14692.016577761866, 14016.0, 14364.85635143677, 14384.784228236376, 14431.711365772415, 14486.855131448972, 13713.657158570717, 14016.29918504091, 14051.37728257525, 14188.645283867985, 14271.857281427052, 11183.105351571692, 11361.822175285914, 11696.35670038156, 11821.0, 11875.0, 9039.45763254207, 11602.535898563963, 11680.357580333164, 11851.881481185423, 11891.702707432383], "value": 7796.145582449265, "unit": "score"}], "name": "dromaeo_css", "value": 7373.80405707159, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 112.0, 112.0, 113.0, 111.0, 110.0, 112.0, 111.0, 112.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 112.0, 134.0, 178.0, 107.0, 134.0, 128.0, 108.0, 161.0, 134.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 185.0, 183.0, 183.0, 190.0, 260.0, 184.0, 183.0, 184.0], "value": 191.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 57.0, 87.0, 59.0, 58.0, 58.0, 65.0, 98.0, 57.0], "value": 69.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 91.0, 71.0, 78.0, 68.0, 96.0, 69.0, 68.0, 101.0], "value": 81.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 86.0, 84.0, 86.0, 83.0, 87.0, 84.0, 86.0, 83.0], "value": 85.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 92.0, 93.0, 92.0, 92.0], "value": 92.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 101.0, 114.0, 86.0, 84.0, 86.0, 85.0, 85.0, 84.0, 86.0], "value": 89.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 57.0, 53.0, 54.0, 55.0, 52.0, 54.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 81.0, 114.0, 106.0, 108.0, 70.0, 70.0, 71.0, 71.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 80.0, 85.0, 81.0, 83.0, 81.0, 85.0, 83.0, 80.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 155.0, 128.0, 138.0, 139.0, 143.0, 143.0, 134.0, 172.0, 140.0], "value": 142.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 170.0, 174.0, 161.0, 163.0, 160.0, 160.0, 165.0, 162.0], "value": 163.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 65.0, 64.0, 67.0, 66.0, 66.0, 67.0, 65.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1447.1999999999998, "alertThreshold": 2.0}]} 06:18:48 INFO - Return code: 0 06:18:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:18:48 INFO - # TBPL SUCCESS # 06:18:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:18:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:18:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:18:48 INFO - 2016-07-11 06:18:48.693 screenresolution[1667:9589] starting screenresolution argv=screenresolution get 06:18:48 INFO - 2016-07-11 06:18:48.695 screenresolution[1667:9589] Display 0: 1600x1200x32@60 06:18:48 INFO - 2016-07-11 06:18:48.701 screenresolution[1668:9592] starting screenresolution argv=screenresolution list 06:18:48 INFO - Available Modes on Display 0 06:18:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:18:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:18:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:18:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:18:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:18:48 INFO - Intel Iris: 06:18:48 INFO - Chipset Model: Intel Iris 06:18:48 INFO - Type: GPU 06:18:48 INFO - Bus: Built-In 06:18:48 INFO - VRAM (Dynamic, Max): 1536 MB 06:18:48 INFO - Vendor: Intel (0x8086) 06:18:48 INFO - Device ID: 0x0a2e 06:18:48 INFO - Revision ID: 0x0009 06:18:48 INFO - Displays: 06:18:48 INFO - Display: 06:18:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:18:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:18:48 INFO - Display Serial Number: 1600x1200 60 06:18:48 INFO - Main Display: Yes 06:18:48 INFO - Mirror: Off 06:18:48 INFO - Online: Yes 06:18:48 INFO - Rotation: Supported 06:18:48 INFO - Return code: 0 06:18:48 INFO - Running post-action listener: _resource_record_post_action 06:18:48 INFO - ##### 06:18:48 INFO - ##### Finished run-tests step (success) 06:18:48 INFO - ##### 06:18:48 INFO - Running post-run listener: _resource_record_post_run 06:18:48 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 36967936; Write bytes: 705146880; Read time: 239; Write time: 1933 06:18:48 INFO - TinderboxPrint: CPU usage
53.4% 06:18:48 INFO - TinderboxPrint: I/O read bytes / time
36,967,936 / 239 06:18:48 INFO - TinderboxPrint: I/O write bytes / time
705,146,880 / 1,933 06:18:48 INFO - TinderboxPrint: CPU idle
2,258.4 (46.6%) 06:18:48 INFO - TinderboxPrint: CPU system
965.3 (19.9%) 06:18:48 INFO - TinderboxPrint: CPU user
1,621.9 (33.5%) 06:18:48 INFO - TinderboxPrint: Swap in / out
443,363,328 / 0 06:18:48 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 398041600; Write bytes: 392984064; Read time: 29457; Write time: 808 06:18:49 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 34907648; Write bytes: 294459904; Read time: 221; Write time: 1080 06:18:49 INFO - Running post-run listener: _upload_blobber_files 06:18:49 INFO - Blob upload gear active. 06:18:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:18:49 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 06:18:49 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:18:49 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:18:49 INFO - (blobuploader) - INFO - Open directory for files ... 06:18:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:18:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:18:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:51 INFO - (blobuploader) - INFO - Done attempting. 06:18:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:18:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:18:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:53 INFO - (blobuploader) - INFO - Done attempting. 06:18:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:18:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:18:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:55 INFO - (blobuploader) - INFO - Done attempting. 06:18:55 INFO - (blobuploader) - INFO - Iteration through files over. 06:18:55 INFO - Return code: 0 06:18:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:18:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:18:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a1f1b398213638bfe065fd659612d65ba5c8a3583ebe61fd6d3c3e59857594e920c18d3c0932c76eaee6ef7f37e8f5b8a02e3c1bc9feacb0eb05a3409ea8afe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be7cd593782cb4664d73828c52964b6224132849c63669f851abc2a9e87c60ad3e58f64784548a1bf0b867ca6f684b4deb8e29ba5acd7f1bc4b56e6748b32267", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13ceebc8ba5af080b0228ae98ecfd6d5bb7ffef01268bde256e8dbb3106e633c703a66a842ccfd0b2b7b589487077645f3c83a2298777cae16aa846ed1e84abb"} 06:18:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:18:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:18:55 INFO - Contents: 06:18:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a1f1b398213638bfe065fd659612d65ba5c8a3583ebe61fd6d3c3e59857594e920c18d3c0932c76eaee6ef7f37e8f5b8a02e3c1bc9feacb0eb05a3409ea8afe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be7cd593782cb4664d73828c52964b6224132849c63669f851abc2a9e87c60ad3e58f64784548a1bf0b867ca6f684b4deb8e29ba5acd7f1bc4b56e6748b32267", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13ceebc8ba5af080b0228ae98ecfd6d5bb7ffef01268bde256e8dbb3106e633c703a66a842ccfd0b2b7b589487077645f3c83a2298777cae16aa846ed1e84abb"} 06:18:55 INFO - Running post-run listener: copy_logs_to_upload_dir 06:18:55 INFO - Copying logs to upload dir... 06:18:55 INFO - mkdir: /builds/slave/test/build/upload/logs 06:18:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.581485 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-07-11 06:18:55.824151) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 06:18:55.827569) ========= 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.8HnU0mUdeX/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.zp0IUXjzrj/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a1f1b398213638bfe065fd659612d65ba5c8a3583ebe61fd6d3c3e59857594e920c18d3c0932c76eaee6ef7f37e8f5b8a02e3c1bc9feacb0eb05a3409ea8afe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be7cd593782cb4664d73828c52964b6224132849c63669f851abc2a9e87c60ad3e58f64784548a1bf0b867ca6f684b4deb8e29ba5acd7f1bc4b56e6748b32267", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13ceebc8ba5af080b0228ae98ecfd6d5bb7ffef01268bde256e8dbb3106e633c703a66a842ccfd0b2b7b589487077645f3c83a2298777cae16aa846ed1e84abb"} build_url:https://queue.taskcluster.net/v1/task/BNYUPhiKSROGLoiy2sZAyw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011098 build_url: 'https://queue.taskcluster.net/v1/task/BNYUPhiKSROGLoiy2sZAyw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a1f1b398213638bfe065fd659612d65ba5c8a3583ebe61fd6d3c3e59857594e920c18d3c0932c76eaee6ef7f37e8f5b8a02e3c1bc9feacb0eb05a3409ea8afe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be7cd593782cb4664d73828c52964b6224132849c63669f851abc2a9e87c60ad3e58f64784548a1bf0b867ca6f684b4deb8e29ba5acd7f1bc4b56e6748b32267", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13ceebc8ba5af080b0228ae98ecfd6d5bb7ffef01268bde256e8dbb3106e633c703a66a842ccfd0b2b7b589487077645f3c83a2298777cae16aa846ed1e84abb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 06:18:55.860159) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 06:18:55.860517) ========= 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.8HnU0mUdeX/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.zp0IUXjzrj/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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.005047 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 06:18:55.911187) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 06:18:55.911831) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 06:18:55.912658) ========= ========= Total master_lag: 0.19 =========