builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0235 starttime: 1470615209.81 results: success (0) buildid: 20160807150652 builduid: 5d0255e5fbda4650869c42fbb26aebb6 revision: 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 17:13:29.807774) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 17:13:29.808203) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 17:13:29.808474) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 17:13:29.831581) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 17:13:29.831974) ========= 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.dlIisPMRRz/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.U0nsP0ZL84/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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-08-07 17:13:29-- 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% 39.9M=0s 2016-08-07 17:13:29 (39.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119003 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 17:13:29.973834) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 17:13:29.974146) ========= 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.dlIisPMRRz/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.U0nsP0ZL84/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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.019743 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 17:13:30.022212) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-07 17:13:30.022571) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c --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 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dlIisPMRRz/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.U0nsP0ZL84/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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-08-07 17:13:30,100 truncating revision to first 12 chars 2016-08-07 17:13:30,100 Setting DEBUG logging. 2016-08-07 17:13:30,100 attempt 1/10 2016-08-07 17:13:30,100 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/763fe887c37c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-07 17:13:30,819 unpacking tar archive at: fx-team-763fe887c37c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.978669 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-07 17:13:31.022844) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 17:13:31.023165) ========= script_repo_revision: 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 17:13:31.023582) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 17:13:31.023850) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 17:13:31.038994) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-08-07 17:13:31.039271) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dlIisPMRRz/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.U0nsP0ZL84/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 17:13:31 INFO - MultiFileLogger online at 20160807 17:13:31 in /builds/slave/test 17:13:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:13:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:13:31 INFO - {'append_to_log': False, 17:13:31 INFO - 'base_work_dir': '/builds/slave/test', 17:13:31 INFO - 'blob_upload_branch': 'Fx-Team', 17:13:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:13:31 INFO - 'branch': 'Fx-Team', 17:13:31 INFO - 'buildbot_json_path': 'buildprops.json', 17:13:31 INFO - 'config_files': ('talos/mac_config.py',), 17:13:31 INFO - 'default_actions': ('clobber', 17:13:31 INFO - 'read-buildbot-config', 17:13:31 INFO - 'download-and-extract', 17:13:31 INFO - 'populate-webroot', 17:13:31 INFO - 'create-virtualenv', 17:13:31 INFO - 'install', 17:13:31 INFO - 'run-tests'), 17:13:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:13:31 INFO - 'download_minidump_stackwalk': True, 17:13:31 INFO - 'download_symbols': 'ondemand', 17:13:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:13:31 INFO - 'tooltool.py': '/tools/tooltool.py', 17:13:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:13:31 INFO - '/tools/misc-python/virtualenv.py')}, 17:13:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:13:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:13:31 INFO - 'installer_path': 'installer.exe', 17:13:31 INFO - 'log_level': 'info', 17:13:31 INFO - 'log_name': 'talos', 17:13:31 INFO - 'log_to_console': True, 17:13:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:13:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:13:31 INFO - 'opt_config_files': (), 17:13:31 INFO - 'pip_index': False, 17:13:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:13:31 INFO - 'cmd': ('bash', 17:13:31 INFO - '-c', 17:13:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:13:31 INFO - 'enabled': True, 17:13:31 INFO - 'halt_on_failure': False, 17:13:31 INFO - 'name': 'check_screen_resolution'},), 17:13:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:13:31 INFO - 'cmd': ('bash', 17:13:31 INFO - '-c', 17:13:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:13:31 INFO - 'enabled': True, 17:13:31 INFO - 'halt_on_failure': False, 17:13:31 INFO - 'name': 'check_screen_resolution'},), 17:13:31 INFO - 'run_cmd_checks_enabled': True, 17:13:31 INFO - 'sps_profile': False, 17:13:31 INFO - 'sps_profile_interval': 0, 17:13:31 INFO - 'suite': 'dromaeojs-e10s', 17:13:31 INFO - 'system_bits': '32', 17:13:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:13:31 INFO - 'title': 't-yosemite-r7-0235', 17:13:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:13:31 INFO - 'use_talos_json': True, 17:13:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:13:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:13:31 INFO - 'work_dir': 'build'} 17:13:31 INFO - [mozharness: 2016-08-08 00:13:31.226423Z] Running clobber step. 17:13:31 INFO - Running pre-action listener: _resource_record_pre_action 17:13:31 INFO - Running main action method: clobber 17:13:31 INFO - rmtree: /builds/slave/test/build 17:13:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:13:32 INFO - Running post-action listener: _resource_record_post_action 17:13:32 INFO - [mozharness: 2016-08-08 00:13:32.886460Z] Finished clobber step (success) 17:13:32 INFO - [mozharness: 2016-08-08 00:13:32.886718Z] Running read-buildbot-config step. 17:13:32 INFO - Running pre-action listener: _resource_record_pre_action 17:13:32 INFO - Running main action method: read_buildbot_config 17:13:32 INFO - Using buildbot properties: 17:13:32 INFO - { 17:13:32 INFO - "project": "", 17:13:32 INFO - "product": "firefox", 17:13:32 INFO - "script_repo_revision": "production", 17:13:32 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 17:13:32 INFO - "repository": "", 17:13:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 17:13:32 INFO - "buildid": "20160807150652", 17:13:32 INFO - "pgo_build": "False", 17:13:32 INFO - "basedir": "/builds/slave/test", 17:13:32 INFO - "buildnumber": 72, 17:13:32 INFO - "slavename": "t-yosemite-r7-0235", 17:13:32 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 17:13:32 INFO - "platform": "yosemite_r7", 17:13:32 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 17:13:32 INFO - "branch": "fx-team", 17:13:32 INFO - "repo_path": "integration/fx-team", 17:13:32 INFO - "revision": "763fe887c37cee5fcfe0f00e94fdffc84a41ea1c", 17:13:32 INFO - "stage_platform": "macosx64", 17:13:32 INFO - "builduid": "5d0255e5fbda4650869c42fbb26aebb6", 17:13:32 INFO - "slavebuilddir": "test" 17:13:32 INFO - } 17:13:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/dHBm4sInQSeE2juCQKFmQw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 17:13:32 INFO - Running post-action listener: _resource_record_post_action 17:13:32 INFO - [mozharness: 2016-08-08 00:13:32.892516Z] Finished read-buildbot-config step (success) 17:13:32 INFO - [mozharness: 2016-08-08 00:13:32.892722Z] Running download-and-extract step. 17:13:32 INFO - Running pre-action listener: _resource_record_pre_action 17:13:32 INFO - Running main action method: download_and_extract 17:13:32 INFO - mkdir: /builds/slave/test/build/tests 17:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:32 INFO - trying https://queue.taskcluster.net/v1/task/dHBm4sInQSeE2juCQKFmQw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 17:13:32 INFO - Downloading https://queue.taskcluster.net/v1/task/dHBm4sInQSeE2juCQKFmQw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 17:13:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dHBm4sInQSeE2juCQKFmQw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 17:13:33 INFO - Downloaded 1199 bytes. 17:13:33 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 17:13:33 INFO - Using the following test package requirements: 17:13:33 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:13:33 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:13:33 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 17:13:33 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:13:33 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 17:13:33 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:13:33 INFO - u'jsshell-mac.zip'], 17:13:33 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:13:33 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 17:13:33 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:13:33 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:13:33 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 17:13:33 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:13:33 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 17:13:33 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:13:33 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 17:13:33 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:13:33 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 17:13:33 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:33 INFO - trying https://queue.taskcluster.net/v1/task/dHBm4sInQSeE2juCQKFmQw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:13:33 INFO - Downloading https://queue.taskcluster.net/v1/task/dHBm4sInQSeE2juCQKFmQw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:13:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dHBm4sInQSeE2juCQKFmQw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:13:34 INFO - Downloaded 16324201 bytes. 17:13:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:13:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:13:37 INFO - Return code: 0 17:13:37 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:37 INFO - trying https://queue.taskcluster.net/v1/task/dHBm4sInQSeE2juCQKFmQw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:13:37 INFO - Downloading https://queue.taskcluster.net/v1/task/dHBm4sInQSeE2juCQKFmQw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:13:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dHBm4sInQSeE2juCQKFmQw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:13:38 INFO - Downloaded 16324201 bytes. 17:13:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:13:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:13:42 INFO - Return code: 0 17:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:42 INFO - trying https://queue.taskcluster.net/v1/task/dHBm4sInQSeE2juCQKFmQw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 17:13:42 INFO - Downloading https://queue.taskcluster.net/v1/task/dHBm4sInQSeE2juCQKFmQw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 17:13:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dHBm4sInQSeE2juCQKFmQw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:13:42 INFO - Downloaded 14413723 bytes. 17:13:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:13:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 17:13:43 INFO - Return code: 0 17:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:43 INFO - trying https://queue.taskcluster.net/v1/task/dHBm4sInQSeE2juCQKFmQw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:13:43 INFO - Downloading https://queue.taskcluster.net/v1/task/dHBm4sInQSeE2juCQKFmQw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 17:13:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dHBm4sInQSeE2juCQKFmQw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 17:13:46 INFO - Downloaded 111871572 bytes. 17:13:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dHBm4sInQSeE2juCQKFmQw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:13:46 INFO - mkdir: /builds/slave/test/properties 17:13:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:13:46 INFO - Writing to file /builds/slave/test/properties/build_url 17:13:46 INFO - Contents: 17:13:46 INFO - build_url:https://queue.taskcluster.net/v1/task/dHBm4sInQSeE2juCQKFmQw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:13:46 INFO - Running post-action listener: _resource_record_post_action 17:13:46 INFO - Running post-action listener: set_extra_try_arguments 17:13:46 INFO - [mozharness: 2016-08-08 00:13:46.900209Z] Finished download-and-extract step (success) 17:13:46 INFO - [mozharness: 2016-08-08 00:13:46.900352Z] Running populate-webroot step. 17:13:46 INFO - Running pre-action listener: _resource_record_pre_action 17:13:46 INFO - Running main action method: populate_webroot 17:13:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:13:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:13:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:13:46 INFO - '--tppagecycles', 17:13:46 INFO - '7'], 17:13:46 INFO - 'tests': ['tsvgm']}}, 17:13:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:13:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:13:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:13:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:13:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:13:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:13:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:46 INFO - 'talos_options': ['--disable-e10s'], 17:13:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:13:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:13:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:46 INFO - 'talos_options': ['--disable-e10s'], 17:13:46 INFO - 'tests': ['damp', 'tps']}, 17:13:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:46 INFO - 'tests': ['damp', 'tps']}, 17:13:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:13:46 INFO - 'tests': ['dromaeo_dom']}, 17:13:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:13:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:13:46 INFO - 'tests': ['basic_compositor_video']}, 17:13:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:13:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:13:46 INFO - 'tests': ['a11yr', 17:13:46 INFO - 'ts_paint', 17:13:46 INFO - 'tpaint', 17:13:46 INFO - 'sessionrestore', 17:13:46 INFO - 'sessionrestore_no_auto_restore', 17:13:46 INFO - 'tabpaint']}, 17:13:46 INFO - 'other-e10s': {'tests': ['a11yr', 17:13:46 INFO - 'ts_paint', 17:13:46 INFO - 'tpaint', 17:13:46 INFO - 'sessionrestore', 17:13:46 INFO - 'sessionrestore_no_auto_restore', 17:13:46 INFO - 'tabpaint']}, 17:13:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:13:46 INFO - 'ts_paint', 17:13:46 INFO - 'tpaint', 17:13:46 INFO - 'sessionrestore', 17:13:46 INFO - 'sessionrestore_no_auto_restore', 17:13:46 INFO - 'tabpaint']}, 17:13:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:13:46 INFO - 'ts_paint', 17:13:46 INFO - 'tpaint', 17:13:46 INFO - 'sessionrestore', 17:13:46 INFO - 'sessionrestore_no_auto_restore', 17:13:46 INFO - 'tabpaint']}, 17:13:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:13:46 INFO - 'tests': ['a11yr', 17:13:46 INFO - 'ts_paint', 17:13:46 INFO - 'tpaint', 17:13:46 INFO - 'sessionrestore', 17:13:46 INFO - 'sessionrestore_no_auto_restore', 17:13:46 INFO - 'tabpaint']}, 17:13:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:13:46 INFO - 'tests': ['a11yr', 17:13:46 INFO - 'ts_paint', 17:13:46 INFO - 'tpaint', 17:13:46 INFO - 'sessionrestore', 17:13:46 INFO - 'sessionrestore_no_auto_restore', 17:13:46 INFO - 'tabpaint']}, 17:13:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:13:46 INFO - 'tests': ['tsvgx', 17:13:46 INFO - 'tsvgr_opacity', 17:13:46 INFO - 'tart', 17:13:46 INFO - 'tscrollx', 17:13:46 INFO - 'cart']}, 17:13:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:13:46 INFO - 'tsvgr_opacity', 17:13:46 INFO - 'tart', 17:13:46 INFO - 'tscrollx', 17:13:46 INFO - 'cart']}, 17:13:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:46 INFO - 'talos_options': ['--disable-e10s'], 17:13:46 INFO - 'tests': ['tp5o']}, 17:13:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:46 INFO - 'tests': ['tp5o']}, 17:13:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:46 INFO - 'talos_options': ['--disable-e10s', 17:13:46 INFO - '--xperf_path', 17:13:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:13:46 INFO - 'tests': ['tp5n']}, 17:13:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:46 INFO - 'talos_options': ['--xperf_path', 17:13:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:13:46 INFO - 'tests': ['tp5n']}}, 17:13:46 INFO - 'talos.zip': {'path': '', 17:13:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:13:46 INFO - Running post-action listener: _resource_record_post_action 17:13:46 INFO - [mozharness: 2016-08-08 00:13:46.919060Z] Finished populate-webroot step (success) 17:13:46 INFO - [mozharness: 2016-08-08 00:13:46.919165Z] Running create-virtualenv step. 17:13:46 INFO - Running pre-action listener: _resource_record_pre_action 17:13:46 INFO - Running main action method: create_virtualenv 17:13:46 INFO - Creating virtualenv /builds/slave/test/build/venv 17:13:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:13:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:13:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:13:47 INFO - Using real prefix '/tools/python27' 17:13:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:13:47 INFO - Installing distribute.............................................................................................................................................................................................done. 17:13:50 INFO - Installing pip.................done. 17:13:50 INFO - Return code: 0 17:13:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:13: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:50 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 0x1049dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a71618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabe9c76720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104940d30>, '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 0x1046a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104938b20>, '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.dlIisPMRRz/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.U0nsP0ZL84/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:13:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:13:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dlIisPMRRz/Render', 17:13:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:13:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:13:50 INFO - 'HOME': '/Users/cltbld', 17:13:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:13:50 INFO - 'LOGNAME': 'cltbld', 17:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:50 INFO - 'MOZ_NO_REMOTE': '1', 17:13:50 INFO - 'NO_EM_RESTART': '1', 17:13:50 INFO - 'PAGER': '/bin/cat', 17:13:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:50 INFO - 'PWD': '/builds/slave/test', 17:13:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:13:50 INFO - 'SHELL': '/bin/bash', 17:13:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U0nsP0ZL84/Listeners', 17:13:50 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 17:13:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:13:50 INFO - 'USER': 'cltbld', 17:13:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:13:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:50 INFO - 'XPC_FLAGS': '0x0', 17:13:50 INFO - 'XPC_SERVICE_NAME': '0', 17:13:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:13:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:13:51 INFO - Cleaning up... 17:13:51 INFO - Return code: 0 17:13:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:51 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 0x1049dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a71618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabe9c76720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104940d30>, '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 0x1046a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104938b20>, '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.dlIisPMRRz/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.U0nsP0ZL84/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:13:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:13:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:13:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dlIisPMRRz/Render', 17:13:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:13:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:13:51 INFO - 'HOME': '/Users/cltbld', 17:13:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:13:51 INFO - 'LOGNAME': 'cltbld', 17:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:51 INFO - 'MOZ_NO_REMOTE': '1', 17:13:51 INFO - 'NO_EM_RESTART': '1', 17:13:51 INFO - 'PAGER': '/bin/cat', 17:13:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:51 INFO - 'PWD': '/builds/slave/test', 17:13:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:13:51 INFO - 'SHELL': '/bin/bash', 17:13:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U0nsP0ZL84/Listeners', 17:13:51 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 17:13:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:13:51 INFO - 'USER': 'cltbld', 17:13:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:13:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:51 INFO - 'XPC_FLAGS': '0x0', 17:13:51 INFO - 'XPC_SERVICE_NAME': '0', 17:13:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:13:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:51 INFO - Downloading/unpacking psutil>=3.1.1 17:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:13:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:13:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:13:54 INFO - Installing collected packages: psutil 17:13:54 INFO - Running setup.py install for psutil 17:13:54 INFO - building 'psutil._psutil_osx' extension 17:13:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 17:13:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 17:13:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 17:13:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 17:13:55 INFO - building 'psutil._psutil_posix' extension 17:13:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 17:13:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:13:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:13:55 INFO - ^ 17:13:55 INFO - 1 warning generated. 17:13:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 17:13:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:13:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:13:55 INFO - Successfully installed psutil 17:13:55 INFO - Cleaning up... 17:13:55 INFO - Return code: 0 17:13:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:13: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:55 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 0x1049dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a71618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabe9c76720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104940d30>, '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 0x1046a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104938b20>, '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.dlIisPMRRz/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.U0nsP0ZL84/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:13:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:13:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:13:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dlIisPMRRz/Render', 17:13:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:13:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:13:55 INFO - 'HOME': '/Users/cltbld', 17:13:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:13:55 INFO - 'LOGNAME': 'cltbld', 17:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:55 INFO - 'MOZ_NO_REMOTE': '1', 17:13:55 INFO - 'NO_EM_RESTART': '1', 17:13:55 INFO - 'PAGER': '/bin/cat', 17:13:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:55 INFO - 'PWD': '/builds/slave/test', 17:13:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:13:55 INFO - 'SHELL': '/bin/bash', 17:13:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U0nsP0ZL84/Listeners', 17:13:55 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 17:13:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:13:55 INFO - 'USER': 'cltbld', 17:13:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:13:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:55 INFO - 'XPC_FLAGS': '0x0', 17:13:55 INFO - 'XPC_SERVICE_NAME': '0', 17:13:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:13:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:13:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:13:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:13:58 INFO - Installing collected packages: mozsystemmonitor 17:13:58 INFO - Running setup.py install for mozsystemmonitor 17:13:58 INFO - Successfully installed mozsystemmonitor 17:13:58 INFO - Cleaning up... 17:13:58 INFO - Return code: 0 17:13:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1049dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a71618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabe9c76720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104940d30>, '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 0x1046a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104938b20>, '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.dlIisPMRRz/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.U0nsP0ZL84/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:13:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:13:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:13:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dlIisPMRRz/Render', 17:13:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:13:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:13:58 INFO - 'HOME': '/Users/cltbld', 17:13:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:13:58 INFO - 'LOGNAME': 'cltbld', 17:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:58 INFO - 'MOZ_NO_REMOTE': '1', 17:13:58 INFO - 'NO_EM_RESTART': '1', 17:13:58 INFO - 'PAGER': '/bin/cat', 17:13:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:58 INFO - 'PWD': '/builds/slave/test', 17:13:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:13:58 INFO - 'SHELL': '/bin/bash', 17:13:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U0nsP0ZL84/Listeners', 17:13:58 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 17:13:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:13:58 INFO - 'USER': 'cltbld', 17:13:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:13:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:58 INFO - 'XPC_FLAGS': '0x0', 17:13:58 INFO - 'XPC_SERVICE_NAME': '0', 17:13:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:58 INFO - Downloading/unpacking jsonschema==2.5.1 17:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:14:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:01 INFO - Downloading functools32-3.2.3-2.tar.gz 17:14:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:14:01 INFO - warning: no files found matching '*.txt' 17:14:01 INFO - no previously-included directories found matching 'build' 17:14:01 INFO - no previously-included directories found matching 'dist' 17:14:01 INFO - no previously-included directories found matching '.git*' 17:14:01 INFO - Installing collected packages: jsonschema, functools32 17:14:01 INFO - Running setup.py install for functools32 17:14:01 INFO - warning: no files found matching '*.txt' 17:14:01 INFO - no previously-included directories found matching 'build' 17:14:01 INFO - no previously-included directories found matching 'dist' 17:14:01 INFO - no previously-included directories found matching '.git*' 17:14:01 INFO - Successfully installed jsonschema functools32 17:14:01 INFO - Cleaning up... 17:14:02 INFO - Return code: 0 17:14:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1049dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a71618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabe9c76720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104940d30>, '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 0x1046a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104938b20>, '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.dlIisPMRRz/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.U0nsP0ZL84/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:14:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:14:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:14:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dlIisPMRRz/Render', 17:14:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:02 INFO - 'HOME': '/Users/cltbld', 17:14:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:02 INFO - 'LOGNAME': 'cltbld', 17:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:02 INFO - 'MOZ_NO_REMOTE': '1', 17:14:02 INFO - 'NO_EM_RESTART': '1', 17:14:02 INFO - 'PAGER': '/bin/cat', 17:14:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:02 INFO - 'PWD': '/builds/slave/test', 17:14:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:02 INFO - 'SHELL': '/bin/bash', 17:14:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U0nsP0ZL84/Listeners', 17:14:02 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 17:14:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:02 INFO - 'USER': 'cltbld', 17:14:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:02 INFO - 'XPC_FLAGS': '0x0', 17:14:02 INFO - 'XPC_SERVICE_NAME': '0', 17:14:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:14:02 INFO - Cleaning up... 17:14:02 INFO - Return code: 0 17:14:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1049dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a71618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabe9c76720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104940d30>, '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 0x1046a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104938b20>, '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.dlIisPMRRz/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.U0nsP0ZL84/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:14:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:14:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:14:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dlIisPMRRz/Render', 17:14:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:02 INFO - 'HOME': '/Users/cltbld', 17:14:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:02 INFO - 'LOGNAME': 'cltbld', 17:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:02 INFO - 'MOZ_NO_REMOTE': '1', 17:14:02 INFO - 'NO_EM_RESTART': '1', 17:14:02 INFO - 'PAGER': '/bin/cat', 17:14:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:02 INFO - 'PWD': '/builds/slave/test', 17:14:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:02 INFO - 'SHELL': '/bin/bash', 17:14:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U0nsP0ZL84/Listeners', 17:14:02 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 17:14:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:02 INFO - 'USER': 'cltbld', 17:14:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:02 INFO - 'XPC_FLAGS': '0x0', 17:14:02 INFO - 'XPC_SERVICE_NAME': '0', 17:14:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:02 INFO - Downloading/unpacking blobuploader==1.2.4 17:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:04 INFO - Downloading blobuploader-1.2.4.tar.gz 17:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:14:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:14:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:06 INFO - Downloading docopt-0.6.1.tar.gz 17:14:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:14:06 INFO - Installing collected packages: blobuploader, requests, docopt 17:14:06 INFO - Running setup.py install for blobuploader 17:14:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:14:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:14:06 INFO - Running setup.py install for requests 17:14:06 INFO - Running setup.py install for docopt 17:14:07 INFO - Successfully installed blobuploader requests docopt 17:14:07 INFO - Cleaning up... 17:14:07 INFO - Return code: 0 17:14:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:07 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 0x1049dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a71618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabe9c76720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104940d30>, '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 0x1046a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104938b20>, '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.dlIisPMRRz/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.U0nsP0ZL84/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:14:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:14:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dlIisPMRRz/Render', 17:14:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:07 INFO - 'HOME': '/Users/cltbld', 17:14:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:07 INFO - 'LOGNAME': 'cltbld', 17:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:07 INFO - 'MOZ_NO_REMOTE': '1', 17:14:07 INFO - 'NO_EM_RESTART': '1', 17:14:07 INFO - 'PAGER': '/bin/cat', 17:14:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:07 INFO - 'PWD': '/builds/slave/test', 17:14:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:07 INFO - 'SHELL': '/bin/bash', 17:14:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U0nsP0ZL84/Listeners', 17:14:07 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 17:14:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:07 INFO - 'USER': 'cltbld', 17:14:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:07 INFO - 'XPC_FLAGS': '0x0', 17:14:07 INFO - 'XPC_SERVICE_NAME': '0', 17:14:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:14:07 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-8Ckf10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:14:07 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Fcft_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:14:07 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-_uWeXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:14:07 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-MmusRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:14:07 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-smhi5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:14:07 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-oPIVan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:14:08 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-kSCgOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:14:08 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-DlWcRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:14:08 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-W4zwJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:14:08 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-1KG0Lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:14:08 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-fsZWND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:14:08 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-LheDOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:14:08 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-XOrg9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:14:08 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-zUx3Ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:14:08 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-bgnvqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:14:08 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-WKo11t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:14:09 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-On0gNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:14:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:14:09 INFO - Running setup.py install for manifestparser 17:14:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:14:09 INFO - Running setup.py install for mozcrash 17:14:09 INFO - Running setup.py install for mozdebug 17:14:09 INFO - Running setup.py install for mozdevice 17:14:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:14:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:14:09 INFO - Running setup.py install for mozfile 17:14:09 INFO - Running setup.py install for mozhttpd 17:14:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:14:10 INFO - Running setup.py install for mozinfo 17:14:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:14:10 INFO - Running setup.py install for mozInstall 17:14:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:14:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:14:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:14:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:14:10 INFO - Running setup.py install for mozleak 17:14:10 INFO - Running setup.py install for mozlog 17:14:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:14:10 INFO - Running setup.py install for moznetwork 17:14:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:14:10 INFO - Running setup.py install for mozprocess 17:14:10 INFO - Running setup.py install for mozprofile 17:14:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:14:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:14:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:14:11 INFO - Running setup.py install for mozrunner 17:14:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:14:11 INFO - Running setup.py install for mozscreenshot 17:14:11 INFO - Running setup.py install for moztest 17:14:11 INFO - Running setup.py install for mozversion 17:14:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:14:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:14:11 INFO - Cleaning up... 17:14:11 INFO - Return code: 0 17:14:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:14: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:11 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 0x1049dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a71618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabe9c76720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104940d30>, '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 0x1046a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104938b20>, '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.dlIisPMRRz/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.U0nsP0ZL84/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:14:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:14:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:14:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dlIisPMRRz/Render', 17:14:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:11 INFO - 'HOME': '/Users/cltbld', 17:14:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:11 INFO - 'LOGNAME': 'cltbld', 17:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:11 INFO - 'MOZ_NO_REMOTE': '1', 17:14:11 INFO - 'NO_EM_RESTART': '1', 17:14:11 INFO - 'PAGER': '/bin/cat', 17:14:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:11 INFO - 'PWD': '/builds/slave/test', 17:14:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:11 INFO - 'SHELL': '/bin/bash', 17:14:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U0nsP0ZL84/Listeners', 17:14:11 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 17:14:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:11 INFO - 'USER': 'cltbld', 17:14:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:11 INFO - 'XPC_FLAGS': '0x0', 17:14:11 INFO - 'XPC_SERVICE_NAME': '0', 17:14:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:14:12 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-4KHxwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:14:12 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-GrOYsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:14:12 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-hGRZGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:14:12 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-CRHk7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:14:12 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-eHcsqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:14:12 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-syUnB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:14:12 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-fK9HCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:14:12 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-a0nghm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:14:12 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-EMw3th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:14:12 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-HFWh4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:14:13 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-VncJZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:14:13 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-l462L0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:14:13 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)) 17:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:14:13 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-EXOlt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:14:13 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-j895mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:14:13 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)) 17:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:14:13 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-hnI5Gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:14:13 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Bty8ru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:14:13 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-LENTYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:14:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:16 INFO - Downloading blessings-1.6.tar.gz 17:14:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:14:16 INFO - Installing collected packages: blessings 17:14:16 INFO - Running setup.py install for blessings 17:14:16 INFO - Successfully installed blessings 17:14:16 INFO - Cleaning up... 17:14:16 INFO - Return code: 0 17:14:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:14:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:14:16 INFO - Reading from file tmpfile_stdout 17:14:16 INFO - Current package versions: 17:14:16 INFO - blessings == 1.6 17:14:16 INFO - blobuploader == 1.2.4 17:14:16 INFO - docopt == 0.6.1 17:14:16 INFO - functools32 == 3.2.3-2 17:14:16 INFO - jsonschema == 2.5.1 17:14:16 INFO - manifestparser == 1.1 17:14:16 INFO - mozInstall == 1.12 17:14:16 INFO - mozcrash == 0.17 17:14:16 INFO - mozdebug == 0.1 17:14:16 INFO - mozdevice == 0.48 17:14:16 INFO - mozfile == 1.2 17:14:16 INFO - mozhttpd == 0.7 17:14:16 INFO - mozinfo == 0.9 17:14:16 INFO - mozleak == 0.1 17:14:16 INFO - mozlog == 3.3 17:14:16 INFO - moznetwork == 0.27 17:14:16 INFO - mozprocess == 0.23 17:14:16 INFO - mozprofile == 0.28 17:14:16 INFO - mozrunner == 6.12 17:14:16 INFO - mozscreenshot == 0.1 17:14:16 INFO - mozsystemmonitor == 0.3 17:14:16 INFO - moztest == 0.7 17:14:16 INFO - mozversion == 1.4 17:14:16 INFO - psutil == 3.1.1 17:14:16 INFO - requests == 1.2.3 17:14:16 INFO - wsgiref == 0.1.2 17:14:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:14:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:16 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 0x1049dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a71618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabe9c76720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104940d30>, '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 0x1046a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104938b20>, '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.dlIisPMRRz/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.U0nsP0ZL84/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:14:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:14:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dlIisPMRRz/Render', 17:14:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:16 INFO - 'HOME': '/Users/cltbld', 17:14:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:16 INFO - 'LOGNAME': 'cltbld', 17:14:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:16 INFO - 'MOZ_NO_REMOTE': '1', 17:14:16 INFO - 'NO_EM_RESTART': '1', 17:14:16 INFO - 'PAGER': '/bin/cat', 17:14:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:16 INFO - 'PWD': '/builds/slave/test', 17:14:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:16 INFO - 'SHELL': '/bin/bash', 17:14:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U0nsP0ZL84/Listeners', 17:14:16 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 17:14:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:16 INFO - 'USER': 'cltbld', 17:14:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:16 INFO - 'XPC_FLAGS': '0x0', 17:14:16 INFO - 'XPC_SERVICE_NAME': '0', 17:14:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:14:17 INFO - Cleaning up... 17:14:17 INFO - Return code: 0 17:14:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:14:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1049dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a71618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabe9c76720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104940d30>, '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 0x1046a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104938b20>, '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.dlIisPMRRz/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.U0nsP0ZL84/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:14:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:14:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dlIisPMRRz/Render', 17:14:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:17 INFO - 'HOME': '/Users/cltbld', 17:14:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:17 INFO - 'LOGNAME': 'cltbld', 17:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:17 INFO - 'MOZ_NO_REMOTE': '1', 17:14:17 INFO - 'NO_EM_RESTART': '1', 17:14:17 INFO - 'PAGER': '/bin/cat', 17:14:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:17 INFO - 'PWD': '/builds/slave/test', 17:14:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:17 INFO - 'SHELL': '/bin/bash', 17:14:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U0nsP0ZL84/Listeners', 17:14:17 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 17:14:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:17 INFO - 'USER': 'cltbld', 17:14:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:17 INFO - 'XPC_FLAGS': '0x0', 17:14:17 INFO - 'XPC_SERVICE_NAME': '0', 17:14:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:14:17 INFO - Cleaning up... 17:14:17 INFO - Return code: 0 17:14:17 INFO - Running post-action listener: _resource_record_post_action 17:14:17 INFO - Running post-action listener: _start_resource_monitoring 17:14:17 INFO - Starting resource monitoring. 17:14:17 INFO - [mozharness: 2016-08-08 00:14:17.428837Z] Finished create-virtualenv step (success) 17:14:17 INFO - [mozharness: 2016-08-08 00:14:17.429864Z] Running install step. 17:14:17 INFO - Running pre-action listener: _resource_record_pre_action 17:14:17 INFO - Running main action method: install 17:14:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:14:17 INFO - Reading from file tmpfile_stdout 17:14:17 INFO - Detecting whether we're running mozinstall >=1.0... 17:14:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:14:17 INFO - Reading from file tmpfile_stdout 17:14:17 INFO - Output received: 17:14:17 INFO - Usage: mozinstall [options] installer 17:14:17 INFO - Options: 17:14:17 INFO - -h, --help show this help message and exit 17:14:17 INFO - -d DEST, --destination=DEST 17:14:17 INFO - Directory to install application into. [default: 17:14:17 INFO - "/builds/slave/test"] 17:14:17 INFO - --app=APP Application being installed. [default: firefox] 17:14:17 INFO - mkdir: /builds/slave/test/build/application 17:14:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:14:51 INFO - Reading from file tmpfile_stdout 17:14:51 INFO - Output received: 17:14:51 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:14:51 INFO - Running post-action listener: _resource_record_post_action 17:14:51 INFO - [mozharness: 2016-08-08 00:14:51.669520Z] Finished install step (success) 17:14:51 INFO - [mozharness: 2016-08-08 00:14:51.669694Z] Running run-tests step. 17:14:51 INFO - Running pre-action listener: _resource_record_pre_action 17:14:51 INFO - Running main action method: run_tests 17:14:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:14:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:14:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:14:51 INFO - 2016-08-07 17:14:51.684 screenresolution[4473:37561] starting screenresolution argv=screenresolution get 17:14:51 INFO - 2016-08-07 17:14:51.687 screenresolution[4473:37561] Display 0: 1600x1200x32@60 17:14:51 INFO - 2016-08-07 17:14:51.692 screenresolution[4474:37563] starting screenresolution argv=screenresolution list 17:14:51 INFO - Available Modes on Display 0 17:14:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:14:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:14:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:14:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:14:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:14:51 INFO - Intel Iris: 17:14:51 INFO - Chipset Model: Intel Iris 17:14:51 INFO - Type: GPU 17:14:51 INFO - Bus: Built-In 17:14:51 INFO - VRAM (Dynamic, Max): 1536 MB 17:14:51 INFO - Vendor: Intel (0x8086) 17:14:51 INFO - Device ID: 0x0a2e 17:14:51 INFO - Revision ID: 0x0009 17:14:51 INFO - Displays: 17:14:51 INFO - Display: 17:14:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:14:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:14:51 INFO - Display Serial Number: 1600x1200 60 17:14:51 INFO - Main Display: Yes 17:14:51 INFO - Mirror: Off 17:14:51 INFO - Online: Yes 17:14:51 INFO - Rotation: Supported 17:14:51 INFO - Return code: 0 17:14:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:14:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:14:51 INFO - Python 2.7.3 17:14:51 INFO - Return code: 0 17:14:51 INFO - grabbing minidump binary from tooltool 17:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:51 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 0x104940d30>, '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 0x1046a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104938b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:14:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:14:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 17:14:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:14:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:14:52 INFO - Return code: 0 17:14:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:14:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:14:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:14:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:14:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:14:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dHBm4sInQSeE2juCQKFmQw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0235', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:14:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dHBm4sInQSeE2juCQKFmQw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0235 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:14:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dlIisPMRRz/Render', 17:14:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:52 INFO - 'HOME': '/Users/cltbld', 17:14:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:52 INFO - 'LOGNAME': 'cltbld', 17:14:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:14:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:52 INFO - 'MOZ_NO_REMOTE': '1', 17:14:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:14:52 INFO - 'NO_EM_RESTART': '1', 17:14:52 INFO - 'PAGER': '/bin/cat', 17:14:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:52 INFO - 'PWD': '/builds/slave/test', 17:14:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:14:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:52 INFO - 'SHELL': '/bin/bash', 17:14:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U0nsP0ZL84/Listeners', 17:14:52 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 17:14:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:52 INFO - 'USER': 'cltbld', 17:14:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:52 INFO - 'XPC_FLAGS': '0x0', 17:14:52 INFO - 'XPC_SERVICE_NAME': '0', 17:14:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dHBm4sInQSeE2juCQKFmQw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0235', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:14:52 INFO - mozversion application_buildid: 20160807150652 17:14:52 INFO - mozversion application_changeset: 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c 17:14:52 INFO - mozversion application_display_name: Nightly 17:14:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:14:52 INFO - mozversion application_name: Firefox 17:14:52 INFO - mozversion application_remotingname: firefox 17:14:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:14:52 INFO - mozversion application_vendor: Mozilla 17:14:52 INFO - mozversion application_version: 51.0a1 17:14:52 INFO - mozversion platform_buildid: 20160807150652 17:14:52 INFO - mozversion platform_changeset: 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c 17:14:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:14:52 INFO - mozversion platform_version: 51.0a1 17:14:52 INFO - using testdate: 1470615292 17:14:52 INFO - actual date: 1470615292 17:14:52 INFO - starting webserver on 'localhost:52773' 17:14:52 INFO - SUITE-START | Running 2 tests 17:14:52 INFO - TEST-START | dromaeo_css 17:14:52 INFO - operating with platform_type : mac_ 17:14:52 INFO - Initialising browser for dromaeo_css test... 17:14:52 INFO - TEST-INFO | started process 4484 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpo55jm1/profile http://localhost:52773/getInfo.html) 17:14:55 INFO - PROCESS | 4484 | __metrics Screen width/height:1600/1200 17:14:55 INFO - PROCESS | 4484 | colorDepth:24 17:14:55 INFO - PROCESS | 4484 | Browser inner width/height: 1024/689 17:14:55 INFO - PROCESS | 4484 | __metrics 17:14:55 ERROR - PROCESS | 4484 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 17:14:56 INFO - TEST-INFO | 4484: exit 0 17:14:56 INFO - Browser initialized. 17:14:56 INFO - Running cycle 1/1 for dromaeo_css test... 17:14:56 INFO - TEST-INFO | started process 4487 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpo55jm1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:15:08 INFO - PROCESS | 4487 | RSS: Main: 254881792 17:15:08 INFO - PROCESS | 4487 | 17:15:57 INFO - PROCESS | 4487 | 1470615357819 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:18:10 INFO - PROCESS | 4487 | Cycle 1(1): loaded http://localhost:52773/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52773/tests/dromaeo/cssquery-ext.html) 17:18:11 INFO - PROCESS | 4487 | RSS: Main: 272027648 17:18:11 INFO - PROCESS | 4487 | 17:21:13 INFO - PROCESS | 4487 | Cycle 1(1): loaded http://localhost:52773/tests/dromaeo/cssquery-ext.html (next: http://localhost:52773/tests/dromaeo/cssquery-jquery.html) 17:21:14 INFO - PROCESS | 4487 | RSS: Main: 281464832 17:21:14 INFO - PROCESS | 4487 | 17:24:16 INFO - PROCESS | 4487 | Cycle 1(1): loaded http://localhost:52773/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52773/tests/dromaeo/cssquery-mootools.html) 17:24:17 INFO - PROCESS | 4487 | RSS: Main: 288436224 17:24:17 INFO - PROCESS | 4487 | 17:27:18 INFO - PROCESS | 4487 | Cycle 1(1): loaded http://localhost:52773/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52773/tests/dromaeo/cssquery-prototype.html) 17:27:19 INFO - PROCESS | 4487 | RSS: Main: 287272960 17:27:19 INFO - PROCESS | 4487 | 17:30:22 INFO - PROCESS | 4487 | Cycle 1(1): loaded http://localhost:52773/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52773/tests/dromaeo/cssquery-yui.html) 17:30:22 INFO - PROCESS | 4487 | RSS: Main: 292122624 17:30:22 INFO - PROCESS | 4487 | 17:33:25 INFO - PROCESS | 4487 | Cycle 1(1): loaded http://localhost:52773/tests/dromaeo/cssquery-yui.html (next: http://localhost:52773/tests/dromaeo/cssquery-dojo.html) 17:33:25 INFO - PROCESS | 4487 | RSS: Main: 291807232 17:33:25 INFO - PROCESS | 4487 | 17:33:25 INFO - PROCESS | 4487 | __start_tp_report 17:33:25 INFO - PROCESS | 4487 | _x_x_mozilla_page_load 17:33:25 INFO - PROCESS | 4487 | _x_x_mozilla_page_load_details 17:33:25 INFO - PROCESS | 4487 | |i|pagename|runs| 17:33:25 INFO - PROCESS | 4487 | |0;dojo.html;2887.682354940956;3429.1427143214196;3439.587249530055;3452.1887356471225;3469.4102002659547;4812.566868981791;5513.62159460135;5789.2184555085105;5855.47300742933;5941.4058594140615;5200.193969934666;5787.189793428924;5793.073108302672;5858.7949421770245;5898.764049438028;5194.974025129888;5280.313559237313;5289.761960711778;5350.973245133769;5378.8924221515545;5380.085385484477;5417.59368047396;5430.3755068167275;5432.837014889559;5445.945540544583;5176.094183517869;5207.98444303361;5242.895142097137;5266.683998960056;5292;5228.895422091537;5233.1888557273305;5260.789568417297;5302.390225124122;5355.089634762061;5227.137522308853;5250.763715632767;5255.08036093682;5291.603129765283;5296.523312901819;5686.118651609007;5750.626209296424;5810.1865738796605;5844.620099693507;5844.707764611795;6217.285012223607;6239.532035097341;6245.594036387665;6264.3422440643535;6288.371162883721;6239.032949892774;6244.281907580641;6264.1543391642;6273.498120150422;6284.528660350492;5542.2795036644975;5711.314642242916;5713.857153571194;5754.971225143931;5763.049096899007;5470;6240.875182496416;6253.343398943137;6262.780802671976;6288.119663247149;6076.908846367308;6149.385061493905;6151.0773383992755;6161.106639537242;6166.660833654102;4823.517648235148;4984.950150498521;5950.018246989285;6224.968875155595;6268.153799237045;5264.631475796734;5614.775408983676;6221.502279817604;6285.8742825143245;6289.119523266746;6154.383339568525;6257.374262573797;6268.153799237136;6268.185135932391;6269.65516896566;3907.648311651908;4796.352492413549;4914.33656456381;4926.901461970812;4945.950540494549;4425.933610995838;4484.282514797616;4494.191045611821;4502.887427814266;4526.456825181;5830.941690583039;5895.793647222413;5902.173695682608;5914.763409463573;5918.201042859159;6188.566800323934;6193.071039344134;6199.690015499207;6215.098810672517;6250.749850030013;5918.082697181943;5928.407159284037;5929.822105336847;5948.167256584082;5971.343152253248;5430.321209848769;5436.537894278951;5462.20797984298;5480.369757477862;5487.5609951203805;6176.81469555914;6278.497720182283;6290.056491526308;6354.555181137369;6380.9361906380345;5540.168974653834;5941.168236446987;6258.249010118815;6279;6296.244450665949;6306.369363063657;6350.079238510482;6352.523560733056;6353.205849268841;6361.522885783677;6077.361877002851;6162.22972128484;6219.222597175353;6230.376962303914;6239.7504099837315;6225.8132256032395;6246.437820596168;6284.120223168851;6288.213973253343;6291.653959032297;4898.951010489849;6216.378362163748;6248.250209974651;6254.749810007549;6266.498680105489;6094.329623741473;6139.815805525842;6149.292831324455;6184.041473571604;6235.971064774261;4731.69243999139;5924.585279030426;6113.602615829956;6131.687037415961;6137.8979746733885;6160;6178.196834411498;6214.8135555933395;6218.720157593009;6254.155688981929;5923.4076592340425;6035.939640603713;6036.9094463582205;6045.78839740607;6076.453119219114 17:33:25 INFO - PROCESS | 4487 | |1;ext.html;504.3569448952585;519.9662021968571;522.8039485193052;539.6600141910595;560.985975350616;37845;40135.79932100335;40154.594589189386;40220.396694049574;40279.791606251856;41487.37768933461;41669.58330416695;41914.580854191525;41931;41962.37056444156;9547.188488978445;9738.367006144614;9759.121679048883;9760.2679799015;9781.070798274153;8899.798527198811;9245.815083698355;9578;9664.661736839213;9742.902570974271;9730.562124704406;9761.560729767178;9761.902380976206;9764.804703905918;9778.951105244463;9601.37591056579;9695.951520242388;9731.95134024329;9743.074407931306;9768.413895166314;9659.855102173473;9730.513474326255;9775.364601300893;9780.021997800235;9807;39147.41278880819;39365.80317098425;39504;39607.207855842724;39758.60241397607;3036.880665590463;3258.560094387251;3275.894716909678;3436.7078798302173;3454.0072973391398;23240.418989525228;25470.36324091894;29416;29978.100656980107;31015.22461938447;2724.3870129220963;3057.5260834570454;3090;3119.142235885127;3161.0832858471017;397487;399220;402701;403559;403985;27485.17544473669;32102.839485802888;32340.83829580884;32396.35207295841;32398;29282.97509587154;32592;34362.48456273158;34720.82639586786;35788.82105589456;16325.938813977053;16512.25694843735;16614.83385166133;16682.916585416995;16702.58243543897;12592;12671.683207919876;12734.426950787052;12738.235705857678;12739.108262421541;19051.523711907037;19134.330298439487;19164.329248476235;19183.52041198981;19304.613907722047;7468.813279668052;7976.760697179094;8185.71350002747;8259.256666900008;8359.456635318686;891.8171774786153;985.103555764251;1008.2740426892625;1037.455335948633;1109.3454861631676;30318.61906956662;30494.84752576223;30526.69473305283;31151.84424077865;31223.219419514695;1043.832986722136;1055.9577616895237;1071.196602548089;1083.3283364314018;1103.382106020631;15390.615234619225;15511.224438778016;15868;15987.200639967956;16206.432774852823;621348;621634;632156;633527;635064;57822;58148.12777808336;58264.70867645634;58575;58775.11837322444;1322.543722415765;1346.2124657075524;1363.638635761524;1363.7136201397618;1370.465518447806;29579.408411831213;30035.699643004165;30183.672044137547;30264.848675757363;30677.693223067483;49123;49356.27253046126;49836.25245621246;49941;50005.249921250484;543825;544797;547006;548347;549690;26370.34074148085;26569.468610627293;26916.05793797286;27158.864205678845;27753.722462775113;46704;47819.52180478151;48435;49189.26216106833;49587;33631;34540.48189277213;34806.12984675403;39616.60383396129;39877.601223988546;38999.02502437462;39244.41133382944;39847.60152398439;40394.79802600968;40419.39370909498;36956.26087478289;37541.624583753815;37831;38409.807950960065;38612;34807.59211016003;34842.12894677653;34901.476477852346;35310.823445882605;35413.64586354104;25896.964121434932;26089.869550652886;26431;26439.206823795317;26587.601185982614 17:33:25 INFO - PROCESS | 4487 | |2;jquery.html;332.6457322951057;365.51751687772145;369.5712972951375;385.1680370399937;394.1584716629998;20504.282350117748;20546.38360849175;21075.683864742023;21307;22035.338939831792;9492.430454172738;12204.755904881897;12241.816372754416;12257.938710306458;15442.61393465164;5389.73051347433;5614.66312021278;5625.634333768312;5634.549236061105;5635.830925072254;3312.73498120151;5648;6103.572749907508;6918.273581273969;6995.65021748913;6852.897206541906;7014.649267536628;7034.472414568928;7044.894326585106;7050.5769653820935;6216.689165541728;6269.937300626981;6270.78052268173;6287.717052732615;6309.053641953721;5237.921431178535;6021.36775638556;6043.8186854394435;6052.485538729214;6069.878602427927;13457.192568445924;13586.320683965761;17473.563160920952;25223.36941576457;26087.826047827893;1995.8902260375673;2214.933551993443;2257.5372048730137;2618.764311211981;2776.8195067320557;10226.386416815016;10325.741856453573;10393.428361440117;16037;16683.49949501517;1696.686113069086;1850.00099946029;1896.9661534463612;2020.2121172742643;2028.3103744726716;100258;122951.77048229493;140359;140484;142648;19187.232510699694;20346.593068138554;20952.58094838125;22013.11947522113;22154.556908862054;35202.47196292058;35202.823985880415;35304.82347588297;35394.58421663156;35472.82263588717;10745.355278683304;10932.508037138348;11068.723281918017;11194.328340299608;11201.943990279997;6719.496037797185;8958.148975847284;8995.55022248885;9220.953895230481;9226.35415520907;8526;9720.07659272368;9938.409854423258;10056.64801731936;10081.69754907354;1497.0119720984317;1527.6709262941313;1672.7240005398974;1677.1362748184695;3407.539982102434;846.289117141604;893.4594570285014;896.8565029595234;912.9589168487435;959.788846453779;21141.04865281066;21738.91305434722;21897;21929.23247686323;21938.561228775336;892.2683399612256;923.6536298887917;974.4591751577942;994.7413672445216;1009.414539567064;11091.72270693239;11464.25482343645;11504.597339093092;11581.247218930912;11654;564903;570942;572757;575838;597683;113347.43326283316;120605;125214;126075.36962315314;127793;985.7437066362797;1017.110028724851;1031.4584842957506;1077.617445806743;1078.6440474643348;19079.809201907803;19592.608147837247;19728.408147755592;19834;19834.90908000074;54809.629759256335;55330.44669553414;56042.43957560536;56545;57527.71236143792;84631.15368846232;85780.28439431301;85891;86074.27851443061;86430;8119.188081191834;8171.142030086993;8405.957970210355;8442.282405995558;8466.06873243955;11347.432628368384;13260.53588124411;13280;13672.17966921948;13696;8531.95734021326;11348.03541698965;11852.992495637967;11926.105542084204;11953.581624643095;10996.725081873017;11163.553457861595;11492.94253528727;11495.885041149815;11778.76442471163;11601;11765.352905590275;11810.881891180978;11995.980341671057;11996.340201289013;8137.104918458846;8358.582070896553;8375.623096960773;8394.034686011188;8503.277221436247;11426.885731142582;11509.769804604028;11716.9454749073;11870.762584748429;11873.346965916957 17:33:25 INFO - PROCESS | 4487 | |3;mootools.html;1493.3653197391109;1551.4259723902155;1733.8699597530187;1801.936932207373;1848.4454663600916;7722.304992550669;8030.5181689098545;8405.705800296992;8577.656893724243;8985.73042808716;7563.92436075639;8679.69621063263;8787.12128787121;8797.912020879789;8801.691940782073;2344.5310937812465;2397.06514459361;2398.1726304425033;2400.939976500593;2414.6015907375263;2024.2611446821952;2353.49399879026;2361.9645705314433;2397.6403539469134;2404.3989002749313;2329.091654254842;2371;2373.4541055557233;2375.1330764271;2380.071772008918;2329.720433547985;2347.9647805282934;2350.976490235093;2367.5028244068767;2369.0642196332524;2332.288651961151;2358.2807243790635;2366.2428023032635;2370.466645004877;2373.6795532603223;8858.247049000842;8858.424202426822;8923.821523569557;8940.687075952375;8944.418612790212;5215.6609820361555;5351.464853514656;5359.1425371940695;5373.489518495737;5383.973080134574;3563.2873425314783;3584.372734771405;3621.8732344367822;3628.074840915576;3638.235970446183;1073.50618715391;1076.2197406880027;1079.8164312066967;1089.0198821061108;1109.1016276815806;11583.18917675763;11699.766004679945;11704.297742135414;11717.121215908755;11740.943315101596;4519.457665080211;4618.0994706032;4783.402074740658;4796.784144713496;4807.423109226916;9959.651412200537;10058.04448577384;10070.244731645156;10081;10085.798284034425;5260.842174734764;5307;5345.01117293302;5365.865853353697;5366.221897824794;4384.7369157850635;4638.536146385402;4843.830465933675;4847.95152048475;4891.5353041461;3862.3820188769664;3963.1875465529497;4018.7789671568344;4049.8862812726734;4097.282975479279;1094.7810437912449;1265.9493620255087;1286.530416398008;1292.4507084489055;1296.8962483001337;848.2196379331031;854.1543871567228;904.5070436612062;907.3195103672246;938.7559234599054;4714.834980775725;5610.803621873215;5815.617691206735;5900.996830538818;5958.612690175125;865.6104752861238;913.9497327647043;947.8104379124203;953.4851180362665;1004.6132239088004;3572.4284114541547;3873.070463088895;3993.6206060424215;4032.798360082043;4036;10433.426161561036;10849.240553161202;10866.619668311729;10884.496565789912;10914.126869850394;10181.134603558632;10619.787604247871;10650.467476626138;10721.785564288826;10805.297655652357;7986.321162701235;8218.876716849252;8226.670933162726;8239.340852731886;8277.793055173668;4594.655400844883;5664.235328230636;5664.773409063591;5738.971305143447;5787.681677507778;9290.95354523223;9333.206677432223;9413.011633778355;9419;9432.717018489457;8630.266427353745;8639.92000999875;9422.293328000564;9502.524873756423;9505.239580833655;7566.394688425023;7602.4298177638;7619.619019049136;7693.192214817587;7721.92278077212;8270.83458330842;8380.874286885579;8384.119667434832;8390.11903750122;8396.118407567117;6638.269790322964;7105.786826395217;7585.810354741176;7661.080670319598;7671.462997590115;7299.671514781741;7457.515261507984;7481.251874812475;7549.1695913448375;7576.924230757621;5991.7603295867675;6555.704993275219;6651.767188148391;7001.96499017522;7067.929320706727;4233.78831058452;4841.031793641357;4866.075445665312;4921.2864134700985;5012;4919.188333925005;4960.578350840219;5021.719461537431;5028.798848046037;5046.419661738947 17:33:25 INFO - PROCESS | 4487 | |4;prototype.html;296.80410928787006;302.19917219368676;311.66807350172064;314.9622045354558;315.7332054414021;5380.7309634518215;5504.284443022401;5657.547396208303;5713.285839270096;5727.455891690288;5492;5580.274564306645;5593.552515798737;5608;5614.494695477406;3841.6926645868402;3957.773090341989;4156.023334516386;4273.059926816096;4274.273373526493;3255.3977514159956;4050.6354428101463;4071.307877660805;4198.866306097352;4273.572642735717;4207.642350400204;4207.8539944628155;4228.386883901832;4229.661627069842;4230.259704551707;4187.864189263482;4218.493780746299;4227.619514243733;4239.215745087138;4251.87244382669;3165.6387753266085;3561.71506279497;3654.7624404413627;3663.688586470153;3666.8899933002053;4817.807287708488;5138.203578445309;5154.855538121743;5184.326037615086;5442.292501974757;4260.403543503912;4855.232517465046;4867.488913664085;4871.975640121812;4885.560299573055;4268.786560671954;5109;5906.586538942276;5949.1968584241;5949.25634295713;3645.890623281279;3666.983159262422;3920.666743326821;3969.186316805048;4034.3545032794905;5951.285845698544;6243.594166379171;6253.405926436982;6270.749170033193;6281.560290779647;3469.6356882527475;3756.8917169434535;4070.3487442009728;4072.7759973201164;4102.876913692594;3171.936561268808;3581.0331210573;3812.961870381316;4029.2545879012478;4144.730592511537;3874.6319099685484;4865.221564549726;4870.220764677705;4923.335349727741;4927.807125829044;5940.970295148497;5999.1803852189405;6003.369646187175;6050.878982420327;6054.458141986899;1262.9391311298552;1347.8449978252431;1401.3973991183889;1406.817113775223;1421.3177674715987;766.8880123820483;777.1567848884024;784.3450718649877;819.7376839411331;886.822635472908;4138.8344466221615;4498.640108791289;4518.028623845889;4624.884377890579;4661.160991021581;4249.5113061997645;5071.808125090601;5094.57351941457;5127;5130.410002849645;3992.401139829049;4429.224885645;4580.770961451981;4634.791434385461;4652.13851525157;2415.1064106280787;2420.076039548563;2573.562494375961;2702.3785728562707;2703.432279221346;4723.527647235318;4870.586000189953;4922.852314430573;5232.566856411787;5364.892702145935;4283.935740963826;4747.905041899143;4858.902821943541;5171.844844654666;5235.973820130875;5560.77756889728;5673.858153546194;5997.760089596454;6347.650879201688;6399.744010239631;6162;6165.84585385369;6178.034543419094;6205.5345849062405;6207.81376558704;5843.574916409642;5909.438603332676;5940.257467816523;5947.464728174485;6070.3929607038945;5122.538971492583;5803.622764520293;6344.809655710336;6415.71129299192;6425.261094974137;4012.4181993610177;4048.9797551012057;4060.5939406059156;4065.2072845794787;4073.246449406869;5908.7045647718305;5911.91132133027;6101.542384321105;6167.691615419121;6175.752969881154;4947.678400903929;5492.780288788564;5839;5880.176775251553;6009.45914867664;5217.452167522356;5796.710164491674;5963.463288304073;6000.159977603226;6019.244796610804;4963.429205641253;5673.517750991047;5736.569757268138;5818.458108601309;5850.561207909509;5151.201563757623;5976.970115149396;5982.371850955587;6029.1559181715475;6035.456808887221;4845.345878306383;5548.944510555004;5778.797742079007;5833.8249852502795;5850.561207909339 17:33:25 INFO - PROCESS | 4487 | |5;yui.html;696.7944456385366;721.2138768742067;753.3521171792254;757.3146302596152;827.5241736001799;15471;16003.199840008012;16048;16079.83920160798;16678.666426671458;15879.603009924758;15997.200139992983;16028.198590070479;16037.83962160378;16043.197840107978;848.0925409811504;872.4634349874813;877.2762470961451;879.3404946290283;880.5509190312954;676.7597502886454;853.8505761491746;861.7802460372596;864.2912811494577;878.7275944457207;791.2601717394226;931.2782593490032;931.9580618872167;935.8502639577669;938.3244064273712;903.421810041574;924.8289066522715;926.4256161180077;930.8696782450462;930.9813803723955;682.4403988729244;685.5064353665352;689.8413364926045;693.774523279931;694.6943344928216;15048;15308.923455382763;15335;15370.923145384313;15427.614309642237;14156.85843141576;14235.359408826627;14301.78547321791;14433.639159021004;14597.051191672508;12039.939800300943;12108.576199832964;12132.818007729891;12148;12300.384980751016;3817.8091095445116;3894.532656081288;3910.2179564087014;4029.49631296088;4041.595840415964;117039;117578;120673.99999999913;121342;122700.77299226983;9383.483908384967;11056.226064175431;11150.163737719704;11220.943895280634;11236.719082022852;18847.71728424075;22511.98696058681;22526.774732252794;22548.774512254666;22583.43541411445;6928.822100242971;7942.801429964182;8104.1085480597085;8128.309093726981;8246.917530824734;4506.459224893034;4507.2788353863225;4538.795754191069;4560.475545312332;4651.348811166439;3628.219932714479;3722.571904231048;3738.5887552369218;3745.0450135215347;3768.4724138620613;599.0116308091683;664.764008776887;674.0731494195481;674.6626686656672;682.0485422835217;612.9233845769279;629.5026928726346;683.1563019670702;700.6321681117454;710.435204012811;9215.53922303882;9283.303752218475;9284.814303714023;9850.064243896819;10042.899571004196;649.0264603095357;669.1969636436296;683.54885775388;685.5715178013742;686.9421091519005;5130.769115389817;5211.739413029333;5221.190715439113;5314.521693047567;5367.812126575551;135875;140095;142023;156843.43156568517;158257;110344.89655103507;124741.37629311795;129518.35240823736;132995;135250;113135;113324;115125;116813.83186168199;122133;9180.311476639145;9921.503924803876;10144.594216231268;10231.079202871777;10263.12763415118;61814.69092654508;62409.68795156177;63411.68294158499;63541.36458635354;64229;96126.51936740271;101622.49188754009;102610.48694756777;104483.95516044743;106957.46521267344;11004.79892123426;12799.232046077264;13285.86714132885;13446.058775885595;13591.52429664957;14953.700925981637;15117.848821512083;15134.621634459227;15331.003484773453;15471.381144754083;13808.240546770025;14029.649258768612;14030.969974838268;14103.576892692825;14681.412743490568;14013.649658758613;14260.572182834532;14272.857271427569;14290.714185716435;14474.059186152866;12196.390180490762;13601.863981360455;13955.930220348833;13959.860401395856;14215.715685686435;11263.943680281545;11275.210735248455;11277.379744114152;11495.252808567417;11942.701432464259;9781.462019588991;9851.655192068243;11497;11709.76580468403;11748.060155187735 17:33:25 INFO - PROCESS | 4487 | __end_tp_report 17:33:25 INFO - PROCESS | 4487 | __start_cc_report 17:33:25 INFO - PROCESS | 4487 | _x_x_mozilla_cycle_collect,411 17:33:25 INFO - PROCESS | 4487 | __end_cc_report 17:33:25 INFO - PROCESS | 4487 | __startTimestamp1470616405507__endTimestamp 17:33:25 INFO - PROCESS | 4487 | 17:33:25 INFO - PROCESS | 4487 | ------- Summary: start ------- 17:33:25 INFO - PROCESS | 4487 | Number of tests: 6 17:33:25 INFO - PROCESS | 4487 | 17:33:25 INFO - PROCESS | 4487 | [#0] dojo.html Cycles:165 Average:5733.63 Median:5941.17 stddev:666.15 (11.2%) stddev-sans-first:629.67 17:33:25 INFO - PROCESS | 4487 | Values: 2887.7 3429.1 3439.6 3452.2 3469.4 4812.6 5513.6 5789.2 5855.5 5941.4 5200.2 5787.2 5793.1 5858.8 5898.8 5195.0 5280.3 5289.8 5351.0 5378.9 5380.1 5417.6 5430.4 5432.8 5445.9 5176.1 5208.0 5242.9 5266.7 5292.0 5228.9 5233.2 5260.8 5302.4 5355.1 5227.1 5250.8 5255.1 5291.6 5296.5 5686.1 5750.6 5810.2 5844.6 5844.7 6217.3 6239.5 6245.6 6264.3 6288.4 6239.0 6244.3 6264.2 6273.5 6284.5 5542.3 5711.3 5713.9 5755.0 5763.0 5470.0 6240.9 6253.3 6262.8 6288.1 6076.9 6149.4 6151.1 6161.1 6166.7 4823.5 4985.0 5950.0 6225.0 6268.2 5264.6 5614.8 6221.5 6285.9 6289.1 6154.4 6257.4 6268.2 6268.2 6269.7 3907.6 4796.4 4914.3 4926.9 4946.0 4425.9 4484.3 4494.2 4502.9 4526.5 5830.9 5895.8 5902.2 5914.8 5918.2 6188.6 6193.1 6199.7 6215.1 6250.7 5918.1 5928.4 5929.8 5948.2 5971.3 5430.3 5436.5 5462.2 5480.4 5487.6 6176.8 6278.5 6290.1 6354.6 6380.9 5540.2 5941.2 6258.2 6279.0 6296.2 6306.4 6350.1 6352.5 6353.2 6361.5 6077.4 6162.2 6219.2 6230.4 6239.8 6225.8 6246.4 6284.1 6288.2 6291.7 4899.0 6216.4 6248.3 6254.7 6266.5 6094.3 6139.8 6149.3 6184.0 6236.0 4731.7 5924.6 6113.6 6131.7 6137.9 6160.0 6178.2 6214.8 6218.7 6254.2 5923.4 6035.9 6036.9 6045.8 6076.5 17:33:25 INFO - PROCESS | 4487 | 17:33:25 INFO - PROCESS | 4487 | [#1] ext.html Cycles:180 Average:65026.48 Median:38510.90 stddev:142760.00 (370.7%) stddev-sans-first:143078.29 17:33:25 INFO - PROCESS | 4487 | Values: 504.4 520.0 522.8 539.7 561.0 37845.0 40135.8 40154.6 40220.4 40279.8 41487.4 41669.6 41914.6 41931.0 41962.4 9547.2 9738.4 9759.1 9760.3 9781.1 8899.8 9245.8 9578.0 9664.7 9742.9 9730.6 9761.6 9761.9 9764.8 9779.0 9601.4 9696.0 9732.0 9743.1 9768.4 9659.9 9730.5 9775.4 9780.0 9807.0 39147.4 39365.8 39504.0 39607.2 39758.6 3036.9 3258.6 3275.9 3436.7 3454.0 23240.4 25470.4 29416.0 29978.1 31015.2 2724.4 3057.5 3090.0 3119.1 3161.1 397487.0 399220.0 402701.0 403559.0 403985.0 27485.2 32102.8 32340.8 32396.4 32398.0 29283.0 32592.0 34362.5 34720.8 35788.8 16325.9 16512.3 16614.8 16682.9 16702.6 12592.0 12671.7 12734.4 12738.2 12739.1 19051.5 19134.3 19164.3 19183.5 19304.6 7468.8 7976.8 8185.7 8259.3 8359.5 891.8 985.1 1008.3 1037.5 1109.3 30318.6 30494.8 30526.7 31151.8 31223.2 1043.8 1056.0 1071.2 1083.3 1103.4 15390.6 15511.2 15868.0 15987.2 16206.4 621348.0 621634.0 632156.0 633527.0 635064.0 57822.0 58148.1 58264.7 58575.0 58775.1 1322.5 1346.2 1363.6 1363.7 1370.5 29579.4 30035.7 30183.7 30264.8 30677.7 49123.0 49356.3 49836.3 49941.0 50005.2 543825.0 544797.0 547006.0 548347.0 549690.0 26370.3 26569.5 26916.1 27158.9 27753.7 46704.0 47819.5 48435.0 49189.3 49587.0 33631.0 34540.5 34806.1 39616.6 39877.6 38999.0 39244.4 39847.6 40394.8 40419.4 36956.3 37541.6 37831.0 38409.8 38612.0 34807.6 34842.1 34901.5 35310.8 35413.6 25897.0 26089.9 26431.0 26439.2 26587.6 17:33:25 INFO - PROCESS | 4487 | 17:33:25 INFO - PROCESS | 4487 | [#2] jquery.html Cycles:180 Average:35823.47 Median:22024.23 stddev:96578.72 (438.5%) stddev-sans-first:96812.89 17:33:25 INFO - PROCESS | 4487 | Values: 332.6 365.5 369.6 385.2 394.2 20504.3 20546.4 21075.7 21307.0 22035.3 9492.4 12204.8 12241.8 12257.9 15442.6 5389.7 5614.7 5625.6 5634.5 5635.8 3312.7 5648.0 6103.6 6918.3 6995.7 6852.9 7014.6 7034.5 7044.9 7050.6 6216.7 6269.9 6270.8 6287.7 6309.1 5237.9 6021.4 6043.8 6052.5 6069.9 13457.2 13586.3 17473.6 25223.4 26087.8 1995.9 2214.9 2257.5 2618.8 2776.8 10226.4 10325.7 10393.4 16037.0 16683.5 1696.7 1850.0 1897.0 2020.2 2028.3 100258.0 122951.8 140359.0 140484.0 142648.0 19187.2 20346.6 20952.6 22013.1 22154.6 35202.5 35202.8 35304.8 35394.6 35472.8 10745.4 10932.5 11068.7 11194.3 11201.9 6719.5 8958.1 8995.6 9221.0 9226.4 8526.0 9720.1 9938.4 10056.6 10081.7 1497.0 1527.7 1672.7 1677.1 3407.5 846.3 893.5 896.9 913.0 959.8 21141.0 21738.9 21897.0 21929.2 21938.6 892.3 923.7 974.5 994.7 1009.4 11091.7 11464.3 11504.6 11581.2 11654.0 564903.0 570942.0 572757.0 575838.0 597683.0 113347.4 120605.0 125214.0 126075.4 127793.0 985.7 1017.1 1031.5 1077.6 1078.6 19079.8 19592.6 19728.4 19834.0 19834.9 54809.6 55330.4 56042.4 56545.0 57527.7 84631.2 85780.3 85891.0 86074.3 86430.0 8119.2 8171.1 8406.0 8442.3 8466.1 11347.4 13260.5 13280.0 13672.2 13696.0 8532.0 11348.0 11853.0 11926.1 11953.6 10996.7 11163.6 11492.9 11495.9 11778.8 11601.0 11765.4 11810.9 11996.0 11996.3 8137.1 8358.6 8375.6 8394.0 8503.3 11426.9 11509.8 11716.9 11870.8 11873.3 17:33:25 INFO - PROCESS | 4487 | 17:33:25 INFO - PROCESS | 4487 | [#3] mootools.html Cycles:180 Average:5643.25 Median:4920.24 stddev:3143.30 (63.9%) stddev-sans-first:3136.65 17:33:25 INFO - PROCESS | 4487 | Values: 1493.4 1551.4 1733.9 1801.9 1848.4 7722.3 8030.5 8405.7 8577.7 8985.7 7563.9 8679.7 8787.1 8797.9 8801.7 2344.5 2397.1 2398.2 2400.9 2414.6 2024.3 2353.5 2362.0 2397.6 2404.4 2329.1 2371.0 2373.5 2375.1 2380.1 2329.7 2348.0 2351.0 2367.5 2369.1 2332.3 2358.3 2366.2 2370.5 2373.7 8858.2 8858.4 8923.8 8940.7 8944.4 5215.7 5351.5 5359.1 5373.5 5384.0 3563.3 3584.4 3621.9 3628.1 3638.2 1073.5 1076.2 1079.8 1089.0 1109.1 11583.2 11699.8 11704.3 11717.1 11740.9 4519.5 4618.1 4783.4 4796.8 4807.4 9959.7 10058.0 10070.2 10081.0 10085.8 5260.8 5307.0 5345.0 5365.9 5366.2 4384.7 4638.5 4843.8 4848.0 4891.5 3862.4 3963.2 4018.8 4049.9 4097.3 1094.8 1265.9 1286.5 1292.5 1296.9 848.2 854.2 904.5 907.3 938.8 4714.8 5610.8 5815.6 5901.0 5958.6 865.6 913.9 947.8 953.5 1004.6 3572.4 3873.1 3993.6 4032.8 4036.0 10433.4 10849.2 10866.6 10884.5 10914.1 10181.1 10619.8 10650.5 10721.8 10805.3 7986.3 8218.9 8226.7 8239.3 8277.8 4594.7 5664.2 5664.8 5739.0 5787.7 9291.0 9333.2 9413.0 9419.0 9432.7 8630.3 8639.9 9422.3 9502.5 9505.2 7566.4 7602.4 7619.6 7693.2 7721.9 8270.8 8380.9 8384.1 8390.1 8396.1 6638.3 7105.8 7585.8 7661.1 7671.5 7299.7 7457.5 7481.3 7549.2 7576.9 5991.8 6555.7 6651.8 7002.0 7067.9 4233.8 4841.0 4866.1 4921.3 5012.0 4919.2 4960.6 5021.7 5028.8 5046.4 17:33:25 INFO - PROCESS | 4487 | 17:33:25 INFO - PROCESS | 4487 | [#4] prototype.html Cycles:180 Average:4624.03 Median:4955.55 stddev:1479.73 (29.9%) stddev-sans-first:1447.80 17:33:25 INFO - PROCESS | 4487 | Values: 296.8 302.2 311.7 315.0 315.7 5380.7 5504.3 5657.5 5713.3 5727.5 5492.0 5580.3 5593.6 5608.0 5614.5 3841.7 3957.8 4156.0 4273.1 4274.3 3255.4 4050.6 4071.3 4198.9 4273.6 4207.6 4207.9 4228.4 4229.7 4230.3 4187.9 4218.5 4227.6 4239.2 4251.9 3165.6 3561.7 3654.8 3663.7 3666.9 4817.8 5138.2 5154.9 5184.3 5442.3 4260.4 4855.2 4867.5 4872.0 4885.6 4268.8 5109.0 5906.6 5949.2 5949.3 3645.9 3667.0 3920.7 3969.2 4034.4 5951.3 6243.6 6253.4 6270.7 6281.6 3469.6 3756.9 4070.3 4072.8 4102.9 3171.9 3581.0 3813.0 4029.3 4144.7 3874.6 4865.2 4870.2 4923.3 4927.8 5941.0 5999.2 6003.4 6050.9 6054.5 1262.9 1347.8 1401.4 1406.8 1421.3 766.9 777.2 784.3 819.7 886.8 4138.8 4498.6 4518.0 4624.9 4661.2 4249.5 5071.8 5094.6 5127.0 5130.4 3992.4 4429.2 4580.8 4634.8 4652.1 2415.1 2420.1 2573.6 2702.4 2703.4 4723.5 4870.6 4922.9 5232.6 5364.9 4283.9 4747.9 4858.9 5171.8 5236.0 5560.8 5673.9 5997.8 6347.7 6399.7 6162.0 6165.8 6178.0 6205.5 6207.8 5843.6 5909.4 5940.3 5947.5 6070.4 5122.5 5803.6 6344.8 6415.7 6425.3 4012.4 4049.0 4060.6 4065.2 4073.2 5908.7 5911.9 6101.5 6167.7 6175.8 4947.7 5492.8 5839.0 5880.2 6009.5 5217.5 5796.7 5963.5 6000.2 6019.2 4963.4 5673.5 5736.6 5818.5 5850.6 5151.2 5977.0 5982.4 6029.2 6035.5 4845.3 5548.9 5778.8 5833.8 5850.6 17:33:25 INFO - PROCESS | 4487 | 17:33:25 INFO - PROCESS | 4487 | [#5] yui.html Cycles:180 Average:25700.49 Median:20679.85 stddev:40768.91 (197.1%) stddev-sans-first:40840.06 17:33:25 INFO - PROCESS | 4487 | Values: 696.8 721.2 753.4 757.3 827.5 15471.0 16003.2 16048.0 16079.8 16678.7 15879.6 15997.2 16028.2 16037.8 16043.2 848.1 872.5 877.3 879.3 880.6 676.8 853.9 861.8 864.3 878.7 791.3 931.3 932.0 935.9 938.3 903.4 924.8 926.4 930.9 931.0 682.4 685.5 689.8 693.8 694.7 15048.0 15308.9 15335.0 15370.9 15427.6 14156.9 14235.4 14301.8 14433.6 14597.1 12039.9 12108.6 12132.8 12148.0 12300.4 3817.8 3894.5 3910.2 4029.5 4041.6 117039.0 117578.0 120674.0 121342.0 122700.8 9383.5 11056.2 11150.2 11220.9 11236.7 18847.7 22512.0 22526.8 22548.8 22583.4 6928.8 7942.8 8104.1 8128.3 8246.9 4506.5 4507.3 4538.8 4560.5 4651.3 3628.2 3722.6 3738.6 3745.0 3768.5 599.0 664.8 674.1 674.7 682.0 612.9 629.5 683.2 700.6 710.4 9215.5 9283.3 9284.8 9850.1 10042.9 649.0 669.2 683.5 685.6 686.9 5130.8 5211.7 5221.2 5314.5 5367.8 135875.0 140095.0 142023.0 156843.4 158257.0 110344.9 124741.4 129518.4 132995.0 135250.0 113135.0 113324.0 115125.0 116813.8 122133.0 9180.3 9921.5 10144.6 10231.1 10263.1 61814.7 62409.7 63411.7 63541.4 64229.0 96126.5 101622.5 102610.5 104484.0 106957.5 11004.8 12799.2 13285.9 13446.1 13591.5 14953.7 15117.8 15134.6 15331.0 15471.4 13808.2 14029.6 14031.0 14103.6 14681.4 14013.6 14260.6 14272.9 14290.7 14474.1 12196.4 13601.9 13955.9 13959.9 14215.7 11263.9 11275.2 11277.4 11495.3 11942.7 9781.5 9851.7 11497.0 11709.8 11748.1 17:33:25 INFO - PROCESS | 4487 | -------- Summary: end -------- 17:33:25 INFO - PROCESS | 4487 | 17:33:26 INFO - TEST-INFO | 4487: exit 0 17:33:26 INFO - TEST-OK | dromaeo_css | took 1113858ms 17:33:26 INFO - TEST-START | kraken 17:33:26 INFO - operating with platform_type : mac_ 17:33:26 INFO - Initialising browser for kraken test... 17:33:26 INFO - TEST-INFO | started process 4603 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmppsHBm5/profile http://localhost:52773/getInfo.html) 17:33:28 INFO - PROCESS | 4603 | __metrics Screen width/height:1600/1200 17:33:28 INFO - PROCESS | 4603 | colorDepth:24 17:33:28 INFO - PROCESS | 4603 | Browser inner width/height: 1024/689 17:33:28 INFO - PROCESS | 4603 | __metrics 17:33:28 ERROR - PROCESS | 4603 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 17:33:29 INFO - TEST-INFO | 4603: exit 0 17:33:29 INFO - Browser initialized. 17:33:29 INFO - Running cycle 1/1 for kraken test... 17:33:29 INFO - TEST-INFO | started process 4605 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmppsHBm5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:33:41 INFO - PROCESS | 4605 | RSS: Main: 254631936 17:33:41 INFO - PROCESS | 4605 | 17:33:44 INFO - PROCESS | 4605 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52773/tests/kraken/driver.html?testName=audio-beat-detection) 17:33:45 INFO - PROCESS | 4605 | RSS: Main: 267485184 17:33:45 INFO - PROCESS | 4605 | 17:33:48 INFO - PROCESS | 4605 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52773/tests/kraken/driver.html?testName=audio-dft) 17:33:48 INFO - PROCESS | 4605 | RSS: Main: 276123648 17:33:48 INFO - PROCESS | 4605 | 17:33:52 INFO - PROCESS | 4605 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52773/tests/kraken/driver.html?testName=audio-fft) 17:33:53 INFO - PROCESS | 4605 | RSS: Main: 279162880 17:33:53 INFO - PROCESS | 4605 | 17:33:55 INFO - PROCESS | 4605 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52773/tests/kraken/driver.html?testName=audio-oscillator) 17:33:55 INFO - PROCESS | 4605 | RSS: Main: 280399872 17:33:55 INFO - PROCESS | 4605 | 17:33:57 INFO - PROCESS | 4605 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52773/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:33:58 INFO - PROCESS | 4605 | RSS: Main: 280739840 17:33:58 INFO - PROCESS | 4605 | 17:34:01 INFO - PROCESS | 4605 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52773/tests/kraken/driver.html?testName=imaging-darkroom) 17:34:02 INFO - PROCESS | 4605 | RSS: Main: 281989120 17:34:02 INFO - PROCESS | 4605 | 17:34:05 INFO - PROCESS | 4605 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52773/tests/kraken/driver.html?testName=imaging-desaturate) 17:34:05 INFO - PROCESS | 4605 | RSS: Main: 282365952 17:34:05 INFO - PROCESS | 4605 | 17:34:08 INFO - PROCESS | 4605 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52773/tests/kraken/driver.html?testName=json-parse-financial) 17:34:09 INFO - PROCESS | 4605 | RSS: Main: 282329088 17:34:09 INFO - PROCESS | 4605 | 17:34:11 INFO - PROCESS | 4605 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52773/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:34:11 INFO - PROCESS | 4605 | RSS: Main: 282103808 17:34:11 INFO - PROCESS | 4605 | 17:34:13 INFO - PROCESS | 4605 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52773/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:34:14 INFO - PROCESS | 4605 | RSS: Main: 282185728 17:34:14 INFO - PROCESS | 4605 | 17:34:16 INFO - PROCESS | 4605 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52773/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:34:17 INFO - PROCESS | 4605 | RSS: Main: 282542080 17:34:17 INFO - PROCESS | 4605 | 17:34:20 INFO - PROCESS | 4605 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52773/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:34:20 INFO - PROCESS | 4605 | RSS: Main: 282615808 17:34:20 INFO - PROCESS | 4605 | 17:34:23 INFO - PROCESS | 4605 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52773/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:34:24 INFO - PROCESS | 4605 | RSS: Main: 282574848 17:34:24 INFO - PROCESS | 4605 | 17:34:25 INFO - PROCESS | 4605 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52773/tests/kraken/driver.html?testName=ai-astar) 17:34:26 INFO - PROCESS | 4605 | RSS: Main: 283672576 17:34:26 INFO - PROCESS | 4605 | 17:34:26 INFO - PROCESS | 4605 | __start_tp_report 17:34:26 INFO - PROCESS | 4605 | _x_x_mozilla_page_load 17:34:26 INFO - PROCESS | 4605 | _x_x_mozilla_page_load_details 17:34:26 INFO - PROCESS | 4605 | |i|pagename|runs| 17:34:26 INFO - PROCESS | 4605 | |0;ai-astar;130;171;87;165;114;172;165;129;122;116 17:34:26 INFO - PROCESS | 4605 | |1;audio-beat-detection;144;111;135;170;125;163;141;110;169;109 17:34:26 INFO - PROCESS | 4605 | |2;audio-dft;205;242;226;277;240;233;253;194;197;204 17:34:26 INFO - PROCESS | 4605 | |3;audio-fft;72;79;76;150;51;71;87;90;126;84 17:34:26 INFO - PROCESS | 4605 | |4;audio-oscillator;69;72;113;71;71;73;113;82;101;114 17:34:26 INFO - PROCESS | 4605 | |5;imaging-gaussian-blur;137;126;124;88;99;130;90;86;90;86 17:34:26 INFO - PROCESS | 4605 | |6;imaging-darkroom;105;95;113;144;96;143;153;105;102;95 17:34:26 INFO - PROCESS | 4605 | |7;imaging-desaturate;92;94;107;90;146;143;118;89;91;94 17:34:26 INFO - PROCESS | 4605 | |8;json-parse-financial;57;55;57;56;57;56;55;56;57;55 17:34:26 INFO - PROCESS | 4605 | |9;json-stringify-tinderbox;56;79;104;110;111;88;76;74;72;71 17:34:26 INFO - PROCESS | 4605 | |10;stanford-crypto-aes;77;89;106;106;81;86;88;83;87;84 17:34:26 INFO - PROCESS | 4605 | |11;stanford-crypto-ccm;138;137;143;151;146;137;140;142;155;150 17:34:26 INFO - PROCESS | 4605 | |12;stanford-crypto-pbkdf2;168;165;167;168;169;163;165;166;165;166 17:34:26 INFO - PROCESS | 4605 | |13;stanford-crypto-sha256-iterative;66;68;67;70;69;65;67;68;68;66 17:34:26 INFO - PROCESS | 4605 | __end_tp_report 17:34:26 INFO - PROCESS | 4605 | __start_cc_report 17:34:26 INFO - PROCESS | 4605 | _x_x_mozilla_cycle_collect,1041 17:34:26 INFO - PROCESS | 4605 | __end_cc_report 17:34:26 INFO - PROCESS | 4605 | __startTimestamp1470616466118__endTimestamp 17:34:26 INFO - PROCESS | 4605 | 17:34:26 INFO - PROCESS | 4605 | ------- Summary: start ------- 17:34:26 INFO - PROCESS | 4605 | Number of tests: 14 17:34:26 INFO - PROCESS | 4605 | 17:34:26 INFO - PROCESS | 4605 | [#0] ai-astar Cycles:10 Average:137.10 Median:165.00 stddev:29.36 (17.8%) stddev-sans-first:31.03 17:34:26 INFO - PROCESS | 4605 | Values: 130.0 171.0 87.0 165.0 114.0 172.0 165.0 129.0 122.0 116.0 17:34:26 INFO - PROCESS | 4605 | 17:34:26 INFO - PROCESS | 4605 | [#1] audio-beat-detection Cycles:10 Average:137.70 Median:142.50 stddev:24.00 (16.8%) stddev-sans-first:25.35 17:34:26 INFO - PROCESS | 4605 | Values: 144.0 111.0 135.0 170.0 125.0 163.0 141.0 110.0 169.0 109.0 17:34:26 INFO - PROCESS | 4605 | 17:34:26 INFO - PROCESS | 4605 | [#2] audio-dft Cycles:10 Average:227.10 Median:236.50 stddev:27.10 (11.5%) stddev-sans-first:27.54 17:34:26 INFO - PROCESS | 4605 | Values: 205.0 242.0 226.0 277.0 240.0 233.0 253.0 194.0 197.0 204.0 17:34:26 INFO - PROCESS | 4605 | 17:34:26 INFO - PROCESS | 4605 | [#3] audio-fft Cycles:10 Average:88.60 Median:77.50 stddev:28.76 (37.1%) stddev-sans-first:29.87 17:34:26 INFO - PROCESS | 4605 | Values: 72.0 79.0 76.0 150.0 51.0 71.0 87.0 90.0 126.0 84.0 17:34:26 INFO - PROCESS | 4605 | 17:34:26 INFO - PROCESS | 4605 | [#4] audio-oscillator Cycles:10 Average:87.90 Median:71.00 stddev:19.86 (28.0%) stddev-sans-first:19.86 17:34:26 INFO - PROCESS | 4605 | Values: 69.0 72.0 113.0 71.0 71.0 73.0 113.0 82.0 101.0 114.0 17:34:26 INFO - PROCESS | 4605 | 17:34:26 INFO - PROCESS | 4605 | [#5] imaging-gaussian-blur Cycles:10 Average:105.60 Median:87.00 stddev:20.93 (24.1%) stddev-sans-first:18.87 17:34:26 INFO - PROCESS | 4605 | Values: 137.0 126.0 124.0 88.0 99.0 130.0 90.0 86.0 90.0 86.0 17:34:26 INFO - PROCESS | 4605 | 17:34:26 INFO - PROCESS | 4605 | [#6] imaging-darkroom Cycles:10 Average:115.10 Median:148.50 stddev:22.61 (15.2%) stddev-sans-first:23.69 17:34:26 INFO - PROCESS | 4605 | Values: 105.0 95.0 113.0 144.0 96.0 143.0 153.0 105.0 102.0 95.0 17:34:26 INFO - PROCESS | 4605 | 17:34:26 INFO - PROCESS | 4605 | [#7] imaging-desaturate Cycles:10 Average:106.40 Median:90.50 stddev:22.03 (24.3%) stddev-sans-first:22.74 17:34:26 INFO - PROCESS | 4605 | Values: 92.0 94.0 107.0 90.0 146.0 143.0 118.0 89.0 91.0 94.0 17:34:26 INFO - PROCESS | 4605 | 17:34:26 INFO - PROCESS | 4605 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.50 stddev:0.88 (1.5%) stddev-sans-first:0.87 17:34:26 INFO - PROCESS | 4605 | Values: 57.0 55.0 57.0 56.0 57.0 56.0 55.0 56.0 57.0 55.0 17:34:26 INFO - PROCESS | 4605 | 17:34:26 INFO - PROCESS | 4605 | [#9] json-stringify-tinderbox Cycles:10 Average:84.10 Median:73.00 stddev:18.58 (25.5%) stddev-sans-first:16.69 17:34:26 INFO - PROCESS | 4605 | Values: 56.0 79.0 104.0 110.0 111.0 88.0 76.0 74.0 72.0 71.0 17:34:26 INFO - PROCESS | 4605 | 17:34:26 INFO - PROCESS | 4605 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:85.00 stddev:9.78 (11.5%) stddev-sans-first:9.41 17:34:26 INFO - PROCESS | 4605 | Values: 77.0 89.0 106.0 106.0 81.0 86.0 88.0 83.0 87.0 84.0 17:34:26 INFO - PROCESS | 4605 | 17:34:26 INFO - PROCESS | 4605 | [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:144.50 stddev:6.37 (4.4%) stddev-sans-first:6.39 17:34:26 INFO - PROCESS | 4605 | Values: 138.0 137.0 143.0 151.0 146.0 137.0 140.0 142.0 155.0 150.0 17:34:26 INFO - PROCESS | 4605 | 17:34:26 INFO - PROCESS | 4605 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.20 Median:166.50 stddev:1.81 (1.1%) stddev-sans-first:1.80 17:34:26 INFO - PROCESS | 4605 | Values: 168.0 165.0 167.0 168.0 169.0 163.0 165.0 166.0 165.0 166.0 17:34:26 INFO - PROCESS | 4605 | 17:34:26 INFO - PROCESS | 4605 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:1.51 (2.2%) stddev-sans-first:1.51 17:34:26 INFO - PROCESS | 4605 | Values: 66.0 68.0 67.0 70.0 69.0 65.0 67.0 68.0 68.0 66.0 17:34:26 INFO - PROCESS | 4605 | -------- Summary: end -------- 17:34:26 INFO - PROCESS | 4605 | 17:34:26 INFO - TEST-INFO | 4605: exit 0 17:34:26 INFO - TEST-OK | kraken | took 60853ms 17:34:26 INFO - SUITE-END | took 1174s 17:34:27 INFO - Completed test suite (00:19:35) 17:34:27 INFO - javascript benchmark 17:34:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7460.992244435086, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2887.682354940956, 3429.1427143214196, 3439.587249530055, 3452.1887356471225, 3469.4102002659547, 4812.566868981791, 5513.62159460135, 5789.2184555085105, 5855.47300742933, 5941.4058594140615, 5200.193969934666, 5787.189793428924, 5793.073108302672, 5858.7949421770245, 5898.764049438028, 5194.974025129888, 5280.313559237313, 5289.761960711778, 5350.973245133769, 5378.8924221515545, 5380.085385484477, 5417.59368047396, 5430.3755068167275, 5432.837014889559, 5445.945540544583, 5176.094183517869, 5207.98444303361, 5242.895142097137, 5266.683998960056, 5292.0, 5228.895422091537, 5233.1888557273305, 5260.789568417297, 5302.390225124122, 5355.089634762061, 5227.137522308853, 5250.763715632767, 5255.08036093682, 5291.603129765283, 5296.523312901819, 5686.118651609007, 5750.626209296424, 5810.1865738796605, 5844.620099693507, 5844.707764611795, 6217.285012223607, 6239.532035097341, 6245.594036387665, 6264.3422440643535, 6288.371162883721, 6239.032949892774, 6244.281907580641, 6264.1543391642, 6273.498120150422, 6284.528660350492, 5542.2795036644975, 5711.314642242916, 5713.857153571194, 5754.971225143931, 5763.049096899007, 5470.0, 6240.875182496416, 6253.343398943137, 6262.780802671976, 6288.119663247149, 6076.908846367308, 6149.385061493905, 6151.0773383992755, 6161.106639537242, 6166.660833654102, 4823.517648235148, 4984.950150498521, 5950.018246989285, 6224.968875155595, 6268.153799237045, 5264.631475796734, 5614.775408983676, 6221.502279817604, 6285.8742825143245, 6289.119523266746, 6154.383339568525, 6257.374262573797, 6268.153799237136, 6268.185135932391, 6269.65516896566, 3907.648311651908, 4796.352492413549, 4914.33656456381, 4926.901461970812, 4945.950540494549, 4425.933610995838, 4484.282514797616, 4494.191045611821, 4502.887427814266, 4526.456825181, 5830.941690583039, 5895.793647222413, 5902.173695682608, 5914.763409463573, 5918.201042859159, 6188.566800323934, 6193.071039344134, 6199.690015499207, 6215.098810672517, 6250.749850030013, 5918.082697181943, 5928.407159284037, 5929.822105336847, 5948.167256584082, 5971.343152253248, 5430.321209848769, 5436.537894278951, 5462.20797984298, 5480.369757477862, 5487.5609951203805, 6176.81469555914, 6278.497720182283, 6290.056491526308, 6354.555181137369, 6380.9361906380345, 5540.168974653834, 5941.168236446987, 6258.249010118815, 6279.0, 6296.244450665949, 6306.369363063657, 6350.079238510482, 6352.523560733056, 6353.205849268841, 6361.522885783677, 6077.361877002851, 6162.22972128484, 6219.222597175353, 6230.376962303914, 6239.7504099837315, 6225.8132256032395, 6246.437820596168, 6284.120223168851, 6288.213973253343, 6291.653959032297, 4898.951010489849, 6216.378362163748, 6248.250209974651, 6254.749810007549, 6266.498680105489, 6094.329623741473, 6139.815805525842, 6149.292831324455, 6184.041473571604, 6235.971064774261, 4731.69243999139, 5924.585279030426, 6113.602615829956, 6131.687037415961, 6137.8979746733885, 6160.0, 6178.196834411498, 6214.8135555933395, 6218.720157593009, 6254.155688981929, 5923.4076592340425, 6035.939640603713, 6036.9094463582205, 6045.78839740607, 6076.453119219114], "value": 5693.072293101306, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [504.3569448952585, 519.9662021968571, 522.8039485193052, 539.6600141910595, 560.985975350616, 37845.0, 40135.79932100335, 40154.594589189386, 40220.396694049574, 40279.791606251856, 41487.37768933461, 41669.58330416695, 41914.580854191525, 41931.0, 41962.37056444156, 9547.188488978445, 9738.367006144614, 9759.121679048883, 9760.2679799015, 9781.070798274153, 8899.798527198811, 9245.815083698355, 9578.0, 9664.661736839213, 9742.902570974271, 9730.562124704406, 9761.560729767178, 9761.902380976206, 9764.804703905918, 9778.951105244463, 9601.37591056579, 9695.951520242388, 9731.95134024329, 9743.074407931306, 9768.413895166314, 9659.855102173473, 9730.513474326255, 9775.364601300893, 9780.021997800235, 9807.0, 39147.41278880819, 39365.80317098425, 39504.0, 39607.207855842724, 39758.60241397607, 3036.880665590463, 3258.560094387251, 3275.894716909678, 3436.7078798302173, 3454.0072973391398, 23240.418989525228, 25470.36324091894, 29416.0, 29978.100656980107, 31015.22461938447, 2724.3870129220963, 3057.5260834570454, 3090.0, 3119.142235885127, 3161.0832858471017, 397487.0, 399220.0, 402701.0, 403559.0, 403985.0, 27485.17544473669, 32102.839485802888, 32340.83829580884, 32396.35207295841, 32398.0, 29282.97509587154, 32592.0, 34362.48456273158, 34720.82639586786, 35788.82105589456, 16325.938813977053, 16512.25694843735, 16614.83385166133, 16682.916585416995, 16702.58243543897, 12592.0, 12671.683207919876, 12734.426950787052, 12738.235705857678, 12739.108262421541, 19051.523711907037, 19134.330298439487, 19164.329248476235, 19183.52041198981, 19304.613907722047, 7468.813279668052, 7976.760697179094, 8185.71350002747, 8259.256666900008, 8359.456635318686, 891.8171774786153, 985.103555764251, 1008.2740426892625, 1037.455335948633, 1109.3454861631676, 30318.61906956662, 30494.84752576223, 30526.69473305283, 31151.84424077865, 31223.219419514695, 1043.832986722136, 1055.9577616895237, 1071.196602548089, 1083.3283364314018, 1103.382106020631, 15390.615234619225, 15511.224438778016, 15868.0, 15987.200639967956, 16206.432774852823, 621348.0, 621634.0, 632156.0, 633527.0, 635064.0, 57822.0, 58148.12777808336, 58264.70867645634, 58575.0, 58775.11837322444, 1322.543722415765, 1346.2124657075524, 1363.638635761524, 1363.7136201397618, 1370.465518447806, 29579.408411831213, 30035.699643004165, 30183.672044137547, 30264.848675757363, 30677.693223067483, 49123.0, 49356.27253046126, 49836.25245621246, 49941.0, 50005.249921250484, 543825.0, 544797.0, 547006.0, 548347.0, 549690.0, 26370.34074148085, 26569.468610627293, 26916.05793797286, 27158.864205678845, 27753.722462775113, 46704.0, 47819.52180478151, 48435.0, 49189.26216106833, 49587.0, 33631.0, 34540.48189277213, 34806.12984675403, 39616.60383396129, 39877.601223988546, 38999.02502437462, 39244.41133382944, 39847.60152398439, 40394.79802600968, 40419.39370909498, 36956.26087478289, 37541.624583753815, 37831.0, 38409.807950960065, 38612.0, 34807.59211016003, 34842.12894677653, 34901.476477852346, 35310.823445882605, 35413.64586354104, 25896.964121434932, 26089.869550652886, 26431.0, 26439.206823795317, 26587.601185982614], "value": 19195.048289438764, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.6457322951057, 365.51751687772145, 369.5712972951375, 385.1680370399937, 394.1584716629998, 20504.282350117748, 20546.38360849175, 21075.683864742023, 21307.0, 22035.338939831792, 9492.430454172738, 12204.755904881897, 12241.816372754416, 12257.938710306458, 15442.61393465164, 5389.73051347433, 5614.66312021278, 5625.634333768312, 5634.549236061105, 5635.830925072254, 3312.73498120151, 5648.0, 6103.572749907508, 6918.273581273969, 6995.65021748913, 6852.897206541906, 7014.649267536628, 7034.472414568928, 7044.894326585106, 7050.5769653820935, 6216.689165541728, 6269.937300626981, 6270.78052268173, 6287.717052732615, 6309.053641953721, 5237.921431178535, 6021.36775638556, 6043.8186854394435, 6052.485538729214, 6069.878602427927, 13457.192568445924, 13586.320683965761, 17473.563160920952, 25223.36941576457, 26087.826047827893, 1995.8902260375673, 2214.933551993443, 2257.5372048730137, 2618.764311211981, 2776.8195067320557, 10226.386416815016, 10325.741856453573, 10393.428361440117, 16037.0, 16683.49949501517, 1696.686113069086, 1850.00099946029, 1896.9661534463612, 2020.2121172742643, 2028.3103744726716, 100258.0, 122951.77048229493, 140359.0, 140484.0, 142648.0, 19187.232510699694, 20346.593068138554, 20952.58094838125, 22013.11947522113, 22154.556908862054, 35202.47196292058, 35202.823985880415, 35304.82347588297, 35394.58421663156, 35472.82263588717, 10745.355278683304, 10932.508037138348, 11068.723281918017, 11194.328340299608, 11201.943990279997, 6719.496037797185, 8958.148975847284, 8995.55022248885, 9220.953895230481, 9226.35415520907, 8526.0, 9720.07659272368, 9938.409854423258, 10056.64801731936, 10081.69754907354, 1497.0119720984317, 1527.6709262941313, 1672.7240005398974, 1677.1362748184695, 3407.539982102434, 846.289117141604, 893.4594570285014, 896.8565029595234, 912.9589168487435, 959.788846453779, 21141.04865281066, 21738.91305434722, 21897.0, 21929.23247686323, 21938.561228775336, 892.2683399612256, 923.6536298887917, 974.4591751577942, 994.7413672445216, 1009.414539567064, 11091.72270693239, 11464.25482343645, 11504.597339093092, 11581.247218930912, 11654.0, 564903.0, 570942.0, 572757.0, 575838.0, 597683.0, 113347.43326283316, 120605.0, 125214.0, 126075.36962315314, 127793.0, 985.7437066362797, 1017.110028724851, 1031.4584842957506, 1077.617445806743, 1078.6440474643348, 19079.809201907803, 19592.608147837247, 19728.408147755592, 19834.0, 19834.90908000074, 54809.629759256335, 55330.44669553414, 56042.43957560536, 56545.0, 57527.71236143792, 84631.15368846232, 85780.28439431301, 85891.0, 86074.27851443061, 86430.0, 8119.188081191834, 8171.142030086993, 8405.957970210355, 8442.282405995558, 8466.06873243955, 11347.432628368384, 13260.53588124411, 13280.0, 13672.17966921948, 13696.0, 8531.95734021326, 11348.03541698965, 11852.992495637967, 11926.105542084204, 11953.581624643095, 10996.725081873017, 11163.553457861595, 11492.94253528727, 11495.885041149815, 11778.76442471163, 11601.0, 11765.352905590275, 11810.881891180978, 11995.980341671057, 11996.340201289013, 8137.104918458846, 8358.582070896553, 8375.623096960773, 8394.034686011188, 8503.277221436247, 11426.885731142582, 11509.769804604028, 11716.9454749073, 11870.762584748429, 11873.346965916957], "value": 10362.995415822961, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1493.3653197391109, 1551.4259723902155, 1733.8699597530187, 1801.936932207373, 1848.4454663600916, 7722.304992550669, 8030.5181689098545, 8405.705800296992, 8577.656893724243, 8985.73042808716, 7563.92436075639, 8679.69621063263, 8787.12128787121, 8797.912020879789, 8801.691940782073, 2344.5310937812465, 2397.06514459361, 2398.1726304425033, 2400.939976500593, 2414.6015907375263, 2024.2611446821952, 2353.49399879026, 2361.9645705314433, 2397.6403539469134, 2404.3989002749313, 2329.091654254842, 2371.0, 2373.4541055557233, 2375.1330764271, 2380.071772008918, 2329.720433547985, 2347.9647805282934, 2350.976490235093, 2367.5028244068767, 2369.0642196332524, 2332.288651961151, 2358.2807243790635, 2366.2428023032635, 2370.466645004877, 2373.6795532603223, 8858.247049000842, 8858.424202426822, 8923.821523569557, 8940.687075952375, 8944.418612790212, 5215.6609820361555, 5351.464853514656, 5359.1425371940695, 5373.489518495737, 5383.973080134574, 3563.2873425314783, 3584.372734771405, 3621.8732344367822, 3628.074840915576, 3638.235970446183, 1073.50618715391, 1076.2197406880027, 1079.8164312066967, 1089.0198821061108, 1109.1016276815806, 11583.18917675763, 11699.766004679945, 11704.297742135414, 11717.121215908755, 11740.943315101596, 4519.457665080211, 4618.0994706032, 4783.402074740658, 4796.784144713496, 4807.423109226916, 9959.651412200537, 10058.04448577384, 10070.244731645156, 10081.0, 10085.798284034425, 5260.842174734764, 5307.0, 5345.01117293302, 5365.865853353697, 5366.221897824794, 4384.7369157850635, 4638.536146385402, 4843.830465933675, 4847.95152048475, 4891.5353041461, 3862.3820188769664, 3963.1875465529497, 4018.7789671568344, 4049.8862812726734, 4097.282975479279, 1094.7810437912449, 1265.9493620255087, 1286.530416398008, 1292.4507084489055, 1296.8962483001337, 848.2196379331031, 854.1543871567228, 904.5070436612062, 907.3195103672246, 938.7559234599054, 4714.834980775725, 5610.803621873215, 5815.617691206735, 5900.996830538818, 5958.612690175125, 865.6104752861238, 913.9497327647043, 947.8104379124203, 953.4851180362665, 1004.6132239088004, 3572.4284114541547, 3873.070463088895, 3993.6206060424215, 4032.798360082043, 4036.0, 10433.426161561036, 10849.240553161202, 10866.619668311729, 10884.496565789912, 10914.126869850394, 10181.134603558632, 10619.787604247871, 10650.467476626138, 10721.785564288826, 10805.297655652357, 7986.321162701235, 8218.876716849252, 8226.670933162726, 8239.340852731886, 8277.793055173668, 4594.655400844883, 5664.235328230636, 5664.773409063591, 5738.971305143447, 5787.681677507778, 9290.95354523223, 9333.206677432223, 9413.011633778355, 9419.0, 9432.717018489457, 8630.266427353745, 8639.92000999875, 9422.293328000564, 9502.524873756423, 9505.239580833655, 7566.394688425023, 7602.4298177638, 7619.619019049136, 7693.192214817587, 7721.92278077212, 8270.83458330842, 8380.874286885579, 8384.119667434832, 8390.11903750122, 8396.118407567117, 6638.269790322964, 7105.786826395217, 7585.810354741176, 7661.080670319598, 7671.462997590115, 7299.671514781741, 7457.515261507984, 7481.251874812475, 7549.1695913448375, 7576.924230757621, 5991.7603295867675, 6555.704993275219, 6651.767188148391, 7001.96499017522, 7067.929320706727, 4233.78831058452, 4841.031793641357, 4866.075445665312, 4921.2864134700985, 5012.0, 4919.188333925005, 4960.578350840219, 5021.719461537431, 5028.798848046037, 5046.419661738947], "value": 4553.749337610159, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.80410928787006, 302.19917219368676, 311.66807350172064, 314.9622045354558, 315.7332054414021, 5380.7309634518215, 5504.284443022401, 5657.547396208303, 5713.285839270096, 5727.455891690288, 5492.0, 5580.274564306645, 5593.552515798737, 5608.0, 5614.494695477406, 3841.6926645868402, 3957.773090341989, 4156.023334516386, 4273.059926816096, 4274.273373526493, 3255.3977514159956, 4050.6354428101463, 4071.307877660805, 4198.866306097352, 4273.572642735717, 4207.642350400204, 4207.8539944628155, 4228.386883901832, 4229.661627069842, 4230.259704551707, 4187.864189263482, 4218.493780746299, 4227.619514243733, 4239.215745087138, 4251.87244382669, 3165.6387753266085, 3561.71506279497, 3654.7624404413627, 3663.688586470153, 3666.8899933002053, 4817.807287708488, 5138.203578445309, 5154.855538121743, 5184.326037615086, 5442.292501974757, 4260.403543503912, 4855.232517465046, 4867.488913664085, 4871.975640121812, 4885.560299573055, 4268.786560671954, 5109.0, 5906.586538942276, 5949.1968584241, 5949.25634295713, 3645.890623281279, 3666.983159262422, 3920.666743326821, 3969.186316805048, 4034.3545032794905, 5951.285845698544, 6243.594166379171, 6253.405926436982, 6270.749170033193, 6281.560290779647, 3469.6356882527475, 3756.8917169434535, 4070.3487442009728, 4072.7759973201164, 4102.876913692594, 3171.936561268808, 3581.0331210573, 3812.961870381316, 4029.2545879012478, 4144.730592511537, 3874.6319099685484, 4865.221564549726, 4870.220764677705, 4923.335349727741, 4927.807125829044, 5940.970295148497, 5999.1803852189405, 6003.369646187175, 6050.878982420327, 6054.458141986899, 1262.9391311298552, 1347.8449978252431, 1401.3973991183889, 1406.817113775223, 1421.3177674715987, 766.8880123820483, 777.1567848884024, 784.3450718649877, 819.7376839411331, 886.822635472908, 4138.8344466221615, 4498.640108791289, 4518.028623845889, 4624.884377890579, 4661.160991021581, 4249.5113061997645, 5071.808125090601, 5094.57351941457, 5127.0, 5130.410002849645, 3992.401139829049, 4429.224885645, 4580.770961451981, 4634.791434385461, 4652.13851525157, 2415.1064106280787, 2420.076039548563, 2573.562494375961, 2702.3785728562707, 2703.432279221346, 4723.527647235318, 4870.586000189953, 4922.852314430573, 5232.566856411787, 5364.892702145935, 4283.935740963826, 4747.905041899143, 4858.902821943541, 5171.844844654666, 5235.973820130875, 5560.77756889728, 5673.858153546194, 5997.760089596454, 6347.650879201688, 6399.744010239631, 6162.0, 6165.84585385369, 6178.034543419094, 6205.5345849062405, 6207.81376558704, 5843.574916409642, 5909.438603332676, 5940.257467816523, 5947.464728174485, 6070.3929607038945, 5122.538971492583, 5803.622764520293, 6344.809655710336, 6415.71129299192, 6425.261094974137, 4012.4181993610177, 4048.9797551012057, 4060.5939406059156, 4065.2072845794787, 4073.246449406869, 5908.7045647718305, 5911.91132133027, 6101.542384321105, 6167.691615419121, 6175.752969881154, 4947.678400903929, 5492.780288788564, 5839.0, 5880.176775251553, 6009.45914867664, 5217.452167522356, 5796.710164491674, 5963.463288304073, 6000.159977603226, 6019.244796610804, 4963.429205641253, 5673.517750991047, 5736.569757268138, 5818.458108601309, 5850.561207909509, 5151.201563757623, 5976.970115149396, 5982.371850955587, 6029.1559181715475, 6035.456808887221, 4845.345878306383, 5548.944510555004, 5778.797742079007, 5833.8249852502795, 5850.561207909339], "value": 4145.762418260726, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.7944456385366, 721.2138768742067, 753.3521171792254, 757.3146302596152, 827.5241736001799, 15471.0, 16003.199840008012, 16048.0, 16079.83920160798, 16678.666426671458, 15879.603009924758, 15997.200139992983, 16028.198590070479, 16037.83962160378, 16043.197840107978, 848.0925409811504, 872.4634349874813, 877.2762470961451, 879.3404946290283, 880.5509190312954, 676.7597502886454, 853.8505761491746, 861.7802460372596, 864.2912811494577, 878.7275944457207, 791.2601717394226, 931.2782593490032, 931.9580618872167, 935.8502639577669, 938.3244064273712, 903.421810041574, 924.8289066522715, 926.4256161180077, 930.8696782450462, 930.9813803723955, 682.4403988729244, 685.5064353665352, 689.8413364926045, 693.774523279931, 694.6943344928216, 15048.0, 15308.923455382763, 15335.0, 15370.923145384313, 15427.614309642237, 14156.85843141576, 14235.359408826627, 14301.78547321791, 14433.639159021004, 14597.051191672508, 12039.939800300943, 12108.576199832964, 12132.818007729891, 12148.0, 12300.384980751016, 3817.8091095445116, 3894.532656081288, 3910.2179564087014, 4029.49631296088, 4041.595840415964, 117039.0, 117578.0, 120673.99999999913, 121342.0, 122700.77299226983, 9383.483908384967, 11056.226064175431, 11150.163737719704, 11220.943895280634, 11236.719082022852, 18847.71728424075, 22511.98696058681, 22526.774732252794, 22548.774512254666, 22583.43541411445, 6928.822100242971, 7942.801429964182, 8104.1085480597085, 8128.309093726981, 8246.917530824734, 4506.459224893034, 4507.2788353863225, 4538.795754191069, 4560.475545312332, 4651.348811166439, 3628.219932714479, 3722.571904231048, 3738.5887552369218, 3745.0450135215347, 3768.4724138620613, 599.0116308091683, 664.764008776887, 674.0731494195481, 674.6626686656672, 682.0485422835217, 612.9233845769279, 629.5026928726346, 683.1563019670702, 700.6321681117454, 710.435204012811, 9215.53922303882, 9283.303752218475, 9284.814303714023, 9850.064243896819, 10042.899571004196, 649.0264603095357, 669.1969636436296, 683.54885775388, 685.5715178013742, 686.9421091519005, 5130.769115389817, 5211.739413029333, 5221.190715439113, 5314.521693047567, 5367.812126575551, 135875.0, 140095.0, 142023.0, 156843.43156568517, 158257.0, 110344.89655103507, 124741.37629311795, 129518.35240823736, 132995.0, 135250.0, 113135.0, 113324.0, 115125.0, 116813.83186168199, 122133.0, 9180.311476639145, 9921.503924803876, 10144.594216231268, 10231.079202871777, 10263.12763415118, 61814.69092654508, 62409.68795156177, 63411.68294158499, 63541.36458635354, 64229.0, 96126.51936740271, 101622.49188754009, 102610.48694756777, 104483.95516044743, 106957.46521267344, 11004.79892123426, 12799.232046077264, 13285.86714132885, 13446.058775885595, 13591.52429664957, 14953.700925981637, 15117.848821512083, 15134.621634459227, 15331.003484773453, 15471.381144754083, 13808.240546770025, 14029.649258768612, 14030.969974838268, 14103.576892692825, 14681.412743490568, 14013.649658758613, 14260.572182834532, 14272.857271427569, 14290.714185716435, 14474.059186152866, 12196.390180490762, 13601.863981360455, 13955.930220348833, 13959.860401395856, 14215.715685686435, 11263.943680281545, 11275.210735248455, 11277.379744114152, 11495.252808567417, 11942.701432464259, 9781.462019588991, 9851.655192068243, 11497.0, 11709.76580468403, 11748.060155187735], "value": 8067.505547878312, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1611.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 171.0, 87.0, 165.0, 114.0, 172.0, 165.0, 129.0, 122.0, 116.0], "value": 137.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 111.0, 135.0, 170.0, 125.0, 163.0, 141.0, 110.0, 169.0, 109.0], "value": 137.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 242.0, 226.0, 277.0, 240.0, 233.0, 253.0, 194.0, 197.0, 204.0], "value": 227.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 79.0, 76.0, 150.0, 51.0, 71.0, 87.0, 90.0, 126.0, 84.0], "value": 88.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 113.0, 71.0, 71.0, 73.0, 113.0, 82.0, 101.0, 114.0], "value": 87.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 126.0, 124.0, 88.0, 99.0, 130.0, 90.0, 86.0, 90.0, 86.0], "value": 105.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 95.0, 113.0, 144.0, 96.0, 143.0, 153.0, 105.0, 102.0, 95.0], "value": 115.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 107.0, 90.0, 146.0, 143.0, 118.0, 89.0, 91.0, 94.0], "value": 106.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 57.0, 56.0, 57.0, 56.0, 55.0, 56.0, 57.0, 55.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 79.0, 104.0, 110.0, 111.0, 88.0, 76.0, 74.0, 72.0, 71.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 89.0, 106.0, 106.0, 81.0, 86.0, 88.0, 83.0, 87.0, 84.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 143.0, 151.0, 146.0, 137.0, 140.0, 142.0, 155.0, 150.0], "value": 143.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 167.0, 168.0, 169.0, 163.0, 165.0, 166.0, 165.0, 166.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 70.0, 69.0, 65.0, 67.0, 68.0, 68.0, 66.0], "value": 67.4, "unit": "score"}]}]} 17:34:27 INFO - Return code: 0 17:34:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:34:27 ERROR - # TBPL SUCCESS # 17:34:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:34:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:34:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:34:27 INFO - 2016-08-07 17:34:27.439 screenresolution[4616:40291] starting screenresolution argv=screenresolution get 17:34:27 INFO - 2016-08-07 17:34:27.442 screenresolution[4616:40291] Display 0: 1600x1200x32@60 17:34:27 INFO - 2016-08-07 17:34:27.448 screenresolution[4617:40294] starting screenresolution argv=screenresolution list 17:34:27 INFO - Available Modes on Display 0 17:34:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:34:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:34:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:34:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:34:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:34:27 INFO - Intel Iris: 17:34:27 INFO - Chipset Model: Intel Iris 17:34:27 INFO - Type: GPU 17:34:27 INFO - Bus: Built-In 17:34:27 INFO - VRAM (Dynamic, Max): 1536 MB 17:34:27 INFO - Vendor: Intel (0x8086) 17:34:27 INFO - Device ID: 0x0a2e 17:34:27 INFO - Revision ID: 0x0009 17:34:27 INFO - Displays: 17:34:27 INFO - Display: 17:34:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:34:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:34:27 INFO - Display Serial Number: 1600x1200 60 17:34:27 INFO - Main Display: Yes 17:34:27 INFO - Mirror: Off 17:34:27 INFO - Online: Yes 17:34:27 INFO - Rotation: Supported 17:34:27 INFO - Return code: 0 17:34:27 INFO - Running post-action listener: _resource_record_post_action 17:34:27 INFO - [mozharness: 2016-08-08 00:34:27.684230Z] Finished run-tests step (success) 17:34:27 INFO - Running post-run listener: _resource_record_post_run 17:34:27 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 348160; Write bytes: 707635712; Read time: 1; Write time: 2033 17:34:27 INFO - TinderboxPrint: CPU usage
54.4% 17:34:27 INFO - TinderboxPrint: I/O read bytes / time
348,160 / 1 17:34:27 INFO - TinderboxPrint: I/O write bytes / time
707,635,712 / 2,033 17:34:27 INFO - TinderboxPrint: CPU idle
2,203.8 (45.6%) 17:34:27 INFO - TinderboxPrint: CPU system
979.5 (20.2%) 17:34:27 INFO - TinderboxPrint: CPU user
1,654.2 (34.2%) 17:34:27 INFO - TinderboxPrint: Swap in / out
406,560,768 / 0 17:34:27 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 404451840; Write bytes: 400267264; Read time: 29794; Write time: 885 17:34:27 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 348160; Write bytes: 295514624; Read time: 1; Write time: 1112 17:34:28 INFO - Running post-run listener: _upload_blobber_files 17:34:28 INFO - Blob upload gear active. 17:34:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:34:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:34:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:34:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:34:28 INFO - (blobuploader) - INFO - Open directory for files ... 17:34:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:34:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:34:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:34:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:34:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:34:29 INFO - (blobuploader) - INFO - Done attempting. 17:34:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:34:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:34:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:34:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:34:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:34:30 INFO - (blobuploader) - INFO - Done attempting. 17:34:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:34:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:34:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:34:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:34:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:34:32 INFO - (blobuploader) - INFO - Done attempting. 17:34:32 INFO - (blobuploader) - INFO - Iteration through files over. 17:34:32 INFO - Return code: 0 17:34:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:34:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:34:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0672c5bf63be0fa7576e50b1fe88c827c62979c800b6ec4a8f27b8af0998a6a45bc9fa7b3f3826e6819f7060603e039bd940b1534afd24affed68c5fd7d02ef2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/103be5e6412abba446ca33910dc883c176c00602de7037318c806fb4d7edf921bc4c4fe83ec23c42c58479735ff99f62791945a05d444b0838f7d49a0bb1a7b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ccf46f29d690edfc0aa019f001261a4d3c61fc7e53c706c448e3fdc3fe2c40f9d42ebaccb3577be3d48d81d7c06027d8d44fd1c458c8a7a4a5227a5d446306e"} 17:34:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:34:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:34:32 INFO - Contents: 17:34:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0672c5bf63be0fa7576e50b1fe88c827c62979c800b6ec4a8f27b8af0998a6a45bc9fa7b3f3826e6819f7060603e039bd940b1534afd24affed68c5fd7d02ef2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/103be5e6412abba446ca33910dc883c176c00602de7037318c806fb4d7edf921bc4c4fe83ec23c42c58479735ff99f62791945a05d444b0838f7d49a0bb1a7b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ccf46f29d690edfc0aa019f001261a4d3c61fc7e53c706c448e3fdc3fe2c40f9d42ebaccb3577be3d48d81d7c06027d8d44fd1c458c8a7a4a5227a5d446306e"} 17:34:32 INFO - Running post-run listener: copy_logs_to_upload_dir 17:34:32 INFO - Copying logs to upload dir... 17:34:32 INFO - mkdir: /builds/slave/test/build/upload/logs 17:34:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.815307 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-08-07 17:34:32.895395) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 17:34:32.898940) ========= 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.dlIisPMRRz/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.U0nsP0ZL84/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0672c5bf63be0fa7576e50b1fe88c827c62979c800b6ec4a8f27b8af0998a6a45bc9fa7b3f3826e6819f7060603e039bd940b1534afd24affed68c5fd7d02ef2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/103be5e6412abba446ca33910dc883c176c00602de7037318c806fb4d7edf921bc4c4fe83ec23c42c58479735ff99f62791945a05d444b0838f7d49a0bb1a7b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ccf46f29d690edfc0aa019f001261a4d3c61fc7e53c706c448e3fdc3fe2c40f9d42ebaccb3577be3d48d81d7c06027d8d44fd1c458c8a7a4a5227a5d446306e"} build_url:https://queue.taskcluster.net/v1/task/dHBm4sInQSeE2juCQKFmQw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011047 build_url: 'https://queue.taskcluster.net/v1/task/dHBm4sInQSeE2juCQKFmQw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0672c5bf63be0fa7576e50b1fe88c827c62979c800b6ec4a8f27b8af0998a6a45bc9fa7b3f3826e6819f7060603e039bd940b1534afd24affed68c5fd7d02ef2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/103be5e6412abba446ca33910dc883c176c00602de7037318c806fb4d7edf921bc4c4fe83ec23c42c58479735ff99f62791945a05d444b0838f7d49a0bb1a7b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ccf46f29d690edfc0aa019f001261a4d3c61fc7e53c706c448e3fdc3fe2c40f9d42ebaccb3577be3d48d81d7c06027d8d44fd1c458c8a7a4a5227a5d446306e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 17:34:32.931544) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 17:34:32.931892) ========= 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.dlIisPMRRz/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.U0nsP0ZL84/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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.005303 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 17:34:32.980575) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 17:34:32.980907) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 17:34:32.981290) ========= ========= Total master_lag: 0.18 =========