builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0228 starttime: 1468677873.87 results: success (0) buildid: 20160716041051 builduid: 96a31fedca3d42c4b065d0ed9f3cf80e revision: 98e3e1a81859a64dfa625d1d40d3d0043a46941c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 07:04:33.867248) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 07:04:33.867656) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 7 secs) (at 2016-07-16 07:04:33.867944) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 7 secs) (at 2016-07-16 07:04:41.619974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 07:04:41.620356) ========= 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.9Ur9ME3cqO/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.aMsOeFz8uh/Listeners TMPDIR=/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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-16 07:04:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.17M=0.001s 2016-07-16 07:04:41 (8.17 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158437 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 07:04:41.800681) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 07:04:41.800964) ========= 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.9Ur9ME3cqO/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.aMsOeFz8uh/Listeners TMPDIR=/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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.020593 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 07:04:41.849113) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-16 07:04:41.849456) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 98e3e1a81859a64dfa625d1d40d3d0043a46941c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 98e3e1a81859a64dfa625d1d40d3d0043a46941c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9Ur9ME3cqO/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.aMsOeFz8uh/Listeners TMPDIR=/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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-16 07:04:41,928 truncating revision to first 12 chars 2016-07-16 07:04:41,928 Setting DEBUG logging. 2016-07-16 07:04:41,928 attempt 1/10 2016-07-16 07:04:41,928 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/98e3e1a81859?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-16 07:04:42,255 unpacking tar archive at: fx-team-98e3e1a81859/testing/mozharness/ program finished with exit code 0 elapsedTime=0.586249 ========= master_lag: 0.67 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-16 07:04:43.109757) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 07:04:43.110050) ========= script_repo_revision: 98e3e1a81859a64dfa625d1d40d3d0043a46941c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 07:04:43.110448) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 07:04:43.110739) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 07:04:43.135816) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-16 07:04:43.136228) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9Ur9ME3cqO/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.aMsOeFz8uh/Listeners TMPDIR=/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:04:43 INFO - MultiFileLogger online at 20160716 07:04:43 in /builds/slave/test 07:04:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 07:04:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:04:43 INFO - {'append_to_log': False, 07:04:43 INFO - 'base_work_dir': '/builds/slave/test', 07:04:43 INFO - 'blob_upload_branch': 'Fx-Team', 07:04:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:04:43 INFO - 'branch': 'Fx-Team', 07:04:43 INFO - 'buildbot_json_path': 'buildprops.json', 07:04:43 INFO - 'config_files': ('talos/mac_config.py',), 07:04:43 INFO - 'default_actions': ('clobber', 07:04:43 INFO - 'read-buildbot-config', 07:04:43 INFO - 'download-and-extract', 07:04:43 INFO - 'populate-webroot', 07:04:43 INFO - 'create-virtualenv', 07:04:43 INFO - 'install', 07:04:43 INFO - 'run-tests'), 07:04:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:04:43 INFO - 'download_minidump_stackwalk': True, 07:04:43 INFO - 'download_symbols': 'ondemand', 07:04:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:04:43 INFO - 'tooltool.py': '/tools/tooltool.py', 07:04:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:04:43 INFO - '/tools/misc-python/virtualenv.py')}, 07:04:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:04:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:04:43 INFO - 'installer_path': 'installer.exe', 07:04:43 INFO - 'log_level': 'info', 07:04:43 INFO - 'log_name': 'talos', 07:04:43 INFO - 'log_to_console': True, 07:04:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:04:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:04:43 INFO - 'opt_config_files': (), 07:04:43 INFO - 'pip_index': False, 07:04:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:04:43 INFO - 'cmd': ('bash', 07:04:43 INFO - '-c', 07:04:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:04:43 INFO - 'enabled': True, 07:04:43 INFO - 'halt_on_failure': False, 07:04:43 INFO - 'name': 'check_screen_resolution'},), 07:04:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:04:43 INFO - 'cmd': ('bash', 07:04:43 INFO - '-c', 07:04:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:04:43 INFO - 'enabled': True, 07:04:43 INFO - 'halt_on_failure': False, 07:04:43 INFO - 'name': 'check_screen_resolution'},), 07:04:43 INFO - 'run_cmd_checks_enabled': True, 07:04:43 INFO - 'sps_profile': False, 07:04:43 INFO - 'sps_profile_interval': 0, 07:04:43 INFO - 'suite': 'dromaeojs', 07:04:43 INFO - 'system_bits': '32', 07:04:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:04:43 INFO - 'title': 't-yosemite-r7-0228', 07:04:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:04:43 INFO - 'use_talos_json': True, 07:04:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:04:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:04:43 INFO - 'work_dir': 'build'} 07:04:43 INFO - ##### 07:04:43 INFO - ##### Running clobber step. 07:04:43 INFO - ##### 07:04:43 INFO - Running pre-action listener: _resource_record_pre_action 07:04:43 INFO - Running main action method: clobber 07:04:43 INFO - rmtree: /builds/slave/test/build 07:04:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:04:45 INFO - Running post-action listener: _resource_record_post_action 07:04:45 INFO - ##### 07:04:45 INFO - ##### Finished clobber step (success) 07:04:45 INFO - ##### 07:04:45 INFO - ##### 07:04:45 INFO - ##### Running read-buildbot-config step. 07:04:45 INFO - ##### 07:04:45 INFO - Running pre-action listener: _resource_record_pre_action 07:04:45 INFO - Running main action method: read_buildbot_config 07:04:45 INFO - Using buildbot properties: 07:04:45 INFO - { 07:04:45 INFO - "project": "", 07:04:45 INFO - "product": "firefox", 07:04:45 INFO - "script_repo_revision": "production", 07:04:45 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 07:04:45 INFO - "repository": "", 07:04:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 07:04:45 INFO - "buildid": "20160716041051", 07:04:45 INFO - "pgo_build": "False", 07:04:45 INFO - "basedir": "/builds/slave/test", 07:04:45 INFO - "buildnumber": 86, 07:04:45 INFO - "slavename": "t-yosemite-r7-0228", 07:04:45 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 07:04:45 INFO - "platform": "yosemite_r7", 07:04:45 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 07:04:45 INFO - "branch": "fx-team", 07:04:45 INFO - "repo_path": "integration/fx-team", 07:04:45 INFO - "revision": "98e3e1a81859a64dfa625d1d40d3d0043a46941c", 07:04:45 INFO - "stage_platform": "macosx64", 07:04:45 INFO - "builduid": "96a31fedca3d42c4b065d0ed9f3cf80e", 07:04:45 INFO - "slavebuilddir": "test" 07:04:45 INFO - } 07:04:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/a3m75HQyQVKqSpcWQ-t5CA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 07:04:45 INFO - Running post-action listener: _resource_record_post_action 07:04:45 INFO - ##### 07:04:45 INFO - ##### Finished read-buildbot-config step (success) 07:04:45 INFO - ##### 07:04:45 INFO - ##### 07:04:45 INFO - ##### Running download-and-extract step. 07:04:45 INFO - ##### 07:04:45 INFO - Running pre-action listener: _resource_record_pre_action 07:04:45 INFO - Running main action method: download_and_extract 07:04:45 INFO - mkdir: /builds/slave/test/build/tests 07:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:04:45 INFO - https://queue.taskcluster.net/v1/task/a3m75HQyQVKqSpcWQ-t5CA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:04:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3m75HQyQVKqSpcWQ-t5CA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 07:04:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3m75HQyQVKqSpcWQ-t5CA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 07:04:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3m75HQyQVKqSpcWQ-t5CA/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 07:04:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3m75HQyQVKqSpcWQ-t5CA/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 07:04:46 INFO - Downloaded 1199 bytes. 07:04:46 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 07:04:46 INFO - Using the following test package requirements: 07:04:46 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 07:04:46 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 07:04:46 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 07:04:46 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 07:04:46 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 07:04:46 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 07:04:46 INFO - u'jsshell-mac.zip'], 07:04:46 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 07:04:46 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 07:04:46 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 07:04:46 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 07:04:46 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 07:04:46 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 07:04:46 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 07:04:46 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 07:04:46 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 07:04:46 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 07:04:46 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 07:04:46 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:04:46 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')]} 07:04:46 INFO - https://queue.taskcluster.net/v1/task/a3m75HQyQVKqSpcWQ-t5CA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:04:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3m75HQyQVKqSpcWQ-t5CA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 07:04:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3m75HQyQVKqSpcWQ-t5CA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 07:04:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3m75HQyQVKqSpcWQ-t5CA/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 07:04:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3m75HQyQVKqSpcWQ-t5CA/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 07:04:47 INFO - Downloaded 18829419 bytes. 07:04:47 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'] 07:04:47 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 07:04:50 INFO - Return code: 0 07:04:50 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 07:04: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')]} 07:04:50 INFO - https://queue.taskcluster.net/v1/task/a3m75HQyQVKqSpcWQ-t5CA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:04:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3m75HQyQVKqSpcWQ-t5CA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 07:04:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3m75HQyQVKqSpcWQ-t5CA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 07:04:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3m75HQyQVKqSpcWQ-t5CA/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 07:04:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3m75HQyQVKqSpcWQ-t5CA/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 07:04:51 INFO - Downloaded 18829419 bytes. 07:04: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'] 07:04: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 07:04:55 INFO - Return code: 0 07:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:55 INFO - https://queue.taskcluster.net/v1/task/a3m75HQyQVKqSpcWQ-t5CA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:04:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3m75HQyQVKqSpcWQ-t5CA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 07:04:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3m75HQyQVKqSpcWQ-t5CA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 07:04:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3m75HQyQVKqSpcWQ-t5CA/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 07:04:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3m75HQyQVKqSpcWQ-t5CA/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 07:04:56 INFO - Downloaded 14403317 bytes. 07:04:56 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'] 07:04:56 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 07:04:56 INFO - Return code: 0 07:04:56 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')]} 07:04:56 INFO - https://queue.taskcluster.net/v1/task/a3m75HQyQVKqSpcWQ-t5CA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:04:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3m75HQyQVKqSpcWQ-t5CA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 07:04:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3m75HQyQVKqSpcWQ-t5CA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 07:04:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3m75HQyQVKqSpcWQ-t5CA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 07:04:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3m75HQyQVKqSpcWQ-t5CA/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 07:04:59 INFO - Downloaded 112781617 bytes. 07:04:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a3m75HQyQVKqSpcWQ-t5CA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 07:04:59 INFO - mkdir: /builds/slave/test/properties 07:04:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:04:59 INFO - Writing to file /builds/slave/test/properties/build_url 07:04:59 INFO - Contents: 07:04:59 INFO - build_url:https://queue.taskcluster.net/v1/task/a3m75HQyQVKqSpcWQ-t5CA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 07:05:00 INFO - Running post-action listener: _resource_record_post_action 07:05:00 INFO - Running post-action listener: set_extra_try_arguments 07:05:00 INFO - ##### 07:05:00 INFO - ##### Finished download-and-extract step (success) 07:05:00 INFO - ##### 07:05:00 INFO - ##### 07:05:00 INFO - ##### Running populate-webroot step. 07:05:00 INFO - ##### 07:05:00 INFO - Running pre-action listener: _resource_record_pre_action 07:05:00 INFO - Running main action method: populate_webroot 07:05:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:05:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:05:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:05:00 INFO - '--tppagecycles', 07:05:00 INFO - '7'], 07:05:00 INFO - 'tests': ['tsvgm']}}, 07:05:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:05:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:05:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:05:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:05:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:05:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:05:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:00 INFO - 'talos_options': ['--disable-e10s'], 07:05:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:05:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:05:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:00 INFO - 'talos_options': ['--disable-e10s'], 07:05:00 INFO - 'tests': ['damp', 'tps']}, 07:05:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:00 INFO - 'tests': ['damp', 'tps']}, 07:05:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:05:00 INFO - 'tests': ['dromaeo_dom']}, 07:05:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:05:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:05:00 INFO - 'tests': ['basic_compositor_video']}, 07:05:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:05:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:05:00 INFO - 'tests': ['a11yr', 07:05:00 INFO - 'ts_paint', 07:05:00 INFO - 'tpaint', 07:05:00 INFO - 'sessionrestore', 07:05:00 INFO - 'sessionrestore_no_auto_restore', 07:05:00 INFO - 'tabpaint']}, 07:05:00 INFO - 'other-e10s': {'tests': ['a11yr', 07:05:00 INFO - 'ts_paint', 07:05:00 INFO - 'tpaint', 07:05:00 INFO - 'sessionrestore', 07:05:00 INFO - 'sessionrestore_no_auto_restore', 07:05:00 INFO - 'tabpaint']}, 07:05:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:05:00 INFO - 'ts_paint', 07:05:00 INFO - 'tpaint', 07:05:00 INFO - 'sessionrestore', 07:05:00 INFO - 'sessionrestore_no_auto_restore', 07:05:00 INFO - 'tabpaint']}, 07:05:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:05:00 INFO - 'ts_paint', 07:05:00 INFO - 'tpaint', 07:05:00 INFO - 'sessionrestore', 07:05:00 INFO - 'sessionrestore_no_auto_restore', 07:05:00 INFO - 'tabpaint']}, 07:05:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:05:00 INFO - 'tests': ['a11yr', 07:05:00 INFO - 'ts_paint', 07:05:00 INFO - 'tpaint', 07:05:00 INFO - 'sessionrestore', 07:05:00 INFO - 'sessionrestore_no_auto_restore', 07:05:00 INFO - 'tabpaint']}, 07:05:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:05:00 INFO - 'tests': ['a11yr', 07:05:00 INFO - 'ts_paint', 07:05:00 INFO - 'tpaint', 07:05:00 INFO - 'sessionrestore', 07:05:00 INFO - 'sessionrestore_no_auto_restore', 07:05:00 INFO - 'tabpaint']}, 07:05:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:05:00 INFO - 'tests': ['tsvgx', 07:05:00 INFO - 'tsvgr_opacity', 07:05:00 INFO - 'tart', 07:05:00 INFO - 'tscrollx', 07:05:00 INFO - 'cart']}, 07:05:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:05:00 INFO - 'tsvgr_opacity', 07:05:00 INFO - 'tart', 07:05:00 INFO - 'tscrollx', 07:05:00 INFO - 'cart']}, 07:05:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:00 INFO - 'talos_options': ['--disable-e10s'], 07:05:00 INFO - 'tests': ['tp5o']}, 07:05:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:00 INFO - 'tests': ['tp5o']}, 07:05:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:00 INFO - 'talos_options': ['--disable-e10s', 07:05:00 INFO - '--xperf_path', 07:05:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:05:00 INFO - 'tests': ['tp5n']}, 07:05:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:00 INFO - 'talos_options': ['--xperf_path', 07:05:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:05:00 INFO - 'tests': ['tp5n']}}, 07:05:00 INFO - 'talos.zip': {'path': '', 07:05:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:05:00 INFO - Running post-action listener: _resource_record_post_action 07:05:00 INFO - ##### 07:05:00 INFO - ##### Finished populate-webroot step (success) 07:05:00 INFO - ##### 07:05:00 INFO - ##### 07:05:00 INFO - ##### Running create-virtualenv step. 07:05:00 INFO - ##### 07:05:00 INFO - Running pre-action listener: _resource_record_pre_action 07:05:00 INFO - Running main action method: create_virtualenv 07:05:00 INFO - Creating virtualenv /builds/slave/test/build/venv 07:05:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:05:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:05:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:05:00 INFO - Using real prefix '/tools/python27' 07:05:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:05:01 INFO - Installing distribute.............................................................................................................................................................................................done. 07:05:04 INFO - Installing pip.................done. 07:05:04 INFO - Return code: 0 07:05:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:05:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103217a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032ac618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9a9c920c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10317bd30>, '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 0x102ee0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103173b20>, '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.9Ur9ME3cqO/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.aMsOeFz8uh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:05:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:05:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:05:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ur9ME3cqO/Render', 07:05:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:05:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:05:04 INFO - 'HOME': '/Users/cltbld', 07:05:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:05:04 INFO - 'LOGNAME': 'cltbld', 07:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:04 INFO - 'MOZ_NO_REMOTE': '1', 07:05:04 INFO - 'NO_EM_RESTART': '1', 07:05:04 INFO - 'PAGER': '/bin/cat', 07:05:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:05:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:04 INFO - 'PWD': '/builds/slave/test', 07:05:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:05:04 INFO - 'SHELL': '/bin/bash', 07:05:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aMsOeFz8uh/Listeners', 07:05:04 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 07:05:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:05:04 INFO - 'USER': 'cltbld', 07:05:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:05:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:04 INFO - 'XPC_FLAGS': '0x0', 07:05:04 INFO - 'XPC_SERVICE_NAME': '0', 07:05:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:05:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:05:04 INFO - Cleaning up... 07:05:04 INFO - Return code: 0 07:05:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:05:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103217a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032ac618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9a9c920c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10317bd30>, '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 0x102ee0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103173b20>, '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.9Ur9ME3cqO/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.aMsOeFz8uh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:05:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:05:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:05:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ur9ME3cqO/Render', 07:05:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:05:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:05:04 INFO - 'HOME': '/Users/cltbld', 07:05:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:05:04 INFO - 'LOGNAME': 'cltbld', 07:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:04 INFO - 'MOZ_NO_REMOTE': '1', 07:05:04 INFO - 'NO_EM_RESTART': '1', 07:05:04 INFO - 'PAGER': '/bin/cat', 07:05:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:05:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:04 INFO - 'PWD': '/builds/slave/test', 07:05:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:05:04 INFO - 'SHELL': '/bin/bash', 07:05:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aMsOeFz8uh/Listeners', 07:05:04 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 07:05:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:05:04 INFO - 'USER': 'cltbld', 07:05:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:05:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:04 INFO - 'XPC_FLAGS': '0x0', 07:05:04 INFO - 'XPC_SERVICE_NAME': '0', 07:05:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:05:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:04 INFO - Downloading/unpacking psutil>=3.1.1 07:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:05:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:05:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:05:07 INFO - Installing collected packages: psutil 07:05:07 INFO - Running setup.py install for psutil 07:05:07 INFO - building 'psutil._psutil_osx' extension 07:05:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:05:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:05:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:05:07 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:05:07 INFO - building 'psutil._psutil_posix' extension 07:05:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:05:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:05:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:05:07 INFO - ^ 07:05:07 INFO - 1 warning generated. 07:05:07 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:05:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:05:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:05:08 INFO - Successfully installed psutil 07:05:08 INFO - Cleaning up... 07:05:08 INFO - Return code: 0 07:05:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:08 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 0x103217a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032ac618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9a9c920c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10317bd30>, '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 0x102ee0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103173b20>, '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.9Ur9ME3cqO/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.aMsOeFz8uh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:05:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:05:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ur9ME3cqO/Render', 07:05:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:05:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:05:08 INFO - 'HOME': '/Users/cltbld', 07:05:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:05:08 INFO - 'LOGNAME': 'cltbld', 07:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:08 INFO - 'MOZ_NO_REMOTE': '1', 07:05:08 INFO - 'NO_EM_RESTART': '1', 07:05:08 INFO - 'PAGER': '/bin/cat', 07:05:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:08 INFO - 'PWD': '/builds/slave/test', 07:05:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:05:08 INFO - 'SHELL': '/bin/bash', 07:05:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aMsOeFz8uh/Listeners', 07:05:08 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 07:05:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:05:08 INFO - 'USER': 'cltbld', 07:05:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:05:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:08 INFO - 'XPC_FLAGS': '0x0', 07:05:08 INFO - 'XPC_SERVICE_NAME': '0', 07:05:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:05:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:05:10 INFO - Installing collected packages: mozsystemmonitor 07:05:10 INFO - Running setup.py install for mozsystemmonitor 07:05:11 INFO - Successfully installed mozsystemmonitor 07:05:11 INFO - Cleaning up... 07:05:11 INFO - Return code: 0 07:05:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:05:11 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')]} 07:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:11 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')]} 07:05:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:11 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 0x103217a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032ac618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9a9c920c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10317bd30>, '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 0x102ee0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103173b20>, '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.9Ur9ME3cqO/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.aMsOeFz8uh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:05:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:05:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ur9ME3cqO/Render', 07:05:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:05:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:05:11 INFO - 'HOME': '/Users/cltbld', 07:05:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:05:11 INFO - 'LOGNAME': 'cltbld', 07:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:11 INFO - 'MOZ_NO_REMOTE': '1', 07:05:11 INFO - 'NO_EM_RESTART': '1', 07:05:11 INFO - 'PAGER': '/bin/cat', 07:05:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:11 INFO - 'PWD': '/builds/slave/test', 07:05:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:05:11 INFO - 'SHELL': '/bin/bash', 07:05:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aMsOeFz8uh/Listeners', 07:05:11 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 07:05:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:05:11 INFO - 'USER': 'cltbld', 07:05:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:05:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:11 INFO - 'XPC_FLAGS': '0x0', 07:05:11 INFO - 'XPC_SERVICE_NAME': '0', 07:05:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:05:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:11 INFO - Downloading/unpacking jsonschema==2.5.1 07:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:05:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:15 INFO - Downloading functools32-3.2.3-2.tar.gz 07:05:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:05:15 INFO - warning: no files found matching '*.txt' 07:05:15 INFO - no previously-included directories found matching 'build' 07:05:15 INFO - no previously-included directories found matching 'dist' 07:05:15 INFO - no previously-included directories found matching '.git*' 07:05:15 INFO - Installing collected packages: jsonschema, functools32 07:05:15 INFO - Running setup.py install for functools32 07:05:15 INFO - warning: no files found matching '*.txt' 07:05:15 INFO - no previously-included directories found matching 'build' 07:05:15 INFO - no previously-included directories found matching 'dist' 07:05:15 INFO - no previously-included directories found matching '.git*' 07:05:15 INFO - Successfully installed jsonschema functools32 07:05:15 INFO - Cleaning up... 07:05:15 INFO - Return code: 0 07:05:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:05:15 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')]} 07:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:15 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')]} 07:05:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:15 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 0x103217a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032ac618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9a9c920c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10317bd30>, '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 0x102ee0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103173b20>, '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.9Ur9ME3cqO/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.aMsOeFz8uh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:05:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:05:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:05:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ur9ME3cqO/Render', 07:05:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:05:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:05:15 INFO - 'HOME': '/Users/cltbld', 07:05:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:05:15 INFO - 'LOGNAME': 'cltbld', 07:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:15 INFO - 'MOZ_NO_REMOTE': '1', 07:05:15 INFO - 'NO_EM_RESTART': '1', 07:05:15 INFO - 'PAGER': '/bin/cat', 07:05:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:15 INFO - 'PWD': '/builds/slave/test', 07:05:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:05:15 INFO - 'SHELL': '/bin/bash', 07:05:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aMsOeFz8uh/Listeners', 07:05:15 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 07:05:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:05:15 INFO - 'USER': 'cltbld', 07:05:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:05:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:15 INFO - 'XPC_FLAGS': '0x0', 07:05:15 INFO - 'XPC_SERVICE_NAME': '0', 07:05:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:05:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:15 INFO - Downloading/unpacking blobuploader==1.2.4 07:05: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 07:05: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 07:05: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 07:05: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 07:05: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 07:05: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 07:05:18 INFO - Downloading blobuploader-1.2.4.tar.gz 07:05:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:05:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:05: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 07:05: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 07:05: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 07:05: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 07:05: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 07:05: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 07:05:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:05:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:19 INFO - Downloading docopt-0.6.1.tar.gz 07:05:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:05:19 INFO - Installing collected packages: blobuploader, requests, docopt 07:05:19 INFO - Running setup.py install for blobuploader 07:05:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:05:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:05:19 INFO - Running setup.py install for requests 07:05:20 INFO - Running setup.py install for docopt 07:05:20 INFO - Successfully installed blobuploader requests docopt 07:05:20 INFO - Cleaning up... 07:05:20 INFO - Return code: 0 07:05:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:05:20 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')]} 07:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:20 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')]} 07:05:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:20 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 0x103217a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032ac618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9a9c920c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10317bd30>, '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 0x102ee0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103173b20>, '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.9Ur9ME3cqO/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.aMsOeFz8uh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:05:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:05:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:05:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ur9ME3cqO/Render', 07:05:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:05:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:05:20 INFO - 'HOME': '/Users/cltbld', 07:05:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:05:20 INFO - 'LOGNAME': 'cltbld', 07:05:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:20 INFO - 'MOZ_NO_REMOTE': '1', 07:05:20 INFO - 'NO_EM_RESTART': '1', 07:05:20 INFO - 'PAGER': '/bin/cat', 07:05:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:05:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:20 INFO - 'PWD': '/builds/slave/test', 07:05:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:05:20 INFO - 'SHELL': '/bin/bash', 07:05:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aMsOeFz8uh/Listeners', 07:05:20 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 07:05:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:05:20 INFO - 'USER': 'cltbld', 07:05:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:05:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:05:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:20 INFO - 'XPC_FLAGS': '0x0', 07:05:20 INFO - 'XPC_SERVICE_NAME': '0', 07:05:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:05:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:05:20 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-9CBmsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:05:20 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-Qx9h_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:05:20 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-G0fGHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:05:21 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-XHAnTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:05:21 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-NxiEAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:05:21 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-kN6wjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:05:21 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-iHVC62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:05:21 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-C3JKxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:05:21 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-I0GMIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:05:21 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-gMySSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:05:21 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-9q1z2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:05:21 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-_ahYQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:05:21 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-XaYLbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:05:22 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-Fs3htX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:05:22 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-zeVaCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:05:22 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-PClcBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:05:22 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-PhizFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:05:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:05:22 INFO - Running setup.py install for manifestparser 07:05:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:05:22 INFO - Running setup.py install for mozcrash 07:05:22 INFO - Running setup.py install for mozdebug 07:05:22 INFO - Running setup.py install for mozdevice 07:05:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:05:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:05:23 INFO - Running setup.py install for mozfile 07:05:23 INFO - Running setup.py install for mozhttpd 07:05:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:05:23 INFO - Running setup.py install for mozinfo 07:05:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:05:23 INFO - Running setup.py install for mozInstall 07:05:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:05:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:05:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:05:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:05:23 INFO - Running setup.py install for mozleak 07:05:23 INFO - Running setup.py install for mozlog 07:05:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:05:23 INFO - Running setup.py install for moznetwork 07:05:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:05:24 INFO - Running setup.py install for mozprocess 07:05:24 INFO - Running setup.py install for mozprofile 07:05:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:05:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:05:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:05:24 INFO - Running setup.py install for mozrunner 07:05:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:05:24 INFO - Running setup.py install for mozscreenshot 07:05:24 INFO - Running setup.py install for moztest 07:05:24 INFO - Running setup.py install for mozversion 07:05:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:05:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:05:24 INFO - Cleaning up... 07:05:25 INFO - Return code: 0 07:05:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:05:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:05:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:25 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 0x103217a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032ac618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9a9c920c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10317bd30>, '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 0x102ee0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103173b20>, '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.9Ur9ME3cqO/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.aMsOeFz8uh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:05:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:05:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:05:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ur9ME3cqO/Render', 07:05:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:05:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:05:25 INFO - 'HOME': '/Users/cltbld', 07:05:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:05:25 INFO - 'LOGNAME': 'cltbld', 07:05:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:25 INFO - 'MOZ_NO_REMOTE': '1', 07:05:25 INFO - 'NO_EM_RESTART': '1', 07:05:25 INFO - 'PAGER': '/bin/cat', 07:05:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:05:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:25 INFO - 'PWD': '/builds/slave/test', 07:05:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:05:25 INFO - 'SHELL': '/bin/bash', 07:05:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aMsOeFz8uh/Listeners', 07:05:25 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 07:05:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:05:25 INFO - 'USER': 'cltbld', 07:05:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:05:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:05:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:25 INFO - 'XPC_FLAGS': '0x0', 07:05:25 INFO - 'XPC_SERVICE_NAME': '0', 07:05:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:05:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:05:25 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-Wz1L5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:05:25 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-pWDWk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:05:25 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-KuxvGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:05:25 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-ifFLN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:05:25 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-_uJYB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:05:25 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-e48nkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:05:25 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-qlF8C7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:05:26 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-7Wm3xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:05:26 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-3tKSh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:05:26 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-mRPt44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:05:26 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)) 07:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:05:26 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-KFnSPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:05:26 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-QBxbc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:05:26 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-aLLr6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:05:26 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-chdIJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:05:26 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-VR6HJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:05:26 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-6LEb3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:05:26 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-74fzRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:05:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:05:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:05:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:05:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:05:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:05:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:05:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:29 INFO - Downloading blessings-1.6.tar.gz 07:05:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:05:29 INFO - Installing collected packages: blessings 07:05:29 INFO - Running setup.py install for blessings 07:05:29 INFO - Successfully installed blessings 07:05:29 INFO - Cleaning up... 07:05:29 INFO - Return code: 0 07:05:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:05:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:05:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:05:30 INFO - Reading from file tmpfile_stdout 07:05:30 INFO - Current package versions: 07:05:30 INFO - blessings == 1.6 07:05:30 INFO - blobuploader == 1.2.4 07:05:30 INFO - docopt == 0.6.1 07:05:30 INFO - functools32 == 3.2.3-2 07:05:30 INFO - jsonschema == 2.5.1 07:05:30 INFO - manifestparser == 1.1 07:05:30 INFO - mozInstall == 1.12 07:05:30 INFO - mozcrash == 0.17 07:05:30 INFO - mozdebug == 0.1 07:05:30 INFO - mozdevice == 0.48 07:05:30 INFO - mozfile == 1.2 07:05:30 INFO - mozhttpd == 0.7 07:05:30 INFO - mozinfo == 0.9 07:05:30 INFO - mozleak == 0.1 07:05:30 INFO - mozlog == 3.2 07:05:30 INFO - moznetwork == 0.27 07:05:30 INFO - mozprocess == 0.23 07:05:30 INFO - mozprofile == 0.28 07:05:30 INFO - mozrunner == 6.12 07:05:30 INFO - mozscreenshot == 0.1 07:05:30 INFO - mozsystemmonitor == 0.3 07:05:30 INFO - moztest == 0.7 07:05:30 INFO - mozversion == 1.4 07:05:30 INFO - psutil == 3.1.1 07:05:30 INFO - requests == 1.2.3 07:05:30 INFO - wsgiref == 0.1.2 07:05:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:05: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')]} 07:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05: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')]} 07:05:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:30 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 0x103217a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032ac618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9a9c920c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10317bd30>, '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 0x102ee0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103173b20>, '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.9Ur9ME3cqO/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.aMsOeFz8uh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:05:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:05:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:05:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ur9ME3cqO/Render', 07:05:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:05:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:05:30 INFO - 'HOME': '/Users/cltbld', 07:05:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:05:30 INFO - 'LOGNAME': 'cltbld', 07:05:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:30 INFO - 'MOZ_NO_REMOTE': '1', 07:05:30 INFO - 'NO_EM_RESTART': '1', 07:05:30 INFO - 'PAGER': '/bin/cat', 07:05:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:05:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:30 INFO - 'PWD': '/builds/slave/test', 07:05:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:05:30 INFO - 'SHELL': '/bin/bash', 07:05:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aMsOeFz8uh/Listeners', 07:05:30 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 07:05:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:05:30 INFO - 'USER': 'cltbld', 07:05:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:05:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:05:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:30 INFO - 'XPC_FLAGS': '0x0', 07:05:30 INFO - 'XPC_SERVICE_NAME': '0', 07:05:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:05:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:05:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:05:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:05:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:05:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:05:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:05:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:05:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:05:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:05:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:05:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:05:30 INFO - Cleaning up... 07:05:30 INFO - Return code: 0 07:05:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:05: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')]} 07:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05: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')]} 07:05:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:30 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 0x103217a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032ac618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9a9c920c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10317bd30>, '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 0x102ee0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103173b20>, '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.9Ur9ME3cqO/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.aMsOeFz8uh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:05:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:05:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:05:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ur9ME3cqO/Render', 07:05:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:05:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:05:30 INFO - 'HOME': '/Users/cltbld', 07:05:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:05:30 INFO - 'LOGNAME': 'cltbld', 07:05:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:30 INFO - 'MOZ_NO_REMOTE': '1', 07:05:30 INFO - 'NO_EM_RESTART': '1', 07:05:30 INFO - 'PAGER': '/bin/cat', 07:05:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:05:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:30 INFO - 'PWD': '/builds/slave/test', 07:05:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:05:30 INFO - 'SHELL': '/bin/bash', 07:05:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aMsOeFz8uh/Listeners', 07:05:30 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 07:05:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:05:30 INFO - 'USER': 'cltbld', 07:05:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:05:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:05:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:30 INFO - 'XPC_FLAGS': '0x0', 07:05:30 INFO - 'XPC_SERVICE_NAME': '0', 07:05:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:05:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:05:30 INFO - Cleaning up... 07:05:30 INFO - Return code: 0 07:05:30 INFO - Running post-action listener: _resource_record_post_action 07:05:30 INFO - Running post-action listener: _start_resource_monitoring 07:05:30 INFO - Starting resource monitoring. 07:05:30 INFO - ##### 07:05:30 INFO - ##### Finished create-virtualenv step (success) 07:05:30 INFO - ##### 07:05:30 INFO - ##### 07:05:30 INFO - ##### Running install step. 07:05:30 INFO - ##### 07:05:30 INFO - Running pre-action listener: _resource_record_pre_action 07:05:30 INFO - Running main action method: install 07:05:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:05:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:05:31 INFO - Reading from file tmpfile_stdout 07:05:31 INFO - Detecting whether we're running mozinstall >=1.0... 07:05:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:05:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:05:31 INFO - Reading from file tmpfile_stdout 07:05:31 INFO - Output received: 07:05:31 INFO - Usage: mozinstall [options] installer 07:05:31 INFO - Options: 07:05:31 INFO - -h, --help show this help message and exit 07:05:31 INFO - -d DEST, --destination=DEST 07:05:31 INFO - Directory to install application into. [default: 07:05:31 INFO - "/builds/slave/test"] 07:05:31 INFO - --app=APP Application being installed. [default: firefox] 07:05:31 INFO - mkdir: /builds/slave/test/build/application 07:05:31 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'] 07:05:31 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 07:06:05 INFO - Reading from file tmpfile_stdout 07:06:05 INFO - Output received: 07:06:05 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:06:05 INFO - Running post-action listener: _resource_record_post_action 07:06:05 INFO - ##### 07:06:05 INFO - ##### Finished install step (success) 07:06:05 INFO - ##### 07:06:05 INFO - ##### 07:06:05 INFO - ##### Running run-tests step. 07:06:05 INFO - ##### 07:06:05 INFO - Running pre-action listener: _resource_record_pre_action 07:06:05 INFO - Running main action method: run_tests 07:06:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:06:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:06:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:06:05 INFO - 2016-07-16 07:06:05.570 screenresolution[1987:10274] starting screenresolution argv=screenresolution get 07:06:05 INFO - 2016-07-16 07:06:05.573 screenresolution[1987:10274] Display 0: 1600x1200x32@60 07:06:05 INFO - 2016-07-16 07:06:05.579 screenresolution[1988:10276] starting screenresolution argv=screenresolution list 07:06:05 INFO - Available Modes on Display 0 07:06:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:06:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:06:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:06:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:06:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:06:05 INFO - Intel Iris: 07:06:05 INFO - Chipset Model: Intel Iris 07:06:05 INFO - Type: GPU 07:06:05 INFO - Bus: Built-In 07:06:05 INFO - VRAM (Dynamic, Max): 1536 MB 07:06:05 INFO - Vendor: Intel (0x8086) 07:06:05 INFO - Device ID: 0x0a2e 07:06:05 INFO - Revision ID: 0x0009 07:06:05 INFO - Displays: 07:06:05 INFO - Display: 07:06:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:06:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:06:05 INFO - Display Serial Number: 1600x1200 60 07:06:05 INFO - Main Display: Yes 07:06:05 INFO - Mirror: Off 07:06:05 INFO - Online: Yes 07:06:05 INFO - Rotation: Supported 07:06:05 INFO - Return code: 0 07:06:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:06:05 INFO - Python 2.7.3 07:06:05 INFO - Return code: 0 07:06:05 INFO - grabbing minidump binary from tooltool 07:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:05 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 0x10317bd30>, '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 0x102ee0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103173b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:06:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:06:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:06:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:06:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:06:05 INFO - Return code: 0 07:06:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:06:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:06:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:06:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:06:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:06:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a3m75HQyQVKqSpcWQ-t5CA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0228', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a3m75HQyQVKqSpcWQ-t5CA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0228 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:06:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ur9ME3cqO/Render', 07:06:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:05 INFO - 'HOME': '/Users/cltbld', 07:06:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:05 INFO - 'LOGNAME': 'cltbld', 07:06:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:06:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:05 INFO - 'MOZ_NO_REMOTE': '1', 07:06:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:06:05 INFO - 'NO_EM_RESTART': '1', 07:06:05 INFO - 'PAGER': '/bin/cat', 07:06:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:05 INFO - 'PWD': '/builds/slave/test', 07:06:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:06:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:05 INFO - 'SHELL': '/bin/bash', 07:06:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aMsOeFz8uh/Listeners', 07:06:05 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 07:06:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:05 INFO - 'USER': 'cltbld', 07:06:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:05 INFO - 'XPC_FLAGS': '0x0', 07:06:05 INFO - 'XPC_SERVICE_NAME': '0', 07:06:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a3m75HQyQVKqSpcWQ-t5CA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0228', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:06:06 INFO - mozversion application_buildid: 20160716041051 07:06:06 INFO - mozversion application_changeset: 98e3e1a81859a64dfa625d1d40d3d0043a46941c 07:06:06 INFO - mozversion application_display_name: Nightly 07:06:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:06:06 INFO - mozversion application_name: Firefox 07:06:06 INFO - mozversion application_remotingname: firefox 07:06:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:06:06 INFO - mozversion application_vendor: Mozilla 07:06:06 INFO - mozversion application_version: 50.0a1 07:06:06 INFO - mozversion platform_buildid: 20160716041051 07:06:06 INFO - mozversion platform_changeset: 98e3e1a81859a64dfa625d1d40d3d0043a46941c 07:06:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:06:06 INFO - mozversion platform_version: 50.0a1 07:06:06 INFO - using testdate: 1468677966 07:06:06 INFO - actual date: 1468677966 07:06:06 INFO - starting webserver on 'localhost:49391' 07:06:06 INFO - SUITE-START | Running 2 tests 07:06:06 INFO - TEST-START | dromaeo_css 07:06:06 INFO - operating with platform_type : mac_ 07:06:06 INFO - Initialising browser for dromaeo_css test... 07:06:06 INFO - TEST-INFO | started process 1998 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/tmp6bkY74/profile http://localhost:49391/getInfo.html) 07:06:08 INFO - PROCESS | 1998 | __metrics Screen width/height:1600/1200 07:06:08 INFO - PROCESS | 1998 | colorDepth:24 07:06:08 INFO - PROCESS | 1998 | Browser inner width/height: 1024/689 07:06:08 INFO - PROCESS | 1998 | __metrics 07:06:08 INFO - PROCESS | 1998 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:06:08 INFO - PROCESS | 1998 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:06:09 INFO - TEST-INFO | 1998: exit 0 07:06:09 INFO - Browser initialized. 07:06:09 INFO - Running cycle 1/1 for dromaeo_css test... 07:06:09 INFO - TEST-INFO | started process 2000 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/tmp6bkY74/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:06:21 INFO - PROCESS | 2000 | RSS: Main: 243810304 07:06:21 INFO - PROCESS | 2000 | 07:07:12 INFO - PROCESS | 2000 | 1468678032672 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:09:23 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49391/tests/dromaeo/cssquery-ext.html) 07:09:24 INFO - PROCESS | 2000 | RSS: Main: 354959360 07:09:24 INFO - PROCESS | 2000 | 07:12:27 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-ext.html (next: http://localhost:49391/tests/dromaeo/cssquery-jquery.html) 07:12:28 INFO - PROCESS | 2000 | RSS: Main: 383516672 07:12:28 INFO - PROCESS | 2000 | 07:15:30 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49391/tests/dromaeo/cssquery-mootools.html) 07:15:31 INFO - PROCESS | 2000 | RSS: Main: 376922112 07:15:31 INFO - PROCESS | 2000 | 07:18:33 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49391/tests/dromaeo/cssquery-prototype.html) 07:18:34 INFO - PROCESS | 2000 | RSS: Main: 372224000 07:18:34 INFO - PROCESS | 2000 | 07:21:37 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49391/tests/dromaeo/cssquery-yui.html) 07:21:38 INFO - PROCESS | 2000 | RSS: Main: 342937600 07:21:38 INFO - PROCESS | 2000 | 07:24:41 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-yui.html (next: http://localhost:49391/tests/dromaeo/cssquery-dojo.html) 07:24:42 INFO - PROCESS | 2000 | RSS: Main: 411824128 07:24:42 INFO - PROCESS | 2000 | 07:24:42 INFO - PROCESS | 2000 | __start_tp_report 07:24:42 INFO - PROCESS | 2000 | _x_x_mozilla_page_load 07:24:42 INFO - PROCESS | 2000 | _x_x_mozilla_page_load_details 07:24:42 INFO - PROCESS | 2000 | |i|pagename|runs| 07:24:42 INFO - PROCESS | 2000 | |0;dojo.html;3142.340108577199;3252.203210213497;3297.1592243977775;3324.235425852054;3328.8335583220833;5564.693941833198;5582.218489411481;5605.775768969246;5627.549796016319;5662.17898404731;5618.988582055228;5648.406917273689;5660.377358490563;5665.688387138705;5674.09214525676;4409.206342858284;4818.59041981432;5094.77073531692;5212.1660534314515;5237.47625237477;5134.1528647773075;5202.219667049954;5210.2445145453885;5211.687298762067;5229.843104706865;5151.4075881273575;5165.948340516603;5182.844514664547;5189.299444574991;5208.765605547759;5236.423993360746;5250.05499010178;5270.998510283072;5271.683698978073;5327.147656374961;5076.162433198518;5084.567811736007;5095.108356037678;5103.515166059218;5137.537621614036;5551.084071128259;5602.215689803431;5621;5623.971880140614;5745.511631511326;6199.380061993809;6235.563510554263;6238.313785483593;6239.937600623981;6244.46922011625;5607.439256074401;5697.259356283656;6141.78503752371;6261.436470717657;6290.622562646256;4813.855584332476;5732.914006289909;5762.942370576283;5850.297964244318;5879.823605291848;6191.102290167901;6234.937650623436;6244.219472565929;6250.562460627712;6259.655718935503;5884.735186916599;5987.101934709828;6049;6163.013917773134;6189.783357582463;6103.489197737689;6165.229346331708;6184.226971628546;6185.319614842364;6193.907091393633;6140.9078863816185;6154.19995400604;6156.29202641702;6158.630482171084;6178.7219575119225;5807.622504537191;6044.425779550936;6097.3292937776805;6186.721597528122;6198.132261483396;4895.853124406273;4930.531599498042;4937.456879743226;4943;4945.703257804544;3289.5394644749754;4436.933445998313;4474.955250447519;4484.708493947948;4489.618382437529;5611.270534830446;5642.322921249394;5668.461496157858;5674.829755107354;5699.401562835926;6197.915893905445;6237.719302631393;6284.591501552384;6301.6534090625455;6314.62112273265;5529;5552.91670624941;5558.805441809517;5596.944030559724;5638;5387.003404370204;5397.217403476474;5406.243125962368;5409.918851217235;5422.728863556807;5799.695068609613;6001.699915004319;6240.594361366497;6286.277078136073;6294.087357333161;5426.918596220981;5835.328937172279;6062.545309101747;6119.541034422347;6284.277308109626;6205.875882482234;6222.875542489034;6225.252969643671;6226.533010024357;6284.874302514016;5917.112433135064;6065.939340606537;6070.575059745952;6078.7872424466705;6091.086337049478;5996.2504686914135;6023.548233882389;6046.90929636047;6151.3541078186145;6154;6012.038073908154;6054.212952316347;6086.817395478142;6099.695015249131;6107.786227482017;5467.660423196183;5662.462066103713;6045.395460453919;6095.8780824382375;6100.511959043355;5738.885222295614;5829.854253643693;5883.676397797991;5928.940710593011;5931.911021334769;5958.314793798769;6088.634681918922;6096.542759293159;6098.603590766586;6103.938960610337;5855.912161317498;5876.324222714443;5885.3820348862755;5887.67617781009;5890.764369425175 07:24:42 INFO - PROCESS | 2000 | |1;ext.html;508.6541152016628;521.5592824063665;524.2372348233321;526.6839896062363;563.9960869652018;30870.91951781688;32485.350292994124;32502.0249392518;32536.349273014526;32560.83719581405;43970.560294397044;44977.55022449775;45038.774806126006;47419.52580474194;47480;9885.15976142027;10040.297179197423;10046.346987445793;10052.648157314496;10071.093601575856;8866;9054.637814487412;9779.11987921087;9891.90108098917;9896.55465504054;12012.639620811346;12226.449809758582;12228.266304021787;12465.688357791083;12500.187487813308;12295.754084918297;12363.505459781598;12371.319577423239;12373.257604543756;12416.751664966696;8760.386772925898;11852.703682407922;12151.392430378446;12172.452239649238;12279.140460167791;42701.35947960783;42809.143817123484;42922.71231863049;43132.56867431348;43153.70538883838;3570.393033184365;3597.6582224688614;3623.4808735817687;4040.2525532776235;4104.630583247492;33074.106364428946;33416.832915835264;33679.6632033679;34073.659263407295;35450.759223427056;3296;3352.5306457096026;3429.9485507717404;3463.0476618929742;3465.7573969822124;525656.3717181428;526832;528514;529818;530959;65710.67144664342;66219.66890165518;66289.66855165693;66308.67382652416;66337;68064;68966.65516672384;69011.96482052773;69035;69099;16506.58733531671;17321.7401738974;17326;17357.218925148398;17362;13156.144850584682;13244.337783110806;13257.40911090656;13261.204327740366;13265.734685306239;15260.31328590216;16142.435014774426;16529.016518017674;18226.635467290846;18774.436766897015;6890.655467226618;6922.58464492132;7005.458799064198;7017.789466316019;7020.613866237406;940.2759874896428;1018.6842078955548;1092.5796464595994;1099.2140619456966;1142.1433924556582;30631.774729011035;31454.37091258162;31468.685313147034;31630.36739265248;32028.679713203037;975.9898505047383;1034.6120204923154;1041.3075304922143;1081.0540776820283;1092.2136062035322;14773.482928097465;16477;16573.585660358345;16753.999306621954;16930.661386772197;679434;680694;693692;696077;699459;60350;62132.68933655393;62212;62350.0647490288;62436;1379.9931000344934;1387.9167249965035;1388.3821699343896;1396.7555677756352;1407.507372419645;30252.69747302499;30696.232594185323;30828.537571936886;31388.843055784575;31873;41591.37612935748;54724;55161.44838551724;55177;55316.44683553274;616847;618726;622211.7778822153;623808;626610;27271.72728272692;27900.16299511018;28076.71923280741;44178;44547.33179002253;41308;42263.52077677267;50305.239316623745;50654.49345506498;50850.491495086055;40256.79871600623;40911.7954410226;42181;42297.788511057246;43208.135837283706;40959.97600059903;41355;41372.965675858344;42080;42398.72803815891;39846.00384990399;40603.59396405998;40956.79521602373;41026;41040.1791964165;29221.561676575293;34798;35831;35876;36369.81815090908;25865;25981.610275845498;26231.60652590251;26238.86880565585;26495.33761655897 07:24:42 INFO - PROCESS | 2000 | |2;jquery.html;381.32505465326375;388.9027743064234;389.6493156159458;389.68458987894394;410.54429583162687;14785.852141478583;20887;21660.458488537795;21884.781152188494;21891.781082189194;16359.59101022475;19072.378847797954;21090.261840835534;21249.68125478119;21841.344759657197;5992.850178745544;6195.5663103582765;6238.4385405313515;6253.624782513041;6262.373762623747;5177.689338639675;5789.710514474281;6125.081237814319;6125.5712100153005;6221.284552276478;3899.941500877489;4111.177764447108;5842.211301474289;6137.140800287963;6137.815865524041;6052.277849122802;6109.786157484489;6118.112873633343;6149.29283132441;6637.668116594151;5911.497522710575;5927.762889484416;5937.554683398763;5957.612755170943;5965.522758179335;12838.293893835835;13632.045756797028;13637.249951252677;13973.371198296101;14025.64935876601;2162.0378931375544;2203.372038968886;2415.770501802326;2994.475966705818;3079.414911166871;10158.796824063478;10266.12737917278;10548.261621686484;10662.360258384522;10675.733106672318;1847.1410793980729;1910.426871938413;1946.5912158446743;1951.9707204391946;1953.8632295739303;119403;120513;123740;124726.37636811848;126034.10948835775;11533;11666.183367164387;11802.177552779409;11829.526818927146;11842.76314473723;14886.553403397915;15012.249387530579;15038.699226015418;15053.473128440452;15071.171085590178;8635.352348573757;8731.126887311219;8751.693690720795;8782.692605758895;8819.514926678967;8609.956950215208;8619.913800862036;8624.525651089125;8737.781555461164;8790.560471976376;3822.617738226211;4510.188166130062;4599.539246503105;4611;4663.440387153563;1751.9152208871658;1847.3257261099602;1930.3365638415469;1949;1995.6607376745699;769.2768797330491;864.7449002544264;930.1721467893581;984.6799790068256;996.9601215951426;16923.238454269587;21367.03848326829;21979.010944507216;22421.878906054633;22805.88597057004;919.866619340192;944.7256127815709;946.966856160031;950.9476978766235;969.709087273815;10058.34620749649;11062;11230.876912308704;11379.374134422686;11767.11746619007;538971;585206;609879;629811;631145;104685;126260.36869815776;144402;147136;148539;985.3841349156777;1007.4005966449951;1024.1346062577259;1044.9738756530996;1048.1457612046158;14896.329665164876;20107.98920108036;20150.59698806045;20165.697514537;20200.797992020478;36612.81693591515;38472;47873.5212647883;49832.75083624704;52383.73808130935;79012.60493697495;79991.60004199942;80222;80401.59799200967;82058;7164.641767911688;8615.138486151585;8686.652533898574;8715.782105447415;8723.214910658071;9890.851637225303;11554.768904621693;13699.041067125605;13703.314834258048;13876.58370248894;11813.527458901892;11926.344051077274;11927.880721193023;11953.163278570417;11984.340861252715;11667.949884510435;11713.062954963752;11769.470373833026;12006.21959572625;12010.939945300217;11884.702882428008;11890.643280701594;11914.702132446411;12141.575044873387;12165.33090680021;8631.91368086311;8639.697610583851;8709;8729.25801306896;8827.602757875782;11089.112870970464;11951.820722688994;12035.217710848767;12118.454669539715;12125.454354553889 07:24:42 INFO - PROCESS | 2000 | |3;mootools.html;1574.6693194429165;1608.091428342986;1809.4842969753622;1906.3708976037908;1928.0263466949189;8725.956370218148;8991.730248092552;9214.585343659535;9222.170004699576;9225.861612075823;8041.276285134337;8256.133106023872;8770.429922055062;8968.775780605472;9029.683961061364;2391.461921067759;2418.9274321770285;2419.250032489934;2419.8185136114776;2423.1761201191593;2376.964345534818;2401.495685905953;2419.1532963462737;2421.6609674645565;2428.162284012013;2126.766055733868;2190.561887622474;2336.918207862725;2415.372003279151;2416.9879150604224;2378.6194208926663;2398.4243781492405;2416.4442178298914;2417.2023232333286;2421.4672771990136;2399.2082612737754;2409.1929203716777;2411.4212588978694;2412.49337639096;2416.2509622017233;9118.58966346516;9189.264858811346;9199.862002069975;9203.171714545657;9218.308626853013;5314.97342513285;5444.074507333763;5497.532709719679;5504.4770746778995;5521.751521181556;3556.466530020492;3618.1859081706407;3735.72121006186;3738.1776009277914;3747.0445036515785;1082.2153938394601;1092.3362366131632;1111.8165502692045;1125.217973508412;1126.2791813239533;12447.190932589352;12460.190087644274;12464.376781160905;12483.875161248452;12507.687307817287;3650.543682039745;4302.763348015889;4530.731395209346;4639.025804581076;4900.019996000814;10313.535890884928;10393.06462418386;10393.37639741618;10394.688159355232;10401.323913945569;5491.505764481216;5492.945070549324;5496.203050557647;5498.725063746797;5533.335999680065;4842.443119041285;5014.89970200594;5030.647854650139;5034.748262586856;5034.84895453137;3898.922021559553;3904.574830187018;3928.096537796323;3952.308346039489;4016.59834016596;1062.2033474893828;1113.4655365424642;1149.109440183864;1190.7201807575213;1206.1315852586124;747.7906186267745;788.5071830106184;825.1748251748252;880.6565439478609;912.119804388768;6116.938830611726;6161.96919015411;6221.47117495018;6246.187995560639;6302.747890084437;907.981840363189;911.7629416351797;932.7668082979255;956.206348730552;967.6855022117699;4006.3790112532606;4137.937930931039;4142.668586513072;4198.727082739612;4237.110206856594;9451;11035.83446248307;11242.213045086766;11336.603218887465;11399.886001140048;10066.49667516636;11118.999290063934;11251.493682784294;11258.943705281585;11275.210735248455;7606.239376062349;8123.106458289583;8182.918170818335;8439.367047471464;8586;6042.818715438544;6111.236095488064;6292.874142517216;6313.329304894575;6359.90460143089;10094.24293178;10239.436830974368;10482.842757358798;10517.894821051692;10534.473276336306;10153.543090560795;10428.333208890155;10500.949905009744;10543.472826358804;10553.63062292816;7103.751368702071;7277.854442911006;7282.781516554512;7296;7296.562206267641;7934.880976785468;8523.74428767138;8625.353098517511;8635.913640863511;8636.14322920575;6754;7029.683664235224;7672.808179795326;7756.8448631028195;7770.883436748566;7622;7643.57960312166;7702.961485192538;7766.262205090507;7773.3004029637605;7143.321384468467;7301.634918254173;7307.488475806643;7311.561306321638;7312.780616581511;4873.87815304606;4984.526469985346;5087.618428617942;5100.336956195671;5173.896522069613;4447.266201076786;5196.272521846869;5362.812301569426;5364.892702146013;5393.352797664305 07:24:42 INFO - PROCESS | 2000 | |4;prototype.html;274.4894496236999;301.2513902951167;312.0482528288719;319.2497630568167;320.5144206527112;4477.395551600533;4522.389477420547;5180.715060671661;5459.781608735646;5506.862328441791;5058.408529943735;5144.22836574514;5293.761780719868;5421.457854214586;5465.863353416166;3853;3954.9123990902444;4157.625813676768;4184.351425529047;4213.967577943408;3348;3737.140457694732;3930.272899513585;4212.662986961036;4220.324748040314;3923.431102490137;4092.85675001375;4124.298869192229;4143.979280103596;4149;4061.3907913813164;4093.7543747375253;4115.588441155875;4125.938110928309;4128.339465685506;3548.840302186382;3551.3074950384685;3579.2125732338845;3587.5694916610173;3595.856165753367;4919.827806026772;5298.708571028592;5299.12564426873;5340.652857564285;5354.759035843396;3684.5946945835935;4637.304404339342;4655.604273636745;4666.813327466897;4704.01215744694;5187.48125187482;5406.513413792738;5654.236678048452;5669.489745922846;5749;3776.3013842439236;3827.8464878213895;3864.5555761087553;3879.8254078566533;3904.3362628352966;4971.900561988812;5096.79612815487;5726.885462290731;5887.941120588782;5941.732622031976;3892.591277915778;3917.353636649978;3917.490726205575;3925.1953349563273;3956.169204467094;3922.9019274517796;3979.4030895365927;3992.4610177626228;3998;4015.8795236142964;3688.2001345841595;4657.464391594942;4714.5521175488275;4716.693414928019;4719.032598317337;5520.861978450491;5571.609987300931;5711.7144142792695;5766.769329226868;5782.971085144632;1130.8642962844347;1264.7415821257907;1285.6271681212531;1315.7894736842252;1356.620146359021;839.9328053755808;841.3563623827777;871.2811930157645;895.7357579514058;923.9861402078974;4598.517155698671;4704.788284527204;4980.352554168007;5269.683818970874;5442.537384322298;5037.269595908573;5538.972305138448;5701.230333904953;5860.267466566679;5900.4984576310635;4811.975940120347;4880.876818583927;5254.133068043807;5264.289320941701;5279.366476022902;2817.337925587485;3001.744851687631;3006.669266380696;3059.393818245439;3068.8925887594273;5198.636095473281;5705.71471426427;5942.405759424109;5953.345132035559;6029.125776762345;5109.72256935766;5411.945880541223;5568.552176434076;5849.268841394741;5951.226340575784;5183.19660452638;5683.5737319700365;5896.882062358729;5905.055191169392;5915.792947246826;5494.5054945055135;5723.427657234243;5742.885142297214;5754.798582049608;5862.882742345215;4737.715737055788;4749.525047495361;5324.6006549508165;5684.63049901755;5686.516646084963;4523.841665541822;5879.2944846618675;5899.852503687443;5952.732127054206;5957.3744756799915;3297.8515966781074;3908.1241004318654;3947.9407808883466;3953.1895961328432;3968.4840970673627;5141.331626888481;5636.505366672689;5650.689212093374;5773.364929857797;5803.970980145073;5405.702686352289;5609.382967873449;5670.546356291405;5683.914741278802;5787.508061814793;5058.013687330935;5157;5534.557235421237;5780.7398667060925;5814;4559.38448309474;5181.875431073242;5441;5514.696691681996;5737.282839645044;5530.944690553043;5772.769089236552;5801.042827933344;5819.388964158872;5823.816068974134;5417.022786682911;5675.602707810413;5708.857278568069;5711.8000869969355;5735.2794161752145 07:24:42 INFO - PROCESS | 2000 | |5;yui.html;723.0600219714372;776.1927595300888;800.7717800426876;818.5988865455928;820.3150369441516;14888.478903238389;16129.677406451863;16147.434839780595;16154.596135096628;16171.75742363864;14679.339429725687;14912.85087149131;14923.701525969474;14949.92525037376;14956.551303460914;699.8775214337496;721.2462976189894;722.5628494760673;723.6056349289623;727.8580676768032;717.2755516927914;872.8734333521636;894.0344428017726;898.7528429681857;900;925.5603588295573;940.2900809888524;941.9387739796925;944.0889541592362;944.3342443577261;935.069605742284;936.2229349639782;936.7377134402378;937.9765505862374;938.3009657804945;554.9445055494458;684.7192651013111;700.6006576251539;701.7193122750889;702.8875379939236;12173.939130304381;12203.511859525608;12399.93800031003;14783.778243326358;14856.405743770236;13656.112352697042;14125.223112728898;14135.363908624136;14177.362018709182;14338.211398373085;12670;12688.111832171751;12711.364431778467;12895.935520322431;12897.548585799452;4532.637389008872;4594.95405045952;4700.7179569225955;4762.928556071627;4772.093302272592;111097.44451277691;111167.44416277947;115042;115426.84573154245;115606;11049.060829829394;11103.278286911325;11135.944320278346;11161.72095697614;11669;21743.782562174492;21744.238951636617;21744.456388590414;21760;21774.346769596938;7747.961260193663;7766.495177813424;7767.262110099531;7860.4104692147175;7982.600869956479;4368.301071828492;4435.911281774346;4469.374287599739;4497.8200871964755;4635.466921304093;3013.081010291838;3412.3175364927115;3524.4713293006253;3528.929421411609;3533.9293214136087;608.2002167150272;609.2354095609982;629.6222266639979;646.7186773753432;659.0147729144863;506.4909765685536;517.6143772889221;550.2186894609664;582.72320647692;594.8163155320881;8601.483910965362;8845.380823342304;8899.065598112235;8937.776555586031;9147.313951453667;516.968981861082;546.1780021068267;574.4289368576939;605.7637521366671;626.6584711332334;3874.767513949172;4057.127717540684;4217.8523751668545;4296.957030429656;4381.408509851193;89393.55303223443;133517.66482335053;141027;146369;150959.2452037733;122529;124029;124569;125590;126503;107181.92818071875;110689.53732001172;111094;111313;111679.8832011702;8118.634661440131;8230.547319897463;8393.664253429795;8460.280876125353;8504.574771261536;44176.77911610421;61138;62350.68824655848;63328.68335658292;64561.70876582536;63495;77236.61381693055;88854.13057466764;90710;94680;11589.971754942682;11692.883071169179;12011.339376334035;12078.939605301917;12103.818442723543;12079.184211051452;12196.390180490762;12268.509259629514;12463.813042804184;12674.619761407173;11693.356865372487;11972.760544788882;12038.398080096134;12384.009279257458;12388.56640017595;11555.884441155817;12107.757844842878;12145.028397728338;12346.012319014637;12348;11672.533098675958;11716.531338746354;11791.306929223327;12102.636920892388;12103.455344509694;9745.222611555673;9855.901440985785;9974.301798874008;10318.226133040202;10516.316439431412;9587.472689002172;9688.46713430768;9997.814468220427;10014.70698207754;10030.749231269278 07:24:42 INFO - PROCESS | 2000 | __end_tp_report 07:24:42 INFO - PROCESS | 2000 | __start_cc_report 07:24:42 INFO - PROCESS | 2000 | _x_x_mozilla_cycle_collect,1074 07:24:42 INFO - PROCESS | 2000 | __end_cc_report 07:24:42 INFO - PROCESS | 2000 | __startTimestamp1468679082177__endTimestamp 07:24:42 INFO - PROCESS | 2000 | 07:24:42 INFO - PROCESS | 2000 | ------- Summary: start ------- 07:24:42 INFO - PROCESS | 2000 | Number of tests: 6 07:24:42 INFO - PROCESS | 2000 | 07:24:42 INFO - PROCESS | 2000 | [#0] dojo.html Cycles:165 Average:5655.61 Median:5835.33 stddev:652.89 (11.2%) stddev-sans-first:624.42 07:24:42 INFO - PROCESS | 2000 | Values: 3142.3 3252.2 3297.2 3324.2 3328.8 5564.7 5582.2 5605.8 5627.5 5662.2 5619.0 5648.4 5660.4 5665.7 5674.1 4409.2 4818.6 5094.8 5212.2 5237.5 5134.2 5202.2 5210.2 5211.7 5229.8 5151.4 5165.9 5182.8 5189.3 5208.8 5236.4 5250.1 5271.0 5271.7 5327.1 5076.2 5084.6 5095.1 5103.5 5137.5 5551.1 5602.2 5621.0 5624.0 5745.5 6199.4 6235.6 6238.3 6239.9 6244.5 5607.4 5697.3 6141.8 6261.4 6290.6 4813.9 5732.9 5762.9 5850.3 5879.8 6191.1 6234.9 6244.2 6250.6 6259.7 5884.7 5987.1 6049.0 6163.0 6189.8 6103.5 6165.2 6184.2 6185.3 6193.9 6140.9 6154.2 6156.3 6158.6 6178.7 5807.6 6044.4 6097.3 6186.7 6198.1 4895.9 4930.5 4937.5 4943.0 4945.7 3289.5 4436.9 4475.0 4484.7 4489.6 5611.3 5642.3 5668.5 5674.8 5699.4 6197.9 6237.7 6284.6 6301.7 6314.6 5529.0 5552.9 5558.8 5596.9 5638.0 5387.0 5397.2 5406.2 5409.9 5422.7 5799.7 6001.7 6240.6 6286.3 6294.1 5426.9 5835.3 6062.5 6119.5 6284.3 6205.9 6222.9 6225.3 6226.5 6284.9 5917.1 6065.9 6070.6 6078.8 6091.1 5996.3 6023.5 6046.9 6151.4 6154.0 6012.0 6054.2 6086.8 6099.7 6107.8 5467.7 5662.5 6045.4 6095.9 6100.5 5738.9 5829.9 5883.7 5928.9 5931.9 5958.3 6088.6 6096.5 6098.6 6103.9 5855.9 5876.3 5885.4 5887.7 5890.8 07:24:42 INFO - PROCESS | 2000 | 07:24:42 INFO - PROCESS | 2000 | [#1] ext.html Cycles:180 Average:75280.99 Median:19996.65 stddev:164912.15 (824.7%) stddev-sans-first:165279.21 07:24:42 INFO - PROCESS | 2000 | Values: 508.7 521.6 524.2 526.7 564.0 30870.9 32485.4 32502.0 32536.3 32560.8 43970.6 44977.6 45038.8 47419.5 47480.0 9885.2 10040.3 10046.3 10052.6 10071.1 8866.0 9054.6 9779.1 9891.9 9896.6 12012.6 12226.4 12228.3 12465.7 12500.2 12295.8 12363.5 12371.3 12373.3 12416.8 8760.4 11852.7 12151.4 12172.5 12279.1 42701.4 42809.1 42922.7 43132.6 43153.7 3570.4 3597.7 3623.5 4040.3 4104.6 33074.1 33416.8 33679.7 34073.7 35450.8 3296.0 3352.5 3429.9 3463.0 3465.8 525656.4 526832.0 528514.0 529818.0 530959.0 65710.7 66219.7 66289.7 66308.7 66337.0 68064.0 68966.7 69012.0 69035.0 69099.0 16506.6 17321.7 17326.0 17357.2 17362.0 13156.1 13244.3 13257.4 13261.2 13265.7 15260.3 16142.4 16529.0 18226.6 18774.4 6890.7 6922.6 7005.5 7017.8 7020.6 940.3 1018.7 1092.6 1099.2 1142.1 30631.8 31454.4 31468.7 31630.4 32028.7 976.0 1034.6 1041.3 1081.1 1092.2 14773.5 16477.0 16573.6 16754.0 16930.7 679434.0 680694.0 693692.0 696077.0 699459.0 60350.0 62132.7 62212.0 62350.1 62436.0 1380.0 1387.9 1388.4 1396.8 1407.5 30252.7 30696.2 30828.5 31388.8 31873.0 41591.4 54724.0 55161.4 55177.0 55316.4 616847.0 618726.0 622211.8 623808.0 626610.0 27271.7 27900.2 28076.7 44178.0 44547.3 41308.0 42263.5 50305.2 50654.5 50850.5 40256.8 40911.8 42181.0 42297.8 43208.1 40960.0 41355.0 41373.0 42080.0 42398.7 39846.0 40603.6 40956.8 41026.0 41040.2 29221.6 34798.0 35831.0 35876.0 36369.8 25865.0 25981.6 26231.6 26238.9 26495.3 07:24:42 INFO - PROCESS | 2000 | 07:24:42 INFO - PROCESS | 2000 | [#2] jquery.html Cycles:180 Average:35054.65 Median:21935.40 stddev:100463.10 (458.0%) stddev-sans-first:100711.19 07:24:42 INFO - PROCESS | 2000 | Values: 381.3 388.9 389.6 389.7 410.5 14785.9 20887.0 21660.5 21884.8 21891.8 16359.6 19072.4 21090.3 21249.7 21841.3 5992.9 6195.6 6238.4 6253.6 6262.4 5177.7 5789.7 6125.1 6125.6 6221.3 3899.9 4111.2 5842.2 6137.1 6137.8 6052.3 6109.8 6118.1 6149.3 6637.7 5911.5 5927.8 5937.6 5957.6 5965.5 12838.3 13632.0 13637.2 13973.4 14025.6 2162.0 2203.4 2415.8 2994.5 3079.4 10158.8 10266.1 10548.3 10662.4 10675.7 1847.1 1910.4 1946.6 1952.0 1953.9 119403.0 120513.0 123740.0 124726.4 126034.1 11533.0 11666.2 11802.2 11829.5 11842.8 14886.6 15012.2 15038.7 15053.5 15071.2 8635.4 8731.1 8751.7 8782.7 8819.5 8610.0 8619.9 8624.5 8737.8 8790.6 3822.6 4510.2 4599.5 4611.0 4663.4 1751.9 1847.3 1930.3 1949.0 1995.7 769.3 864.7 930.2 984.7 997.0 16923.2 21367.0 21979.0 22421.9 22805.9 919.9 944.7 947.0 950.9 969.7 10058.3 11062.0 11230.9 11379.4 11767.1 538971.0 585206.0 609879.0 629811.0 631145.0 104685.0 126260.4 144402.0 147136.0 148539.0 985.4 1007.4 1024.1 1045.0 1048.1 14896.3 20108.0 20150.6 20165.7 20200.8 36612.8 38472.0 47873.5 49832.8 52383.7 79012.6 79991.6 80222.0 80401.6 82058.0 7164.6 8615.1 8686.7 8715.8 8723.2 9890.9 11554.8 13699.0 13703.3 13876.6 11813.5 11926.3 11927.9 11953.2 11984.3 11667.9 11713.1 11769.5 12006.2 12010.9 11884.7 11890.6 11914.7 12141.6 12165.3 8631.9 8639.7 8709.0 8729.3 8827.6 11089.1 11951.8 12035.2 12118.5 12125.5 07:24:42 INFO - PROCESS | 2000 | 07:24:42 INFO - PROCESS | 2000 | [#3] mootools.html Cycles:180 Average:5866.08 Median:4886.95 stddev:3331.18 (68.2%) stddev-sans-first:3324.92 07:24:42 INFO - PROCESS | 2000 | Values: 1574.7 1608.1 1809.5 1906.4 1928.0 8726.0 8991.7 9214.6 9222.2 9225.9 8041.3 8256.1 8770.4 8968.8 9029.7 2391.5 2418.9 2419.3 2419.8 2423.2 2377.0 2401.5 2419.2 2421.7 2428.2 2126.8 2190.6 2336.9 2415.4 2417.0 2378.6 2398.4 2416.4 2417.2 2421.5 2399.2 2409.2 2411.4 2412.5 2416.3 9118.6 9189.3 9199.9 9203.2 9218.3 5315.0 5444.1 5497.5 5504.5 5521.8 3556.5 3618.2 3735.7 3738.2 3747.0 1082.2 1092.3 1111.8 1125.2 1126.3 12447.2 12460.2 12464.4 12483.9 12507.7 3650.5 4302.8 4530.7 4639.0 4900.0 10313.5 10393.1 10393.4 10394.7 10401.3 5491.5 5492.9 5496.2 5498.7 5533.3 4842.4 5014.9 5030.6 5034.7 5034.8 3898.9 3904.6 3928.1 3952.3 4016.6 1062.2 1113.5 1149.1 1190.7 1206.1 747.8 788.5 825.2 880.7 912.1 6116.9 6162.0 6221.5 6246.2 6302.7 908.0 911.8 932.8 956.2 967.7 4006.4 4137.9 4142.7 4198.7 4237.1 9451.0 11035.8 11242.2 11336.6 11399.9 10066.5 11119.0 11251.5 11258.9 11275.2 7606.2 8123.1 8182.9 8439.4 8586.0 6042.8 6111.2 6292.9 6313.3 6359.9 10094.2 10239.4 10482.8 10517.9 10534.5 10153.5 10428.3 10500.9 10543.5 10553.6 7103.8 7277.9 7282.8 7296.0 7296.6 7934.9 8523.7 8625.4 8635.9 8636.1 6754.0 7029.7 7672.8 7756.8 7770.9 7622.0 7643.6 7703.0 7766.3 7773.3 7143.3 7301.6 7307.5 7311.6 7312.8 4873.9 4984.5 5087.6 5100.3 5173.9 4447.3 5196.3 5362.8 5364.9 5393.4 07:24:42 INFO - PROCESS | 2000 | 07:24:42 INFO - PROCESS | 2000 | [#4] prototype.html Cycles:180 Average:4575.91 Median:5168.86 stddev:1399.57 (27.1%) stddev-sans-first:1365.75 07:24:42 INFO - PROCESS | 2000 | Values: 274.5 301.3 312.0 319.2 320.5 4477.4 4522.4 5180.7 5459.8 5506.9 5058.4 5144.2 5293.8 5421.5 5465.9 3853.0 3954.9 4157.6 4184.4 4214.0 3348.0 3737.1 3930.3 4212.7 4220.3 3923.4 4092.9 4124.3 4144.0 4149.0 4061.4 4093.8 4115.6 4125.9 4128.3 3548.8 3551.3 3579.2 3587.6 3595.9 4919.8 5298.7 5299.1 5340.7 5354.8 3684.6 4637.3 4655.6 4666.8 4704.0 5187.5 5406.5 5654.2 5669.5 5749.0 3776.3 3827.8 3864.6 3879.8 3904.3 4971.9 5096.8 5726.9 5887.9 5941.7 3892.6 3917.4 3917.5 3925.2 3956.2 3922.9 3979.4 3992.5 3998.0 4015.9 3688.2 4657.5 4714.6 4716.7 4719.0 5520.9 5571.6 5711.7 5766.8 5783.0 1130.9 1264.7 1285.6 1315.8 1356.6 839.9 841.4 871.3 895.7 924.0 4598.5 4704.8 4980.4 5269.7 5442.5 5037.3 5539.0 5701.2 5860.3 5900.5 4812.0 4880.9 5254.1 5264.3 5279.4 2817.3 3001.7 3006.7 3059.4 3068.9 5198.6 5705.7 5942.4 5953.3 6029.1 5109.7 5411.9 5568.6 5849.3 5951.2 5183.2 5683.6 5896.9 5905.1 5915.8 5494.5 5723.4 5742.9 5754.8 5862.9 4737.7 4749.5 5324.6 5684.6 5686.5 4523.8 5879.3 5899.9 5952.7 5957.4 3297.9 3908.1 3947.9 3953.2 3968.5 5141.3 5636.5 5650.7 5773.4 5804.0 5405.7 5609.4 5670.5 5683.9 5787.5 5058.0 5157.0 5534.6 5780.7 5814.0 4559.4 5181.9 5441.0 5514.7 5737.3 5530.9 5772.8 5801.0 5819.4 5823.8 5417.0 5675.6 5708.9 5711.8 5735.3 07:24:42 INFO - PROCESS | 2000 | 07:24:42 INFO - PROCESS | 2000 | [#5] yui.html Cycles:180 Average:23768.20 Median:4257.40 stddev:37999.00 (892.5%) stddev-sans-first:38066.20 07:24:42 INFO - PROCESS | 2000 | Values: 723.1 776.2 800.8 818.6 820.3 14888.5 16129.7 16147.4 16154.6 16171.8 14679.3 14912.9 14923.7 14949.9 14956.6 699.9 721.2 722.6 723.6 727.9 717.3 872.9 894.0 898.8 900.0 925.6 940.3 941.9 944.1 944.3 935.1 936.2 936.7 938.0 938.3 554.9 684.7 700.6 701.7 702.9 12173.9 12203.5 12399.9 14783.8 14856.4 13656.1 14125.2 14135.4 14177.4 14338.2 12670.0 12688.1 12711.4 12895.9 12897.5 4532.6 4595.0 4700.7 4762.9 4772.1 111097.4 111167.4 115042.0 115426.8 115606.0 11049.1 11103.3 11135.9 11161.7 11669.0 21743.8 21744.2 21744.5 21760.0 21774.3 7748.0 7766.5 7767.3 7860.4 7982.6 4368.3 4435.9 4469.4 4497.8 4635.5 3013.1 3412.3 3524.5 3528.9 3533.9 608.2 609.2 629.6 646.7 659.0 506.5 517.6 550.2 582.7 594.8 8601.5 8845.4 8899.1 8937.8 9147.3 517.0 546.2 574.4 605.8 626.7 3874.8 4057.1 4217.9 4297.0 4381.4 89393.6 133517.7 141027.0 146369.0 150959.2 122529.0 124029.0 124569.0 125590.0 126503.0 107181.9 110689.5 111094.0 111313.0 111679.9 8118.6 8230.5 8393.7 8460.3 8504.6 44176.8 61138.0 62350.7 63328.7 64561.7 63495.0 77236.6 88854.1 90710.0 94680.0 11590.0 11692.9 12011.3 12078.9 12103.8 12079.2 12196.4 12268.5 12463.8 12674.6 11693.4 11972.8 12038.4 12384.0 12388.6 11555.9 12107.8 12145.0 12346.0 12348.0 11672.5 11716.5 11791.3 12102.6 12103.5 9745.2 9855.9 9974.3 10318.2 10516.3 9587.5 9688.5 9997.8 10014.7 10030.7 07:24:42 INFO - PROCESS | 2000 | -------- Summary: end -------- 07:24:42 INFO - PROCESS | 2000 | 07:24:42 INFO - TEST-INFO | 2000: exit 0 07:24:42 INFO - TEST-OK | dromaeo_css | took 1116600ms 07:24:42 INFO - TEST-START | kraken 07:24:42 INFO - operating with platform_type : mac_ 07:24:42 INFO - Initialising browser for kraken test... 07:24:42 INFO - TEST-INFO | started process 2003 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/tmpOwt3Ou/profile http://localhost:49391/getInfo.html) 07:24:44 INFO - PROCESS | 2003 | __metrics Screen width/height:1600/1200 07:24:44 INFO - PROCESS | 2003 | colorDepth:24 07:24:44 INFO - PROCESS | 2003 | Browser inner width/height: 1024/689 07:24:44 INFO - PROCESS | 2003 | __metrics 07:24:45 INFO - PROCESS | 2003 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:24:45 INFO - PROCESS | 2003 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:24:45 INFO - TEST-INFO | 2003: exit 0 07:24:45 INFO - Browser initialized. 07:24:45 INFO - Running cycle 1/1 for kraken test... 07:24:45 INFO - TEST-INFO | started process 2004 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/tmpOwt3Ou/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:24:57 INFO - PROCESS | 2004 | RSS: Main: 243814400 07:24:57 INFO - PROCESS | 2004 | 07:25:00 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49391/tests/kraken/driver.html?testName=audio-beat-detection) 07:25:01 INFO - PROCESS | 2004 | RSS: Main: 294256640 07:25:01 INFO - PROCESS | 2004 | 07:25:03 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49391/tests/kraken/driver.html?testName=audio-dft) 07:25:04 INFO - PROCESS | 2004 | RSS: Main: 304623616 07:25:04 INFO - PROCESS | 2004 | 07:25:08 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49391/tests/kraken/driver.html?testName=audio-fft) 07:25:08 INFO - PROCESS | 2004 | RSS: Main: 389890048 07:25:08 INFO - PROCESS | 2004 | 07:25:10 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49391/tests/kraken/driver.html?testName=audio-oscillator) 07:25:11 INFO - PROCESS | 2004 | RSS: Main: 292831232 07:25:11 INFO - PROCESS | 2004 | 07:25:13 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49391/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:25:14 INFO - PROCESS | 2004 | RSS: Main: 297201664 07:25:14 INFO - PROCESS | 2004 | 07:25:16 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49391/tests/kraken/driver.html?testName=imaging-darkroom) 07:25:17 INFO - PROCESS | 2004 | RSS: Main: 333340672 07:25:17 INFO - PROCESS | 2004 | 07:25:20 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49391/tests/kraken/driver.html?testName=imaging-desaturate) 07:25:20 INFO - PROCESS | 2004 | RSS: Main: 334630912 07:25:20 INFO - PROCESS | 2004 | 07:25:23 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49391/tests/kraken/driver.html?testName=json-parse-financial) 07:25:24 INFO - PROCESS | 2004 | RSS: Main: 332664832 07:25:24 INFO - PROCESS | 2004 | 07:25:25 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49391/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:25:26 INFO - PROCESS | 2004 | RSS: Main: 313434112 07:25:26 INFO - PROCESS | 2004 | 07:25:28 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:25:29 INFO - PROCESS | 2004 | RSS: Main: 320446464 07:25:29 INFO - PROCESS | 2004 | 07:25:31 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:25:31 INFO - PROCESS | 2004 | RSS: Main: 317808640 07:25:31 INFO - PROCESS | 2004 | 07:25:34 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:25:35 INFO - PROCESS | 2004 | RSS: Main: 327434240 07:25:35 INFO - PROCESS | 2004 | 07:25:38 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:25:38 INFO - PROCESS | 2004 | RSS: Main: 328814592 07:25:38 INFO - PROCESS | 2004 | 07:25:40 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49391/tests/kraken/driver.html?testName=ai-astar) 07:25:40 INFO - PROCESS | 2004 | RSS: Main: 371449856 07:25:40 INFO - PROCESS | 2004 | 07:25:40 INFO - PROCESS | 2004 | __start_tp_report 07:25:40 INFO - PROCESS | 2004 | _x_x_mozilla_page_load 07:25:40 INFO - PROCESS | 2004 | _x_x_mozilla_page_load_details 07:25:40 INFO - PROCESS | 2004 | |i|pagename|runs| 07:25:40 INFO - PROCESS | 2004 | |0;ai-astar;101;112;110;113;113;110;113;113;111;112 07:25:40 INFO - PROCESS | 2004 | |1;audio-beat-detection;143;107;107;156;105;106;129;104;140;104 07:25:40 INFO - PROCESS | 2004 | |2;audio-dft;195;263;203;185;182;183;179;178;182;183 07:25:40 INFO - PROCESS | 2004 | |3;audio-fft;80;77;58;86;61;75;81;59;82;57 07:25:40 INFO - PROCESS | 2004 | |4;audio-oscillator;89;89;90;71;75;68;97;71;68;102 07:25:40 INFO - PROCESS | 2004 | |5;imaging-gaussian-blur;89;87;88;87;89;85;88;86;89;85 07:25:40 INFO - PROCESS | 2004 | |6;imaging-darkroom;99;94;93;94;94;94;95;94;93;93 07:25:40 INFO - PROCESS | 2004 | |7;imaging-desaturate;87;86;84;86;86;83;84;85;84;87 07:25:40 INFO - PROCESS | 2004 | |8;json-parse-financial;54;53;52;55;53;53;54;53;51;54 07:25:40 INFO - PROCESS | 2004 | |9;json-stringify-tinderbox;67;76;68;73;73;70;70;70;70;70 07:25:40 INFO - PROCESS | 2004 | |10;stanford-crypto-aes;86;82;93;101;99;79;78;83;85;85 07:25:40 INFO - PROCESS | 2004 | |11;stanford-crypto-ccm;138;137;136;142;149;136;135;136;178;138 07:25:40 INFO - PROCESS | 2004 | |12;stanford-crypto-pbkdf2;166;166;183;229;202;165;168;166;165;166 07:25:40 INFO - PROCESS | 2004 | |13;stanford-crypto-sha256-iterative;68;67;68;66;68;67;66;67;67;66 07:25:40 INFO - PROCESS | 2004 | __end_tp_report 07:25:40 INFO - PROCESS | 2004 | __start_cc_report 07:25:40 INFO - PROCESS | 2004 | _x_x_mozilla_cycle_collect,2005 07:25:40 INFO - PROCESS | 2004 | __end_cc_report 07:25:40 INFO - PROCESS | 2004 | __startTimestamp1468679140892__endTimestamp 07:25:40 INFO - PROCESS | 2004 | 07:25:40 INFO - PROCESS | 2004 | ------- Summary: start ------- 07:25:40 INFO - PROCESS | 2004 | Number of tests: 14 07:25:40 INFO - PROCESS | 2004 | 07:25:40 INFO - PROCESS | 2004 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.50 stddev:3.65 (3.2%) stddev-sans-first:1.27 07:25:40 INFO - PROCESS | 2004 | Values: 101.0 112.0 110.0 113.0 113.0 110.0 113.0 113.0 111.0 112.0 07:25:40 INFO - PROCESS | 2004 | 07:25:40 INFO - PROCESS | 2004 | [#1] audio-beat-detection Cycles:10 Average:120.10 Median:118.00 stddev:19.94 (16.9%) stddev-sans-first:19.35 07:25:40 INFO - PROCESS | 2004 | Values: 143.0 107.0 107.0 156.0 105.0 106.0 129.0 104.0 140.0 104.0 07:25:40 INFO - PROCESS | 2004 | 07:25:40 INFO - PROCESS | 2004 | [#2] audio-dft Cycles:10 Average:193.30 Median:184.00 stddev:25.67 (14.0%) stddev-sans-first:27.22 07:25:40 INFO - PROCESS | 2004 | Values: 195.0 263.0 203.0 185.0 182.0 183.0 179.0 178.0 182.0 183.0 07:25:40 INFO - PROCESS | 2004 | 07:25:40 INFO - PROCESS | 2004 | [#3] audio-fft Cycles:10 Average:71.60 Median:78.50 stddev:11.47 (14.6%) stddev-sans-first:11.76 07:25:40 INFO - PROCESS | 2004 | Values: 80.0 77.0 58.0 86.0 61.0 75.0 81.0 59.0 82.0 57.0 07:25:40 INFO - PROCESS | 2004 | 07:25:40 INFO - PROCESS | 2004 | [#4] audio-oscillator Cycles:10 Average:82.00 Median:82.00 stddev:12.78 (15.6%) stddev-sans-first:13.30 07:25:40 INFO - PROCESS | 2004 | Values: 89.0 89.0 90.0 71.0 75.0 68.0 97.0 71.0 68.0 102.0 07:25:40 INFO - PROCESS | 2004 | 07:25:40 INFO - PROCESS | 2004 | [#5] imaging-gaussian-blur Cycles:10 Average:87.30 Median:88.00 stddev:1.57 (1.8%) stddev-sans-first:1.54 07:25:40 INFO - PROCESS | 2004 | Values: 89.0 87.0 88.0 87.0 89.0 85.0 88.0 86.0 89.0 85.0 07:25:40 INFO - PROCESS | 2004 | 07:25:40 INFO - PROCESS | 2004 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.00 stddev:1.77 (1.9%) stddev-sans-first:0.67 07:25:40 INFO - PROCESS | 2004 | Values: 99.0 94.0 93.0 94.0 94.0 94.0 95.0 94.0 93.0 93.0 07:25:40 INFO - PROCESS | 2004 | 07:25:40 INFO - PROCESS | 2004 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:86.00 stddev:1.40 (1.6%) stddev-sans-first:1.32 07:25:40 INFO - PROCESS | 2004 | Values: 87.0 86.0 84.0 86.0 86.0 83.0 84.0 85.0 84.0 87.0 07:25:40 INFO - PROCESS | 2004 | 07:25:40 INFO - PROCESS | 2004 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.50 stddev:1.14 (2.1%) stddev-sans-first:1.17 07:25:40 INFO - PROCESS | 2004 | Values: 54.0 53.0 52.0 55.0 53.0 53.0 54.0 53.0 51.0 54.0 07:25:40 INFO - PROCESS | 2004 | 07:25:40 INFO - PROCESS | 2004 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:70.00 stddev:2.63 (3.8%) stddev-sans-first:2.42 07:25:40 INFO - PROCESS | 2004 | Values: 67.0 76.0 68.0 73.0 73.0 70.0 70.0 70.0 70.0 70.0 07:25:40 INFO - PROCESS | 2004 | 07:25:40 INFO - PROCESS | 2004 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:85.00 stddev:7.96 (9.4%) stddev-sans-first:8.44 07:25:40 INFO - PROCESS | 2004 | Values: 86.0 82.0 93.0 101.0 99.0 79.0 78.0 83.0 85.0 85.0 07:25:40 INFO - PROCESS | 2004 | 07:25:40 INFO - PROCESS | 2004 | [#11] stanford-crypto-ccm Cycles:10 Average:142.50 Median:138.00 stddev:13.15 (9.5%) stddev-sans-first:13.85 07:25:40 INFO - PROCESS | 2004 | Values: 138.0 137.0 136.0 142.0 149.0 136.0 135.0 136.0 178.0 138.0 07:25:40 INFO - PROCESS | 2004 | 07:25:40 INFO - PROCESS | 2004 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.60 Median:167.00 stddev:21.64 (13.0%) stddev-sans-first:22.54 07:25:40 INFO - PROCESS | 2004 | Values: 166.0 166.0 183.0 229.0 202.0 165.0 168.0 166.0 165.0 166.0 07:25:40 INFO - PROCESS | 2004 | 07:25:40 INFO - PROCESS | 2004 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 07:25:40 INFO - PROCESS | 2004 | Values: 68.0 67.0 68.0 66.0 68.0 67.0 66.0 67.0 67.0 66.0 07:25:40 INFO - PROCESS | 2004 | -------- Summary: end -------- 07:25:40 INFO - PROCESS | 2004 | 07:25:41 INFO - TEST-INFO | 2004: exit 0 07:25:41 INFO - TEST-OK | kraken | took 59054ms 07:25:41 INFO - SUITE-END | took 1175s 07:25:42 INFO - Completed test suite (00:19:35) 07:25:42 INFO - javascript benchmark 07:25:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3142.340108577199, 3252.203210213497, 3297.1592243977775, 3324.235425852054, 3328.8335583220833, 5564.693941833198, 5582.218489411481, 5605.775768969246, 5627.549796016319, 5662.17898404731, 5618.988582055228, 5648.406917273689, 5660.377358490563, 5665.688387138705, 5674.09214525676, 4409.206342858284, 4818.59041981432, 5094.77073531692, 5212.1660534314515, 5237.47625237477, 5134.1528647773075, 5202.219667049954, 5210.2445145453885, 5211.687298762067, 5229.843104706865, 5151.4075881273575, 5165.948340516603, 5182.844514664547, 5189.299444574991, 5208.765605547759, 5236.423993360746, 5250.05499010178, 5270.998510283072, 5271.683698978073, 5327.147656374961, 5076.162433198518, 5084.567811736007, 5095.108356037678, 5103.515166059218, 5137.537621614036, 5551.084071128259, 5602.215689803431, 5621.0, 5623.971880140614, 5745.511631511326, 6199.380061993809, 6235.563510554263, 6238.313785483593, 6239.937600623981, 6244.46922011625, 5607.439256074401, 5697.259356283656, 6141.78503752371, 6261.436470717657, 6290.622562646256, 4813.855584332476, 5732.914006289909, 5762.942370576283, 5850.297964244318, 5879.823605291848, 6191.102290167901, 6234.937650623436, 6244.219472565929, 6250.562460627712, 6259.655718935503, 5884.735186916599, 5987.101934709828, 6049.0, 6163.013917773134, 6189.783357582463, 6103.489197737689, 6165.229346331708, 6184.226971628546, 6185.319614842364, 6193.907091393633, 6140.9078863816185, 6154.19995400604, 6156.29202641702, 6158.630482171084, 6178.7219575119225, 5807.622504537191, 6044.425779550936, 6097.3292937776805, 6186.721597528122, 6198.132261483396, 4895.853124406273, 4930.531599498042, 4937.456879743226, 4943.0, 4945.703257804544, 3289.5394644749754, 4436.933445998313, 4474.955250447519, 4484.708493947948, 4489.618382437529, 5611.270534830446, 5642.322921249394, 5668.461496157858, 5674.829755107354, 5699.401562835926, 6197.915893905445, 6237.719302631393, 6284.591501552384, 6301.6534090625455, 6314.62112273265, 5529.0, 5552.91670624941, 5558.805441809517, 5596.944030559724, 5638.0, 5387.003404370204, 5397.217403476474, 5406.243125962368, 5409.918851217235, 5422.728863556807, 5799.695068609613, 6001.699915004319, 6240.594361366497, 6286.277078136073, 6294.087357333161, 5426.918596220981, 5835.328937172279, 6062.545309101747, 6119.541034422347, 6284.277308109626, 6205.875882482234, 6222.875542489034, 6225.252969643671, 6226.533010024357, 6284.874302514016, 5917.112433135064, 6065.939340606537, 6070.575059745952, 6078.7872424466705, 6091.086337049478, 5996.2504686914135, 6023.548233882389, 6046.90929636047, 6151.3541078186145, 6154.0, 6012.038073908154, 6054.212952316347, 6086.817395478142, 6099.695015249131, 6107.786227482017, 5467.660423196183, 5662.462066103713, 6045.395460453919, 6095.8780824382375, 6100.511959043355, 5738.885222295614, 5829.854253643693, 5883.676397797991, 5928.940710593011, 5931.911021334769, 5958.314793798769, 6088.634681918922, 6096.542759293159, 6098.603590766586, 6103.938960610337, 5855.912161317498, 5876.324222714443, 5885.3820348862755, 5887.67617781009, 5890.764369425175], "value": 5613.1509284469485, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.6541152016628, 521.5592824063665, 524.2372348233321, 526.6839896062363, 563.9960869652018, 30870.91951781688, 32485.350292994124, 32502.0249392518, 32536.349273014526, 32560.83719581405, 43970.560294397044, 44977.55022449775, 45038.774806126006, 47419.52580474194, 47480.0, 9885.15976142027, 10040.297179197423, 10046.346987445793, 10052.648157314496, 10071.093601575856, 8866.0, 9054.637814487412, 9779.11987921087, 9891.90108098917, 9896.55465504054, 12012.639620811346, 12226.449809758582, 12228.266304021787, 12465.688357791083, 12500.187487813308, 12295.754084918297, 12363.505459781598, 12371.319577423239, 12373.257604543756, 12416.751664966696, 8760.386772925898, 11852.703682407922, 12151.392430378446, 12172.452239649238, 12279.140460167791, 42701.35947960783, 42809.143817123484, 42922.71231863049, 43132.56867431348, 43153.70538883838, 3570.393033184365, 3597.6582224688614, 3623.4808735817687, 4040.2525532776235, 4104.630583247492, 33074.106364428946, 33416.832915835264, 33679.6632033679, 34073.659263407295, 35450.759223427056, 3296.0, 3352.5306457096026, 3429.9485507717404, 3463.0476618929742, 3465.7573969822124, 525656.3717181428, 526832.0, 528514.0, 529818.0, 530959.0, 65710.67144664342, 66219.66890165518, 66289.66855165693, 66308.67382652416, 66337.0, 68064.0, 68966.65516672384, 69011.96482052773, 69035.0, 69099.0, 16506.58733531671, 17321.7401738974, 17326.0, 17357.218925148398, 17362.0, 13156.144850584682, 13244.337783110806, 13257.40911090656, 13261.204327740366, 13265.734685306239, 15260.31328590216, 16142.435014774426, 16529.016518017674, 18226.635467290846, 18774.436766897015, 6890.655467226618, 6922.58464492132, 7005.458799064198, 7017.789466316019, 7020.613866237406, 940.2759874896428, 1018.6842078955548, 1092.5796464595994, 1099.2140619456966, 1142.1433924556582, 30631.774729011035, 31454.37091258162, 31468.685313147034, 31630.36739265248, 32028.679713203037, 975.9898505047383, 1034.6120204923154, 1041.3075304922143, 1081.0540776820283, 1092.2136062035322, 14773.482928097465, 16477.0, 16573.585660358345, 16753.999306621954, 16930.661386772197, 679434.0, 680694.0, 693692.0, 696077.0, 699459.0, 60350.0, 62132.68933655393, 62212.0, 62350.0647490288, 62436.0, 1379.9931000344934, 1387.9167249965035, 1388.3821699343896, 1396.7555677756352, 1407.507372419645, 30252.69747302499, 30696.232594185323, 30828.537571936886, 31388.843055784575, 31873.0, 41591.37612935748, 54724.0, 55161.44838551724, 55177.0, 55316.44683553274, 616847.0, 618726.0, 622211.7778822153, 623808.0, 626610.0, 27271.72728272692, 27900.16299511018, 28076.71923280741, 44178.0, 44547.33179002253, 41308.0, 42263.52077677267, 50305.239316623745, 50654.49345506498, 50850.491495086055, 40256.79871600623, 40911.7954410226, 42181.0, 42297.788511057246, 43208.135837283706, 40959.97600059903, 41355.0, 41372.965675858344, 42080.0, 42398.72803815891, 39846.00384990399, 40603.59396405998, 40956.79521602373, 41026.0, 41040.1791964165, 29221.561676575293, 34798.0, 35831.0, 35876.0, 36369.81815090908, 25865.0, 25981.610275845498, 26231.60652590251, 26238.86880565585, 26495.33761655897], "value": 21193.404416503883, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.32505465326375, 388.9027743064234, 389.6493156159458, 389.68458987894394, 410.54429583162687, 14785.852141478583, 20887.0, 21660.458488537795, 21884.781152188494, 21891.781082189194, 16359.59101022475, 19072.378847797954, 21090.261840835534, 21249.68125478119, 21841.344759657197, 5992.850178745544, 6195.5663103582765, 6238.4385405313515, 6253.624782513041, 6262.373762623747, 5177.689338639675, 5789.710514474281, 6125.081237814319, 6125.5712100153005, 6221.284552276478, 3899.941500877489, 4111.177764447108, 5842.211301474289, 6137.140800287963, 6137.815865524041, 6052.277849122802, 6109.786157484489, 6118.112873633343, 6149.29283132441, 6637.668116594151, 5911.497522710575, 5927.762889484416, 5937.554683398763, 5957.612755170943, 5965.522758179335, 12838.293893835835, 13632.045756797028, 13637.249951252677, 13973.371198296101, 14025.64935876601, 2162.0378931375544, 2203.372038968886, 2415.770501802326, 2994.475966705818, 3079.414911166871, 10158.796824063478, 10266.12737917278, 10548.261621686484, 10662.360258384522, 10675.733106672318, 1847.1410793980729, 1910.426871938413, 1946.5912158446743, 1951.9707204391946, 1953.8632295739303, 119403.0, 120513.0, 123740.0, 124726.37636811848, 126034.10948835775, 11533.0, 11666.183367164387, 11802.177552779409, 11829.526818927146, 11842.76314473723, 14886.553403397915, 15012.249387530579, 15038.699226015418, 15053.473128440452, 15071.171085590178, 8635.352348573757, 8731.126887311219, 8751.693690720795, 8782.692605758895, 8819.514926678967, 8609.956950215208, 8619.913800862036, 8624.525651089125, 8737.781555461164, 8790.560471976376, 3822.617738226211, 4510.188166130062, 4599.539246503105, 4611.0, 4663.440387153563, 1751.9152208871658, 1847.3257261099602, 1930.3365638415469, 1949.0, 1995.6607376745699, 769.2768797330491, 864.7449002544264, 930.1721467893581, 984.6799790068256, 996.9601215951426, 16923.238454269587, 21367.03848326829, 21979.010944507216, 22421.878906054633, 22805.88597057004, 919.866619340192, 944.7256127815709, 946.966856160031, 950.9476978766235, 969.709087273815, 10058.34620749649, 11062.0, 11230.876912308704, 11379.374134422686, 11767.11746619007, 538971.0, 585206.0, 609879.0, 629811.0, 631145.0, 104685.0, 126260.36869815776, 144402.0, 147136.0, 148539.0, 985.3841349156777, 1007.4005966449951, 1024.1346062577259, 1044.9738756530996, 1048.1457612046158, 14896.329665164876, 20107.98920108036, 20150.59698806045, 20165.697514537, 20200.797992020478, 36612.81693591515, 38472.0, 47873.5212647883, 49832.75083624704, 52383.73808130935, 79012.60493697495, 79991.60004199942, 80222.0, 80401.59799200967, 82058.0, 7164.641767911688, 8615.138486151585, 8686.652533898574, 8715.782105447415, 8723.214910658071, 9890.851637225303, 11554.768904621693, 13699.041067125605, 13703.314834258048, 13876.58370248894, 11813.527458901892, 11926.344051077274, 11927.880721193023, 11953.163278570417, 11984.340861252715, 11667.949884510435, 11713.062954963752, 11769.470373833026, 12006.21959572625, 12010.939945300217, 11884.702882428008, 11890.643280701594, 11914.702132446411, 12141.575044873387, 12165.33090680021, 8631.91368086311, 8639.697610583851, 8709.0, 8729.25801306896, 8827.602757875782, 11089.112870970464, 11951.820722688994, 12035.217710848767, 12118.454669539715, 12125.454354553889], "value": 9598.42383700516, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1574.6693194429165, 1608.091428342986, 1809.4842969753622, 1906.3708976037908, 1928.0263466949189, 8725.956370218148, 8991.730248092552, 9214.585343659535, 9222.170004699576, 9225.861612075823, 8041.276285134337, 8256.133106023872, 8770.429922055062, 8968.775780605472, 9029.683961061364, 2391.461921067759, 2418.9274321770285, 2419.250032489934, 2419.8185136114776, 2423.1761201191593, 2376.964345534818, 2401.495685905953, 2419.1532963462737, 2421.6609674645565, 2428.162284012013, 2126.766055733868, 2190.561887622474, 2336.918207862725, 2415.372003279151, 2416.9879150604224, 2378.6194208926663, 2398.4243781492405, 2416.4442178298914, 2417.2023232333286, 2421.4672771990136, 2399.2082612737754, 2409.1929203716777, 2411.4212588978694, 2412.49337639096, 2416.2509622017233, 9118.58966346516, 9189.264858811346, 9199.862002069975, 9203.171714545657, 9218.308626853013, 5314.97342513285, 5444.074507333763, 5497.532709719679, 5504.4770746778995, 5521.751521181556, 3556.466530020492, 3618.1859081706407, 3735.72121006186, 3738.1776009277914, 3747.0445036515785, 1082.2153938394601, 1092.3362366131632, 1111.8165502692045, 1125.217973508412, 1126.2791813239533, 12447.190932589352, 12460.190087644274, 12464.376781160905, 12483.875161248452, 12507.687307817287, 3650.543682039745, 4302.763348015889, 4530.731395209346, 4639.025804581076, 4900.019996000814, 10313.535890884928, 10393.06462418386, 10393.37639741618, 10394.688159355232, 10401.323913945569, 5491.505764481216, 5492.945070549324, 5496.203050557647, 5498.725063746797, 5533.335999680065, 4842.443119041285, 5014.89970200594, 5030.647854650139, 5034.748262586856, 5034.84895453137, 3898.922021559553, 3904.574830187018, 3928.096537796323, 3952.308346039489, 4016.59834016596, 1062.2033474893828, 1113.4655365424642, 1149.109440183864, 1190.7201807575213, 1206.1315852586124, 747.7906186267745, 788.5071830106184, 825.1748251748252, 880.6565439478609, 912.119804388768, 6116.938830611726, 6161.96919015411, 6221.47117495018, 6246.187995560639, 6302.747890084437, 907.981840363189, 911.7629416351797, 932.7668082979255, 956.206348730552, 967.6855022117699, 4006.3790112532606, 4137.937930931039, 4142.668586513072, 4198.727082739612, 4237.110206856594, 9451.0, 11035.83446248307, 11242.213045086766, 11336.603218887465, 11399.886001140048, 10066.49667516636, 11118.999290063934, 11251.493682784294, 11258.943705281585, 11275.210735248455, 7606.239376062349, 8123.106458289583, 8182.918170818335, 8439.367047471464, 8586.0, 6042.818715438544, 6111.236095488064, 6292.874142517216, 6313.329304894575, 6359.90460143089, 10094.24293178, 10239.436830974368, 10482.842757358798, 10517.894821051692, 10534.473276336306, 10153.543090560795, 10428.333208890155, 10500.949905009744, 10543.472826358804, 10553.63062292816, 7103.751368702071, 7277.854442911006, 7282.781516554512, 7296.0, 7296.562206267641, 7934.880976785468, 8523.74428767138, 8625.353098517511, 8635.913640863511, 8636.14322920575, 6754.0, 7029.683664235224, 7672.808179795326, 7756.8448631028195, 7770.883436748566, 7622.0, 7643.57960312166, 7702.961485192538, 7766.262205090507, 7773.3004029637605, 7143.321384468467, 7301.634918254173, 7307.488475806643, 7311.561306321638, 7312.780616581511, 4873.87815304606, 4984.526469985346, 5087.618428617942, 5100.336956195671, 5173.896522069613, 4447.266201076786, 5196.272521846869, 5362.812301569426, 5364.892702146013, 5393.352797664305], "value": 4680.718291297201, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [274.4894496236999, 301.2513902951167, 312.0482528288719, 319.2497630568167, 320.5144206527112, 4477.395551600533, 4522.389477420547, 5180.715060671661, 5459.781608735646, 5506.862328441791, 5058.408529943735, 5144.22836574514, 5293.761780719868, 5421.457854214586, 5465.863353416166, 3853.0, 3954.9123990902444, 4157.625813676768, 4184.351425529047, 4213.967577943408, 3348.0, 3737.140457694732, 3930.272899513585, 4212.662986961036, 4220.324748040314, 3923.431102490137, 4092.85675001375, 4124.298869192229, 4143.979280103596, 4149.0, 4061.3907913813164, 4093.7543747375253, 4115.588441155875, 4125.938110928309, 4128.339465685506, 3548.840302186382, 3551.3074950384685, 3579.2125732338845, 3587.5694916610173, 3595.856165753367, 4919.827806026772, 5298.708571028592, 5299.12564426873, 5340.652857564285, 5354.759035843396, 3684.5946945835935, 4637.304404339342, 4655.604273636745, 4666.813327466897, 4704.01215744694, 5187.48125187482, 5406.513413792738, 5654.236678048452, 5669.489745922846, 5749.0, 3776.3013842439236, 3827.8464878213895, 3864.5555761087553, 3879.8254078566533, 3904.3362628352966, 4971.900561988812, 5096.79612815487, 5726.885462290731, 5887.941120588782, 5941.732622031976, 3892.591277915778, 3917.353636649978, 3917.490726205575, 3925.1953349563273, 3956.169204467094, 3922.9019274517796, 3979.4030895365927, 3992.4610177626228, 3998.0, 4015.8795236142964, 3688.2001345841595, 4657.464391594942, 4714.5521175488275, 4716.693414928019, 4719.032598317337, 5520.861978450491, 5571.609987300931, 5711.7144142792695, 5766.769329226868, 5782.971085144632, 1130.8642962844347, 1264.7415821257907, 1285.6271681212531, 1315.7894736842252, 1356.620146359021, 839.9328053755808, 841.3563623827777, 871.2811930157645, 895.7357579514058, 923.9861402078974, 4598.517155698671, 4704.788284527204, 4980.352554168007, 5269.683818970874, 5442.537384322298, 5037.269595908573, 5538.972305138448, 5701.230333904953, 5860.267466566679, 5900.4984576310635, 4811.975940120347, 4880.876818583927, 5254.133068043807, 5264.289320941701, 5279.366476022902, 2817.337925587485, 3001.744851687631, 3006.669266380696, 3059.393818245439, 3068.8925887594273, 5198.636095473281, 5705.71471426427, 5942.405759424109, 5953.345132035559, 6029.125776762345, 5109.72256935766, 5411.945880541223, 5568.552176434076, 5849.268841394741, 5951.226340575784, 5183.19660452638, 5683.5737319700365, 5896.882062358729, 5905.055191169392, 5915.792947246826, 5494.5054945055135, 5723.427657234243, 5742.885142297214, 5754.798582049608, 5862.882742345215, 4737.715737055788, 4749.525047495361, 5324.6006549508165, 5684.63049901755, 5686.516646084963, 4523.841665541822, 5879.2944846618675, 5899.852503687443, 5952.732127054206, 5957.3744756799915, 3297.8515966781074, 3908.1241004318654, 3947.9407808883466, 3953.1895961328432, 3968.4840970673627, 5141.331626888481, 5636.505366672689, 5650.689212093374, 5773.364929857797, 5803.970980145073, 5405.702686352289, 5609.382967873449, 5670.546356291405, 5683.914741278802, 5787.508061814793, 5058.013687330935, 5157.0, 5534.557235421237, 5780.7398667060925, 5814.0, 4559.38448309474, 5181.875431073242, 5441.0, 5514.696691681996, 5737.282839645044, 5530.944690553043, 5772.769089236552, 5801.042827933344, 5819.388964158872, 5823.816068974134, 5417.022786682911, 5675.602707810413, 5708.857278568069, 5711.8000869969355, 5735.2794161752145], "value": 4123.822882389641, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.0600219714372, 776.1927595300888, 800.7717800426876, 818.5988865455928, 820.3150369441516, 14888.478903238389, 16129.677406451863, 16147.434839780595, 16154.596135096628, 16171.75742363864, 14679.339429725687, 14912.85087149131, 14923.701525969474, 14949.92525037376, 14956.551303460914, 699.8775214337496, 721.2462976189894, 722.5628494760673, 723.6056349289623, 727.8580676768032, 717.2755516927914, 872.8734333521636, 894.0344428017726, 898.7528429681857, 900.0, 925.5603588295573, 940.2900809888524, 941.9387739796925, 944.0889541592362, 944.3342443577261, 935.069605742284, 936.2229349639782, 936.7377134402378, 937.9765505862374, 938.3009657804945, 554.9445055494458, 684.7192651013111, 700.6006576251539, 701.7193122750889, 702.8875379939236, 12173.939130304381, 12203.511859525608, 12399.93800031003, 14783.778243326358, 14856.405743770236, 13656.112352697042, 14125.223112728898, 14135.363908624136, 14177.362018709182, 14338.211398373085, 12670.0, 12688.111832171751, 12711.364431778467, 12895.935520322431, 12897.548585799452, 4532.637389008872, 4594.95405045952, 4700.7179569225955, 4762.928556071627, 4772.093302272592, 111097.44451277691, 111167.44416277947, 115042.0, 115426.84573154245, 115606.0, 11049.060829829394, 11103.278286911325, 11135.944320278346, 11161.72095697614, 11669.0, 21743.782562174492, 21744.238951636617, 21744.456388590414, 21760.0, 21774.346769596938, 7747.961260193663, 7766.495177813424, 7767.262110099531, 7860.4104692147175, 7982.600869956479, 4368.301071828492, 4435.911281774346, 4469.374287599739, 4497.8200871964755, 4635.466921304093, 3013.081010291838, 3412.3175364927115, 3524.4713293006253, 3528.929421411609, 3533.9293214136087, 608.2002167150272, 609.2354095609982, 629.6222266639979, 646.7186773753432, 659.0147729144863, 506.4909765685536, 517.6143772889221, 550.2186894609664, 582.72320647692, 594.8163155320881, 8601.483910965362, 8845.380823342304, 8899.065598112235, 8937.776555586031, 9147.313951453667, 516.968981861082, 546.1780021068267, 574.4289368576939, 605.7637521366671, 626.6584711332334, 3874.767513949172, 4057.127717540684, 4217.8523751668545, 4296.957030429656, 4381.408509851193, 89393.55303223443, 133517.66482335053, 141027.0, 146369.0, 150959.2452037733, 122529.0, 124029.0, 124569.0, 125590.0, 126503.0, 107181.92818071875, 110689.53732001172, 111094.0, 111313.0, 111679.8832011702, 8118.634661440131, 8230.547319897463, 8393.664253429795, 8460.280876125353, 8504.574771261536, 44176.77911610421, 61138.0, 62350.68824655848, 63328.68335658292, 64561.70876582536, 63495.0, 77236.61381693055, 88854.13057466764, 90710.0, 94680.0, 11589.971754942682, 11692.883071169179, 12011.339376334035, 12078.939605301917, 12103.818442723543, 12079.184211051452, 12196.390180490762, 12268.509259629514, 12463.813042804184, 12674.619761407173, 11693.356865372487, 11972.760544788882, 12038.398080096134, 12384.009279257458, 12388.56640017595, 11555.884441155817, 12107.757844842878, 12145.028397728338, 12346.012319014637, 12348.0, 11672.533098675958, 11716.531338746354, 11791.306929223327, 12102.636920892388, 12103.455344509694, 9745.222611555673, 9855.901440985785, 9974.301798874008, 10318.226133040202, 10516.316439431412, 9587.472689002172, 9688.46713430768, 9997.814468220427, 10014.70698207754, 10030.749231269278], "value": 7521.177331050356, "unit": "score"}], "name": "dromaeo_css", "value": 7411.831067768852, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 110.0, 113.0, 113.0, 110.0, 113.0, 113.0, 111.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 107.0, 107.0, 156.0, 105.0, 106.0, 129.0, 104.0, 140.0, 104.0], "value": 120.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 263.0, 203.0, 185.0, 182.0, 183.0, 179.0, 178.0, 182.0, 183.0], "value": 193.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 77.0, 58.0, 86.0, 61.0, 75.0, 81.0, 59.0, 82.0, 57.0], "value": 71.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 90.0, 71.0, 75.0, 68.0, 97.0, 71.0, 68.0, 102.0], "value": 82.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 88.0, 87.0, 89.0, 85.0, 88.0, 86.0, 89.0, 85.0], "value": 87.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 93.0, 94.0, 94.0, 94.0, 95.0, 94.0, 93.0, 93.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 84.0, 86.0, 86.0, 83.0, 84.0, 85.0, 84.0, 87.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 55.0, 53.0, 53.0, 54.0, 53.0, 51.0, 54.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 76.0, 68.0, 73.0, 73.0, 70.0, 70.0, 70.0, 70.0, 70.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 93.0, 101.0, 99.0, 79.0, 78.0, 83.0, 85.0, 85.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 136.0, 142.0, 149.0, 136.0, 135.0, 136.0, 178.0, 138.0], "value": 142.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 183.0, 229.0, 202.0, 165.0, 168.0, 166.0, 165.0, 166.0], "value": 177.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 66.0, 68.0, 67.0, 66.0, 67.0, 67.0, 66.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1442.6999999999998, "alertThreshold": 2.0}]} 07:25:42 INFO - Return code: 0 07:25:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:25:42 INFO - # TBPL SUCCESS # 07:25:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:25:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:25:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:25:42 INFO - 2016-07-16 07:25:42.236 screenresolution[2008:12161] starting screenresolution argv=screenresolution get 07:25:42 INFO - 2016-07-16 07:25:42.240 screenresolution[2008:12161] Display 0: 1600x1200x32@60 07:25:42 INFO - 2016-07-16 07:25:42.246 screenresolution[2009:12164] starting screenresolution argv=screenresolution list 07:25:42 INFO - Available Modes on Display 0 07:25:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:25:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:25:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:25:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:25:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:25:42 INFO - Intel Iris: 07:25:42 INFO - Chipset Model: Intel Iris 07:25:42 INFO - Type: GPU 07:25:42 INFO - Bus: Built-In 07:25:42 INFO - VRAM (Dynamic, Max): 1536 MB 07:25:42 INFO - Vendor: Intel (0x8086) 07:25:42 INFO - Device ID: 0x0a2e 07:25:42 INFO - Revision ID: 0x0009 07:25:42 INFO - Displays: 07:25:42 INFO - Display: 07:25:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:25:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:25:42 INFO - Display Serial Number: 1600x1200 60 07:25:42 INFO - Main Display: Yes 07:25:42 INFO - Mirror: Off 07:25:42 INFO - Online: Yes 07:25:42 INFO - Rotation: Supported 07:25:42 INFO - Return code: 0 07:25:42 INFO - Running post-action listener: _resource_record_post_action 07:25:42 INFO - ##### 07:25:42 INFO - ##### Finished run-tests step (success) 07:25:42 INFO - ##### 07:25:42 INFO - Running post-run listener: _resource_record_post_run 07:25:42 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 397312; Write bytes: 705585664; Read time: 7; Write time: 1919 07:25:42 INFO - TinderboxPrint: CPU usage
53.3% 07:25:42 INFO - TinderboxPrint: I/O read bytes / time
397,312 / 7 07:25:42 INFO - TinderboxPrint: I/O write bytes / time
705,585,664 / 1,919 07:25:42 INFO - TinderboxPrint: CPU idle
2,263.7 (46.7%) 07:25:42 INFO - TinderboxPrint: CPU system
963.2 (19.9%) 07:25:42 INFO - TinderboxPrint: CPU user
1,618.8 (33.4%) 07:25:42 INFO - TinderboxPrint: Swap in / out
407,683,072 / 0 07:25:42 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 390416896; Write bytes: 385644032; Read time: 29071; Write time: 786 07:25:42 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 397312; Write bytes: 294775808; Read time: 7; Write time: 1074 07:25:42 INFO - Running post-run listener: _upload_blobber_files 07:25:42 INFO - Blob upload gear active. 07:25:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:25:42 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 07:25:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:25:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:25:43 INFO - (blobuploader) - INFO - Open directory for files ... 07:25:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:25:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:25:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:25:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:25:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:25:44 INFO - (blobuploader) - INFO - Done attempting. 07:25:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:25:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:25:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:25:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:25:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:25:45 INFO - (blobuploader) - INFO - Done attempting. 07:25:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:25:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:25:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:25:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:25:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:25:47 INFO - (blobuploader) - INFO - Done attempting. 07:25:47 INFO - (blobuploader) - INFO - Iteration through files over. 07:25:47 INFO - Return code: 0 07:25:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:25:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:25:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77057b4e3ab551b97d9dd64cdf1ce0604d7df49fd44b00d76b7a813a897282d86acf38fd7dd1b3240eb75149ca3aff7c3dfdc92ed716a0650637ffdd060c728c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1d93570b5e27e3b422ac38827a2ef9e017174950ee20c1fe5584cd36b24ae5e36b00d1e7f83a6f57d99c82e4bf7000999e35ec2b8d17db81974f947ea91ba30c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d45bf62a506e320571ee4bfbd50bfca68a936d3102963d185475e3e6ed71002d4167bff46141362899f55a01b21e700b163942efe20ff6ccf32a060c30594e64"} 07:25:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:25:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:25:47 INFO - Contents: 07:25:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77057b4e3ab551b97d9dd64cdf1ce0604d7df49fd44b00d76b7a813a897282d86acf38fd7dd1b3240eb75149ca3aff7c3dfdc92ed716a0650637ffdd060c728c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1d93570b5e27e3b422ac38827a2ef9e017174950ee20c1fe5584cd36b24ae5e36b00d1e7f83a6f57d99c82e4bf7000999e35ec2b8d17db81974f947ea91ba30c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d45bf62a506e320571ee4bfbd50bfca68a936d3102963d185475e3e6ed71002d4167bff46141362899f55a01b21e700b163942efe20ff6ccf32a060c30594e64"} 07:25:47 INFO - Running post-run listener: copy_logs_to_upload_dir 07:25:47 INFO - Copying logs to upload dir... 07:25:47 INFO - mkdir: /builds/slave/test/build/upload/logs 07:25:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.619957 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-16 07:25:47.796368) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 07:25:47.799992) ========= 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.9Ur9ME3cqO/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.aMsOeFz8uh/Listeners TMPDIR=/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77057b4e3ab551b97d9dd64cdf1ce0604d7df49fd44b00d76b7a813a897282d86acf38fd7dd1b3240eb75149ca3aff7c3dfdc92ed716a0650637ffdd060c728c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1d93570b5e27e3b422ac38827a2ef9e017174950ee20c1fe5584cd36b24ae5e36b00d1e7f83a6f57d99c82e4bf7000999e35ec2b8d17db81974f947ea91ba30c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d45bf62a506e320571ee4bfbd50bfca68a936d3102963d185475e3e6ed71002d4167bff46141362899f55a01b21e700b163942efe20ff6ccf32a060c30594e64"} build_url:https://queue.taskcluster.net/v1/task/a3m75HQyQVKqSpcWQ-t5CA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011380 build_url: 'https://queue.taskcluster.net/v1/task/a3m75HQyQVKqSpcWQ-t5CA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77057b4e3ab551b97d9dd64cdf1ce0604d7df49fd44b00d76b7a813a897282d86acf38fd7dd1b3240eb75149ca3aff7c3dfdc92ed716a0650637ffdd060c728c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1d93570b5e27e3b422ac38827a2ef9e017174950ee20c1fe5584cd36b24ae5e36b00d1e7f83a6f57d99c82e4bf7000999e35ec2b8d17db81974f947ea91ba30c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d45bf62a506e320571ee4bfbd50bfca68a936d3102963d185475e3e6ed71002d4167bff46141362899f55a01b21e700b163942efe20ff6ccf32a060c30594e64"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 07:25:47.837546) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 07:25:47.838203) ========= 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.9Ur9ME3cqO/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.aMsOeFz8uh/Listeners TMPDIR=/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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.005368 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 07:25:47.890241) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 07:25:47.890944) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 07:25:47.891827) ========= ========= Total master_lag: 0.84 =========