builder: pine_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-011 starttime: 1490321256.91 results: success (0) revision: 5117704c9361e4b9a3eee82d1ce4a9d93222e6be ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 19:07:36.911719) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 19:07:36.912129) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 19:07:36.912393) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 19:07:36.926549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 19:07:36.926808) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1490321256.551566-107350318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-23 19:07:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2017-03-23 19:07:37 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124948 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 19:07:37.065076) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 19:07:37.065373) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1490321256.551566-107350318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016798 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 19:07:37.114343) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 19:07:37.114626) ========= bash -c 'python archiver_client.py mozharness --repo projects/pine --rev 5117704c9361e4b9a3eee82d1ce4a9d93222e6be --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo projects/pine --rev 5117704c9361e4b9a3eee82d1ce4a9d93222e6be --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1490321256.551566-107350318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-23 19:07:37,359 truncating revision to first 12 chars 2017-03-23 19:07:37,360 Setting DEBUG logging. 2017-03-23 19:07:37,360 attempt 1/10 2017-03-23 19:07:37,360 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/pine/5117704c9361?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-23 19:07:37,656 unpacking tar archive at: pine-5117704c9361/testing/mozharness/ program finished with exit code 0 elapsedTime=0.652206 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 19:07:37.779779) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 19:07:37.780107) ========= script_repo_revision: 5117704c9361e4b9a3eee82d1ce4a9d93222e6be ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 19:07:37.780489) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 19:07:37.780748) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 19:07:37.788989) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-23 19:07:37.789262) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Pine --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 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', 'Pine', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Pine'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1490321256.551566-107350318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:07:38 INFO - MultiFileLogger online at 20170323 19:07:38 in /builds/slave/test 19:07:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Pine --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 19:07:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:07:38 INFO - {'append_to_log': False, 19:07:38 INFO - 'base_work_dir': '/builds/slave/test', 19:07:38 INFO - 'blob_upload_branch': 'Pine', 19:07:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:07:38 INFO - 'branch': 'Pine', 19:07:38 INFO - 'buildbot_json_path': 'buildprops.json', 19:07:38 INFO - 'config_files': ('talos/linux_config.py',), 19:07:38 INFO - 'default_actions': ('clobber', 19:07:38 INFO - 'read-buildbot-config', 19:07:38 INFO - 'download-and-extract', 19:07:38 INFO - 'populate-webroot', 19:07:38 INFO - 'create-virtualenv', 19:07:38 INFO - 'install', 19:07:38 INFO - 'run-tests'), 19:07:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:07:38 INFO - 'download_minidump_stackwalk': True, 19:07:38 INFO - 'download_symbols': 'ondemand', 19:07:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:07:38 INFO - 'tooltool.py': '/tools/tooltool.py', 19:07:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:07:38 INFO - '/tools/misc-python/virtualenv.py')}, 19:07:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:07:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:07:38 INFO - 'gecko_profile': False, 19:07:38 INFO - 'gecko_profile_interval': 0, 19:07:38 INFO - 'installer_path': 'installer.exe', 19:07:38 INFO - 'log_level': 'info', 19:07:38 INFO - 'log_name': 'talos', 19:07:38 INFO - 'log_to_console': True, 19:07:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:07:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:07:38 INFO - 'opt_config_files': (), 19:07:38 INFO - 'pip_index': False, 19:07:38 INFO - 'suite': 'dromaeojs-e10s', 19:07:38 INFO - 'system_bits': '32', 19:07:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:07:38 INFO - 'title': 'talos-linux64-ix-011', 19:07:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:07:38 INFO - 'use_talos_json': True, 19:07:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:07:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:07:38 INFO - 'work_dir': 'build'} 19:07:38 INFO - [mozharness: 2017-03-24 02:07:38.133661Z] Running clobber step. 19:07:38 INFO - Running pre-action listener: _resource_record_pre_action 19:07:38 INFO - Running main action method: clobber 19:07:38 INFO - rmtree: /builds/slave/test/build 19:07:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:07:39 INFO - Running post-action listener: _resource_record_post_action 19:07:39 INFO - [mozharness: 2017-03-24 02:07:39.069914Z] Finished clobber step (success) 19:07:39 INFO - [mozharness: 2017-03-24 02:07:39.070014Z] Running read-buildbot-config step. 19:07:39 INFO - Running pre-action listener: _resource_record_pre_action 19:07:39 INFO - Running main action method: read_buildbot_config 19:07:39 INFO - Using buildbot properties: 19:07:39 INFO - { 19:07:39 INFO - "project": "", 19:07:39 INFO - "product": "firefox", 19:07:39 INFO - "who": "dmosedale@mozilla.com", 19:07:39 INFO - "installer_path": "public/build/target.tar.bz2", 19:07:39 INFO - "builddir": "pine_ubuntu64_hw_test-dromaeojs-e10s", 19:07:39 INFO - "repository": "https://hg.mozilla.org/projects/pine/", 19:07:39 INFO - "buildername": "Ubuntu HW 12.04 x64 pine talos dromaeojs-e10s", 19:07:39 INFO - "stage_platform": "linux64", 19:07:39 INFO - "basedir": "/builds/slave/test", 19:07:39 INFO - "buildnumber": 4, 19:07:39 INFO - "platform": "ubuntu64_hw", 19:07:39 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:07:39 INFO - "slavebuilddir": "test", 19:07:39 INFO - "taskId": "RCeBrGzER0iI8pGR8RvkVw", 19:07:39 INFO - "branch": "pine", 19:07:39 INFO - "script_repo_revision": "default", 19:07:39 INFO - "revision": "5117704c9361e4b9a3eee82d1ce4a9d93222e6be", 19:07:39 INFO - "slavename": "talos-linux64-ix-011", 19:07:39 INFO - "repo_path": "projects/pine" 19:07:39 INFO - } 19:07:39 INFO - Finding installer, test and symbols from parent task. 19:07:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RCeBrGzER0iI8pGR8RvkVw'}, attempt #1 19:07:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RCeBrGzER0iI8pGR8RvkVw'}, attempt #1 19:07:40 INFO - Task dependencies: En4_ybPfRAirG61usP7e7w 19:07:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/En4_ybPfRAirG61usP7e7w'}, attempt #1 19:07:40 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/En4_ybPfRAirG61usP7e7w/artifacts/public/build/target.tar.bz2 19:07:40 INFO - Set test_url: https://queue.taskcluster.net/v1/task/En4_ybPfRAirG61usP7e7w/artifacts/public/build/test_packages.json 19:07:40 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/En4_ybPfRAirG61usP7e7w/artifacts/public/build/target.crashreporter-symbols.zip 19:07:40 INFO - Running post-action listener: _resource_record_post_action 19:07:40 INFO - [mozharness: 2017-03-24 02:07:40.468021Z] Finished read-buildbot-config step (success) 19:07:40 INFO - [mozharness: 2017-03-24 02:07:40.468239Z] Running download-and-extract step. 19:07:40 INFO - Running pre-action listener: _resource_record_pre_action 19:07:40 INFO - Running main action method: download_and_extract 19:07:40 INFO - mkdir: /builds/slave/test/build/tests 19:07:40 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')]} 19:07:40 INFO - trying https://queue.taskcluster.net/v1/task/En4_ybPfRAirG61usP7e7w/artifacts/public/build/target.test_packages.json 19:07:40 INFO - Downloading https://queue.taskcluster.net/v1/task/En4_ybPfRAirG61usP7e7w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:07:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/En4_ybPfRAirG61usP7e7w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:07:41 INFO - Downloaded 986 bytes. 19:07:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:07:41 INFO - Using the following test package requirements: 19:07:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:07:41 INFO - u'common': [u'target.common.tests.zip'], 19:07:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:07:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:07:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:07:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:07:41 INFO - u'mozbase': [u'target.common.tests.zip'], 19:07:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:07:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:07:41 INFO - u'web-platform': [u'target.common.tests.zip', 19:07:41 INFO - u'target.web-platform.tests.zip'], 19:07:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:07:41 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:07:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/En4_ybPfRAirG61usP7e7w/artifacts/public/build/target.common.tests.zip 19:07:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/En4_ybPfRAirG61usP7e7w/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:07:41 INFO - Fetch https://queue.taskcluster.net/v1/task/En4_ybPfRAirG61usP7e7w/artifacts/public/build/target.common.tests.zip into memory 19:07:42 INFO - Expected file size: 58125554 19:07:42 INFO - Obtained file size: 58125554 19:07:52 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:07:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/En4_ybPfRAirG61usP7e7w/artifacts/public/build/target.common.tests.zip 19:07:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/En4_ybPfRAirG61usP7e7w/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:07:52 INFO - Fetch https://queue.taskcluster.net/v1/task/En4_ybPfRAirG61usP7e7w/artifacts/public/build/target.common.tests.zip into memory 19:07:53 INFO - Expected file size: 58125554 19:07:53 INFO - Obtained file size: 58125554 19:08:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/En4_ybPfRAirG61usP7e7w/artifacts/public/build/target.talos.tests.zip 19:08:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/En4_ybPfRAirG61usP7e7w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:08:03 INFO - Fetch https://queue.taskcluster.net/v1/task/En4_ybPfRAirG61usP7e7w/artifacts/public/build/target.talos.tests.zip into memory 19:08:04 INFO - Expected file size: 14404171 19:08:04 INFO - Obtained file size: 14404171 19:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:04 INFO - trying https://queue.taskcluster.net/v1/task/En4_ybPfRAirG61usP7e7w/artifacts/public/build/target.tar.bz2 19:08:04 INFO - Downloading https://queue.taskcluster.net/v1/task/En4_ybPfRAirG61usP7e7w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:08:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/En4_ybPfRAirG61usP7e7w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:08:06 INFO - Downloaded 62476328 bytes. 19:08:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/En4_ybPfRAirG61usP7e7w/artifacts/public/build/target.tar.bz2 19:08:06 INFO - mkdir: /builds/slave/test/properties 19:08:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:08:06 INFO - Writing to file /builds/slave/test/properties/build_url 19:08:06 INFO - Contents: 19:08:06 INFO - build_url:https://queue.taskcluster.net/v1/task/En4_ybPfRAirG61usP7e7w/artifacts/public/build/target.tar.bz2 19:08:06 INFO - Running post-action listener: _resource_record_post_action 19:08:06 INFO - Running post-action listener: set_extra_try_arguments 19:08:06 INFO - [mozharness: 2017-03-24 02:08:06.453205Z] Finished download-and-extract step (success) 19:08:06 INFO - [mozharness: 2017-03-24 02:08:06.453302Z] Running populate-webroot step. 19:08:06 INFO - Running pre-action listener: _resource_record_pre_action 19:08:06 INFO - Running main action method: populate_webroot 19:08:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:08:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:08:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:08:06 INFO - '--tppagecycles', 19:08:06 INFO - '7'], 19:08:06 INFO - 'tests': ['tsvgm']}}, 19:08:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:08:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:08:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:08:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:08:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:08:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:08:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:08:06 INFO - 'talos_options': ['--disable-e10s'], 19:08:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:08:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:08:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:08:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:08:06 INFO - 'talos_options': ['--disable-e10s'], 19:08:06 INFO - 'tests': ['damp', 'tps']}, 19:08:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:08:06 INFO - 'tests': ['damp', 'tps']}, 19:08:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:08:06 INFO - 'tests': ['dromaeo_dom']}, 19:08:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:08:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:08:06 INFO - 'tests': ['basic_compositor_video']}, 19:08:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:08:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:08:06 INFO - 'tests': ['a11yr', 19:08:06 INFO - 'ts_paint', 19:08:06 INFO - 'tpaint', 19:08:06 INFO - 'sessionrestore', 19:08:06 INFO - 'sessionrestore_no_auto_restore', 19:08:06 INFO - 'tabpaint']}, 19:08:06 INFO - 'other-e10s': {'tests': ['a11yr', 19:08:06 INFO - 'ts_paint', 19:08:06 INFO - 'tpaint', 19:08:06 INFO - 'sessionrestore', 19:08:06 INFO - 'sessionrestore_no_auto_restore', 19:08:06 INFO - 'tabpaint']}, 19:08:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:08:06 INFO - 'ts_paint', 19:08:06 INFO - 'tpaint', 19:08:06 INFO - 'sessionrestore', 19:08:06 INFO - 'sessionrestore_no_auto_restore', 19:08:06 INFO - 'tabpaint']}, 19:08:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:08:06 INFO - 'ts_paint', 19:08:06 INFO - 'tpaint', 19:08:06 INFO - 'sessionrestore', 19:08:06 INFO - 'sessionrestore_no_auto_restore', 19:08:06 INFO - 'tabpaint']}, 19:08:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:08:06 INFO - 'tests': ['a11yr', 19:08:06 INFO - 'ts_paint', 19:08:06 INFO - 'tpaint', 19:08:06 INFO - 'sessionrestore', 19:08:06 INFO - 'sessionrestore_no_auto_restore', 19:08:06 INFO - 'tabpaint']}, 19:08:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:08:06 INFO - 'tests': ['a11yr', 19:08:06 INFO - 'ts_paint', 19:08:06 INFO - 'tpaint', 19:08:06 INFO - 'sessionrestore', 19:08:06 INFO - 'sessionrestore_no_auto_restore', 19:08:06 INFO - 'tabpaint']}, 19:08:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:08:06 INFO - 'tests': ['tsvgx', 19:08:06 INFO - 'tsvgr_opacity', 19:08:06 INFO - 'tart', 19:08:06 INFO - 'tscrollx', 19:08:06 INFO - 'cart', 19:08:06 INFO - 'tsvg_static']}, 19:08:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:08:06 INFO - 'tsvgr_opacity', 19:08:06 INFO - 'tart', 19:08:06 INFO - 'tscrollx', 19:08:06 INFO - 'cart', 19:08:06 INFO - 'tsvg_static']}, 19:08:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:08:06 INFO - 'talos_options': ['--disable-e10s'], 19:08:06 INFO - 'tests': ['tp5o']}, 19:08:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:08:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:08:06 INFO - 'talos_options': ['--disable-e10s', 19:08:06 INFO - '--xperf_path', 19:08:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:08:06 INFO - 'tests': ['tp5n']}, 19:08:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:08:06 INFO - 'talos_options': ['--xperf_path', 19:08:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:08:06 INFO - 'tests': ['tp5n']}}, 19:08:06 INFO - 'talos.zip': {'path': '', 19:08:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:08:06 INFO - Running post-action listener: _resource_record_post_action 19:08:06 INFO - [mozharness: 2017-03-24 02:08:06.466433Z] Finished populate-webroot step (success) 19:08:06 INFO - [mozharness: 2017-03-24 02:08:06.466523Z] Running create-virtualenv step. 19:08:06 INFO - Running pre-action listener: _resource_record_pre_action 19:08:06 INFO - Running main action method: create_virtualenv 19:08:06 INFO - Creating virtualenv /builds/slave/test/build/venv 19:08:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:08:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:08:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:08:06 INFO - Using real prefix '/usr' 19:08:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:08:07 INFO - Installing distribute.............................................................................................................................................................................................done. 19:08:09 INFO - Installing pip.................done. 19:08:09 INFO - Return code: 0 19:08:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:08:09 INFO - Reading from file tmpfile_stdout 19:08:09 INFO - Output received: 19:08:09 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 19:08:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a290>, '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 0x106ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490321256.551566-107350318', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:08:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:08:09 INFO - Using env: {'DISPLAY': ':0', 19:08:09 INFO - 'HOME': '/home/cltbld', 19:08:09 INFO - 'LANG': 'en_US.UTF-8', 19:08:09 INFO - 'LANGUAGE': 'en_US:en', 19:08:09 INFO - 'LOGNAME': 'cltbld', 19:08:09 INFO - 'MAIL': '/var/mail/cltbld', 19:08:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:09 INFO - 'MOZ_NO_REMOTE': '1', 19:08:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:09 INFO - 'NO_EM_RESTART': '1', 19:08:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:09 INFO - 'PWD': '/builds/slave/test', 19:08:09 INFO - 'SHELL': '/bin/bash', 19:08:09 INFO - 'SHLVL': '1', 19:08:09 INFO - 'TERM': 'linux', 19:08:09 INFO - 'TMOUT': '86400', 19:08:09 INFO - 'USER': 'cltbld', 19:08:09 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490321256.551566-107350318', 19:08:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:09 INFO - '_': '/tools/buildbot/bin/python'} 19:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:09 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 19:08:09 INFO - Cleaning up... 19:08:09 INFO - Return code: 0 19:08:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xdcf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a290>, '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 0x106ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490321256.551566-107350318', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:08:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:08:09 INFO - Using env: {'DISPLAY': ':0', 19:08:09 INFO - 'HOME': '/home/cltbld', 19:08:09 INFO - 'LANG': 'en_US.UTF-8', 19:08:09 INFO - 'LANGUAGE': 'en_US:en', 19:08:09 INFO - 'LOGNAME': 'cltbld', 19:08:09 INFO - 'MAIL': '/var/mail/cltbld', 19:08:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:09 INFO - 'MOZ_NO_REMOTE': '1', 19:08:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:09 INFO - 'NO_EM_RESTART': '1', 19:08:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:09 INFO - 'PWD': '/builds/slave/test', 19:08:09 INFO - 'SHELL': '/bin/bash', 19:08:09 INFO - 'SHLVL': '1', 19:08:09 INFO - 'TERM': 'linux', 19:08:09 INFO - 'TMOUT': '86400', 19:08:09 INFO - 'USER': 'cltbld', 19:08:09 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490321256.551566-107350318', 19:08:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:09 INFO - '_': '/tools/buildbot/bin/python'} 19:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:09 INFO - Downloading/unpacking psutil>=3.1.1 19:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:08:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:08:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:08:11 INFO - Installing collected packages: psutil 19:08:11 INFO - Running setup.py install for psutil 19:08:11 INFO - building 'psutil._psutil_linux' extension 19:08:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:08:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:08:12 INFO - building 'psutil._psutil_posix' extension 19:08:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:08:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:08:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:08:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:08:12 INFO - Successfully installed psutil 19:08:12 INFO - Cleaning up... 19:08:12 INFO - Return code: 0 19:08:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:08: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')]} 19:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08: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')]} 19:08:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:12 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 0xdcf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a290>, '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 0x106ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490321256.551566-107350318', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:08:12 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 19:08:12 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 19:08:12 INFO - Using env: {'DISPLAY': ':0', 19:08:12 INFO - 'HOME': '/home/cltbld', 19:08:12 INFO - 'LANG': 'en_US.UTF-8', 19:08:12 INFO - 'LANGUAGE': 'en_US:en', 19:08:12 INFO - 'LOGNAME': 'cltbld', 19:08:12 INFO - 'MAIL': '/var/mail/cltbld', 19:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:12 INFO - 'MOZ_NO_REMOTE': '1', 19:08:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:12 INFO - 'NO_EM_RESTART': '1', 19:08:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:12 INFO - 'PWD': '/builds/slave/test', 19:08:12 INFO - 'SHELL': '/bin/bash', 19:08:12 INFO - 'SHLVL': '1', 19:08:12 INFO - 'TERM': 'linux', 19:08:12 INFO - 'TMOUT': '86400', 19:08:12 INFO - 'USER': 'cltbld', 19:08:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490321256.551566-107350318', 19:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:12 INFO - '_': '/tools/buildbot/bin/python'} 19:08:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:08:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:08:14 INFO - Installing collected packages: mozsystemmonitor 19:08:14 INFO - Running setup.py install for mozsystemmonitor 19:08:15 INFO - Successfully installed mozsystemmonitor 19:08:15 INFO - Cleaning up... 19:08:15 INFO - Return code: 0 19:08:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xdcf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a290>, '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 0x106ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490321256.551566-107350318', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:08:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:08:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:08:15 INFO - Using env: {'DISPLAY': ':0', 19:08:15 INFO - 'HOME': '/home/cltbld', 19:08:15 INFO - 'LANG': 'en_US.UTF-8', 19:08:15 INFO - 'LANGUAGE': 'en_US:en', 19:08:15 INFO - 'LOGNAME': 'cltbld', 19:08:15 INFO - 'MAIL': '/var/mail/cltbld', 19:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:15 INFO - 'MOZ_NO_REMOTE': '1', 19:08:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:15 INFO - 'NO_EM_RESTART': '1', 19:08:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:15 INFO - 'PWD': '/builds/slave/test', 19:08:15 INFO - 'SHELL': '/bin/bash', 19:08:15 INFO - 'SHLVL': '1', 19:08:15 INFO - 'TERM': 'linux', 19:08:15 INFO - 'TMOUT': '86400', 19:08:15 INFO - 'USER': 'cltbld', 19:08:15 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490321256.551566-107350318', 19:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:15 INFO - '_': '/tools/buildbot/bin/python'} 19:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:15 INFO - Downloading/unpacking jsonschema==2.5.1 19:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:08:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:08:17 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 19:08:17 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 19:08:17 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 19:08:17 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 19:08:17 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 19:08:17 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 19:08:17 INFO - Downloading functools32-3.2.3-2.tar.gz 19:08:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:08:17 INFO - warning: no files found matching '*.txt' 19:08:17 INFO - no previously-included directories found matching 'build' 19:08:17 INFO - no previously-included directories found matching 'dist' 19:08:17 INFO - no previously-included directories found matching '.git*' 19:08:17 INFO - Installing collected packages: jsonschema, functools32 19:08:17 INFO - Running setup.py install for functools32 19:08:17 INFO - warning: no files found matching '*.txt' 19:08:17 INFO - no previously-included directories found matching 'build' 19:08:17 INFO - no previously-included directories found matching 'dist' 19:08:17 INFO - no previously-included directories found matching '.git*' 19:08:17 INFO - Successfully installed jsonschema functools32 19:08:17 INFO - Cleaning up... 19:08:17 INFO - Return code: 0 19:08:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:08: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')]} 19:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08: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')]} 19:08:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08: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', '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 0xdcf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a290>, '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 0x106ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490321256.551566-107350318', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:08: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:08: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 functools32==3.2.3-2 19:08:17 INFO - Using env: {'DISPLAY': ':0', 19:08:17 INFO - 'HOME': '/home/cltbld', 19:08:17 INFO - 'LANG': 'en_US.UTF-8', 19:08:17 INFO - 'LANGUAGE': 'en_US:en', 19:08:17 INFO - 'LOGNAME': 'cltbld', 19:08:17 INFO - 'MAIL': '/var/mail/cltbld', 19:08:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:17 INFO - 'MOZ_NO_REMOTE': '1', 19:08:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:17 INFO - 'NO_EM_RESTART': '1', 19:08:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:17 INFO - 'PWD': '/builds/slave/test', 19:08:17 INFO - 'SHELL': '/bin/bash', 19:08:17 INFO - 'SHLVL': '1', 19:08:17 INFO - 'TERM': 'linux', 19:08:17 INFO - 'TMOUT': '86400', 19:08:17 INFO - 'USER': 'cltbld', 19:08:17 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490321256.551566-107350318', 19:08:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:17 INFO - '_': '/tools/buildbot/bin/python'} 19:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:08:18 INFO - Cleaning up... 19:08:18 INFO - Return code: 0 19:08:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:18 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 0xdcf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a290>, '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 0x106ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490321256.551566-107350318', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:08:18 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 19:08:18 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 19:08:18 INFO - Using env: {'DISPLAY': ':0', 19:08:18 INFO - 'HOME': '/home/cltbld', 19:08:18 INFO - 'LANG': 'en_US.UTF-8', 19:08:18 INFO - 'LANGUAGE': 'en_US:en', 19:08:18 INFO - 'LOGNAME': 'cltbld', 19:08:18 INFO - 'MAIL': '/var/mail/cltbld', 19:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:18 INFO - 'MOZ_NO_REMOTE': '1', 19:08:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:18 INFO - 'NO_EM_RESTART': '1', 19:08:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:18 INFO - 'PWD': '/builds/slave/test', 19:08:18 INFO - 'SHELL': '/bin/bash', 19:08:18 INFO - 'SHLVL': '1', 19:08:18 INFO - 'TERM': 'linux', 19:08:18 INFO - 'TMOUT': '86400', 19:08:18 INFO - 'USER': 'cltbld', 19:08:18 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490321256.551566-107350318', 19:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:18 INFO - '_': '/tools/buildbot/bin/python'} 19:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:18 INFO - Downloading/unpacking blobuploader==1.2.4 19:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:20 INFO - Downloading blobuploader-1.2.4.tar.gz 19:08:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:08:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:08:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:21 INFO - Downloading docopt-0.6.1.tar.gz 19:08:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:08:21 INFO - Installing collected packages: blobuploader, requests, docopt 19:08:21 INFO - Running setup.py install for blobuploader 19:08:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:08:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:08:21 INFO - Running setup.py install for requests 19:08:21 INFO - Running setup.py install for docopt 19:08:21 INFO - Successfully installed blobuploader requests docopt 19:08:21 INFO - Cleaning up... 19:08:21 INFO - Return code: 0 19:08:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:21 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 0xdcf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a290>, '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 0x106ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490321256.551566-107350318', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:08:21 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 19:08:21 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 19:08:21 INFO - Using env: {'DISPLAY': ':0', 19:08:21 INFO - 'HOME': '/home/cltbld', 19:08:21 INFO - 'LANG': 'en_US.UTF-8', 19:08:21 INFO - 'LANGUAGE': 'en_US:en', 19:08:21 INFO - 'LOGNAME': 'cltbld', 19:08:21 INFO - 'MAIL': '/var/mail/cltbld', 19:08:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:21 INFO - 'MOZ_NO_REMOTE': '1', 19:08:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:21 INFO - 'NO_EM_RESTART': '1', 19:08:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:21 INFO - 'PWD': '/builds/slave/test', 19:08:21 INFO - 'SHELL': '/bin/bash', 19:08:21 INFO - 'SHLVL': '1', 19:08:21 INFO - 'TERM': 'linux', 19:08:21 INFO - 'TMOUT': '86400', 19:08:21 INFO - 'USER': 'cltbld', 19:08:21 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490321256.551566-107350318', 19:08:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:21 INFO - '_': '/tools/buildbot/bin/python'} 19:08:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:08:21 INFO - Running setup.py (path:/tmp/pip-5DANbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:08:22 INFO - Running setup.py (path:/tmp/pip-UOfaVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:08:22 INFO - Running setup.py (path:/tmp/pip-jzopBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:08:22 INFO - Running setup.py (path:/tmp/pip-XW09un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:08:22 INFO - Running setup.py (path:/tmp/pip-UWglS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:08:22 INFO - Running setup.py (path:/tmp/pip-gHEQSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:08:22 INFO - Running setup.py (path:/tmp/pip-pUVnEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:08:22 INFO - Running setup.py (path:/tmp/pip-UnjUTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:08:22 INFO - Running setup.py (path:/tmp/pip-ZylJ3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:08:22 INFO - Running setup.py (path:/tmp/pip-kzWN7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:08:22 INFO - Running setup.py (path:/tmp/pip-jQG7Uo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:08:22 INFO - Running setup.py (path:/tmp/pip-bOTKSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:08:22 INFO - Running setup.py (path:/tmp/pip-r3wzJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:08:22 INFO - Running setup.py (path:/tmp/pip-IhnqHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:22 INFO - Running setup.py (path:/tmp/pip-uAoKis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:08:23 INFO - Running setup.py (path:/tmp/pip-nKobWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:08:23 INFO - Running setup.py (path:/tmp/pip-BpISxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:08:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:08:23 INFO - Running setup.py install for manifestparser 19:08:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:08:23 INFO - Running setup.py install for mozcrash 19:08:23 INFO - Running setup.py install for mozdebug 19:08:23 INFO - Running setup.py install for mozdevice 19:08:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:08:23 INFO - Running setup.py install for mozfile 19:08:23 INFO - Running setup.py install for mozhttpd 19:08:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:08:23 INFO - Running setup.py install for mozinfo 19:08:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:08:23 INFO - Running setup.py install for mozInstall 19:08:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:08:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:08:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:08:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:08:23 INFO - Running setup.py install for mozleak 19:08:24 INFO - Running setup.py install for mozlog 19:08:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:08:24 INFO - Running setup.py install for moznetwork 19:08:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:08:24 INFO - Running setup.py install for mozprocess 19:08:24 INFO - Running setup.py install for mozprofile 19:08:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:08:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:08:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:08:24 INFO - Running setup.py install for mozrunner 19:08:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:08:24 INFO - Running setup.py install for mozscreenshot 19:08:24 INFO - Running setup.py install for moztest 19:08:24 INFO - Running setup.py install for mozversion 19:08:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:08:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:08:24 INFO - Cleaning up... 19:08:24 INFO - Return code: 0 19:08:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:24 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 0xdcf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a290>, '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 0x106ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490321256.551566-107350318', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:08:24 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 19:08:24 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 19:08:24 INFO - Using env: {'DISPLAY': ':0', 19:08:24 INFO - 'HOME': '/home/cltbld', 19:08:24 INFO - 'LANG': 'en_US.UTF-8', 19:08:24 INFO - 'LANGUAGE': 'en_US:en', 19:08:24 INFO - 'LOGNAME': 'cltbld', 19:08:24 INFO - 'MAIL': '/var/mail/cltbld', 19:08:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:24 INFO - 'MOZ_NO_REMOTE': '1', 19:08:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:24 INFO - 'NO_EM_RESTART': '1', 19:08:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:24 INFO - 'PWD': '/builds/slave/test', 19:08:24 INFO - 'SHELL': '/bin/bash', 19:08:24 INFO - 'SHLVL': '1', 19:08:24 INFO - 'TERM': 'linux', 19:08:24 INFO - 'TMOUT': '86400', 19:08:24 INFO - 'USER': 'cltbld', 19:08:24 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490321256.551566-107350318', 19:08:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:24 INFO - '_': '/tools/buildbot/bin/python'} 19:08:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:08:25 INFO - Running setup.py (path:/tmp/pip-ndo5Pv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:08:25 INFO - Running setup.py (path:/tmp/pip-cPqzQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 19:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:08:25 INFO - Running setup.py (path:/tmp/pip-jl8UPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:08:25 INFO - Running setup.py (path:/tmp/pip-fWjVLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 19:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:08:25 INFO - Running setup.py (path:/tmp/pip-p4Trqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:08:25 INFO - Running setup.py (path:/tmp/pip-8iQQY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:08:25 INFO - Running setup.py (path:/tmp/pip-OqPsEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:08:25 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)) 19:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:08:25 INFO - Running setup.py (path:/tmp/pip-DVL3Md-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:08:25 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)) 19:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:08:25 INFO - Running setup.py (path:/tmp/pip-7B6odF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:08:25 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)) 19:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:08:25 INFO - Running setup.py (path:/tmp/pip-nZUelR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 19:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:08:25 INFO - Running setup.py (path:/tmp/pip-uoEwLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:08:25 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)) 19:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:08:25 INFO - Running setup.py (path:/tmp/pip-u4b6zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 19:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:08:26 INFO - Running setup.py (path:/tmp/pip-YtP4SR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:08:26 INFO - Running setup.py (path:/tmp/pip-_iqH2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 19:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:26 INFO - Running setup.py (path:/tmp/pip-xNnUxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:08:26 INFO - Running setup.py (path:/tmp/pip-LaINF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 19:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:08:26 INFO - Running setup.py (path:/tmp/pip-P4wVmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:08:26 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)) 19:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:08:26 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)) 19:08:26 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:08:26 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:08:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:08:26 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 19:08:26 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 19:08:26 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 19:08:26 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 19:08:26 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 19:08:26 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 19:08:28 INFO - Downloading blessings-1.6.tar.gz 19:08:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:08:28 INFO - Installing collected packages: blessings 19:08:28 INFO - Running setup.py install for blessings 19:08:28 INFO - Successfully installed blessings 19:08:28 INFO - Cleaning up... 19:08:28 INFO - Return code: 0 19:08:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:08:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:08:28 INFO - Reading from file tmpfile_stdout 19:08:28 INFO - Current package versions: 19:08:28 INFO - argparse == 1.2.1 19:08:28 INFO - blessings == 1.6 19:08:28 INFO - blobuploader == 1.2.4 19:08:28 INFO - docopt == 0.6.1 19:08:28 INFO - functools32 == 3.2.3-2 19:08:28 INFO - jsonschema == 2.5.1 19:08:28 INFO - manifestparser == 1.1 19:08:28 INFO - mozInstall == 1.12 19:08:28 INFO - mozcrash == 1.0 19:08:28 INFO - mozdebug == 0.1 19:08:28 INFO - mozdevice == 0.49 19:08:28 INFO - mozfile == 1.2 19:08:28 INFO - mozhttpd == 0.7 19:08:28 INFO - mozinfo == 0.9 19:08:28 INFO - mozleak == 0.1 19:08:28 INFO - mozlog == 3.4 19:08:28 INFO - moznetwork == 0.27 19:08:28 INFO - mozprocess == 0.25 19:08:28 INFO - mozprofile == 0.28 19:08:28 INFO - mozrunner == 6.13 19:08:28 INFO - mozscreenshot == 0.1 19:08:28 INFO - mozsystemmonitor == 0.3 19:08:28 INFO - moztest == 0.8 19:08:28 INFO - mozversion == 1.4 19:08:28 INFO - psutil == 3.1.1 19:08:28 INFO - requests == 1.2.3 19:08:28 INFO - wsgiref == 0.1.2 19:08:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:28 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')]} 19:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:28 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')]} 19:08:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:28 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 0xdcf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a290>, '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 0x106ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490321256.551566-107350318', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:08:28 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 19:08:28 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 19:08:28 INFO - Using env: {'DISPLAY': ':0', 19:08:28 INFO - 'HOME': '/home/cltbld', 19:08:28 INFO - 'LANG': 'en_US.UTF-8', 19:08:28 INFO - 'LANGUAGE': 'en_US:en', 19:08:28 INFO - 'LOGNAME': 'cltbld', 19:08:28 INFO - 'MAIL': '/var/mail/cltbld', 19:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:28 INFO - 'MOZ_NO_REMOTE': '1', 19:08:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:28 INFO - 'NO_EM_RESTART': '1', 19:08:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:28 INFO - 'PWD': '/builds/slave/test', 19:08:28 INFO - 'SHELL': '/bin/bash', 19:08:28 INFO - 'SHLVL': '1', 19:08:28 INFO - 'TERM': 'linux', 19:08:28 INFO - 'TMOUT': '86400', 19:08:28 INFO - 'USER': 'cltbld', 19:08:28 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490321256.551566-107350318', 19:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:28 INFO - '_': '/tools/buildbot/bin/python'} 19:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:29 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)) 19:08:29 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)) 19:08:29 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)) 19:08:29 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)) 19:08:29 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)) 19:08:29 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)) 19:08:29 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)) 19:08:29 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)) 19:08:29 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)) 19:08:29 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)) 19:08:29 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)) 19:08:29 INFO - Cleaning up... 19:08:29 INFO - Return code: 0 19:08:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:08:29 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')]} 19:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:29 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')]} 19:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:29 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 0xdcf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a290>, '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 0x106ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490321256.551566-107350318', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:08:29 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 19:08:29 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 19:08:29 INFO - Using env: {'DISPLAY': ':0', 19:08:29 INFO - 'HOME': '/home/cltbld', 19:08:29 INFO - 'LANG': 'en_US.UTF-8', 19:08:29 INFO - 'LANGUAGE': 'en_US:en', 19:08:29 INFO - 'LOGNAME': 'cltbld', 19:08:29 INFO - 'MAIL': '/var/mail/cltbld', 19:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:29 INFO - 'MOZ_NO_REMOTE': '1', 19:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:29 INFO - 'NO_EM_RESTART': '1', 19:08:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:29 INFO - 'PWD': '/builds/slave/test', 19:08:29 INFO - 'SHELL': '/bin/bash', 19:08:29 INFO - 'SHLVL': '1', 19:08:29 INFO - 'TERM': 'linux', 19:08:29 INFO - 'TMOUT': '86400', 19:08:29 INFO - 'USER': 'cltbld', 19:08:29 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490321256.551566-107350318', 19:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:29 INFO - '_': '/tools/buildbot/bin/python'} 19:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:08:29 INFO - Cleaning up... 19:08:29 INFO - Return code: 0 19:08:29 INFO - Running post-action listener: _resource_record_post_action 19:08:29 INFO - Running post-action listener: _start_resource_monitoring 19:08:29 INFO - Starting resource monitoring. 19:08:29 INFO - [mozharness: 2017-03-24 02:08:29.398436Z] Finished create-virtualenv step (success) 19:08:29 INFO - [mozharness: 2017-03-24 02:08:29.398942Z] Running install step. 19:08:29 INFO - Running pre-action listener: _resource_record_pre_action 19:08:29 INFO - Running main action method: install 19:08:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:08:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:08:29 INFO - Reading from file tmpfile_stdout 19:08:29 INFO - Detecting whether we're running mozinstall >=1.0... 19:08:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:08:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:08:29 INFO - Reading from file tmpfile_stdout 19:08:29 INFO - Output received: 19:08:29 INFO - Usage: mozinstall [options] installer 19:08:29 INFO - Options: 19:08:29 INFO - -h, --help show this help message and exit 19:08:29 INFO - -d DEST, --destination=DEST 19:08:29 INFO - Directory to install application into. [default: 19:08:29 INFO - "/builds/slave/test"] 19:08:29 INFO - --app=APP Application being installed. [default: firefox] 19:08:29 INFO - mkdir: /builds/slave/test/build/application 19:08:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:08:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:08:45 INFO - Reading from file tmpfile_stdout 19:08:45 INFO - Output received: 19:08:45 INFO - /builds/slave/test/build/application/firefox/firefox 19:08:45 INFO - Running post-action listener: _resource_record_post_action 19:08:45 INFO - [mozharness: 2017-03-24 02:08:45.345646Z] Finished install step (success) 19:08:45 INFO - [mozharness: 2017-03-24 02:08:45.345895Z] Running run-tests step. 19:08:45 INFO - Running pre-action listener: _resource_record_pre_action 19:08:45 INFO - Running main action method: run_tests 19:08:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:08:45 INFO - Python 2.7.3 19:08:45 INFO - Return code: 0 19:08:45 INFO - grabbing minidump binary from tooltool 19:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:45 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/linux64/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 0x106a290>, '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 0x106ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:08:45 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:08:45 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/linux64/releng.manifest -o -c /builds/tooltool_cache 19:08:45 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:08:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:08:45 INFO - Return code: 0 19:08:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:08:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:08:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:08:45 INFO - ENV: RUST_BACKTRACE is now 1 19:08:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:08:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:08:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/En4_ybPfRAirG61usP7e7w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 19:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Pine --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/En4_ybPfRAirG61usP7e7w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 19:08:45 INFO - Using env: {'DISPLAY': ':0', 19:08:45 INFO - 'HOME': '/home/cltbld', 19:08:45 INFO - 'LANG': 'en_US.UTF-8', 19:08:45 INFO - 'LANGUAGE': 'en_US:en', 19:08:45 INFO - 'LOGNAME': 'cltbld', 19:08:45 INFO - 'MAIL': '/var/mail/cltbld', 19:08:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:08:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:45 INFO - 'MOZ_NO_REMOTE': '1', 19:08:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:45 INFO - 'NO_EM_RESTART': '1', 19:08:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:45 INFO - 'PWD': '/builds/slave/test', 19:08:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:08:45 INFO - 'RUST_BACKTRACE': '1', 19:08:45 INFO - 'SHELL': '/bin/bash', 19:08:45 INFO - 'SHLVL': '1', 19:08:45 INFO - 'TERM': 'linux', 19:08:45 INFO - 'TMOUT': '86400', 19:08:45 INFO - 'USER': 'cltbld', 19:08:45 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1490321256.551566-107350318', 19:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:45 INFO - '_': '/tools/buildbot/bin/python'} 19:08:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/En4_ybPfRAirG61usP7e7w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 19:08:45 INFO - mozversion application_buildid: 20170323221417 19:08:45 INFO - mozversion application_changeset: 5117704c9361e4b9a3eee82d1ce4a9d93222e6be 19:08:45 INFO - mozversion application_display_name: Nightly 19:08:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:08:45 INFO - mozversion application_name: Firefox 19:08:45 INFO - mozversion application_remotingname: firefox 19:08:45 INFO - mozversion application_repository: https://hg.mozilla.org/projects/pine 19:08:45 INFO - mozversion application_vendor: Mozilla 19:08:45 INFO - mozversion application_version: 55.0a1 19:08:45 INFO - mozversion platform_buildid: 20170323221417 19:08:45 INFO - mozversion platform_changeset: 5117704c9361e4b9a3eee82d1ce4a9d93222e6be 19:08:45 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/pine 19:08:45 INFO - mozversion platform_version: 55.0a1 19:08:45 INFO - using testdate: 1490321325 19:08:45 INFO - actual date: 1490321325 19:08:45 INFO - starting webserver on 'localhost:33699' 19:08:45 INFO - SUITE-START | Running 2 tests 19:08:45 INFO - TEST-START | dromaeo_css 19:08:45 INFO - operating with platform_type : linux_ 19:08:45 INFO - Initialising browser for dromaeo_css test... 19:08:45 INFO - TEST-INFO | started process 28313 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY14jsS/profile http://localhost:33699/getInfo.html) 19:08:50 INFO - PID 28313 | __metrics Screen width/height:1600/1200 19:08:50 INFO - PID 28313 | colorDepth:24 19:08:50 INFO - PID 28313 | Browser inner width/height: 1024/697 19:08:50 INFO - PID 28313 | __metrics 19:08:51 ERROR - PID 28313 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3388: TypeError: this.tabs is undefined 19:08:52 INFO - TEST-INFO | 28313: exit 0 19:08:52 INFO - Browser initialized. 19:08:52 INFO - Running cycle 1/1 for dromaeo_css test... 19:08:52 INFO - TEST-INFO | started process 28445 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY14jsS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:09:04 INFO - PID 28445 | RSS: Main: 157458432 19:09:04 INFO - PID 28445 | 19:12:08 INFO - PID 28445 | Cycle 1(1): loaded http://localhost:33699/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33699/tests/dromaeo/cssquery-ext.html) 19:12:10 INFO - PID 28445 | RSS: Main: 166354944 19:12:10 INFO - PID 28445 | 19:13:52 INFO - PID 28445 | ************************* 19:13:52 INFO - PID 28445 | A coding exception was thrown and uncaught in a Task. 19:13:52 INFO - PID 28445 | 19:13:52 ERROR - PID 28445 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:13:52 INFO - PID 28445 | Full stack: 19:13:52 INFO - PID 28445 | ************************* 19:15:12 INFO - PID 28445 | Cycle 1(1): loaded http://localhost:33699/tests/dromaeo/cssquery-ext.html (next: http://localhost:33699/tests/dromaeo/cssquery-jquery.html) 19:15:13 INFO - PID 28445 | RSS: Main: 162312192 19:15:13 INFO - PID 28445 | 19:18:15 INFO - PID 28445 | Cycle 1(1): loaded http://localhost:33699/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33699/tests/dromaeo/cssquery-mootools.html) 19:18:15 INFO - PID 28445 | RSS: Main: 169902080 19:18:15 INFO - PID 28445 | 19:21:17 INFO - PID 28445 | Cycle 1(1): loaded http://localhost:33699/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33699/tests/dromaeo/cssquery-prototype.html) 19:21:18 INFO - PID 28445 | RSS: Main: 162078720 19:21:18 INFO - PID 28445 | 19:24:21 INFO - PID 28445 | Cycle 1(1): loaded http://localhost:33699/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33699/tests/dromaeo/cssquery-yui.html) 19:24:21 INFO - PID 28445 | RSS: Main: 168980480 19:24:21 INFO - PID 28445 | 19:27:24 INFO - PID 28445 | Cycle 1(1): loaded http://localhost:33699/tests/dromaeo/cssquery-yui.html (next: http://localhost:33699/tests/dromaeo/cssquery-dojo.html) 19:27:25 INFO - PID 28445 | RSS: Main: 163188736 19:27:25 INFO - PID 28445 | 19:27:25 INFO - PID 28445 | __start_tp_report 19:27:25 INFO - PID 28445 | _x_x_mozilla_page_load 19:27:25 INFO - PID 28445 | _x_x_mozilla_page_load_details 19:27:25 INFO - PID 28445 | |i|pagename|runs| 19:27:25 INFO - PID 28445 | |0;dojo.html;2659.614355918392;2665.760081592656;2677.290518012727;2701.9459610807785;2708.3770732731464;5014.674046187004;5108.233764935261;5133.666311689738;5170.5605023573;5173.094708426029;5033.11920413928;5097.298431831126;5104.05574968631;5186.247994040862;5218.034663587229;4685.273782563708;4708.5526874947;4718.646101542381;4728.739919304437;4733.408323959505;4752.4297084349755;4779;4779.187538118511;4784.330193772875;4837.806487740486;4560.498345182027;4594.287885377772;4669.136209801198;4678.251479763256;4684.180268453007;4712.269598212282;4731.929021064652;4738.407699037621;4776.5701086902345;4780.856574302777;4608.516105808875;4680.812767489297;4699.506551812045;4719.575238228542;4737.052589482083;4987.326710894055;5037.194048952187;5139.7687104080405;5155.639105262633;5170.19861921399;5491.862703432446;5522.475364840334;5558.888822223533;5578.972105139489;5579.832605021856;5546.362168350651;5562.888742225174;5565.276514053147;5579.107342825169;5583.832485025456;5027.84916452507;5161.5870730341485;5174.042802081627;5179.637425380225;5214.713190774468;5593;5646.407127251661;5731.369549349568;5731.455511726379;5737.311522617312;5236.554892834151;5316.415194328621;5398.082326004589;5481.780728770805;5484.177373394023;5445.50990410865;5456.099743542271;5493.752781124859;5510.090835012258;5521.503064724114;5307.044731948286;5479.643823151482;5481.397046324901;5483.588730845123;5484.7531861066345;5426.70153141581;5434.782608695687;5473.480019398151;5475.397706252309;5505.229267902497;4649.3026046093355;4677.555632214934;4687.531246875354;4691.39011928454;4724.456687480915;3972.1857019310974;3994.6005399460405;4006.8797936061965;4040.8383664653675;4046.575109613448;4654.4414670239785;4728.338032675429;4786.832460863853;4832.782524786393;4841.975790121027;5580.553555715533;5594.692291923983;5594.692291923983;5604.131359639263;5635.605507614428;4762.9523704763205;4773.11697335994;4777.617790576745;4801.039792041605;4843.0798148352405;4842.104210721028;4897.314375987365;4917.680350777188;4921.384826896638;4984.102861484895;5047.2429135629945;5092.745362731775;5094.974525127351;5095.210242412432;5097.464766199496;5418.864528386822;5438.102713052302;5482.068048431696;5484.890302194013;5506.394296627448;5094.5669618082875;5096.770645320896;5109.310243117132;5110.054639891632;5161.509656582619;5366.302380690485;5375.354957405137;5416.51251387377;5419.539339156216;5452.863678408072;5565.6104072714525;5566.610337276352;5569.387367389503;5581.358143813351;5593.972030139986;5219.660722053054;5341.465853414627;5383.757730902197;5385.703786291791;5395.568354531707;5207.140821764367;5286.392064912584;5343.305370301991;5371.5702743781185;5383.6500627460655;5325.840224793263;5328.307320048369;5332.040232757986;5333.5199832015305;5340.866478338073;5431.6740995540395;5431.945680543144;5445.618806683494;5454.952601328688;5477.4796394342475;5109.744512774272;5191.8182863599595;5255.579553635776;5261.4738526147075;5332.653377530448 19:27:25 INFO - PID 28445 | |1;ext.html;655.4265018109154;706.9575825450472;730.2077246187886;1056.4189695667385;1063.1547919404072;30373.392532149344;31635.20911977202;31659.20851978702;31749.36501269973;31849.36301273973;33122.17194570137;33476.83261583689;33505.66494335062;33524.49713254297;33617;7059.682314295844;7231.421486281111;7344.2288559701265;7364.263573642646;7368.852622947537;7327.890081648779;7473.177950425449;7476.1776204617445;7478.813029674275;7495.775126746206;7441.367483763886;7487.513311634726;7494.887576686354;7497.962510187442;7505.5121417107985;7454.850902981937;7457.328840404335;7477.663505142282;7479.738209162653;7486.625668716597;7286.81782955425;7324.194338622748;7362;7367.557946523172;7397.149327827315;34040;34522;34650.82674586611;34669.30661386758;34725;2659.9202023939315;2663.5605125154325;2670.692870319899;2687.2744359022954;2704.2428120126397;24292.271231863073;24303.63544546833;24703;24890.5021899561;25177.118800841883;2768.1418760184206;2809.6347474828344;2811.8031737778365;2821.167755512108;2831.957520637192;119955;131459.34270328682;135219.32390338083;154184;154252;37993.62006379901;38368;38414;38462.42306365407;38520.8073959634;43885.78057109694;44030.55969440329;44035;44054.73096939033;44059.11881762411;11700.941495292469;11701;11802.52789888395;11802.76394472123;11810.40947952599;9210.447373157498;9214.216791572791;9299.488528131018;9309.44143351401;9329.253659707207;13350.332483375792;13380.19718816874;13418.664533386549;13514.59456216315;13725.794113088312;5450.945490545044;5477.643953143033;5491.093969494988;5564.888702226014;5591.384947655754;863.2964134230582;876.1851478125277;888.4092078767547;898.3756289378819;908.5139450394007;20577.07403166861;21299.893500532708;21420.143194272056;21540.569188616453;21948.451288717908;952.4047470331043;953.9284553658365;986.7779749556292;987.4272921705393;988.1057642833248;10740.892591074145;11070;11192.216544841784;11242.325460472397;11274.830877536844;227094;228829;229068;229997;230397;42876.78561607172;43185.568144318786;43418.7829060859;43450.56549434528;43497.347539786926;1186.0014243887094;1222.413241644016;1231.1259006105765;1233.3031837012059;1234.5864135514703;19753.802461975196;20363.185472581525;20569.48576285545;21046.57906841885;21310.467238319165;30589.847050764605;30659.846700766353;30704.38591228118;30711.846440767655;30719;204101;204920;205136;205276;206166;27506.587401188597;28210.71789282081;28356.858215708788;28425.28936776597;28561.143165705063;33546.496802547495;33651.15872103217;33860;34309.48535771915;34587;25820.748031103412;26646.600300995888;28287.85856070789;28701.569476458288;29168.416631666823;25773.3556661085;26266.868665656548;26409.60385594179;26803.19590412291;27411.86294068517;30504.34191723901;30814.69185308118;30898.76404943777;31239.219019524695;31487.21281967969;26315.10533841314;26737.19788406351;27017.72982270152;27787.58318625263;27800.58299125474;20527.28154514585;22102.668459972792;22185;22312;22351.552968940206 19:27:25 INFO - PID 28445 | |2;jquery.html;408.8160327852467;408.81807595619944;424.24272673278193;424.37404827878885;443.21329639889194;11602.187846850724;13038.282894440801;17736.11319434028;18390.264389424425;18407.17167727454;14628.780568291457;14686.55940321792;14773.409063637468;14991.175485348329;15225.92387038066;5639.379668236491;5782.24830771999;5817.0983497557945;5818.156367326735;5823.9708801456145;5347.144456886899;5562.833115006556;5612.607117501777;5615.887682246353;5615.915761263564;5537.944620553783;5538.529225015858;5539.639923404986;5583.609147359686;5585.385607583163;5476.342838859342;5668.858278543028;5679.318481782213;5716.628419152742;5717.9714101429645;5004.699718016895;5102.387713474407;5140.897182056338;5144.639875208737;5157.4584668610005;21619.135234590598;21933.232336868132;22185.44536386587;22190.223342182948;22229.888850555806;1546.3814474210294;1549.147968617256;1553.8368471310462;1562.8359022302723;1600.3278622978378;13749.450021999108;13786.724265514735;14027.64930876726;14206.715865682732;14716.705665886622;1598.2168737318746;1675.8240384759667;1699.643074954261;1744.049493026291;1789.1412122181296;85932;86467.13532864653;87395;88262.55868720615;91083.54458227733;10810.405427701551;10992.560297588007;11046.097613202306;11049.613263535737;11198.832017519744;15322.080675159526;15355;15366.769498457532;15388.076715396888;15445.536633901002;6747.493937954575;6758.560693555001;6892.241853396123;6944.930550694529;7017.824554386181;5987.341392446828;6048.637081775108;6192.287886892975;6196.087838715796;6226.5641405102115;6671.666416679147;6951.965240173767;6964.721411143599;6970.442364610819;7026.367626913602;2024.0891598780313;2094.1309356616835;2117.883516406612;2120.544083022127;2231.509068005036;834.1950018232313;850.1243718969471;859.0979471554842;884.2439714044529;885.5749240364532;16469.91765041167;16659.584785119023;16977.320907163576;17212.655746884993;17273.136343182792;859.5143743784741;862.4609618988133;874.728834061443;881.0572687224608;884.0717246890739;8989.280857531381;9095.181433670869;9377.109174628536;9388.62445502186;9547.570359333846;418806;419719;423502;424846;428787;90179.54910225538;92797;93100;93365;93670.99999999863;1040.2302296300684;1069.9732506687394;1074.3731576296038;1079.9784004319713;1081.0378762901025;14259.358328875018;14369.497067602584;14450.421983120557;14500.057496262709;14927.552173434815;40627.59372406238;41771.58228417799;42570.57429425666;42751.572484276;44127.11745765131;51670;53292.73353633207;54155.72922135364;54540.727296363264;56392.43607563872;7459.179490256176;7828.45200835936;7839;7887.369010479262;8212.13772553897;12040.21738586989;12267.87732122703;12326.260424374566;12347.444365003417;12364.690882728004;9458.574364153492;9935.453550054817;10515.263931525025;10842.295250808673;11215.158863085138;9323.906760932305;9326.207272381924;9472.857907131262;9511.429314241168;9550.95224523873;10618.309809862334;11067.557297708001;11419.771604568028;11503.53985840557;11552.826707599224;7749.496282741604;7921.128675845767;7965.56189409588;7967.482113662593;8147.79630509242;9963.701088967342;10210;10310.896891030994;10372.792544148924;10615.575376985144 19:27:25 INFO - PID 28445 | |3;mootools.html;1223.5717498875392;1287.4270949427503;1288.4137717338613;1295.3652710172018;1296.436050318111;9487.81024379512;9709.902900970988;9863.30956833022;9864.506774661257;9901.207903367731;9947.204223662107;10116;10118.494075296225;10143.898561014388;10153.59385624576;2144.4317255927153;2184.9563008739815;2191.616467118256;2194.846360754748;2199.912003519857;2130.7762684918093;2159.9568008639817;2192.177933275022;2198.373463562885;2200.7469141048823;2085.7080008798703;2161.5460753241837;2171.89140542973;2179.280837323687;2201.4936564590153;2143.882086485243;2145.1312218551357;2145.249162793026;2152.773958734334;2154.515234072329;1773.219783295346;1830.9084545772657;2102.16964299101;2141.2719675310314;2147.452399638098;9275.072492750738;9536.380135291183;9546.713598591983;9548.522573871278;9549;5084.13569693153;5347.385050719178;5357.062514060063;5358.33020872391;5359.356877174725;3167.8732850685947;3173.5557022016937;3188.3942051010235;3210.133264018725;3312.4368857294317;1115.0466351269629;1123.9044681202108;1135.523080306265;1141.4635121492886;1152.7406333574963;14704.779428308477;14715.190664513448;14749.188794616291;14790.556283311518;14886.776698349533;4527.864164075083;4768.117898188777;4834.879128021757;4846.36997190363;4879.072976134523;11042.613508527164;11046.723831904266;11048.116150707923;11050.889491105147;11051.281666691639;5221.477852214748;5259.579233661298;5259.815906443333;5260.552853007537;5273.209018647157;4710.152172608963;4797.880052998633;4809.302651115569;4825.5898248649255;4843.854684359475;3624.9093772655897;3636.1455058061333;3716.9442458363146;3733.9066523337133;3798.145417281145;1102.944852757375;1119.4290911634962;1123.039800970175;1125.2798209146154;1126.4649291586431;639.2935805934468;666.6033709942576;675.4157653629575;675.6486626954055;677.4783416769159;5018.322526458955;5046.7476626168545;5074.594032477393;5093.286939828427;5232.790688372423;527.7677821758414;551.203510926707;553.7674176845735;554.7032337699311;556.5047108073736;3151.2121969507625;3292.8353582320788;3294.341131773655;3339.3655205510877;3463.2554000889427;12675.302858342695;13122.34388280582;13162.736745265232;13165.144265622705;13227.73544529104;12561.120721549587;13056.151350162208;13125.737485250242;13135;13314.600561983156;9370.156685898302;9449.622015119456;9528.571214295373;9561.995990421045;9577.281703872377;5500.559955203654;5506.944930550643;5517.2275881377445;5526.336839579276;5627.662340259598;11729.882701173221;11889.940550297539;11919.642410727693;11938.52245910154;11981.101417393556;12255.387230638611;12271.754564908473;12427.502899883903;12428.81356779631;12429.75140497203;7188.5327453715345;7246.166690830411;7275.890861636974;7361.889571656537;7384.18773934856;9468.195203407788;9469;9580.712578622653;9587.280953928623;9598.568064437257;8023.438359314792;8035.156308587514;8096.878546821685;8229.46508476971;8242.381821363302;7865.426914616985;7886.566238856918;8000.879986800086;8124.39067069984;8134.349252059703;7234.385077268491;7327.413806895329;7376.668049937873;7416.035915330973;7416.925830741624;4731.148393289241;4868.342773725643;4892.8532144035735;4918.0901533216465;4925.433575138905;4631.189541830234;4712.128256272601;4770.904581908412;4800.231962885921;4855.708657480563 19:27:25 INFO - PID 28445 | |4;prototype.html;375.9398496240601;392.51916402407045;397.0966052231175;403.3727553654069;404.2581862282715;5441.428649991743;5587.6811123383795;5630.971845140773;5644.407337229593;5658.122990936401;5385.407605163438;5489.34127904652;5492.697901615409;5507.972460137694;5529.778808847651;4271.444712187411;4275.273203555403;4285.378620100084;4288.742675439468;4291.635211007068;4106.630403263705;4277.914441711164;4298.699091063627;4310.80601372939;4312.698111132207;4250.744955302692;4256.297710877717;4259.446271984653;4262;4275.444192255002;4230.428892099558;4234.386014027964;4242.8727138185905;4247.235497610444;4260.9147817043795;3556.733245006609;3724.1992971511254;3735.906602334936;3736.5516138063335;3751.662350388478;5335.1997200419855;5354.598405119632;5387.542058924996;5397.217403476474;5415.756290966877;4894.1679914414635;4895.31465594817;4903.65674402792;4907.362042934431;4918.114739346916;5549.38956714761;5737.39757325479;5775.5668324875805;5795.913061304042;5802.47777700009;4061.4923134608175;4077.799866137883;4081.2857749893947;4087;4087.3650539784026;5763.682997435139;5988.520918326523;6012.89548657975;6093.969530152365;6116.388361163892;4176.14389050244;4178.770167640748;4200.684948628865;4204.432401625802;4213.492971681844;4212.684048696298;4223.915521689611;4233.597808208216;4249.447571815645;4263.126059157865;4785.760711964457;4843.15244832153;4855.547948286164;4865.659403841697;4879.878003049952;5831.854203644858;5855.824325270249;5857.179994800731;5858.179854820329;5863.179154918314;1463.495094192502;1468.5814542855235;1471.0952764050032;1472.1535117307376;1478.0835881753383;948.990510094904;978.6281213139104;988.9072574804737;1000.5297510170209;1009.8232809258351;5108.948910510921;5123.538881500608;5123.666961647481;5128.897422051538;5130;6044.788432404845;6059.182010428536;6077.17958075663;6081.17904082952;6114.357992410822;4836.250381190921;5083;5086.364204474441;5116.232565115262;5151.150060240094;3225.903222903317;3236.478854938175;3240.2016880631004;3249.431349513826;3251.219707270285;5434.565234781208;5598.496135347838;5638;5651.378348381675;5660.688662123623;6135.938640613536;6140.4473597376455;6174.413430724074;6176;6209.161763162006;5585.636933599303;5623;5625.353084395183;5636.633618814764;5637.267155269788;5782.653040817564;6027.6986150693165;6069.119977603134;6109.69451527413;6171.1668924694595;5997.790077347272;6012.308584512837;6040.879182416415;6045.576809623284;6047;5360.16917377807;5461.5357694596405;5546.528545073714;5613.607047506635;5656.906944430587;4173.518400967613;4207.495100587949;4210.810513526837;4210.957890421179;4218.662506999494;5927.911081333869;6019.277686677627;6074.848128796815;6088.4215999479975;6097.634141951497;5842.912356314744;5884.823455296348;5912.852178695567;5913.231279933581;5938.138969849434;5806.274215723035;5806.854828629318;5819.359870414336;5902.20320256777;5904.763809447574;5555.194626713484;5729.914051289151;5793.304803423616;5818.44724751148;5855.970720146372;5909.586328957103;5920.970395147997;5926.851828704144;5932.703364831655;5956.612820166675;5558.499735023867;5722.4249087909775;5748.109043098327;5768.2501274834;5779.768809247751 19:27:25 INFO - PID 28445 | |5;yui.html;590.7932223721696;616.0451300484249;622.6388694557156;638.3010603389287;639.6705696566268;11099.889001109987;11442.656720298404;11947.641570752881;11953.7609247815;11984.221025633327;11550.422478876064;11602.535898564047;11638.825417618742;11729.354885481294;12287.692807679812;825.1212458731462;833.3791325462539;848.2789628815489;852.7441767469766;859.072202021818;854.2311919272643;855.7719672270281;858.8153546987396;858.9656413743443;860.9182127697859;890.6437425030008;891.6522556203086;893.7318804358699;894.7986702991807;895.212213252337;880.8062226310234;884.5975081337975;888.2183678363064;888.506878682331;888.9111088891092;647.6308504152635;654;654.9815037616504;656.1339032477132;657.0079180437526;12020.759584808342;12155;12228.510859565607;12238.204516706475;12904.419301131471;13745.38145783442;14357;14412.927935360256;14437.494687685881;14451.277436128257;9997.950010249902;10160.79678406435;10185.643502477451;10398.740031499197;10526.31578947366;2658.4815960887636;2661.6939052009075;2674.1041751013436;2704.8512331821744;2758.544840101381;66509.67687100323;66820.66589667069;66832;67394;67669;10295.3822770634;10498;10500.264981451224;10505.369677819355;10599.470026498644;21148.048337824835;21158.78841211599;21294.36116916495;21300.147994080064;21445.356639300848;6267.749290028348;6364.299927008025;6407.391297826699;6411;6624.205095388488;3308.354870800219;3363;3382.340443613472;3387.0516255448515;3442.1910850950007;3499.9125021874656;3556.199855032649;3567.0725611341236;3579.302036102987;3910.6675932546054;730.4777084384584;731.6159016516265;735.9926400736031;753.348353674068;754.8075240813557;473.37750857622115;488.16280079663545;494.6216144649346;502.0887089931762;507.4874376879305;8369.49783013021;8390.412671112963;8407.2433480987;8593.871091933626;8637.352198585131;475.67891673120505;489.81387072912065;491.4323955831021;492.92606109083926;504.5862392837911;3701.851925922987;3727.6458736419995;3743.457198706172;3775.414810704345;3865.207632435344;64681.35318646848;64772.67613661902;65297.34702653008;66711.66644166748;67398;54076.18885716717;54230.728846355516;55597;55965.72017139888;56243;49260.50739492559;49437.75281123643;50057.749711251214;50625.49374506281;50763.49236507588;8698.60856261457;8931.553422328727;9075.636974520945;9139.680111196076;9140.54078221167;24195.516089677756;24291.878540607184;26245.606315905658;26379;26676.19971400861;42518.362224567274;44070.559294406645;45644.087118256786;46249.30626040545;46684;11546.76906461883;11683.123765717435;11743.295402275891;11805.881941180822;12046.578369757017;11634.6509604712;11695.239809412362;11879.881201187878;12126.151169418408;12482.937585312378;11974.401279936143;12076.75846483083;12236.632901012983;12659.620211393672;12665.366731663564;11819.40902954866;12152.696182595506;12232.449539770554;12422.440990155284;12680.682982925131;11411.429428528707;11583.536658533565;11723.589674361356;11902.345371004678;12065.638030859089;7671.309582137635;7955.204479551999;8540.658373664985;8540.804795117423;8647.481151130953;8385.874211886705;9947.552360143665;9976.401415915068;10113.494325283853;10146.391216527032 19:27:25 INFO - PID 28445 | __end_tp_report 19:27:25 INFO - PID 28445 | __start_cc_report 19:27:25 INFO - PID 28445 | _x_x_mozilla_cycle_collect,389 19:27:25 INFO - PID 28445 | __end_cc_report 19:27:25 INFO - PID 28445 | __startTimestamp1490322445085__endTimestamp 19:27:25 INFO - PID 28445 | 19:27:25 INFO - PID 28445 | ------- Summary: start ------- 19:27:25 INFO - PID 28445 | Number of tests: 6 19:27:25 INFO - PID 28445 | 19:27:25 INFO - PID 28445 | [#0] dojo.html Cycles:165 Average:5073.69 Median:5179.64 stddev:565.66 (10.9%) stddev-sans-first:534.76 19:27:25 INFO - PID 28445 | Values: 2659.6 2665.8 2677.3 2701.9 2708.4 5014.7 5108.2 5133.7 5170.6 5173.1 5033.1 5097.3 5104.1 5186.2 5218.0 4685.3 4708.6 4718.6 4728.7 4733.4 4752.4 4779.0 4779.2 4784.3 4837.8 4560.5 4594.3 4669.1 4678.3 4684.2 4712.3 4731.9 4738.4 4776.6 4780.9 4608.5 4680.8 4699.5 4719.6 4737.1 4987.3 5037.2 5139.8 5155.6 5170.2 5491.9 5522.5 5558.9 5579.0 5579.8 5546.4 5562.9 5565.3 5579.1 5583.8 5027.8 5161.6 5174.0 5179.6 5214.7 5593.0 5646.4 5731.4 5731.5 5737.3 5236.6 5316.4 5398.1 5481.8 5484.2 5445.5 5456.1 5493.8 5510.1 5521.5 5307.0 5479.6 5481.4 5483.6 5484.8 5426.7 5434.8 5473.5 5475.4 5505.2 4649.3 4677.6 4687.5 4691.4 4724.5 3972.2 3994.6 4006.9 4040.8 4046.6 4654.4 4728.3 4786.8 4832.8 4842.0 5580.6 5594.7 5594.7 5604.1 5635.6 4763.0 4773.1 4777.6 4801.0 4843.1 4842.1 4897.3 4917.7 4921.4 4984.1 5047.2 5092.7 5095.0 5095.2 5097.5 5418.9 5438.1 5482.1 5484.9 5506.4 5094.6 5096.8 5109.3 5110.1 5161.5 5366.3 5375.4 5416.5 5419.5 5452.9 5565.6 5566.6 5569.4 5581.4 5594.0 5219.7 5341.5 5383.8 5385.7 5395.6 5207.1 5286.4 5343.3 5371.6 5383.7 5325.8 5328.3 5332.0 5333.5 5340.9 5431.7 5431.9 5445.6 5455.0 5477.5 5109.7 5191.8 5255.6 5261.5 5332.7 19:27:25 INFO - PID 28445 | 19:27:25 INFO - PID 28445 | [#1] ext.html Cycles:180 Average:33045.85 Median:30682.12 stddev:50752.13 (165.4%) stddev-sans-first:50836.23 19:27:25 INFO - PID 28445 | Values: 655.4 707.0 730.2 1056.4 1063.2 30373.4 31635.2 31659.2 31749.4 31849.4 33122.2 33476.8 33505.7 33524.5 33617.0 7059.7 7231.4 7344.2 7364.3 7368.9 7327.9 7473.2 7476.2 7478.8 7495.8 7441.4 7487.5 7494.9 7498.0 7505.5 7454.9 7457.3 7477.7 7479.7 7486.6 7286.8 7324.2 7362.0 7367.6 7397.1 34040.0 34522.0 34650.8 34669.3 34725.0 2659.9 2663.6 2670.7 2687.3 2704.2 24292.3 24303.6 24703.0 24890.5 25177.1 2768.1 2809.6 2811.8 2821.2 2832.0 119955.0 131459.3 135219.3 154184.0 154252.0 37993.6 38368.0 38414.0 38462.4 38520.8 43885.8 44030.6 44035.0 44054.7 44059.1 11700.9 11701.0 11802.5 11802.8 11810.4 9210.4 9214.2 9299.5 9309.4 9329.3 13350.3 13380.2 13418.7 13514.6 13725.8 5450.9 5477.6 5491.1 5564.9 5591.4 863.3 876.2 888.4 898.4 908.5 20577.1 21299.9 21420.1 21540.6 21948.5 952.4 953.9 986.8 987.4 988.1 10740.9 11070.0 11192.2 11242.3 11274.8 227094.0 228829.0 229068.0 229997.0 230397.0 42876.8 43185.6 43418.8 43450.6 43497.3 1186.0 1222.4 1231.1 1233.3 1234.6 19753.8 20363.2 20569.5 21046.6 21310.5 30589.8 30659.8 30704.4 30711.8 30719.0 204101.0 204920.0 205136.0 205276.0 206166.0 27506.6 28210.7 28356.9 28425.3 28561.1 33546.5 33651.2 33860.0 34309.5 34587.0 25820.7 26646.6 28287.9 28701.6 29168.4 25773.4 26266.9 26409.6 26803.2 27411.9 30504.3 30814.7 30898.8 31239.2 31487.2 26315.1 26737.2 27017.7 27787.6 27800.6 20527.3 22102.7 22185.0 22312.0 22351.6 19:27:25 INFO - PID 28445 | 19:27:25 INFO - PID 28445 | [#2] jquery.html Cycles:180 Average:26652.14 Median:22285.17 stddev:70434.41 (316.1%) stddev-sans-first:70604.44 19:27:25 INFO - PID 28445 | Values: 408.8 408.8 424.2 424.4 443.2 11602.2 13038.3 17736.1 18390.3 18407.2 14628.8 14686.6 14773.4 14991.2 15225.9 5639.4 5782.2 5817.1 5818.2 5824.0 5347.1 5562.8 5612.6 5615.9 5615.9 5537.9 5538.5 5539.6 5583.6 5585.4 5476.3 5668.9 5679.3 5716.6 5718.0 5004.7 5102.4 5140.9 5144.6 5157.5 21619.1 21933.2 22185.4 22190.2 22229.9 1546.4 1549.1 1553.8 1562.8 1600.3 13749.5 13786.7 14027.6 14206.7 14716.7 1598.2 1675.8 1699.6 1744.0 1789.1 85932.0 86467.1 87395.0 88262.6 91083.5 10810.4 10992.6 11046.1 11049.6 11198.8 15322.1 15355.0 15366.8 15388.1 15445.5 6747.5 6758.6 6892.2 6944.9 7017.8 5987.3 6048.6 6192.3 6196.1 6226.6 6671.7 6952.0 6964.7 6970.4 7026.4 2024.1 2094.1 2117.9 2120.5 2231.5 834.2 850.1 859.1 884.2 885.6 16469.9 16659.6 16977.3 17212.7 17273.1 859.5 862.5 874.7 881.1 884.1 8989.3 9095.2 9377.1 9388.6 9547.6 418806.0 419719.0 423502.0 424846.0 428787.0 90179.5 92797.0 93100.0 93365.0 93671.0 1040.2 1070.0 1074.4 1080.0 1081.0 14259.4 14369.5 14450.4 14500.1 14927.6 40627.6 41771.6 42570.6 42751.6 44127.1 51670.0 53292.7 54155.7 54540.7 56392.4 7459.2 7828.5 7839.0 7887.4 8212.1 12040.2 12267.9 12326.3 12347.4 12364.7 9458.6 9935.5 10515.3 10842.3 11215.2 9323.9 9326.2 9472.9 9511.4 9551.0 10618.3 11067.6 11419.8 11503.5 11552.8 7749.5 7921.1 7965.6 7967.5 8147.8 9963.7 10210.0 10310.9 10372.8 10615.6 19:27:25 INFO - PID 28445 | 19:27:25 INFO - PID 28445 | [#3] mootools.html Cycles:180 Average:6148.73 Median:4670.67 stddev:4050.90 (86.7%) stddev-sans-first:4045.36 19:27:25 INFO - PID 28445 | Values: 1223.6 1287.4 1288.4 1295.4 1296.4 9487.8 9709.9 9863.3 9864.5 9901.2 9947.2 10116.0 10118.5 10143.9 10153.6 2144.4 2185.0 2191.6 2194.8 2199.9 2130.8 2160.0 2192.2 2198.4 2200.7 2085.7 2161.5 2171.9 2179.3 2201.5 2143.9 2145.1 2145.2 2152.8 2154.5 1773.2 1830.9 2102.2 2141.3 2147.5 9275.1 9536.4 9546.7 9548.5 9549.0 5084.1 5347.4 5357.1 5358.3 5359.4 3167.9 3173.6 3188.4 3210.1 3312.4 1115.0 1123.9 1135.5 1141.5 1152.7 14704.8 14715.2 14749.2 14790.6 14886.8 4527.9 4768.1 4834.9 4846.4 4879.1 11042.6 11046.7 11048.1 11050.9 11051.3 5221.5 5259.6 5259.8 5260.6 5273.2 4710.2 4797.9 4809.3 4825.6 4843.9 3624.9 3636.1 3716.9 3733.9 3798.1 1102.9 1119.4 1123.0 1125.3 1126.5 639.3 666.6 675.4 675.6 677.5 5018.3 5046.7 5074.6 5093.3 5232.8 527.8 551.2 553.8 554.7 556.5 3151.2 3292.8 3294.3 3339.4 3463.3 12675.3 13122.3 13162.7 13165.1 13227.7 12561.1 13056.2 13125.7 13135.0 13314.6 9370.2 9449.6 9528.6 9562.0 9577.3 5500.6 5506.9 5517.2 5526.3 5627.7 11729.9 11889.9 11919.6 11938.5 11981.1 12255.4 12271.8 12427.5 12428.8 12429.8 7188.5 7246.2 7275.9 7361.9 7384.2 9468.2 9469.0 9580.7 9587.3 9598.6 8023.4 8035.2 8096.9 8229.5 8242.4 7865.4 7886.6 8000.9 8124.4 8134.3 7234.4 7327.4 7376.7 7416.0 7416.9 4731.1 4868.3 4892.9 4918.1 4925.4 4631.2 4712.1 4770.9 4800.2 4855.7 19:27:25 INFO - PID 28445 | 19:27:25 INFO - PID 28445 | [#4] prototype.html Cycles:180 Average:4826.29 Median:5451.48 stddev:1415.59 (26.0%) stddev-sans-first:1379.59 19:27:25 INFO - PID 28445 | Values: 375.9 392.5 397.1 403.4 404.3 5441.4 5587.7 5631.0 5644.4 5658.1 5385.4 5489.3 5492.7 5508.0 5529.8 4271.4 4275.3 4285.4 4288.7 4291.6 4106.6 4277.9 4298.7 4310.8 4312.7 4250.7 4256.3 4259.4 4262.0 4275.4 4230.4 4234.4 4242.9 4247.2 4260.9 3556.7 3724.2 3735.9 3736.6 3751.7 5335.2 5354.6 5387.5 5397.2 5415.8 4894.2 4895.3 4903.7 4907.4 4918.1 5549.4 5737.4 5775.6 5795.9 5802.5 4061.5 4077.8 4081.3 4087.0 4087.4 5763.7 5988.5 6012.9 6094.0 6116.4 4176.1 4178.8 4200.7 4204.4 4213.5 4212.7 4223.9 4233.6 4249.4 4263.1 4785.8 4843.2 4855.5 4865.7 4879.9 5831.9 5855.8 5857.2 5858.2 5863.2 1463.5 1468.6 1471.1 1472.2 1478.1 949.0 978.6 988.9 1000.5 1009.8 5108.9 5123.5 5123.7 5128.9 5130.0 6044.8 6059.2 6077.2 6081.2 6114.4 4836.3 5083.0 5086.4 5116.2 5151.2 3225.9 3236.5 3240.2 3249.4 3251.2 5434.6 5598.5 5638.0 5651.4 5660.7 6135.9 6140.4 6174.4 6176.0 6209.2 5585.6 5623.0 5625.4 5636.6 5637.3 5782.7 6027.7 6069.1 6109.7 6171.2 5997.8 6012.3 6040.9 6045.6 6047.0 5360.2 5461.5 5546.5 5613.6 5656.9 4173.5 4207.5 4210.8 4211.0 4218.7 5927.9 6019.3 6074.8 6088.4 6097.6 5842.9 5884.8 5912.9 5913.2 5938.1 5806.3 5806.9 5819.4 5902.2 5904.8 5555.2 5729.9 5793.3 5818.4 5856.0 5909.6 5921.0 5926.9 5932.7 5956.6 5558.5 5722.4 5748.1 5768.3 5779.8 19:27:25 INFO - PID 28445 | 19:27:25 INFO - PID 28445 | [#5] yui.html Cycles:180 Average:14515.62 Median:23578.69 stddev:18234.69 (77.3%) stddev-sans-first:18255.86 19:27:25 INFO - PID 28445 | Values: 590.8 616.0 622.6 638.3 639.7 11099.9 11442.7 11947.6 11953.8 11984.2 11550.4 11602.5 11638.8 11729.4 12287.7 825.1 833.4 848.3 852.7 859.1 854.2 855.8 858.8 859.0 860.9 890.6 891.7 893.7 894.8 895.2 880.8 884.6 888.2 888.5 888.9 647.6 654.0 655.0 656.1 657.0 12020.8 12155.0 12228.5 12238.2 12904.4 13745.4 14357.0 14412.9 14437.5 14451.3 9998.0 10160.8 10185.6 10398.7 10526.3 2658.5 2661.7 2674.1 2704.9 2758.5 66509.7 66820.7 66832.0 67394.0 67669.0 10295.4 10498.0 10500.3 10505.4 10599.5 21148.0 21158.8 21294.4 21300.1 21445.4 6267.7 6364.3 6407.4 6411.0 6624.2 3308.4 3363.0 3382.3 3387.1 3442.2 3499.9 3556.2 3567.1 3579.3 3910.7 730.5 731.6 736.0 753.3 754.8 473.4 488.2 494.6 502.1 507.5 8369.5 8390.4 8407.2 8593.9 8637.4 475.7 489.8 491.4 492.9 504.6 3701.9 3727.6 3743.5 3775.4 3865.2 64681.4 64772.7 65297.3 66711.7 67398.0 54076.2 54230.7 55597.0 55965.7 56243.0 49260.5 49437.8 50057.7 50625.5 50763.5 8698.6 8931.6 9075.6 9139.7 9140.5 24195.5 24291.9 26245.6 26379.0 26676.2 42518.4 44070.6 45644.1 46249.3 46684.0 11546.8 11683.1 11743.3 11805.9 12046.6 11634.7 11695.2 11879.9 12126.2 12482.9 11974.4 12076.8 12236.6 12659.6 12665.4 11819.4 12152.7 12232.4 12422.4 12680.7 11411.4 11583.5 11723.6 11902.3 12065.6 7671.3 7955.2 8540.7 8540.8 8647.5 8385.9 9947.6 9976.4 10113.5 10146.4 19:27:25 INFO - PID 28445 | -------- Summary: end -------- 19:27:25 INFO - PID 28445 | 19:27:25 INFO - TEST-INFO | 28445: exit 0 19:27:25 INFO - TEST-OK | dromaeo_css | took 1120344ms 19:27:25 INFO - TEST-START | kraken 19:27:25 INFO - operating with platform_type : linux_ 19:27:25 INFO - Initialising browser for kraken test... 19:27:25 INFO - TEST-INFO | started process 28830 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJNzjUh/profile http://localhost:33699/getInfo.html) 19:27:30 INFO - PID 28830 | __metrics Screen width/height:1600/1200 19:27:30 INFO - PID 28830 | colorDepth:24 19:27:30 INFO - PID 28830 | Browser inner width/height: 1024/697 19:27:30 INFO - PID 28830 | __metrics 19:27:31 ERROR - PID 28830 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3388: TypeError: this.tabs is undefined 19:27:32 INFO - TEST-INFO | 28830: exit 0 19:27:32 INFO - Browser initialized. 19:27:32 INFO - Running cycle 1/1 for kraken test... 19:27:32 INFO - TEST-INFO | started process 28960 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJNzjUh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:27:44 INFO - PID 28960 | RSS: Main: 156160000 19:27:44 INFO - PID 28960 | 19:27:47 INFO - PID 28960 | Cycle 1(1): loaded http://localhost:33699/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33699/tests/kraken/driver.html?testName=audio-beat-detection) 19:27:48 INFO - PID 28960 | RSS: Main: 162590720 19:27:48 INFO - PID 28960 | 19:27:51 INFO - PID 28960 | Cycle 1(1): loaded http://localhost:33699/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33699/tests/kraken/driver.html?testName=audio-dft) 19:27:51 INFO - PID 28960 | RSS: Main: 161677312 19:27:51 INFO - PID 28960 | 19:27:54 INFO - PID 28960 | Cycle 1(1): loaded http://localhost:33699/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33699/tests/kraken/driver.html?testName=audio-fft) 19:27:55 INFO - PID 28960 | RSS: Main: 158449664 19:27:55 INFO - PID 28960 | 19:27:57 INFO - PID 28960 | Cycle 1(1): loaded http://localhost:33699/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33699/tests/kraken/driver.html?testName=audio-oscillator) 19:27:58 INFO - PID 28960 | RSS: Main: 158965760 19:27:58 INFO - PID 28960 | 19:28:00 INFO - PID 28960 | Cycle 1(1): loaded http://localhost:33699/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33699/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:28:00 INFO - PID 28960 | RSS: Main: 159281152 19:28:00 INFO - PID 28960 | 19:28:04 INFO - PID 28960 | Cycle 1(1): loaded http://localhost:33699/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33699/tests/kraken/driver.html?testName=imaging-darkroom) 19:28:04 INFO - PID 28960 | RSS: Main: 163737600 19:28:04 INFO - PID 28960 | 19:28:08 INFO - PID 28960 | Cycle 1(1): loaded http://localhost:33699/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33699/tests/kraken/driver.html?testName=imaging-desaturate) 19:28:08 INFO - PID 28960 | RSS: Main: 161701888 19:28:08 INFO - PID 28960 | 19:28:11 INFO - PID 28960 | Cycle 1(1): loaded http://localhost:33699/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33699/tests/kraken/driver.html?testName=json-parse-financial) 19:28:12 INFO - PID 28960 | RSS: Main: 162848768 19:28:12 INFO - PID 28960 | 19:28:14 INFO - PID 28960 | Cycle 1(1): loaded http://localhost:33699/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33699/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:28:14 INFO - PID 28960 | RSS: Main: 163401728 19:28:14 INFO - PID 28960 | 19:28:16 INFO - PID 28960 | Cycle 1(1): loaded http://localhost:33699/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33699/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:28:17 INFO - PID 28960 | RSS: Main: 163553280 19:28:17 INFO - PID 28960 | 19:28:19 INFO - PID 28960 | Cycle 1(1): loaded http://localhost:33699/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33699/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:28:20 INFO - PID 28960 | RSS: Main: 163713024 19:28:20 INFO - PID 28960 | 19:28:23 INFO - PID 28960 | Cycle 1(1): loaded http://localhost:33699/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33699/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:28:23 INFO - PID 28960 | RSS: Main: 164200448 19:28:23 INFO - PID 28960 | 19:28:27 INFO - PID 28960 | Cycle 1(1): loaded http://localhost:33699/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33699/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:28:27 INFO - PID 28960 | RSS: Main: 161951744 19:28:27 INFO - PID 28960 | 19:28:29 INFO - PID 28960 | Cycle 1(1): loaded http://localhost:33699/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33699/tests/kraken/driver.html?testName=ai-astar) 19:28:29 INFO - PID 28960 | RSS: Main: 163655680 19:28:29 INFO - PID 28960 | 19:28:29 INFO - PID 28960 | __start_tp_report 19:28:29 INFO - PID 28960 | _x_x_mozilla_page_load 19:28:29 INFO - PID 28960 | _x_x_mozilla_page_load_details 19:28:29 INFO - PID 28960 | |i|pagename|runs| 19:28:29 INFO - PID 28960 | |0;ai-astar;104;112;111;112;113;112;113;113;112;112 19:28:29 INFO - PID 28960 | |1;audio-beat-detection;153;132;126;171;130;128;127;127;162;132 19:28:29 INFO - PID 28960 | |2;audio-dft;165;163;168;166;169;172;166;166;164;165 19:28:29 INFO - PID 28960 | |3;audio-fft;75;75;76;110;78;77;76;77;95;75 19:28:29 INFO - PID 28960 | |4;audio-oscillator;85;86;103;84;85;86;102;85;84;106 19:28:29 INFO - PID 28960 | |5;imaging-gaussian-blur;115;114;114;114;117;114;114;114;114;114 19:28:29 INFO - PID 28960 | |6;imaging-darkroom;151;150;151;151;151;150;150;151;150;153 19:28:29 INFO - PID 28960 | |7;imaging-desaturate;94;96;95;95;94;96;95;95;94;94 19:28:29 INFO - PID 28960 | |8;json-parse-financial;68;68;67;69;70;69;68;69;68;69 19:28:29 INFO - PID 28960 | |9;json-stringify-tinderbox;55;55;55;55;55;55;56;55;55;55 19:28:29 INFO - PID 28960 | |10;stanford-crypto-aes;84;84;84;85;83;90;83;82;82;83 19:28:29 INFO - PID 28960 | |11;stanford-crypto-ccm;135;143;142;133;142;141;138;135;185;133 19:28:29 INFO - PID 28960 | |12;stanford-crypto-pbkdf2;191;202;213;196;199;197;200;206;199;197 19:28:29 INFO - PID 28960 | |13;stanford-crypto-sha256-iterative;74;73;74;73;71;72;79;71;73;72 19:28:29 INFO - PID 28960 | __end_tp_report 19:28:29 INFO - PID 28960 | __start_cc_report 19:28:29 INFO - PID 28960 | _x_x_mozilla_cycle_collect,873 19:28:29 INFO - PID 28960 | __end_cc_report 19:28:29 INFO - PID 28960 | __startTimestamp1490322509885__endTimestamp 19:28:29 INFO - PID 28960 | 19:28:29 INFO - PID 28960 | ------- Summary: start ------- 19:28:29 INFO - PID 28960 | Number of tests: 14 19:28:29 INFO - PID 28960 | 19:28:29 INFO - PID 28960 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:2.67 (2.4%) stddev-sans-first:0.67 19:28:29 INFO - PID 28960 | Values: 104.0 112.0 111.0 112.0 113.0 112.0 113.0 113.0 112.0 112.0 19:28:29 INFO - PID 28960 | 19:28:29 INFO - PID 28960 | [#1] audio-beat-detection Cycles:10 Average:138.80 Median:132.00 stddev:16.69 (12.6%) stddev-sans-first:16.89 19:28:29 INFO - PID 28960 | Values: 153.0 132.0 126.0 171.0 130.0 128.0 127.0 127.0 162.0 132.0 19:28:29 INFO - PID 28960 | 19:28:29 INFO - PID 28960 | [#2] audio-dft Cycles:10 Average:166.40 Median:166.00 stddev:2.63 (1.6%) stddev-sans-first:2.74 19:28:29 INFO - PID 28960 | Values: 165.0 163.0 168.0 166.0 169.0 172.0 166.0 166.0 164.0 165.0 19:28:29 INFO - PID 28960 | 19:28:29 INFO - PID 28960 | [#3] audio-fft Cycles:10 Average:81.40 Median:76.50 stddev:11.71 (15.3%) stddev-sans-first:12.19 19:28:29 INFO - PID 28960 | Values: 75.0 75.0 76.0 110.0 78.0 77.0 76.0 77.0 95.0 75.0 19:28:29 INFO - PID 28960 | 19:28:29 INFO - PID 28960 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:85.00 stddev:9.09 (10.7%) stddev-sans-first:9.42 19:28:29 INFO - PID 28960 | Values: 85.0 86.0 103.0 84.0 85.0 86.0 102.0 85.0 84.0 106.0 19:28:29 INFO - PID 28960 | 19:28:29 INFO - PID 28960 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:0.97 (0.8%) stddev-sans-first:1.00 19:28:29 INFO - PID 28960 | Values: 115.0 114.0 114.0 114.0 117.0 114.0 114.0 114.0 114.0 114.0 19:28:29 INFO - PID 28960 | 19:28:29 INFO - PID 28960 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 19:28:29 INFO - PID 28960 | Values: 151.0 150.0 151.0 151.0 151.0 150.0 150.0 151.0 150.0 153.0 19:28:29 INFO - PID 28960 | 19:28:29 INFO - PID 28960 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 19:28:29 INFO - PID 28960 | Values: 94.0 96.0 95.0 95.0 94.0 96.0 95.0 95.0 94.0 94.0 19:28:29 INFO - PID 28960 | 19:28:29 INFO - PID 28960 | [#8] json-parse-financial Cycles:10 Average:68.50 Median:69.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 19:28:29 INFO - PID 28960 | Values: 68.0 68.0 67.0 69.0 70.0 69.0 68.0 69.0 68.0 69.0 19:28:29 INFO - PID 28960 | 19:28:29 INFO - PID 28960 | [#9] json-stringify-tinderbox Cycles:10 Average:55.10 Median:55.00 stddev:0.32 (0.6%) stddev-sans-first:0.33 19:28:29 INFO - PID 28960 | Values: 55.0 55.0 55.0 55.0 55.0 55.0 56.0 55.0 55.0 55.0 19:28:29 INFO - PID 28960 | 19:28:29 INFO - PID 28960 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.00 stddev:2.31 (2.7%) stddev-sans-first:2.45 19:28:29 INFO - PID 28960 | Values: 84.0 84.0 84.0 85.0 83.0 90.0 83.0 82.0 82.0 83.0 19:28:29 INFO - PID 28960 | 19:28:29 INFO - PID 28960 | [#11] stanford-crypto-ccm Cycles:10 Average:142.70 Median:141.50 stddev:15.36 (10.9%) stddev-sans-first:16.03 19:28:29 INFO - PID 28960 | Values: 135.0 143.0 142.0 133.0 142.0 141.0 138.0 135.0 185.0 133.0 19:28:29 INFO - PID 28960 | 19:28:29 INFO - PID 28960 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:200.00 Median:199.50 stddev:6.02 (3.0%) stddev-sans-first:5.43 19:28:29 INFO - PID 28960 | Values: 191.0 202.0 213.0 196.0 199.0 197.0 200.0 206.0 199.0 197.0 19:28:29 INFO - PID 28960 | 19:28:29 INFO - PID 28960 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:73.00 stddev:2.30 (3.2%) stddev-sans-first:2.42 19:28:29 INFO - PID 28960 | Values: 74.0 73.0 74.0 73.0 71.0 72.0 79.0 71.0 73.0 72.0 19:28:29 INFO - PID 28960 | -------- Summary: end -------- 19:28:29 INFO - PID 28960 | 19:28:31 INFO - TEST-INFO | 28960: exit 0 19:28:31 INFO - TEST-OK | kraken | took 65169ms 19:28:31 INFO - SUITE-END | took 1185s 19:28:31 INFO - Completed test suite (00:19:45) 19:28:31 INFO - javascript benchmark 19:28:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6561.056532579034, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2659.614355918392, 2665.760081592656, 2677.290518012727, 2701.9459610807785, 2708.3770732731464, 5014.674046187004, 5108.233764935261, 5133.666311689738, 5170.5605023573, 5173.094708426029, 5033.11920413928, 5097.298431831126, 5104.05574968631, 5186.247994040862, 5218.034663587229, 4685.273782563708, 4708.5526874947, 4718.646101542381, 4728.739919304437, 4733.408323959505, 4752.4297084349755, 4779.0, 4779.187538118511, 4784.330193772875, 4837.806487740486, 4560.498345182027, 4594.287885377772, 4669.136209801198, 4678.251479763256, 4684.180268453007, 4712.269598212282, 4731.929021064652, 4738.407699037621, 4776.5701086902345, 4780.856574302777, 4608.516105808875, 4680.812767489297, 4699.506551812045, 4719.575238228542, 4737.052589482083, 4987.326710894055, 5037.194048952187, 5139.7687104080405, 5155.639105262633, 5170.19861921399, 5491.862703432446, 5522.475364840334, 5558.888822223533, 5578.972105139489, 5579.832605021856, 5546.362168350651, 5562.888742225174, 5565.276514053147, 5579.107342825169, 5583.832485025456, 5027.84916452507, 5161.5870730341485, 5174.042802081627, 5179.637425380225, 5214.713190774468, 5593.0, 5646.407127251661, 5731.369549349568, 5731.455511726379, 5737.311522617312, 5236.554892834151, 5316.415194328621, 5398.082326004589, 5481.780728770805, 5484.177373394023, 5445.50990410865, 5456.099743542271, 5493.752781124859, 5510.090835012258, 5521.503064724114, 5307.044731948286, 5479.643823151482, 5481.397046324901, 5483.588730845123, 5484.7531861066345, 5426.70153141581, 5434.782608695687, 5473.480019398151, 5475.397706252309, 5505.229267902497, 4649.3026046093355, 4677.555632214934, 4687.531246875354, 4691.39011928454, 4724.456687480915, 3972.1857019310974, 3994.6005399460405, 4006.8797936061965, 4040.8383664653675, 4046.575109613448, 4654.4414670239785, 4728.338032675429, 4786.832460863853, 4832.782524786393, 4841.975790121027, 5580.553555715533, 5594.692291923983, 5594.692291923983, 5604.131359639263, 5635.605507614428, 4762.9523704763205, 4773.11697335994, 4777.617790576745, 4801.039792041605, 4843.0798148352405, 4842.104210721028, 4897.314375987365, 4917.680350777188, 4921.384826896638, 4984.102861484895, 5047.2429135629945, 5092.745362731775, 5094.974525127351, 5095.210242412432, 5097.464766199496, 5418.864528386822, 5438.102713052302, 5482.068048431696, 5484.890302194013, 5506.394296627448, 5094.5669618082875, 5096.770645320896, 5109.310243117132, 5110.054639891632, 5161.509656582619, 5366.302380690485, 5375.354957405137, 5416.51251387377, 5419.539339156216, 5452.863678408072, 5565.6104072714525, 5566.610337276352, 5569.387367389503, 5581.358143813351, 5593.972030139986, 5219.660722053054, 5341.465853414627, 5383.757730902197, 5385.703786291791, 5395.568354531707, 5207.140821764367, 5286.392064912584, 5343.305370301991, 5371.5702743781185, 5383.6500627460655, 5325.840224793263, 5328.307320048369, 5332.040232757986, 5333.5199832015305, 5340.866478338073, 5431.6740995540395, 5431.945680543144, 5445.618806683494, 5454.952601328688, 5477.4796394342475, 5109.744512774272, 5191.8182863599595, 5255.579553635776, 5261.4738526147075, 5332.653377530448], "value": 5033.996651516278, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.4265018109154, 706.9575825450472, 730.2077246187886, 1056.4189695667385, 1063.1547919404072, 30373.392532149344, 31635.20911977202, 31659.20851978702, 31749.36501269973, 31849.36301273973, 33122.17194570137, 33476.83261583689, 33505.66494335062, 33524.49713254297, 33617.0, 7059.682314295844, 7231.421486281111, 7344.2288559701265, 7364.263573642646, 7368.852622947537, 7327.890081648779, 7473.177950425449, 7476.1776204617445, 7478.813029674275, 7495.775126746206, 7441.367483763886, 7487.513311634726, 7494.887576686354, 7497.962510187442, 7505.5121417107985, 7454.850902981937, 7457.328840404335, 7477.663505142282, 7479.738209162653, 7486.625668716597, 7286.81782955425, 7324.194338622748, 7362.0, 7367.557946523172, 7397.149327827315, 34040.0, 34522.0, 34650.82674586611, 34669.30661386758, 34725.0, 2659.9202023939315, 2663.5605125154325, 2670.692870319899, 2687.2744359022954, 2704.2428120126397, 24292.271231863073, 24303.63544546833, 24703.0, 24890.5021899561, 25177.118800841883, 2768.1418760184206, 2809.6347474828344, 2811.8031737778365, 2821.167755512108, 2831.957520637192, 119955.0, 131459.34270328682, 135219.32390338083, 154184.0, 154252.0, 37993.62006379901, 38368.0, 38414.0, 38462.42306365407, 38520.8073959634, 43885.78057109694, 44030.55969440329, 44035.0, 44054.73096939033, 44059.11881762411, 11700.941495292469, 11701.0, 11802.52789888395, 11802.76394472123, 11810.40947952599, 9210.447373157498, 9214.216791572791, 9299.488528131018, 9309.44143351401, 9329.253659707207, 13350.332483375792, 13380.19718816874, 13418.664533386549, 13514.59456216315, 13725.794113088312, 5450.945490545044, 5477.643953143033, 5491.093969494988, 5564.888702226014, 5591.384947655754, 863.2964134230582, 876.1851478125277, 888.4092078767547, 898.3756289378819, 908.5139450394007, 20577.07403166861, 21299.893500532708, 21420.143194272056, 21540.569188616453, 21948.451288717908, 952.4047470331043, 953.9284553658365, 986.7779749556292, 987.4272921705393, 988.1057642833248, 10740.892591074145, 11070.0, 11192.216544841784, 11242.325460472397, 11274.830877536844, 227094.0, 228829.0, 229068.0, 229997.0, 230397.0, 42876.78561607172, 43185.568144318786, 43418.7829060859, 43450.56549434528, 43497.347539786926, 1186.0014243887094, 1222.413241644016, 1231.1259006105765, 1233.3031837012059, 1234.5864135514703, 19753.802461975196, 20363.185472581525, 20569.48576285545, 21046.57906841885, 21310.467238319165, 30589.847050764605, 30659.846700766353, 30704.38591228118, 30711.846440767655, 30719.0, 204101.0, 204920.0, 205136.0, 205276.0, 206166.0, 27506.587401188597, 28210.71789282081, 28356.858215708788, 28425.28936776597, 28561.143165705063, 33546.496802547495, 33651.15872103217, 33860.0, 34309.48535771915, 34587.0, 25820.748031103412, 26646.600300995888, 28287.85856070789, 28701.569476458288, 29168.416631666823, 25773.3556661085, 26266.868665656548, 26409.60385594179, 26803.19590412291, 27411.86294068517, 30504.34191723901, 30814.69185308118, 30898.76404943777, 31239.219019524695, 31487.21281967969, 26315.10533841314, 26737.19788406351, 27017.72982270152, 27787.58318625263, 27800.58299125474, 20527.28154514585, 22102.668459972792, 22185.0, 22312.0, 22351.552968940206], "value": 14681.637170338014, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.8160327852467, 408.81807595619944, 424.24272673278193, 424.37404827878885, 443.21329639889194, 11602.187846850724, 13038.282894440801, 17736.11319434028, 18390.264389424425, 18407.17167727454, 14628.780568291457, 14686.55940321792, 14773.409063637468, 14991.175485348329, 15225.92387038066, 5639.379668236491, 5782.24830771999, 5817.0983497557945, 5818.156367326735, 5823.9708801456145, 5347.144456886899, 5562.833115006556, 5612.607117501777, 5615.887682246353, 5615.915761263564, 5537.944620553783, 5538.529225015858, 5539.639923404986, 5583.609147359686, 5585.385607583163, 5476.342838859342, 5668.858278543028, 5679.318481782213, 5716.628419152742, 5717.9714101429645, 5004.699718016895, 5102.387713474407, 5140.897182056338, 5144.639875208737, 5157.4584668610005, 21619.135234590598, 21933.232336868132, 22185.44536386587, 22190.223342182948, 22229.888850555806, 1546.3814474210294, 1549.147968617256, 1553.8368471310462, 1562.8359022302723, 1600.3278622978378, 13749.450021999108, 13786.724265514735, 14027.64930876726, 14206.715865682732, 14716.705665886622, 1598.2168737318746, 1675.8240384759667, 1699.643074954261, 1744.049493026291, 1789.1412122181296, 85932.0, 86467.13532864653, 87395.0, 88262.55868720615, 91083.54458227733, 10810.405427701551, 10992.560297588007, 11046.097613202306, 11049.613263535737, 11198.832017519744, 15322.080675159526, 15355.0, 15366.769498457532, 15388.076715396888, 15445.536633901002, 6747.493937954575, 6758.560693555001, 6892.241853396123, 6944.930550694529, 7017.824554386181, 5987.341392446828, 6048.637081775108, 6192.287886892975, 6196.087838715796, 6226.5641405102115, 6671.666416679147, 6951.965240173767, 6964.721411143599, 6970.442364610819, 7026.367626913602, 2024.0891598780313, 2094.1309356616835, 2117.883516406612, 2120.544083022127, 2231.509068005036, 834.1950018232313, 850.1243718969471, 859.0979471554842, 884.2439714044529, 885.5749240364532, 16469.91765041167, 16659.584785119023, 16977.320907163576, 17212.655746884993, 17273.136343182792, 859.5143743784741, 862.4609618988133, 874.728834061443, 881.0572687224608, 884.0717246890739, 8989.280857531381, 9095.181433670869, 9377.109174628536, 9388.62445502186, 9547.570359333846, 418806.0, 419719.0, 423502.0, 424846.0, 428787.0, 90179.54910225538, 92797.0, 93100.0, 93365.0, 93670.99999999863, 1040.2302296300684, 1069.9732506687394, 1074.3731576296038, 1079.9784004319713, 1081.0378762901025, 14259.358328875018, 14369.497067602584, 14450.421983120557, 14500.057496262709, 14927.552173434815, 40627.59372406238, 41771.58228417799, 42570.57429425666, 42751.572484276, 44127.11745765131, 51670.0, 53292.73353633207, 54155.72922135364, 54540.727296363264, 56392.43607563872, 7459.179490256176, 7828.45200835936, 7839.0, 7887.369010479262, 8212.13772553897, 12040.21738586989, 12267.87732122703, 12326.260424374566, 12347.444365003417, 12364.690882728004, 9458.574364153492, 9935.453550054817, 10515.263931525025, 10842.295250808673, 11215.158863085138, 9323.906760932305, 9326.207272381924, 9472.857907131262, 9511.429314241168, 9550.95224523873, 10618.309809862334, 11067.557297708001, 11419.771604568028, 11503.53985840557, 11552.826707599224, 7749.496282741604, 7921.128675845767, 7965.56189409588, 7967.482113662593, 8147.79630509242, 9963.701088967342, 10210.0, 10310.896891030994, 10372.792544148924, 10615.575376985144], "value": 8656.72846474656, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1223.5717498875392, 1287.4270949427503, 1288.4137717338613, 1295.3652710172018, 1296.436050318111, 9487.81024379512, 9709.902900970988, 9863.30956833022, 9864.506774661257, 9901.207903367731, 9947.204223662107, 10116.0, 10118.494075296225, 10143.898561014388, 10153.59385624576, 2144.4317255927153, 2184.9563008739815, 2191.616467118256, 2194.846360754748, 2199.912003519857, 2130.7762684918093, 2159.9568008639817, 2192.177933275022, 2198.373463562885, 2200.7469141048823, 2085.7080008798703, 2161.5460753241837, 2171.89140542973, 2179.280837323687, 2201.4936564590153, 2143.882086485243, 2145.1312218551357, 2145.249162793026, 2152.773958734334, 2154.515234072329, 1773.219783295346, 1830.9084545772657, 2102.16964299101, 2141.2719675310314, 2147.452399638098, 9275.072492750738, 9536.380135291183, 9546.713598591983, 9548.522573871278, 9549.0, 5084.13569693153, 5347.385050719178, 5357.062514060063, 5358.33020872391, 5359.356877174725, 3167.8732850685947, 3173.5557022016937, 3188.3942051010235, 3210.133264018725, 3312.4368857294317, 1115.0466351269629, 1123.9044681202108, 1135.523080306265, 1141.4635121492886, 1152.7406333574963, 14704.779428308477, 14715.190664513448, 14749.188794616291, 14790.556283311518, 14886.776698349533, 4527.864164075083, 4768.117898188777, 4834.879128021757, 4846.36997190363, 4879.072976134523, 11042.613508527164, 11046.723831904266, 11048.116150707923, 11050.889491105147, 11051.281666691639, 5221.477852214748, 5259.579233661298, 5259.815906443333, 5260.552853007537, 5273.209018647157, 4710.152172608963, 4797.880052998633, 4809.302651115569, 4825.5898248649255, 4843.854684359475, 3624.9093772655897, 3636.1455058061333, 3716.9442458363146, 3733.9066523337133, 3798.145417281145, 1102.944852757375, 1119.4290911634962, 1123.039800970175, 1125.2798209146154, 1126.4649291586431, 639.2935805934468, 666.6033709942576, 675.4157653629575, 675.6486626954055, 677.4783416769159, 5018.322526458955, 5046.7476626168545, 5074.594032477393, 5093.286939828427, 5232.790688372423, 527.7677821758414, 551.203510926707, 553.7674176845735, 554.7032337699311, 556.5047108073736, 3151.2121969507625, 3292.8353582320788, 3294.341131773655, 3339.3655205510877, 3463.2554000889427, 12675.302858342695, 13122.34388280582, 13162.736745265232, 13165.144265622705, 13227.73544529104, 12561.120721549587, 13056.151350162208, 13125.737485250242, 13135.0, 13314.600561983156, 9370.156685898302, 9449.622015119456, 9528.571214295373, 9561.995990421045, 9577.281703872377, 5500.559955203654, 5506.944930550643, 5517.2275881377445, 5526.336839579276, 5627.662340259598, 11729.882701173221, 11889.940550297539, 11919.642410727693, 11938.52245910154, 11981.101417393556, 12255.387230638611, 12271.754564908473, 12427.502899883903, 12428.81356779631, 12429.75140497203, 7188.5327453715345, 7246.166690830411, 7275.890861636974, 7361.889571656537, 7384.18773934856, 9468.195203407788, 9469.0, 9580.712578622653, 9587.280953928623, 9598.568064437257, 8023.438359314792, 8035.156308587514, 8096.878546821685, 8229.46508476971, 8242.381821363302, 7865.426914616985, 7886.566238856918, 8000.879986800086, 8124.39067069984, 8134.349252059703, 7234.385077268491, 7327.413806895329, 7376.668049937873, 7416.035915330973, 7416.925830741624, 4731.148393289241, 4868.342773725643, 4892.8532144035735, 4918.0901533216465, 4925.433575138905, 4631.189541830234, 4712.128256272601, 4770.904581908412, 4800.231962885921, 4855.708657480563], "value": 4557.919454537294, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.9398496240601, 392.51916402407045, 397.0966052231175, 403.3727553654069, 404.2581862282715, 5441.428649991743, 5587.6811123383795, 5630.971845140773, 5644.407337229593, 5658.122990936401, 5385.407605163438, 5489.34127904652, 5492.697901615409, 5507.972460137694, 5529.778808847651, 4271.444712187411, 4275.273203555403, 4285.378620100084, 4288.742675439468, 4291.635211007068, 4106.630403263705, 4277.914441711164, 4298.699091063627, 4310.80601372939, 4312.698111132207, 4250.744955302692, 4256.297710877717, 4259.446271984653, 4262.0, 4275.444192255002, 4230.428892099558, 4234.386014027964, 4242.8727138185905, 4247.235497610444, 4260.9147817043795, 3556.733245006609, 3724.1992971511254, 3735.906602334936, 3736.5516138063335, 3751.662350388478, 5335.1997200419855, 5354.598405119632, 5387.542058924996, 5397.217403476474, 5415.756290966877, 4894.1679914414635, 4895.31465594817, 4903.65674402792, 4907.362042934431, 4918.114739346916, 5549.38956714761, 5737.39757325479, 5775.5668324875805, 5795.913061304042, 5802.47777700009, 4061.4923134608175, 4077.799866137883, 4081.2857749893947, 4087.0, 4087.3650539784026, 5763.682997435139, 5988.520918326523, 6012.89548657975, 6093.969530152365, 6116.388361163892, 4176.14389050244, 4178.770167640748, 4200.684948628865, 4204.432401625802, 4213.492971681844, 4212.684048696298, 4223.915521689611, 4233.597808208216, 4249.447571815645, 4263.126059157865, 4785.760711964457, 4843.15244832153, 4855.547948286164, 4865.659403841697, 4879.878003049952, 5831.854203644858, 5855.824325270249, 5857.179994800731, 5858.179854820329, 5863.179154918314, 1463.495094192502, 1468.5814542855235, 1471.0952764050032, 1472.1535117307376, 1478.0835881753383, 948.990510094904, 978.6281213139104, 988.9072574804737, 1000.5297510170209, 1009.8232809258351, 5108.948910510921, 5123.538881500608, 5123.666961647481, 5128.897422051538, 5130.0, 6044.788432404845, 6059.182010428536, 6077.17958075663, 6081.17904082952, 6114.357992410822, 4836.250381190921, 5083.0, 5086.364204474441, 5116.232565115262, 5151.150060240094, 3225.903222903317, 3236.478854938175, 3240.2016880631004, 3249.431349513826, 3251.219707270285, 5434.565234781208, 5598.496135347838, 5638.0, 5651.378348381675, 5660.688662123623, 6135.938640613536, 6140.4473597376455, 6174.413430724074, 6176.0, 6209.161763162006, 5585.636933599303, 5623.0, 5625.353084395183, 5636.633618814764, 5637.267155269788, 5782.653040817564, 6027.6986150693165, 6069.119977603134, 6109.69451527413, 6171.1668924694595, 5997.790077347272, 6012.308584512837, 6040.879182416415, 6045.576809623284, 6047.0, 5360.16917377807, 5461.5357694596405, 5546.528545073714, 5613.607047506635, 5656.906944430587, 4173.518400967613, 4207.495100587949, 4210.810513526837, 4210.957890421179, 4218.662506999494, 5927.911081333869, 6019.277686677627, 6074.848128796815, 6088.4215999479975, 6097.634141951497, 5842.912356314744, 5884.823455296348, 5912.852178695567, 5913.231279933581, 5938.138969849434, 5806.274215723035, 5806.854828629318, 5819.359870414336, 5902.20320256777, 5904.763809447574, 5555.194626713484, 5729.914051289151, 5793.304803423616, 5818.44724751148, 5855.970720146372, 5909.586328957103, 5920.970395147997, 5926.851828704144, 5932.703364831655, 5956.612820166675, 5558.499735023867, 5722.4249087909775, 5748.109043098327, 5768.2501274834, 5779.768809247751], "value": 4391.155130318922, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.7932223721696, 616.0451300484249, 622.6388694557156, 638.3010603389287, 639.6705696566268, 11099.889001109987, 11442.656720298404, 11947.641570752881, 11953.7609247815, 11984.221025633327, 11550.422478876064, 11602.535898564047, 11638.825417618742, 11729.354885481294, 12287.692807679812, 825.1212458731462, 833.3791325462539, 848.2789628815489, 852.7441767469766, 859.072202021818, 854.2311919272643, 855.7719672270281, 858.8153546987396, 858.9656413743443, 860.9182127697859, 890.6437425030008, 891.6522556203086, 893.7318804358699, 894.7986702991807, 895.212213252337, 880.8062226310234, 884.5975081337975, 888.2183678363064, 888.506878682331, 888.9111088891092, 647.6308504152635, 654.0, 654.9815037616504, 656.1339032477132, 657.0079180437526, 12020.759584808342, 12155.0, 12228.510859565607, 12238.204516706475, 12904.419301131471, 13745.38145783442, 14357.0, 14412.927935360256, 14437.494687685881, 14451.277436128257, 9997.950010249902, 10160.79678406435, 10185.643502477451, 10398.740031499197, 10526.31578947366, 2658.4815960887636, 2661.6939052009075, 2674.1041751013436, 2704.8512331821744, 2758.544840101381, 66509.67687100323, 66820.66589667069, 66832.0, 67394.0, 67669.0, 10295.3822770634, 10498.0, 10500.264981451224, 10505.369677819355, 10599.470026498644, 21148.048337824835, 21158.78841211599, 21294.36116916495, 21300.147994080064, 21445.356639300848, 6267.749290028348, 6364.299927008025, 6407.391297826699, 6411.0, 6624.205095388488, 3308.354870800219, 3363.0, 3382.340443613472, 3387.0516255448515, 3442.1910850950007, 3499.9125021874656, 3556.199855032649, 3567.0725611341236, 3579.302036102987, 3910.6675932546054, 730.4777084384584, 731.6159016516265, 735.9926400736031, 753.348353674068, 754.8075240813557, 473.37750857622115, 488.16280079663545, 494.6216144649346, 502.0887089931762, 507.4874376879305, 8369.49783013021, 8390.412671112963, 8407.2433480987, 8593.871091933626, 8637.352198585131, 475.67891673120505, 489.81387072912065, 491.4323955831021, 492.92606109083926, 504.5862392837911, 3701.851925922987, 3727.6458736419995, 3743.457198706172, 3775.414810704345, 3865.207632435344, 64681.35318646848, 64772.67613661902, 65297.34702653008, 66711.66644166748, 67398.0, 54076.18885716717, 54230.728846355516, 55597.0, 55965.72017139888, 56243.0, 49260.50739492559, 49437.75281123643, 50057.749711251214, 50625.49374506281, 50763.49236507588, 8698.60856261457, 8931.553422328727, 9075.636974520945, 9139.680111196076, 9140.54078221167, 24195.516089677756, 24291.878540607184, 26245.606315905658, 26379.0, 26676.19971400861, 42518.362224567274, 44070.559294406645, 45644.087118256786, 46249.30626040545, 46684.0, 11546.76906461883, 11683.123765717435, 11743.295402275891, 11805.881941180822, 12046.578369757017, 11634.6509604712, 11695.239809412362, 11879.881201187878, 12126.151169418408, 12482.937585312378, 11974.401279936143, 12076.75846483083, 12236.632901012983, 12659.620211393672, 12665.366731663564, 11819.40902954866, 12152.696182595506, 12232.449539770554, 12422.440990155284, 12680.682982925131, 11411.429428528707, 11583.536658533565, 11723.589674361356, 11902.345371004678, 12065.638030859089, 7671.309582137635, 7955.204479551999, 8540.658373664985, 8540.804795117423, 8647.481151130953, 8385.874211886705, 9947.552360143665, 9976.401415915068, 10113.494325283853, 10146.391216527032], "value": 6229.071075676068, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1572.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 111.0, 112.0, 113.0, 112.0, 113.0, 113.0, 112.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 132.0, 126.0, 171.0, 130.0, 128.0, 127.0, 127.0, 162.0, 132.0], "value": 138.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 168.0, 166.0, 169.0, 172.0, 166.0, 166.0, 164.0, 165.0], "value": 166.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 110.0, 78.0, 77.0, 76.0, 77.0, 95.0, 75.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 103.0, 84.0, 85.0, 86.0, 102.0, 85.0, 84.0, 106.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 114.0, 117.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 151.0, 151.0, 150.0, 150.0, 151.0, 150.0, 153.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 69.0, 70.0, 69.0, 68.0, 69.0, 68.0, 69.0], "value": 68.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 56.0, 55.0, 55.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 85.0, 83.0, 90.0, 83.0, 82.0, 82.0, 83.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 143.0, 142.0, 133.0, 142.0, 141.0, 138.0, 135.0, 185.0, 133.0], "value": 142.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 202.0, 213.0, 196.0, 199.0, 197.0, 200.0, 206.0, 199.0, 197.0], "value": 200.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 73.0, 71.0, 72.0, 79.0, 71.0, 73.0, 72.0], "value": 73.2, "unit": "score"}]}]} 19:28:31 INFO - Return code: 0 19:28:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:28:31 ERROR - # TBPL SUCCESS # 19:28:31 INFO - Running post-action listener: _resource_record_post_action 19:28:31 INFO - [mozharness: 2017-03-24 02:28:31.673953Z] Finished run-tests step (success) 19:28:31 INFO - Running post-run listener: _resource_record_post_run 19:28:31 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 365502464; Read time: 16; Write time: 271340 19:28:31 INFO - TinderboxPrint: CPU usage
13.3% 19:28:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 19:28:31 INFO - TinderboxPrint: I/O write bytes / time
365,502,464 / 271,340 19:28:31 INFO - TinderboxPrint: CPU idle
8,317.3 (86.7%) 19:28:31 INFO - TinderboxPrint: CPU user
1,217.3 (12.7%) 19:28:31 INFO - TinderboxPrint: Swap in / out
0 / 0 19:28:31 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106074112; Read time: 0; Write time: 112376 19:28:31 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 257236992; Read time: 16; Write time: 158652 19:28:32 INFO - Running post-run listener: _upload_blobber_files 19:28:32 INFO - Blob upload gear active. 19:28:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:28:32 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 19:28:32 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', 'Pine', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:28:32 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 Pine -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:28:32 INFO - (blobuploader) - INFO - Open directory for files ... 19:28:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:28:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:28:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:33 INFO - (blobuploader) - INFO - Done attempting. 19:28:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:28:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:28:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:34 INFO - (blobuploader) - INFO - Done attempting. 19:28:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:28:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:28:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:37 INFO - (blobuploader) - INFO - Done attempting. 19:28:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:28:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:28:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:38 INFO - (blobuploader) - INFO - Done attempting. 19:28:38 INFO - (blobuploader) - INFO - Iteration through files over. 19:28:38 INFO - Return code: 0 19:28:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:28:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:28:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/53d700d4b6c9e86d6c6d95d3419c3bdae52ff02f36d2857ef3cb67176f177b7d73ca7fd17a6cf6fd3b3ea90660c8400e17dd008d1ac471a32d142828aff179c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/de87521644774b638846129839e0c139fb0aad25e9da8206c73ea5d4f77c35f50718b810826d1d5902b3b212da8dcf75f59b20fdcdddebcf88d04e158766e2e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/70ff1f1548f2d5c3c59fa7936f2bb87d645b4827488fd935c706aa875f806f274931bebdcc361c2b020cc662de7ce7f6433bbfcdaccf5cd4a54be2b830026cf6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/a5b8174889940516db18e722f20c856adbac28703b3376eca25cf01bdf41fd49f42df5fe2b91221ab01b530a25c887a00b6db41af66c82e6264ed717329625dc"} 19:28:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:28:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:28:38 INFO - Contents: 19:28:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/53d700d4b6c9e86d6c6d95d3419c3bdae52ff02f36d2857ef3cb67176f177b7d73ca7fd17a6cf6fd3b3ea90660c8400e17dd008d1ac471a32d142828aff179c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/de87521644774b638846129839e0c139fb0aad25e9da8206c73ea5d4f77c35f50718b810826d1d5902b3b212da8dcf75f59b20fdcdddebcf88d04e158766e2e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/70ff1f1548f2d5c3c59fa7936f2bb87d645b4827488fd935c706aa875f806f274931bebdcc361c2b020cc662de7ce7f6433bbfcdaccf5cd4a54be2b830026cf6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/a5b8174889940516db18e722f20c856adbac28703b3376eca25cf01bdf41fd49f42df5fe2b91221ab01b530a25c887a00b6db41af66c82e6264ed717329625dc"} 19:28:38 INFO - Running post-run listener: copy_logs_to_upload_dir 19:28:38 INFO - Copying logs to upload dir... 19:28:38 INFO - mkdir: /builds/slave/test/build/upload/logs 19:28:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.899510 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-23 19:28:38.751809) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 19:28:38.755417) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1490321256.551566-107350318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/53d700d4b6c9e86d6c6d95d3419c3bdae52ff02f36d2857ef3cb67176f177b7d73ca7fd17a6cf6fd3b3ea90660c8400e17dd008d1ac471a32d142828aff179c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/de87521644774b638846129839e0c139fb0aad25e9da8206c73ea5d4f77c35f50718b810826d1d5902b3b212da8dcf75f59b20fdcdddebcf88d04e158766e2e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/70ff1f1548f2d5c3c59fa7936f2bb87d645b4827488fd935c706aa875f806f274931bebdcc361c2b020cc662de7ce7f6433bbfcdaccf5cd4a54be2b830026cf6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/a5b8174889940516db18e722f20c856adbac28703b3376eca25cf01bdf41fd49f42df5fe2b91221ab01b530a25c887a00b6db41af66c82e6264ed717329625dc"} build_url:https://queue.taskcluster.net/v1/task/En4_ybPfRAirG61usP7e7w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011191 build_url: 'https://queue.taskcluster.net/v1/task/En4_ybPfRAirG61usP7e7w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/53d700d4b6c9e86d6c6d95d3419c3bdae52ff02f36d2857ef3cb67176f177b7d73ca7fd17a6cf6fd3b3ea90660c8400e17dd008d1ac471a32d142828aff179c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/de87521644774b638846129839e0c139fb0aad25e9da8206c73ea5d4f77c35f50718b810826d1d5902b3b212da8dcf75f59b20fdcdddebcf88d04e158766e2e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/70ff1f1548f2d5c3c59fa7936f2bb87d645b4827488fd935c706aa875f806f274931bebdcc361c2b020cc662de7ce7f6433bbfcdaccf5cd4a54be2b830026cf6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/a5b8174889940516db18e722f20c856adbac28703b3376eca25cf01bdf41fd49f42df5fe2b91221ab01b530a25c887a00b6db41af66c82e6264ed717329625dc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 19:28:38.780093) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 19:28:38.780395) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1490321256.551566-107350318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004297 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 19:28:38.862822) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 19:28:38.863148) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 19:28:38.863434) ========= ========= Total master_lag: 0.21 =========