builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0238 starttime: 1470429501.49 results: success (0) buildid: 20160805121521 builduid: 0c4f2336ea8f47e4934e1bef141791c2 revision: e648eb9685a0416aa2468412402d03fc5c347362 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 13:38:21.488422) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 13:38:21.489040) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 13:38:21.489328) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 13:38:21.513796) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 13:38:21.514124) ========= 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.GjfDHzaGuZ/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.0KCYaPGb1s/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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-05 13:38:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.5M=0.001s 2016-08-05 13:38:21 (19.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123644 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 13:38:21.660268) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 13:38:21.660613) ========= 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.GjfDHzaGuZ/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.0KCYaPGb1s/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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.025587 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 13:38:21.709011) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 13:38:21.709366) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev e648eb9685a0416aa2468412402d03fc5c347362 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev e648eb9685a0416aa2468412402d03fc5c347362 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GjfDHzaGuZ/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.0KCYaPGb1s/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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-05 13:38:21,790 truncating revision to first 12 chars 2016-08-05 13:38:21,790 Setting DEBUG logging. 2016-08-05 13:38:21,790 attempt 1/10 2016-08-05 13:38:21,790 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/e648eb9685a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-05 13:38:23,143 unpacking tar archive at: autoland-e648eb9685a0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.607442 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 13:38:23.338750) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 13:38:23.339096) ========= script_repo_revision: e648eb9685a0416aa2468412402d03fc5c347362 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 13:38:23.339487) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 13:38:23.339762) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 13:38:23.358645) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-05 13:38:23.359071) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GjfDHzaGuZ/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.0KCYaPGb1s/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 13:38:23 INFO - MultiFileLogger online at 20160805 13:38:23 in /builds/slave/test 13:38:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 13:38:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:38:23 INFO - {'append_to_log': False, 13:38:23 INFO - 'base_work_dir': '/builds/slave/test', 13:38:23 INFO - 'blob_upload_branch': 'Autoland', 13:38:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:38:23 INFO - 'branch': 'Autoland', 13:38:23 INFO - 'buildbot_json_path': 'buildprops.json', 13:38:23 INFO - 'config_files': ('talos/mac_config.py',), 13:38:23 INFO - 'default_actions': ('clobber', 13:38:23 INFO - 'read-buildbot-config', 13:38:23 INFO - 'download-and-extract', 13:38:23 INFO - 'populate-webroot', 13:38:23 INFO - 'create-virtualenv', 13:38:23 INFO - 'install', 13:38:23 INFO - 'run-tests'), 13:38:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:38:23 INFO - 'download_minidump_stackwalk': True, 13:38:23 INFO - 'download_symbols': 'ondemand', 13:38:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:38:23 INFO - 'tooltool.py': '/tools/tooltool.py', 13:38:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:38:23 INFO - '/tools/misc-python/virtualenv.py')}, 13:38:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:38:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:38:23 INFO - 'installer_path': 'installer.exe', 13:38:23 INFO - 'log_level': 'info', 13:38:23 INFO - 'log_name': 'talos', 13:38:23 INFO - 'log_to_console': True, 13:38:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:38:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:38:23 INFO - 'opt_config_files': (), 13:38:23 INFO - 'pip_index': False, 13:38:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:38:23 INFO - 'cmd': ('bash', 13:38:23 INFO - '-c', 13:38:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:38:23 INFO - 'enabled': True, 13:38:23 INFO - 'halt_on_failure': False, 13:38:23 INFO - 'name': 'check_screen_resolution'},), 13:38:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:38:23 INFO - 'cmd': ('bash', 13:38:23 INFO - '-c', 13:38:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:38:23 INFO - 'enabled': True, 13:38:23 INFO - 'halt_on_failure': False, 13:38:23 INFO - 'name': 'check_screen_resolution'},), 13:38:23 INFO - 'run_cmd_checks_enabled': True, 13:38:23 INFO - 'sps_profile': False, 13:38:23 INFO - 'sps_profile_interval': 0, 13:38:23 INFO - 'suite': 'dromaeojs-e10s', 13:38:23 INFO - 'system_bits': '32', 13:38:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:38:23 INFO - 'title': 't-yosemite-r7-0238', 13:38:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:38:23 INFO - 'use_talos_json': True, 13:38:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:38:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:38:23 INFO - 'work_dir': 'build'} 13:38:23 INFO - [mozharness: 2016-08-05 20:38:23.549960Z] Running clobber step. 13:38:23 INFO - Running pre-action listener: _resource_record_pre_action 13:38:23 INFO - Running main action method: clobber 13:38:23 INFO - rmtree: /builds/slave/test/build 13:38:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:38:25 INFO - Running post-action listener: _resource_record_post_action 13:38:25 INFO - [mozharness: 2016-08-05 20:38:25.638523Z] Finished clobber step (success) 13:38:25 INFO - [mozharness: 2016-08-05 20:38:25.638659Z] Running read-buildbot-config step. 13:38:25 INFO - Running pre-action listener: _resource_record_pre_action 13:38:25 INFO - Running main action method: read_buildbot_config 13:38:25 INFO - Using buildbot properties: 13:38:25 INFO - { 13:38:25 INFO - "project": "", 13:38:25 INFO - "product": "firefox", 13:38:25 INFO - "script_repo_revision": "production", 13:38:25 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 13:38:25 INFO - "repository": "", 13:38:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 13:38:25 INFO - "buildid": "20160805121521", 13:38:25 INFO - "pgo_build": "False", 13:38:25 INFO - "basedir": "/builds/slave/test", 13:38:25 INFO - "buildnumber": 61, 13:38:25 INFO - "slavename": "t-yosemite-r7-0238", 13:38:25 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 13:38:25 INFO - "platform": "yosemite_r7", 13:38:25 INFO - "scheduler": "tests-autoland-macosx64-talos", 13:38:25 INFO - "branch": "autoland", 13:38:25 INFO - "repo_path": "integration/autoland", 13:38:25 INFO - "revision": "e648eb9685a0416aa2468412402d03fc5c347362", 13:38:25 INFO - "stage_platform": "macosx64", 13:38:25 INFO - "builduid": "0c4f2336ea8f47e4934e1bef141791c2", 13:38:25 INFO - "slavebuilddir": "test" 13:38:25 INFO - } 13:38:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/c7SUe_zNSkS7iCtqMgK0uA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 13:38:25 INFO - Running post-action listener: _resource_record_post_action 13:38:25 INFO - [mozharness: 2016-08-05 20:38:25.641810Z] Finished read-buildbot-config step (success) 13:38:25 INFO - [mozharness: 2016-08-05 20:38:25.641928Z] Running download-and-extract step. 13:38:25 INFO - Running pre-action listener: _resource_record_pre_action 13:38:25 INFO - Running main action method: download_and_extract 13:38:25 INFO - mkdir: /builds/slave/test/build/tests 13:38:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:38:25 INFO - trying https://queue.taskcluster.net/v1/task/c7SUe_zNSkS7iCtqMgK0uA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 13:38:25 INFO - Downloading https://queue.taskcluster.net/v1/task/c7SUe_zNSkS7iCtqMgK0uA/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 13:38:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c7SUe_zNSkS7iCtqMgK0uA/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 13:38:26 INFO - Downloaded 1199 bytes. 13:38:26 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 13:38:26 INFO - Using the following test package requirements: 13:38:26 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 13:38:26 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:38:26 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 13:38:26 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:38:26 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 13:38:26 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:38:26 INFO - u'jsshell-mac.zip'], 13:38:26 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:38:26 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 13:38:26 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 13:38:26 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:38:26 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 13:38:26 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:38:26 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 13:38:26 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:38:26 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 13:38:26 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:38:26 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 13:38:26 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:38:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:38:26 INFO - trying https://queue.taskcluster.net/v1/task/c7SUe_zNSkS7iCtqMgK0uA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 13:38:26 INFO - Downloading https://queue.taskcluster.net/v1/task/c7SUe_zNSkS7iCtqMgK0uA/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 13:38:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c7SUe_zNSkS7iCtqMgK0uA/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 13:38:27 INFO - Downloaded 16320595 bytes. 13:38:27 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 13:38:34 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 13:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:38:34 INFO - trying https://queue.taskcluster.net/v1/task/c7SUe_zNSkS7iCtqMgK0uA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 13:38:34 INFO - Downloading https://queue.taskcluster.net/v1/task/c7SUe_zNSkS7iCtqMgK0uA/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 13:38:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c7SUe_zNSkS7iCtqMgK0uA/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 13:38:35 INFO - Downloaded 16320595 bytes. 13:38:35 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 13:38:41 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')]} 13:38:41 INFO - trying https://queue.taskcluster.net/v1/task/c7SUe_zNSkS7iCtqMgK0uA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 13:38:41 INFO - Downloading https://queue.taskcluster.net/v1/task/c7SUe_zNSkS7iCtqMgK0uA/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 13:38:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c7SUe_zNSkS7iCtqMgK0uA/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 13:38:42 INFO - Downloaded 14413723 bytes. 13:38:42 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 13:38: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')]} 13:38:43 INFO - trying https://queue.taskcluster.net/v1/task/c7SUe_zNSkS7iCtqMgK0uA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:38:43 INFO - Downloading https://queue.taskcluster.net/v1/task/c7SUe_zNSkS7iCtqMgK0uA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 13:38:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c7SUe_zNSkS7iCtqMgK0uA/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 13:38:46 INFO - Downloaded 111433979 bytes. 13:38:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c7SUe_zNSkS7iCtqMgK0uA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:38:46 INFO - mkdir: /builds/slave/test/properties 13:38:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:38:46 INFO - Writing to file /builds/slave/test/properties/build_url 13:38:46 INFO - Contents: 13:38:46 INFO - build_url:https://queue.taskcluster.net/v1/task/c7SUe_zNSkS7iCtqMgK0uA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:38:47 INFO - Running post-action listener: _resource_record_post_action 13:38:47 INFO - Running post-action listener: set_extra_try_arguments 13:38:47 INFO - [mozharness: 2016-08-05 20:38:47.487917Z] Finished download-and-extract step (success) 13:38:47 INFO - [mozharness: 2016-08-05 20:38:47.488040Z] Running populate-webroot step. 13:38:47 INFO - Running pre-action listener: _resource_record_pre_action 13:38:47 INFO - Running main action method: populate_webroot 13:38:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:38:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:38:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:38:47 INFO - '--tppagecycles', 13:38:47 INFO - '7'], 13:38:47 INFO - 'tests': ['tsvgm']}}, 13:38:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:38:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:38:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:38:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:38:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:38:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:38:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:47 INFO - 'talos_options': ['--disable-e10s'], 13:38:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:38:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:38:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:47 INFO - 'talos_options': ['--disable-e10s'], 13:38:47 INFO - 'tests': ['damp', 'tps']}, 13:38:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:47 INFO - 'tests': ['damp', 'tps']}, 13:38:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:38:47 INFO - 'tests': ['dromaeo_dom']}, 13:38:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:38:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:38:47 INFO - 'tests': ['basic_compositor_video']}, 13:38:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:38:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:38:47 INFO - 'tests': ['a11yr', 13:38:47 INFO - 'ts_paint', 13:38:47 INFO - 'tpaint', 13:38:47 INFO - 'sessionrestore', 13:38:47 INFO - 'sessionrestore_no_auto_restore', 13:38:47 INFO - 'tabpaint']}, 13:38:47 INFO - 'other-e10s': {'tests': ['a11yr', 13:38:47 INFO - 'ts_paint', 13:38:47 INFO - 'tpaint', 13:38:47 INFO - 'sessionrestore', 13:38:47 INFO - 'sessionrestore_no_auto_restore', 13:38:47 INFO - 'tabpaint']}, 13:38:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:38:47 INFO - 'ts_paint', 13:38:47 INFO - 'tpaint', 13:38:47 INFO - 'sessionrestore', 13:38:47 INFO - 'sessionrestore_no_auto_restore', 13:38:47 INFO - 'tabpaint']}, 13:38:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:38:47 INFO - 'ts_paint', 13:38:47 INFO - 'tpaint', 13:38:47 INFO - 'sessionrestore', 13:38:47 INFO - 'sessionrestore_no_auto_restore', 13:38:47 INFO - 'tabpaint']}, 13:38:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:38:47 INFO - 'tests': ['a11yr', 13:38:47 INFO - 'ts_paint', 13:38:47 INFO - 'tpaint', 13:38:47 INFO - 'sessionrestore', 13:38:47 INFO - 'sessionrestore_no_auto_restore', 13:38:47 INFO - 'tabpaint']}, 13:38:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:38:47 INFO - 'tests': ['a11yr', 13:38:47 INFO - 'ts_paint', 13:38:47 INFO - 'tpaint', 13:38:47 INFO - 'sessionrestore', 13:38:47 INFO - 'sessionrestore_no_auto_restore', 13:38:47 INFO - 'tabpaint']}, 13:38:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:38:47 INFO - 'tests': ['tsvgx', 13:38:47 INFO - 'tsvgr_opacity', 13:38:47 INFO - 'tart', 13:38:47 INFO - 'tscrollx', 13:38:47 INFO - 'cart']}, 13:38:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:38:47 INFO - 'tsvgr_opacity', 13:38:47 INFO - 'tart', 13:38:47 INFO - 'tscrollx', 13:38:47 INFO - 'cart']}, 13:38:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:47 INFO - 'talos_options': ['--disable-e10s'], 13:38:47 INFO - 'tests': ['tp5o']}, 13:38:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:47 INFO - 'tests': ['tp5o']}, 13:38:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:47 INFO - 'talos_options': ['--disable-e10s', 13:38:47 INFO - '--xperf_path', 13:38:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:38:47 INFO - 'tests': ['tp5n']}, 13:38:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:47 INFO - 'talos_options': ['--xperf_path', 13:38:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:38:47 INFO - 'tests': ['tp5n']}}, 13:38:47 INFO - 'talos.zip': {'path': '', 13:38:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:38:47 INFO - Running post-action listener: _resource_record_post_action 13:38:47 INFO - [mozharness: 2016-08-05 20:38:47.505539Z] Finished populate-webroot step (success) 13:38:47 INFO - [mozharness: 2016-08-05 20:38:47.505654Z] Running create-virtualenv step. 13:38:47 INFO - Running pre-action listener: _resource_record_pre_action 13:38:47 INFO - Running main action method: create_virtualenv 13:38:47 INFO - Creating virtualenv /builds/slave/test/build/venv 13:38:47 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 13:38:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:38:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:38:47 INFO - Using real prefix '/tools/python27' 13:38:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:38:48 INFO - Installing distribute.............................................................................................................................................................................................done. 13:38:51 INFO - Installing pip.................done. 13:38:51 INFO - Return code: 0 13:38:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:38: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')]} 13:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38: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')]} 13:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca04a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca99618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae634c10c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c968d30>, '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 0x10c6cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c960b20>, '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.GjfDHzaGuZ/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.0KCYaPGb1s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 13:38: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', 'pip>=1.5'] in /builds/slave/test/build 13:38: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 pip>=1.5 13:38:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GjfDHzaGuZ/Render', 13:38:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:38:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:38:51 INFO - 'HOME': '/Users/cltbld', 13:38:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:38:51 INFO - 'LOGNAME': 'cltbld', 13:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:51 INFO - 'MOZ_NO_REMOTE': '1', 13:38:51 INFO - 'NO_EM_RESTART': '1', 13:38:51 INFO - 'PAGER': '/bin/cat', 13:38:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:51 INFO - 'PWD': '/builds/slave/test', 13:38:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:38:51 INFO - 'SHELL': '/bin/bash', 13:38:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0KCYaPGb1s/Listeners', 13:38:51 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 13:38:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:38:51 INFO - 'USER': 'cltbld', 13:38:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:38:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:51 INFO - 'XPC_FLAGS': '0x0', 13:38:51 INFO - 'XPC_SERVICE_NAME': '0', 13:38:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:38:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38: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 13:38:51 INFO - Cleaning up... 13:38:51 INFO - Return code: 0 13:38:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:38: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')]} 13:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38: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')]} 13:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38: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 0x10ca04a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca99618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae634c10c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c968d30>, '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 0x10c6cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c960b20>, '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.GjfDHzaGuZ/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.0KCYaPGb1s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 13:38: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 13:38: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 13:38:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GjfDHzaGuZ/Render', 13:38:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:38:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:38:51 INFO - 'HOME': '/Users/cltbld', 13:38:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:38:51 INFO - 'LOGNAME': 'cltbld', 13:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:51 INFO - 'MOZ_NO_REMOTE': '1', 13:38:51 INFO - 'NO_EM_RESTART': '1', 13:38:51 INFO - 'PAGER': '/bin/cat', 13:38:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:51 INFO - 'PWD': '/builds/slave/test', 13:38:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:38:51 INFO - 'SHELL': '/bin/bash', 13:38:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0KCYaPGb1s/Listeners', 13:38:51 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 13:38:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:38:51 INFO - 'USER': 'cltbld', 13:38:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:38:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:51 INFO - 'XPC_FLAGS': '0x0', 13:38:51 INFO - 'XPC_SERVICE_NAME': '0', 13:38:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:38:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:51 INFO - Downloading/unpacking psutil>=3.1.1 13:38: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 13:38: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 13:38: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 13:38: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 13:38: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 13:38: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 13:38:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:38:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:38:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:38:54 INFO - Installing collected packages: psutil 13:38:54 INFO - Running setup.py install for psutil 13:38:54 INFO - building 'psutil._psutil_osx' extension 13:38: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 13:38: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 13:38: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 13:38: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 13:38:55 INFO - building 'psutil._psutil_posix' extension 13:38: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 13:38:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:38:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:38:55 INFO - ^ 13:38:55 INFO - 1 warning generated. 13:38: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 13:38:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:38:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:38:55 INFO - Successfully installed psutil 13:38:55 INFO - Cleaning up... 13:38:55 INFO - Return code: 0 13:38:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:38: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')]} 13:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38: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')]} 13:38:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38: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 0x10ca04a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca99618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae634c10c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c968d30>, '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 0x10c6cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c960b20>, '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.GjfDHzaGuZ/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.0KCYaPGb1s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 13:38: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 13:38: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 13:38:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GjfDHzaGuZ/Render', 13:38:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:38:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:38:55 INFO - 'HOME': '/Users/cltbld', 13:38:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:38:55 INFO - 'LOGNAME': 'cltbld', 13:38:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:55 INFO - 'MOZ_NO_REMOTE': '1', 13:38:55 INFO - 'NO_EM_RESTART': '1', 13:38:55 INFO - 'PAGER': '/bin/cat', 13:38:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:38:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:55 INFO - 'PWD': '/builds/slave/test', 13:38:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:38:55 INFO - 'SHELL': '/bin/bash', 13:38:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0KCYaPGb1s/Listeners', 13:38:55 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 13:38:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:38:55 INFO - 'USER': 'cltbld', 13:38:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:38:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:38:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:55 INFO - 'XPC_FLAGS': '0x0', 13:38:55 INFO - 'XPC_SERVICE_NAME': '0', 13:38:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:38:56 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 13:38:56 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 13:38:56 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 13:38:56 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 13:38:56 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 13:38:56 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 13:38:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:38:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:38:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:38:58 INFO - Installing collected packages: mozsystemmonitor 13:38:58 INFO - Running setup.py install for mozsystemmonitor 13:38:58 INFO - Successfully installed mozsystemmonitor 13:38:58 INFO - Cleaning up... 13:38:58 INFO - Return code: 0 13:38:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:38: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')]} 13:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38: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')]} 13:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38: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 0x10ca04a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca99618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae634c10c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c968d30>, '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 0x10c6cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c960b20>, '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.GjfDHzaGuZ/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.0KCYaPGb1s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 13:38: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 13:38: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 13:38:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GjfDHzaGuZ/Render', 13:38:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:38:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:38:58 INFO - 'HOME': '/Users/cltbld', 13:38:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:38:58 INFO - 'LOGNAME': 'cltbld', 13:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:58 INFO - 'MOZ_NO_REMOTE': '1', 13:38:58 INFO - 'NO_EM_RESTART': '1', 13:38:58 INFO - 'PAGER': '/bin/cat', 13:38:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:58 INFO - 'PWD': '/builds/slave/test', 13:38:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:38:58 INFO - 'SHELL': '/bin/bash', 13:38:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0KCYaPGb1s/Listeners', 13:38:58 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 13:38:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:38:58 INFO - 'USER': 'cltbld', 13:38:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:38:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:58 INFO - 'XPC_FLAGS': '0x0', 13:38:58 INFO - 'XPC_SERVICE_NAME': '0', 13:38:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:59 INFO - Downloading/unpacking jsonschema==2.5.1 13:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:39:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39:01 INFO - Downloading functools32-3.2.3-2.tar.gz 13:39:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:39:02 INFO - warning: no files found matching '*.txt' 13:39:02 INFO - no previously-included directories found matching 'build' 13:39:02 INFO - no previously-included directories found matching 'dist' 13:39:02 INFO - no previously-included directories found matching '.git*' 13:39:02 INFO - Installing collected packages: jsonschema, functools32 13:39:02 INFO - Running setup.py install for functools32 13:39:02 INFO - warning: no files found matching '*.txt' 13:39:02 INFO - no previously-included directories found matching 'build' 13:39:02 INFO - no previously-included directories found matching 'dist' 13:39:02 INFO - no previously-included directories found matching '.git*' 13:39:02 INFO - Successfully installed jsonschema functools32 13:39:02 INFO - Cleaning up... 13:39:02 INFO - Return code: 0 13:39:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:39: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')]} 13:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39: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')]} 13:39:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39: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 0x10ca04a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca99618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae634c10c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c968d30>, '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 0x10c6cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c960b20>, '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.GjfDHzaGuZ/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.0KCYaPGb1s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 13:39: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 13:39: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 13:39:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GjfDHzaGuZ/Render', 13:39:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:39:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:39:02 INFO - 'HOME': '/Users/cltbld', 13:39:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:39:02 INFO - 'LOGNAME': 'cltbld', 13:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:02 INFO - 'MOZ_NO_REMOTE': '1', 13:39:02 INFO - 'NO_EM_RESTART': '1', 13:39:02 INFO - 'PAGER': '/bin/cat', 13:39:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:02 INFO - 'PWD': '/builds/slave/test', 13:39:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:39:02 INFO - 'SHELL': '/bin/bash', 13:39:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0KCYaPGb1s/Listeners', 13:39:02 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 13:39:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:39:02 INFO - 'USER': 'cltbld', 13:39:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:39:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:02 INFO - 'XPC_FLAGS': '0x0', 13:39:02 INFO - 'XPC_SERVICE_NAME': '0', 13:39:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:39:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:39:02 INFO - Cleaning up... 13:39:02 INFO - Return code: 0 13:39:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:39: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')]} 13:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39: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')]} 13:39:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39: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 0x10ca04a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca99618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae634c10c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c968d30>, '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 0x10c6cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c960b20>, '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.GjfDHzaGuZ/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.0KCYaPGb1s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 13:39: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 13:39: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 13:39:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GjfDHzaGuZ/Render', 13:39:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:39:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:39:02 INFO - 'HOME': '/Users/cltbld', 13:39:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:39:02 INFO - 'LOGNAME': 'cltbld', 13:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:02 INFO - 'MOZ_NO_REMOTE': '1', 13:39:02 INFO - 'NO_EM_RESTART': '1', 13:39:02 INFO - 'PAGER': '/bin/cat', 13:39:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:02 INFO - 'PWD': '/builds/slave/test', 13:39:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:39:02 INFO - 'SHELL': '/bin/bash', 13:39:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0KCYaPGb1s/Listeners', 13:39:02 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 13:39:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:39:02 INFO - 'USER': 'cltbld', 13:39:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:39:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:02 INFO - 'XPC_FLAGS': '0x0', 13:39:02 INFO - 'XPC_SERVICE_NAME': '0', 13:39:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:39:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:02 INFO - Downloading/unpacking blobuploader==1.2.4 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39:05 INFO - Downloading blobuploader-1.2.4.tar.gz 13:39:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:39:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:39:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:06 INFO - Downloading docopt-0.6.1.tar.gz 13:39:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:39:06 INFO - Installing collected packages: blobuploader, requests, docopt 13:39:06 INFO - Running setup.py install for blobuploader 13:39:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:39:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:39:06 INFO - Running setup.py install for requests 13:39:07 INFO - Running setup.py install for docopt 13:39:07 INFO - Successfully installed blobuploader requests docopt 13:39:07 INFO - Cleaning up... 13:39:07 INFO - Return code: 0 13:39:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:39: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')]} 13:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39: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')]} 13:39:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39: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 0x10ca04a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca99618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae634c10c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c968d30>, '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 0x10c6cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c960b20>, '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.GjfDHzaGuZ/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.0KCYaPGb1s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 13:39: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 13:39: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 13:39:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GjfDHzaGuZ/Render', 13:39:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:39:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:39:07 INFO - 'HOME': '/Users/cltbld', 13:39:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:39:07 INFO - 'LOGNAME': 'cltbld', 13:39:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:07 INFO - 'MOZ_NO_REMOTE': '1', 13:39:07 INFO - 'NO_EM_RESTART': '1', 13:39:07 INFO - 'PAGER': '/bin/cat', 13:39:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:39:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:07 INFO - 'PWD': '/builds/slave/test', 13:39:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:39:07 INFO - 'SHELL': '/bin/bash', 13:39:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0KCYaPGb1s/Listeners', 13:39:07 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 13:39:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:39:07 INFO - 'USER': 'cltbld', 13:39:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:39:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:39:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:07 INFO - 'XPC_FLAGS': '0x0', 13:39:07 INFO - 'XPC_SERVICE_NAME': '0', 13:39:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:39:07 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-pNyqCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:39:07 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-kpvfIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:39:07 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-HQVo8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:39:08 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-q9z0N4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:39:08 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-LoQDG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:39:08 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-QcCE8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:39:08 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-dak838-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:39:08 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-BBnoC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:39:08 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-7f2fvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:39:08 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-6OpzmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:39:08 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-Q2WaoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:39:08 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-vHevuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:39:08 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-rXItf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:39:09 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-iKXYEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:09 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-SMnkTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:39:09 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-Hry7r5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:39:09 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-zlpmnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:39:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:39:09 INFO - Running setup.py install for manifestparser 13:39:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:39:09 INFO - Running setup.py install for mozcrash 13:39:09 INFO - Running setup.py install for mozdebug 13:39:09 INFO - Running setup.py install for mozdevice 13:39:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:39:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:39:10 INFO - Running setup.py install for mozfile 13:39:10 INFO - Running setup.py install for mozhttpd 13:39:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:39:10 INFO - Running setup.py install for mozinfo 13:39:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:39:10 INFO - Running setup.py install for mozInstall 13:39:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:39:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:39:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:39:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:39:10 INFO - Running setup.py install for mozleak 13:39:10 INFO - Running setup.py install for mozlog 13:39:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:39:10 INFO - Running setup.py install for moznetwork 13:39:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:39:11 INFO - Running setup.py install for mozprocess 13:39:11 INFO - Running setup.py install for mozprofile 13:39:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:39:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:39:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:39:11 INFO - Running setup.py install for mozrunner 13:39:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:39:11 INFO - Running setup.py install for mozscreenshot 13:39:11 INFO - Running setup.py install for moztest 13:39:11 INFO - Running setup.py install for mozversion 13:39:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:39:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:39:12 INFO - Cleaning up... 13:39:12 INFO - Return code: 0 13:39:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:39:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:12 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 0x10ca04a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca99618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae634c10c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c968d30>, '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 0x10c6cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c960b20>, '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.GjfDHzaGuZ/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.0KCYaPGb1s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 13:39:12 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 13:39:12 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 13:39:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GjfDHzaGuZ/Render', 13:39:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:39:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:39:12 INFO - 'HOME': '/Users/cltbld', 13:39:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:39:12 INFO - 'LOGNAME': 'cltbld', 13:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:12 INFO - 'MOZ_NO_REMOTE': '1', 13:39:12 INFO - 'NO_EM_RESTART': '1', 13:39:12 INFO - 'PAGER': '/bin/cat', 13:39:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:12 INFO - 'PWD': '/builds/slave/test', 13:39:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:39:12 INFO - 'SHELL': '/bin/bash', 13:39:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0KCYaPGb1s/Listeners', 13:39:12 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 13:39:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:39:12 INFO - 'USER': 'cltbld', 13:39:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:39:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:12 INFO - 'XPC_FLAGS': '0x0', 13:39:12 INFO - 'XPC_SERVICE_NAME': '0', 13:39:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:39:12 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-LhySe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:39: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)) 13:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:39:12 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-Sb71uZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:39: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)) 13:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:39:12 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-MnPAkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:39: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)) 13:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:39:12 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-2fdOzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:39: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)) 13:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:39:12 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-ARvoa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:39: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)) 13:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:39:12 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-lsX9vE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:39: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)) 13:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:39:12 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-6ZOOWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:39:13 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)) 13:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:39:13 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-wswqsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:39:13 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)) 13:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:39:13 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-4W0JeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:39:13 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)) 13:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:39:13 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-yDpARV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:39: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)) 13:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:39:13 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-suMmn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:39: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)) 13:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:39:13 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-fqevCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:39: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)) 13:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:39:13 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-i4ogOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:39: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)) 13:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:39:13 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-hYjXXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:39: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)) 13:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:13 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-lbMDDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:39: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)) 13:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:39:13 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-Y7aYUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:39:14 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)) 13:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:39:14 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-di89GR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:39:14 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)) 13:39:14 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)) 13:39:14 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)) 13:39:14 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)) 13:39:14 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)) 13:39:14 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)) 13:39:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:16 INFO - Downloading blessings-1.6.tar.gz 13:39:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:39:16 INFO - Installing collected packages: blessings 13:39:16 INFO - Running setup.py install for blessings 13:39:16 INFO - Successfully installed blessings 13:39:16 INFO - Cleaning up... 13:39:16 INFO - Return code: 0 13:39:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:39:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:39:17 INFO - Reading from file tmpfile_stdout 13:39:17 INFO - Current package versions: 13:39:17 INFO - blessings == 1.6 13:39:17 INFO - blobuploader == 1.2.4 13:39:17 INFO - docopt == 0.6.1 13:39:17 INFO - functools32 == 3.2.3-2 13:39:17 INFO - jsonschema == 2.5.1 13:39:17 INFO - manifestparser == 1.1 13:39:17 INFO - mozInstall == 1.12 13:39:17 INFO - mozcrash == 0.17 13:39:17 INFO - mozdebug == 0.1 13:39:17 INFO - mozdevice == 0.48 13:39:17 INFO - mozfile == 1.2 13:39:17 INFO - mozhttpd == 0.7 13:39:17 INFO - mozinfo == 0.9 13:39:17 INFO - mozleak == 0.1 13:39:17 INFO - mozlog == 3.3 13:39:17 INFO - moznetwork == 0.27 13:39:17 INFO - mozprocess == 0.23 13:39:17 INFO - mozprofile == 0.28 13:39:17 INFO - mozrunner == 6.12 13:39:17 INFO - mozscreenshot == 0.1 13:39:17 INFO - mozsystemmonitor == 0.3 13:39:17 INFO - moztest == 0.7 13:39:17 INFO - mozversion == 1.4 13:39:17 INFO - psutil == 3.1.1 13:39:17 INFO - requests == 1.2.3 13:39:17 INFO - wsgiref == 0.1.2 13:39:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:39: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')]} 13:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39: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')]} 13:39:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:17 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 0x10ca04a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca99618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae634c10c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c968d30>, '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 0x10c6cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c960b20>, '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.GjfDHzaGuZ/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.0KCYaPGb1s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 13:39:17 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 13:39:17 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 13:39:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GjfDHzaGuZ/Render', 13:39:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:39:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:39:17 INFO - 'HOME': '/Users/cltbld', 13:39:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:39:17 INFO - 'LOGNAME': 'cltbld', 13:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:17 INFO - 'MOZ_NO_REMOTE': '1', 13:39:17 INFO - 'NO_EM_RESTART': '1', 13:39:17 INFO - 'PAGER': '/bin/cat', 13:39:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:17 INFO - 'PWD': '/builds/slave/test', 13:39:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:39:17 INFO - 'SHELL': '/bin/bash', 13:39:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0KCYaPGb1s/Listeners', 13:39:17 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 13:39:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:39:17 INFO - 'USER': 'cltbld', 13:39:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:39:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:17 INFO - 'XPC_FLAGS': '0x0', 13:39:17 INFO - 'XPC_SERVICE_NAME': '0', 13:39:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:39:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39: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)) 13:39: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)) 13:39: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)) 13:39: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)) 13:39: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)) 13:39: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)) 13:39: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)) 13:39: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)) 13:39: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)) 13:39: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)) 13:39: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)) 13:39:17 INFO - Cleaning up... 13:39:17 INFO - Return code: 0 13:39:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:39: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')]} 13:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39: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')]} 13:39:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39: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 0x10ca04a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca99618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae634c10c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c968d30>, '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 0x10c6cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c960b20>, '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.GjfDHzaGuZ/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.0KCYaPGb1s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 13:39: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 13:39: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 13:39:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GjfDHzaGuZ/Render', 13:39:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:39:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:39:17 INFO - 'HOME': '/Users/cltbld', 13:39:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:39:17 INFO - 'LOGNAME': 'cltbld', 13:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:17 INFO - 'MOZ_NO_REMOTE': '1', 13:39:17 INFO - 'NO_EM_RESTART': '1', 13:39:17 INFO - 'PAGER': '/bin/cat', 13:39:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:17 INFO - 'PWD': '/builds/slave/test', 13:39:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:39:17 INFO - 'SHELL': '/bin/bash', 13:39:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0KCYaPGb1s/Listeners', 13:39:17 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 13:39:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:39:17 INFO - 'USER': 'cltbld', 13:39:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:39:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:17 INFO - 'XPC_FLAGS': '0x0', 13:39:17 INFO - 'XPC_SERVICE_NAME': '0', 13:39:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:39:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:39:17 INFO - Cleaning up... 13:39:17 INFO - Return code: 0 13:39:17 INFO - Running post-action listener: _resource_record_post_action 13:39:17 INFO - Running post-action listener: _start_resource_monitoring 13:39:17 INFO - Starting resource monitoring. 13:39:17 INFO - [mozharness: 2016-08-05 20:39:17.730098Z] Finished create-virtualenv step (success) 13:39:17 INFO - [mozharness: 2016-08-05 20:39:17.731030Z] Running install step. 13:39:17 INFO - Running pre-action listener: _resource_record_pre_action 13:39:17 INFO - Running main action method: install 13:39:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:39:17 INFO - Reading from file tmpfile_stdout 13:39:17 INFO - Detecting whether we're running mozinstall >=1.0... 13:39:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:39:18 INFO - Reading from file tmpfile_stdout 13:39:18 INFO - Output received: 13:39:18 INFO - Usage: mozinstall [options] installer 13:39:18 INFO - Options: 13:39:18 INFO - -h, --help show this help message and exit 13:39:18 INFO - -d DEST, --destination=DEST 13:39:18 INFO - Directory to install application into. [default: 13:39:18 INFO - "/builds/slave/test"] 13:39:18 INFO - --app=APP Application being installed. [default: firefox] 13:39:18 INFO - mkdir: /builds/slave/test/build/application 13:39:18 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'] 13:39:18 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 13:39:51 INFO - Reading from file tmpfile_stdout 13:39:51 INFO - Output received: 13:39:51 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:39:51 INFO - Running post-action listener: _resource_record_post_action 13:39:51 INFO - [mozharness: 2016-08-05 20:39:51.835872Z] Finished install step (success) 13:39:51 INFO - [mozharness: 2016-08-05 20:39:51.836048Z] Running run-tests step. 13:39:51 INFO - Running pre-action listener: _resource_record_pre_action 13:39:51 INFO - Running main action method: run_tests 13:39:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:39:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:39:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:39:51 INFO - 2016-08-05 13:39:51.850 screenresolution[1637:7461] starting screenresolution argv=screenresolution get 13:39:51 INFO - 2016-08-05 13:39:51.853 screenresolution[1637:7461] Display 0: 1600x1200x32@60 13:39:51 INFO - 2016-08-05 13:39:51.858 screenresolution[1638:7463] starting screenresolution argv=screenresolution list 13:39:51 INFO - Available Modes on Display 0 13:39:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:39:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:39:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:39:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:39:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:39:52 INFO - Intel Iris: 13:39:52 INFO - Chipset Model: Intel Iris 13:39:52 INFO - Type: GPU 13:39:52 INFO - Bus: Built-In 13:39:52 INFO - VRAM (Dynamic, Max): 1536 MB 13:39:52 INFO - Vendor: Intel (0x8086) 13:39:52 INFO - Device ID: 0x0a2e 13:39:52 INFO - Revision ID: 0x0009 13:39:52 INFO - Displays: 13:39:52 INFO - Display: 13:39:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:39:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:39:52 INFO - Display Serial Number: 1600x1200 60 13:39:52 INFO - Main Display: Yes 13:39:52 INFO - Mirror: Off 13:39:52 INFO - Online: Yes 13:39:52 INFO - Rotation: Supported 13:39:52 INFO - Return code: 0 13:39:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:39:52 INFO - Python 2.7.3 13:39:52 INFO - Return code: 0 13:39:52 INFO - grabbing minidump binary from tooltool 13:39:52 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')]} 13:39:52 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 0x10c968d30>, '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 0x10c6cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c960b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:39:52 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 13:39:52 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 13:39:52 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 13:39:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:39:52 INFO - Return code: 0 13:39:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:39:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:39:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:39:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:39:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:39:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c7SUe_zNSkS7iCtqMgK0uA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0238', '--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 13:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/c7SUe_zNSkS7iCtqMgK0uA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0238 --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 13:39:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GjfDHzaGuZ/Render', 13:39:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:39:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:39:52 INFO - 'HOME': '/Users/cltbld', 13:39:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:39:52 INFO - 'LOGNAME': 'cltbld', 13:39:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:39:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:52 INFO - 'MOZ_NO_REMOTE': '1', 13:39:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:39:52 INFO - 'NO_EM_RESTART': '1', 13:39:52 INFO - 'PAGER': '/bin/cat', 13:39:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:52 INFO - 'PWD': '/builds/slave/test', 13:39:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:39:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:39:52 INFO - 'SHELL': '/bin/bash', 13:39:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0KCYaPGb1s/Listeners', 13:39:52 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 13:39:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:39:52 INFO - 'USER': 'cltbld', 13:39:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:39:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:52 INFO - 'XPC_FLAGS': '0x0', 13:39:52 INFO - 'XPC_SERVICE_NAME': '0', 13:39:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:39:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c7SUe_zNSkS7iCtqMgK0uA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0238', '--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 13:39:52 INFO - mozversion application_buildid: 20160805121521 13:39:52 INFO - mozversion application_changeset: e648eb9685a0416aa2468412402d03fc5c347362 13:39:52 INFO - mozversion application_display_name: Nightly 13:39:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:39:52 INFO - mozversion application_name: Firefox 13:39:52 INFO - mozversion application_remotingname: firefox 13:39:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 13:39:52 INFO - mozversion application_vendor: Mozilla 13:39:52 INFO - mozversion application_version: 51.0a1 13:39:52 INFO - mozversion platform_buildid: 20160805121521 13:39:52 INFO - mozversion platform_changeset: e648eb9685a0416aa2468412402d03fc5c347362 13:39:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 13:39:52 INFO - mozversion platform_version: 51.0a1 13:39:52 INFO - using testdate: 1470429592 13:39:52 INFO - actual date: 1470429592 13:39:52 INFO - starting webserver on 'localhost:49266' 13:39:52 INFO - SUITE-START | Running 2 tests 13:39:52 INFO - TEST-START | dromaeo_css 13:39:52 INFO - operating with platform_type : mac_ 13:39:52 INFO - Initialising browser for dromaeo_css test... 13:39:52 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmp7fL8Ah/profile http://localhost:49266/getInfo.html) 13:39:55 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 13:39:55 INFO - PROCESS | 1648 | colorDepth:24 13:39:55 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 13:39:55 INFO - PROCESS | 1648 | __metrics 13:39:55 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 13:39:56 INFO - TEST-INFO | 1648: exit 0 13:39:56 INFO - Browser initialized. 13:39:56 INFO - Running cycle 1/1 for dromaeo_css test... 13:39:56 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmp7fL8Ah/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:40:08 INFO - PROCESS | 1652 | RSS: Main: 254861312 13:40:08 INFO - PROCESS | 1652 | 13:40:58 INFO - PROCESS | 1652 | 1470429658253 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] 13:43:10 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 13:43:11 INFO - PROCESS | 1652 | RSS: Main: 267927552 13:43:11 INFO - PROCESS | 1652 | 13:46:13 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 13:46:14 INFO - PROCESS | 1652 | RSS: Main: 281919488 13:46:14 INFO - PROCESS | 1652 | 13:49:16 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 13:49:17 INFO - PROCESS | 1652 | RSS: Main: 292007936 13:49:17 INFO - PROCESS | 1652 | 13:52:19 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 13:52:19 INFO - PROCESS | 1652 | RSS: Main: 292675584 13:52:19 INFO - PROCESS | 1652 | 13:55:22 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 13:55:22 INFO - PROCESS | 1652 | RSS: Main: 297406464 13:55:22 INFO - PROCESS | 1652 | 13:58:25 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 13:58:26 INFO - PROCESS | 1652 | RSS: Main: 297373696 13:58:26 INFO - PROCESS | 1652 | 13:58:26 INFO - PROCESS | 1652 | __start_tp_report 13:58:26 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 13:58:26 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 13:58:26 INFO - PROCESS | 1652 | |i|pagename|runs| 13:58:26 INFO - PROCESS | 1652 | |0;dojo.html;2931.897383591575;2944.882204711811;3422.640622734613;3462.671046250607;3494.196334842986;4701;5736.483716465517;5772.249607551018;5848.6490810551395;5865.970670146654;5683.374828768842;5798.2172406725185;5872.148538461921;5908.261467316585;5954.315253745821;5209.557187639046;5247.527722504974;5330.147176451768;5387.0303345397815;5387.24578559002;5313.362396512424;5416.51251387375;5422.75597598107;5496.422875598065;5514.310711161105;5241.947580524203;5292.153255479124;5379.569634429236;5382.111951527993;5385.030694474993;5335.573154147659;5343.385510666284;5346.866328341784;5367.865803354908;5374.301340825707;5284.392294886099;5307.708076055816;5320.733963301858;5356.009138309425;5372.462753724635;5635.3237611486475;5691.03252447085;5815.127730840408;5828.125781132821;5926.348101708809;6214.720337584819;6238.189035425366;6296.055591661242;6317.4314311711705;6327.620342779448;6254.843628909313;6280.497560195219;6282.811515654537;6284.12022316876;6294.0873573332065;5716.371199168088;5771.567132465082;5856.853578660568;5900.43945825146;5943.673097979567;6407.13503677007;6433.324500927335;6445.45213656835;6455.548111632234;6463.676816159267;6187.504999600022;6204.255489341218;6251.437370636573;6253.5622506425025;6267.561270711098;6153.292371377349;6182.752689892354;6199.473044791243;6212.409821066992;6288.151099601587;6103.852895754731;6173.166622505994;6241.7191226394925;6259.530535209878;6264.467520260829;6270.216222972129;6288.465480434214;6290.779822706183;6305;6305.716242769086;4912.901741965141;4962.057209130254;4963.429205641398;4976.0794253063295;5025.095482813129;4440.4671439427475;4447.599716025508;4450.599446049871;4473.993351495952;4474.239379305526;5823.592348535646;5873.4126587340925;5916.26046744157;5920.733566989496;5941.881162376728;6211.2857021443115;6278.246610406689;6307.684615769193;6312.873742525124;6325.240971083407;5880.7353669085;5887.499562537147;5898.646081235054;5941.613795103304;5982.670953097534;5536.833894983157;5541.362743284574;5546.639468434539;5549.056660367747;5560.805371811967;4769.2130798417875;6427.58220715652;6448.709808058742;6494.707738151795;6512.413882750575;5554.750036248298;6069.423404776716;6099.551912188564;6239.7504099837315;6305.117283580211;6448.967755161194;6454.160959075478;6493.2857385688485;6514.6416947068365;6517.055027020961;6096.75612975476;6187.102870083722;6232.376762323732;6284.183056202664;6288.056791481315;4852.951470485391;5176.249443830548;6139.093519790236;6288.0882272069375;6300.527460440394;5583.162525621189;5710.2576665033275;5793.768249269982;6119.908201376894;6228.781992630236;4920.72935988524;5712.571557133315;6215.316315205414;6228.688565571794;6237.5321850860455;5899.616524925866;6053.4551890330085;6124.724387402489;6143.662098584621;6164.938350616437;6200.720967556561;6204.751809927733;6208.906866397098;6214.844628884314;6254.343293954069;5897.439743224387;6079.148919151411;6116.816495505142;6147.600405973598;6148.1085242640465 13:58:26 INFO - PROCESS | 1652 | |1;ext.html;467.40172579098726;473.68026582057115;480.9759512024398;554.5425024354905;581.4272941152961;38413.231735365276;41061.97345066375;41096.972575685584;41101.79449102758;41105.7668269952;41789.582104178946;42312.57687423125;42364.551722069125;42439.72680819573;42544.9363765906;9559.28305377096;9606.663766768164;9615.807683846318;9777.853332200022;9778.853317200212;9550;9663.5168241588;9677.75805604862;9683.370580912218;9699.224062075053;9692.27307951903;9703.854442183372;9740.074692904198;9754.02459754026;9756.804863902718;9549.045095490465;9644.614215431375;9682.612695492207;9717.416954982653;9720.368176068532;9556.856647150298;9580.0898914603;9652.662156824477;9691.757706057335;9764.951175244149;40162.598374016474;40373.394399084034;40523.797381012904;40684;41064;3085.568020477135;3314.5193946877566;3456.1877958679943;3476.644108797571;3505.1237190702323;30870.38259234803;30949;31365.37269254602;31867.362652746815;32026;2632.657754491923;3081.229692576856;3097.5198844178963;3141.764367672411;3236.12624591359;426298;430669;432491;432622.8368858167;435686;32400.83799580987;32653;32853.67146328506;32885.50671739926;32895.177620559676;34819.65180348215;35201;35318.64681353154;35541;36069.819650901576;16272.43046493367;16785.748213776802;16826.158692065346;16842.49472515802;16856.662866742598;12819.294938778457;12896.032797540222;12905.290209038592;12915.806262906064;12938.741225175443;18485.7227141593;19380.072260296256;19878.90060549717;19955.002249887737;20034.89982550078;6693.832654183684;6827;6949.722011119498;7074.292570742988;8241.546714930617;864.2351518905814;979.774651830083;1021.5658345203259;1055.9947200264103;1061.3154515337565;30277.545836812464;30653.540196897065;31104;31357.745690172138;31421.214469638442;1034.9741256468649;1055.773008803111;1082.7293176705823;1087.4617064553097;1138.3340745663713;12629.93685031569;15962.60093497672;16024.19879006045;16085.678286434206;16271.430499932445;576536;683871;688301;694905;697120;57838.37293016549;58382.83234335289;59367.703161483914;59499.70250148721;59626.80746385048;1358.7146699193281;1386.9653258668613;1398.9580312590638;1400.5378225185664;1403.9259966125921;29938;30268.394632107676;30360;30507.847460762554;30632.234194144432;52818;53026.469735302155;53308.73345633402;53373.46626533685;53393;423373;423406;424123;424935;427172;26669;27298.454030919667;27695;27750.306242344104;27761.58357624597;48655.78360541015;48760.75619621879;49283.507164929324;50259.74870125626;50627.746861265456;35374.823125884206;39814.2037159261;40771.77684669464;40817;41394.96512587209;34163;40537.79731101444;41040;41308.58691413047;41795.9551011215;39567.604323957545;39572.604273956895;39962.80111596657;40338.798306008284;40598;31884.681153188172;31947;35236.94289171329;35523;36066.4590031155;26280.8685956569;26462.867685661447;26470.338241544116;26744.732552674224;26828 13:58:26 INFO - PROCESS | 1652 | |2;jquery.html;369.49563845351105;380.45214890557594;385.77624977513045;394.8361430006547;406.5223362549006;18450.723239151408;19993.500162495944;20579.073941672625;20718.585628287427;20765.896170519147;19003.42989710311;19272.710909336372;19507.927064011474;19649.70525442116;19770.802291977077;5522;5568.972155139219;5689.3172819261745;5778.104393818965;5953.613015154001;5811.186433899236;5846.093855452412;5851.531877449794;5885.646861188342;5901.23283973085;4874.707517548958;4912.852614421573;5754.1944127822135;5783.958887400267;5790;5673.574481913873;5680.886382272352;5692.203091567184;5806.622569532988;5845.7369418376065;5028.974855125737;5055.241713742931;5094.032133894548;5137.434882162959;5151.922721159186;24100.75899241003;24260;24501.754982450126;24629.507409851703;24799.752002479923;2017.3241963942096;2458.1519375815315;2670.639463672399;2696.7707744841714;3046.2536678513684;9410.247180225566;9858.507074646239;9983.400995940267;10010.64962726301;10069.54687039085;1494.3574263066878;1544.3050627217797;1800.729890516433;1895.895725735084;1929.3150931419284;81263.9999999994;115884;120372;124053;124934;9380.8592871107;10954.342739435659;10979.505922233519;11570.710732231762;11716.94141529304;14320.283985800668;14360;14384.136951782717;14386;14441.49454769078;8244.422890397735;8490.108538603481;8494.74515764528;8624.180702833346;8661.956690216508;8367.372447066495;8492.830143397097;8530.530820804792;8664.263537599249;8676.566171691391;3604.7837129772297;4497.88755281114;4516.07420478801;4566.337881007235;4584.885377865513;1691.7885264341958;1895.9620807583772;1937.3703546347494;1938.5056810513229;1943.494691380223;700.9065857262686;798.3732769775698;939.9765005874908;978.1881038737973;993.9861341431699;19902.701459478118;21165.259215927676;21175.117947904422;21258.854523367794;21411.571768564543;952.7141857442739;987.7431867714303;1008.1581879130861;1046.387863100095;1051.0960573906434;10835.891641083488;10852.403117828595;11212.887871121347;11855.525778968917;11940.283582984875;618801;621922;623760;631059;633679;79298.20701793024;127579;140504.29747851196;141824;143097;1052.1214785654065;1055.0428954289835;1087.521490544158;1089.373610174153;1089.7929393415225;18802.811971880652;18896.622067558295;18970;19038.809611903704;19301.613967720285;55802;56838.57903552279;57486.7125664369;57619.423805761406;57869.13196302143;82695.75956360539;83267;83475.16524834673;85101.57449212714;86236.70644940456;6839;7505.624718763931;7543.3965282778345;7545.811354716176;7553.524415081305;12478.313692746986;12996.285204313475;13098.607041788762;13201.471941122247;13431.664208394477;11413.078625973054;11528.538858445569;11688.94155529217;11689.181757276909;11701.88298117042;10866.348019118563;11043.282186657842;11196.992270695677;11237.3257604544;11350.489227984926;10873.836892446461;11348.205625606128;11783.823242651195;11912.702182445162;11985;7310.451716121419;7389.704411823467;7433.851322973402;7603.9619801900635;7647.770566883002;8318.500889946623;8738.868916966378;9178.852643419572;11309.377984210947;11762.58830940913 13:58:26 INFO - PROCESS | 1652 | |3;mootools.html;1330.5808670268864;1343.1471015904901;1444.927753612319;1769.0712376002598;1821.6356728654273;7850.175731548191;8220.424570280084;8220.465669731464;8749.343799215068;8772.69295574655;7124.145102587684;8406.117357677433;8536.829263414727;8559.27246184075;8578.44240124393;2330.8951097200625;2353.6351865460797;2357.728861180969;2357.882105894707;2363.385519764865;2172.2397160993683;2233.452804062999;2247.6516139998325;2259.401258666455;2268.5009297954425;1968.8424926005957;2096.821770149539;2257.7403598586206;2331.1374791327235;2354.5879471092576;2319.512902290521;2350.518143780521;2352.7882490575757;2357.6109941859486;2361.315218586608;2204.206485665159;2213.4023813570248;2214.202886960693;2216.013873826148;2218.2901471529117;8580.442271252348;8661.090585488559;8694.39139260252;8707.956460217658;8713.695020674246;5147.202183661539;5194.4026436959475;5216.243644671501;5261.421243663194;5262.526372626482;2940.1326608650284;3435.914102147441;3578.3380074686265;3587.1749497615433;3629.0927268182954;1080.902718755308;1086.9891301086966;1091.4160923905672;1094.956201751937;1115.570505355436;11152.60965866199;11416.54333826646;11428.885711142866;11452.370119643416;11460.025897798698;4512.796924138422;4515.706479078849;4673.953260467351;4750.287456881495;4752.95247047532;9625.855612165824;9671.516424178762;9761.121499065119;9772.413655180711;9773.951130244302;5237.607179461479;5267.868303292448;5278;5279.656822306538;5281.102212623787;4330.415393921843;4652.348671186037;4778.378810754649;4798.904021919542;4808.326834243208;3792.810359482015;3919.392494163409;3964.147708242742;3975.960240397559;4032.6773858091283;1288.4652869059423;1298.5909438526835;1299.1815156451564;1303.2831942431624;1308.0647337153791;827.8054657155564;866.9033672404413;914.5838643417229;938.9201917836924;960.6205548808182;5763.250777398911;5818.389069147764;5939.584229103922;5951.047832346891;6074;447.2173696031944;450.2750571579754;451.38611488375784;456.59591261733607;459.91491574058904;3949.861754838567;4010.0977280111742;4132.132252227006;4135.069609337875;4147.336426171798;10110;10219.029192226726;10352.844707329396;10454.059134677915;10564.418956957288;10323.380597164194;10349.896501035044;10495.580176792842;10523.631672891412;10531.789364212673;7964.323032542299;7990.680372785024;7992.880106798402;7999.400044996649;8123.553204573687;5791.652500849962;5818.796342128006;5847.619904706181;5955.67243801595;5974.014287642491;9714.222862171151;9834.803303934024;9836.21310295189;9899.406035637885;9914.652987145415;9580.66467673628;9977.151942085004;10030.197584193393;10033.14718248957;10057.899421005697;6846.486513511606;7132.108486439195;7286.635668216462;7409.962950185214;7513.887291690519;8080.030396352476;8229.177082291722;8267.958660206661;8271.421000529905;8275.62759675828;7194.388476979515;7291.015712878693;7302.598357090411;7386.96306518464;7431.888521672287;7169.605671687898;7229.530080544748;7232.16098316976;7239.601821899846;7263.418926485974;5767;6762.96618516924;6820.454363650797;6890.758823441155;6911.239763626098;4036.4752582164133;4968.8757781055765;5014.6991180529285;5035.84892453227;5115.028144652504;4198.6431153352305;4815.22956327;4829.13075646387;4869.220924652039;4900 13:58:26 INFO - PROCESS | 1652 | |4;prototype.html;254.2778509034342;302.3801207524574;308.3555369278209;315.33149722588115;317.4508100985297;4691.8123275069;5365;5503.559715222783;5581.302337207849;5718.1994520767075;4476.888077798057;5530.866172434651;5610.915836262449;5658.688772117532;5679.772809087632;3749.43758436234;4343.717658352213;4345.521992580813;4347.413099231595;4379.649628029766;3939.9606003940025;4315.654747620183;4329.783510824446;4331.6534677225745;4387.978060109695;4280.678949078816;4292.720973136752;4301.698881078326;4306.224879521685;4313.913721725564;3672.5042119313816;4267.743935363857;4285.185814695214;4288.463942007249;4306.44016277885;3604.891138683873;3709.5919448860604;3733.290674771785;3744.157564547982;3753.11801726594;4490.3488994096;4530.841420550298;5475.397706252309;5535.778568857241;5539.473749993744;4553.021100463383;4917.975410122962;4937.456879743226;4942.975285123587;4977.50224977503;5612.66324020556;5753.88492230153;6046.304674962392;6054.909176362358;6068.271807383142;3534.8437453153556;4089.386592011222;4093.140440507497;4129.442525259082;4145.66834653227;6296.496280297565;6327.303996560375;6422.871542569169;6427.585931095152;6468.611883286971;3498.510208570802;3565.841101641977;3951.1110000250287;4087.4481944937647;4108.958910410917;3742.7812081609795;3885.4560361549406;4158.771267580251;4212.831486740557;4259.488861336659;4520.728756274634;4786.946871688293;4948.6783359082265;4956.21576232556;4980.203167493256;5401.567874570025;5815.82552523425;6074.362191969868;6075.969620151959;6082.36135205797;1305.5508385691874;1364.9217118476292;1406.2476575032513;1442.6826098258575;1444.2634256529036;745.02401853572;784.811645205158;834.7161964931952;839.8614228652204;882.5851849630664;4010.7994600270454;4030.7581545107387;4703.800530864608;4785.736784476818;4809.879753006203;4587.8623641290815;4671.556202160789;5037.697738135724;5142.460041695643;5250.715938566659;4237.948676952589;4242.618164365222;4322.459692538433;4410.977945110318;4764.023375208074;2909.5926570280176;3126.03093041158;3234;3271.8384973334123;3274.950875736866;6201.1938448002375;6211.81364559064;6322.996576626158;6385.329540398284;6475.089848494706;4960.454350021495;5993.850153746104;6317.368263173646;6326.49388048955;6419.454346380517;5110.897782044412;5426.620136590401;6357.078223657451;6368.426841584187;6428.678566071678;5122.769475373691;5680.289963754531;5965.34381218057;6210.944139496387;6217.906731398942;5108.2160222677985;5337.22610221508;5935.614185077956;6052.636841789506;6141.324454309933;6353.5870168438905;6417.48660107181;6417.5666018679785;6459.09340796634;6474.870502590016;3637.3270944875285;3691.944620830636;3808.8286027128293;3948.684105271629;3977.085270387885;5755.81279113934;5786.739596718074;6039.48664363534;6057.848553786191;6105.84735381619;5212.5569326607665;5412.323459567554;5857.941420585739;5877.35349111606;5942.673152976455;4875.219964805614;5108.821191258288;5791.7683292667825;5891.731683301874;5912.438318359749;4852.350200931559;5761.971190144022;5764.654120752768;5783.987802134526;5847.26909136358;4746.38297021385;5408.945910540844;5682.318121825408;5859.94140058594;5933.317668468181;5444.700541470257;5673.375928647928;5693.715314234355;5696.487316141567;5704.629199102045 13:58:26 INFO - PROCESS | 1652 | |5;yui.html;716.7455553278583;717.48699679729;773.6286582440429;782.6595430987525;829.4774292195917;15192.164430956307;15662;15878.52364429066;15888.523344299661;15924.363025478982;14340.211288379134;14479.276036198175;14496.5651030469;14504;14543.3455494503;690.851466934609;831.2394159344223;846.6824940647273;856.6744637037917;868.409481552544;847.3644766425181;860.1871231686059;860.9009963854174;861.732862812527;863.4732812984074;893.6202114101513;926.5043201886991;926.6293482606944;928.0209379105041;930.1210356213381;779.6491578789568;838.7441830241773;885.1767855894049;923.1276443760615;931.6925414613162;528.6801485101497;598.7455331484146;677.7187467201105;681.3901558105467;682.5154140560209;14689.77965330521;14824.925875370662;14856.925715371463;14879.553613391616;14904;12128.45421956014;12214.694632634255;12298.20061695987;12344.753104937941;12871.163374380636;11612.303261804318;11780;11874.16880818343;11901.94049029758;12134.939325303405;4584.174848527264;4640.09518143962;4775.594074503671;4819.108464933998;4829.323894654716;85819.57090214572;108914.45542772315;109222;112368.4381578095;114067.99999999917;10892.61875834342;10925.562977480971;10941.671749847517;10973.670789876316;11085.002349788558;20398.592028159354;20841.186439830733;20859.061342239635;20861.895690521753;20893.37319880406;7782.426361949438;7792.805179870548;7886.329661978796;8070.47541909774;8084.757457276173;4321.67587430944;4326.15639950213;4373.497047839539;4382.956170438255;4394.802233899482;3384.1370450534955;3481.47777833327;3503.2292895562937;3559.715222782171;3560.839762210707;656.5601047298321;656.9474442044625;675.2133764164693;679.4496457869043;680.5950459476603;530.578190338674;559.1863838115532;574.5719439017959;578.7540295374449;632.2065807411669;8645.351598630128;9529.714108576754;9985.550650220757;10627.256092073636;11010;550.3918170421706;663.075010360554;672.9562578432484;680.938715515606;689.5724650716487;4530.22986092365;4643.674942754043;4716.221823399101;4886.21820508724;4985.102681517289;86890.1310986882;87130;87742.56128719315;119425.40287298508;139462;115303;127495.36252318679;129640;132500;132516;107676;109428.4528577352;113483.43258283655;113615;114961.4251928735;9365.906340936503;9426.528673566432;9439;9471.715848524555;9518;61305;63032.36967630265;63379;64674.676626616565;65339.67330163509;82793;89523.65714514417;91603;94442.52778736337;96050;12187.390630468264;12329.198602091194;12335;12348.3825808711;12505.624831255076;12554.937225313815;13944.790828137384;14018.088824226392;14453.855461445251;14502.1298722077;12069.27584344942;13490.66273343135;13511.121777084458;13532.72934541284;13704.45182192741;12698.746025079632;13897.749202571817;14181;14570.85429145695;15111.924440378167;14105.083169593943;14255.572332830032;14378.640533986316;14649.12105273687;14707.705845882809;11360.886391136313;11512.53949841997;11581.768364632828;11630;12069.336186509827;10474.68575942723;10501.947490262806;10809.783804324026;11509.94245028803;11783.52865885355 13:58:26 INFO - PROCESS | 1652 | __end_tp_report 13:58:26 INFO - PROCESS | 1652 | __start_cc_report 13:58:26 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,405 13:58:26 INFO - PROCESS | 1652 | __end_cc_report 13:58:26 INFO - PROCESS | 1652 | __startTimestamp1470430706049__endTimestamp 13:58:26 INFO - PROCESS | 1652 | 13:58:26 INFO - PROCESS | 1652 | ------- Summary: start ------- 13:58:26 INFO - PROCESS | 1652 | Number of tests: 6 13:58:26 INFO - PROCESS | 1652 | 13:58:26 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5782.81 Median:5941.88 stddev:670.24 (11.3%) stddev-sans-first:633.89 13:58:26 INFO - PROCESS | 1652 | Values: 2931.9 2944.9 3422.6 3462.7 3494.2 4701.0 5736.5 5772.2 5848.6 5866.0 5683.4 5798.2 5872.1 5908.3 5954.3 5209.6 5247.5 5330.1 5387.0 5387.2 5313.4 5416.5 5422.8 5496.4 5514.3 5241.9 5292.2 5379.6 5382.1 5385.0 5335.6 5343.4 5346.9 5367.9 5374.3 5284.4 5307.7 5320.7 5356.0 5372.5 5635.3 5691.0 5815.1 5828.1 5926.3 6214.7 6238.2 6296.1 6317.4 6327.6 6254.8 6280.5 6282.8 6284.1 6294.1 5716.4 5771.6 5856.9 5900.4 5943.7 6407.1 6433.3 6445.5 6455.5 6463.7 6187.5 6204.3 6251.4 6253.6 6267.6 6153.3 6182.8 6199.5 6212.4 6288.2 6103.9 6173.2 6241.7 6259.5 6264.5 6270.2 6288.5 6290.8 6305.0 6305.7 4912.9 4962.1 4963.4 4976.1 5025.1 4440.5 4447.6 4450.6 4474.0 4474.2 5823.6 5873.4 5916.3 5920.7 5941.9 6211.3 6278.2 6307.7 6312.9 6325.2 5880.7 5887.5 5898.6 5941.6 5982.7 5536.8 5541.4 5546.6 5549.1 5560.8 4769.2 6427.6 6448.7 6494.7 6512.4 5554.8 6069.4 6099.6 6239.8 6305.1 6449.0 6454.2 6493.3 6514.6 6517.1 6096.8 6187.1 6232.4 6284.2 6288.1 4853.0 5176.2 6139.1 6288.1 6300.5 5583.2 5710.3 5793.8 6119.9 6228.8 4920.7 5712.6 6215.3 6228.7 6237.5 5899.6 6053.5 6124.7 6143.7 6164.9 6200.7 6204.8 6208.9 6214.8 6254.3 5897.4 6079.1 6116.8 6147.6 6148.1 13:58:26 INFO - PROCESS | 1652 | 13:58:26 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:64116.52 Median:40250.70 stddev:139343.45 (346.2%) stddev-sans-first:139652.40 13:58:26 INFO - PROCESS | 1652 | Values: 467.4 473.7 481.0 554.5 581.4 38413.2 41062.0 41097.0 41101.8 41105.8 41789.6 42312.6 42364.6 42439.7 42544.9 9559.3 9606.7 9615.8 9777.9 9778.9 9550.0 9663.5 9677.8 9683.4 9699.2 9692.3 9703.9 9740.1 9754.0 9756.8 9549.0 9644.6 9682.6 9717.4 9720.4 9556.9 9580.1 9652.7 9691.8 9765.0 40162.6 40373.4 40523.8 40684.0 41064.0 3085.6 3314.5 3456.2 3476.6 3505.1 30870.4 30949.0 31365.4 31867.4 32026.0 2632.7 3081.2 3097.5 3141.8 3236.1 426298.0 430669.0 432491.0 432622.8 435686.0 32400.8 32653.0 32853.7 32885.5 32895.2 34819.7 35201.0 35318.6 35541.0 36069.8 16272.4 16785.7 16826.2 16842.5 16856.7 12819.3 12896.0 12905.3 12915.8 12938.7 18485.7 19380.1 19878.9 19955.0 20034.9 6693.8 6827.0 6949.7 7074.3 8241.5 864.2 979.8 1021.6 1056.0 1061.3 30277.5 30653.5 31104.0 31357.7 31421.2 1035.0 1055.8 1082.7 1087.5 1138.3 12629.9 15962.6 16024.2 16085.7 16271.4 576536.0 683871.0 688301.0 694905.0 697120.0 57838.4 58382.8 59367.7 59499.7 59626.8 1358.7 1387.0 1399.0 1400.5 1403.9 29938.0 30268.4 30360.0 30507.8 30632.2 52818.0 53026.5 53308.7 53373.5 53393.0 423373.0 423406.0 424123.0 424935.0 427172.0 26669.0 27298.5 27695.0 27750.3 27761.6 48655.8 48760.8 49283.5 50259.7 50627.7 35374.8 39814.2 40771.8 40817.0 41395.0 34163.0 40537.8 41040.0 41308.6 41796.0 39567.6 39572.6 39962.8 40338.8 40598.0 31884.7 31947.0 35236.9 35523.0 36066.5 26280.9 26462.9 26470.3 26744.7 26828.0 13:58:26 INFO - PROCESS | 1652 | 13:58:26 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:35784.54 Median:13735.20 stddev:104305.28 (759.4%) stddev-sans-first:104563.98 13:58:26 INFO - PROCESS | 1652 | Values: 369.5 380.5 385.8 394.8 406.5 18450.7 19993.5 20579.1 20718.6 20765.9 19003.4 19272.7 19507.9 19649.7 19770.8 5522.0 5569.0 5689.3 5778.1 5953.6 5811.2 5846.1 5851.5 5885.6 5901.2 4874.7 4912.9 5754.2 5784.0 5790.0 5673.6 5680.9 5692.2 5806.6 5845.7 5029.0 5055.2 5094.0 5137.4 5151.9 24100.8 24260.0 24501.8 24629.5 24799.8 2017.3 2458.2 2670.6 2696.8 3046.3 9410.2 9858.5 9983.4 10010.6 10069.5 1494.4 1544.3 1800.7 1895.9 1929.3 81264.0 115884.0 120372.0 124053.0 124934.0 9380.9 10954.3 10979.5 11570.7 11716.9 14320.3 14360.0 14384.1 14386.0 14441.5 8244.4 8490.1 8494.7 8624.2 8662.0 8367.4 8492.8 8530.5 8664.3 8676.6 3604.8 4497.9 4516.1 4566.3 4584.9 1691.8 1896.0 1937.4 1938.5 1943.5 700.9 798.4 940.0 978.2 994.0 19902.7 21165.3 21175.1 21258.9 21411.6 952.7 987.7 1008.2 1046.4 1051.1 10835.9 10852.4 11212.9 11855.5 11940.3 618801.0 621922.0 623760.0 631059.0 633679.0 79298.2 127579.0 140504.3 141824.0 143097.0 1052.1 1055.0 1087.5 1089.4 1089.8 18802.8 18896.6 18970.0 19038.8 19301.6 55802.0 56838.6 57486.7 57619.4 57869.1 82695.8 83267.0 83475.2 85101.6 86236.7 6839.0 7505.6 7543.4 7545.8 7553.5 12478.3 12996.3 13098.6 13201.5 13431.7 11413.1 11528.5 11688.9 11689.2 11701.9 10866.3 11043.3 11197.0 11237.3 11350.5 10873.8 11348.2 11783.8 11912.7 11985.0 7310.5 7389.7 7433.9 7604.0 7647.8 8318.5 8738.9 9178.9 11309.4 11762.6 13:58:26 INFO - PROCESS | 1652 | 13:58:26 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5578.51 Median:4822.18 stddev:3140.52 (65.1%) stddev-sans-first:3133.10 13:58:26 INFO - PROCESS | 1652 | Values: 1330.6 1343.1 1444.9 1769.1 1821.6 7850.2 8220.4 8220.5 8749.3 8772.7 7124.1 8406.1 8536.8 8559.3 8578.4 2330.9 2353.6 2357.7 2357.9 2363.4 2172.2 2233.5 2247.7 2259.4 2268.5 1968.8 2096.8 2257.7 2331.1 2354.6 2319.5 2350.5 2352.8 2357.6 2361.3 2204.2 2213.4 2214.2 2216.0 2218.3 8580.4 8661.1 8694.4 8708.0 8713.7 5147.2 5194.4 5216.2 5261.4 5262.5 2940.1 3435.9 3578.3 3587.2 3629.1 1080.9 1087.0 1091.4 1095.0 1115.6 11152.6 11416.5 11428.9 11452.4 11460.0 4512.8 4515.7 4674.0 4750.3 4753.0 9625.9 9671.5 9761.1 9772.4 9774.0 5237.6 5267.9 5278.0 5279.7 5281.1 4330.4 4652.3 4778.4 4798.9 4808.3 3792.8 3919.4 3964.1 3976.0 4032.7 1288.5 1298.6 1299.2 1303.3 1308.1 827.8 866.9 914.6 938.9 960.6 5763.3 5818.4 5939.6 5951.0 6074.0 447.2 450.3 451.4 456.6 459.9 3949.9 4010.1 4132.1 4135.1 4147.3 10110.0 10219.0 10352.8 10454.1 10564.4 10323.4 10349.9 10495.6 10523.6 10531.8 7964.3 7990.7 7992.9 7999.4 8123.6 5791.7 5818.8 5847.6 5955.7 5974.0 9714.2 9834.8 9836.2 9899.4 9914.7 9580.7 9977.2 10030.2 10033.1 10057.9 6846.5 7132.1 7286.6 7410.0 7513.9 8080.0 8229.2 8268.0 8271.4 8275.6 7194.4 7291.0 7302.6 7387.0 7431.9 7169.6 7229.5 7232.2 7239.6 7263.4 5767.0 6763.0 6820.5 6890.8 6911.2 4036.5 4968.9 5014.7 5035.8 5115.0 4198.6 4815.2 4829.1 4869.2 4900.0 13:58:26 INFO - PROCESS | 1652 | 13:58:26 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4715.31 Median:5072.96 stddev:1482.69 (29.2%) stddev-sans-first:1448.55 13:58:26 INFO - PROCESS | 1652 | Values: 254.3 302.4 308.4 315.3 317.5 4691.8 5365.0 5503.6 5581.3 5718.2 4476.9 5530.9 5610.9 5658.7 5679.8 3749.4 4343.7 4345.5 4347.4 4379.6 3940.0 4315.7 4329.8 4331.7 4388.0 4280.7 4292.7 4301.7 4306.2 4313.9 3672.5 4267.7 4285.2 4288.5 4306.4 3604.9 3709.6 3733.3 3744.2 3753.1 4490.3 4530.8 5475.4 5535.8 5539.5 4553.0 4918.0 4937.5 4943.0 4977.5 5612.7 5753.9 6046.3 6054.9 6068.3 3534.8 4089.4 4093.1 4129.4 4145.7 6296.5 6327.3 6422.9 6427.6 6468.6 3498.5 3565.8 3951.1 4087.4 4109.0 3742.8 3885.5 4158.8 4212.8 4259.5 4520.7 4786.9 4948.7 4956.2 4980.2 5401.6 5815.8 6074.4 6076.0 6082.4 1305.6 1364.9 1406.2 1442.7 1444.3 745.0 784.8 834.7 839.9 882.6 4010.8 4030.8 4703.8 4785.7 4809.9 4587.9 4671.6 5037.7 5142.5 5250.7 4237.9 4242.6 4322.5 4411.0 4764.0 2909.6 3126.0 3234.0 3271.8 3275.0 6201.2 6211.8 6323.0 6385.3 6475.1 4960.5 5993.9 6317.4 6326.5 6419.5 5110.9 5426.6 6357.1 6368.4 6428.7 5122.8 5680.3 5965.3 6210.9 6217.9 5108.2 5337.2 5935.6 6052.6 6141.3 6353.6 6417.5 6417.6 6459.1 6474.9 3637.3 3691.9 3808.8 3948.7 3977.1 5755.8 5786.7 6039.5 6057.8 6105.8 5212.6 5412.3 5857.9 5877.4 5942.7 4875.2 5108.8 5791.8 5891.7 5912.4 4852.4 5762.0 5764.7 5784.0 5847.3 4746.4 5408.9 5682.3 5859.9 5933.3 5444.7 5673.4 5693.7 5696.5 5704.6 13:58:26 INFO - PROCESS | 1652 | 13:58:26 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:23528.53 Median:3531.47 stddev:36199.19 (1025.0%) stddev-sans-first:36260.22 13:58:26 INFO - PROCESS | 1652 | Values: 716.7 717.5 773.6 782.7 829.5 15192.2 15662.0 15878.5 15888.5 15924.4 14340.2 14479.3 14496.6 14504.0 14543.3 690.9 831.2 846.7 856.7 868.4 847.4 860.2 860.9 861.7 863.5 893.6 926.5 926.6 928.0 930.1 779.6 838.7 885.2 923.1 931.7 528.7 598.7 677.7 681.4 682.5 14689.8 14824.9 14856.9 14879.6 14904.0 12128.5 12214.7 12298.2 12344.8 12871.2 11612.3 11780.0 11874.2 11901.9 12134.9 4584.2 4640.1 4775.6 4819.1 4829.3 85819.6 108914.5 109222.0 112368.4 114068.0 10892.6 10925.6 10941.7 10973.7 11085.0 20398.6 20841.2 20859.1 20861.9 20893.4 7782.4 7792.8 7886.3 8070.5 8084.8 4321.7 4326.2 4373.5 4383.0 4394.8 3384.1 3481.5 3503.2 3559.7 3560.8 656.6 656.9 675.2 679.4 680.6 530.6 559.2 574.6 578.8 632.2 8645.4 9529.7 9985.6 10627.3 11010.0 550.4 663.1 673.0 680.9 689.6 4530.2 4643.7 4716.2 4886.2 4985.1 86890.1 87130.0 87742.6 119425.4 139462.0 115303.0 127495.4 129640.0 132500.0 132516.0 107676.0 109428.5 113483.4 113615.0 114961.4 9365.9 9426.5 9439.0 9471.7 9518.0 61305.0 63032.4 63379.0 64674.7 65339.7 82793.0 89523.7 91603.0 94442.5 96050.0 12187.4 12329.2 12335.0 12348.4 12505.6 12554.9 13944.8 14018.1 14453.9 14502.1 12069.3 13490.7 13511.1 13532.7 13704.5 12698.7 13897.7 14181.0 14570.9 15111.9 14105.1 14255.6 14378.6 14649.1 14707.7 11360.9 11512.5 11581.8 11630.0 12069.3 10474.7 10501.9 10809.8 11509.9 11783.5 13:58:26 INFO - PROCESS | 1652 | -------- Summary: end -------- 13:58:26 INFO - PROCESS | 1652 | 13:58:26 INFO - TEST-INFO | 1652: exit 0 13:58:26 INFO - TEST-OK | dromaeo_css | took 1114256ms 13:58:26 INFO - TEST-START | kraken 13:58:26 INFO - operating with platform_type : mac_ 13:58:26 INFO - Initialising browser for kraken test... 13:58:26 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpebu4hp/profile http://localhost:49266/getInfo.html) 13:58:29 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 13:58:29 INFO - PROCESS | 1663 | colorDepth:24 13:58:29 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 13:58:29 INFO - PROCESS | 1663 | __metrics 13:58:29 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 13:58:30 INFO - TEST-INFO | 1663: exit 0 13:58:30 INFO - Browser initialized. 13:58:30 INFO - Running cycle 1/1 for kraken test... 13:58:30 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpebu4hp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:58:42 INFO - PROCESS | 1665 | RSS: Main: 254689280 13:58:42 INFO - PROCESS | 1665 | 13:58:45 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 13:58:46 INFO - PROCESS | 1665 | RSS: Main: 267886592 13:58:46 INFO - PROCESS | 1665 | 13:58:48 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 13:58:49 INFO - PROCESS | 1665 | RSS: Main: 276656128 13:58:49 INFO - PROCESS | 1665 | 13:58:52 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 13:58:53 INFO - PROCESS | 1665 | RSS: Main: 279552000 13:58:53 INFO - PROCESS | 1665 | 13:58:55 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 13:58:56 INFO - PROCESS | 1665 | RSS: Main: 282001408 13:58:56 INFO - PROCESS | 1665 | 13:58:58 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:58:58 INFO - PROCESS | 1665 | RSS: Main: 282824704 13:58:58 INFO - PROCESS | 1665 | 13:59:01 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 13:59:02 INFO - PROCESS | 1665 | RSS: Main: 283435008 13:59:02 INFO - PROCESS | 1665 | 13:59:05 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 13:59:05 INFO - PROCESS | 1665 | RSS: Main: 284176384 13:59:05 INFO - PROCESS | 1665 | 13:59:09 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 13:59:09 INFO - PROCESS | 1665 | RSS: Main: 283742208 13:59:09 INFO - PROCESS | 1665 | 13:59:11 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:59:11 INFO - PROCESS | 1665 | RSS: Main: 283553792 13:59:11 INFO - PROCESS | 1665 | 13:59:13 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:59:14 INFO - PROCESS | 1665 | RSS: Main: 283205632 13:59:14 INFO - PROCESS | 1665 | 13:59:16 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:59:17 INFO - PROCESS | 1665 | RSS: Main: 283254784 13:59:17 INFO - PROCESS | 1665 | 13:59:20 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:59:21 INFO - PROCESS | 1665 | RSS: Main: 283447296 13:59:21 INFO - PROCESS | 1665 | 13:59:24 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:59:24 INFO - PROCESS | 1665 | RSS: Main: 283443200 13:59:24 INFO - PROCESS | 1665 | 13:59:26 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 13:59:26 INFO - PROCESS | 1665 | RSS: Main: 284389376 13:59:26 INFO - PROCESS | 1665 | 13:59:26 INFO - PROCESS | 1665 | __start_tp_report 13:59:26 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 13:59:26 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 13:59:26 INFO - PROCESS | 1665 | |i|pagename|runs| 13:59:26 INFO - PROCESS | 1665 | |0;ai-astar;106;126;106;98;163;169;164;117;146;164 13:59:26 INFO - PROCESS | 1665 | |1;audio-beat-detection;137;91;135;153;138;165;158;108;158;110 13:59:26 INFO - PROCESS | 1665 | |2;audio-dft;192;204;218;199;191;200;196;199;198;201 13:59:26 INFO - PROCESS | 1665 | |3;audio-fft;82;87;76;145;58;59;60;62;147;85 13:59:26 INFO - PROCESS | 1665 | |4;audio-oscillator;72;70;117;72;71;74;114;70;74;124 13:59:26 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;137;131;89;87;88;85;89;86;90;86 13:59:26 INFO - PROCESS | 1665 | |6;imaging-darkroom;95;97;102;152;151;97;95;96;95;95 13:59:26 INFO - PROCESS | 1665 | |7;imaging-desaturate;100;90;91;90;140;153;95;91;89;136 13:59:26 INFO - PROCESS | 1665 | |8;json-parse-financial;57;57;55;55;56;55;47;47;77;85 13:59:26 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;67;73;59;86;102;109;103;73;68;73 13:59:26 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;85;86;88;81;81;74;104;98;109;103 13:59:26 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;140;138;142;155;125;147;157;161;137;149 13:59:26 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;166;167;167;166;217;158;225;229;169;170 13:59:26 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;65;69;66;73;88;85;88;61;77;88 13:59:26 INFO - PROCESS | 1665 | __end_tp_report 13:59:26 INFO - PROCESS | 1665 | __start_cc_report 13:59:26 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1048 13:59:26 INFO - PROCESS | 1665 | __end_cc_report 13:59:26 INFO - PROCESS | 1665 | __startTimestamp1470430766706__endTimestamp 13:59:26 INFO - PROCESS | 1665 | 13:59:26 INFO - PROCESS | 1665 | ------- Summary: start ------- 13:59:26 INFO - PROCESS | 1665 | Number of tests: 14 13:59:26 INFO - PROCESS | 1665 | 13:59:26 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:135.90 Median:163.50 stddev:28.27 (17.3%) stddev-sans-first:27.83 13:59:26 INFO - PROCESS | 1665 | Values: 106.0 126.0 106.0 98.0 163.0 169.0 164.0 117.0 146.0 164.0 13:59:26 INFO - PROCESS | 1665 | 13:59:26 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:155.50 stddev:24.91 (16.0%) stddev-sans-first:26.41 13:59:26 INFO - PROCESS | 1665 | Values: 137.0 91.0 135.0 153.0 138.0 165.0 158.0 108.0 158.0 110.0 13:59:26 INFO - PROCESS | 1665 | 13:59:26 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:199.80 Median:199.50 stddev:7.51 (3.8%) stddev-sans-first:7.42 13:59:26 INFO - PROCESS | 1665 | Values: 192.0 204.0 218.0 199.0 191.0 200.0 196.0 199.0 198.0 201.0 13:59:26 INFO - PROCESS | 1665 | 13:59:26 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:86.10 Median:69.00 stddev:33.47 (48.5%) stddev-sans-first:35.47 13:59:26 INFO - PROCESS | 1665 | Values: 82.0 87.0 76.0 145.0 58.0 59.0 60.0 62.0 147.0 85.0 13:59:26 INFO - PROCESS | 1665 | 13:59:26 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:85.80 Median:71.50 stddev:22.62 (31.6%) stddev-sans-first:23.44 13:59:26 INFO - PROCESS | 1665 | Values: 72.0 70.0 117.0 72.0 71.0 74.0 114.0 70.0 74.0 124.0 13:59:26 INFO - PROCESS | 1665 | 13:59:26 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:96.80 Median:87.50 stddev:19.72 (22.5%) stddev-sans-first:14.59 13:59:26 INFO - PROCESS | 1665 | Values: 137.0 131.0 89.0 87.0 88.0 85.0 89.0 86.0 90.0 86.0 13:59:26 INFO - PROCESS | 1665 | 13:59:26 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:107.50 Median:95.00 stddev:23.29 (24.5%) stddev-sans-first:24.26 13:59:26 INFO - PROCESS | 1665 | Values: 95.0 97.0 102.0 152.0 151.0 97.0 95.0 96.0 95.0 95.0 13:59:26 INFO - PROCESS | 1665 | 13:59:26 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:107.50 Median:90.00 stddev:25.06 (27.8%) stddev-sans-first:26.43 13:59:26 INFO - PROCESS | 1665 | Values: 100.0 90.0 91.0 90.0 140.0 153.0 95.0 91.0 89.0 136.0 13:59:26 INFO - PROCESS | 1665 | 13:59:26 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:56.50 stddev:12.26 (21.7%) stddev-sans-first:12.98 13:59:26 INFO - PROCESS | 1665 | Values: 57.0 57.0 55.0 55.0 56.0 55.0 47.0 47.0 77.0 85.0 13:59:26 INFO - PROCESS | 1665 | 13:59:26 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:81.30 Median:70.50 stddev:17.56 (24.9%) stddev-sans-first:17.84 13:59:26 INFO - PROCESS | 1665 | Values: 67.0 73.0 59.0 86.0 102.0 109.0 103.0 73.0 68.0 73.0 13:59:26 INFO - PROCESS | 1665 | 13:59:26 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:83.00 stddev:11.76 (14.2%) stddev-sans-first:12.28 13:59:26 INFO - PROCESS | 1665 | Values: 85.0 86.0 88.0 81.0 81.0 74.0 104.0 98.0 109.0 103.0 13:59:26 INFO - PROCESS | 1665 | 13:59:26 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:145.10 Median:148.00 stddev:10.89 (7.4%) stddev-sans-first:11.39 13:59:26 INFO - PROCESS | 1665 | Values: 140.0 138.0 142.0 155.0 125.0 147.0 157.0 161.0 137.0 149.0 13:59:26 INFO - PROCESS | 1665 | 13:59:26 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.40 Median:169.50 stddev:28.12 (16.6%) stddev-sans-first:29.11 13:59:26 INFO - PROCESS | 1665 | Values: 166.0 167.0 167.0 166.0 217.0 158.0 225.0 229.0 169.0 170.0 13:59:26 INFO - PROCESS | 1665 | 13:59:26 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.00 Median:81.00 stddev:10.64 (13.1%) stddev-sans-first:10.51 13:59:26 INFO - PROCESS | 1665 | Values: 65.0 69.0 66.0 73.0 88.0 85.0 88.0 61.0 77.0 88.0 13:59:26 INFO - PROCESS | 1665 | -------- Summary: end -------- 13:59:26 INFO - PROCESS | 1665 | 13:59:27 INFO - TEST-INFO | 1665: exit 0 13:59:27 INFO - TEST-OK | kraken | took 60874ms 13:59:27 INFO - SUITE-END | took 1175s 13:59:27 INFO - Completed test suite (00:19:35) 13:59:27 INFO - javascript benchmark 13:59:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7315.715053584666, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2931.897383591575, 2944.882204711811, 3422.640622734613, 3462.671046250607, 3494.196334842986, 4701.0, 5736.483716465517, 5772.249607551018, 5848.6490810551395, 5865.970670146654, 5683.374828768842, 5798.2172406725185, 5872.148538461921, 5908.261467316585, 5954.315253745821, 5209.557187639046, 5247.527722504974, 5330.147176451768, 5387.0303345397815, 5387.24578559002, 5313.362396512424, 5416.51251387375, 5422.75597598107, 5496.422875598065, 5514.310711161105, 5241.947580524203, 5292.153255479124, 5379.569634429236, 5382.111951527993, 5385.030694474993, 5335.573154147659, 5343.385510666284, 5346.866328341784, 5367.865803354908, 5374.301340825707, 5284.392294886099, 5307.708076055816, 5320.733963301858, 5356.009138309425, 5372.462753724635, 5635.3237611486475, 5691.03252447085, 5815.127730840408, 5828.125781132821, 5926.348101708809, 6214.720337584819, 6238.189035425366, 6296.055591661242, 6317.4314311711705, 6327.620342779448, 6254.843628909313, 6280.497560195219, 6282.811515654537, 6284.12022316876, 6294.0873573332065, 5716.371199168088, 5771.567132465082, 5856.853578660568, 5900.43945825146, 5943.673097979567, 6407.13503677007, 6433.324500927335, 6445.45213656835, 6455.548111632234, 6463.676816159267, 6187.504999600022, 6204.255489341218, 6251.437370636573, 6253.5622506425025, 6267.561270711098, 6153.292371377349, 6182.752689892354, 6199.473044791243, 6212.409821066992, 6288.151099601587, 6103.852895754731, 6173.166622505994, 6241.7191226394925, 6259.530535209878, 6264.467520260829, 6270.216222972129, 6288.465480434214, 6290.779822706183, 6305.0, 6305.716242769086, 4912.901741965141, 4962.057209130254, 4963.429205641398, 4976.0794253063295, 5025.095482813129, 4440.4671439427475, 4447.599716025508, 4450.599446049871, 4473.993351495952, 4474.239379305526, 5823.592348535646, 5873.4126587340925, 5916.26046744157, 5920.733566989496, 5941.881162376728, 6211.2857021443115, 6278.246610406689, 6307.684615769193, 6312.873742525124, 6325.240971083407, 5880.7353669085, 5887.499562537147, 5898.646081235054, 5941.613795103304, 5982.670953097534, 5536.833894983157, 5541.362743284574, 5546.639468434539, 5549.056660367747, 5560.805371811967, 4769.2130798417875, 6427.58220715652, 6448.709808058742, 6494.707738151795, 6512.413882750575, 5554.750036248298, 6069.423404776716, 6099.551912188564, 6239.7504099837315, 6305.117283580211, 6448.967755161194, 6454.160959075478, 6493.2857385688485, 6514.6416947068365, 6517.055027020961, 6096.75612975476, 6187.102870083722, 6232.376762323732, 6284.183056202664, 6288.056791481315, 4852.951470485391, 5176.249443830548, 6139.093519790236, 6288.0882272069375, 6300.527460440394, 5583.162525621189, 5710.2576665033275, 5793.768249269982, 6119.908201376894, 6228.781992630236, 4920.72935988524, 5712.571557133315, 6215.316315205414, 6228.688565571794, 6237.5321850860455, 5899.616524925866, 6053.4551890330085, 6124.724387402489, 6143.662098584621, 6164.938350616437, 6200.720967556561, 6204.751809927733, 6208.906866397098, 6214.844628884314, 6254.343293954069, 5897.439743224387, 6079.148919151411, 6116.816495505142, 6147.600405973598, 6148.1085242640465], "value": 5740.39619071964, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [467.40172579098726, 473.68026582057115, 480.9759512024398, 554.5425024354905, 581.4272941152961, 38413.231735365276, 41061.97345066375, 41096.972575685584, 41101.79449102758, 41105.7668269952, 41789.582104178946, 42312.57687423125, 42364.551722069125, 42439.72680819573, 42544.9363765906, 9559.28305377096, 9606.663766768164, 9615.807683846318, 9777.853332200022, 9778.853317200212, 9550.0, 9663.5168241588, 9677.75805604862, 9683.370580912218, 9699.224062075053, 9692.27307951903, 9703.854442183372, 9740.074692904198, 9754.02459754026, 9756.804863902718, 9549.045095490465, 9644.614215431375, 9682.612695492207, 9717.416954982653, 9720.368176068532, 9556.856647150298, 9580.0898914603, 9652.662156824477, 9691.757706057335, 9764.951175244149, 40162.598374016474, 40373.394399084034, 40523.797381012904, 40684.0, 41064.0, 3085.568020477135, 3314.5193946877566, 3456.1877958679943, 3476.644108797571, 3505.1237190702323, 30870.38259234803, 30949.0, 31365.37269254602, 31867.362652746815, 32026.0, 2632.657754491923, 3081.229692576856, 3097.5198844178963, 3141.764367672411, 3236.12624591359, 426298.0, 430669.0, 432491.0, 432622.8368858167, 435686.0, 32400.83799580987, 32653.0, 32853.67146328506, 32885.50671739926, 32895.177620559676, 34819.65180348215, 35201.0, 35318.64681353154, 35541.0, 36069.819650901576, 16272.43046493367, 16785.748213776802, 16826.158692065346, 16842.49472515802, 16856.662866742598, 12819.294938778457, 12896.032797540222, 12905.290209038592, 12915.806262906064, 12938.741225175443, 18485.7227141593, 19380.072260296256, 19878.90060549717, 19955.002249887737, 20034.89982550078, 6693.832654183684, 6827.0, 6949.722011119498, 7074.292570742988, 8241.546714930617, 864.2351518905814, 979.774651830083, 1021.5658345203259, 1055.9947200264103, 1061.3154515337565, 30277.545836812464, 30653.540196897065, 31104.0, 31357.745690172138, 31421.214469638442, 1034.9741256468649, 1055.773008803111, 1082.7293176705823, 1087.4617064553097, 1138.3340745663713, 12629.93685031569, 15962.60093497672, 16024.19879006045, 16085.678286434206, 16271.430499932445, 576536.0, 683871.0, 688301.0, 694905.0, 697120.0, 57838.37293016549, 58382.83234335289, 59367.703161483914, 59499.70250148721, 59626.80746385048, 1358.7146699193281, 1386.9653258668613, 1398.9580312590638, 1400.5378225185664, 1403.9259966125921, 29938.0, 30268.394632107676, 30360.0, 30507.847460762554, 30632.234194144432, 52818.0, 53026.469735302155, 53308.73345633402, 53373.46626533685, 53393.0, 423373.0, 423406.0, 424123.0, 424935.0, 427172.0, 26669.0, 27298.454030919667, 27695.0, 27750.306242344104, 27761.58357624597, 48655.78360541015, 48760.75619621879, 49283.507164929324, 50259.74870125626, 50627.746861265456, 35374.823125884206, 39814.2037159261, 40771.77684669464, 40817.0, 41394.96512587209, 34163.0, 40537.79731101444, 41040.0, 41308.58691413047, 41795.9551011215, 39567.604323957545, 39572.604273956895, 39962.80111596657, 40338.798306008284, 40598.0, 31884.681153188172, 31947.0, 35236.94289171329, 35523.0, 36066.4590031155, 26280.8685956569, 26462.867685661447, 26470.338241544116, 26744.732552674224, 26828.0], "value": 19375.210751671668, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.49563845351105, 380.45214890557594, 385.77624977513045, 394.8361430006547, 406.5223362549006, 18450.723239151408, 19993.500162495944, 20579.073941672625, 20718.585628287427, 20765.896170519147, 19003.42989710311, 19272.710909336372, 19507.927064011474, 19649.70525442116, 19770.802291977077, 5522.0, 5568.972155139219, 5689.3172819261745, 5778.104393818965, 5953.613015154001, 5811.186433899236, 5846.093855452412, 5851.531877449794, 5885.646861188342, 5901.23283973085, 4874.707517548958, 4912.852614421573, 5754.1944127822135, 5783.958887400267, 5790.0, 5673.574481913873, 5680.886382272352, 5692.203091567184, 5806.622569532988, 5845.7369418376065, 5028.974855125737, 5055.241713742931, 5094.032133894548, 5137.434882162959, 5151.922721159186, 24100.75899241003, 24260.0, 24501.754982450126, 24629.507409851703, 24799.752002479923, 2017.3241963942096, 2458.1519375815315, 2670.639463672399, 2696.7707744841714, 3046.2536678513684, 9410.247180225566, 9858.507074646239, 9983.400995940267, 10010.64962726301, 10069.54687039085, 1494.3574263066878, 1544.3050627217797, 1800.729890516433, 1895.895725735084, 1929.3150931419284, 81263.9999999994, 115884.0, 120372.0, 124053.0, 124934.0, 9380.8592871107, 10954.342739435659, 10979.505922233519, 11570.710732231762, 11716.94141529304, 14320.283985800668, 14360.0, 14384.136951782717, 14386.0, 14441.49454769078, 8244.422890397735, 8490.108538603481, 8494.74515764528, 8624.180702833346, 8661.956690216508, 8367.372447066495, 8492.830143397097, 8530.530820804792, 8664.263537599249, 8676.566171691391, 3604.7837129772297, 4497.88755281114, 4516.07420478801, 4566.337881007235, 4584.885377865513, 1691.7885264341958, 1895.9620807583772, 1937.3703546347494, 1938.5056810513229, 1943.494691380223, 700.9065857262686, 798.3732769775698, 939.9765005874908, 978.1881038737973, 993.9861341431699, 19902.701459478118, 21165.259215927676, 21175.117947904422, 21258.854523367794, 21411.571768564543, 952.7141857442739, 987.7431867714303, 1008.1581879130861, 1046.387863100095, 1051.0960573906434, 10835.891641083488, 10852.403117828595, 11212.887871121347, 11855.525778968917, 11940.283582984875, 618801.0, 621922.0, 623760.0, 631059.0, 633679.0, 79298.20701793024, 127579.0, 140504.29747851196, 141824.0, 143097.0, 1052.1214785654065, 1055.0428954289835, 1087.521490544158, 1089.373610174153, 1089.7929393415225, 18802.811971880652, 18896.622067558295, 18970.0, 19038.809611903704, 19301.613967720285, 55802.0, 56838.57903552279, 57486.7125664369, 57619.423805761406, 57869.13196302143, 82695.75956360539, 83267.0, 83475.16524834673, 85101.57449212714, 86236.70644940456, 6839.0, 7505.624718763931, 7543.3965282778345, 7545.811354716176, 7553.524415081305, 12478.313692746986, 12996.285204313475, 13098.607041788762, 13201.471941122247, 13431.664208394477, 11413.078625973054, 11528.538858445569, 11688.94155529217, 11689.181757276909, 11701.88298117042, 10866.348019118563, 11043.282186657842, 11196.992270695677, 11237.3257604544, 11350.489227984926, 10873.836892446461, 11348.205625606128, 11783.823242651195, 11912.702182445162, 11985.0, 7310.451716121419, 7389.704411823467, 7433.851322973402, 7603.9619801900635, 7647.770566883002, 8318.500889946623, 8738.868916966378, 9178.852643419572, 11309.377984210947, 11762.58830940913], "value": 9506.115474032886, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.5808670268864, 1343.1471015904901, 1444.927753612319, 1769.0712376002598, 1821.6356728654273, 7850.175731548191, 8220.424570280084, 8220.465669731464, 8749.343799215068, 8772.69295574655, 7124.145102587684, 8406.117357677433, 8536.829263414727, 8559.27246184075, 8578.44240124393, 2330.8951097200625, 2353.6351865460797, 2357.728861180969, 2357.882105894707, 2363.385519764865, 2172.2397160993683, 2233.452804062999, 2247.6516139998325, 2259.401258666455, 2268.5009297954425, 1968.8424926005957, 2096.821770149539, 2257.7403598586206, 2331.1374791327235, 2354.5879471092576, 2319.512902290521, 2350.518143780521, 2352.7882490575757, 2357.6109941859486, 2361.315218586608, 2204.206485665159, 2213.4023813570248, 2214.202886960693, 2216.013873826148, 2218.2901471529117, 8580.442271252348, 8661.090585488559, 8694.39139260252, 8707.956460217658, 8713.695020674246, 5147.202183661539, 5194.4026436959475, 5216.243644671501, 5261.421243663194, 5262.526372626482, 2940.1326608650284, 3435.914102147441, 3578.3380074686265, 3587.1749497615433, 3629.0927268182954, 1080.902718755308, 1086.9891301086966, 1091.4160923905672, 1094.956201751937, 1115.570505355436, 11152.60965866199, 11416.54333826646, 11428.885711142866, 11452.370119643416, 11460.025897798698, 4512.796924138422, 4515.706479078849, 4673.953260467351, 4750.287456881495, 4752.95247047532, 9625.855612165824, 9671.516424178762, 9761.121499065119, 9772.413655180711, 9773.951130244302, 5237.607179461479, 5267.868303292448, 5278.0, 5279.656822306538, 5281.102212623787, 4330.415393921843, 4652.348671186037, 4778.378810754649, 4798.904021919542, 4808.326834243208, 3792.810359482015, 3919.392494163409, 3964.147708242742, 3975.960240397559, 4032.6773858091283, 1288.4652869059423, 1298.5909438526835, 1299.1815156451564, 1303.2831942431624, 1308.0647337153791, 827.8054657155564, 866.9033672404413, 914.5838643417229, 938.9201917836924, 960.6205548808182, 5763.250777398911, 5818.389069147764, 5939.584229103922, 5951.047832346891, 6074.0, 447.2173696031944, 450.2750571579754, 451.38611488375784, 456.59591261733607, 459.91491574058904, 3949.861754838567, 4010.0977280111742, 4132.132252227006, 4135.069609337875, 4147.336426171798, 10110.0, 10219.029192226726, 10352.844707329396, 10454.059134677915, 10564.418956957288, 10323.380597164194, 10349.896501035044, 10495.580176792842, 10523.631672891412, 10531.789364212673, 7964.323032542299, 7990.680372785024, 7992.880106798402, 7999.400044996649, 8123.553204573687, 5791.652500849962, 5818.796342128006, 5847.619904706181, 5955.67243801595, 5974.014287642491, 9714.222862171151, 9834.803303934024, 9836.21310295189, 9899.406035637885, 9914.652987145415, 9580.66467673628, 9977.151942085004, 10030.197584193393, 10033.14718248957, 10057.899421005697, 6846.486513511606, 7132.108486439195, 7286.635668216462, 7409.962950185214, 7513.887291690519, 8080.030396352476, 8229.177082291722, 8267.958660206661, 8271.421000529905, 8275.62759675828, 7194.388476979515, 7291.015712878693, 7302.598357090411, 7386.96306518464, 7431.888521672287, 7169.605671687898, 7229.530080544748, 7232.16098316976, 7239.601821899846, 7263.418926485974, 5767.0, 6762.96618516924, 6820.454363650797, 6890.758823441155, 6911.239763626098, 4036.4752582164133, 4968.8757781055765, 5014.6991180529285, 5035.84892453227, 5115.028144652504, 4198.6431153352305, 4815.22956327, 4829.13075646387, 4869.220924652039, 4900.0], "value": 4414.78481462438, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [254.2778509034342, 302.3801207524574, 308.3555369278209, 315.33149722588115, 317.4508100985297, 4691.8123275069, 5365.0, 5503.559715222783, 5581.302337207849, 5718.1994520767075, 4476.888077798057, 5530.866172434651, 5610.915836262449, 5658.688772117532, 5679.772809087632, 3749.43758436234, 4343.717658352213, 4345.521992580813, 4347.413099231595, 4379.649628029766, 3939.9606003940025, 4315.654747620183, 4329.783510824446, 4331.6534677225745, 4387.978060109695, 4280.678949078816, 4292.720973136752, 4301.698881078326, 4306.224879521685, 4313.913721725564, 3672.5042119313816, 4267.743935363857, 4285.185814695214, 4288.463942007249, 4306.44016277885, 3604.891138683873, 3709.5919448860604, 3733.290674771785, 3744.157564547982, 3753.11801726594, 4490.3488994096, 4530.841420550298, 5475.397706252309, 5535.778568857241, 5539.473749993744, 4553.021100463383, 4917.975410122962, 4937.456879743226, 4942.975285123587, 4977.50224977503, 5612.66324020556, 5753.88492230153, 6046.304674962392, 6054.909176362358, 6068.271807383142, 3534.8437453153556, 4089.386592011222, 4093.140440507497, 4129.442525259082, 4145.66834653227, 6296.496280297565, 6327.303996560375, 6422.871542569169, 6427.585931095152, 6468.611883286971, 3498.510208570802, 3565.841101641977, 3951.1110000250287, 4087.4481944937647, 4108.958910410917, 3742.7812081609795, 3885.4560361549406, 4158.771267580251, 4212.831486740557, 4259.488861336659, 4520.728756274634, 4786.946871688293, 4948.6783359082265, 4956.21576232556, 4980.203167493256, 5401.567874570025, 5815.82552523425, 6074.362191969868, 6075.969620151959, 6082.36135205797, 1305.5508385691874, 1364.9217118476292, 1406.2476575032513, 1442.6826098258575, 1444.2634256529036, 745.02401853572, 784.811645205158, 834.7161964931952, 839.8614228652204, 882.5851849630664, 4010.7994600270454, 4030.7581545107387, 4703.800530864608, 4785.736784476818, 4809.879753006203, 4587.8623641290815, 4671.556202160789, 5037.697738135724, 5142.460041695643, 5250.715938566659, 4237.948676952589, 4242.618164365222, 4322.459692538433, 4410.977945110318, 4764.023375208074, 2909.5926570280176, 3126.03093041158, 3234.0, 3271.8384973334123, 3274.950875736866, 6201.1938448002375, 6211.81364559064, 6322.996576626158, 6385.329540398284, 6475.089848494706, 4960.454350021495, 5993.850153746104, 6317.368263173646, 6326.49388048955, 6419.454346380517, 5110.897782044412, 5426.620136590401, 6357.078223657451, 6368.426841584187, 6428.678566071678, 5122.769475373691, 5680.289963754531, 5965.34381218057, 6210.944139496387, 6217.906731398942, 5108.2160222677985, 5337.22610221508, 5935.614185077956, 6052.636841789506, 6141.324454309933, 6353.5870168438905, 6417.48660107181, 6417.5666018679785, 6459.09340796634, 6474.870502590016, 3637.3270944875285, 3691.944620830636, 3808.8286027128293, 3948.684105271629, 3977.085270387885, 5755.81279113934, 5786.739596718074, 6039.48664363534, 6057.848553786191, 6105.84735381619, 5212.5569326607665, 5412.323459567554, 5857.941420585739, 5877.35349111606, 5942.673152976455, 4875.219964805614, 5108.821191258288, 5791.7683292667825, 5891.731683301874, 5912.438318359749, 4852.350200931559, 5761.971190144022, 5764.654120752768, 5783.987802134526, 5847.26909136358, 4746.38297021385, 5408.945910540844, 5682.318121825408, 5859.94140058594, 5933.317668468181, 5444.700541470257, 5673.375928647928, 5693.715314234355, 5696.487316141567, 5704.629199102045], "value": 4233.023890535199, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.7455553278583, 717.48699679729, 773.6286582440429, 782.6595430987525, 829.4774292195917, 15192.164430956307, 15662.0, 15878.52364429066, 15888.523344299661, 15924.363025478982, 14340.211288379134, 14479.276036198175, 14496.5651030469, 14504.0, 14543.3455494503, 690.851466934609, 831.2394159344223, 846.6824940647273, 856.6744637037917, 868.409481552544, 847.3644766425181, 860.1871231686059, 860.9009963854174, 861.732862812527, 863.4732812984074, 893.6202114101513, 926.5043201886991, 926.6293482606944, 928.0209379105041, 930.1210356213381, 779.6491578789568, 838.7441830241773, 885.1767855894049, 923.1276443760615, 931.6925414613162, 528.6801485101497, 598.7455331484146, 677.7187467201105, 681.3901558105467, 682.5154140560209, 14689.77965330521, 14824.925875370662, 14856.925715371463, 14879.553613391616, 14904.0, 12128.45421956014, 12214.694632634255, 12298.20061695987, 12344.753104937941, 12871.163374380636, 11612.303261804318, 11780.0, 11874.16880818343, 11901.94049029758, 12134.939325303405, 4584.174848527264, 4640.09518143962, 4775.594074503671, 4819.108464933998, 4829.323894654716, 85819.57090214572, 108914.45542772315, 109222.0, 112368.4381578095, 114067.99999999917, 10892.61875834342, 10925.562977480971, 10941.671749847517, 10973.670789876316, 11085.002349788558, 20398.592028159354, 20841.186439830733, 20859.061342239635, 20861.895690521753, 20893.37319880406, 7782.426361949438, 7792.805179870548, 7886.329661978796, 8070.47541909774, 8084.757457276173, 4321.67587430944, 4326.15639950213, 4373.497047839539, 4382.956170438255, 4394.802233899482, 3384.1370450534955, 3481.47777833327, 3503.2292895562937, 3559.715222782171, 3560.839762210707, 656.5601047298321, 656.9474442044625, 675.2133764164693, 679.4496457869043, 680.5950459476603, 530.578190338674, 559.1863838115532, 574.5719439017959, 578.7540295374449, 632.2065807411669, 8645.351598630128, 9529.714108576754, 9985.550650220757, 10627.256092073636, 11010.0, 550.3918170421706, 663.075010360554, 672.9562578432484, 680.938715515606, 689.5724650716487, 4530.22986092365, 4643.674942754043, 4716.221823399101, 4886.21820508724, 4985.102681517289, 86890.1310986882, 87130.0, 87742.56128719315, 119425.40287298508, 139462.0, 115303.0, 127495.36252318679, 129640.0, 132500.0, 132516.0, 107676.0, 109428.4528577352, 113483.43258283655, 113615.0, 114961.4251928735, 9365.906340936503, 9426.528673566432, 9439.0, 9471.715848524555, 9518.0, 61305.0, 63032.36967630265, 63379.0, 64674.676626616565, 65339.67330163509, 82793.0, 89523.65714514417, 91603.0, 94442.52778736337, 96050.0, 12187.390630468264, 12329.198602091194, 12335.0, 12348.3825808711, 12505.624831255076, 12554.937225313815, 13944.790828137384, 14018.088824226392, 14453.855461445251, 14502.1298722077, 12069.27584344942, 13490.66273343135, 13511.121777084458, 13532.72934541284, 13704.45182192741, 12698.746025079632, 13897.749202571817, 14181.0, 14570.85429145695, 15111.924440378167, 14105.083169593943, 14255.572332830032, 14378.640533986316, 14649.12105273687, 14707.705845882809, 11360.886391136313, 11512.53949841997, 11581.768364632828, 11630.0, 12069.336186509827, 10474.68575942723, 10501.947490262806, 10809.783804324026, 11509.94245028803, 11783.52865885355], "value": 7757.9063597564655, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1590.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 126.0, 106.0, 98.0, 163.0, 169.0, 164.0, 117.0, 146.0, 164.0], "value": 135.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 91.0, 135.0, 153.0, 138.0, 165.0, 158.0, 108.0, 158.0, 110.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 204.0, 218.0, 199.0, 191.0, 200.0, 196.0, 199.0, 198.0, 201.0], "value": 199.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 87.0, 76.0, 145.0, 58.0, 59.0, 60.0, 62.0, 147.0, 85.0], "value": 86.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 117.0, 72.0, 71.0, 74.0, 114.0, 70.0, 74.0, 124.0], "value": 85.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 131.0, 89.0, 87.0, 88.0, 85.0, 89.0, 86.0, 90.0, 86.0], "value": 96.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 102.0, 152.0, 151.0, 97.0, 95.0, 96.0, 95.0, 95.0], "value": 107.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 90.0, 91.0, 90.0, 140.0, 153.0, 95.0, 91.0, 89.0, 136.0], "value": 107.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 55.0, 55.0, 56.0, 55.0, 47.0, 47.0, 77.0, 85.0], "value": 59.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 73.0, 59.0, 86.0, 102.0, 109.0, 103.0, 73.0, 68.0, 73.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 88.0, 81.0, 81.0, 74.0, 104.0, 98.0, 109.0, 103.0], "value": 90.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 138.0, 142.0, 155.0, 125.0, 147.0, 157.0, 161.0, 137.0, 149.0], "value": 145.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 167.0, 166.0, 217.0, 158.0, 225.0, 229.0, 169.0, 170.0], "value": 183.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 66.0, 73.0, 88.0, 85.0, 88.0, 61.0, 77.0, 88.0], "value": 76.0, "unit": "score"}]}]} 13:59:27 INFO - Return code: 0 13:59:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:59:27 ERROR - # TBPL SUCCESS # 13:59:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:59:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:59:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:59:28 INFO - 2016-08-05 13:59:28.002 screenresolution[1670:10392] starting screenresolution argv=screenresolution get 13:59:28 INFO - 2016-08-05 13:59:28.005 screenresolution[1670:10392] Display 0: 1600x1200x32@60 13:59:28 INFO - 2016-08-05 13:59:28.010 screenresolution[1671:10395] starting screenresolution argv=screenresolution list 13:59:28 INFO - Available Modes on Display 0 13:59:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:59:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:59:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:59:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:59:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:59:28 INFO - Intel Iris: 13:59:28 INFO - Chipset Model: Intel Iris 13:59:28 INFO - Type: GPU 13:59:28 INFO - Bus: Built-In 13:59:28 INFO - VRAM (Dynamic, Max): 1536 MB 13:59:28 INFO - Vendor: Intel (0x8086) 13:59:28 INFO - Device ID: 0x0a2e 13:59:28 INFO - Revision ID: 0x0009 13:59:28 INFO - Displays: 13:59:28 INFO - Display: 13:59:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:59:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:59:28 INFO - Display Serial Number: 1600x1200 60 13:59:28 INFO - Main Display: Yes 13:59:28 INFO - Mirror: Off 13:59:28 INFO - Online: Yes 13:59:28 INFO - Rotation: Supported 13:59:28 INFO - Return code: 0 13:59:28 INFO - Running post-action listener: _resource_record_post_action 13:59:28 INFO - [mozharness: 2016-08-05 20:59:28.245160Z] Finished run-tests step (success) 13:59:28 INFO - Running post-run listener: _resource_record_post_run 13:59:28 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 37114880; Write bytes: 706512896; Read time: 237; Write time: 1972 13:59:28 INFO - TinderboxPrint: CPU usage
54.2% 13:59:28 INFO - TinderboxPrint: I/O read bytes / time
37,114,880 / 237 13:59:28 INFO - TinderboxPrint: I/O write bytes / time
706,512,896 / 1,972 13:59:28 INFO - TinderboxPrint: CPU idle
2,217.3 (45.8%) 13:59:28 INFO - TinderboxPrint: CPU system
974.8 (20.1%) 13:59:28 INFO - TinderboxPrint: CPU user
1,649.6 (34.1%) 13:59:28 INFO - TinderboxPrint: Swap in / out
455,905,280 / 0 13:59:28 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 405391872; Write bytes: 407476224; Read time: 30071; Write time: 815 13:59:28 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 34456576; Write bytes: 297484288; Read time: 213; Write time: 1151 13:59:28 INFO - Running post-run listener: _upload_blobber_files 13:59:28 INFO - Blob upload gear active. 13:59:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:59: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 13:59: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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:59: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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:59:29 INFO - (blobuploader) - INFO - Open directory for files ... 13:59:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:59:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:59:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:59:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:59:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:59:30 INFO - (blobuploader) - INFO - Done attempting. 13:59:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:59:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:59:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:59:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:59:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:59:31 INFO - (blobuploader) - INFO - Done attempting. 13:59:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:59:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:59:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:59:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:59:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:59:33 INFO - (blobuploader) - INFO - Done attempting. 13:59:33 INFO - (blobuploader) - INFO - Iteration through files over. 13:59:33 INFO - Return code: 0 13:59:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:59:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:59:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/52fd285f220778f06383ddf633f55e89024efe97c4f1b9af93acd97714a604875bef4cc9f82c75c2a317d9df58147fcd40948f69e7089765991a437223bd4f3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9a66de77247b18faa03cd01ea58a916affc887df06e77d5fbb7b01f5d8438a94567bf2d7a9e4f98462a09d7570c7ac2828fd27539d9647679d99e3a1bd3a372a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e81b8d35ec3f8f2ee4bb861b6460c13c59809342ff7fa35c7025d1c861a1849c2bd423dea70eb41a3c589f96dae149625146777f9732e7510d938ce931a6216e"} 13:59:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:59:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:59:33 INFO - Contents: 13:59:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/52fd285f220778f06383ddf633f55e89024efe97c4f1b9af93acd97714a604875bef4cc9f82c75c2a317d9df58147fcd40948f69e7089765991a437223bd4f3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9a66de77247b18faa03cd01ea58a916affc887df06e77d5fbb7b01f5d8438a94567bf2d7a9e4f98462a09d7570c7ac2828fd27539d9647679d99e3a1bd3a372a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e81b8d35ec3f8f2ee4bb861b6460c13c59809342ff7fa35c7025d1c861a1849c2bd423dea70eb41a3c589f96dae149625146777f9732e7510d938ce931a6216e"} 13:59:33 INFO - Running post-run listener: copy_logs_to_upload_dir 13:59:33 INFO - Copying logs to upload dir... 13:59:33 INFO - mkdir: /builds/slave/test/build/upload/logs 13:59:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.429494 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-05 13:59:33.826054) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 13:59:33.829411) ========= 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.GjfDHzaGuZ/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.0KCYaPGb1s/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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/Autoland/sha512/52fd285f220778f06383ddf633f55e89024efe97c4f1b9af93acd97714a604875bef4cc9f82c75c2a317d9df58147fcd40948f69e7089765991a437223bd4f3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9a66de77247b18faa03cd01ea58a916affc887df06e77d5fbb7b01f5d8438a94567bf2d7a9e4f98462a09d7570c7ac2828fd27539d9647679d99e3a1bd3a372a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e81b8d35ec3f8f2ee4bb861b6460c13c59809342ff7fa35c7025d1c861a1849c2bd423dea70eb41a3c589f96dae149625146777f9732e7510d938ce931a6216e"} build_url:https://queue.taskcluster.net/v1/task/c7SUe_zNSkS7iCtqMgK0uA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011317 build_url: 'https://queue.taskcluster.net/v1/task/c7SUe_zNSkS7iCtqMgK0uA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/52fd285f220778f06383ddf633f55e89024efe97c4f1b9af93acd97714a604875bef4cc9f82c75c2a317d9df58147fcd40948f69e7089765991a437223bd4f3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9a66de77247b18faa03cd01ea58a916affc887df06e77d5fbb7b01f5d8438a94567bf2d7a9e4f98462a09d7570c7ac2828fd27539d9647679d99e3a1bd3a372a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e81b8d35ec3f8f2ee4bb861b6460c13c59809342ff7fa35c7025d1c861a1849c2bd423dea70eb41a3c589f96dae149625146777f9732e7510d938ce931a6216e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 13:59:33.867686) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 13:59:33.868236) ========= 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.GjfDHzaGuZ/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.0KCYaPGb1s/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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.004869 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 13:59:33.919527) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 13:59:33.920222) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 13:59:33.920831) ========= ========= Total master_lag: 0.18 =========