builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1500199187.46 results: success (0) revision: b4e656e5a996dd385e9af43a4d9e207553377c51 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-16 02:59:47.463519) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-16 02:59:47.464020) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-16 02:59:47.464307) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-16 02:59:47.538608) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:59:47.539027) ========= 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=fa44defc139c4ba8574fe040000001db-1500198110.462652-402112138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-16 02:59:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.1M=0s 2017-07-16 02:59:47 (40.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.178462 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:59:47.749780) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:59:47.750236) ========= 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=fa44defc139c4ba8574fe040000001db-1500198110.462652-402112138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020059 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:59:47.800224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:59:47.800618) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b4e656e5a996dd385e9af43a4d9e207553377c51 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev b4e656e5a996dd385e9af43a4d9e207553377c51 --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=fa44defc139c4ba8574fe040000001db-1500198110.462652-402112138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-16 02:59:47,841 truncating revision to first 12 chars 2017-07-16 02:59:47,841 Setting DEBUG logging. 2017-07-16 02:59:47,841 attempt 1/10 2017-07-16 02:59:47,841 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b4e656e5a996?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-16 02:59:48,439 unpacking tar archive at: mozilla-central-b4e656e5a996/testing/mozharness/ program finished with exit code 0 elapsedTime=0.967985 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:59:48.787461) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-16 02:59:48.787962) ========= script_repo_revision: b4e656e5a996dd385e9af43a4d9e207553377c51 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-16 02:59:48.788423) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-16 02:59:48.788696) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-16 02:59:48.799898) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-07-16 02:59:48.800323) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=fa44defc139c4ba8574fe040000001db-1500198110.462652-402112138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:59:49 INFO - MultiFileLogger online at 20170716 02:59:49 in /builds/slave/test 02:59:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:59:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:59:49 INFO - {'append_to_log': False, 02:59:49 INFO - 'base_work_dir': '/builds/slave/test', 02:59:49 INFO - 'blob_upload_branch': 'Firefox', 02:59:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:59:49 INFO - 'branch': 'Firefox', 02:59:49 INFO - 'buildbot_json_path': 'buildprops.json', 02:59:49 INFO - 'code_coverage': False, 02:59:49 INFO - 'config_files': ('talos/linux_config.py',), 02:59:49 INFO - 'default_actions': ('clobber', 02:59:49 INFO - 'read-buildbot-config', 02:59:49 INFO - 'download-and-extract', 02:59:49 INFO - 'populate-webroot', 02:59:49 INFO - 'create-virtualenv', 02:59:49 INFO - 'install', 02:59:49 INFO - 'setup-mitmproxy', 02:59:49 INFO - 'run-tests'), 02:59:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:59:49 INFO - 'disable_ccov_upload': False, 02:59:49 INFO - 'download_minidump_stackwalk': True, 02:59:49 INFO - 'download_symbols': 'ondemand', 02:59:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:59:49 INFO - 'tooltool.py': '/tools/tooltool.py', 02:59:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:59:49 INFO - '/tools/misc-python/virtualenv.py')}, 02:59:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:59:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:59:49 INFO - 'gecko_profile': False, 02:59:49 INFO - 'gecko_profile_interval': 0, 02:59:49 INFO - 'installer_path': 'installer.exe', 02:59:49 INFO - 'log_level': 'info', 02:59:49 INFO - 'log_name': 'talos', 02:59:49 INFO - 'log_to_console': True, 02:59:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:59:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:59:49 INFO - 'opt_config_files': (), 02:59:49 INFO - 'pip_index': False, 02:59:49 INFO - 'suite': 'dromaeojs-e10s', 02:59:49 INFO - 'system_bits': '32', 02:59:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:59:49 INFO - 'title': 'talos-linux64-ix-048', 02:59:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:59:49 INFO - 'use_talos_json': True, 02:59:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:59:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:59:49 INFO - 'work_dir': 'build'} 02:59:49 INFO - [mozharness: 2017-07-16 09:59:49.024551Z] Running clobber step. 02:59:49 INFO - Running pre-action listener: _resource_record_pre_action 02:59:49 INFO - Running main action method: clobber 02:59:49 INFO - rmtree: /builds/slave/test/build 02:59:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:59:50 INFO - Running post-action listener: _resource_record_post_action 02:59:50 INFO - [mozharness: 2017-07-16 09:59:50.011189Z] Finished clobber step (success) 02:59:50 INFO - [mozharness: 2017-07-16 09:59:50.011295Z] Running read-buildbot-config step. 02:59:50 INFO - Running pre-action listener: _resource_record_pre_action 02:59:50 INFO - Running main action method: read_buildbot_config 02:59:50 INFO - Using buildbot properties: 02:59:50 INFO - { 02:59:50 INFO - "project": "", 02:59:50 INFO - "product": "firefox", 02:59:50 INFO - "who": "archaeopteryx@coole-files.de", 02:59:50 INFO - "installer_path": "public/build/target.tar.bz2", 02:59:50 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 02:59:50 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:59:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 02:59:50 INFO - "stage_platform": "linux64-pgo", 02:59:50 INFO - "basedir": "/builds/slave/test", 02:59:50 INFO - "buildnumber": 64, 02:59:50 INFO - "platform": "ubuntu64_hw", 02:59:50 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:59:50 INFO - "slavebuilddir": "test", 02:59:50 INFO - "taskId": "QhN3rSXQSSSyNeByMhzcuA", 02:59:50 INFO - "branch": "mozilla-central", 02:59:50 INFO - "script_repo_revision": "production", 02:59:50 INFO - "revision": "b4e656e5a996dd385e9af43a4d9e207553377c51", 02:59:50 INFO - "slavename": "talos-linux64-ix-048", 02:59:50 INFO - "repo_path": "mozilla-central" 02:59:50 INFO - } 02:59:50 INFO - Finding installer, test and symbols from parent task. 02:59:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QhN3rSXQSSSyNeByMhzcuA'}, attempt #1 02:59:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QhN3rSXQSSSyNeByMhzcuA'}, attempt #1 02:59:50 INFO - Task dependencies: aur2h2bgQum-Gi7Kq6lexA 02:59:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aur2h2bgQum-Gi7Kq6lexA'}, attempt #1 02:59:51 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aur2h2bgQum-Gi7Kq6lexA/artifacts/public/build/target.tar.bz2 02:59:51 INFO - Set test_url: https://queue.taskcluster.net/v1/task/aur2h2bgQum-Gi7Kq6lexA/artifacts/public/build/test_packages.json 02:59:51 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aur2h2bgQum-Gi7Kq6lexA/artifacts/public/build/target.crashreporter-symbols.zip 02:59:51 INFO - Running post-action listener: _resource_record_post_action 02:59:51 INFO - [mozharness: 2017-07-16 09:59:51.325108Z] Finished read-buildbot-config step (success) 02:59:51 INFO - [mozharness: 2017-07-16 09:59:51.325332Z] Running download-and-extract step. 02:59:51 INFO - Running pre-action listener: _resource_record_pre_action 02:59:51 INFO - Running main action method: download_and_extract 02:59:51 INFO - mkdir: /builds/slave/test/build/tests 02:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 02:59:51 INFO - trying https://queue.taskcluster.net/v1/task/aur2h2bgQum-Gi7Kq6lexA/artifacts/public/build/target.test_packages.json 02:59:51 INFO - Downloading https://queue.taskcluster.net/v1/task/aur2h2bgQum-Gi7Kq6lexA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:59:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aur2h2bgQum-Gi7Kq6lexA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:59:51 INFO - Downloaded 989 bytes. 02:59:51 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:59:51 INFO - Using the following test package requirements: 02:59:51 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:59:51 INFO - u'common': [u'target.common.tests.zip'], 02:59:51 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:59:51 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:59:51 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:59:51 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:59:51 INFO - u'mozbase': [u'target.common.tests.zip'], 02:59:51 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:59:51 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:59:51 INFO - u'web-platform': [u'target.common.tests.zip', 02:59:51 INFO - u'target.web-platform.tests.tar.gz'], 02:59:51 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:59:51 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:59:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aur2h2bgQum-Gi7Kq6lexA/artifacts/public/build/target.common.tests.zip 02:59:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aur2h2bgQum-Gi7Kq6lexA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:59:51 INFO - Fetch https://queue.taskcluster.net/v1/task/aur2h2bgQum-Gi7Kq6lexA/artifacts/public/build/target.common.tests.zip into memory 02:59:53 INFO - Content-Length response header: 73374735 02:59:53 INFO - Bytes received: 73374735 03:00:05 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:00:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aur2h2bgQum-Gi7Kq6lexA/artifacts/public/build/target.common.tests.zip 03:00:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aur2h2bgQum-Gi7Kq6lexA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:00:05 INFO - Fetch https://queue.taskcluster.net/v1/task/aur2h2bgQum-Gi7Kq6lexA/artifacts/public/build/target.common.tests.zip into memory 03:00:06 INFO - Content-Length response header: 73374735 03:00:06 INFO - Bytes received: 73374735 03:00:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aur2h2bgQum-Gi7Kq6lexA/artifacts/public/build/target.talos.tests.zip 03:00:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aur2h2bgQum-Gi7Kq6lexA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:00:19 INFO - Fetch https://queue.taskcluster.net/v1/task/aur2h2bgQum-Gi7Kq6lexA/artifacts/public/build/target.talos.tests.zip into memory 03:00:20 INFO - Content-Length response header: 14495033 03:00:20 INFO - Bytes received: 14495033 03:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:00:20 INFO - trying https://queue.taskcluster.net/v1/task/aur2h2bgQum-Gi7Kq6lexA/artifacts/public/build/target.tar.bz2 03:00:20 INFO - Downloading https://queue.taskcluster.net/v1/task/aur2h2bgQum-Gi7Kq6lexA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:00:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aur2h2bgQum-Gi7Kq6lexA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:00:21 INFO - Downloaded 62794103 bytes. 03:00:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aur2h2bgQum-Gi7Kq6lexA/artifacts/public/build/target.tar.bz2 03:00:21 INFO - mkdir: /builds/slave/test/properties 03:00:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:00:21 INFO - Writing to file /builds/slave/test/properties/build_url 03:00:21 INFO - Contents: 03:00:21 INFO - build_url:https://queue.taskcluster.net/v1/task/aur2h2bgQum-Gi7Kq6lexA/artifacts/public/build/target.tar.bz2 03:00:21 INFO - Running post-action listener: _resource_record_post_action 03:00:21 INFO - Running post-action listener: set_extra_try_arguments 03:00:21 INFO - [mozharness: 2017-07-16 10:00:21.393328Z] Finished download-and-extract step (success) 03:00:21 INFO - [mozharness: 2017-07-16 10:00:21.393435Z] Running populate-webroot step. 03:00:21 INFO - Running pre-action listener: _resource_record_pre_action 03:00:21 INFO - Running main action method: populate_webroot 03:00:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:00:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:00:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:00:21 INFO - '--tppagecycles', 03:00:21 INFO - '7'], 03:00:21 INFO - 'tests': ['tsvgm']}}, 03:00:21 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:00:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:00:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:00:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:00:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:00:21 INFO - 'talos_options': ['--disable-e10s'], 03:00:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:00:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:00:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:00:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:00:21 INFO - 'talos_options': ['--disable-e10s'], 03:00:21 INFO - 'tests': ['damp', 'tps']}, 03:00:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:00:21 INFO - 'tests': ['damp', 'tps']}, 03:00:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:00:21 INFO - 'tests': ['dromaeo_dom']}, 03:00:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:00:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:00:21 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:00:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:00:21 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:00:21 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:00:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:00:21 INFO - 'tests': ['a11yr', 03:00:21 INFO - 'ts_paint', 03:00:21 INFO - 'tpaint', 03:00:21 INFO - 'sessionrestore', 03:00:21 INFO - 'sessionrestore_no_auto_restore', 03:00:21 INFO - 'tabpaint']}, 03:00:21 INFO - 'other-e10s': {'tests': ['a11yr', 03:00:21 INFO - 'ts_paint', 03:00:21 INFO - 'tpaint', 03:00:21 INFO - 'sessionrestore', 03:00:21 INFO - 'sessionrestore_many_windows', 03:00:21 INFO - 'sessionrestore_no_auto_restore', 03:00:21 INFO - 'tabpaint']}, 03:00:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:00:21 INFO - 'ts_paint', 03:00:21 INFO - 'tpaint', 03:00:21 INFO - 'sessionrestore', 03:00:21 INFO - 'sessionrestore_many_windows', 03:00:21 INFO - 'sessionrestore_no_auto_restore', 03:00:21 INFO - 'tabpaint']}, 03:00:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:00:21 INFO - 'ts_paint', 03:00:21 INFO - 'tpaint', 03:00:21 INFO - 'sessionrestore', 03:00:21 INFO - 'sessionrestore_many_windows', 03:00:21 INFO - 'sessionrestore_no_auto_restore', 03:00:21 INFO - 'tabpaint']}, 03:00:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:00:21 INFO - 'tests': ['a11yr', 03:00:21 INFO - 'ts_paint', 03:00:21 INFO - 'tpaint', 03:00:21 INFO - 'sessionrestore', 03:00:21 INFO - 'sessionrestore_no_auto_restore', 03:00:21 INFO - 'tabpaint']}, 03:00:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:00:21 INFO - 'tests': ['a11yr', 03:00:21 INFO - 'ts_paint', 03:00:21 INFO - 'tpaint', 03:00:21 INFO - 'sessionrestore', 03:00:21 INFO - 'sessionrestore_no_auto_restore', 03:00:21 INFO - 'tabpaint']}, 03:00:21 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 03:00:21 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:00:21 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:00:21 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:00:21 INFO - 'talos_options': ['--mitmproxy', 03:00:21 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:00:21 INFO - '--firstNonBlankPaint'], 03:00:21 INFO - 'tests': ['quantum_pageload_google', 03:00:21 INFO - 'quantum_pageload_youtube', 03:00:21 INFO - 'quantum_pageload_amazon', 03:00:21 INFO - 'quantum_pageload_facebook']}, 03:00:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:00:21 INFO - 'tests': ['tsvgx', 03:00:21 INFO - 'tsvgr_opacity', 03:00:21 INFO - 'tart', 03:00:21 INFO - 'tscrollx', 03:00:21 INFO - 'cart', 03:00:21 INFO - 'tsvg_static']}, 03:00:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:00:21 INFO - 'tsvgr_opacity', 03:00:21 INFO - 'tart', 03:00:21 INFO - 'tscrollx', 03:00:21 INFO - 'cart', 03:00:21 INFO - 'tsvg_static']}, 03:00:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:00:21 INFO - 'talos_options': ['--disable-e10s'], 03:00:21 INFO - 'tests': ['tp5o']}, 03:00:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:00:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:00:21 INFO - 'talos_options': ['--disable-e10s', 03:00:21 INFO - '--xperf_path', 03:00:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:00:21 INFO - 'tests': ['tp5n']}, 03:00:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:00:21 INFO - 'talos_options': ['--xperf_path', 03:00:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:00:21 INFO - 'tests': ['tp5n']}}, 03:00:21 INFO - 'talos.zip': {'path': '', 03:00:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:00:21 INFO - Running post-action listener: _resource_record_post_action 03:00:21 INFO - [mozharness: 2017-07-16 10:00:21.408829Z] Finished populate-webroot step (success) 03:00:21 INFO - [mozharness: 2017-07-16 10:00:21.408921Z] Running create-virtualenv step. 03:00:21 INFO - Running pre-action listener: _resource_record_pre_action 03:00:21 INFO - Running main action method: create_virtualenv 03:00:21 INFO - Creating virtualenv /builds/slave/test/build/venv 03:00:21 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 03:00:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:00:21 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:00:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:00:21 INFO - Using real prefix '/usr' 03:00:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:00:22 INFO - Installing distribute.............................................................................................................................................................................................done. 03:00:24 INFO - Installing pip.................done. 03:00:24 INFO - Return code: 0 03:00:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:00:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:00:24 INFO - Reading from file tmpfile_stdout 03:00:24 INFO - Output received: 03:00:24 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) 03:00:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:24 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/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 0xafa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6bb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe68d00>, '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 0xe69c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6a090>, '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': 'fa44defc139c4ba8574fe040000001db-1500198110.462652-402112138', '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 03:00:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:00:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:00:24 INFO - Using env: {'DISPLAY': ':0', 03:00:24 INFO - 'HOME': '/home/cltbld', 03:00:24 INFO - 'LANG': 'en_US.UTF-8', 03:00:24 INFO - 'LANGUAGE': 'en_US:en', 03:00:24 INFO - 'LOGNAME': 'cltbld', 03:00:24 INFO - 'MAIL': '/var/mail/cltbld', 03:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:24 INFO - 'MOZ_NO_REMOTE': '1', 03:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:24 INFO - 'NO_EM_RESTART': '1', 03:00:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:24 INFO - 'PWD': '/builds/slave/test', 03:00:24 INFO - 'SHELL': '/bin/bash', 03:00:24 INFO - 'SHLVL': '1', 03:00:24 INFO - 'TERM': 'linux', 03:00:24 INFO - 'TMOUT': '86400', 03:00:24 INFO - 'USER': 'cltbld', 03:00:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1500198110.462652-402112138', 03:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:24 INFO - '_': '/tools/buildbot/bin/python'} 03:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:24 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 03:00:24 INFO - Cleaning up... 03:00:24 INFO - Return code: 0 03:00:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:24 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/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 0xafa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6bb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe68d00>, '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 0xe69c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6a090>, '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': 'fa44defc139c4ba8574fe040000001db-1500198110.462652-402112138', '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 03:00:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:00:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:00:24 INFO - Using env: {'DISPLAY': ':0', 03:00:24 INFO - 'HOME': '/home/cltbld', 03:00:24 INFO - 'LANG': 'en_US.UTF-8', 03:00:24 INFO - 'LANGUAGE': 'en_US:en', 03:00:24 INFO - 'LOGNAME': 'cltbld', 03:00:24 INFO - 'MAIL': '/var/mail/cltbld', 03:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:24 INFO - 'MOZ_NO_REMOTE': '1', 03:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:24 INFO - 'NO_EM_RESTART': '1', 03:00:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:24 INFO - 'PWD': '/builds/slave/test', 03:00:24 INFO - 'SHELL': '/bin/bash', 03:00:24 INFO - 'SHLVL': '1', 03:00:24 INFO - 'TERM': 'linux', 03:00:24 INFO - 'TMOUT': '86400', 03:00:24 INFO - 'USER': 'cltbld', 03:00:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1500198110.462652-402112138', 03:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:24 INFO - '_': '/tools/buildbot/bin/python'} 03:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:24 INFO - Downloading/unpacking psutil>=3.1.1 03:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:00:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:00:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:00:26 INFO - Installing collected packages: psutil 03:00:26 INFO - Running setup.py install for psutil 03:00:26 INFO - building 'psutil._psutil_linux' extension 03:00:26 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 03:00:27 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 03:00:27 INFO - building 'psutil._psutil_posix' extension 03:00:27 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 03:00:27 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 03:00:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:00:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:00:27 INFO - Successfully installed psutil 03:00:27 INFO - Cleaning up... 03:00:27 INFO - Return code: 0 03:00:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:00:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:27 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/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 0xafa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6bb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe68d00>, '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 0xe69c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6a090>, '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': 'fa44defc139c4ba8574fe040000001db-1500198110.462652-402112138', '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 03:00:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:00:27 INFO - Using env: {'DISPLAY': ':0', 03:00:27 INFO - 'HOME': '/home/cltbld', 03:00:27 INFO - 'LANG': 'en_US.UTF-8', 03:00:27 INFO - 'LANGUAGE': 'en_US:en', 03:00:27 INFO - 'LOGNAME': 'cltbld', 03:00:27 INFO - 'MAIL': '/var/mail/cltbld', 03:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:27 INFO - 'MOZ_NO_REMOTE': '1', 03:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:27 INFO - 'NO_EM_RESTART': '1', 03:00:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:27 INFO - 'PWD': '/builds/slave/test', 03:00:27 INFO - 'SHELL': '/bin/bash', 03:00:27 INFO - 'SHLVL': '1', 03:00:27 INFO - 'TERM': 'linux', 03:00:27 INFO - 'TMOUT': '86400', 03:00:27 INFO - 'USER': 'cltbld', 03:00:27 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1500198110.462652-402112138', 03:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:27 INFO - '_': '/tools/buildbot/bin/python'} 03:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:00:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:00:28 INFO - Installing collected packages: mozsystemmonitor 03:00:28 INFO - Running setup.py install for mozsystemmonitor 03:00:28 INFO - Successfully installed mozsystemmonitor 03:00:28 INFO - Cleaning up... 03:00:28 INFO - Return code: 0 03:00:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:28 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/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 0xafa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6bb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe68d00>, '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 0xe69c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6a090>, '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': 'fa44defc139c4ba8574fe040000001db-1500198110.462652-402112138', '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 03:00:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:00:28 INFO - Using env: {'DISPLAY': ':0', 03:00:28 INFO - 'HOME': '/home/cltbld', 03:00:28 INFO - 'LANG': 'en_US.UTF-8', 03:00:28 INFO - 'LANGUAGE': 'en_US:en', 03:00:28 INFO - 'LOGNAME': 'cltbld', 03:00:28 INFO - 'MAIL': '/var/mail/cltbld', 03:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:28 INFO - 'MOZ_NO_REMOTE': '1', 03:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:28 INFO - 'NO_EM_RESTART': '1', 03:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:28 INFO - 'PWD': '/builds/slave/test', 03:00:28 INFO - 'SHELL': '/bin/bash', 03:00:28 INFO - 'SHLVL': '1', 03:00:28 INFO - 'TERM': 'linux', 03:00:29 INFO - 'TMOUT': '86400', 03:00:29 INFO - 'USER': 'cltbld', 03:00:29 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1500198110.462652-402112138', 03:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:29 INFO - '_': '/tools/buildbot/bin/python'} 03:00:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:29 INFO - Downloading/unpacking jsonschema==2.5.1 03:00:29 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 03:00:29 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 03:00:29 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 03:00:29 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 03:00:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:00:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:00:30 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 03:00:30 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 03:00:30 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 03:00:30 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 03:00:30 INFO - Downloading functools32-3.2.3-2.tar.gz 03:00:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:00:30 INFO - warning: no files found matching '*.txt' 03:00:30 INFO - no previously-included directories found matching 'build' 03:00:30 INFO - no previously-included directories found matching 'dist' 03:00:30 INFO - no previously-included directories found matching '.git*' 03:00:30 INFO - Installing collected packages: jsonschema, functools32 03:00:30 INFO - Running setup.py install for functools32 03:00:30 INFO - warning: no files found matching '*.txt' 03:00:30 INFO - no previously-included directories found matching 'build' 03:00:30 INFO - no previously-included directories found matching 'dist' 03:00:30 INFO - no previously-included directories found matching '.git*' 03:00:30 INFO - Successfully installed jsonschema functools32 03:00:30 INFO - Cleaning up... 03:00:30 INFO - Return code: 0 03:00:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xafa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6bb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe68d00>, '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 0xe69c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6a090>, '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': 'fa44defc139c4ba8574fe040000001db-1500198110.462652-402112138', '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 03:00:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:00:30 INFO - Using env: {'DISPLAY': ':0', 03:00:30 INFO - 'HOME': '/home/cltbld', 03:00:30 INFO - 'LANG': 'en_US.UTF-8', 03:00:30 INFO - 'LANGUAGE': 'en_US:en', 03:00:30 INFO - 'LOGNAME': 'cltbld', 03:00:30 INFO - 'MAIL': '/var/mail/cltbld', 03:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:30 INFO - 'MOZ_NO_REMOTE': '1', 03:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:30 INFO - 'NO_EM_RESTART': '1', 03:00:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:30 INFO - 'PWD': '/builds/slave/test', 03:00:30 INFO - 'SHELL': '/bin/bash', 03:00:30 INFO - 'SHLVL': '1', 03:00:30 INFO - 'TERM': 'linux', 03:00:30 INFO - 'TMOUT': '86400', 03:00:30 INFO - 'USER': 'cltbld', 03:00:30 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1500198110.462652-402112138', 03:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:30 INFO - '_': '/tools/buildbot/bin/python'} 03:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:00:30 INFO - Cleaning up... 03:00:30 INFO - Return code: 0 03:00:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xafa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6bb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe68d00>, '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 0xe69c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6a090>, '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': 'fa44defc139c4ba8574fe040000001db-1500198110.462652-402112138', '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 03:00:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:00:30 INFO - Using env: {'DISPLAY': ':0', 03:00:30 INFO - 'HOME': '/home/cltbld', 03:00:30 INFO - 'LANG': 'en_US.UTF-8', 03:00:30 INFO - 'LANGUAGE': 'en_US:en', 03:00:30 INFO - 'LOGNAME': 'cltbld', 03:00:30 INFO - 'MAIL': '/var/mail/cltbld', 03:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:30 INFO - 'MOZ_NO_REMOTE': '1', 03:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:30 INFO - 'NO_EM_RESTART': '1', 03:00:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:30 INFO - 'PWD': '/builds/slave/test', 03:00:30 INFO - 'SHELL': '/bin/bash', 03:00:30 INFO - 'SHLVL': '1', 03:00:30 INFO - 'TERM': 'linux', 03:00:30 INFO - 'TMOUT': '86400', 03:00:30 INFO - 'USER': 'cltbld', 03:00:30 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1500198110.462652-402112138', 03:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:30 INFO - '_': '/tools/buildbot/bin/python'} 03:00:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:31 INFO - Downloading/unpacking blobuploader==1.2.4 03:00:31 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 03:00:31 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 03:00:31 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 03:00:31 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 03:00:32 INFO - Downloading blobuploader-1.2.4.tar.gz 03:00:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:00:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:00:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:32 INFO - Downloading docopt-0.6.1.tar.gz 03:00:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:00:32 INFO - Installing collected packages: blobuploader, requests, docopt 03:00:32 INFO - Running setup.py install for blobuploader 03:00:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:00:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:00:32 INFO - Running setup.py install for requests 03:00:33 INFO - Running setup.py install for docopt 03:00:33 INFO - Successfully installed blobuploader requests docopt 03:00:33 INFO - Cleaning up... 03:00:33 INFO - Return code: 0 03:00:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:33 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/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 0xafa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6bb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe68d00>, '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 0xe69c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6a090>, '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': 'fa44defc139c4ba8574fe040000001db-1500198110.462652-402112138', '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 03:00:33 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:00:33 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:00:33 INFO - Using env: {'DISPLAY': ':0', 03:00:33 INFO - 'HOME': '/home/cltbld', 03:00:33 INFO - 'LANG': 'en_US.UTF-8', 03:00:33 INFO - 'LANGUAGE': 'en_US:en', 03:00:33 INFO - 'LOGNAME': 'cltbld', 03:00:33 INFO - 'MAIL': '/var/mail/cltbld', 03:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:33 INFO - 'MOZ_NO_REMOTE': '1', 03:00:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:33 INFO - 'NO_EM_RESTART': '1', 03:00:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:33 INFO - 'PWD': '/builds/slave/test', 03:00:33 INFO - 'SHELL': '/bin/bash', 03:00:33 INFO - 'SHLVL': '1', 03:00:33 INFO - 'TERM': 'linux', 03:00:33 INFO - 'TMOUT': '86400', 03:00:33 INFO - 'USER': 'cltbld', 03:00:33 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1500198110.462652-402112138', 03:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:33 INFO - '_': '/tools/buildbot/bin/python'} 03:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:33 INFO - Running setup.py (path:/tmp/pip-7oxxtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:33 INFO - Running setup.py (path:/tmp/pip-u4M1qT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:33 INFO - Running setup.py (path:/tmp/pip-HXd9rP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:33 INFO - Running setup.py (path:/tmp/pip-NatxtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:33 INFO - Running setup.py (path:/tmp/pip-HKjsi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:33 INFO - Running setup.py (path:/tmp/pip-ppsvYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:34 INFO - Running setup.py (path:/tmp/pip-7weJGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:34 INFO - Running setup.py (path:/tmp/pip-OGt2jz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:34 INFO - Running setup.py (path:/tmp/pip-OF0JeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:34 INFO - Running setup.py (path:/tmp/pip-1ICFuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:34 INFO - Running setup.py (path:/tmp/pip-Za295i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:34 INFO - Running setup.py (path:/tmp/pip-Dm_RSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:34 INFO - Running setup.py (path:/tmp/pip-0Cp69N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:34 INFO - Running setup.py (path:/tmp/pip-tREtaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:34 INFO - Running setup.py (path:/tmp/pip-m64ABq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:34 INFO - Running setup.py (path:/tmp/pip-nCw7g2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:34 INFO - Running setup.py (path:/tmp/pip-SMM4_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:00:34 INFO - Running setup.py install for manifestparser 03:00:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:00:34 INFO - Running setup.py install for mozcrash 03:00:35 INFO - Running setup.py install for mozdebug 03:00:35 INFO - Running setup.py install for mozdevice 03:00:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:00:35 INFO - Running setup.py install for mozfile 03:00:35 INFO - Running setup.py install for mozhttpd 03:00:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:00:35 INFO - Running setup.py install for mozinfo 03:00:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:00:35 INFO - Running setup.py install for mozInstall 03:00:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:00:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:00:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:00:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:00:35 INFO - Running setup.py install for mozleak 03:00:35 INFO - Running setup.py install for mozlog 03:00:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:00:35 INFO - Running setup.py install for moznetwork 03:00:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:00:35 INFO - Running setup.py install for mozprocess 03:00:36 INFO - Running setup.py install for mozprofile 03:00:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:00:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:00:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:00:36 INFO - Running setup.py install for mozrunner 03:00:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:00:36 INFO - Running setup.py install for mozscreenshot 03:00:36 INFO - Running setup.py install for moztest 03:00:36 INFO - Running setup.py install for mozversion 03:00:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:00:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:00:36 INFO - Cleaning up... 03:00:36 INFO - Return code: 0 03:00:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:36 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/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 0xafa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6bb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe68d00>, '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 0xe69c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6a090>, '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': 'fa44defc139c4ba8574fe040000001db-1500198110.462652-402112138', '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 03:00:36 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:00:36 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:00:36 INFO - Using env: {'DISPLAY': ':0', 03:00:36 INFO - 'HOME': '/home/cltbld', 03:00:36 INFO - 'LANG': 'en_US.UTF-8', 03:00:36 INFO - 'LANGUAGE': 'en_US:en', 03:00:36 INFO - 'LOGNAME': 'cltbld', 03:00:36 INFO - 'MAIL': '/var/mail/cltbld', 03:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:36 INFO - 'MOZ_NO_REMOTE': '1', 03:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:36 INFO - 'NO_EM_RESTART': '1', 03:00:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:36 INFO - 'PWD': '/builds/slave/test', 03:00:36 INFO - 'SHELL': '/bin/bash', 03:00:36 INFO - 'SHLVL': '1', 03:00:36 INFO - 'TERM': 'linux', 03:00:36 INFO - 'TMOUT': '86400', 03:00:36 INFO - 'USER': 'cltbld', 03:00:36 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1500198110.462652-402112138', 03:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:36 INFO - '_': '/tools/buildbot/bin/python'} 03:00:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:36 INFO - Running setup.py (path:/tmp/pip-b3GmDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:36 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)) 03:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:36 INFO - Running setup.py (path:/tmp/pip-88zx6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:36 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)) 03:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:36 INFO - Running setup.py (path:/tmp/pip-I3owUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:37 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)) 03:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:37 INFO - Running setup.py (path:/tmp/pip-WQLXuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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)) 03:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:37 INFO - Running setup.py (path:/tmp/pip-m0BOvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:37 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)) 03:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:37 INFO - Running setup.py (path:/tmp/pip-10gkYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:37 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)) 03:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:37 INFO - Running setup.py (path:/tmp/pip-DMtRwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 03:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:37 INFO - Running setup.py (path:/tmp/pip-jahwtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 03:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:37 INFO - Running setup.py (path:/tmp/pip-phSs02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:37 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)) 03:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:37 INFO - Running setup.py (path:/tmp/pip-_meZDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 03:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:37 INFO - Running setup.py (path:/tmp/pip-UZc9Bb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00:37 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)) 03:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:37 INFO - Running setup.py (path:/tmp/pip-guO7bE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:37 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)) 03:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:37 INFO - Running setup.py (path:/tmp/pip-fjcxah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:37 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)) 03:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:37 INFO - Running setup.py (path:/tmp/pip-zn3fL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:37 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)) 03:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:37 INFO - Running setup.py (path:/tmp/pip-Wr4fu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:37 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)) 03:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:37 INFO - Running setup.py (path:/tmp/pip-XfqN0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:37 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)) 03:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:37 INFO - Running setup.py (path:/tmp/pip-b2repg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:38 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)) 03:00:38 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)) 03:00:38 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)) 03:00:38 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)) 03:00:38 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:00:38 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:00:38 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:00:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:00:38 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 03:00:38 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 03:00:38 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 03:00:38 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 03:00:39 INFO - Downloading blessings-1.6.tar.gz 03:00:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:00:39 INFO - Installing collected packages: blessings 03:00:39 INFO - Running setup.py install for blessings 03:00:39 INFO - Successfully installed blessings 03:00:39 INFO - Cleaning up... 03:00:39 INFO - Return code: 0 03:00:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:00:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:39 INFO - Reading from file tmpfile_stdout 03:00:39 INFO - Current package versions: 03:00:39 INFO - argparse == 1.2.1 03:00:39 INFO - blessings == 1.6 03:00:39 INFO - blobuploader == 1.2.4 03:00:39 INFO - docopt == 0.6.1 03:00:39 INFO - functools32 == 3.2.3-2 03:00:39 INFO - jsonschema == 2.5.1 03:00:39 INFO - manifestparser == 1.1 03:00:39 INFO - mozInstall == 1.13 03:00:39 INFO - mozcrash == 1.0 03:00:39 INFO - mozdebug == 0.1 03:00:39 INFO - mozdevice == 0.51 03:00:39 INFO - mozfile == 1.2 03:00:39 INFO - mozhttpd == 0.7 03:00:39 INFO - mozinfo == 0.10 03:00:39 INFO - mozleak == 0.1 03:00:39 INFO - mozlog == 3.5 03:00:39 INFO - moznetwork == 0.27 03:00:39 INFO - mozprocess == 0.25 03:00:39 INFO - mozprofile == 0.28 03:00:39 INFO - mozrunner == 6.13 03:00:39 INFO - mozscreenshot == 0.1 03:00:39 INFO - mozsystemmonitor == 0.3 03:00:39 INFO - moztest == 0.8 03:00:39 INFO - mozversion == 1.4 03:00:39 INFO - psutil == 3.1.1 03:00:39 INFO - requests == 1.2.3 03:00:39 INFO - wsgiref == 0.1.2 03:00:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:39 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/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 0xafa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6bb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe68d00>, '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 0xe69c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6a090>, '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': 'fa44defc139c4ba8574fe040000001db-1500198110.462652-402112138', '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 03:00:39 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:00:39 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:00:39 INFO - Using env: {'DISPLAY': ':0', 03:00:39 INFO - 'HOME': '/home/cltbld', 03:00:39 INFO - 'LANG': 'en_US.UTF-8', 03:00:39 INFO - 'LANGUAGE': 'en_US:en', 03:00:39 INFO - 'LOGNAME': 'cltbld', 03:00:39 INFO - 'MAIL': '/var/mail/cltbld', 03:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:39 INFO - 'MOZ_NO_REMOTE': '1', 03:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:39 INFO - 'NO_EM_RESTART': '1', 03:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:39 INFO - 'PWD': '/builds/slave/test', 03:00:39 INFO - 'SHELL': '/bin/bash', 03:00:39 INFO - 'SHLVL': '1', 03:00:39 INFO - 'TERM': 'linux', 03:00:39 INFO - 'TMOUT': '86400', 03:00:39 INFO - 'USER': 'cltbld', 03:00:39 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1500198110.462652-402112138', 03:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:39 INFO - '_': '/tools/buildbot/bin/python'} 03:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:39 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)) 03:00:39 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)) 03:00:39 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)) 03:00:39 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)) 03:00:39 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)) 03:00:39 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)) 03:00:39 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)) 03:00:39 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)) 03:00:39 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)) 03:00:39 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:00:39 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 03:00:39 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 03:00:39 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 03:00:39 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 03:00:40 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:00:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:00:41 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 03:00:41 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 03:00:41 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 03:00:41 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 03:00:41 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 03:00:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:00:41 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)) 03:00:41 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)) 03:00:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:00:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:00:41 INFO - Installing collected packages: marionette-driver, simplejson 03:00:41 INFO - Running setup.py install for marionette-driver 03:00:41 INFO - Running setup.py install for simplejson 03:00:41 INFO - building 'simplejson._speedups' extension 03:00:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:00:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:00:42 INFO - Successfully installed marionette-driver simplejson 03:00:42 INFO - Cleaning up... 03:00:42 INFO - Return code: 0 03:00:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:42 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/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 0xafa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6bb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe68d00>, '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 0xe69c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6a090>, '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': 'fa44defc139c4ba8574fe040000001db-1500198110.462652-402112138', '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 03:00:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:00:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:00:42 INFO - Using env: {'DISPLAY': ':0', 03:00:42 INFO - 'HOME': '/home/cltbld', 03:00:42 INFO - 'LANG': 'en_US.UTF-8', 03:00:42 INFO - 'LANGUAGE': 'en_US:en', 03:00:42 INFO - 'LOGNAME': 'cltbld', 03:00:42 INFO - 'MAIL': '/var/mail/cltbld', 03:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:42 INFO - 'MOZ_NO_REMOTE': '1', 03:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:42 INFO - 'NO_EM_RESTART': '1', 03:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:42 INFO - 'PWD': '/builds/slave/test', 03:00:42 INFO - 'SHELL': '/bin/bash', 03:00:42 INFO - 'SHLVL': '1', 03:00:42 INFO - 'TERM': 'linux', 03:00:42 INFO - 'TMOUT': '86400', 03:00:42 INFO - 'USER': 'cltbld', 03:00:42 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1500198110.462652-402112138', 03:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:42 INFO - '_': '/tools/buildbot/bin/python'} 03:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:00:42 INFO - Cleaning up... 03:00:42 INFO - Return code: 0 03:00:42 INFO - Running post-action listener: _resource_record_post_action 03:00:42 INFO - Running post-action listener: _start_resource_monitoring 03:00:42 INFO - Starting resource monitoring. 03:00:42 INFO - [mozharness: 2017-07-16 10:00:42.704852Z] Finished create-virtualenv step (success) 03:00:42 INFO - [mozharness: 2017-07-16 10:00:42.705916Z] Running install step. 03:00:42 INFO - Running pre-action listener: _resource_record_pre_action 03:00:42 INFO - Running main action method: install 03:00:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:42 INFO - Reading from file tmpfile_stdout 03:00:42 INFO - Detecting whether we're running mozinstall >=1.0... 03:00:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:00:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:00:43 INFO - Reading from file tmpfile_stdout 03:00:43 INFO - Output received: 03:00:43 INFO - Usage: mozinstall [options] installer 03:00:43 INFO - Options: 03:00:43 INFO - -h, --help show this help message and exit 03:00:43 INFO - -d DEST, --destination=DEST 03:00:43 INFO - Directory to install application into. [default: 03:00:43 INFO - "/builds/slave/test"] 03:00:43 INFO - --app=APP Application being installed. [default: firefox] 03:00:43 INFO - mkdir: /builds/slave/test/build/application 03:00:43 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'] 03:00:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:01:00 INFO - Reading from file tmpfile_stdout 03:01:00 INFO - Output received: 03:01:00 INFO - /builds/slave/test/build/application/firefox/firefox 03:01:00 INFO - Running post-action listener: _resource_record_post_action 03:01:00 INFO - [mozharness: 2017-07-16 10:01:00.803342Z] Finished install step (success) 03:01:00 INFO - [mozharness: 2017-07-16 10:01:00.803602Z] Running setup-mitmproxy step. 03:01:00 INFO - Running pre-action listener: _resource_record_pre_action 03:01:00 INFO - Running main action method: setup_mitmproxy 03:01:00 INFO - Skipping: mitmproxy is not required 03:01:00 INFO - Running post-action listener: _resource_record_post_action 03:01:00 INFO - [mozharness: 2017-07-16 10:01:00.804752Z] Finished setup-mitmproxy step (success) 03:01:00 INFO - [mozharness: 2017-07-16 10:01:00.804993Z] Running run-tests step. 03:01:00 INFO - Running pre-action listener: _resource_record_pre_action 03:01:00 INFO - Running pre-action listener: _set_gcov_prefix 03:01:00 INFO - Running main action method: run_tests 03:01:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:01:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:01:00 INFO - Python 2.7.3 03:01:00 INFO - Return code: 0 03:01:00 INFO - grabbing minidump binary from tooltool 03:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:01:00 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 0xe68d00>, '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 0xe69c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6a090>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:01:00 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 03:01:00 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 03:01:00 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 03:01:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:01:00 INFO - Return code: 0 03:01:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:01:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:01:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:01:00 INFO - ENV: RUST_BACKTRACE is now 1 03:01:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:01:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:01:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aur2h2bgQum-Gi7Kq6lexA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 03:01:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aur2h2bgQum-Gi7Kq6lexA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 03:01:00 INFO - Using env: {'DISPLAY': ':0', 03:01:00 INFO - 'HOME': '/home/cltbld', 03:01:00 INFO - 'LANG': 'en_US.UTF-8', 03:01:00 INFO - 'LANGUAGE': 'en_US:en', 03:01:00 INFO - 'LOGNAME': 'cltbld', 03:01:00 INFO - 'MAIL': '/var/mail/cltbld', 03:01:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:01:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:00 INFO - 'MOZ_NO_REMOTE': '1', 03:01:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:01:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:00 INFO - 'NO_EM_RESTART': '1', 03:01:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:00 INFO - 'PWD': '/builds/slave/test', 03:01:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:01:00 INFO - 'RUST_BACKTRACE': '1', 03:01:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:01:00 INFO - 'SHELL': '/bin/bash', 03:01:00 INFO - 'SHLVL': '1', 03:01:00 INFO - 'TERM': 'linux', 03:01:00 INFO - 'TMOUT': '86400', 03:01:00 INFO - 'USER': 'cltbld', 03:01:00 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1500198110.462652-402112138', 03:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:00 INFO - '_': '/tools/buildbot/bin/python'} 03:01:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aur2h2bgQum-Gi7Kq6lexA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 03:01:01 INFO - mozversion application_buildid: 20170716085807 03:01:01 INFO - mozversion application_changeset: b4e656e5a996dd385e9af43a4d9e207553377c51 03:01:01 INFO - mozversion application_display_name: Nightly 03:01:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:01:01 INFO - mozversion application_name: Firefox 03:01:01 INFO - mozversion application_remotingname: firefox 03:01:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:01:01 INFO - mozversion application_vendor: Mozilla 03:01:01 INFO - mozversion application_version: 56.0a1 03:01:01 INFO - mozversion platform_buildid: 20170716085807 03:01:01 INFO - mozversion platform_changeset: b4e656e5a996dd385e9af43a4d9e207553377c51 03:01:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:01:01 INFO - mozversion platform_version: 56.0a1 03:01:01 INFO - using testdate: 1500199261 03:01:01 INFO - actual date: 1500199261 03:01:01 INFO - starting webserver on 'localhost:60881' 03:01:01 INFO - SUITE-START | Running 2 tests 03:01:01 INFO - TEST-START | dromaeo_css 03:01:01 INFO - Initialising browser for dromaeo_css test... 03:01:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60881/getInfo.html -profile /tmp/tmpC6q2WJ/profile 03:01:01 INFO - TEST-INFO | started process 3317 (/builds/slave/test/build/application/firefox/firefox http://localhost:60881/getInfo.html) 03:01:09 INFO - TEST-INFO | 3317: exit 0 03:01:10 INFO - Browser initialized. 03:01:10 INFO - Running cycle 1/1 for dromaeo_css test... 03:01:10 INFO - TEST-INFO | started process 3524 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC6q2WJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:01:22 INFO - PID 3524 | RSS: Main: 164560896 03:01:22 INFO - PID 3524 | 03:04:19 INFO - PID 3524 | Cycle 1(1): loaded http://localhost:60881/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60881/tests/dromaeo/cssquery-ext.html) 03:04:21 INFO - PID 3524 | RSS: Main: 169984000 03:04:21 INFO - PID 3524 | 03:07:22 INFO - PID 3524 | Cycle 1(1): loaded http://localhost:60881/tests/dromaeo/cssquery-ext.html (next: http://localhost:60881/tests/dromaeo/cssquery-jquery.html) 03:07:23 INFO - PID 3524 | RSS: Main: 167612416 03:07:23 INFO - PID 3524 | 03:10:24 INFO - PID 3524 | Cycle 1(1): loaded http://localhost:60881/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60881/tests/dromaeo/cssquery-mootools.html) 03:10:25 INFO - PID 3524 | RSS: Main: 169996288 03:10:25 INFO - PID 3524 | 03:13:26 INFO - PID 3524 | Cycle 1(1): loaded http://localhost:60881/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60881/tests/dromaeo/cssquery-prototype.html) 03:13:27 INFO - PID 3524 | RSS: Main: 169193472 03:13:27 INFO - PID 3524 | 03:16:30 INFO - PID 3524 | Cycle 1(1): loaded http://localhost:60881/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60881/tests/dromaeo/cssquery-yui.html) 03:16:31 INFO - PID 3524 | RSS: Main: 168628224 03:16:31 INFO - PID 3524 | 03:19:32 INFO - PID 3524 | Cycle 1(1): loaded http://localhost:60881/tests/dromaeo/cssquery-yui.html (next: http://localhost:60881/tests/dromaeo/cssquery-dojo.html) 03:19:32 INFO - PID 3524 | RSS: Main: 172154880 03:19:32 INFO - PID 3524 | 03:19:32 INFO - PID 3524 | __start_tp_report 03:19:32 INFO - PID 3524 | _x_x_mozilla_page_load 03:19:32 INFO - PID 3524 | _x_x_mozilla_page_load_details 03:19:32 INFO - PID 3524 | |i|pagename|runs| 03:19:32 INFO - PID 3524 | |0;dojo.html;3352.916177095574;3401.897943061709;3417.3677869594126;3426.725861931046;3438.6045604755445;6245.562810603254;6276.435120839124;6300.401461861127;6339.683015849207;6373;6119.3268740438625;6130.662813545253;6195.876082478348;6201.968990155043;6224.595401298924;5456.781728730846;5457.099578569531;5490.56075513958;5496.1755736639425;5511.063119269714;5462.781488740446;5551.1118221084635;5555.694436805974;5563.109902415615;5566;5552.3892371839065;5553.416891226424;5553.972230138864;5556.722163891789;5557.3331200256025;5519.99999999998;5522.502974732293;5523.116301391758;5526.281583394133;5538.363088244843;5322;5446.700431476267;5468.425815289377;5507;5547.25112109868;6177.66022868742;6193.907091393633;6209.223847019122;6259.71831267594;6260.749570017194;6595.97762346837;6693.799186024427;6717.664116794141;6789.18529776425;6808.863822723518;6774.390304872585;6782.898256526156;6806.123920383053;6810.62541560214;6840.897386539206;6222.066689996536;6234.9999999999545;6240.469560087398;6310.5267104967315;6341.682915854189;6942.757003504853;6949.722011119599;6998.93001069993;7042.119735033121;7044.330788575179;6532.08550802888;6620.569662971891;6634.203895532471;6686;6704.430123439464;6652;6652.966735166293;6665.133532640726;6686.632235227109;6695.163104611924;6563.507736919654;6569.638669873108;6601.735930562723;6615.106960560359;6644.700988455531;5775.826725198251;6756.324367563303;6760.087388202628;6842.794716158523;6844.965775171092;5090.592752579785;5144.15121504955;5148.510891465305;5160.7419629018395;5163.715995620202;4508.143452743968;4544.818207271672;4562.7262364257585;4590.908181836411;4592.908141837144;6265.686715664198;6315.684215789192;6363.809085727436;6414.711337989802;6431.356864313531;6797.456203503708;6808.2510923798345;6809.761658341934;6823.283555226729;6872.965635171792;6418.326075762071;6432.228132624022;6434.549581529248;6437.581557198767;6462.224533055969;5607.971960140173;5682.374938756733;5778.739956701958;5827.184194212814;5852.151438041546;6994.33553812387;7016.789496315118;7025.578465292099;7026.578405295699;7042.436605071582;6689.799306020827;6691.631960242234;6696;6705.195376554844;6707.731690732414;6911.481638877205;7059.011738356737;7098.077249957472;7134.072570565793;7153.320434558708;6650.700718467584;6678.666066696548;6721.1598550181225;6726.293739157318;6752.561083529555;6665.733370665119;6709.664516774044;6730.8653826924165;6780.830479238059;6853.9314606853295;5557.972210138923;6494.155759751202;6500.544961852814;6553.377429144223;6561.835954101186;6524.9021264682015;6551.901721474086;6590.8352291193105;6603.372679595431;6614;6529.347065293433;6542.34576542361;6614.933850661624;6617.735290588323;6623.900641490478;6549.8690026200165;6601.438877695449;6608;6637.601743895381;6666.466682665472;6390.648514331757;6419.2296924369375;6424.196975378078;6426.967865160645;6428.100065990859 03:19:32 INFO - PID 3524 | |1;ext.html;806.6410447350928;848.0883050720477;875.8948926128866;908.6229214875825;920.0155833258416;41902.16195676084;42500;42522;42693.573064269345;42697.14605707884;39385.60614393855;39769.80115099427;40158;40216.396754048714;40244.39633405501;6572.769953051644;6654.633995130266;6664.033715111306;6701.396874281314;6709.060731497594;6581;6685.064091027236;6704.93295067048;6720.59676419414;6722.630255335955;6561.311062338457;6651.600903945755;6658.600483970978;6685.465162786965;6690.866182676344;6641.601503909781;6677.332266773333;6681.098051762999;6684;6710.630915299656;5977.462028417463;6021.187139736124;6025.427584379477;6030.849228769272;6043.153958445821;34440.48339274913;34645.6535434645;34689.826550867336;34792.30415391678;34962.650373496195;3226.1611980884904;3272.9509057364157;3292.160499072745;3433.759636825423;3443.2941247044296;32349.51475727866;33062;33313.50029749556;33328;33346;4856.757162141914;4863.80544778212;4883.975580122112;4921.261810728383;4965.354503914468;203801;204594;205490.9725451378;211569;211936;54343.72828135834;54769.452305476436;55019.449805501434;55106.17340739892;55119.448805512235;56851;57103.42896571064;57443;57753.71123144357;57763.711181443825;16194.190290485429;16265.186740662919;16277.755833662504;16278.348866045462;16284.185790710417;13328.133671311334;13505.189688618715;13551.051426400254;13556.254406007763;13567;15345.232738363036;15362.615934601725;15571.221438928234;15602.453914112952;15809.604759880865;6049.848753781191;6180.783672571439;6246.6876656167005;6248.094026366151;6300.054991751183;1063.4310643805682;1094.6114129484079;1095.9616413425492;1098.1379617000616;1107.3355986408092;24718.382040448774;24971.50056998886;25023.249302520955;25026.749732502805;25156.24531264065;1176.4235524592889;1180.1267062373954;1182.2020136407891;1192.9940350298193;1208.2448469706433;13122.671933201746;13243.801342979863;13372.398242079129;13380.732385352434;13528.93235533816;271977;272765;272937;274783;274798;57742.71128644414;57891.71054144702;58297.70851145802;58479.70760146172;58533.41466585365;1480.2820631993475;1510.358097808427;1515.6968606278788;1522.3073501556764;1537.2237020304674;24327.27018189457;30003.249918752204;30129.849350753982;30693.693063069084;30879.2280192997;57566.424335756106;58178.7091064542;58232.4176758227;58271.70864145652;58293.70853145707;247205;248747;250345;251229;252858;34831.47752783659;35089.824550877085;35107.29785404329;35331.293374131856;38136.809315953244;45009.32486012647;46423;46980.82547936329;47054.76472617615;47349.763251183525;33150.5027424584;34082.65917340795;34214;34296.14259643529;34401.82799086089;33302.333953321286;35671.64328356787;36181.457278140326;36308.455373168894;36816.81591592025;41927.16145677008;43030.56969430391;43062;43564;43641.12717745564;33910;34596.48105278473;35884.641153589175;36091.81954090213;36249;25530.872345638152;26729;26931;26953.191404257905;27170.72829271682 03:19:32 INFO - PID 3524 | |2;jquery.html;568.4741614007042;568.5565259097903;573.4638113364005;592.2330581896445;598.8323269484544;22482.43793905153;23605.527889442244;23867.045318187273;23874.40313992151;23901.64147537784;23614;24290;24407.51184976304;24539.14113006041;24754.75245247547;6324.873502529947;6408.967955160218;6455.741770329181;6461.935380646204;6471.255805582371;6309.242890853081;6368.586041907284;6368.9681551592175;6372.203474565679;6399.584027038228;5771.105478650816;5954.791582294621;6309.116723658692;6340.968295158517;6345.397187267202;6275.68621568922;6280.937190628104;6299.244090709144;6322;6322.083297921821;5812.854678633025;5860;5880.470757631833;5888.057910734305;5902.321233058167;30036.399272014656;31044;31382.372352552822;31450.685493145003;31560.36879262402;2173.3914503938922;2229.2866282789514;2230.3643461613524;2241.0251540579898;2256.8194544436406;18837.811621883742;19356.32252871143;19365.80634193668;19376.612467750707;19402;2322.7212734471805;2383.13015749252;2404.446977195237;2428.805695544352;2442.8778561071877;153008;154209;155908;157650;158589.207053964;14996.775048374284;15767.29047192879;15935.123568203628;16055.598610034842;16170.27233774483;24227.878860605586;24260.272191834272;24373.26880193597;24416.755832441802;24427;10090.09189172978;10140.239482038876;10195.490225488697;10204.948975255225;10257.230707696952;8947.731568052968;8981.371304008788;8983.011868694439;8994.460332380078;9068.093190680878;9199.632014719336;9506.572204250826;9560.474173920502;9653.855192172123;9845.458499782437;2725.4004119093765;2757.9172624821285;2779.70743604221;2808.1014075495646;2835.7306055924655;1021.279997601689;1036.08306648615;1043.8225501664583;1056.9471526423647;1059.2691043180334;21148;21202.469938251666;21355.46611334729;21598;21934.232301869357;1071.116329028539;1095.2880627592128;1095.6932059023486;1096.091698396076;1113.5156207049959;11616.303021818718;11644.88355116455;11723.648290551297;11841.171118021655;11868.762624747456;598040;601339;622968;626304;627639;123371;129454;129824;130270;132218;1096.9122470202524;1102.873169585492;1113.7494063835572;1121.4560937945091;1128.2891778179694;18131.728024079912;18961.620767584845;19055.90472047631;19273.903630481756;19401.70897436568;61828.690856547226;62491;63306;63538.36461635325;65186.348136519926;80102;81536.59231703804;82224.58887705523;82467.17532824836;82531.5873420629;14117.223552704289;14214.28928553589;14314.355853986388;14948.551543453714;15040.473583424966;23644.645330319716;23761.811909404805;23997.760022399554;24323.148689795773;24471.143509977064;19017.33439329617;19308;19604.01979901028;19663.70504442406;19666.311679091163;16435.83564164343;16629.91685041567;17058.31766729317;17201.311947521957;17797.377091801725;17586.472405827844;17600.647987040444;17611.647767044844;17627.942323460633;19744.21023159115;14765.926170369079;14782.113073215642;14793.186374749492;14798.6300342488;14812.037217580822;16752.246148923572;17279.56801079933;18568.721469177704;18654.626907461505;18899.527511812314 03:19:32 INFO - PID 3524 | |3;mootools.html;1403.235236795946;1432.1836553164694;1465.2966576043505;1471.1834931612957;1481.7036592681463;14865.331060102295;15693.686126277467;15698.76451853223;15711.292991815368;15751.921240393782;15142.848571514309;15439.536813895573;15461.458848940289;15501.06993580386;15513.84486155138;2601.9609705854427;2640.115561286971;2644.9867750661315;2653.150991682662;2664.893404263827;2566.8331558448735;2633;2641.590553464216;2651.9469610607775;2653.60195970605;2492.3519884829893;2591.080166540879;2591.987040064797;2604.3619313268277;2628.894844206239;2648.2055383385004;2696.4067905060856;2696.5685490321453;2697.9190624281305;2699.9730002699916;2562.8211022929477;2584.37974886026;2599.077327548731;2602.5445547029385;2631.907883224078;14206.289685515683;14373.281335933267;14381.712365752626;14382.208978506178;14607.78088328676;7915;8168;8216.383771217183;8246.917530824734;8255.133211012817;5157.4068982067165;5262.8684282892855;5356.571474282048;5446.21029950655;5457.372402173761;1890.3856246719872;1891.6878715012006;1900.5577832485328;1952.7070939359069;1954.765428148617;26834.865825670942;27473.587896181572;27492.862535687193;27497.587536186973;27541.586876196674;7251.8187045324285;7454.2545745426105;7499.587522686195;7538.585377804274;7625.6568454419685;20322.187112515334;20482;20504.282350117675;20524.897375513327;20528.794712052986;8191.098979112293;8529.360297977677;8536.274416674529;8536.573171341408;8538.231559159705;6783.152105986752;7151.355188306615;7156.570605763671;7250.347468727839;7616.69533218665;5222.791088356499;5414.648047876875;5430.51125398716;5443.727813609383;5470.194835704208;1589.2053973013494;1601.49552890839;1602.5032240005635;1610.55709679839;1619.0771260381468;902.273669695901;905.7282815155427;909.5861383070687;934.9111834375724;941.6892425499568;7658.387329013665;7866.567338796421;7870.212978702199;7934.523928564305;7976.322012628875;727.6834576959039;747.114669117098;752.868248056588;755.9395248380116;772.204629231892;4735.739534325577;4760.833370832004;4768.809247630056;4822.9758851205515;4901.872569309079;20339.18643254283;21108.577828443653;21230.363089107042;21475.57048859014;21510.784892150878;20496.38510844677;20786.58426831455;21081.472963176042;21229.893850530647;21584.78415215859;11800;11900.523979040914;11947.999999999825;11991.22057066288;12039.157258991787;7782.766517004499;8141.267285944294;8260.173982601691;8358.874616880874;8479.15208479147;18286.908565457088;18468.63062738711;18892.716609251147;19468;19804.60390792147;18506.907465462587;19296.8070319295;19523.51191220174;19715.40853774389;20080.39758807238;12684.492620295085;12966.35168241603;12972.8054079187;12978.80531792005;12990.740185196055;14333;14464.20446875432;14481.493147739779;14504.637384065483;14505.4923077696;10966.616168434066;11026.50380732885;11082.61210857616;11144.88855111471;11717.472713727731;10881.401522916316;11036.5033573491;11355.602553910574;11632.18574699763;11792.29246245228;10014.849777253492;10130.290879638354;10132.189424846141;10136.94931525367;10184.847227291448;7387.482876198829;7765.107012693613;7766.5728384939375;7791.415643826849;7862.606869656609;7589.013428254512;7631.503952243086;7834.608269586612;7877.724279650185;7886.645100970585 03:19:32 INFO - PID 3524 | |4;prototype.html;488.1712354487419;501.7106037483666;520.0171675533242;523.8009556368581;524.3419508516811;6027.819165425039;6080.753445543664;6125.173101631279;6125.6018358806705;6162.352952939933;5789.565782566314;5935.554833387502;5986.221791167153;5995.280566332035;6009.218801555802;4664.930026049612;4679.344891715163;4697.365855609501;4718.834840780573;4736.147493451177;4678.181318269306;4696.225122854725;4716.551927566876;4751.5010923853015;4785.856424307276;4528.501864794886;4648.558386953234;4696.412948381452;4707.882302942437;4728.172569800288;4596.49438561758;4617.261238201889;4636.53634636537;4663.533646635309;4696.201645720235;4262.914741705148;4272.423222864904;4280.315149576084;4289.528151903288;4296.935545966813;5920.674362910038;5927.555433342516;5935.317438494585;5957.851053723648;5977.462028417463;5603.467670571289;5641.153826925953;5649.322081350264;5658.603897727161;5677.233573467571;6398.784230996096;6416;6490.578112422724;6508.25155107164;6534.8366290843105;4807.855764327041;4820.662553621248;4868.659193856432;4883.267509873512;4892.535209155125;6709.798706038827;6785.2858856457315;6786.253512113663;6796.728130874809;6825.283345248727;4986.401631804207;4990.176620857518;5021.322121513549;5029.27075574047;5041.294218809369;5025.6482046256415;5038.64729468941;5081.23781432788;5101.795928162906;5113.724392645311;5599.816071732028;5606.6916319602;5649.514213745939;5656.717164141859;5659.151127330933;6442.323556026643;6498.245473722069;6514.478841692653;6565.376289252514;6578.506612004119;1750.264888746704;1758.9648207036043;1759.8944063355984;1777.7155655095123;1780.9670391173088;1145.0381679389352;1154.9364784936909;1227.490591404557;1227.9815802762967;1239.7520495900856;6063.7574497020505;6066.636001839815;6130.540209484307;6136.969315153396;6153.815385538441;6557.901631475532;6571.54993628349;6587.308332625101;6631.137952066297;6652.96673516639;6115.877682446415;6117.785877494355;6188.659623720739;6217.347178546278;6217.751289948352;3405.1487128217946;3460.982695086559;3463.480477928331;3472.201393679468;3479.7216222702123;6905.136857892763;6936.237013928464;6938.271481494471;6939.826504337432;7023.262557431498;6803.761868334684;6808.795736127924;6818.3976765460075;6819.147606549182;6833.658317084126;6941.95870619401;6982.2319544850025;6987.336203060803;7015.36861682451;7015.579065256101;6628;6634.270230274762;6656;6661.16735408074;6677.83305417349;6401.167848179707;6467.967660161669;6478.578892371981;6516.73933042692;6553.901691474727;6842.384185423336;6863.313668633296;6884.724611015503;6910.274421185703;6951.409130223988;4952.133376659142;4952.752362381794;4968.726720030433;4971.931034827529;5012.498750124958;6627.072209890523;6628.304028077176;6642.169728783902;6653.800385988428;6738.898916516158;6356.650384228727;6369.363063693593;6405.487560995202;6440.742370305135;6449.838754031187;6362.809115726535;6366.458850997532;6421.848680692021;6463.385978332051;6482.7034593080625;6277.686115694289;6306.779262725782;6361.968190159019;6381.680915954091;6402.519811014099;5973.820785376446;6323.715432805627;6416.165898433173;6491.805245842632;6524.739010439719;6217.036359364306;6265;6279.686015699105;6342.270638876404;6366.172397588284 03:19:32 INFO - PID 3524 | |5;yui.html;885.163520473153;902.5667679513829;917.3211823250795;928.6424726480303;939.9859002114973;16534.33862645494;16875.746863797038;18234.81765182348;18875.15061822218;18911.716324255114;16027.679446411064;16094.275757590907;16160.595985100379;16598;18917.810821891777;1045.508610952853;1053.9894601054007;1057.1701214546583;1060.7401186709267;1062.6865074802952;1072.3780207479642;1073.0235485708008;1076.2251179150999;1076.9299995500307;1077.536659236528;1137.0448822988687;1138.4535422996967;1141.4863311509812;1141.680329507739;1142.2860712054965;1048.6644273832376;1109.805783987807;1120.8991190792826;1133.7505748735266;1136.8806275341094;814.9511029338258;821.6343727041469;821.9178082191793;822.8971378577678;823.069930977991;18533.166007529693;18987.240510379568;19053.61892762137;19095.90452047745;19259.51851203717;16789.32842686291;17530.38643647479;17652.11739413024;17692.203850826743;17889.10554472271;14695.853041469556;15286.082835029823;15310;15315;15358.692826143526;3429.6741809528053;3430.5711786026745;3450.0857272822473;3450.4996775467416;3453.3783918894587;88477.46090156451;122161;123091;125660.37169814092;130513;13232.867671323163;13592.796108058386;13616.455341786415;13797.586072417844;14887.851121488864;29577.408451830845;30616.693833061385;30914.69085309163;31096.44517774102;31311.217219569236;8368.665253389796;8500.44747091437;8508.319334453228;8660.610272537751;8731.170538798804;4235.174141042528;4335.1329734053315;4365.585269399402;4370.21336159488;4370.38814565961;5351.652142610717;5382;5399.649022813504;5488.286522752097;5497.202905578669;1092.5192915117323;1106.7880670665609;1108.6507750058706;1109.8335249712445;1111.394290111891;706.8162277807807;720.7945735465368;728.0244472406894;737.6791095873313;744;12745.490180392866;13049.869501305055;13128.409221585052;13226.801597976038;13520.18878867271;661.9238787539495;682.2597481732377;693.5873155472486;701.0850839654198;702.3222590200481;5623.878747295209;6084.5436592255755;6141.263048434216;6223.439890409885;6294.622322660655;110938;113872;115018;116206.41896790462;117563;100860;101523;102009.48995255124;103135;105320;83522;86796.13203868007;90274.54862725644;91853.5407322959;92260.53869730608;11155.553777848796;11809.881901180877;12055.276683399024;12094.274343539415;12183.878161218274;45955.310670339306;46758.76620616875;46780.29829552492;47164.52835471739;48469.75765121293;55158.44841551533;56608.71695641495;57904.4209557899;58029.4197058024;58564.4143558576;16601.75097373516;16634.916825415796;16706.331746729993;16943.57641058934;16946.40687575929;15590.454334098253;16096.27566759522;16274.755878661592;16326.510204693877;16667.83332166663;15266.160361179798;15302.234888255765;15466.458673946358;15724.764128537852;15763.448279310169;14884.553463396116;15069.17119558391;15207.543773686808;15223.619409514851;15298.923505382401;15651.843481565038;16273.918630406772;16394.83605163933;16571.254293556576;16893.91553042227;11464.541418343173;11516.30902145874;11615.361155136548;11747.941260293986;11835.408229588658;13499.190048597116;14103.647408814863;14345.426182952566;14385.280735962951;14449.49426770058 03:19:32 INFO - PID 3524 | __end_tp_report 03:19:32 INFO - PID 3524 | __start_cc_report 03:19:32 INFO - PID 3524 | _x_x_mozilla_cycle_collect,325 03:19:32 INFO - PID 3524 | __end_cc_report 03:19:32 INFO - PID 3524 | __startTimestamp1500200372986__endTimestamp 03:19:32 INFO - PID 3524 | 03:19:32 INFO - PID 3524 | ------- Summary: start ------- 03:19:32 INFO - PID 3524 | Number of tests: 6 03:19:32 INFO - PID 3524 | 03:19:32 INFO - PID 3524 | [#0] dojo.html Cycles:165 Average:6206.08 Median:6494.16 stddev:777.13 (12.0%) stddev-sans-first:746.58 03:19:33 INFO - PID 3524 | Values: 3352.9 3401.9 3417.4 3426.7 3438.6 6245.6 6276.4 6300.4 6339.7 6373.0 6119.3 6130.7 6195.9 6202.0 6224.6 5456.8 5457.1 5490.6 5496.2 5511.1 5462.8 5551.1 5555.7 5563.1 5566.0 5552.4 5553.4 5554.0 5556.7 5557.3 5520.0 5522.5 5523.1 5526.3 5538.4 5322.0 5446.7 5468.4 5507.0 5547.3 6177.7 6193.9 6209.2 6259.7 6260.7 6596.0 6693.8 6717.7 6789.2 6808.9 6774.4 6782.9 6806.1 6810.6 6840.9 6222.1 6235.0 6240.5 6310.5 6341.7 6942.8 6949.7 6998.9 7042.1 7044.3 6532.1 6620.6 6634.2 6686.0 6704.4 6652.0 6653.0 6665.1 6686.6 6695.2 6563.5 6569.6 6601.7 6615.1 6644.7 5775.8 6756.3 6760.1 6842.8 6845.0 5090.6 5144.2 5148.5 5160.7 5163.7 4508.1 4544.8 4562.7 4590.9 4592.9 6265.7 6315.7 6363.8 6414.7 6431.4 6797.5 6808.3 6809.8 6823.3 6873.0 6418.3 6432.2 6434.5 6437.6 6462.2 5608.0 5682.4 5778.7 5827.2 5852.2 6994.3 7016.8 7025.6 7026.6 7042.4 6689.8 6691.6 6696.0 6705.2 6707.7 6911.5 7059.0 7098.1 7134.1 7153.3 6650.7 6678.7 6721.2 6726.3 6752.6 6665.7 6709.7 6730.9 6780.8 6853.9 5558.0 6494.2 6500.5 6553.4 6561.8 6524.9 6551.9 6590.8 6603.4 6614.0 6529.3 6542.3 6614.9 6617.7 6623.9 6549.9 6601.4 6608.0 6637.6 6666.5 6390.6 6419.2 6424.2 6427.0 6428.1 03:19:33 INFO - PID 3524 | 03:19:33 INFO - PID 3524 | [#1] ext.html Cycles:180 Average:42538.17 Median:35219.30 stddev:63934.23 (181.5%) stddev-sans-first:64036.80 03:19:33 INFO - PID 3524 | Values: 806.6 848.1 875.9 908.6 920.0 41902.2 42500.0 42522.0 42693.6 42697.1 39385.6 39769.8 40158.0 40216.4 40244.4 6572.8 6654.6 6664.0 6701.4 6709.1 6581.0 6685.1 6704.9 6720.6 6722.6 6561.3 6651.6 6658.6 6685.5 6690.9 6641.6 6677.3 6681.1 6684.0 6710.6 5977.5 6021.2 6025.4 6030.8 6043.2 34440.5 34645.7 34689.8 34792.3 34962.7 3226.2 3273.0 3292.2 3433.8 3443.3 32349.5 33062.0 33313.5 33328.0 33346.0 4856.8 4863.8 4884.0 4921.3 4965.4 203801.0 204594.0 205491.0 211569.0 211936.0 54343.7 54769.5 55019.4 55106.2 55119.4 56851.0 57103.4 57443.0 57753.7 57763.7 16194.2 16265.2 16277.8 16278.3 16284.2 13328.1 13505.2 13551.1 13556.3 13567.0 15345.2 15362.6 15571.2 15602.5 15809.6 6049.8 6180.8 6246.7 6248.1 6300.1 1063.4 1094.6 1096.0 1098.1 1107.3 24718.4 24971.5 25023.2 25026.7 25156.2 1176.4 1180.1 1182.2 1193.0 1208.2 13122.7 13243.8 13372.4 13380.7 13528.9 271977.0 272765.0 272937.0 274783.0 274798.0 57742.7 57891.7 58297.7 58479.7 58533.4 1480.3 1510.4 1515.7 1522.3 1537.2 24327.3 30003.2 30129.8 30693.7 30879.2 57566.4 58178.7 58232.4 58271.7 58293.7 247205.0 248747.0 250345.0 251229.0 252858.0 34831.5 35089.8 35107.3 35331.3 38136.8 45009.3 46423.0 46980.8 47054.8 47349.8 33150.5 34082.7 34214.0 34296.1 34401.8 33302.3 35671.6 36181.5 36308.5 36816.8 41927.2 43030.6 43062.0 43564.0 43641.1 33910.0 34596.5 35884.6 36091.8 36249.0 25530.9 26729.0 26931.0 26953.2 27170.7 03:19:33 INFO - PID 3524 | 03:19:33 INFO - PID 3524 | [#2] jquery.html Cycles:180 Average:39796.35 Median:2289.77 stddev:103087.33 (4502.1%) stddev-sans-first:103334.44 03:19:33 INFO - PID 3524 | Values: 568.5 568.6 573.5 592.2 598.8 22482.4 23605.5 23867.0 23874.4 23901.6 23614.0 24290.0 24407.5 24539.1 24754.8 6324.9 6409.0 6455.7 6461.9 6471.3 6309.2 6368.6 6369.0 6372.2 6399.6 5771.1 5954.8 6309.1 6341.0 6345.4 6275.7 6280.9 6299.2 6322.0 6322.1 5812.9 5860.0 5880.5 5888.1 5902.3 30036.4 31044.0 31382.4 31450.7 31560.4 2173.4 2229.3 2230.4 2241.0 2256.8 18837.8 19356.3 19365.8 19376.6 19402.0 2322.7 2383.1 2404.4 2428.8 2442.9 153008.0 154209.0 155908.0 157650.0 158589.2 14996.8 15767.3 15935.1 16055.6 16170.3 24227.9 24260.3 24373.3 24416.8 24427.0 10090.1 10140.2 10195.5 10204.9 10257.2 8947.7 8981.4 8983.0 8994.5 9068.1 9199.6 9506.6 9560.5 9653.9 9845.5 2725.4 2757.9 2779.7 2808.1 2835.7 1021.3 1036.1 1043.8 1056.9 1059.3 21148.0 21202.5 21355.5 21598.0 21934.2 1071.1 1095.3 1095.7 1096.1 1113.5 11616.3 11644.9 11723.6 11841.2 11868.8 598040.0 601339.0 622968.0 626304.0 627639.0 123371.0 129454.0 129824.0 130270.0 132218.0 1096.9 1102.9 1113.7 1121.5 1128.3 18131.7 18961.6 19055.9 19273.9 19401.7 61828.7 62491.0 63306.0 63538.4 65186.3 80102.0 81536.6 82224.6 82467.2 82531.6 14117.2 14214.3 14314.4 14948.6 15040.5 23644.6 23761.8 23997.8 24323.1 24471.1 19017.3 19308.0 19604.0 19663.7 19666.3 16435.8 16629.9 17058.3 17201.3 17797.4 17586.5 17600.6 17611.6 17627.9 19744.2 14765.9 14782.1 14793.2 14798.6 14812.0 16752.2 17279.6 18568.7 18654.6 18899.5 03:19:33 INFO - PID 3524 | 03:19:33 INFO - PID 3524 | [#3] mootools.html Cycles:180 Average:9551.94 Median:2595.53 stddev:6875.57 (264.9%) stddev-sans-first:6867.60 03:19:33 INFO - PID 3524 | Values: 1403.2 1432.2 1465.3 1471.2 1481.7 14865.3 15693.7 15698.8 15711.3 15751.9 15142.8 15439.5 15461.5 15501.1 15513.8 2602.0 2640.1 2645.0 2653.2 2664.9 2566.8 2633.0 2641.6 2651.9 2653.6 2492.4 2591.1 2592.0 2604.4 2628.9 2648.2 2696.4 2696.6 2697.9 2700.0 2562.8 2584.4 2599.1 2602.5 2631.9 14206.3 14373.3 14381.7 14382.2 14607.8 7915.0 8168.0 8216.4 8246.9 8255.1 5157.4 5262.9 5356.6 5446.2 5457.4 1890.4 1891.7 1900.6 1952.7 1954.8 26834.9 27473.6 27492.9 27497.6 27541.6 7251.8 7454.3 7499.6 7538.6 7625.7 20322.2 20482.0 20504.3 20524.9 20528.8 8191.1 8529.4 8536.3 8536.6 8538.2 6783.2 7151.4 7156.6 7250.3 7616.7 5222.8 5414.6 5430.5 5443.7 5470.2 1589.2 1601.5 1602.5 1610.6 1619.1 902.3 905.7 909.6 934.9 941.7 7658.4 7866.6 7870.2 7934.5 7976.3 727.7 747.1 752.9 755.9 772.2 4735.7 4760.8 4768.8 4823.0 4901.9 20339.2 21108.6 21230.4 21475.6 21510.8 20496.4 20786.6 21081.5 21229.9 21584.8 11800.0 11900.5 11948.0 11991.2 12039.2 7782.8 8141.3 8260.2 8358.9 8479.2 18286.9 18468.6 18892.7 19468.0 19804.6 18506.9 19296.8 19523.5 19715.4 20080.4 12684.5 12966.4 12972.8 12978.8 12990.7 14333.0 14464.2 14481.5 14504.6 14505.5 10966.6 11026.5 11082.6 11144.9 11717.5 10881.4 11036.5 11355.6 11632.2 11792.3 10014.8 10130.3 10132.2 10136.9 10184.8 7387.5 7765.1 7766.6 7791.4 7862.6 7589.0 7631.5 7834.6 7877.7 7886.6 03:19:33 INFO - PID 3524 | 03:19:33 INFO - PID 3524 | [#4] prototype.html Cycles:180 Average:5472.92 Median:6116.83 stddev:1573.59 (25.7%) stddev-sans-first:1532.88 03:19:33 INFO - PID 3524 | Values: 488.2 501.7 520.0 523.8 524.3 6027.8 6080.8 6125.2 6125.6 6162.4 5789.6 5935.6 5986.2 5995.3 6009.2 4664.9 4679.3 4697.4 4718.8 4736.1 4678.2 4696.2 4716.6 4751.5 4785.9 4528.5 4648.6 4696.4 4707.9 4728.2 4596.5 4617.3 4636.5 4663.5 4696.2 4262.9 4272.4 4280.3 4289.5 4296.9 5920.7 5927.6 5935.3 5957.9 5977.5 5603.5 5641.2 5649.3 5658.6 5677.2 6398.8 6416.0 6490.6 6508.3 6534.8 4807.9 4820.7 4868.7 4883.3 4892.5 6709.8 6785.3 6786.3 6796.7 6825.3 4986.4 4990.2 5021.3 5029.3 5041.3 5025.6 5038.6 5081.2 5101.8 5113.7 5599.8 5606.7 5649.5 5656.7 5659.2 6442.3 6498.2 6514.5 6565.4 6578.5 1750.3 1759.0 1759.9 1777.7 1781.0 1145.0 1154.9 1227.5 1228.0 1239.8 6063.8 6066.6 6130.5 6137.0 6153.8 6557.9 6571.5 6587.3 6631.1 6653.0 6115.9 6117.8 6188.7 6217.3 6217.8 3405.1 3461.0 3463.5 3472.2 3479.7 6905.1 6936.2 6938.3 6939.8 7023.3 6803.8 6808.8 6818.4 6819.1 6833.7 6942.0 6982.2 6987.3 7015.4 7015.6 6628.0 6634.3 6656.0 6661.2 6677.8 6401.2 6468.0 6478.6 6516.7 6553.9 6842.4 6863.3 6884.7 6910.3 6951.4 4952.1 4952.8 4968.7 4971.9 5012.5 6627.1 6628.3 6642.2 6653.8 6738.9 6356.7 6369.4 6405.5 6440.7 6449.8 6362.8 6366.5 6421.8 6463.4 6482.7 6277.7 6306.8 6362.0 6381.7 6402.5 5973.8 6323.7 6416.2 6491.8 6524.7 6217.0 6265.0 6279.7 6342.3 6366.2 03:19:33 INFO - PID 3524 | 03:19:33 INFO - PID 3524 | [#5] yui.html Cycles:180 Average:22960.13 Median:16584.63 stddev:32154.31 (193.9%) stddev-sans-first:32201.78 03:19:33 INFO - PID 3524 | Values: 885.2 902.6 917.3 928.6 940.0 16534.3 16875.7 18234.8 18875.2 18911.7 16027.7 16094.3 16160.6 16598.0 18917.8 1045.5 1054.0 1057.2 1060.7 1062.7 1072.4 1073.0 1076.2 1076.9 1077.5 1137.0 1138.5 1141.5 1141.7 1142.3 1048.7 1109.8 1120.9 1133.8 1136.9 815.0 821.6 821.9 822.9 823.1 18533.2 18987.2 19053.6 19095.9 19259.5 16789.3 17530.4 17652.1 17692.2 17889.1 14695.9 15286.1 15310.0 15315.0 15358.7 3429.7 3430.6 3450.1 3450.5 3453.4 88477.5 122161.0 123091.0 125660.4 130513.0 13232.9 13592.8 13616.5 13797.6 14887.9 29577.4 30616.7 30914.7 31096.4 31311.2 8368.7 8500.4 8508.3 8660.6 8731.2 4235.2 4335.1 4365.6 4370.2 4370.4 5351.7 5382.0 5399.6 5488.3 5497.2 1092.5 1106.8 1108.7 1109.8 1111.4 706.8 720.8 728.0 737.7 744.0 12745.5 13049.9 13128.4 13226.8 13520.2 661.9 682.3 693.6 701.1 702.3 5623.9 6084.5 6141.3 6223.4 6294.6 110938.0 113872.0 115018.0 116206.4 117563.0 100860.0 101523.0 102009.5 103135.0 105320.0 83522.0 86796.1 90274.5 91853.5 92260.5 11155.6 11809.9 12055.3 12094.3 12183.9 45955.3 46758.8 46780.3 47164.5 48469.8 55158.4 56608.7 57904.4 58029.4 58564.4 16601.8 16634.9 16706.3 16943.6 16946.4 15590.5 16096.3 16274.8 16326.5 16667.8 15266.2 15302.2 15466.5 15724.8 15763.4 14884.6 15069.2 15207.5 15223.6 15298.9 15651.8 16273.9 16394.8 16571.3 16893.9 11464.5 11516.3 11615.4 11747.9 11835.4 13499.2 14103.6 14345.4 14385.3 14449.5 03:19:33 INFO - PID 3524 | -------- Summary: end -------- 03:19:33 INFO - PID 3524 | 03:19:33 INFO - TEST-INFO | 3524: exit 0 03:19:33 INFO - TEST-OK | dromaeo_css | took 1112306ms 03:19:33 INFO - TEST-START | kraken 03:19:33 INFO - Initialising browser for kraken test... 03:19:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60881/getInfo.html -profile /tmp/tmpc5kb1s/profile 03:19:33 INFO - TEST-INFO | started process 3932 (/builds/slave/test/build/application/firefox/firefox http://localhost:60881/getInfo.html) 03:19:39 INFO - TEST-INFO | 3932: exit 0 03:19:39 INFO - Browser initialized. 03:19:39 INFO - Running cycle 1/1 for kraken test... 03:19:39 INFO - TEST-INFO | started process 4142 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc5kb1s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:50 INFO - PID 4142 | RSS: Main: 160366592 03:19:50 INFO - PID 4142 | 03:19:53 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:60881/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60881/tests/kraken/driver.html?testName=audio-beat-detection) 03:19:54 INFO - PID 4142 | RSS: Main: 167526400 03:19:54 INFO - PID 4142 | 03:19:56 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:60881/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60881/tests/kraken/driver.html?testName=audio-dft) 03:19:57 INFO - PID 4142 | RSS: Main: 167342080 03:19:57 INFO - PID 4142 | 03:20:00 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:60881/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60881/tests/kraken/driver.html?testName=audio-fft) 03:20:00 INFO - PID 4142 | RSS: Main: 161013760 03:20:00 INFO - PID 4142 | 03:20:02 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:60881/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60881/tests/kraken/driver.html?testName=audio-oscillator) 03:20:03 INFO - PID 4142 | RSS: Main: 162041856 03:20:03 INFO - PID 4142 | 03:20:05 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:60881/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60881/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:20:06 INFO - PID 4142 | RSS: Main: 161439744 03:20:06 INFO - PID 4142 | 03:20:09 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:60881/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60881/tests/kraken/driver.html?testName=imaging-darkroom) 03:20:09 INFO - PID 4142 | RSS: Main: 161701888 03:20:09 INFO - PID 4142 | 03:20:13 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:60881/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60881/tests/kraken/driver.html?testName=imaging-desaturate) 03:20:13 INFO - PID 4142 | RSS: Main: 164585472 03:20:13 INFO - PID 4142 | 03:20:16 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:60881/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60881/tests/kraken/driver.html?testName=json-parse-financial) 03:20:17 INFO - PID 4142 | RSS: Main: 165548032 03:20:17 INFO - PID 4142 | 03:20:18 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:60881/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60881/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:20:19 INFO - PID 4142 | RSS: Main: 166076416 03:20:19 INFO - PID 4142 | 03:20:20 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:60881/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60881/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:20:21 INFO - PID 4142 | RSS: Main: 165904384 03:20:21 INFO - PID 4142 | 03:20:23 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:60881/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60881/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:20:24 INFO - PID 4142 | RSS: Main: 165359616 03:20:24 INFO - PID 4142 | 03:20:26 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:60881/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60881/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:20:27 INFO - PID 4142 | RSS: Main: 166137856 03:20:27 INFO - PID 4142 | 03:20:30 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:60881/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60881/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:20:30 INFO - PID 4142 | RSS: Main: 165654528 03:20:30 INFO - PID 4142 | 03:20:32 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:60881/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60881/tests/kraken/driver.html?testName=ai-astar) 03:20:32 INFO - PID 4142 | RSS: Main: 168038400 03:20:32 INFO - PID 4142 | 03:20:32 INFO - PID 4142 | __start_tp_report 03:20:32 INFO - PID 4142 | _x_x_mozilla_page_load 03:20:32 INFO - PID 4142 | _x_x_mozilla_page_load_details 03:20:32 INFO - PID 4142 | |i|pagename|runs| 03:20:32 INFO - PID 4142 | |0;ai-astar;107;99;109;107;110;109;108;107;107;107 03:20:32 INFO - PID 4142 | |1;audio-beat-detection;146;115;141;166;116;145;148;116;166;116 03:20:32 INFO - PID 4142 | |2;audio-dft;162;161;161;162;163;170;161;161;160;166 03:20:32 INFO - PID 4142 | |3;audio-fft;75;76;74;73;73;76;73;164;74;74 03:20:32 INFO - PID 4142 | |4;audio-oscillator;80;80;137;81;81;80;125;80;80;130 03:20:32 INFO - PID 4142 | |5;imaging-gaussian-blur;114;114;114;114;114;115;114;113;114;115 03:20:32 INFO - PID 4142 | |6;imaging-darkroom;147;147;147;154;147;148;148;148;148;149 03:20:32 INFO - PID 4142 | |7;imaging-desaturate;94;94;94;94;94;94;94;94;94;94 03:20:32 INFO - PID 4142 | |8;json-parse-financial;48;47;48;47;48;48;54;49;48;47 03:20:32 INFO - PID 4142 | |9;json-stringify-tinderbox;55;55;54;54;55;54;56;54;54;54 03:20:32 INFO - PID 4142 | |10;stanford-crypto-aes;76;75;75;76;75;86;76;76;75;81 03:20:32 INFO - PID 4142 | |11;stanford-crypto-ccm;138;128;128;125;123;117;123;119;118;148 03:20:32 INFO - PID 4142 | |12;stanford-crypto-pbkdf2;172;184;175;172;177;175;173;170;174;166 03:20:32 INFO - PID 4142 | |13;stanford-crypto-sha256-iterative;62;64;62;62;63;63;63;64;61;64 03:20:32 INFO - PID 4142 | __end_tp_report 03:20:32 INFO - PID 4142 | __start_cc_report 03:20:32 INFO - PID 4142 | _x_x_mozilla_cycle_collect,865 03:20:32 INFO - PID 4142 | __end_cc_report 03:20:32 INFO - PID 4142 | __startTimestamp1500200432714__endTimestamp 03:20:32 INFO - PID 4142 | 03:20:32 INFO - PID 4142 | ------- Summary: start ------- 03:20:32 INFO - PID 4142 | Number of tests: 14 03:20:32 INFO - PID 4142 | 03:20:32 INFO - PID 4142 | [#0] ai-astar Cycles:10 Average:107.00 Median:108.50 stddev:3.02 (2.8%) stddev-sans-first:3.20 03:20:32 INFO - PID 4142 | Values: 107.0 99.0 109.0 107.0 110.0 109.0 108.0 107.0 107.0 107.0 03:20:32 INFO - PID 4142 | 03:20:32 INFO - PID 4142 | [#1] audio-beat-detection Cycles:10 Average:137.50 Median:145.50 stddev:20.46 (14.1%) stddev-sans-first:21.47 03:20:32 INFO - PID 4142 | Values: 146.0 115.0 141.0 166.0 116.0 145.0 148.0 116.0 166.0 116.0 03:20:32 INFO - PID 4142 | 03:20:32 INFO - PID 4142 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.00 stddev:3.06 (1.9%) stddev-sans-first:3.23 03:20:32 INFO - PID 4142 | Values: 162.0 161.0 161.0 162.0 163.0 170.0 161.0 161.0 160.0 166.0 03:20:32 INFO - PID 4142 | 03:20:32 INFO - PID 4142 | [#3] audio-fft Cycles:10 Average:83.20 Median:74.00 stddev:28.41 (38.4%) stddev-sans-first:29.98 03:20:32 INFO - PID 4142 | Values: 75.0 76.0 74.0 73.0 73.0 76.0 73.0 164.0 74.0 74.0 03:20:32 INFO - PID 4142 | 03:20:32 INFO - PID 4142 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:80.00 stddev:24.50 (30.6%) stddev-sans-first:25.35 03:20:32 INFO - PID 4142 | Values: 80.0 80.0 137.0 81.0 81.0 80.0 125.0 80.0 80.0 130.0 03:20:32 INFO - PID 4142 | 03:20:32 INFO - PID 4142 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 03:20:32 INFO - PID 4142 | Values: 114.0 114.0 114.0 114.0 114.0 115.0 114.0 113.0 114.0 115.0 03:20:32 INFO - PID 4142 | 03:20:32 INFO - PID 4142 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:2.11 (1.4%) stddev-sans-first:2.19 03:20:32 INFO - PID 4142 | Values: 147.0 147.0 147.0 154.0 147.0 148.0 148.0 148.0 148.0 149.0 03:20:32 INFO - PID 4142 | 03:20:32 INFO - PID 4142 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 03:20:32 INFO - PID 4142 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 03:20:32 INFO - PID 4142 | 03:20:32 INFO - PID 4142 | [#8] json-parse-financial Cycles:10 Average:48.40 Median:48.00 stddev:2.07 (4.3%) stddev-sans-first:2.19 03:20:32 INFO - PID 4142 | Values: 48.0 47.0 48.0 47.0 48.0 48.0 54.0 49.0 48.0 47.0 03:20:32 INFO - PID 4142 | 03:20:32 INFO - PID 4142 | [#9] json-stringify-tinderbox Cycles:10 Average:54.50 Median:54.50 stddev:0.71 (1.3%) stddev-sans-first:0.73 03:20:32 INFO - PID 4142 | Values: 55.0 55.0 54.0 54.0 55.0 54.0 56.0 54.0 54.0 54.0 03:20:32 INFO - PID 4142 | 03:20:32 INFO - PID 4142 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:76.00 stddev:3.60 (4.7%) stddev-sans-first:3.80 03:20:32 INFO - PID 4142 | Values: 76.0 75.0 75.0 76.0 75.0 86.0 76.0 76.0 75.0 81.0 03:20:32 INFO - PID 4142 | 03:20:32 INFO - PID 4142 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:126.50 stddev:9.68 (7.7%) stddev-sans-first:9.37 03:20:32 INFO - PID 4142 | Values: 138.0 128.0 128.0 125.0 123.0 117.0 123.0 119.0 118.0 148.0 03:20:32 INFO - PID 4142 | 03:20:32 INFO - PID 4142 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.80 Median:174.50 stddev:4.71 (2.7%) stddev-sans-first:4.95 03:20:32 INFO - PID 4142 | Values: 172.0 184.0 175.0 172.0 177.0 175.0 173.0 170.0 174.0 166.0 03:20:32 INFO - PID 4142 | 03:20:32 INFO - PID 4142 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:1.03 (1.6%) stddev-sans-first:1.05 03:20:32 INFO - PID 4142 | Values: 62.0 64.0 62.0 62.0 63.0 63.0 63.0 64.0 61.0 64.0 03:20:32 INFO - PID 4142 | -------- Summary: end -------- 03:20:32 INFO - PID 4142 | 03:20:33 INFO - PID 4142 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:20:33 INFO - TEST-INFO | 4142: exit 0 03:20:33 INFO - TEST-OK | kraken | took 59956ms 03:20:33 INFO - SUITE-END | took 1172s 03:20:33 INFO - Completed test suite (00:19:32) 03:20:33 INFO - javascript benchmark 03:20:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8624.367966440608, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3352.916177095574, 3401.897943061709, 3417.3677869594126, 3426.725861931046, 3438.6045604755445, 6245.562810603254, 6276.435120839124, 6300.401461861127, 6339.683015849207, 6373.0, 6119.3268740438625, 6130.662813545253, 6195.876082478348, 6201.968990155043, 6224.595401298924, 5456.781728730846, 5457.099578569531, 5490.56075513958, 5496.1755736639425, 5511.063119269714, 5462.781488740446, 5551.1118221084635, 5555.694436805974, 5563.109902415615, 5566.0, 5552.3892371839065, 5553.416891226424, 5553.972230138864, 5556.722163891789, 5557.3331200256025, 5519.99999999998, 5522.502974732293, 5523.116301391758, 5526.281583394133, 5538.363088244843, 5322.0, 5446.700431476267, 5468.425815289377, 5507.0, 5547.25112109868, 6177.66022868742, 6193.907091393633, 6209.223847019122, 6259.71831267594, 6260.749570017194, 6595.97762346837, 6693.799186024427, 6717.664116794141, 6789.18529776425, 6808.863822723518, 6774.390304872585, 6782.898256526156, 6806.123920383053, 6810.62541560214, 6840.897386539206, 6222.066689996536, 6234.9999999999545, 6240.469560087398, 6310.5267104967315, 6341.682915854189, 6942.757003504853, 6949.722011119599, 6998.93001069993, 7042.119735033121, 7044.330788575179, 6532.08550802888, 6620.569662971891, 6634.203895532471, 6686.0, 6704.430123439464, 6652.0, 6652.966735166293, 6665.133532640726, 6686.632235227109, 6695.163104611924, 6563.507736919654, 6569.638669873108, 6601.735930562723, 6615.106960560359, 6644.700988455531, 5775.826725198251, 6756.324367563303, 6760.087388202628, 6842.794716158523, 6844.965775171092, 5090.592752579785, 5144.15121504955, 5148.510891465305, 5160.7419629018395, 5163.715995620202, 4508.143452743968, 4544.818207271672, 4562.7262364257585, 4590.908181836411, 4592.908141837144, 6265.686715664198, 6315.684215789192, 6363.809085727436, 6414.711337989802, 6431.356864313531, 6797.456203503708, 6808.2510923798345, 6809.761658341934, 6823.283555226729, 6872.965635171792, 6418.326075762071, 6432.228132624022, 6434.549581529248, 6437.581557198767, 6462.224533055969, 5607.971960140173, 5682.374938756733, 5778.739956701958, 5827.184194212814, 5852.151438041546, 6994.33553812387, 7016.789496315118, 7025.578465292099, 7026.578405295699, 7042.436605071582, 6689.799306020827, 6691.631960242234, 6696.0, 6705.195376554844, 6707.731690732414, 6911.481638877205, 7059.011738356737, 7098.077249957472, 7134.072570565793, 7153.320434558708, 6650.700718467584, 6678.666066696548, 6721.1598550181225, 6726.293739157318, 6752.561083529555, 6665.733370665119, 6709.664516774044, 6730.8653826924165, 6780.830479238059, 6853.9314606853295, 5557.972210138923, 6494.155759751202, 6500.544961852814, 6553.377429144223, 6561.835954101186, 6524.9021264682015, 6551.901721474086, 6590.8352291193105, 6603.372679595431, 6614.0, 6529.347065293433, 6542.34576542361, 6614.933850661624, 6617.735290588323, 6623.900641490478, 6549.8690026200165, 6601.438877695449, 6608.0, 6637.601743895381, 6666.466682665472, 6390.648514331757, 6419.2296924369375, 6424.196975378078, 6426.967865160645, 6428.100065990859], "value": 6148.538416397286, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [806.6410447350928, 848.0883050720477, 875.8948926128866, 908.6229214875825, 920.0155833258416, 41902.16195676084, 42500.0, 42522.0, 42693.573064269345, 42697.14605707884, 39385.60614393855, 39769.80115099427, 40158.0, 40216.396754048714, 40244.39633405501, 6572.769953051644, 6654.633995130266, 6664.033715111306, 6701.396874281314, 6709.060731497594, 6581.0, 6685.064091027236, 6704.93295067048, 6720.59676419414, 6722.630255335955, 6561.311062338457, 6651.600903945755, 6658.600483970978, 6685.465162786965, 6690.866182676344, 6641.601503909781, 6677.332266773333, 6681.098051762999, 6684.0, 6710.630915299656, 5977.462028417463, 6021.187139736124, 6025.427584379477, 6030.849228769272, 6043.153958445821, 34440.48339274913, 34645.6535434645, 34689.826550867336, 34792.30415391678, 34962.650373496195, 3226.1611980884904, 3272.9509057364157, 3292.160499072745, 3433.759636825423, 3443.2941247044296, 32349.51475727866, 33062.0, 33313.50029749556, 33328.0, 33346.0, 4856.757162141914, 4863.80544778212, 4883.975580122112, 4921.261810728383, 4965.354503914468, 203801.0, 204594.0, 205490.9725451378, 211569.0, 211936.0, 54343.72828135834, 54769.452305476436, 55019.449805501434, 55106.17340739892, 55119.448805512235, 56851.0, 57103.42896571064, 57443.0, 57753.71123144357, 57763.711181443825, 16194.190290485429, 16265.186740662919, 16277.755833662504, 16278.348866045462, 16284.185790710417, 13328.133671311334, 13505.189688618715, 13551.051426400254, 13556.254406007763, 13567.0, 15345.232738363036, 15362.615934601725, 15571.221438928234, 15602.453914112952, 15809.604759880865, 6049.848753781191, 6180.783672571439, 6246.6876656167005, 6248.094026366151, 6300.054991751183, 1063.4310643805682, 1094.6114129484079, 1095.9616413425492, 1098.1379617000616, 1107.3355986408092, 24718.382040448774, 24971.50056998886, 25023.249302520955, 25026.749732502805, 25156.24531264065, 1176.4235524592889, 1180.1267062373954, 1182.2020136407891, 1192.9940350298193, 1208.2448469706433, 13122.671933201746, 13243.801342979863, 13372.398242079129, 13380.732385352434, 13528.93235533816, 271977.0, 272765.0, 272937.0, 274783.0, 274798.0, 57742.71128644414, 57891.71054144702, 58297.70851145802, 58479.70760146172, 58533.41466585365, 1480.2820631993475, 1510.358097808427, 1515.6968606278788, 1522.3073501556764, 1537.2237020304674, 24327.27018189457, 30003.249918752204, 30129.849350753982, 30693.693063069084, 30879.2280192997, 57566.424335756106, 58178.7091064542, 58232.4176758227, 58271.70864145652, 58293.70853145707, 247205.0, 248747.0, 250345.0, 251229.0, 252858.0, 34831.47752783659, 35089.824550877085, 35107.29785404329, 35331.293374131856, 38136.809315953244, 45009.32486012647, 46423.0, 46980.82547936329, 47054.76472617615, 47349.763251183525, 33150.5027424584, 34082.65917340795, 34214.0, 34296.14259643529, 34401.82799086089, 33302.333953321286, 35671.64328356787, 36181.457278140326, 36308.455373168894, 36816.81591592025, 41927.16145677008, 43030.56969430391, 43062.0, 43564.0, 43641.12717745564, 33910.0, 34596.48105278473, 35884.641153589175, 36091.81954090213, 36249.0, 25530.872345638152, 26729.0, 26931.0, 26953.191404257905, 27170.72829271682], "value": 18033.09429264826, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.4741614007042, 568.5565259097903, 573.4638113364005, 592.2330581896445, 598.8323269484544, 22482.43793905153, 23605.527889442244, 23867.045318187273, 23874.40313992151, 23901.64147537784, 23614.0, 24290.0, 24407.51184976304, 24539.14113006041, 24754.75245247547, 6324.873502529947, 6408.967955160218, 6455.741770329181, 6461.935380646204, 6471.255805582371, 6309.242890853081, 6368.586041907284, 6368.9681551592175, 6372.203474565679, 6399.584027038228, 5771.105478650816, 5954.791582294621, 6309.116723658692, 6340.968295158517, 6345.397187267202, 6275.68621568922, 6280.937190628104, 6299.244090709144, 6322.0, 6322.083297921821, 5812.854678633025, 5860.0, 5880.470757631833, 5888.057910734305, 5902.321233058167, 30036.399272014656, 31044.0, 31382.372352552822, 31450.685493145003, 31560.36879262402, 2173.3914503938922, 2229.2866282789514, 2230.3643461613524, 2241.0251540579898, 2256.8194544436406, 18837.811621883742, 19356.32252871143, 19365.80634193668, 19376.612467750707, 19402.0, 2322.7212734471805, 2383.13015749252, 2404.446977195237, 2428.805695544352, 2442.8778561071877, 153008.0, 154209.0, 155908.0, 157650.0, 158589.207053964, 14996.775048374284, 15767.29047192879, 15935.123568203628, 16055.598610034842, 16170.27233774483, 24227.878860605586, 24260.272191834272, 24373.26880193597, 24416.755832441802, 24427.0, 10090.09189172978, 10140.239482038876, 10195.490225488697, 10204.948975255225, 10257.230707696952, 8947.731568052968, 8981.371304008788, 8983.011868694439, 8994.460332380078, 9068.093190680878, 9199.632014719336, 9506.572204250826, 9560.474173920502, 9653.855192172123, 9845.458499782437, 2725.4004119093765, 2757.9172624821285, 2779.70743604221, 2808.1014075495646, 2835.7306055924655, 1021.279997601689, 1036.08306648615, 1043.8225501664583, 1056.9471526423647, 1059.2691043180334, 21148.0, 21202.469938251666, 21355.46611334729, 21598.0, 21934.232301869357, 1071.116329028539, 1095.2880627592128, 1095.6932059023486, 1096.091698396076, 1113.5156207049959, 11616.303021818718, 11644.88355116455, 11723.648290551297, 11841.171118021655, 11868.762624747456, 598040.0, 601339.0, 622968.0, 626304.0, 627639.0, 123371.0, 129454.0, 129824.0, 130270.0, 132218.0, 1096.9122470202524, 1102.873169585492, 1113.7494063835572, 1121.4560937945091, 1128.2891778179694, 18131.728024079912, 18961.620767584845, 19055.90472047631, 19273.903630481756, 19401.70897436568, 61828.690856547226, 62491.0, 63306.0, 63538.36461635325, 65186.348136519926, 80102.0, 81536.59231703804, 82224.58887705523, 82467.17532824836, 82531.5873420629, 14117.223552704289, 14214.28928553589, 14314.355853986388, 14948.551543453714, 15040.473583424966, 23644.645330319716, 23761.811909404805, 23997.760022399554, 24323.148689795773, 24471.143509977064, 19017.33439329617, 19308.0, 19604.01979901028, 19663.70504442406, 19666.311679091163, 16435.83564164343, 16629.91685041567, 17058.31766729317, 17201.311947521957, 17797.377091801725, 17586.472405827844, 17600.647987040444, 17611.647767044844, 17627.942323460633, 19744.21023159115, 14765.926170369079, 14782.113073215642, 14793.186374749492, 14798.6300342488, 14812.037217580822, 16752.246148923572, 17279.56801079933, 18568.721469177704, 18654.626907461505, 18899.527511812314], "value": 12351.05707751517, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1403.235236795946, 1432.1836553164694, 1465.2966576043505, 1471.1834931612957, 1481.7036592681463, 14865.331060102295, 15693.686126277467, 15698.76451853223, 15711.292991815368, 15751.921240393782, 15142.848571514309, 15439.536813895573, 15461.458848940289, 15501.06993580386, 15513.84486155138, 2601.9609705854427, 2640.115561286971, 2644.9867750661315, 2653.150991682662, 2664.893404263827, 2566.8331558448735, 2633.0, 2641.590553464216, 2651.9469610607775, 2653.60195970605, 2492.3519884829893, 2591.080166540879, 2591.987040064797, 2604.3619313268277, 2628.894844206239, 2648.2055383385004, 2696.4067905060856, 2696.5685490321453, 2697.9190624281305, 2699.9730002699916, 2562.8211022929477, 2584.37974886026, 2599.077327548731, 2602.5445547029385, 2631.907883224078, 14206.289685515683, 14373.281335933267, 14381.712365752626, 14382.208978506178, 14607.78088328676, 7915.0, 8168.0, 8216.383771217183, 8246.917530824734, 8255.133211012817, 5157.4068982067165, 5262.8684282892855, 5356.571474282048, 5446.21029950655, 5457.372402173761, 1890.3856246719872, 1891.6878715012006, 1900.5577832485328, 1952.7070939359069, 1954.765428148617, 26834.865825670942, 27473.587896181572, 27492.862535687193, 27497.587536186973, 27541.586876196674, 7251.8187045324285, 7454.2545745426105, 7499.587522686195, 7538.585377804274, 7625.6568454419685, 20322.187112515334, 20482.0, 20504.282350117675, 20524.897375513327, 20528.794712052986, 8191.098979112293, 8529.360297977677, 8536.274416674529, 8536.573171341408, 8538.231559159705, 6783.152105986752, 7151.355188306615, 7156.570605763671, 7250.347468727839, 7616.69533218665, 5222.791088356499, 5414.648047876875, 5430.51125398716, 5443.727813609383, 5470.194835704208, 1589.2053973013494, 1601.49552890839, 1602.5032240005635, 1610.55709679839, 1619.0771260381468, 902.273669695901, 905.7282815155427, 909.5861383070687, 934.9111834375724, 941.6892425499568, 7658.387329013665, 7866.567338796421, 7870.212978702199, 7934.523928564305, 7976.322012628875, 727.6834576959039, 747.114669117098, 752.868248056588, 755.9395248380116, 772.204629231892, 4735.739534325577, 4760.833370832004, 4768.809247630056, 4822.9758851205515, 4901.872569309079, 20339.18643254283, 21108.577828443653, 21230.363089107042, 21475.57048859014, 21510.784892150878, 20496.38510844677, 20786.58426831455, 21081.472963176042, 21229.893850530647, 21584.78415215859, 11800.0, 11900.523979040914, 11947.999999999825, 11991.22057066288, 12039.157258991787, 7782.766517004499, 8141.267285944294, 8260.173982601691, 8358.874616880874, 8479.15208479147, 18286.908565457088, 18468.63062738711, 18892.716609251147, 19468.0, 19804.60390792147, 18506.907465462587, 19296.8070319295, 19523.51191220174, 19715.40853774389, 20080.39758807238, 12684.492620295085, 12966.35168241603, 12972.8054079187, 12978.80531792005, 12990.740185196055, 14333.0, 14464.20446875432, 14481.493147739779, 14504.637384065483, 14505.4923077696, 10966.616168434066, 11026.50380732885, 11082.61210857616, 11144.88855111471, 11717.472713727731, 10881.401522916316, 11036.5033573491, 11355.602553910574, 11632.18574699763, 11792.29246245228, 10014.849777253492, 10130.290879638354, 10132.189424846141, 10136.94931525367, 10184.847227291448, 7387.482876198829, 7765.107012693613, 7766.5728384939375, 7791.415643826849, 7862.606869656609, 7589.013428254512, 7631.503952243086, 7834.608269586612, 7877.724279650185, 7886.645100970585], "value": 6744.356980325426, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [488.1712354487419, 501.7106037483666, 520.0171675533242, 523.8009556368581, 524.3419508516811, 6027.819165425039, 6080.753445543664, 6125.173101631279, 6125.6018358806705, 6162.352952939933, 5789.565782566314, 5935.554833387502, 5986.221791167153, 5995.280566332035, 6009.218801555802, 4664.930026049612, 4679.344891715163, 4697.365855609501, 4718.834840780573, 4736.147493451177, 4678.181318269306, 4696.225122854725, 4716.551927566876, 4751.5010923853015, 4785.856424307276, 4528.501864794886, 4648.558386953234, 4696.412948381452, 4707.882302942437, 4728.172569800288, 4596.49438561758, 4617.261238201889, 4636.53634636537, 4663.533646635309, 4696.201645720235, 4262.914741705148, 4272.423222864904, 4280.315149576084, 4289.528151903288, 4296.935545966813, 5920.674362910038, 5927.555433342516, 5935.317438494585, 5957.851053723648, 5977.462028417463, 5603.467670571289, 5641.153826925953, 5649.322081350264, 5658.603897727161, 5677.233573467571, 6398.784230996096, 6416.0, 6490.578112422724, 6508.25155107164, 6534.8366290843105, 4807.855764327041, 4820.662553621248, 4868.659193856432, 4883.267509873512, 4892.535209155125, 6709.798706038827, 6785.2858856457315, 6786.253512113663, 6796.728130874809, 6825.283345248727, 4986.401631804207, 4990.176620857518, 5021.322121513549, 5029.27075574047, 5041.294218809369, 5025.6482046256415, 5038.64729468941, 5081.23781432788, 5101.795928162906, 5113.724392645311, 5599.816071732028, 5606.6916319602, 5649.514213745939, 5656.717164141859, 5659.151127330933, 6442.323556026643, 6498.245473722069, 6514.478841692653, 6565.376289252514, 6578.506612004119, 1750.264888746704, 1758.9648207036043, 1759.8944063355984, 1777.7155655095123, 1780.9670391173088, 1145.0381679389352, 1154.9364784936909, 1227.490591404557, 1227.9815802762967, 1239.7520495900856, 6063.7574497020505, 6066.636001839815, 6130.540209484307, 6136.969315153396, 6153.815385538441, 6557.901631475532, 6571.54993628349, 6587.308332625101, 6631.137952066297, 6652.96673516639, 6115.877682446415, 6117.785877494355, 6188.659623720739, 6217.347178546278, 6217.751289948352, 3405.1487128217946, 3460.982695086559, 3463.480477928331, 3472.201393679468, 3479.7216222702123, 6905.136857892763, 6936.237013928464, 6938.271481494471, 6939.826504337432, 7023.262557431498, 6803.761868334684, 6808.795736127924, 6818.3976765460075, 6819.147606549182, 6833.658317084126, 6941.95870619401, 6982.2319544850025, 6987.336203060803, 7015.36861682451, 7015.579065256101, 6628.0, 6634.270230274762, 6656.0, 6661.16735408074, 6677.83305417349, 6401.167848179707, 6467.967660161669, 6478.578892371981, 6516.73933042692, 6553.901691474727, 6842.384185423336, 6863.313668633296, 6884.724611015503, 6910.274421185703, 6951.409130223988, 4952.133376659142, 4952.752362381794, 4968.726720030433, 4971.931034827529, 5012.498750124958, 6627.072209890523, 6628.304028077176, 6642.169728783902, 6653.800385988428, 6738.898916516158, 6356.650384228727, 6369.363063693593, 6405.487560995202, 6440.742370305135, 6449.838754031187, 6362.809115726535, 6366.458850997532, 6421.848680692021, 6463.385978332051, 6482.7034593080625, 6277.686115694289, 6306.779262725782, 6361.968190159019, 6381.680915954091, 6402.519811014099, 5973.820785376446, 6323.715432805627, 6416.165898433173, 6491.805245842632, 6524.739010439719, 6217.036359364306, 6265.0, 6279.686015699105, 6342.270638876404, 6366.172397588284], "value": 5011.289374782193, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [885.163520473153, 902.5667679513829, 917.3211823250795, 928.6424726480303, 939.9859002114973, 16534.33862645494, 16875.746863797038, 18234.81765182348, 18875.15061822218, 18911.716324255114, 16027.679446411064, 16094.275757590907, 16160.595985100379, 16598.0, 18917.810821891777, 1045.508610952853, 1053.9894601054007, 1057.1701214546583, 1060.7401186709267, 1062.6865074802952, 1072.3780207479642, 1073.0235485708008, 1076.2251179150999, 1076.9299995500307, 1077.536659236528, 1137.0448822988687, 1138.4535422996967, 1141.4863311509812, 1141.680329507739, 1142.2860712054965, 1048.6644273832376, 1109.805783987807, 1120.8991190792826, 1133.7505748735266, 1136.8806275341094, 814.9511029338258, 821.6343727041469, 821.9178082191793, 822.8971378577678, 823.069930977991, 18533.166007529693, 18987.240510379568, 19053.61892762137, 19095.90452047745, 19259.51851203717, 16789.32842686291, 17530.38643647479, 17652.11739413024, 17692.203850826743, 17889.10554472271, 14695.853041469556, 15286.082835029823, 15310.0, 15315.0, 15358.692826143526, 3429.6741809528053, 3430.5711786026745, 3450.0857272822473, 3450.4996775467416, 3453.3783918894587, 88477.46090156451, 122161.0, 123091.0, 125660.37169814092, 130513.0, 13232.867671323163, 13592.796108058386, 13616.455341786415, 13797.586072417844, 14887.851121488864, 29577.408451830845, 30616.693833061385, 30914.69085309163, 31096.44517774102, 31311.217219569236, 8368.665253389796, 8500.44747091437, 8508.319334453228, 8660.610272537751, 8731.170538798804, 4235.174141042528, 4335.1329734053315, 4365.585269399402, 4370.21336159488, 4370.38814565961, 5351.652142610717, 5382.0, 5399.649022813504, 5488.286522752097, 5497.202905578669, 1092.5192915117323, 1106.7880670665609, 1108.6507750058706, 1109.8335249712445, 1111.394290111891, 706.8162277807807, 720.7945735465368, 728.0244472406894, 737.6791095873313, 744.0, 12745.490180392866, 13049.869501305055, 13128.409221585052, 13226.801597976038, 13520.18878867271, 661.9238787539495, 682.2597481732377, 693.5873155472486, 701.0850839654198, 702.3222590200481, 5623.878747295209, 6084.5436592255755, 6141.263048434216, 6223.439890409885, 6294.622322660655, 110938.0, 113872.0, 115018.0, 116206.41896790462, 117563.0, 100860.0, 101523.0, 102009.48995255124, 103135.0, 105320.0, 83522.0, 86796.13203868007, 90274.54862725644, 91853.5407322959, 92260.53869730608, 11155.553777848796, 11809.881901180877, 12055.276683399024, 12094.274343539415, 12183.878161218274, 45955.310670339306, 46758.76620616875, 46780.29829552492, 47164.52835471739, 48469.75765121293, 55158.44841551533, 56608.71695641495, 57904.4209557899, 58029.4197058024, 58564.4143558576, 16601.75097373516, 16634.916825415796, 16706.331746729993, 16943.57641058934, 16946.40687575929, 15590.454334098253, 16096.27566759522, 16274.755878661592, 16326.510204693877, 16667.83332166663, 15266.160361179798, 15302.234888255765, 15466.458673946358, 15724.764128537852, 15763.448279310169, 14884.553463396116, 15069.17119558391, 15207.543773686808, 15223.619409514851, 15298.923505382401, 15651.843481565038, 16273.918630406772, 16394.83605163933, 16571.254293556576, 16893.91553042227, 11464.541418343173, 11516.30902145874, 11615.361155136548, 11747.941260293986, 11835.408229588658, 13499.190048597116, 14103.647408814863, 14345.426182952566, 14385.280735962951, 14449.49426770058], "value": 8889.958228011248, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1485.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 99.0, 109.0, 107.0, 110.0, 109.0, 108.0, 107.0, 107.0, 107.0], "value": 107.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 115.0, 141.0, 166.0, 116.0, 145.0, 148.0, 116.0, 166.0, 116.0], "value": 137.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 163.0, 170.0, 161.0, 161.0, 160.0, 166.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 73.0, 73.0, 76.0, 73.0, 164.0, 74.0, 74.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 137.0, 81.0, 81.0, 80.0, 125.0, 80.0, 80.0, 130.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 113.0, 114.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 154.0, 147.0, 148.0, 148.0, 148.0, 148.0, 149.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 47.0, 48.0, 47.0, 48.0, 48.0, 54.0, 49.0, 48.0, 47.0], "value": 48.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 54.0, 55.0, 54.0, 56.0, 54.0, 54.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 76.0, 75.0, 86.0, 76.0, 76.0, 75.0, 81.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 128.0, 128.0, 125.0, 123.0, 117.0, 123.0, 119.0, 118.0, 148.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 184.0, 175.0, 172.0, 177.0, 175.0, 173.0, 170.0, 174.0, 166.0], "value": 173.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 62.0, 62.0, 63.0, 63.0, 63.0, 64.0, 61.0, 64.0], "value": 62.8, "unit": "score"}]}]} 03:20:33 INFO - Return code: 0 03:20:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:20:33 INFO - # TBPL SUCCESS # 03:20:33 INFO - Running post-action listener: _package_coverage_data 03:20:33 INFO - Running post-action listener: _resource_record_post_action 03:20:33 INFO - [mozharness: 2017-07-16 10:20:33.990075Z] Finished run-tests step (success) 03:20:33 INFO - Running post-run listener: _resource_record_post_run 03:20:34 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 5799936; Write bytes: 442253312; Read time: 2288; Write time: 366628 03:20:34 INFO - TinderboxPrint: CPU usage
13.0% 03:20:34 INFO - TinderboxPrint: I/O read bytes / time
5,799,936 / 2,288 03:20:34 INFO - TinderboxPrint: I/O write bytes / time
442,253,312 / 366,628 03:20:34 INFO - TinderboxPrint: CPU idle
8,260.9 (87.0%) 03:20:34 INFO - TinderboxPrint: CPU user
1,186.7 (12.5%) 03:20:34 INFO - TinderboxPrint: Swap in / out
0 / 0 03:20:34 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 8192; Write bytes: 120934400; Read time: 288; Write time: 112440 03:20:34 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:20:34 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 3420160; Write bytes: 321318912; Read time: 1608; Write time: 254188 03:20:34 INFO - Running post-run listener: _upload_blobber_files 03:20:34 INFO - Blob upload gear active. 03:20:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:20:34 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 03:20:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:20:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:20:35 INFO - Traceback (most recent call last): 03:20:35 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 03:20:35 INFO - main() 03:20:35 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 03:20:35 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 03:20:35 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 03:20:35 INFO - return set(response.json().get('whitelist', [])) 03:20:35 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 03:20:35 INFO - return json.loads(self.text or self.content, **kwargs) 03:20:35 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 03:20:35 INFO - return _default_decoder.decode(s) 03:20:35 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 03:20:35 INFO - obj, end = self.raw_decode(s) 03:20:35 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 03:20:35 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 03:20:35 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 03:20:35 ERROR - Return code: 1 03:20:35 INFO - Setting buildbot property blobber_files to {} 03:20:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:20:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:20:35 INFO - Contents: 03:20:35 INFO - blobber_files:{} 03:20:35 INFO - Running post-run listener: copy_logs_to_upload_dir 03:20:35 INFO - Copying logs to upload dir... 03:20:35 INFO - mkdir: /builds/slave/test/build/upload/logs 03:20:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.317502 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-07-16 03:20:35.136822) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-16 03:20:35.144542) ========= 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=fa44defc139c4ba8574fe040000001db-1500198110.462652-402112138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/aur2h2bgQum-Gi7Kq6lexA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011215 build_url: 'https://queue.taskcluster.net/v1/task/aur2h2bgQum-Gi7Kq6lexA/artifacts/public/build/target.tar.bz2' blobber_files: '{}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-16 03:20:35.202344) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 03:20:35.202755) ========= 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=fa44defc139c4ba8574fe040000001db-1500198110.462652-402112138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004435 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 03:20:35.258954) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-16 03:20:35.259305) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-16 03:20:35.259611) ========= ========= Total master_lag: 0.20 =========