builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-079 starttime: 1504142684.67 results: success (0) revision: d9b405d82cffb07343a5f2fd941e029298c7f6c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-30 18:24:44.674731) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-30 18:24:44.675191) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-30 18:24:44.675525) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-30 18:24:44.691766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 18:24:44.692082) ========= 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=1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-30 18:24:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 54.3M=0s 2017-08-30 18:24:44 (54.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.180681 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 18:24:44.905307) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 18:24:44.905634) ========= 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=1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014235 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 18:24:44.955722) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 18:24:44.956099) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d9b405d82cffb07343a5f2fd941e029298c7f6c4 --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 d9b405d82cffb07343a5f2fd941e029298c7f6c4 --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=1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-30 18:24:45,008 truncating revision to first 12 chars 2017-08-30 18:24:45,008 Setting DEBUG logging. 2017-08-30 18:24:45,008 attempt 1/10 2017-08-30 18:24:45,008 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d9b405d82cff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-30 18:24:45,530 unpacking tar archive at: mozilla-central-d9b405d82cff/testing/mozharness/ program finished with exit code 0 elapsedTime=0.902358 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 18:24:45.873201) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-30 18:24:45.873572) ========= script_repo_revision: d9b405d82cffb07343a5f2fd941e029298c7f6c4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-30 18:24:45.873960) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-30 18:24:45.874226) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-30 18:24:45.886073) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-08-30 18:24:45.886399) ========= /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=1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:24:46 INFO - MultiFileLogger online at 20170830 18:24:46 in /builds/slave/test 18:24:46 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 18:24:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:24:46 INFO - {'append_to_log': False, 18:24:46 INFO - 'base_work_dir': '/builds/slave/test', 18:24:46 INFO - 'blob_upload_branch': 'Firefox', 18:24:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:24:46 INFO - 'branch': 'Firefox', 18:24:46 INFO - 'buildbot_json_path': 'buildprops.json', 18:24:46 INFO - 'code_coverage': False, 18:24:46 INFO - 'config_files': ('talos/linux_config.py',), 18:24:46 INFO - 'default_actions': ('clobber', 18:24:46 INFO - 'read-buildbot-config', 18:24:46 INFO - 'download-and-extract', 18:24:46 INFO - 'populate-webroot', 18:24:46 INFO - 'create-virtualenv', 18:24:46 INFO - 'install', 18:24:46 INFO - 'setup-mitmproxy', 18:24:46 INFO - 'run-tests'), 18:24:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:24:46 INFO - 'disable_ccov_upload': False, 18:24:46 INFO - 'disable_stylo': False, 18:24:46 INFO - 'download_minidump_stackwalk': True, 18:24:46 INFO - 'download_symbols': 'ondemand', 18:24:46 INFO - 'enable_stylo': False, 18:24:46 INFO - 'enable_webrender': False, 18:24:46 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 18:24:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:24:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:24:46 INFO - 'gecko_profile': False, 18:24:46 INFO - 'gecko_profile_interval': 0, 18:24:46 INFO - 'installer_path': 'installer.exe', 18:24:46 INFO - 'log_level': 'info', 18:24:46 INFO - 'log_name': 'talos', 18:24:46 INFO - 'log_to_console': True, 18:24:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:24:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:24:46 INFO - 'opt_config_files': (), 18:24:46 INFO - 'pip_index': False, 18:24:46 INFO - 'suite': 'dromaeojs-e10s', 18:24:46 INFO - 'system_bits': '32', 18:24:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:24:46 INFO - 'title': 'talos-linux64-ix-079', 18:24:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:24:46 INFO - 'use_talos_json': True, 18:24:46 INFO - 'verify': 'False', 18:24:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:24:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:24:46 INFO - 'work_dir': 'build'} 18:24:46 INFO - [mozharness: 2017-08-31 01:24:46.198878Z] Running clobber step. 18:24:46 INFO - Running pre-action listener: _resource_record_pre_action 18:24:46 INFO - Running main action method: clobber 18:24:46 INFO - rmtree: /builds/slave/test/build 18:24:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:24:47 INFO - Running post-action listener: _resource_record_post_action 18:24:47 INFO - [mozharness: 2017-08-31 01:24:47.173062Z] Finished clobber step (success) 18:24:47 INFO - [mozharness: 2017-08-31 01:24:47.173157Z] Running read-buildbot-config step. 18:24:47 INFO - Running pre-action listener: _resource_record_pre_action 18:24:47 INFO - Running main action method: read_buildbot_config 18:24:47 INFO - Using buildbot properties: 18:24:47 INFO - { 18:24:47 INFO - "project": "", 18:24:47 INFO - "product": "firefox", 18:24:47 INFO - "who": "kwierso@gmail.com", 18:24:47 INFO - "installer_path": "public/build/target.tar.bz2", 18:24:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:24:47 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 18:24:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 18:24:47 INFO - "stage_platform": "linux64-pgo", 18:24:47 INFO - "basedir": "/builds/slave/test", 18:24:47 INFO - "buildnumber": 149, 18:24:47 INFO - "platform": "ubuntu64_hw", 18:24:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:24:47 INFO - "slavebuilddir": "test", 18:24:47 INFO - "taskId": "Od2s5nTxSKC2BEniYi6eWg", 18:24:47 INFO - "branch": "mozilla-central", 18:24:47 INFO - "script_repo_revision": "production", 18:24:47 INFO - "revision": "d9b405d82cffb07343a5f2fd941e029298c7f6c4", 18:24:47 INFO - "slavename": "talos-linux64-ix-079", 18:24:47 INFO - "repo_path": "mozilla-central" 18:24:47 INFO - } 18:24:47 INFO - Finding installer, test and symbols from parent task. 18:24:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Od2s5nTxSKC2BEniYi6eWg'}, attempt #1 18:24:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Od2s5nTxSKC2BEniYi6eWg'}, attempt #1 18:24:48 INFO - Task dependencies: MEo91bGsToSiyg6RI0hmpw 18:24:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MEo91bGsToSiyg6RI0hmpw'}, attempt #1 18:24:48 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MEo91bGsToSiyg6RI0hmpw/artifacts/public/build/target.tar.bz2 18:24:48 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/MEo91bGsToSiyg6RI0hmpw/artifacts/public/build/target.test_packages.json 18:24:48 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MEo91bGsToSiyg6RI0hmpw/artifacts/public/build/target.crashreporter-symbols.zip 18:24:48 INFO - Running post-action listener: _resource_record_post_action 18:24:48 INFO - [mozharness: 2017-08-31 01:24:48.631895Z] Finished read-buildbot-config step (success) 18:24:48 INFO - [mozharness: 2017-08-31 01:24:48.632110Z] Running download-and-extract step. 18:24:48 INFO - Running pre-action listener: _resource_record_pre_action 18:24:48 INFO - Running main action method: download_and_extract 18:24:48 INFO - mkdir: /builds/slave/test/build/tests 18:24:48 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')]} 18:24:48 INFO - trying https://queue.taskcluster.net/v1/task/MEo91bGsToSiyg6RI0hmpw/artifacts/public/build/target.test_packages.json 18:24:48 INFO - Downloading https://queue.taskcluster.net/v1/task/MEo91bGsToSiyg6RI0hmpw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:24:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MEo91bGsToSiyg6RI0hmpw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:24:49 INFO - Downloaded 989 bytes. 18:24:49 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:24:49 INFO - Using the following test package requirements: 18:24:49 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:24:49 INFO - u'common': [u'target.common.tests.zip'], 18:24:49 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:24:49 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:24:49 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:24:49 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:24:49 INFO - u'mozbase': [u'target.common.tests.zip'], 18:24:49 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:24:49 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:24:49 INFO - u'web-platform': [u'target.common.tests.zip', 18:24:49 INFO - u'target.web-platform.tests.tar.gz'], 18:24:49 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:24:49 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:24:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MEo91bGsToSiyg6RI0hmpw/artifacts/public/build/target.common.tests.zip 18:24:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MEo91bGsToSiyg6RI0hmpw/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:24:49 INFO - Fetch https://queue.taskcluster.net/v1/task/MEo91bGsToSiyg6RI0hmpw/artifacts/public/build/target.common.tests.zip into memory 18:24:50 INFO - Content-Length response header: 55590011 18:24:50 INFO - Bytes received: 55590011 18:25:01 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:25:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MEo91bGsToSiyg6RI0hmpw/artifacts/public/build/target.common.tests.zip 18:25:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MEo91bGsToSiyg6RI0hmpw/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:25:01 INFO - Fetch https://queue.taskcluster.net/v1/task/MEo91bGsToSiyg6RI0hmpw/artifacts/public/build/target.common.tests.zip into memory 18:25:02 INFO - Content-Length response header: 55590011 18:25:02 INFO - Bytes received: 55590011 18:25:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MEo91bGsToSiyg6RI0hmpw/artifacts/public/build/target.talos.tests.zip 18:25:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MEo91bGsToSiyg6RI0hmpw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:25:14 INFO - Fetch https://queue.taskcluster.net/v1/task/MEo91bGsToSiyg6RI0hmpw/artifacts/public/build/target.talos.tests.zip into memory 18:25:15 INFO - Content-Length response header: 14496650 18:25:15 INFO - Bytes received: 14496650 18:25:16 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')]} 18:25:16 INFO - trying https://queue.taskcluster.net/v1/task/MEo91bGsToSiyg6RI0hmpw/artifacts/public/build/target.tar.bz2 18:25:16 INFO - Downloading https://queue.taskcluster.net/v1/task/MEo91bGsToSiyg6RI0hmpw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:25:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MEo91bGsToSiyg6RI0hmpw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:25:17 INFO - Downloaded 63318736 bytes. 18:25:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MEo91bGsToSiyg6RI0hmpw/artifacts/public/build/target.tar.bz2 18:25:17 INFO - mkdir: /builds/slave/test/properties 18:25:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:25:17 INFO - Writing to file /builds/slave/test/properties/build_url 18:25:17 INFO - Contents: 18:25:17 INFO - build_url:https://queue.taskcluster.net/v1/task/MEo91bGsToSiyg6RI0hmpw/artifacts/public/build/target.tar.bz2 18:25:17 INFO - Running post-action listener: _resource_record_post_action 18:25:17 INFO - Running post-action listener: find_tests_for_verification 18:25:17 INFO - Running post-action listener: set_extra_try_arguments 18:25:17 INFO - [mozharness: 2017-08-31 01:25:17.483111Z] Finished download-and-extract step (success) 18:25:17 INFO - [mozharness: 2017-08-31 01:25:17.483233Z] Running populate-webroot step. 18:25:17 INFO - Running pre-action listener: _resource_record_pre_action 18:25:17 INFO - Running main action method: populate_webroot 18:25:17 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:25:17 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 18:25:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:25:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:25:17 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 18:25:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:25:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:25:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:25:17 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:25:17 INFO - 'talos_options': ['--enable-stylo'], 18:25:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:25:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:25:17 INFO - 'tests': ['damp', 'tps']}, 18:25:17 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:25:17 INFO - 'talos_options': ['--enable-stylo'], 18:25:17 INFO - 'tests': ['damp', 'tps']}, 18:25:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:25:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:25:17 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 18:25:17 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:25:17 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:25:17 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:25:17 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:25:17 INFO - 'talos_options': ['--enable-stylo'], 18:25:17 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:25:17 INFO - 'other-e10s': {'tests': ['a11yr', 18:25:17 INFO - 'ts_paint', 18:25:17 INFO - 'tpaint', 18:25:17 INFO - 'sessionrestore', 18:25:17 INFO - 'sessionrestore_many_windows', 18:25:17 INFO - 'sessionrestore_no_auto_restore', 18:25:17 INFO - 'tabpaint']}, 18:25:17 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 18:25:17 INFO - 'tests': ['a11yr', 18:25:17 INFO - 'ts_paint', 18:25:17 INFO - 'tpaint', 18:25:17 INFO - 'sessionrestore', 18:25:17 INFO - 'sessionrestore_many_windows', 18:25:17 INFO - 'sessionrestore_no_auto_restore', 18:25:17 INFO - 'tabpaint']}, 18:25:17 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:25:17 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:25:17 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 18:25:17 INFO - 'tests': ['bloom_basic_singleton']}, 18:25:17 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 18:25:17 INFO - 'tests': ['bloom_basic']}, 18:25:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:25:17 INFO - 'tsvgr_opacity', 18:25:17 INFO - 'tart', 18:25:17 INFO - 'tscrollx', 18:25:17 INFO - 'tsvg_static']}, 18:25:17 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 18:25:17 INFO - 'tests': ['tsvgx', 18:25:17 INFO - 'tsvgr_opacity', 18:25:17 INFO - 'tart', 18:25:17 INFO - 'tscrollx', 18:25:17 INFO - 'tsvg_static']}, 18:25:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:25:17 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:25:17 INFO - 'talos_options': ['--enable-stylo'], 18:25:17 INFO - 'tests': ['tp5o']}, 18:25:17 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:25:17 INFO - 'talos_options': ['--mitmproxy', 18:25:17 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:25:17 INFO - '--firstNonBlankPaint'], 18:25:17 INFO - 'tests': ['tp6_google', 18:25:17 INFO - 'tp6_youtube', 18:25:17 INFO - 'tp6_amazon', 18:25:17 INFO - 'tp6_facebook']}, 18:25:17 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:25:17 INFO - 'talos_options': ['--enable-stylo', 18:25:17 INFO - '--mitmproxy', 18:25:17 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:25:17 INFO - '--firstNonBlankPaint'], 18:25:17 INFO - 'tests': ['tp6_google', 18:25:17 INFO - 'tp6_youtube', 18:25:17 INFO - 'tp6_amazon', 18:25:17 INFO - 'tp6_facebook']}, 18:25:17 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:25:17 INFO - 'talos_options': ['--enable-stylo', 18:25:17 INFO - '--stylo-threads=1', 18:25:17 INFO - '--mitmproxy', 18:25:17 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:25:17 INFO - '--firstNonBlankPaint'], 18:25:17 INFO - 'tests': ['tp6_google', 18:25:17 INFO - 'tp6_youtube', 18:25:17 INFO - 'tp6_amazon', 18:25:17 INFO - 'tp6_facebook']}, 18:25:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:25:17 INFO - 'talos_options': ['--xperf_path', 18:25:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:25:17 INFO - 'tests': ['tp5n']}, 18:25:17 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:25:17 INFO - 'talos_options': ['--enable-stylo', 18:25:17 INFO - '--xperf_path', 18:25:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:25:17 INFO - 'tests': ['tp5n']}}} 18:25:17 INFO - Running post-action listener: _resource_record_post_action 18:25:17 INFO - [mozharness: 2017-08-31 01:25:17.500125Z] Finished populate-webroot step (success) 18:25:17 INFO - [mozharness: 2017-08-31 01:25:17.500214Z] Running create-virtualenv step. 18:25:17 INFO - Running pre-action listener: _resource_record_pre_action 18:25:17 INFO - Running main action method: create_virtualenv 18:25:17 INFO - Creating virtualenv /builds/slave/test/build/venv 18:25:17 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:25:17 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 18:25:17 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:25:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:25:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:25:18 INFO - Installing distribute.............................................................................................................................................................................................done. 18:25:19 INFO - Installing pip...............done. 18:25:19 INFO - Return code: 0 18:25:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:25:19 INFO - Reading from file tmpfile_stdout 18:25:19 INFO - Output received: 18:25:19 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 18:25:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:25:19 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')]} 18:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:19 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')]} 18:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:19 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 0x178c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afbb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af8580>, '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 0x1af9480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af9910>, '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': '1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238', '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 18:25:19 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 18:25:19 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 18:25:19 INFO - Using env: {'DISPLAY': ':0', 18:25:19 INFO - 'HOME': '/home/cltbld', 18:25:19 INFO - 'LANG': 'en_US.UTF-8', 18:25:19 INFO - 'LANGUAGE': 'en_US:en', 18:25:19 INFO - 'LOGNAME': 'cltbld', 18:25:19 INFO - 'MAIL': '/var/mail/cltbld', 18:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:19 INFO - 'MOZ_NO_REMOTE': '1', 18:25:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:19 INFO - 'NO_EM_RESTART': '1', 18:25:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:19 INFO - 'PWD': '/builds/slave/test', 18:25:19 INFO - 'SHELL': '/bin/bash', 18:25:19 INFO - 'SHLVL': '1', 18:25:19 INFO - 'TERM': 'linux', 18:25:19 INFO - 'TMOUT': '86400', 18:25:19 INFO - 'USER': 'cltbld', 18:25:19 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238', 18:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:19 INFO - '_': '/tools/buildbot/bin/python'} 18:25:21 INFO - Ignoring indexes: http://pypi.python.org/simple/ 18:25:21 INFO - Downloading/unpacking pip>=1.5 18:25:21 INFO - Running setup.py egg_info for package pip 18:25:21 INFO - warning: no files found matching 'pip/cacert.pem' 18:25:21 INFO - warning: no files found matching '*.html' under directory 'docs' 18:25:21 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:25:21 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:25:21 INFO - Installing collected packages: pip 18:25:21 INFO - Found existing installation: pip 1.1 18:25:21 INFO - Uninstalling pip: 18:25:21 INFO - Successfully uninstalled pip 18:25:21 INFO - Running setup.py install for pip 18:25:21 INFO - warning: no files found matching 'pip/cacert.pem' 18:25:21 INFO - warning: no files found matching '*.html' under directory 'docs' 18:25:21 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:25:21 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:25:21 INFO - Installing pip script to /builds/slave/test/build/venv/bin 18:25:21 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 18:25:21 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 18:25:21 INFO - Successfully installed pip 18:25:21 INFO - Cleaning up... 18:25:21 INFO - Return code: 0 18:25:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:25:21 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')]} 18:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:21 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')]} 18:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:21 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 0x178c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afbb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af8580>, '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 0x1af9480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af9910>, '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': '1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238', '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 18:25:21 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 18:25:21 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 18:25:21 INFO - Using env: {'DISPLAY': ':0', 18:25:21 INFO - 'HOME': '/home/cltbld', 18:25:21 INFO - 'LANG': 'en_US.UTF-8', 18:25:21 INFO - 'LANGUAGE': 'en_US:en', 18:25:21 INFO - 'LOGNAME': 'cltbld', 18:25:21 INFO - 'MAIL': '/var/mail/cltbld', 18:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:21 INFO - 'MOZ_NO_REMOTE': '1', 18:25:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:21 INFO - 'NO_EM_RESTART': '1', 18:25:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:21 INFO - 'PWD': '/builds/slave/test', 18:25:21 INFO - 'SHELL': '/bin/bash', 18:25:21 INFO - 'SHLVL': '1', 18:25:21 INFO - 'TERM': 'linux', 18:25:21 INFO - 'TMOUT': '86400', 18:25:21 INFO - 'USER': 'cltbld', 18:25:21 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238', 18:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:21 INFO - '_': '/tools/buildbot/bin/python'} 18:25:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:21 INFO - Downloading/unpacking psutil>=3.1.1 18:25:21 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 18:25:21 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 18:25:21 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 18:25:21 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 18:25:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:25:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:25:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:25:23 INFO - Installing collected packages: psutil 18:25:23 INFO - Running setup.py install for psutil 18:25:23 INFO - building 'psutil._psutil_linux' extension 18:25:23 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 18:25:23 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 18:25:23 INFO - building 'psutil._psutil_posix' extension 18:25:23 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 18:25:24 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 18:25:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:25:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:25:24 INFO - Successfully installed psutil 18:25:24 INFO - Cleaning up... 18:25:24 INFO - Return code: 0 18:25:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:25: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')]} 18:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25: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')]} 18:25:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afbb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af8580>, '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 0x1af9480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af9910>, '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': '1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238', '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 18:25: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:25: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 mozsystemmonitor==0.3 18:25:24 INFO - Using env: {'DISPLAY': ':0', 18:25:24 INFO - 'HOME': '/home/cltbld', 18:25:24 INFO - 'LANG': 'en_US.UTF-8', 18:25:24 INFO - 'LANGUAGE': 'en_US:en', 18:25:24 INFO - 'LOGNAME': 'cltbld', 18:25:24 INFO - 'MAIL': '/var/mail/cltbld', 18:25:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:24 INFO - 'MOZ_NO_REMOTE': '1', 18:25:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:24 INFO - 'NO_EM_RESTART': '1', 18:25:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:24 INFO - 'PWD': '/builds/slave/test', 18:25:24 INFO - 'SHELL': '/bin/bash', 18:25:24 INFO - 'SHLVL': '1', 18:25:24 INFO - 'TERM': 'linux', 18:25:24 INFO - 'TMOUT': '86400', 18:25:24 INFO - 'USER': 'cltbld', 18:25:24 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238', 18:25:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:24 INFO - '_': '/tools/buildbot/bin/python'} 18:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:25: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 18:25: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 18:25: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 18:25: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 18:25:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:25:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:25:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:25:25 INFO - Installing collected packages: mozsystemmonitor 18:25:25 INFO - Running setup.py install for mozsystemmonitor 18:25:25 INFO - Successfully installed mozsystemmonitor 18:25:25 INFO - Cleaning up... 18:25:25 INFO - Return code: 0 18:25:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:25:25 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')]} 18:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:25 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')]} 18:25:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:25 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 0x178c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afbb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af8580>, '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 0x1af9480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af9910>, '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': '1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238', '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 18:25:25 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 18:25:25 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 18:25:25 INFO - Using env: {'DISPLAY': ':0', 18:25:25 INFO - 'HOME': '/home/cltbld', 18:25:25 INFO - 'LANG': 'en_US.UTF-8', 18:25:25 INFO - 'LANGUAGE': 'en_US:en', 18:25:25 INFO - 'LOGNAME': 'cltbld', 18:25:25 INFO - 'MAIL': '/var/mail/cltbld', 18:25:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:25 INFO - 'MOZ_NO_REMOTE': '1', 18:25:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:25 INFO - 'NO_EM_RESTART': '1', 18:25:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:25 INFO - 'PWD': '/builds/slave/test', 18:25:25 INFO - 'SHELL': '/bin/bash', 18:25:25 INFO - 'SHLVL': '1', 18:25:25 INFO - 'TERM': 'linux', 18:25:25 INFO - 'TMOUT': '86400', 18:25:25 INFO - 'USER': 'cltbld', 18:25:25 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238', 18:25:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:25 INFO - '_': '/tools/buildbot/bin/python'} 18:25:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:25 INFO - Downloading/unpacking jsonschema==2.5.1 18:25:25 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 18:25:25 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 18:25:25 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 18:25:25 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 18:25:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:25:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:25: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 18:25: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 18:25: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 18:25: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 18:25:27 INFO - Downloading functools32-3.2.3-2.tar.gz 18:25:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:25:27 INFO - warning: no files found matching '*.txt' 18:25:27 INFO - no previously-included directories found matching 'build' 18:25:27 INFO - no previously-included directories found matching 'dist' 18:25:27 INFO - no previously-included directories found matching '.git*' 18:25:27 INFO - Installing collected packages: jsonschema, functools32 18:25:27 INFO - Running setup.py install for functools32 18:25:27 INFO - warning: no files found matching '*.txt' 18:25:27 INFO - no previously-included directories found matching 'build' 18:25:27 INFO - no previously-included directories found matching 'dist' 18:25:27 INFO - no previously-included directories found matching '.git*' 18:25:27 INFO - Successfully installed jsonschema functools32 18:25:27 INFO - Cleaning up... 18:25:27 INFO - Return code: 0 18:25:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:25: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')]} 18:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25: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')]} 18:25:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25: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', '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 0x178c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afbb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af8580>, '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 0x1af9480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af9910>, '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': '1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238', '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 18:25: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:25: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 functools32==3.2.3-2 18:25:27 INFO - Using env: {'DISPLAY': ':0', 18:25:27 INFO - 'HOME': '/home/cltbld', 18:25:27 INFO - 'LANG': 'en_US.UTF-8', 18:25:27 INFO - 'LANGUAGE': 'en_US:en', 18:25:27 INFO - 'LOGNAME': 'cltbld', 18:25:27 INFO - 'MAIL': '/var/mail/cltbld', 18:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:27 INFO - 'MOZ_NO_REMOTE': '1', 18:25:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:27 INFO - 'NO_EM_RESTART': '1', 18:25:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:27 INFO - 'PWD': '/builds/slave/test', 18:25:27 INFO - 'SHELL': '/bin/bash', 18:25:27 INFO - 'SHLVL': '1', 18:25:27 INFO - 'TERM': 'linux', 18:25:27 INFO - 'TMOUT': '86400', 18:25:27 INFO - 'USER': 'cltbld', 18:25:27 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238', 18:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:27 INFO - '_': '/tools/buildbot/bin/python'} 18:25:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:25:27 INFO - Cleaning up... 18:25:27 INFO - Return code: 0 18:25:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:25: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')]} 18:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25: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')]} 18:25:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25: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', '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 0x178c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afbb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af8580>, '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 0x1af9480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af9910>, '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': '1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238', '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 18:25: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:25: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 blobuploader==1.2.4 18:25:27 INFO - Using env: {'DISPLAY': ':0', 18:25:27 INFO - 'HOME': '/home/cltbld', 18:25:27 INFO - 'LANG': 'en_US.UTF-8', 18:25:27 INFO - 'LANGUAGE': 'en_US:en', 18:25:27 INFO - 'LOGNAME': 'cltbld', 18:25:27 INFO - 'MAIL': '/var/mail/cltbld', 18:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:27 INFO - 'MOZ_NO_REMOTE': '1', 18:25:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:27 INFO - 'NO_EM_RESTART': '1', 18:25:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:27 INFO - 'PWD': '/builds/slave/test', 18:25:27 INFO - 'SHELL': '/bin/bash', 18:25:27 INFO - 'SHLVL': '1', 18:25:27 INFO - 'TERM': 'linux', 18:25:27 INFO - 'TMOUT': '86400', 18:25:27 INFO - 'USER': 'cltbld', 18:25:27 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238', 18:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:27 INFO - '_': '/tools/buildbot/bin/python'} 18:25:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:27 INFO - Downloading/unpacking blobuploader==1.2.4 18:25: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 18:25: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 18:25: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 18:25: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 18:25:28 INFO - Downloading blobuploader-1.2.4.tar.gz 18:25:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:25:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:25: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 18:25: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 18:25: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 18:25: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 18:25:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:25:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:25: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 18:25: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 18:25: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 18:25: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 18:25:29 INFO - Downloading docopt-0.6.1.tar.gz 18:25:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:25:29 INFO - Installing collected packages: blobuploader, requests, docopt 18:25:29 INFO - Running setup.py install for blobuploader 18:25:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:25:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:25:29 INFO - Running setup.py install for requests 18:25:30 INFO - Running setup.py install for docopt 18:25:30 INFO - Successfully installed blobuploader requests docopt 18:25:30 INFO - Cleaning up... 18:25:30 INFO - Return code: 0 18:25:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:25: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')]} 18:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25: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')]} 18:25:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:30 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 0x178c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afbb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af8580>, '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 0x1af9480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af9910>, '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': '1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238', '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 18:25:30 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 18:25:30 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 18:25:30 INFO - Using env: {'DISPLAY': ':0', 18:25:30 INFO - 'HOME': '/home/cltbld', 18:25:30 INFO - 'LANG': 'en_US.UTF-8', 18:25:30 INFO - 'LANGUAGE': 'en_US:en', 18:25:30 INFO - 'LOGNAME': 'cltbld', 18:25:30 INFO - 'MAIL': '/var/mail/cltbld', 18:25:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:30 INFO - 'MOZ_NO_REMOTE': '1', 18:25:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:30 INFO - 'NO_EM_RESTART': '1', 18:25:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:30 INFO - 'PWD': '/builds/slave/test', 18:25:30 INFO - 'SHELL': '/bin/bash', 18:25:30 INFO - 'SHLVL': '1', 18:25:30 INFO - 'TERM': 'linux', 18:25:30 INFO - 'TMOUT': '86400', 18:25:30 INFO - 'USER': 'cltbld', 18:25:30 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238', 18:25:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:30 INFO - '_': '/tools/buildbot/bin/python'} 18:25:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:25:30 INFO - Running setup.py (path:/tmp/pip-YMT3Im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:25:30 INFO - Running setup.py (path:/tmp/pip-Njy8KE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:25:30 INFO - Running setup.py (path:/tmp/pip-QBBOuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:25:30 INFO - Running setup.py (path:/tmp/pip-TBFP7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:25:30 INFO - Running setup.py (path:/tmp/pip-OG5Jwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:25:30 INFO - Running setup.py (path:/tmp/pip-HvYWja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:25:30 INFO - Running setup.py (path:/tmp/pip-DTK7KS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:25:30 INFO - Running setup.py (path:/tmp/pip-Sdk4ap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:25:30 INFO - Running setup.py (path:/tmp/pip-JANBGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:25:30 INFO - Running setup.py (path:/tmp/pip-I0M580-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:25:31 INFO - Running setup.py (path:/tmp/pip-PvykBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:25:31 INFO - Running setup.py (path:/tmp/pip-_nL3Tj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:25:31 INFO - Running setup.py (path:/tmp/pip-IT2Pg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:25:31 INFO - Running setup.py (path:/tmp/pip-_WjLzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:31 INFO - Running setup.py (path:/tmp/pip-WJxD_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:25:31 INFO - Running setup.py (path:/tmp/pip-3jG9iQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:25:31 INFO - Running setup.py (path:/tmp/pip-7y0SM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:25:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:25:31 INFO - Running setup.py install for manifestparser 18:25:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:25:31 INFO - Running setup.py install for mozcrash 18:25:31 INFO - Running setup.py install for mozdebug 18:25:31 INFO - Running setup.py install for mozdevice 18:25:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:25:31 INFO - Running setup.py install for mozfile 18:25:32 INFO - Running setup.py install for mozhttpd 18:25:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:25:32 INFO - Running setup.py install for mozinfo 18:25:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:25:32 INFO - Running setup.py install for mozInstall 18:25:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:25:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:25:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:25:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:25:32 INFO - Running setup.py install for mozleak 18:25:32 INFO - Running setup.py install for mozlog 18:25:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:25:32 INFO - Running setup.py install for moznetwork 18:25:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:25:32 INFO - Running setup.py install for mozprocess 18:25:32 INFO - Running setup.py install for mozprofile 18:25:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:25:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:25:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:25:32 INFO - Running setup.py install for mozrunner 18:25:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:25:32 INFO - Running setup.py install for mozscreenshot 18:25:33 INFO - Running setup.py install for moztest 18:25:33 INFO - Running setup.py install for mozversion 18:25:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:25:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:25:33 INFO - Cleaning up... 18:25:33 INFO - Return code: 0 18:25:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:25: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')]} 18:25:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25: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')]} 18:25:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:33 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 0x178c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afbb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af8580>, '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 0x1af9480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af9910>, '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': '1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238', '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 18:25:33 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 18:25:33 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 18:25:33 INFO - Using env: {'DISPLAY': ':0', 18:25:33 INFO - 'HOME': '/home/cltbld', 18:25:33 INFO - 'LANG': 'en_US.UTF-8', 18:25:33 INFO - 'LANGUAGE': 'en_US:en', 18:25:33 INFO - 'LOGNAME': 'cltbld', 18:25:33 INFO - 'MAIL': '/var/mail/cltbld', 18:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:33 INFO - 'MOZ_NO_REMOTE': '1', 18:25:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:33 INFO - 'NO_EM_RESTART': '1', 18:25:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:33 INFO - 'PWD': '/builds/slave/test', 18:25:33 INFO - 'SHELL': '/bin/bash', 18:25:33 INFO - 'SHLVL': '1', 18:25:33 INFO - 'TERM': 'linux', 18:25:33 INFO - 'TMOUT': '86400', 18:25:33 INFO - 'USER': 'cltbld', 18:25:33 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238', 18:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:33 INFO - '_': '/tools/buildbot/bin/python'} 18:25:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:25:33 INFO - Running setup.py (path:/tmp/pip-l8Jb6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:25:33 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)) 18:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:25:33 INFO - Running setup.py (path:/tmp/pip-ihXT_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:25:33 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)) 18:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:25:33 INFO - Running setup.py (path:/tmp/pip-xcRPcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:25:33 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)) 18:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:25:33 INFO - Running setup.py (path:/tmp/pip-nZjXxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:25:33 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)) 18:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:25:33 INFO - Running setup.py (path:/tmp/pip-YGkY52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:25:33 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)) 18:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:25:33 INFO - Running setup.py (path:/tmp/pip-bQ3oiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:25:33 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)) 18:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:25:33 INFO - Running setup.py (path:/tmp/pip-KzSQrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:25:34 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)) 18:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:25:34 INFO - Running setup.py (path:/tmp/pip-7Wg4Du-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:25:34 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)) 18:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:25:34 INFO - Running setup.py (path:/tmp/pip-UPKerE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:25:34 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)) 18:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:25:34 INFO - Running setup.py (path:/tmp/pip-MIxpYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:25:34 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)) 18:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:25:34 INFO - Running setup.py (path:/tmp/pip-EeXtiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:25:34 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)) 18:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:25:34 INFO - Running setup.py (path:/tmp/pip-oYJIap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:25:34 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)) 18:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:25:34 INFO - Running setup.py (path:/tmp/pip-Xc9brY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:25:34 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)) 18:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:25:34 INFO - Running setup.py (path:/tmp/pip-EfG7AE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:25:34 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)) 18:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:34 INFO - Running setup.py (path:/tmp/pip-cQr5sW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:34 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)) 18:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:25:34 INFO - Running setup.py (path:/tmp/pip-kDDuTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:25:34 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)) 18:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:25:34 INFO - Running setup.py (path:/tmp/pip-cCsEtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:25:34 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)) 18:25:34 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)) 18:25:34 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)) 18:25:34 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)) 18:25:34 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)) 18:25:34 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)) 18:25:34 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)) 18:25:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:25:34 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 18:25:34 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 18:25:34 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 18:25:34 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 18:25:35 INFO - Downloading blessings-1.6.tar.gz 18:25:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:25:35 INFO - Installing collected packages: blessings 18:25:35 INFO - Running setup.py install for blessings 18:25:36 INFO - Successfully installed blessings 18:25:36 INFO - Cleaning up... 18:25:36 INFO - Return code: 0 18:25:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:25:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:25:36 INFO - Reading from file tmpfile_stdout 18:25:36 INFO - Current package versions: 18:25:36 INFO - argparse == 1.2.1 18:25:36 INFO - blessings == 1.6 18:25:36 INFO - blobuploader == 1.2.4 18:25:36 INFO - docopt == 0.6.1 18:25:36 INFO - functools32 == 3.2.3-2 18:25:36 INFO - jsonschema == 2.5.1 18:25:36 INFO - manifestparser == 1.1 18:25:36 INFO - mozInstall == 1.13 18:25:36 INFO - mozcrash == 1.0 18:25:36 INFO - mozdebug == 0.1 18:25:36 INFO - mozdevice == 0.51 18:25:36 INFO - mozfile == 1.2 18:25:36 INFO - mozhttpd == 0.7 18:25:36 INFO - mozinfo == 0.10 18:25:36 INFO - mozleak == 0.1 18:25:36 INFO - mozlog == 3.5 18:25:36 INFO - moznetwork == 0.27 18:25:36 INFO - mozprocess == 0.25 18:25:36 INFO - mozprofile == 0.28 18:25:36 INFO - mozrunner == 6.13 18:25:36 INFO - mozscreenshot == 0.1 18:25:36 INFO - mozsystemmonitor == 0.3 18:25:36 INFO - moztest == 0.8 18:25:36 INFO - mozversion == 1.4 18:25:36 INFO - psutil == 3.1.1 18:25:36 INFO - requests == 1.2.3 18:25:36 INFO - wsgiref == 0.1.2 18:25:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:25: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')]} 18:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25: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')]} 18:25:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:36 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 0x178c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afbb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af8580>, '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 0x1af9480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af9910>, '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': '1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238', '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 18:25:36 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 18:25:36 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 18:25:36 INFO - Using env: {'DISPLAY': ':0', 18:25:36 INFO - 'HOME': '/home/cltbld', 18:25:36 INFO - 'LANG': 'en_US.UTF-8', 18:25:36 INFO - 'LANGUAGE': 'en_US:en', 18:25:36 INFO - 'LOGNAME': 'cltbld', 18:25:36 INFO - 'MAIL': '/var/mail/cltbld', 18:25:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:36 INFO - 'MOZ_NO_REMOTE': '1', 18:25:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:36 INFO - 'NO_EM_RESTART': '1', 18:25:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:36 INFO - 'PWD': '/builds/slave/test', 18:25:36 INFO - 'SHELL': '/bin/bash', 18:25:36 INFO - 'SHLVL': '1', 18:25:36 INFO - 'TERM': 'linux', 18:25:36 INFO - 'TMOUT': '86400', 18:25:36 INFO - 'USER': 'cltbld', 18:25:36 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238', 18:25:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:36 INFO - '_': '/tools/buildbot/bin/python'} 18:25:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:36 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)) 18:25:36 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)) 18:25:36 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)) 18:25:36 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)) 18:25:36 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)) 18:25:36 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)) 18:25:36 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)) 18:25:36 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)) 18:25:36 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)) 18:25:36 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:25:36 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 18:25:36 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 18:25:36 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 18:25:36 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 18:25:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:25:37 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)) 18:25:37 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)) 18:25:37 INFO - Installing collected packages: simplejson 18:25:37 INFO - Running setup.py install for simplejson 18:25:37 INFO - building 'simplejson._speedups' extension 18:25:37 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 18:25:38 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 18:25:38 INFO - Successfully installed simplejson 18:25:38 INFO - Cleaning up... 18:25:38 INFO - Return code: 0 18:25:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:25:38 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')]} 18:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:38 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')]} 18:25:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:38 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 0x178c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afbb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af8580>, '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 0x1af9480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af9910>, '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': '1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238', '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 18:25:38 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 18:25:38 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 18:25:38 INFO - Using env: {'DISPLAY': ':0', 18:25:38 INFO - 'HOME': '/home/cltbld', 18:25:38 INFO - 'LANG': 'en_US.UTF-8', 18:25:38 INFO - 'LANGUAGE': 'en_US:en', 18:25:38 INFO - 'LOGNAME': 'cltbld', 18:25:38 INFO - 'MAIL': '/var/mail/cltbld', 18:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:38 INFO - 'MOZ_NO_REMOTE': '1', 18:25:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:38 INFO - 'NO_EM_RESTART': '1', 18:25:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:38 INFO - 'PWD': '/builds/slave/test', 18:25:38 INFO - 'SHELL': '/bin/bash', 18:25:38 INFO - 'SHLVL': '1', 18:25:38 INFO - 'TERM': 'linux', 18:25:38 INFO - 'TMOUT': '86400', 18:25:38 INFO - 'USER': 'cltbld', 18:25:38 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238', 18:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:38 INFO - '_': '/tools/buildbot/bin/python'} 18:25:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:25:39 INFO - Cleaning up... 18:25:39 INFO - Return code: 0 18:25:39 INFO - Running post-action listener: _resource_record_post_action 18:25:39 INFO - Running post-action listener: _start_resource_monitoring 18:25:39 INFO - Starting resource monitoring. 18:25:39 INFO - [mozharness: 2017-08-31 01:25:39.086118Z] Finished create-virtualenv step (success) 18:25:39 INFO - [mozharness: 2017-08-31 01:25:39.087119Z] Running install step. 18:25:39 INFO - Running pre-action listener: _resource_record_pre_action 18:25:39 INFO - Running main action method: install 18:25:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:25:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:25:39 INFO - Reading from file tmpfile_stdout 18:25:39 INFO - Detecting whether we're running mozinstall >=1.0... 18:25:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:25:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:25:39 INFO - Reading from file tmpfile_stdout 18:25:39 INFO - Output received: 18:25:39 INFO - Usage: mozinstall [options] installer 18:25:39 INFO - Options: 18:25:39 INFO - -h, --help show this help message and exit 18:25:39 INFO - -d DEST, --destination=DEST 18:25:39 INFO - Directory to install application into. [default: 18:25:39 INFO - "/builds/slave/test"] 18:25:39 INFO - --app=APP Application being installed. [default: firefox] 18:25:39 INFO - mkdir: /builds/slave/test/build/application 18:25:39 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'] 18:25:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:25:55 INFO - Reading from file tmpfile_stdout 18:25:55 INFO - Output received: 18:25:55 INFO - /builds/slave/test/build/application/firefox/firefox 18:25:55 INFO - Running post-action listener: _resource_record_post_action 18:25:55 INFO - [mozharness: 2017-08-31 01:25:55.726115Z] Finished install step (success) 18:25:55 INFO - [mozharness: 2017-08-31 01:25:55.726397Z] Running setup-mitmproxy step. 18:25:55 INFO - Running pre-action listener: _resource_record_pre_action 18:25:55 INFO - Running main action method: setup_mitmproxy 18:25:55 INFO - Skipping: mitmproxy is not required 18:25:55 INFO - Running post-action listener: _resource_record_post_action 18:25:55 INFO - [mozharness: 2017-08-31 01:25:55.727521Z] Finished setup-mitmproxy step (success) 18:25:55 INFO - [mozharness: 2017-08-31 01:25:55.727739Z] Running run-tests step. 18:25:55 INFO - Running pre-action listener: _resource_record_pre_action 18:25:55 INFO - Running pre-action listener: _set_gcov_prefix 18:25:55 INFO - Running main action method: run_tests 18:25:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:25:55 INFO - Python 2.7.3 18:25:55 INFO - Return code: 0 18:25:55 INFO - grabbing minidump binary from tooltool 18:25:55 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')]} 18:25:55 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x1af8580>, '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 0x1af9480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af9910>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:25:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 18:25:55 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:25:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 18:25:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:25:55 INFO - Return code: 0 18:25:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:25:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:25:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:25:55 INFO - ENV: RUST_BACKTRACE is now full 18:25:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:25:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:25:55 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/MEo91bGsToSiyg6RI0hmpw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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 18:25:55 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/MEo91bGsToSiyg6RI0hmpw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-079 --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 18:25:55 INFO - Using env: {'DISPLAY': ':0', 18:25:55 INFO - 'HOME': '/home/cltbld', 18:25:55 INFO - 'LANG': 'en_US.UTF-8', 18:25:55 INFO - 'LANGUAGE': 'en_US:en', 18:25:55 INFO - 'LOGNAME': 'cltbld', 18:25:55 INFO - 'MAIL': '/var/mail/cltbld', 18:25:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:25:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:55 INFO - 'MOZ_NO_REMOTE': '1', 18:25:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:25:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:55 INFO - 'NO_EM_RESTART': '1', 18:25:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:55 INFO - 'PWD': '/builds/slave/test', 18:25:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:25:55 INFO - 'RUST_BACKTRACE': 'full', 18:25:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:25:55 INFO - 'SHELL': '/bin/bash', 18:25:55 INFO - 'SHLVL': '1', 18:25:55 INFO - 'TERM': 'linux', 18:25:55 INFO - 'TMOUT': '86400', 18:25:55 INFO - 'USER': 'cltbld', 18:25:55 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238', 18:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:55 INFO - '_': '/tools/buildbot/bin/python'} 18:25:55 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/MEo91bGsToSiyg6RI0hmpw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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 18:25:56 INFO - mozversion application_buildid: 20170831001019 18:25:56 INFO - mozversion application_changeset: d9b405d82cffb07343a5f2fd941e029298c7f6c4 18:25:56 INFO - mozversion application_display_name: Nightly 18:25:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:25:56 INFO - mozversion application_name: Firefox 18:25:56 INFO - mozversion application_remotingname: firefox 18:25:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:25:56 INFO - mozversion application_vendor: Mozilla 18:25:56 INFO - mozversion application_version: 57.0a1 18:25:56 INFO - mozversion platform_buildid: 20170831001019 18:25:56 INFO - mozversion platform_changeset: d9b405d82cffb07343a5f2fd941e029298c7f6c4 18:25:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:25:56 INFO - mozversion platform_version: 57.0a1 18:25:56 INFO - using testdate: 1504142756 18:25:56 INFO - actual date: 1504142756 18:25:56 INFO - starting webserver on 'localhost:44456' 18:25:56 INFO - SUITE-START | Running 2 tests 18:25:56 INFO - TEST-START | dromaeo_css 18:25:56 INFO - Initialising browser for dromaeo_css test... 18:25:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44456/getInfo.html -profile /tmp/tmpmpG1RL/profile 18:25:56 INFO - TEST-INFO | started process 3484 (/builds/slave/test/build/application/firefox/firefox http://localhost:44456/getInfo.html) 18:26:02 INFO - TEST-INFO | 3484: exit 0 18:26:02 INFO - Browser initialized. 18:26:02 INFO - Running cycle 1/1 for dromaeo_css test... 18:26:02 INFO - Using env: {'DISPLAY': ':0', 18:26:02 INFO - 'HOME': '/home/cltbld', 18:26:02 INFO - 'JSGC_DISABLE_POISONING': '1', 18:26:02 INFO - 'LANG': 'en_US.UTF-8', 18:26:02 INFO - 'LANGUAGE': 'en_US:en', 18:26:02 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:26:02 INFO - 'LOGNAME': 'cltbld', 18:26:02 INFO - 'MAIL': '/var/mail/cltbld', 18:26:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:26:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:26:02 INFO - 'MOZ_CRASHREPORTER': '1', 18:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:02 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:26:02 INFO - 'MOZ_NO_REMOTE': '1', 18:26:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:26:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:02 INFO - 'NO_EM_RESTART': '1', 18:26:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:02 INFO - 'PWD': '/builds/slave/test', 18:26:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:26:02 INFO - 'RUST_BACKTRACE': 'full', 18:26:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:26:02 INFO - 'SHELL': '/bin/bash', 18:26:02 INFO - 'SHLVL': '1', 18:26:02 INFO - 'TERM': 'linux', 18:26:02 INFO - 'TMOUT': '86400', 18:26:02 INFO - 'USER': 'cltbld', 18:26:02 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238', 18:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:02 INFO - '_': '/tools/buildbot/bin/python'} 18:26:02 INFO - TEST-INFO | started process 3673 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmpG1RL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:26:03 INFO - PID 3673 | 18:26:03 INFO - PID 3673 | (/builds/slave/test/build/application/firefox/firefox:3724): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:26:03 INFO - PID 3673 | 18:26:13 INFO - PID 3673 | RSS: Main: 162160640 18:26:13 INFO - PID 3673 | 18:29:12 INFO - PID 3673 | Cycle 1(1): loaded http://localhost:44456/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44456/tests/dromaeo/cssquery-ext.html) 18:29:13 INFO - PID 3673 | RSS: Main: 165793792 18:29:13 INFO - PID 3673 | 18:32:15 INFO - PID 3673 | Cycle 1(1): loaded http://localhost:44456/tests/dromaeo/cssquery-ext.html (next: http://localhost:44456/tests/dromaeo/cssquery-jquery.html) 18:32:15 INFO - PID 3673 | RSS: Main: 161751040 18:32:15 INFO - PID 3673 | 18:35:17 INFO - PID 3673 | Cycle 1(1): loaded http://localhost:44456/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44456/tests/dromaeo/cssquery-mootools.html) 18:35:18 INFO - PID 3673 | RSS: Main: 164208640 18:35:18 INFO - PID 3673 | 18:38:19 INFO - PID 3673 | Cycle 1(1): loaded http://localhost:44456/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44456/tests/dromaeo/cssquery-prototype.html) 18:38:20 INFO - PID 3673 | RSS: Main: 162713600 18:38:20 INFO - PID 3673 | 18:41:23 INFO - PID 3673 | Cycle 1(1): loaded http://localhost:44456/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44456/tests/dromaeo/cssquery-yui.html) 18:41:24 INFO - PID 3673 | RSS: Main: 163745792 18:41:24 INFO - PID 3673 | 18:44:25 INFO - PID 3673 | Cycle 1(1): loaded http://localhost:44456/tests/dromaeo/cssquery-yui.html (next: http://localhost:44456/tests/dromaeo/cssquery-dojo.html) 18:44:25 INFO - PID 3673 | RSS: Main: 166739968 18:44:25 INFO - PID 3673 | 18:44:25 INFO - PID 3673 | __start_tp_report 18:44:25 INFO - PID 3673 | _x_x_mozilla_page_load 18:44:25 INFO - PID 3673 | _x_x_mozilla_page_load_details 18:44:25 INFO - PID 3673 | |i|pagename|runs| 18:44:25 INFO - PID 3673 | |0;dojo.html;3906.863259785908;3936.0946982194096;3951.960480395196;3993.960060399396;4009.7794621295834;6820.283870193626;6859.245482996873;6869.484788640853;6879.346462086094;6903.068085808414;6950;7058.047163632908;7064.47016473764;7072.328128827753;7072.363487286143;6174.938250617482;6176.166217560639;6217.782377616784;6241.313455519889;6263.31103578606;6075.939240607604;6119.571629985903;6209;6214.098955651428;6352.269489008754;6070.0591408331775;6096.878062438748;6099.847503812418;6202.317745048041;6205.3484384139465;6128.785492507741;6131.50947924165;6242.032484964792;6257.87484250317;6263.498920086382;6134.141220229171;6144.692765361759;6198.411150940653;6230.283517395512;6246.625202487865;6728.3271672832325;6825.55633883796;6837.35045170708;6927.7228910844005;6940.895886561706;7341.5962122083265;7377.188509263977;7447.292507211806;7465.8506829863645;7484.363829074535;7476.36450901674;7513.135989361239;7518.360939320164;7581.090269167735;7632.3130918217075;6783.898241526381;6859.17689877208;6946.0622815919705;6979.860402791966;7037.401820845234;7537.773866784005;7635.427342949301;7651.69393224276;7652.655630496641;7681;7337.816554586178;7391.039164908528;7395.527309790824;7486.288802563748;7496.175420703718;7509.061367329084;7511.962440187874;7514.736984205527;7588.430867684946;7641.3886889048745;7264.091988501437;7431.256874312526;7478.850422991619;7568.621568921532;7571.280728330799;7368.115826100902;7384.815379615445;7414.666340014713;7494.85010299791;7532.510386824839;6355.269144048401;6456.935430645727;6459.870802583922;6481.546291759626;6483.286838447767;5454.754536045887;5464.754086066137;5492.395836457987;5517.282753242052;5548.389677135512;6284.151639528605;6347.650879201596;6379.55343125986;6412.038194270896;6458.870822583616;7384.040074790243;7478.887816682754;7525.3227209551405;7531.058617672791;7557.319841214317;6362.204724409449;6365.936340636627;6371.171747672773;6398.392152745481;6444.613323200623;6654.500912431587;6668.599884006975;6721.899171512431;6805.455563554904;6807.523473356818;7121.679524421414;7204.819879503054;7239.457040721862;7304.342609165201;7312.5246858954;7363.447741419523;7469.962650186714;7473.327400533978;7476.962615186889;7480.214577469287;7254.854902902018;7328.96335518319;7338.266173382619;7340.11918569775;7340.596267205355;7364.889526656997;7416.110066791804;7473.215312392121;7504.2120577340775;7509.5869727163345;7402.074740657418;7426;7453.068366454193;7529.13414957265;7590.962045189739;7042.718291268497;7153.4277257820295;7154.177269614061;7155.24869888675;7196.388306993964;7227.530210536298;7233.240509746612;7267.563946163247;7286.307800758919;7302.707891684273;7196.8920466192;7201.855962880608;7279.927200728137;7280.0535930328715;7294.817629559304;7226.132864056137;7226.819329516594;7237.384822290164;7276.1996180419055;7328.230535793665;6449.12936753551;6979.4765392594745;7015.36861682451;7060.258672839484;7066.222715501188 18:44:25 INFO - PID 3673 | |1;ext.html;881.9955900220498;948.09456968595;970.1123472023098;1000.1248907206194;1001.0240015984416;41825.37261941074;42367.36448953264;42567.14865702684;42712;42794.7860260699;39390.409143862795;39620.80189599055;39636.20727585447;39701.40447893277;39804.203915921666;7163.35529802319;7293.270672932691;7296.087989001375;7297.452691048166;7297.708091676326;7160.355567998879;7244.782656520313;7254.056972593556;7255.129384473844;7257.165425976027;7250.1299844018795;7944.324732397753;8130.471519351253;8133.593320333989;8135.837283254331;8044.356451483896;8059.758207253792;8062;8102.108768035511;8113.634886430095;7810.843783124363;7891.921080789176;7892.289693927574;7896;7899;38768.22463550742;38932.22135557301;38935.41596876049;39006.21987560261;39011.609883901365;3496.0036389628835;3523.3834079036064;3524.753267271292;3526.400511912955;3527.3650742866275;31845;31947.84026079878;32022.839885800655;32060;32250.354992900244;5431.212474191259;5436.700981446019;5445.237666726662;5499.862503437406;5504.0643090674685;203860;205090;207786;208304;218334;51150.48849511457;51475.227871581956;51687;51888.74055629698;51934.740326298124;53641.19538206852;53783.731081345126;53978.73010634922;54020;54043;15459.768103478456;15581.844181558266;15604.687906241812;15606.9219653901;15656.686866262611;12557.93721031389;12578.930790882878;12608.180468269717;12637;12649.683757906127;14903.478378256708;14926.850731492763;14968.70062598742;15068.095914245181;15195.392184312504;5952.196453478725;5996.569399844395;6036.275646922398;6050.6672133032225;6063.363346848606;1094.0973696700255;1113.7494063835572;1113.821788513834;1114.4260705736551;1118.8601424821898;25005;25079.24762257135;25105.497890042097;25255.62116568253;25345.746542534707;1171.6953592065954;1200.2678366196612;1204.692803335144;1204.7349583091882;1208.323338930202;13106.934465327613;13238.139520931109;13403.798943015863;13450.663733406744;13593.59219223425;284038;285443;286348;286776;287292;54915;55199;58757.41242587519;59759.40240597539;59762;1465.824101107874;1468.3319089814322;1490.1133825373886;1490.6646004648867;1498.8051553298;29574;29926.25184370408;30324.54513182348;30483.390332193674;30705.846470767505;40544.1891162181;40639.79680101581;40676.38985415162;40740.79629601833;40816.183676325716;169095;169160;169330;169423;169656.15171924062;35051.29897401987;40933.59066409417;41341.37987930243;41520;41735.165296694504;49175.754121230595;49550;49715.75142124266;50261.74869125631;50356.24465632945;37018.62981370152;37117;37127.25745485021;37146;37304;37006.629933700315;37373.62626373702;37593.745331407146;37613.623863761015;38239.235215296096;44013.33979990367;44030;44092;44209;44360.334594981745;35464;35500.64499354974;35995.10012249715;36469.635303646624;36836.81581592075;26931;27734.306642334104;27982.44035119327;27997.160085197476;28047.298817529725 18:44:25 INFO - PID 3673 | |2;jquery.html;598.2521847690382;602.32840382973;602.3765402808092;610.6946526736632;618.8700372921686;22830.88584557077;23205.76794232057;23570.410739731517;23593.056277748892;23606.88196559015;22550.774492255074;22882.65676014857;22946.426339341484;22953.4261643459;22964.588718184557;6783.694733736994;6926.792196234121;6931.098957135565;6936.757213497529;6941.375276225139;6499.837504062412;6725.05849181115;6780.186377634691;6798.5580937239165;6807.2512023677355;6747.39273465388;6755.054292399043;6757.695903684322;6760.32396760325;6771.8984215236815;6766.966165169192;6774.424173945221;6779.694913728894;6779.762708305235;6792.320767923193;6264.686765661744;6311.905321420182;6318.399752023551;6325.272593651743;6331.271903731038;29774.851125744448;30790.23024424385;31322.84338578315;31418.21454463634;31510.52734208989;2212.5685491329195;2236.6197746383154;2239;2239.944001399962;2240.551889622066;19821.900890495453;20398.388048358574;20427.48931276715;20428.285010024578;20449.591008179752;2431.5744744669614;2485.2792690119845;2538.9492210155877;2569.396191894903;2582.8966841326323;150446;152735.2363238199;153010.23494882564;153140;153230;15584.454544090902;16265.861389702844;16578.66842663164;16801;16818.327266909186;26318.6052209217;48990.26514602284;49956.25065624018;50195.49804501981;50241.748791255806;11524.250923689933;11822.34977076269;12054.156209065457;12115.454804533818;12124.333161676192;9247.352685311964;9753.707388778206;9774.902250977542;9824.164945979672;9858.063483969156;12213.633590992284;12825.29460879642;12889.677758056123;12923.676908077374;12941;4384.4081049058605;4493.258612328995;4508.571685689854;4557.544245575482;4562.726236425825;1045.639254457211;1063.5320458998017;1069.7272195590074;1073.4471747050275;1077.3643550305358;22018.559628807656;22651.20720774798;22672.773272267066;22955.655665165035;23159.53680926372;1066.3814987307344;1100.2463312630873;1100.5597760895705;1117.0895719988184;1129.0572372069414;12217.877821221851;12751.234925904475;12766.17019893704;12785.296808675426;12843.165194262343;637740;662423;663188;681307;686859;139090.30454847662;140047;142237;142529;143133;1281.5258354408743;1287.189070885355;1314.4413624209672;1318.7428451451874;1321.9933900330436;19704.11331490115;19722.506937326107;19775.40673779789;19988.10053547623;20090.99545022772;64714.67642661757;68967.31032689809;72096;72351.27648723657;76026;86487.5675621643;88338;91093.08906910846;92156;97037;22211.444713882283;23017.309480715605;23041.65437518472;23375.41561460977;23893;26355.60466593041;26889.193324200307;27019.59470607903;27134.864325678245;27136.457270854866;20887;21038.89480552649;21669.78330216741;21773.23793667214;21777;16166.353345866504;17402.5649358762;17412;17520.82479175192;18200.72698909491;20744.792552074287;21437.78562214358;21471.141154353652;21640.24259150922;22069.668954965367;22035.559288813813;22199.77800221977;22317.330480085624;22349.217777377715;22352.552948941255;20747.27384541594;20749.896250519254;20817.89591052035;20985.580288394453;21011.159553617683 18:44:25 INFO - PID 3673 | |3;mootools.html;1440.9351579178935;1484.2578710644677;1497.6255936015996;1503.7819516170148;1513.3946421431422;16298.511044668649;16569;17177.82822171778;17184.398546050892;17248.310067597282;16261.674766504662;17552.0346380949;17584.560385990324;17597.3840915568;17637.382691605795;2768.418632087264;2824.5057115004893;2829.038127036807;2829.278533973834;2830.1792480180725;2627.8291911025817;2691.905783297585;2704.4050308932005;2706.796990225731;2709.2684975056723;2640.075973409311;2663.7602615764577;2666.4267182555745;2666.693330267015;2669.866506674668;2536.226450932465;2555.629433732117;2566.4225549251364;2698.8785504652337;2758.3793646429594;2394.150076722773;2398.5322862041908;2406.350285422926;2408.6989126359204;2411.553862535419;16062.437814676547;16068.59828504285;16271.105089220087;16291.185440728035;16300.918495407566;8312.1687831217;8619.6983105591;8620.353473489451;8637.179467950535;8638.611262493203;5593.077142271521;5629.915551266734;5734;5777.5666824987875;5785.88428231433;2126.8830214338204;2128.7977642123974;2131.3073251193423;2138.5402138540135;2170.045180120742;29892.402151957056;30554;30610;30611.387772244652;30643.540346894813;7538.472306938571;7546;7662.195469475625;7798.298153166243;7869.606519673994;17999.64000719978;18093.095345232687;18110.81889181091;18120.546986325448;18121.456356309067;8273.8345233095;8386.329093672613;8387.748367548984;8390.496570205807;8394.874076888851;7548.698052077855;7596.08846938371;7610.124835643972;7641.847163056819;7646.732364367221;5588;5790.478856902899;5790.71046447676;5830.591858569859;5837.3287071986415;1443.718474897385;1475.7712554554062;1553.4718195813252;1663.9084850333347;1689.7465380192823;961.7259081161835;997.6009596161593;1008.2337423558002;1014.0873214107362;1015.4465816130227;9265.536723163816;9369.922458917175;9627.614895404246;9631.422114673142;9644.228461723045;962.870012548311;1047.2564479219686;1053.9947300263602;1056.6829951014665;1086.2830531848942;5552.750126244328;5640.915386269209;5700.828975130753;5813.389594092644;5951.642901425928;23474.530509389715;24143;24172.87913560421;24527.141550045664;25409.872950635498;24637;24824.627630585557;24948.12681556137;25123.24630261095;25126.748732512806;11478.558562144986;11890.881091188978;11918.344491052902;12012.219205751599;12013.759724805455;8815.338849586435;8949.955250223707;9158.175764181256;9373.343865929319;9393;20471.283505077252;20939.790602094392;21330.360089197347;21577.13691452387;21729.674054889507;21549.353519394444;21554.137834486446;21641.13435462627;22063.33809985703;22228.55542889101;12991.155574887602;13259.80110298327;13288.26914519672;13291.268980206181;13302;15403.537893863202;15514.301856416263;15620.609484762972;15696.450624228097;15794.131322777357;10948.507317170906;11013.2841365311;11160.832587511357;12552.372381381078;12584.74830503403;11276.097912166842;11574.421278935852;11701.180917335705;11768.76462470763;11880.524779008743;9434.433933963985;9642.276829237975;9649.855252171083;9680.75798105053;9689.9031009689;8255.174482551696;8267.62795674208;8477.788055298666;8518.914810851813;8553.401261911606;8414.495130292202;8552.315814734931;8553.358498112791;8566.91433085661;8615.181557752003 18:44:25 INFO - PID 3673 | |4;prototype.html;559.8264537993223;564.9237352957355;571.191763654429;587.667967598307;592.9851753706157;6720.630365329905;6756.189257289126;6783.864322713549;6821.48838837088;6841.5895046297255;6734.427573656233;6754.121964144667;6770.763023294186;6777.627230502333;6803.795886123412;5479.17812328152;5517.36550296715;5518.779248830042;5539.584531160159;5550.139728342114;5154.32993710817;5361.973190134044;5477.370102438231;5507.779688812443;5543.334799824027;5289.523942845143;5339.5728341732565;5341.225522299264;5357.705326207057;5366.06093933562;5290.9735451322495;5309.309789727311;5317.388500322435;5325.440828713007;5343.759530821122;4693.436787585511;4735.242361222188;4747.5787348452195;4754.881127971828;4825.276208568707;6643.269240383554;6652.501062420338;6664.93335066648;6672.099266599044;6688.531802773808;6254.343293954114;6270.498360131179;6298.527610429191;6300.771349586832;6304.27500837405;7135.82160445993;7175.605341706204;7196.530636716134;7224.458165637546;7237.601931893743;5260.684358938476;5304.230886521433;5341.4925582069645;5347.46525347466;5378.515933565959;7166.462515311373;7236.782896513113;7287.886512911303;7369.3367596916;7556;5350.545203657655;5371.435999220103;5387.9461205388225;5481.479259470344;5486.91769623448;5528.640638358494;5546.2823216623565;5572.86067848307;5587.217789509472;5590.888182236333;6146.7233974471255;6177.722002509898;6178.551442961061;6191.659458729813;6200.658963756947;7163.785086447415;7175.13898332193;7179.96410017957;7197.208307086216;7234.240404757425;1930.7103934409952;1931.4398824341065;1937.6899696048565;1957.2171131547495;1959.167353874626;1264.3235868810143;1334.1994803118246;1345.2377385624864;1347.3465369295884;1350.628577141294;6166.845828854314;6168.167297414881;6180.744028429591;6214.223222097238;6281.623102613858;7133.393661538724;7187.64061796908;7294.124705035323;7353.669084891193;7394.889076663854;6164.198654174928;6165.32181460039;6234.906476402857;6294.370562943669;6315.652639104802;3874.8062596870045;3907.7069219808627;3922.490076290064;3931.68546516278;3948.624880636335;7083.82290442743;7083.964580177066;7086.255943126001;7108.440961253945;7155.606441645656;7533.8116547085665;7562.848743025109;7563.357114645207;7567.886481702779;7618.466707330434;7158.642067896584;7166.892496612555;7172.246914073947;7174.641267936478;7202.315780000891;7231.240719724353;7287.453440991841;7313.378362839218;7321.670524826289;7382.52013619113;7314.707411703473;7321.707131714672;7323.791574390379;7324.5971471567445;7395.889061663972;7067.752628658178;7085.901685238796;7121.359077683033;7125;7163.928360716326;5502.642328248651;5514.228008078792;5515.862103447446;5516.724163791875;5529.640573362719;7057.6123460740155;7201.279872012757;7315.451341149329;7381.335679788845;7396.889046664412;7033.507654464139;7045.823854403476;7050.400715939202;7080.256573059754;7123.82190445243;7043.436525077879;7067.858642827217;7067.964660176666;7075.292470752884;7076.893846592202;7019.29807019294;7031.753888613874;7050.717971281091;7064.576125432491;7102.680379382837;6855.794326170223;7117.501774875709;7138.785836424916;7155.177154627285;7183.892241616275;6935.479839012195;6949.30506949301;6979.651017449006;6989.1962424321855;6997.755078572225 18:44:25 INFO - PID 3673 | |5;yui.html;952.723710124064;974.9610015599375;999.2455695949557;1006.2654262388461;1008.6167256442553;18728.625427491443;19589.706154407697;19597.706034409497;19603.5099122522;20418.387448376536;19966;20646.793532064712;20704.171833126657;20706.482337941557;20712.48218794531;1062.9734256643587;1074.8871368506273;1076.4133547216748;1079.3955384984433;1079.773247618003;1041.536516250269;1079.87581428136;1081.6754973507955;1084.0081325587078;1084.8589683341154;1151.3494875395374;1152.5389844062358;1156.3582211872408;1156.444906444907;1158.0272571040325;1145.6677563506573;1147.025028725585;1148.26511032939;1149.7757937202248;1151.89632933036;836.7573403712915;839.0434904209206;839.5844057191669;842.587132305166;844.8479273730726;18836.62326753471;18884.055797210083;18921.7161742574;19142.904285478624;19155.425337239903;20562.485937851525;20993.160273589037;21033;21041.263555775473;21083;17270.654586908193;17318.653626927517;17620.647587048315;17762.111894405356;17794;3955.9011024724323;3982.3827306767207;3987.4018897165365;3989.2221016901717;3990.102226998931;139900;140722;141106.29446852804;141722.29138854344;141789;15769.369225231092;15998.200089995453;16119.27463264156;16156.838431615533;16179.352825886832;26971.056013039448;27114.64426778653;27531.587026194622;27651.446971060464;27678.584821227698;8258.545779982158;8485.448445851;8487.872681909652;8737.257333126756;9081.228095611816;4375.387445757597;4435.024294655171;4435.157320109169;4442.622377097983;4443.311286750559;5293.867653308698;5300.284461597712;5372.811951581676;5411.242426060276;5449.891002179934;1108.2242430298822;1138.703936976392;1139.4758411130972;1141.0643272516622;1143.519721716881;703.9120109986252;717.8923161525813;726.3825748114061;729.8613263479922;748.4461498491078;11934.940325298317;12047.337396443105;12288.201266917622;12304.692382690326;12483.750324993449;757.9810504737426;762.2796457347864;765.8659734546543;775.4610545670818;776;5608.523275521545;5662.7734890603915;5677.261955945701;5683.9715801420725;5773.855653608609;140072;141889;144024;144845;147839;120029;122706.38646806708;124240;125039.3748031254;126845;107479;109854.45072774585;111826.37649423291;114441.85558144479;114536.42731786454;10368.637097701545;10424.583016679248;10491.94754026225;10504.842427363748;10574.788504229718;52107.47892521178;52827.735861321984;53262.20106698325;53513.464865352405;54324.185137223765;64700.67649661721;64997;66400.33599664134;66414.33585664081;67540.3245967534;15826.525204243891;15915.363385464452;15916.602084947968;15972.281247343664;17256.396026139024;20326;20863.478413039797;21012;21087.472813179178;21271.149154034283;17404.477865664052;17544.21051052731;18440.81559184391;18642.90678546653;18886.7166992498;18028.54928626795;18037.549061273046;18397.81602183961;18473.81526184721;18476.260949561867;18267;18338.991355475577;18608.7208691867;18707.81292187115;18721.90639046796;12980.480780769041;13468.663283417602;14227.14637121776;14290.428382864984;14301.64245893861;13163.341832908125;13381.19712817234;14341.498047568284;14511.274436278354;14631.122132672073 18:44:25 INFO - PID 3673 | __end_tp_report 18:44:25 INFO - PID 3673 | __start_cc_report 18:44:25 INFO - PID 3673 | _x_x_mozilla_cycle_collect,373 18:44:25 INFO - PID 3673 | __end_cc_report 18:44:25 INFO - PID 3673 | __startTimestamp1504143865775__endTimestamp 18:44:25 INFO - PID 3673 | 18:44:25 INFO - PID 3673 | ------- Summary: start ------- 18:44:25 INFO - PID 3673 | Number of tests: 6 18:44:25 INFO - PID 3673 | 18:44:25 INFO - PID 3673 | [#0] dojo.html Cycles:165 Average:6871.63 Median:7153.43 stddev:754.11 (10.5%) stddev-sans-first:719.66 18:44:25 INFO - PID 3673 | Values: 3906.9 3936.1 3952.0 3994.0 4009.8 6820.3 6859.2 6869.5 6879.3 6903.1 6950.0 7058.0 7064.5 7072.3 7072.4 6174.9 6176.2 6217.8 6241.3 6263.3 6075.9 6119.6 6209.0 6214.1 6352.3 6070.1 6096.9 6099.8 6202.3 6205.3 6128.8 6131.5 6242.0 6257.9 6263.5 6134.1 6144.7 6198.4 6230.3 6246.6 6728.3 6825.6 6837.4 6927.7 6940.9 7341.6 7377.2 7447.3 7465.9 7484.4 7476.4 7513.1 7518.4 7581.1 7632.3 6783.9 6859.2 6946.1 6979.9 7037.4 7537.8 7635.4 7651.7 7652.7 7681.0 7337.8 7391.0 7395.5 7486.3 7496.2 7509.1 7512.0 7514.7 7588.4 7641.4 7264.1 7431.3 7478.9 7568.6 7571.3 7368.1 7384.8 7414.7 7494.9 7532.5 6355.3 6456.9 6459.9 6481.5 6483.3 5454.8 5464.8 5492.4 5517.3 5548.4 6284.2 6347.7 6379.6 6412.0 6458.9 7384.0 7478.9 7525.3 7531.1 7557.3 6362.2 6365.9 6371.2 6398.4 6444.6 6654.5 6668.6 6721.9 6805.5 6807.5 7121.7 7204.8 7239.5 7304.3 7312.5 7363.4 7470.0 7473.3 7477.0 7480.2 7254.9 7329.0 7338.3 7340.1 7340.6 7364.9 7416.1 7473.2 7504.2 7509.6 7402.1 7426.0 7453.1 7529.1 7591.0 7042.7 7153.4 7154.2 7155.2 7196.4 7227.5 7233.2 7267.6 7286.3 7302.7 7196.9 7201.9 7279.9 7280.1 7294.8 7226.1 7226.8 7237.4 7276.2 7328.2 6449.1 6979.5 7015.4 7060.3 7066.2 18:44:25 INFO - PID 3673 | 18:44:25 INFO - PID 3673 | [#1] ext.html Cycles:180 Average:40653.63 Median:37603.68 stddev:59004.84 (156.9%) stddev-sans-first:59094.79 18:44:25 INFO - PID 3673 | Values: 882.0 948.1 970.1 1000.1 1001.0 41825.4 42367.4 42567.1 42712.0 42794.8 39390.4 39620.8 39636.2 39701.4 39804.2 7163.4 7293.3 7296.1 7297.5 7297.7 7160.4 7244.8 7254.1 7255.1 7257.2 7250.1 7944.3 8130.5 8133.6 8135.8 8044.4 8059.8 8062.0 8102.1 8113.6 7810.8 7891.9 7892.3 7896.0 7899.0 38768.2 38932.2 38935.4 39006.2 39011.6 3496.0 3523.4 3524.8 3526.4 3527.4 31845.0 31947.8 32022.8 32060.0 32250.4 5431.2 5436.7 5445.2 5499.9 5504.1 203860.0 205090.0 207786.0 208304.0 218334.0 51150.5 51475.2 51687.0 51888.7 51934.7 53641.2 53783.7 53978.7 54020.0 54043.0 15459.8 15581.8 15604.7 15606.9 15656.7 12557.9 12578.9 12608.2 12637.0 12649.7 14903.5 14926.9 14968.7 15068.1 15195.4 5952.2 5996.6 6036.3 6050.7 6063.4 1094.1 1113.7 1113.8 1114.4 1118.9 25005.0 25079.2 25105.5 25255.6 25345.7 1171.7 1200.3 1204.7 1204.7 1208.3 13106.9 13238.1 13403.8 13450.7 13593.6 284038.0 285443.0 286348.0 286776.0 287292.0 54915.0 55199.0 58757.4 59759.4 59762.0 1465.8 1468.3 1490.1 1490.7 1498.8 29574.0 29926.3 30324.5 30483.4 30705.8 40544.2 40639.8 40676.4 40740.8 40816.2 169095.0 169160.0 169330.0 169423.0 169656.2 35051.3 40933.6 41341.4 41520.0 41735.2 49175.8 49550.0 49715.8 50261.7 50356.2 37018.6 37117.0 37127.3 37146.0 37304.0 37006.6 37373.6 37593.7 37613.6 38239.2 44013.3 44030.0 44092.0 44209.0 44360.3 35464.0 35500.6 35995.1 36469.6 36836.8 26931.0 27734.3 27982.4 27997.2 28047.3 18:44:25 INFO - PID 3673 | 18:44:25 INFO - PID 3673 | [#2] jquery.html Cycles:180 Average:43635.99 Median:22856.77 stddev:111148.80 (486.3%) stddev-sans-first:111413.63 18:44:25 INFO - PID 3673 | Values: 598.3 602.3 602.4 610.7 618.9 22830.9 23205.8 23570.4 23593.1 23606.9 22550.8 22882.7 22946.4 22953.4 22964.6 6783.7 6926.8 6931.1 6936.8 6941.4 6499.8 6725.1 6780.2 6798.6 6807.3 6747.4 6755.1 6757.7 6760.3 6771.9 6767.0 6774.4 6779.7 6779.8 6792.3 6264.7 6311.9 6318.4 6325.3 6331.3 29774.9 30790.2 31322.8 31418.2 31510.5 2212.6 2236.6 2239.0 2239.9 2240.6 19821.9 20398.4 20427.5 20428.3 20449.6 2431.6 2485.3 2538.9 2569.4 2582.9 150446.0 152735.2 153010.2 153140.0 153230.0 15584.5 16265.9 16578.7 16801.0 16818.3 26318.6 48990.3 49956.3 50195.5 50241.7 11524.3 11822.3 12054.2 12115.5 12124.3 9247.4 9753.7 9774.9 9824.2 9858.1 12213.6 12825.3 12889.7 12923.7 12941.0 4384.4 4493.3 4508.6 4557.5 4562.7 1045.6 1063.5 1069.7 1073.4 1077.4 22018.6 22651.2 22672.8 22955.7 23159.5 1066.4 1100.2 1100.6 1117.1 1129.1 12217.9 12751.2 12766.2 12785.3 12843.2 637740.0 662423.0 663188.0 681307.0 686859.0 139090.3 140047.0 142237.0 142529.0 143133.0 1281.5 1287.2 1314.4 1318.7 1322.0 19704.1 19722.5 19775.4 19988.1 20091.0 64714.7 68967.3 72096.0 72351.3 76026.0 86487.6 88338.0 91093.1 92156.0 97037.0 22211.4 23017.3 23041.7 23375.4 23893.0 26355.6 26889.2 27019.6 27134.9 27136.5 20887.0 21038.9 21669.8 21773.2 21777.0 16166.4 17402.6 17412.0 17520.8 18200.7 20744.8 21437.8 21471.1 21640.2 22069.7 22035.6 22199.8 22317.3 22349.2 22352.6 20747.3 20749.9 20817.9 20985.6 21011.2 18:44:25 INFO - PID 3673 | 18:44:25 INFO - PID 3673 | [#3] mootools.html Cycles:180 Average:10286.87 Median:13831.49 stddev:7624.91 (55.1%) stddev-sans-first:7617.34 18:44:25 INFO - PID 3673 | Values: 1440.9 1484.3 1497.6 1503.8 1513.4 16298.5 16569.0 17177.8 17184.4 17248.3 16261.7 17552.0 17584.6 17597.4 17637.4 2768.4 2824.5 2829.0 2829.3 2830.2 2627.8 2691.9 2704.4 2706.8 2709.3 2640.1 2663.8 2666.4 2666.7 2669.9 2536.2 2555.6 2566.4 2698.9 2758.4 2394.2 2398.5 2406.4 2408.7 2411.6 16062.4 16068.6 16271.1 16291.2 16300.9 8312.2 8619.7 8620.4 8637.2 8638.6 5593.1 5629.9 5734.0 5777.6 5785.9 2126.9 2128.8 2131.3 2138.5 2170.0 29892.4 30554.0 30610.0 30611.4 30643.5 7538.5 7546.0 7662.2 7798.3 7869.6 17999.6 18093.1 18110.8 18120.5 18121.5 8273.8 8386.3 8387.7 8390.5 8394.9 7548.7 7596.1 7610.1 7641.8 7646.7 5588.0 5790.5 5790.7 5830.6 5837.3 1443.7 1475.8 1553.5 1663.9 1689.7 961.7 997.6 1008.2 1014.1 1015.4 9265.5 9369.9 9627.6 9631.4 9644.2 962.9 1047.3 1054.0 1056.7 1086.3 5552.8 5640.9 5700.8 5813.4 5951.6 23474.5 24143.0 24172.9 24527.1 25409.9 24637.0 24824.6 24948.1 25123.2 25126.7 11478.6 11890.9 11918.3 12012.2 12013.8 8815.3 8950.0 9158.2 9373.3 9393.0 20471.3 20939.8 21330.4 21577.1 21729.7 21549.4 21554.1 21641.1 22063.3 22228.6 12991.2 13259.8 13288.3 13291.3 13302.0 15403.5 15514.3 15620.6 15696.5 15794.1 10948.5 11013.3 11160.8 12552.4 12584.7 11276.1 11574.4 11701.2 11768.8 11880.5 9434.4 9642.3 9649.9 9680.8 9689.9 8255.2 8267.6 8477.8 8518.9 8553.4 8414.5 8552.3 8553.4 8566.9 8615.2 18:44:25 INFO - PID 3673 | 18:44:25 INFO - PID 3673 | [#4] prototype.html Cycles:180 Average:6004.05 Median:6727.53 stddev:1683.04 (25.0%) stddev-sans-first:1637.41 18:44:25 INFO - PID 3673 | Values: 559.8 564.9 571.2 587.7 593.0 6720.6 6756.2 6783.9 6821.5 6841.6 6734.4 6754.1 6770.8 6777.6 6803.8 5479.2 5517.4 5518.8 5539.6 5550.1 5154.3 5362.0 5477.4 5507.8 5543.3 5289.5 5339.6 5341.2 5357.7 5366.1 5291.0 5309.3 5317.4 5325.4 5343.8 4693.4 4735.2 4747.6 4754.9 4825.3 6643.3 6652.5 6664.9 6672.1 6688.5 6254.3 6270.5 6298.5 6300.8 6304.3 7135.8 7175.6 7196.5 7224.5 7237.6 5260.7 5304.2 5341.5 5347.5 5378.5 7166.5 7236.8 7287.9 7369.3 7556.0 5350.5 5371.4 5387.9 5481.5 5486.9 5528.6 5546.3 5572.9 5587.2 5590.9 6146.7 6177.7 6178.6 6191.7 6200.7 7163.8 7175.1 7180.0 7197.2 7234.2 1930.7 1931.4 1937.7 1957.2 1959.2 1264.3 1334.2 1345.2 1347.3 1350.6 6166.8 6168.2 6180.7 6214.2 6281.6 7133.4 7187.6 7294.1 7353.7 7394.9 6164.2 6165.3 6234.9 6294.4 6315.7 3874.8 3907.7 3922.5 3931.7 3948.6 7083.8 7084.0 7086.3 7108.4 7155.6 7533.8 7562.8 7563.4 7567.9 7618.5 7158.6 7166.9 7172.2 7174.6 7202.3 7231.2 7287.5 7313.4 7321.7 7382.5 7314.7 7321.7 7323.8 7324.6 7395.9 7067.8 7085.9 7121.4 7125.0 7163.9 5502.6 5514.2 5515.9 5516.7 5529.6 7057.6 7201.3 7315.5 7381.3 7396.9 7033.5 7045.8 7050.4 7080.3 7123.8 7043.4 7067.9 7068.0 7075.3 7076.9 7019.3 7031.8 7050.7 7064.6 7102.7 6855.8 7117.5 7138.8 7155.2 7183.9 6935.5 6949.3 6979.7 6989.2 6997.8 18:44:25 INFO - PID 3673 | 18:44:25 INFO - PID 3673 | [#5] yui.html Cycles:180 Average:26668.15 Median:18475.04 stddev:39337.45 (212.9%) stddev-sans-first:39400.42 18:44:25 INFO - PID 3673 | Values: 952.7 975.0 999.2 1006.3 1008.6 18728.6 19589.7 19597.7 19603.5 20418.4 19966.0 20646.8 20704.2 20706.5 20712.5 1063.0 1074.9 1076.4 1079.4 1079.8 1041.5 1079.9 1081.7 1084.0 1084.9 1151.3 1152.5 1156.4 1156.4 1158.0 1145.7 1147.0 1148.3 1149.8 1151.9 836.8 839.0 839.6 842.6 844.8 18836.6 18884.1 18921.7 19142.9 19155.4 20562.5 20993.2 21033.0 21041.3 21083.0 17270.7 17318.7 17620.6 17762.1 17794.0 3955.9 3982.4 3987.4 3989.2 3990.1 139900.0 140722.0 141106.3 141722.3 141789.0 15769.4 15998.2 16119.3 16156.8 16179.4 26971.1 27114.6 27531.6 27651.4 27678.6 8258.5 8485.4 8487.9 8737.3 9081.2 4375.4 4435.0 4435.2 4442.6 4443.3 5293.9 5300.3 5372.8 5411.2 5449.9 1108.2 1138.7 1139.5 1141.1 1143.5 703.9 717.9 726.4 729.9 748.4 11934.9 12047.3 12288.2 12304.7 12483.8 758.0 762.3 765.9 775.5 776.0 5608.5 5662.8 5677.3 5684.0 5773.9 140072.0 141889.0 144024.0 144845.0 147839.0 120029.0 122706.4 124240.0 125039.4 126845.0 107479.0 109854.5 111826.4 114441.9 114536.4 10368.6 10424.6 10491.9 10504.8 10574.8 52107.5 52827.7 53262.2 53513.5 54324.2 64700.7 64997.0 66400.3 66414.3 67540.3 15826.5 15915.4 15916.6 15972.3 17256.4 20326.0 20863.5 21012.0 21087.5 21271.1 17404.5 17544.2 18440.8 18642.9 18886.7 18028.5 18037.5 18397.8 18473.8 18476.3 18267.0 18339.0 18608.7 18707.8 18721.9 12980.5 13468.7 14227.1 14290.4 14301.6 13163.3 13381.2 14341.5 14511.3 14631.1 18:44:25 INFO - PID 3673 | -------- Summary: end -------- 18:44:25 INFO - PID 3673 | 18:44:26 INFO - TEST-INFO | 3673: exit 0 18:44:26 INFO - TEST-OK | dromaeo_css | took 1110286ms 18:44:26 INFO - TEST-START | kraken 18:44:26 INFO - Initialising browser for kraken test... 18:44:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44456/getInfo.html -profile /tmp/tmpzF8z2M/profile 18:44:26 INFO - TEST-INFO | started process 4045 (/builds/slave/test/build/application/firefox/firefox http://localhost:44456/getInfo.html) 18:44:31 INFO - TEST-INFO | 4045: exit 0 18:44:32 INFO - Browser initialized. 18:44:32 INFO - Running cycle 1/1 for kraken test... 18:44:32 INFO - Using env: {'DISPLAY': ':0', 18:44:32 INFO - 'HOME': '/home/cltbld', 18:44:32 INFO - 'JSGC_DISABLE_POISONING': '1', 18:44:32 INFO - 'LANG': 'en_US.UTF-8', 18:44:32 INFO - 'LANGUAGE': 'en_US:en', 18:44:32 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:44:32 INFO - 'LOGNAME': 'cltbld', 18:44:32 INFO - 'MAIL': '/var/mail/cltbld', 18:44:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:44:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:44:32 INFO - 'MOZ_CRASHREPORTER': '1', 18:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:32 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:44:32 INFO - 'MOZ_NO_REMOTE': '1', 18:44:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:44:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:32 INFO - 'NO_EM_RESTART': '1', 18:44:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:32 INFO - 'PWD': '/builds/slave/test', 18:44:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:44:32 INFO - 'RUST_BACKTRACE': 'full', 18:44:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:44:32 INFO - 'SHELL': '/bin/bash', 18:44:32 INFO - 'SHLVL': '1', 18:44:32 INFO - 'TERM': 'linux', 18:44:32 INFO - 'TMOUT': '86400', 18:44:32 INFO - 'USER': 'cltbld', 18:44:32 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238', 18:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:32 INFO - '_': '/tools/buildbot/bin/python'} 18:44:32 INFO - TEST-INFO | started process 4234 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzF8z2M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:44:32 INFO - PID 4234 | 18:44:32 INFO - PID 4234 | (/builds/slave/test/build/application/firefox/firefox:4285): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:44:32 INFO - PID 4234 | 18:44:43 INFO - PID 4234 | RSS: Main: 161697792 18:44:43 INFO - PID 4234 | 18:44:45 INFO - PID 4234 | Cycle 1(1): loaded http://localhost:44456/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44456/tests/kraken/driver.html?testName=audio-beat-detection) 18:44:46 INFO - PID 4234 | RSS: Main: 167473152 18:44:46 INFO - PID 4234 | 18:44:49 INFO - PID 4234 | Cycle 1(1): loaded http://localhost:44456/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44456/tests/kraken/driver.html?testName=audio-dft) 18:44:49 INFO - PID 4234 | RSS: Main: 171802624 18:44:49 INFO - PID 4234 | 18:44:52 INFO - PID 4234 | Cycle 1(1): loaded http://localhost:44456/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44456/tests/kraken/driver.html?testName=audio-fft) 18:44:53 INFO - PID 4234 | RSS: Main: 163717120 18:44:53 INFO - PID 4234 | 18:44:55 INFO - PID 4234 | Cycle 1(1): loaded http://localhost:44456/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44456/tests/kraken/driver.html?testName=audio-oscillator) 18:44:56 INFO - PID 4234 | RSS: Main: 165019648 18:44:56 INFO - PID 4234 | 18:44:58 INFO - PID 4234 | Cycle 1(1): loaded http://localhost:44456/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44456/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:44:58 INFO - PID 4234 | RSS: Main: 165486592 18:44:58 INFO - PID 4234 | 18:45:01 INFO - PID 4234 | Cycle 1(1): loaded http://localhost:44456/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44456/tests/kraken/driver.html?testName=imaging-darkroom) 18:45:02 INFO - PID 4234 | RSS: Main: 165085184 18:45:02 INFO - PID 4234 | 18:45:05 INFO - PID 4234 | Cycle 1(1): loaded http://localhost:44456/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44456/tests/kraken/driver.html?testName=imaging-desaturate) 18:45:06 INFO - PID 4234 | RSS: Main: 166690816 18:45:06 INFO - PID 4234 | 18:45:09 INFO - PID 4234 | Cycle 1(1): loaded http://localhost:44456/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44456/tests/kraken/driver.html?testName=json-parse-financial) 18:45:09 INFO - PID 4234 | RSS: Main: 166834176 18:45:09 INFO - PID 4234 | 18:45:11 INFO - PID 4234 | Cycle 1(1): loaded http://localhost:44456/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44456/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:45:11 INFO - PID 4234 | RSS: Main: 166481920 18:45:11 INFO - PID 4234 | 18:45:13 INFO - PID 4234 | Cycle 1(1): loaded http://localhost:44456/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44456/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:45:14 INFO - PID 4234 | RSS: Main: 166379520 18:45:14 INFO - PID 4234 | 18:45:16 INFO - PID 4234 | Cycle 1(1): loaded http://localhost:44456/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44456/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:45:16 INFO - PID 4234 | RSS: Main: 163569664 18:45:16 INFO - PID 4234 | 18:45:19 INFO - PID 4234 | Cycle 1(1): loaded http://localhost:44456/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44456/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:45:20 INFO - PID 4234 | RSS: Main: 163332096 18:45:20 INFO - PID 4234 | 18:45:22 INFO - PID 4234 | Cycle 1(1): loaded http://localhost:44456/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44456/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:45:23 INFO - PID 4234 | RSS: Main: 163581952 18:45:23 INFO - PID 4234 | 18:45:24 INFO - PID 4234 | Cycle 1(1): loaded http://localhost:44456/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44456/tests/kraken/driver.html?testName=ai-astar) 18:45:25 INFO - PID 4234 | RSS: Main: 165662720 18:45:25 INFO - PID 4234 | 18:45:25 INFO - PID 4234 | __start_tp_report 18:45:25 INFO - PID 4234 | _x_x_mozilla_page_load 18:45:25 INFO - PID 4234 | _x_x_mozilla_page_load_details 18:45:25 INFO - PID 4234 | |i|pagename|runs| 18:45:25 INFO - PID 4234 | |0;ai-astar;96;106;99;104;105;107;106;95;106;107 18:45:25 INFO - PID 4234 | |1;audio-beat-detection;134;113;137;170;111;142;141;118;172;118 18:45:25 INFO - PID 4234 | |2;audio-dft;161;161;160;160;162;161;162;160;162;164 18:45:25 INFO - PID 4234 | |3;audio-fft;74;72;74;174;74;73;73;74;154;74 18:45:25 INFO - PID 4234 | |4;audio-oscillator;77;77;134;78;78;77;122;78;78;134 18:45:25 INFO - PID 4234 | |5;imaging-gaussian-blur;113;114;113;113;114;114;113;114;113;113 18:45:25 INFO - PID 4234 | |6;imaging-darkroom;151;149;153;161;149;149;149;151;149;149 18:45:25 INFO - PID 4234 | |7;imaging-desaturate;94;94;94;94;94;94;93;100;93;94 18:45:25 INFO - PID 4234 | |8;json-parse-financial;45;47;46;44;44;46;44;45;45;47 18:45:25 INFO - PID 4234 | |9;json-stringify-tinderbox;39;39;38;38;39;38;39;39;39;39 18:45:25 INFO - PID 4234 | |10;stanford-crypto-aes;73;74;73;73;75;75;72;72;76;72 18:45:25 INFO - PID 4234 | |11;stanford-crypto-ccm;112;118;112;125;117;117;113;111;122;148 18:45:25 INFO - PID 4234 | |12;stanford-crypto-pbkdf2;162;161;156;161;154;152;156;160;155;153 18:45:25 INFO - PID 4234 | |13;stanford-crypto-sha256-iterative;63;61;61;60;59;57;61;66;61;57 18:45:25 INFO - PID 4234 | __end_tp_report 18:45:25 INFO - PID 4234 | __start_cc_report 18:45:25 INFO - PID 4234 | _x_x_mozilla_cycle_collect,890 18:45:25 INFO - PID 4234 | __end_cc_report 18:45:25 INFO - PID 4234 | __startTimestamp1504143925248__endTimestamp 18:45:25 INFO - PID 4234 | 18:45:25 INFO - PID 4234 | ------- Summary: start ------- 18:45:25 INFO - PID 4234 | Number of tests: 14 18:45:25 INFO - PID 4234 | 18:45:25 INFO - PID 4234 | [#0] ai-astar Cycles:10 Average:103.10 Median:107.00 stddev:4.63 (4.3%) stddev-sans-first:4.14 18:45:25 INFO - PID 4234 | Values: 96.0 106.0 99.0 104.0 105.0 107.0 106.0 95.0 106.0 107.0 18:45:25 INFO - PID 4234 | 18:45:25 INFO - PID 4234 | [#1] audio-beat-detection Cycles:10 Average:135.60 Median:139.00 stddev:21.90 (15.8%) stddev-sans-first:23.23 18:45:25 INFO - PID 4234 | Values: 134.0 113.0 137.0 170.0 111.0 142.0 141.0 118.0 172.0 118.0 18:45:25 INFO - PID 4234 | 18:45:25 INFO - PID 4234 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.32 18:45:25 INFO - PID 4234 | Values: 161.0 161.0 160.0 160.0 162.0 161.0 162.0 160.0 162.0 164.0 18:45:25 INFO - PID 4234 | 18:45:25 INFO - PID 4234 | [#3] audio-fft Cycles:10 Average:91.60 Median:74.00 stddev:38.45 (52.0%) stddev-sans-first:40.26 18:45:25 INFO - PID 4234 | Values: 74.0 72.0 74.0 174.0 74.0 73.0 73.0 74.0 154.0 74.0 18:45:25 INFO - PID 4234 | 18:45:25 INFO - PID 4234 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:77.50 stddev:25.54 (33.0%) stddev-sans-first:26.40 18:45:25 INFO - PID 4234 | Values: 77.0 77.0 134.0 78.0 78.0 77.0 122.0 78.0 78.0 134.0 18:45:25 INFO - PID 4234 | 18:45:25 INFO - PID 4234 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:113.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 18:45:25 INFO - PID 4234 | Values: 113.0 114.0 113.0 113.0 114.0 114.0 113.0 114.0 113.0 113.0 18:45:25 INFO - PID 4234 | 18:45:25 INFO - PID 4234 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:150.00 stddev:3.77 (2.5%) stddev-sans-first:4.00 18:45:25 INFO - PID 4234 | Values: 151.0 149.0 153.0 161.0 149.0 149.0 149.0 151.0 149.0 149.0 18:45:25 INFO - PID 4234 | 18:45:25 INFO - PID 4234 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:2.01 (2.1%) stddev-sans-first:2.13 18:45:25 INFO - PID 4234 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 93.0 100.0 93.0 94.0 18:45:25 INFO - PID 4234 | 18:45:25 INFO - PID 4234 | [#8] json-parse-financial Cycles:10 Average:45.30 Median:45.50 stddev:1.16 (2.5%) stddev-sans-first:1.22 18:45:25 INFO - PID 4234 | Values: 45.0 47.0 46.0 44.0 44.0 46.0 44.0 45.0 45.0 47.0 18:45:25 INFO - PID 4234 | 18:45:25 INFO - PID 4234 | [#9] json-stringify-tinderbox Cycles:10 Average:38.70 Median:39.00 stddev:0.48 (1.2%) stddev-sans-first:0.50 18:45:25 INFO - PID 4234 | Values: 39.0 39.0 38.0 38.0 39.0 38.0 39.0 39.0 39.0 39.0 18:45:25 INFO - PID 4234 | 18:45:25 INFO - PID 4234 | [#10] stanford-crypto-aes Cycles:10 Average:73.50 Median:73.50 stddev:1.43 (2.0%) stddev-sans-first:1.51 18:45:25 INFO - PID 4234 | Values: 73.0 74.0 73.0 73.0 75.0 75.0 72.0 72.0 76.0 72.0 18:45:25 INFO - PID 4234 | 18:45:25 INFO - PID 4234 | [#11] stanford-crypto-ccm Cycles:10 Average:119.50 Median:117.50 stddev:11.01 (9.4%) stddev-sans-first:11.34 18:45:25 INFO - PID 4234 | Values: 112.0 118.0 112.0 125.0 117.0 117.0 113.0 111.0 122.0 148.0 18:45:25 INFO - PID 4234 | 18:45:25 INFO - PID 4234 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.00 Median:158.00 stddev:3.68 (2.3%) stddev-sans-first:3.43 18:45:25 INFO - PID 4234 | Values: 162.0 161.0 156.0 161.0 154.0 152.0 156.0 160.0 155.0 153.0 18:45:25 INFO - PID 4234 | 18:45:25 INFO - PID 4234 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.60 Median:61.00 stddev:2.67 (4.4%) stddev-sans-first:2.69 18:45:25 INFO - PID 4234 | Values: 63.0 61.0 61.0 60.0 59.0 57.0 61.0 66.0 61.0 57.0 18:45:25 INFO - PID 4234 | -------- Summary: end -------- 18:45:25 INFO - PID 4234 | 18:45:25 INFO - PID 4234 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:45:25 INFO - TEST-INFO | 4234: exit 0 18:45:25 INFO - TEST-OK | kraken | took 59454ms 18:45:25 INFO - SUITE-END | took 1169s 18:45:25 INFO - Completed test suite (00:19:29) 18:45:25 INFO - javascript benchmark 18:45:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9339.863694199756, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3906.863259785908, 3936.0946982194096, 3951.960480395196, 3993.960060399396, 4009.7794621295834, 6820.283870193626, 6859.245482996873, 6869.484788640853, 6879.346462086094, 6903.068085808414, 6950.0, 7058.047163632908, 7064.47016473764, 7072.328128827753, 7072.363487286143, 6174.938250617482, 6176.166217560639, 6217.782377616784, 6241.313455519889, 6263.31103578606, 6075.939240607604, 6119.571629985903, 6209.0, 6214.098955651428, 6352.269489008754, 6070.0591408331775, 6096.878062438748, 6099.847503812418, 6202.317745048041, 6205.3484384139465, 6128.785492507741, 6131.50947924165, 6242.032484964792, 6257.87484250317, 6263.498920086382, 6134.141220229171, 6144.692765361759, 6198.411150940653, 6230.283517395512, 6246.625202487865, 6728.3271672832325, 6825.55633883796, 6837.35045170708, 6927.7228910844005, 6940.895886561706, 7341.5962122083265, 7377.188509263977, 7447.292507211806, 7465.8506829863645, 7484.363829074535, 7476.36450901674, 7513.135989361239, 7518.360939320164, 7581.090269167735, 7632.3130918217075, 6783.898241526381, 6859.17689877208, 6946.0622815919705, 6979.860402791966, 7037.401820845234, 7537.773866784005, 7635.427342949301, 7651.69393224276, 7652.655630496641, 7681.0, 7337.816554586178, 7391.039164908528, 7395.527309790824, 7486.288802563748, 7496.175420703718, 7509.061367329084, 7511.962440187874, 7514.736984205527, 7588.430867684946, 7641.3886889048745, 7264.091988501437, 7431.256874312526, 7478.850422991619, 7568.621568921532, 7571.280728330799, 7368.115826100902, 7384.815379615445, 7414.666340014713, 7494.85010299791, 7532.510386824839, 6355.269144048401, 6456.935430645727, 6459.870802583922, 6481.546291759626, 6483.286838447767, 5454.754536045887, 5464.754086066137, 5492.395836457987, 5517.282753242052, 5548.389677135512, 6284.151639528605, 6347.650879201596, 6379.55343125986, 6412.038194270896, 6458.870822583616, 7384.040074790243, 7478.887816682754, 7525.3227209551405, 7531.058617672791, 7557.319841214317, 6362.204724409449, 6365.936340636627, 6371.171747672773, 6398.392152745481, 6444.613323200623, 6654.500912431587, 6668.599884006975, 6721.899171512431, 6805.455563554904, 6807.523473356818, 7121.679524421414, 7204.819879503054, 7239.457040721862, 7304.342609165201, 7312.5246858954, 7363.447741419523, 7469.962650186714, 7473.327400533978, 7476.962615186889, 7480.214577469287, 7254.854902902018, 7328.96335518319, 7338.266173382619, 7340.11918569775, 7340.596267205355, 7364.889526656997, 7416.110066791804, 7473.215312392121, 7504.2120577340775, 7509.5869727163345, 7402.074740657418, 7426.0, 7453.068366454193, 7529.13414957265, 7590.962045189739, 7042.718291268497, 7153.4277257820295, 7154.177269614061, 7155.24869888675, 7196.388306993964, 7227.530210536298, 7233.240509746612, 7267.563946163247, 7286.307800758919, 7302.707891684273, 7196.8920466192, 7201.855962880608, 7279.927200728137, 7280.0535930328715, 7294.817629559304, 7226.132864056137, 7226.819329516594, 7237.384822290164, 7276.1996180419055, 7328.230535793665, 6449.12936753551, 6979.4765392594745, 7015.36861682451, 7060.258672839484, 7066.222715501188], "value": 6822.694465597897, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [881.9955900220498, 948.09456968595, 970.1123472023098, 1000.1248907206194, 1001.0240015984416, 41825.37261941074, 42367.36448953264, 42567.14865702684, 42712.0, 42794.7860260699, 39390.409143862795, 39620.80189599055, 39636.20727585447, 39701.40447893277, 39804.203915921666, 7163.35529802319, 7293.270672932691, 7296.087989001375, 7297.452691048166, 7297.708091676326, 7160.355567998879, 7244.782656520313, 7254.056972593556, 7255.129384473844, 7257.165425976027, 7250.1299844018795, 7944.324732397753, 8130.471519351253, 8133.593320333989, 8135.837283254331, 8044.356451483896, 8059.758207253792, 8062.0, 8102.108768035511, 8113.634886430095, 7810.843783124363, 7891.921080789176, 7892.289693927574, 7896.0, 7899.0, 38768.22463550742, 38932.22135557301, 38935.41596876049, 39006.21987560261, 39011.609883901365, 3496.0036389628835, 3523.3834079036064, 3524.753267271292, 3526.400511912955, 3527.3650742866275, 31845.0, 31947.84026079878, 32022.839885800655, 32060.0, 32250.354992900244, 5431.212474191259, 5436.700981446019, 5445.237666726662, 5499.862503437406, 5504.0643090674685, 203860.0, 205090.0, 207786.0, 208304.0, 218334.0, 51150.48849511457, 51475.227871581956, 51687.0, 51888.74055629698, 51934.740326298124, 53641.19538206852, 53783.731081345126, 53978.73010634922, 54020.0, 54043.0, 15459.768103478456, 15581.844181558266, 15604.687906241812, 15606.9219653901, 15656.686866262611, 12557.93721031389, 12578.930790882878, 12608.180468269717, 12637.0, 12649.683757906127, 14903.478378256708, 14926.850731492763, 14968.70062598742, 15068.095914245181, 15195.392184312504, 5952.196453478725, 5996.569399844395, 6036.275646922398, 6050.6672133032225, 6063.363346848606, 1094.0973696700255, 1113.7494063835572, 1113.821788513834, 1114.4260705736551, 1118.8601424821898, 25005.0, 25079.24762257135, 25105.497890042097, 25255.62116568253, 25345.746542534707, 1171.6953592065954, 1200.2678366196612, 1204.692803335144, 1204.7349583091882, 1208.323338930202, 13106.934465327613, 13238.139520931109, 13403.798943015863, 13450.663733406744, 13593.59219223425, 284038.0, 285443.0, 286348.0, 286776.0, 287292.0, 54915.0, 55199.0, 58757.41242587519, 59759.40240597539, 59762.0, 1465.824101107874, 1468.3319089814322, 1490.1133825373886, 1490.6646004648867, 1498.8051553298, 29574.0, 29926.25184370408, 30324.54513182348, 30483.390332193674, 30705.846470767505, 40544.1891162181, 40639.79680101581, 40676.38985415162, 40740.79629601833, 40816.183676325716, 169095.0, 169160.0, 169330.0, 169423.0, 169656.15171924062, 35051.29897401987, 40933.59066409417, 41341.37987930243, 41520.0, 41735.165296694504, 49175.754121230595, 49550.0, 49715.75142124266, 50261.74869125631, 50356.24465632945, 37018.62981370152, 37117.0, 37127.25745485021, 37146.0, 37304.0, 37006.629933700315, 37373.62626373702, 37593.745331407146, 37613.623863761015, 38239.235215296096, 44013.33979990367, 44030.0, 44092.0, 44209.0, 44360.334594981745, 35464.0, 35500.64499354974, 35995.10012249715, 36469.635303646624, 36836.81581592075, 26931.0, 27734.306642334104, 27982.44035119327, 27997.160085197476, 28047.298817529725], "value": 18329.389729950017, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.2521847690382, 602.32840382973, 602.3765402808092, 610.6946526736632, 618.8700372921686, 22830.88584557077, 23205.76794232057, 23570.410739731517, 23593.056277748892, 23606.88196559015, 22550.774492255074, 22882.65676014857, 22946.426339341484, 22953.4261643459, 22964.588718184557, 6783.694733736994, 6926.792196234121, 6931.098957135565, 6936.757213497529, 6941.375276225139, 6499.837504062412, 6725.05849181115, 6780.186377634691, 6798.5580937239165, 6807.2512023677355, 6747.39273465388, 6755.054292399043, 6757.695903684322, 6760.32396760325, 6771.8984215236815, 6766.966165169192, 6774.424173945221, 6779.694913728894, 6779.762708305235, 6792.320767923193, 6264.686765661744, 6311.905321420182, 6318.399752023551, 6325.272593651743, 6331.271903731038, 29774.851125744448, 30790.23024424385, 31322.84338578315, 31418.21454463634, 31510.52734208989, 2212.5685491329195, 2236.6197746383154, 2239.0, 2239.944001399962, 2240.551889622066, 19821.900890495453, 20398.388048358574, 20427.48931276715, 20428.285010024578, 20449.591008179752, 2431.5744744669614, 2485.2792690119845, 2538.9492210155877, 2569.396191894903, 2582.8966841326323, 150446.0, 152735.2363238199, 153010.23494882564, 153140.0, 153230.0, 15584.454544090902, 16265.861389702844, 16578.66842663164, 16801.0, 16818.327266909186, 26318.6052209217, 48990.26514602284, 49956.25065624018, 50195.49804501981, 50241.748791255806, 11524.250923689933, 11822.34977076269, 12054.156209065457, 12115.454804533818, 12124.333161676192, 9247.352685311964, 9753.707388778206, 9774.902250977542, 9824.164945979672, 9858.063483969156, 12213.633590992284, 12825.29460879642, 12889.677758056123, 12923.676908077374, 12941.0, 4384.4081049058605, 4493.258612328995, 4508.571685689854, 4557.544245575482, 4562.726236425825, 1045.639254457211, 1063.5320458998017, 1069.7272195590074, 1073.4471747050275, 1077.3643550305358, 22018.559628807656, 22651.20720774798, 22672.773272267066, 22955.655665165035, 23159.53680926372, 1066.3814987307344, 1100.2463312630873, 1100.5597760895705, 1117.0895719988184, 1129.0572372069414, 12217.877821221851, 12751.234925904475, 12766.17019893704, 12785.296808675426, 12843.165194262343, 637740.0, 662423.0, 663188.0, 681307.0, 686859.0, 139090.30454847662, 140047.0, 142237.0, 142529.0, 143133.0, 1281.5258354408743, 1287.189070885355, 1314.4413624209672, 1318.7428451451874, 1321.9933900330436, 19704.11331490115, 19722.506937326107, 19775.40673779789, 19988.10053547623, 20090.99545022772, 64714.67642661757, 68967.31032689809, 72096.0, 72351.27648723657, 76026.0, 86487.5675621643, 88338.0, 91093.08906910846, 92156.0, 97037.0, 22211.444713882283, 23017.309480715605, 23041.65437518472, 23375.41561460977, 23893.0, 26355.60466593041, 26889.193324200307, 27019.59470607903, 27134.864325678245, 27136.457270854866, 20887.0, 21038.89480552649, 21669.78330216741, 21773.23793667214, 21777.0, 16166.353345866504, 17402.5649358762, 17412.0, 17520.82479175192, 18200.72698909491, 20744.792552074287, 21437.78562214358, 21471.141154353652, 21640.24259150922, 22069.668954965367, 22035.559288813813, 22199.77800221977, 22317.330480085624, 22349.217777377715, 22352.552948941255, 20747.27384541594, 20749.896250519254, 20817.89591052035, 20985.580288394453, 21011.159553617683], "value": 13903.455884698355, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.9351579178935, 1484.2578710644677, 1497.6255936015996, 1503.7819516170148, 1513.3946421431422, 16298.511044668649, 16569.0, 17177.82822171778, 17184.398546050892, 17248.310067597282, 16261.674766504662, 17552.0346380949, 17584.560385990324, 17597.3840915568, 17637.382691605795, 2768.418632087264, 2824.5057115004893, 2829.038127036807, 2829.278533973834, 2830.1792480180725, 2627.8291911025817, 2691.905783297585, 2704.4050308932005, 2706.796990225731, 2709.2684975056723, 2640.075973409311, 2663.7602615764577, 2666.4267182555745, 2666.693330267015, 2669.866506674668, 2536.226450932465, 2555.629433732117, 2566.4225549251364, 2698.8785504652337, 2758.3793646429594, 2394.150076722773, 2398.5322862041908, 2406.350285422926, 2408.6989126359204, 2411.553862535419, 16062.437814676547, 16068.59828504285, 16271.105089220087, 16291.185440728035, 16300.918495407566, 8312.1687831217, 8619.6983105591, 8620.353473489451, 8637.179467950535, 8638.611262493203, 5593.077142271521, 5629.915551266734, 5734.0, 5777.5666824987875, 5785.88428231433, 2126.8830214338204, 2128.7977642123974, 2131.3073251193423, 2138.5402138540135, 2170.045180120742, 29892.402151957056, 30554.0, 30610.0, 30611.387772244652, 30643.540346894813, 7538.472306938571, 7546.0, 7662.195469475625, 7798.298153166243, 7869.606519673994, 17999.64000719978, 18093.095345232687, 18110.81889181091, 18120.546986325448, 18121.456356309067, 8273.8345233095, 8386.329093672613, 8387.748367548984, 8390.496570205807, 8394.874076888851, 7548.698052077855, 7596.08846938371, 7610.124835643972, 7641.847163056819, 7646.732364367221, 5588.0, 5790.478856902899, 5790.71046447676, 5830.591858569859, 5837.3287071986415, 1443.718474897385, 1475.7712554554062, 1553.4718195813252, 1663.9084850333347, 1689.7465380192823, 961.7259081161835, 997.6009596161593, 1008.2337423558002, 1014.0873214107362, 1015.4465816130227, 9265.536723163816, 9369.922458917175, 9627.614895404246, 9631.422114673142, 9644.228461723045, 962.870012548311, 1047.2564479219686, 1053.9947300263602, 1056.6829951014665, 1086.2830531848942, 5552.750126244328, 5640.915386269209, 5700.828975130753, 5813.389594092644, 5951.642901425928, 23474.530509389715, 24143.0, 24172.87913560421, 24527.141550045664, 25409.872950635498, 24637.0, 24824.627630585557, 24948.12681556137, 25123.24630261095, 25126.748732512806, 11478.558562144986, 11890.881091188978, 11918.344491052902, 12012.219205751599, 12013.759724805455, 8815.338849586435, 8949.955250223707, 9158.175764181256, 9373.343865929319, 9393.0, 20471.283505077252, 20939.790602094392, 21330.360089197347, 21577.13691452387, 21729.674054889507, 21549.353519394444, 21554.137834486446, 21641.13435462627, 22063.33809985703, 22228.55542889101, 12991.155574887602, 13259.80110298327, 13288.26914519672, 13291.268980206181, 13302.0, 15403.537893863202, 15514.301856416263, 15620.609484762972, 15696.450624228097, 15794.131322777357, 10948.507317170906, 11013.2841365311, 11160.832587511357, 12552.372381381078, 12584.74830503403, 11276.097912166842, 11574.421278935852, 11701.180917335705, 11768.76462470763, 11880.524779008743, 9434.433933963985, 9642.276829237975, 9649.855252171083, 9680.75798105053, 9689.9031009689, 8255.174482551696, 8267.62795674208, 8477.788055298666, 8518.914810851813, 8553.401261911606, 8414.495130292202, 8552.315814734931, 8553.358498112791, 8566.91433085661, 8615.181557752003], "value": 7208.779169165214, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.8264537993223, 564.9237352957355, 571.191763654429, 587.667967598307, 592.9851753706157, 6720.630365329905, 6756.189257289126, 6783.864322713549, 6821.48838837088, 6841.5895046297255, 6734.427573656233, 6754.121964144667, 6770.763023294186, 6777.627230502333, 6803.795886123412, 5479.17812328152, 5517.36550296715, 5518.779248830042, 5539.584531160159, 5550.139728342114, 5154.32993710817, 5361.973190134044, 5477.370102438231, 5507.779688812443, 5543.334799824027, 5289.523942845143, 5339.5728341732565, 5341.225522299264, 5357.705326207057, 5366.06093933562, 5290.9735451322495, 5309.309789727311, 5317.388500322435, 5325.440828713007, 5343.759530821122, 4693.436787585511, 4735.242361222188, 4747.5787348452195, 4754.881127971828, 4825.276208568707, 6643.269240383554, 6652.501062420338, 6664.93335066648, 6672.099266599044, 6688.531802773808, 6254.343293954114, 6270.498360131179, 6298.527610429191, 6300.771349586832, 6304.27500837405, 7135.82160445993, 7175.605341706204, 7196.530636716134, 7224.458165637546, 7237.601931893743, 5260.684358938476, 5304.230886521433, 5341.4925582069645, 5347.46525347466, 5378.515933565959, 7166.462515311373, 7236.782896513113, 7287.886512911303, 7369.3367596916, 7556.0, 5350.545203657655, 5371.435999220103, 5387.9461205388225, 5481.479259470344, 5486.91769623448, 5528.640638358494, 5546.2823216623565, 5572.86067848307, 5587.217789509472, 5590.888182236333, 6146.7233974471255, 6177.722002509898, 6178.551442961061, 6191.659458729813, 6200.658963756947, 7163.785086447415, 7175.13898332193, 7179.96410017957, 7197.208307086216, 7234.240404757425, 1930.7103934409952, 1931.4398824341065, 1937.6899696048565, 1957.2171131547495, 1959.167353874626, 1264.3235868810143, 1334.1994803118246, 1345.2377385624864, 1347.3465369295884, 1350.628577141294, 6166.845828854314, 6168.167297414881, 6180.744028429591, 6214.223222097238, 6281.623102613858, 7133.393661538724, 7187.64061796908, 7294.124705035323, 7353.669084891193, 7394.889076663854, 6164.198654174928, 6165.32181460039, 6234.906476402857, 6294.370562943669, 6315.652639104802, 3874.8062596870045, 3907.7069219808627, 3922.490076290064, 3931.68546516278, 3948.624880636335, 7083.82290442743, 7083.964580177066, 7086.255943126001, 7108.440961253945, 7155.606441645656, 7533.8116547085665, 7562.848743025109, 7563.357114645207, 7567.886481702779, 7618.466707330434, 7158.642067896584, 7166.892496612555, 7172.246914073947, 7174.641267936478, 7202.315780000891, 7231.240719724353, 7287.453440991841, 7313.378362839218, 7321.670524826289, 7382.52013619113, 7314.707411703473, 7321.707131714672, 7323.791574390379, 7324.5971471567445, 7395.889061663972, 7067.752628658178, 7085.901685238796, 7121.359077683033, 7125.0, 7163.928360716326, 5502.642328248651, 5514.228008078792, 5515.862103447446, 5516.724163791875, 5529.640573362719, 7057.6123460740155, 7201.279872012757, 7315.451341149329, 7381.335679788845, 7396.889046664412, 7033.507654464139, 7045.823854403476, 7050.400715939202, 7080.256573059754, 7123.82190445243, 7043.436525077879, 7067.858642827217, 7067.964660176666, 7075.292470752884, 7076.893846592202, 7019.29807019294, 7031.753888613874, 7050.717971281091, 7064.576125432491, 7102.680379382837, 6855.794326170223, 7117.501774875709, 7138.785836424916, 7155.177154627285, 7183.892241616275, 6935.479839012195, 6949.30506949301, 6979.651017449006, 6989.1962424321855, 6997.755078572225], "value": 5513.07216217918, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [952.723710124064, 974.9610015599375, 999.2455695949557, 1006.2654262388461, 1008.6167256442553, 18728.625427491443, 19589.706154407697, 19597.706034409497, 19603.5099122522, 20418.387448376536, 19966.0, 20646.793532064712, 20704.171833126657, 20706.482337941557, 20712.48218794531, 1062.9734256643587, 1074.8871368506273, 1076.4133547216748, 1079.3955384984433, 1079.773247618003, 1041.536516250269, 1079.87581428136, 1081.6754973507955, 1084.0081325587078, 1084.8589683341154, 1151.3494875395374, 1152.5389844062358, 1156.3582211872408, 1156.444906444907, 1158.0272571040325, 1145.6677563506573, 1147.025028725585, 1148.26511032939, 1149.7757937202248, 1151.89632933036, 836.7573403712915, 839.0434904209206, 839.5844057191669, 842.587132305166, 844.8479273730726, 18836.62326753471, 18884.055797210083, 18921.7161742574, 19142.904285478624, 19155.425337239903, 20562.485937851525, 20993.160273589037, 21033.0, 21041.263555775473, 21083.0, 17270.654586908193, 17318.653626927517, 17620.647587048315, 17762.111894405356, 17794.0, 3955.9011024724323, 3982.3827306767207, 3987.4018897165365, 3989.2221016901717, 3990.102226998931, 139900.0, 140722.0, 141106.29446852804, 141722.29138854344, 141789.0, 15769.369225231092, 15998.200089995453, 16119.27463264156, 16156.838431615533, 16179.352825886832, 26971.056013039448, 27114.64426778653, 27531.587026194622, 27651.446971060464, 27678.584821227698, 8258.545779982158, 8485.448445851, 8487.872681909652, 8737.257333126756, 9081.228095611816, 4375.387445757597, 4435.024294655171, 4435.157320109169, 4442.622377097983, 4443.311286750559, 5293.867653308698, 5300.284461597712, 5372.811951581676, 5411.242426060276, 5449.891002179934, 1108.2242430298822, 1138.703936976392, 1139.4758411130972, 1141.0643272516622, 1143.519721716881, 703.9120109986252, 717.8923161525813, 726.3825748114061, 729.8613263479922, 748.4461498491078, 11934.940325298317, 12047.337396443105, 12288.201266917622, 12304.692382690326, 12483.750324993449, 757.9810504737426, 762.2796457347864, 765.8659734546543, 775.4610545670818, 776.0, 5608.523275521545, 5662.7734890603915, 5677.261955945701, 5683.9715801420725, 5773.855653608609, 140072.0, 141889.0, 144024.0, 144845.0, 147839.0, 120029.0, 122706.38646806708, 124240.0, 125039.3748031254, 126845.0, 107479.0, 109854.45072774585, 111826.37649423291, 114441.85558144479, 114536.42731786454, 10368.637097701545, 10424.583016679248, 10491.94754026225, 10504.842427363748, 10574.788504229718, 52107.47892521178, 52827.735861321984, 53262.20106698325, 53513.464865352405, 54324.185137223765, 64700.67649661721, 64997.0, 66400.33599664134, 66414.33585664081, 67540.3245967534, 15826.525204243891, 15915.363385464452, 15916.602084947968, 15972.281247343664, 17256.396026139024, 20326.0, 20863.478413039797, 21012.0, 21087.472813179178, 21271.149154034283, 17404.477865664052, 17544.21051052731, 18440.81559184391, 18642.90678546653, 18886.7166992498, 18028.54928626795, 18037.549061273046, 18397.81602183961, 18473.81526184721, 18476.260949561867, 18267.0, 18338.991355475577, 18608.7208691867, 18707.81292187115, 18721.90639046796, 12980.480780769041, 13468.663283417602, 14227.14637121776, 14290.428382864984, 14301.64245893861, 13163.341832908125, 13381.19712817234, 14341.498047568284, 14511.274436278354, 14631.122132672073], "value": 9605.883629588128, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1438.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 106.0, 99.0, 104.0, 105.0, 107.0, 106.0, 95.0, 106.0, 107.0], "value": 103.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 113.0, 137.0, 170.0, 111.0, 142.0, 141.0, 118.0, 172.0, 118.0], "value": 135.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 160.0, 162.0, 161.0, 162.0, 160.0, 162.0, 164.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 74.0, 174.0, 74.0, 73.0, 73.0, 74.0, 154.0, 74.0], "value": 91.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 134.0, 78.0, 78.0, 77.0, 122.0, 78.0, 78.0, 134.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 113.0, 114.0, 114.0, 113.0, 114.0, 113.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 153.0, 161.0, 149.0, 149.0, 149.0, 151.0, 149.0, 149.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 100.0, 93.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 47.0, 46.0, 44.0, 44.0, 46.0, 44.0, 45.0, 45.0, 47.0], "value": 45.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 38.0, 38.0, 39.0, 38.0, 39.0, 39.0, 39.0, 39.0], "value": 38.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 73.0, 75.0, 75.0, 72.0, 72.0, 76.0, 72.0], "value": 73.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 118.0, 112.0, 125.0, 117.0, 117.0, 113.0, 111.0, 122.0, 148.0], "value": 119.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 156.0, 161.0, 154.0, 152.0, 156.0, 160.0, 155.0, 153.0], "value": 157.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 61.0, 60.0, 59.0, 57.0, 61.0, 66.0, 61.0, 57.0], "value": 60.6, "unit": "score"}]}]} 18:45:25 INFO - Return code: 0 18:45:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:45:26 INFO - # TBPL SUCCESS # 18:45:26 INFO - Running post-action listener: _package_coverage_data 18:45:26 INFO - Running post-action listener: _resource_record_post_action 18:45:26 INFO - [mozharness: 2017-08-31 01:45:26.055805Z] Finished run-tests step (success) 18:45:26 INFO - Running post-run listener: _resource_record_post_run 18:45:26 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 5410816; Write bytes: 379682816; Read time: 1648; Write time: 330856 18:45:26 INFO - TinderboxPrint: CPU usage
13.1% 18:45:26 INFO - TinderboxPrint: I/O read bytes / time
5,410,816 / 1,648 18:45:26 INFO - TinderboxPrint: I/O write bytes / time
379,682,816 / 330,856 18:45:26 INFO - TinderboxPrint: CPU idle
8,219.2 (86.9%) 18:45:26 INFO - TinderboxPrint: CPU user
1,185.9 (12.5%) 18:45:26 INFO - TinderboxPrint: Swap in / out
0 / 0 18:45:26 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 113889280; Read time: 0; Write time: 101820 18:45:26 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:45:26 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 3350528; Write bytes: 264904704; Read time: 1552; Write time: 228960 18:45:26 INFO - Running post-run listener: _upload_blobber_files 18:45:26 INFO - Blob upload gear active. 18:45:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:45:26 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 18:45:26 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'] 18:45:26 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 18:45:27 INFO - (blobuploader) - INFO - Open directory for files ... 18:45:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:45:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:45:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:27 INFO - (blobuploader) - INFO - Done attempting. 18:45:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:45:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:45:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:29 INFO - (blobuploader) - INFO - Done attempting. 18:45:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:45:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:45:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:30 INFO - (blobuploader) - INFO - Done attempting. 18:45:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:45:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:45:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:33 INFO - (blobuploader) - INFO - Done attempting. 18:45:33 INFO - (blobuploader) - INFO - Iteration through files over. 18:45:33 INFO - Return code: 0 18:45:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:45:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:45:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2e2477d18ce26b3c3a6c37a11101550bedef034f70fab8f1ac88b91ee027f881f9b883bccd71b8ad22a5722edabdabc2c8fec295e8b79499562c477dd7c0389", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3daef6772ed7efc14170181a07e4de662250eb56910c5119fff748bf422b4d451012a5e5d8d5b93a9f8fe706784fdbf500c2a32533cffc7e7c4edaa7579ecaf", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31eb3c43189f519700548d6a03bca6a9d2132a46f36369cca6197f490aa5762a139b7ec435d29a2a94de17e5de648a63d5de12401cb5e614eaec5bdbc9ed7718", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b418415e96f410268c200530bb135a8ff43a77ab89c217cfacfe1c4c915a7e4f4b83b0b6eed96cc673b70d08c7c208909099dbb97b1c543ff853d0d776bec84"} 18:45:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:45:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:45:33 INFO - Contents: 18:45:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2e2477d18ce26b3c3a6c37a11101550bedef034f70fab8f1ac88b91ee027f881f9b883bccd71b8ad22a5722edabdabc2c8fec295e8b79499562c477dd7c0389", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3daef6772ed7efc14170181a07e4de662250eb56910c5119fff748bf422b4d451012a5e5d8d5b93a9f8fe706784fdbf500c2a32533cffc7e7c4edaa7579ecaf", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31eb3c43189f519700548d6a03bca6a9d2132a46f36369cca6197f490aa5762a139b7ec435d29a2a94de17e5de648a63d5de12401cb5e614eaec5bdbc9ed7718", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b418415e96f410268c200530bb135a8ff43a77ab89c217cfacfe1c4c915a7e4f4b83b0b6eed96cc673b70d08c7c208909099dbb97b1c543ff853d0d776bec84"} 18:45:33 INFO - Running post-run listener: copy_logs_to_upload_dir 18:45:33 INFO - Copying logs to upload dir... 18:45:33 INFO - mkdir: /builds/slave/test/build/upload/logs 18:45:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.672029 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-08-30 18:45:33.588851) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-30 18:45:33.592909) ========= 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=1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2e2477d18ce26b3c3a6c37a11101550bedef034f70fab8f1ac88b91ee027f881f9b883bccd71b8ad22a5722edabdabc2c8fec295e8b79499562c477dd7c0389", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3daef6772ed7efc14170181a07e4de662250eb56910c5119fff748bf422b4d451012a5e5d8d5b93a9f8fe706784fdbf500c2a32533cffc7e7c4edaa7579ecaf", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31eb3c43189f519700548d6a03bca6a9d2132a46f36369cca6197f490aa5762a139b7ec435d29a2a94de17e5de648a63d5de12401cb5e614eaec5bdbc9ed7718", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b418415e96f410268c200530bb135a8ff43a77ab89c217cfacfe1c4c915a7e4f4b83b0b6eed96cc673b70d08c7c208909099dbb97b1c543ff853d0d776bec84"} build_url:https://queue.taskcluster.net/v1/task/MEo91bGsToSiyg6RI0hmpw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011309 build_url: 'https://queue.taskcluster.net/v1/task/MEo91bGsToSiyg6RI0hmpw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2e2477d18ce26b3c3a6c37a11101550bedef034f70fab8f1ac88b91ee027f881f9b883bccd71b8ad22a5722edabdabc2c8fec295e8b79499562c477dd7c0389", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3daef6772ed7efc14170181a07e4de662250eb56910c5119fff748bf422b4d451012a5e5d8d5b93a9f8fe706784fdbf500c2a32533cffc7e7c4edaa7579ecaf", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31eb3c43189f519700548d6a03bca6a9d2132a46f36369cca6197f490aa5762a139b7ec435d29a2a94de17e5de648a63d5de12401cb5e614eaec5bdbc9ed7718", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b418415e96f410268c200530bb135a8ff43a77ab89c217cfacfe1c4c915a7e4f4b83b0b6eed96cc673b70d08c7c208909099dbb97b1c543ff853d0d776bec84"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-30 18:45:33.619922) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 18:45:33.620261) ========= 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=1258088b6da462a47ba2cd90000001a2-1504142683.173513-1830495238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 18:45:33.702561) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-30 18:45:33.702953) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-30 18:45:33.703368) ========= ========= Total master_lag: 0.21 =========