builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-059 starttime: 1506537711.21 results: success (0) revision: 6100472d3aa833dff22a4edb0934fe600f43ddb8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 11:41:51.213252) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 11:41:51.213745) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 11:41:51.214084) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 11:41:51.232801) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:41:51.233370) ========= 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=3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-27 11:41:51-- 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% 40.9M=0s 2017-09-27 11:41:51 (40.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.175405 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:41:51.427380) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:41:51.427699) ========= 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=3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018815 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:41:51.477424) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:41:51.477806) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6100472d3aa833dff22a4edb0934fe600f43ddb8 --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 6100472d3aa833dff22a4edb0934fe600f43ddb8 --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=3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-27 11:41:51,551 truncating revision to first 12 chars 2017-09-27 11:41:51,551 Setting DEBUG logging. 2017-09-27 11:41:51,551 attempt 1/10 2017-09-27 11:41:51,551 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6100472d3aa8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-27 11:41:51,909 unpacking tar archive at: mozilla-central-6100472d3aa8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.664137 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:41:52.158962) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 11:41:52.159265) ========= script_repo_revision: 6100472d3aa833dff22a4edb0934fe600f43ddb8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 11:41:52.159663) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 11:41:52.159940) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 11:41:52.172735) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-27 11:41:52.173063) ========= /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=3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:41:52 INFO - MultiFileLogger online at 20170927 11:41:52 in /builds/slave/test 11:41:52 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 11:41:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:41:52 INFO - {'append_to_log': False, 11:41:52 INFO - 'base_work_dir': '/builds/slave/test', 11:41:52 INFO - 'blob_upload_branch': 'Firefox', 11:41:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:41:52 INFO - 'branch': 'Firefox', 11:41:52 INFO - 'buildbot_json_path': 'buildprops.json', 11:41:52 INFO - 'code_coverage': False, 11:41:52 INFO - 'config_files': ('talos/linux_config.py',), 11:41:52 INFO - 'default_actions': ('clobber', 11:41:52 INFO - 'read-buildbot-config', 11:41:52 INFO - 'download-and-extract', 11:41:52 INFO - 'populate-webroot', 11:41:52 INFO - 'create-virtualenv', 11:41:52 INFO - 'install', 11:41:52 INFO - 'setup-mitmproxy', 11:41:52 INFO - 'run-tests'), 11:41:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:41:52 INFO - 'disable_ccov_upload': False, 11:41:52 INFO - 'disable_stylo': False, 11:41:52 INFO - 'download_minidump_stackwalk': True, 11:41:52 INFO - 'download_symbols': 'ondemand', 11:41:52 INFO - 'enable_stylo': False, 11:41:52 INFO - 'enable_webrender': False, 11:41:52 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:41:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:41:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:41:52 INFO - 'gecko_profile': False, 11:41:52 INFO - 'gecko_profile_interval': 0, 11:41:52 INFO - 'installer_path': 'installer.exe', 11:41:52 INFO - 'log_level': 'info', 11:41:52 INFO - 'log_name': 'talos', 11:41:52 INFO - 'log_to_console': True, 11:41:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:41:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:41:52 INFO - 'opt_config_files': (), 11:41:52 INFO - 'pip_index': False, 11:41:52 INFO - 'suite': 'dromaeojs-e10s', 11:41:52 INFO - 'system_bits': '32', 11:41:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:41:52 INFO - 'title': 'talos-linux64-ix-059', 11:41:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:41:52 INFO - 'use_talos_json': True, 11:41:52 INFO - 'verify': 'False', 11:41:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:41:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:41:52 INFO - 'work_dir': 'build'} 11:41:52 INFO - [mozharness: 2017-09-27 18:41:52.395041Z] Running clobber step. 11:41:52 INFO - Running pre-action listener: _resource_record_pre_action 11:41:52 INFO - Running main action method: clobber 11:41:52 INFO - rmtree: /builds/slave/test/build 11:41:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:41:53 INFO - Running post-action listener: _resource_record_post_action 11:41:53 INFO - [mozharness: 2017-09-27 18:41:53.391596Z] Finished clobber step (success) 11:41:53 INFO - [mozharness: 2017-09-27 18:41:53.391693Z] Running read-buildbot-config step. 11:41:53 INFO - Running pre-action listener: _resource_record_pre_action 11:41:53 INFO - Running main action method: read_buildbot_config 11:41:53 INFO - Using buildbot properties: 11:41:53 INFO - { 11:41:53 INFO - "project": "", 11:41:53 INFO - "product": "firefox", 11:41:53 INFO - "who": "ryanvm@gmail.com", 11:41:53 INFO - "installer_path": "public/build/target.tar.bz2", 11:41:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:41:53 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:41:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 11:41:53 INFO - "stage_platform": "linux64-pgo", 11:41:53 INFO - "basedir": "/builds/slave/test", 11:41:53 INFO - "buildnumber": 210, 11:41:53 INFO - "platform": "ubuntu64_hw", 11:41:53 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:41:53 INFO - "slavebuilddir": "test", 11:41:53 INFO - "taskId": "QkbEmQe2TECFIIwRiEYYIA", 11:41:53 INFO - "branch": "mozilla-central", 11:41:53 INFO - "script_repo_revision": "production", 11:41:53 INFO - "revision": "6100472d3aa833dff22a4edb0934fe600f43ddb8", 11:41:53 INFO - "slavename": "talos-linux64-ix-059", 11:41:53 INFO - "repo_path": "mozilla-central" 11:41:53 INFO - } 11:41:53 INFO - Finding installer, test and symbols from parent task. 11:41:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QkbEmQe2TECFIIwRiEYYIA'}, attempt #1 11:41:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QkbEmQe2TECFIIwRiEYYIA'}, attempt #1 11:41:54 INFO - Task dependencies: SjP9pZd8TymPHLMi-QrYag 11:41:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag'}, attempt #1 11:41:54 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.tar.bz2 11:41:54 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.test_packages.json 11:41:54 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.crashreporter-symbols.zip 11:41:54 INFO - Running post-action listener: _resource_record_post_action 11:41:54 INFO - [mozharness: 2017-09-27 18:41:54.732895Z] Finished read-buildbot-config step (success) 11:41:54 INFO - [mozharness: 2017-09-27 18:41:54.733112Z] Running download-and-extract step. 11:41:54 INFO - Running pre-action listener: _resource_record_pre_action 11:41:54 INFO - Running main action method: download_and_extract 11:41:54 INFO - mkdir: /builds/slave/test/build/tests 11:41:54 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')]} 11:41:54 INFO - trying https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.test_packages.json 11:41:54 INFO - Downloading https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:41:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:41:55 INFO - Downloaded 989 bytes. 11:41:55 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:41:55 INFO - Using the following test package requirements: 11:41:55 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:41:55 INFO - u'common': [u'target.common.tests.zip'], 11:41:55 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:41:55 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:41:55 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:41:55 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:41:55 INFO - u'mozbase': [u'target.common.tests.zip'], 11:41:55 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:41:55 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:41:55 INFO - u'web-platform': [u'target.common.tests.zip', 11:41:55 INFO - u'target.web-platform.tests.tar.gz'], 11:41:55 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:41:55 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:41:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.common.tests.zip 11:41:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:41:55 INFO - Fetch https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.common.tests.zip into memory 11:41:56 INFO - Content-Length response header: 55350197 11:41:56 INFO - Bytes received: 55350197 11:42:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.talos.tests.zip 11:42:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:42:07 INFO - Fetch https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.talos.tests.zip into memory 11:42:07 INFO - Content-Length response header: 14513665 11:42:07 INFO - Bytes received: 14513665 11:42:08 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')]} 11:42:08 INFO - trying https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.tar.bz2 11:42:08 INFO - Downloading https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:42:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:42:10 INFO - Downloaded 62312035 bytes. 11:42:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.tar.bz2 11:42:10 INFO - mkdir: /builds/slave/test/properties 11:42:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:42:10 INFO - Writing to file /builds/slave/test/properties/build_url 11:42:10 INFO - Contents: 11:42:10 INFO - build_url:https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.tar.bz2 11:42:10 INFO - Running post-action listener: _resource_record_post_action 11:42:10 INFO - Running post-action listener: find_tests_for_verification 11:42:10 INFO - Running post-action listener: set_extra_try_arguments 11:42:10 INFO - [mozharness: 2017-09-27 18:42:10.061853Z] Finished download-and-extract step (success) 11:42:10 INFO - [mozharness: 2017-09-27 18:42:10.061951Z] Running populate-webroot step. 11:42:10 INFO - Running pre-action listener: _resource_record_pre_action 11:42:10 INFO - Running main action method: populate_webroot 11:42:10 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:42:10 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:42:10 INFO - 'tests': ['tresize', 11:42:10 INFO - 'tcanvasmark']}, 11:42:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:42:10 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:42:10 INFO - 'tests': ['dromaeo_css', 11:42:10 INFO - 'kraken']}, 11:42:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:42:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:42:10 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:42:10 INFO - 'talos_options': ['--disable-stylo'], 11:42:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:42:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:42:10 INFO - 'tests': ['damp', 'tps']}, 11:42:10 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:42:10 INFO - 'talos_options': ['--disable-stylo'], 11:42:10 INFO - 'tests': ['damp', 'tps']}, 11:42:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:42:10 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:42:10 INFO - 'tests': ['dromaeo_dom']}, 11:42:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:42:10 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:42:10 INFO - 'tests': ['basic_compositor_video', 11:42:10 INFO - 'glvideo']}, 11:42:10 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:42:10 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:42:10 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:42:10 INFO - 'talos_options': ['--disable-stylo'], 11:42:10 INFO - 'tests': ['ts_paint_webext', 11:42:10 INFO - 'tp5o_webext']}, 11:42:10 INFO - 'other-e10s': {'tests': ['a11yr', 11:42:10 INFO - 'ts_paint', 11:42:10 INFO - 'tpaint', 11:42:10 INFO - 'sessionrestore', 11:42:10 INFO - 'sessionrestore_many_windows', 11:42:10 INFO - 'sessionrestore_no_auto_restore', 11:42:10 INFO - 'tabpaint']}, 11:42:10 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:42:10 INFO - 'tests': ['a11yr', 11:42:10 INFO - 'ts_paint', 11:42:10 INFO - 'tpaint', 11:42:10 INFO - 'sessionrestore', 11:42:10 INFO - 'sessionrestore_many_windows', 11:42:10 INFO - 'sessionrestore_no_auto_restore', 11:42:10 INFO - 'tabpaint']}, 11:42:10 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 11:42:10 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:42:10 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:42:10 INFO - 'tests': ['perf_reftest_singletons']}, 11:42:10 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:42:10 INFO - 'tests': ['perf_reftest']}, 11:42:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:42:10 INFO - 'tsvgr_opacity', 11:42:10 INFO - 'tart', 11:42:10 INFO - 'tscrollx', 11:42:10 INFO - 'tsvg_static']}, 11:42:10 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:42:10 INFO - 'tests': ['tsvgx', 11:42:10 INFO - 'tsvgr_opacity', 11:42:10 INFO - 'tart', 11:42:10 INFO - 'tscrollx', 11:42:10 INFO - 'tsvg_static']}, 11:42:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:42:10 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:42:10 INFO - 'talos_options': ['--disable-stylo'], 11:42:10 INFO - 'tests': ['tp5o']}, 11:42:10 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:42:10 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:42:10 INFO - 'talos_options': ['--mitmproxy', 11:42:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:42:10 INFO - '--firstNonBlankPaint'], 11:42:10 INFO - 'tests': ['tp6_google', 11:42:10 INFO - 'tp6_youtube', 11:42:10 INFO - 'tp6_amazon', 11:42:10 INFO - 'tp6_facebook']}, 11:42:10 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:42:10 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:42:10 INFO - 'talos_options': ['--disable-stylo', 11:42:10 INFO - '--mitmproxy', 11:42:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:42:10 INFO - '--firstNonBlankPaint'], 11:42:10 INFO - 'tests': ['tp6_google', 11:42:10 INFO - 'tp6_youtube', 11:42:10 INFO - 'tp6_amazon', 11:42:10 INFO - 'tp6_facebook']}, 11:42:10 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:42:10 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:42:10 INFO - 'talos_options': ['--stylo-threads=1', 11:42:10 INFO - '--mitmproxy', 11:42:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:42:10 INFO - '--firstNonBlankPaint'], 11:42:10 INFO - 'tests': ['tp6_google', 11:42:10 INFO - 'tp6_youtube', 11:42:10 INFO - 'tp6_amazon', 11:42:10 INFO - 'tp6_facebook']}, 11:42:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:42:10 INFO - 'talos_options': ['--xperf_path', 11:42:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:42:10 INFO - 'tests': ['tp5n']}, 11:42:10 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:42:10 INFO - 'talos_options': ['--disable-stylo', 11:42:10 INFO - '--xperf_path', 11:42:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:42:10 INFO - 'tests': ['tp5n']}}} 11:42:10 INFO - Running post-action listener: _resource_record_post_action 11:42:10 INFO - [mozharness: 2017-09-27 18:42:10.077467Z] Finished populate-webroot step (success) 11:42:10 INFO - [mozharness: 2017-09-27 18:42:10.077557Z] Running create-virtualenv step. 11:42:10 INFO - Running pre-action listener: _resource_record_pre_action 11:42:10 INFO - Running main action method: create_virtualenv 11:42:10 INFO - Creating virtualenv /builds/slave/test/build/venv 11:42:10 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:42:10 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:42:10 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:42:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:42:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:42:10 INFO - Installing distribute.............................................................................................................................................................................................done. 11:42:11 INFO - Installing pip...............done. 11:42:11 INFO - Return code: 0 11:42:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:42:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:42:11 INFO - Reading from file tmpfile_stdout 11:42:11 INFO - Output received: 11:42:11 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:42:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:42:11 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')]} 11:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:11 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')]} 11:42:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:11 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 0x21881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f2d60>, '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 0x24f3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f3ef0>, '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': '3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530', '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 11:42:11 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 11:42:11 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 11:42:11 INFO - Using env: {'DISPLAY': ':0', 11:42:11 INFO - 'HOME': '/home/cltbld', 11:42:11 INFO - 'LANG': 'en_US.UTF-8', 11:42:11 INFO - 'LANGUAGE': 'en_US:en', 11:42:11 INFO - 'LOGNAME': 'cltbld', 11:42:11 INFO - 'MAIL': '/var/mail/cltbld', 11:42:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:11 INFO - 'MOZ_NO_REMOTE': '1', 11:42:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:11 INFO - 'NO_EM_RESTART': '1', 11:42:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:11 INFO - 'PWD': '/builds/slave/test', 11:42:11 INFO - 'SHELL': '/bin/bash', 11:42:11 INFO - 'SHLVL': '1', 11:42:11 INFO - 'TERM': 'linux', 11:42:11 INFO - 'TMOUT': '86400', 11:42:11 INFO - 'USER': 'cltbld', 11:42:11 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530', 11:42:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:11 INFO - '_': '/tools/buildbot/bin/python'} 11:42:12 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:42:12 INFO - Downloading/unpacking pip>=1.5 11:42:12 INFO - Running setup.py egg_info for package pip 11:42:12 INFO - warning: no files found matching 'pip/cacert.pem' 11:42:12 INFO - warning: no files found matching '*.html' under directory 'docs' 11:42:12 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:42:12 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:42:12 INFO - Installing collected packages: pip 11:42:12 INFO - Found existing installation: pip 1.1 11:42:12 INFO - Uninstalling pip: 11:42:12 INFO - Successfully uninstalled pip 11:42:12 INFO - Running setup.py install for pip 11:42:12 INFO - warning: no files found matching 'pip/cacert.pem' 11:42:12 INFO - warning: no files found matching '*.html' under directory 'docs' 11:42:12 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:42:12 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:42:12 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:42:12 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:42:12 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:42:12 INFO - Successfully installed pip 11:42:12 INFO - Cleaning up... 11:42:12 INFO - Return code: 0 11:42:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:42:12 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')]} 11:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:12 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')]} 11:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x21881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f2d60>, '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 0x24f3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f3ef0>, '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': '3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530', '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 11:42:12 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 11:42:12 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 11:42:12 INFO - Using env: {'DISPLAY': ':0', 11:42:12 INFO - 'HOME': '/home/cltbld', 11:42:12 INFO - 'LANG': 'en_US.UTF-8', 11:42:12 INFO - 'LANGUAGE': 'en_US:en', 11:42:12 INFO - 'LOGNAME': 'cltbld', 11:42:12 INFO - 'MAIL': '/var/mail/cltbld', 11:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:12 INFO - 'MOZ_NO_REMOTE': '1', 11:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:12 INFO - 'NO_EM_RESTART': '1', 11:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:12 INFO - 'PWD': '/builds/slave/test', 11:42:12 INFO - 'SHELL': '/bin/bash', 11:42:12 INFO - 'SHLVL': '1', 11:42:12 INFO - 'TERM': 'linux', 11:42:12 INFO - 'TMOUT': '86400', 11:42:12 INFO - 'USER': 'cltbld', 11:42:12 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530', 11:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:12 INFO - '_': '/tools/buildbot/bin/python'} 11:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:12 INFO - Downloading/unpacking psutil>=3.1.1 11:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:42:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:42:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:42:14 INFO - Installing collected packages: psutil 11:42:14 INFO - Running setup.py install for psutil 11:42:14 INFO - building 'psutil._psutil_linux' extension 11:42:14 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 11:42:14 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 11:42:14 INFO - building 'psutil._psutil_posix' extension 11:42:14 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 11:42:14 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 11:42:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:42:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:42:14 INFO - Successfully installed psutil 11:42:14 INFO - Cleaning up... 11:42:14 INFO - Return code: 0 11:42:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:42:14 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')]} 11:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:14 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')]} 11:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:14 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 0x21881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f2d60>, '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 0x24f3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f3ef0>, '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': '3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530', '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 11:42:14 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 11:42:14 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 11:42:14 INFO - Using env: {'DISPLAY': ':0', 11:42:14 INFO - 'HOME': '/home/cltbld', 11:42:14 INFO - 'LANG': 'en_US.UTF-8', 11:42:14 INFO - 'LANGUAGE': 'en_US:en', 11:42:14 INFO - 'LOGNAME': 'cltbld', 11:42:14 INFO - 'MAIL': '/var/mail/cltbld', 11:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:14 INFO - 'MOZ_NO_REMOTE': '1', 11:42:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:14 INFO - 'NO_EM_RESTART': '1', 11:42:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:14 INFO - 'PWD': '/builds/slave/test', 11:42:14 INFO - 'SHELL': '/bin/bash', 11:42:14 INFO - 'SHLVL': '1', 11:42:14 INFO - 'TERM': 'linux', 11:42:14 INFO - 'TMOUT': '86400', 11:42:14 INFO - 'USER': 'cltbld', 11:42:14 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530', 11:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:14 INFO - '_': '/tools/buildbot/bin/python'} 11:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:42:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:42:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:42:15 INFO - Installing collected packages: mozsystemmonitor 11:42:15 INFO - Running setup.py install for mozsystemmonitor 11:42:16 INFO - Successfully installed mozsystemmonitor 11:42:16 INFO - Cleaning up... 11:42:16 INFO - Return code: 0 11:42:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:42: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')]} 11:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42: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')]} 11:42:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:16 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 0x21881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f2d60>, '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 0x24f3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f3ef0>, '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': '3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530', '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 11:42:16 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 11:42:16 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 11:42:16 INFO - Using env: {'DISPLAY': ':0', 11:42:16 INFO - 'HOME': '/home/cltbld', 11:42:16 INFO - 'LANG': 'en_US.UTF-8', 11:42:16 INFO - 'LANGUAGE': 'en_US:en', 11:42:16 INFO - 'LOGNAME': 'cltbld', 11:42:16 INFO - 'MAIL': '/var/mail/cltbld', 11:42:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:16 INFO - 'MOZ_NO_REMOTE': '1', 11:42:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:16 INFO - 'NO_EM_RESTART': '1', 11:42:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:16 INFO - 'PWD': '/builds/slave/test', 11:42:16 INFO - 'SHELL': '/bin/bash', 11:42:16 INFO - 'SHLVL': '1', 11:42:16 INFO - 'TERM': 'linux', 11:42:16 INFO - 'TMOUT': '86400', 11:42:16 INFO - 'USER': 'cltbld', 11:42:16 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530', 11:42:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:16 INFO - '_': '/tools/buildbot/bin/python'} 11:42:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:17 INFO - Downloading/unpacking jsonschema==2.5.1 11:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:42:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:18 INFO - Downloading functools32-3.2.3-2.tar.gz 11:42:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:42:18 INFO - warning: no files found matching '*.txt' 11:42:18 INFO - no previously-included directories found matching 'build' 11:42:18 INFO - no previously-included directories found matching 'dist' 11:42:18 INFO - no previously-included directories found matching '.git*' 11:42:18 INFO - Installing collected packages: jsonschema, functools32 11:42:18 INFO - Running setup.py install for functools32 11:42:18 INFO - warning: no files found matching '*.txt' 11:42:18 INFO - no previously-included directories found matching 'build' 11:42:18 INFO - no previously-included directories found matching 'dist' 11:42:18 INFO - no previously-included directories found matching '.git*' 11:42:19 INFO - Successfully installed jsonschema functools32 11:42:19 INFO - Cleaning up... 11:42:19 INFO - Return code: 0 11:42:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:42: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')]} 11:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42: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')]} 11:42:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42: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', '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 0x21881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f2d60>, '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 0x24f3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f3ef0>, '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': '3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530', '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 11:42: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:42: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 functools32==3.2.3-2 11:42:19 INFO - Using env: {'DISPLAY': ':0', 11:42:19 INFO - 'HOME': '/home/cltbld', 11:42:19 INFO - 'LANG': 'en_US.UTF-8', 11:42:19 INFO - 'LANGUAGE': 'en_US:en', 11:42:19 INFO - 'LOGNAME': 'cltbld', 11:42:19 INFO - 'MAIL': '/var/mail/cltbld', 11:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:19 INFO - 'MOZ_NO_REMOTE': '1', 11:42:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:19 INFO - 'NO_EM_RESTART': '1', 11:42:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:19 INFO - 'PWD': '/builds/slave/test', 11:42:19 INFO - 'SHELL': '/bin/bash', 11:42:19 INFO - 'SHLVL': '1', 11:42:19 INFO - 'TERM': 'linux', 11:42:19 INFO - 'TMOUT': '86400', 11:42:19 INFO - 'USER': 'cltbld', 11:42:19 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530', 11:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:19 INFO - '_': '/tools/buildbot/bin/python'} 11:42:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:42:19 INFO - Cleaning up... 11:42:19 INFO - Return code: 0 11:42:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:42: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')]} 11:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42: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')]} 11:42:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42: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', '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 0x21881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f2d60>, '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 0x24f3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f3ef0>, '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': '3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530', '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 11:42: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:42: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 blobuploader==1.2.4 11:42:19 INFO - Using env: {'DISPLAY': ':0', 11:42:19 INFO - 'HOME': '/home/cltbld', 11:42:19 INFO - 'LANG': 'en_US.UTF-8', 11:42:19 INFO - 'LANGUAGE': 'en_US:en', 11:42:19 INFO - 'LOGNAME': 'cltbld', 11:42:19 INFO - 'MAIL': '/var/mail/cltbld', 11:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:19 INFO - 'MOZ_NO_REMOTE': '1', 11:42:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:19 INFO - 'NO_EM_RESTART': '1', 11:42:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:19 INFO - 'PWD': '/builds/slave/test', 11:42:19 INFO - 'SHELL': '/bin/bash', 11:42:19 INFO - 'SHLVL': '1', 11:42:19 INFO - 'TERM': 'linux', 11:42:19 INFO - 'TMOUT': '86400', 11:42:19 INFO - 'USER': 'cltbld', 11:42:19 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530', 11:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:19 INFO - '_': '/tools/buildbot/bin/python'} 11:42:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:19 INFO - Downloading/unpacking blobuploader==1.2.4 11:42:19 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 11:42:19 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 11:42:19 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 11:42:19 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 11:42:27 INFO - Downloading blobuploader-1.2.4.tar.gz 11:42:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:42:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:42: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 11:42: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 11:42: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 11:42: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 11:42:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:42:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:42: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 11:42: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 11:42: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 11:42: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 11:42:28 INFO - Downloading docopt-0.6.1.tar.gz 11:42:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:42:28 INFO - Installing collected packages: blobuploader, requests, docopt 11:42:28 INFO - Running setup.py install for blobuploader 11:42:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:42:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:42:28 INFO - Running setup.py install for requests 11:42:28 INFO - Running setup.py install for docopt 11:42:28 INFO - Successfully installed blobuploader requests docopt 11:42:28 INFO - Cleaning up... 11:42:28 INFO - Return code: 0 11:42:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:28 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 0x21881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f2d60>, '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 0x24f3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f3ef0>, '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': '3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530', '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 11:42:28 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 11:42:28 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 11:42:28 INFO - Using env: {'DISPLAY': ':0', 11:42:28 INFO - 'HOME': '/home/cltbld', 11:42:28 INFO - 'LANG': 'en_US.UTF-8', 11:42:28 INFO - 'LANGUAGE': 'en_US:en', 11:42:28 INFO - 'LOGNAME': 'cltbld', 11:42:28 INFO - 'MAIL': '/var/mail/cltbld', 11:42:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:28 INFO - 'MOZ_NO_REMOTE': '1', 11:42:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:28 INFO - 'NO_EM_RESTART': '1', 11:42:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:28 INFO - 'PWD': '/builds/slave/test', 11:42:28 INFO - 'SHELL': '/bin/bash', 11:42:28 INFO - 'SHLVL': '1', 11:42:28 INFO - 'TERM': 'linux', 11:42:28 INFO - 'TMOUT': '86400', 11:42:28 INFO - 'USER': 'cltbld', 11:42:28 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530', 11:42:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:28 INFO - '_': '/tools/buildbot/bin/python'} 11:42:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:42:29 INFO - Running setup.py (path:/tmp/pip-crVL68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:42:29 INFO - Running setup.py (path:/tmp/pip-ET0DMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:42:29 INFO - Running setup.py (path:/tmp/pip-TZ83JO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:42:29 INFO - Running setup.py (path:/tmp/pip-aIQFVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:42:29 INFO - Running setup.py (path:/tmp/pip-sglaXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:42:29 INFO - Running setup.py (path:/tmp/pip-ZFnEpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:42:29 INFO - Running setup.py (path:/tmp/pip-R73dqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:42:29 INFO - Running setup.py (path:/tmp/pip-nQianb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:42:29 INFO - Running setup.py (path:/tmp/pip-1pOLYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:42:29 INFO - Running setup.py (path:/tmp/pip-Oiln1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:42:29 INFO - Running setup.py (path:/tmp/pip-1yqO3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:42:29 INFO - Running setup.py (path:/tmp/pip-59blny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:42:29 INFO - Running setup.py (path:/tmp/pip-_4fhTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:42:29 INFO - Running setup.py (path:/tmp/pip-JkhbiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:30 INFO - Running setup.py (path:/tmp/pip-c51O0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:42:30 INFO - Running setup.py (path:/tmp/pip-IuTT98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:42:30 INFO - Running setup.py (path:/tmp/pip-q0i8KQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:42:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:42:30 INFO - Running setup.py install for manifestparser 11:42:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:42:30 INFO - Running setup.py install for mozcrash 11:42:30 INFO - Running setup.py install for mozdebug 11:42:30 INFO - Running setup.py install for mozdevice 11:42:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:42:30 INFO - Running setup.py install for mozfile 11:42:30 INFO - Running setup.py install for mozhttpd 11:42:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:42:30 INFO - Running setup.py install for mozinfo 11:42:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:42:30 INFO - Running setup.py install for mozInstall 11:42:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:42:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:42:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:42:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:42:30 INFO - Running setup.py install for mozleak 11:42:31 INFO - Running setup.py install for mozlog 11:42:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:42:31 INFO - Running setup.py install for moznetwork 11:42:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:42:31 INFO - Running setup.py install for mozprocess 11:42:31 INFO - Running setup.py install for mozprofile 11:42:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:42:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:42:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:42:31 INFO - Running setup.py install for mozrunner 11:42:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:42:31 INFO - Running setup.py install for mozscreenshot 11:42:31 INFO - Running setup.py install for moztest 11:42:31 INFO - Running setup.py install for mozversion 11:42:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:42:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:42:31 INFO - Cleaning up... 11:42:31 INFO - Return code: 0 11:42:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42:31 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')]} 11:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:31 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')]} 11:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:32 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 0x21881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f2d60>, '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 0x24f3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f3ef0>, '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': '3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530', '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 11:42:32 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 11:42:32 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 11:42:32 INFO - Using env: {'DISPLAY': ':0', 11:42:32 INFO - 'HOME': '/home/cltbld', 11:42:32 INFO - 'LANG': 'en_US.UTF-8', 11:42:32 INFO - 'LANGUAGE': 'en_US:en', 11:42:32 INFO - 'LOGNAME': 'cltbld', 11:42:32 INFO - 'MAIL': '/var/mail/cltbld', 11:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:32 INFO - 'MOZ_NO_REMOTE': '1', 11:42:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:32 INFO - 'NO_EM_RESTART': '1', 11:42:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:32 INFO - 'PWD': '/builds/slave/test', 11:42:32 INFO - 'SHELL': '/bin/bash', 11:42:32 INFO - 'SHLVL': '1', 11:42:32 INFO - 'TERM': 'linux', 11:42:32 INFO - 'TMOUT': '86400', 11:42:32 INFO - 'USER': 'cltbld', 11:42:32 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530', 11:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:32 INFO - '_': '/tools/buildbot/bin/python'} 11:42:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:42:32 INFO - Running setup.py (path:/tmp/pip-rl42SX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:42:32 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)) 11:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:42:32 INFO - Running setup.py (path:/tmp/pip-TSNUz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:42:32 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)) 11:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:42:32 INFO - Running setup.py (path:/tmp/pip-Gf0ld9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:42:32 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)) 11:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:42:32 INFO - Running setup.py (path:/tmp/pip-gY3BzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:42:32 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)) 11:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:42:32 INFO - Running setup.py (path:/tmp/pip-_hVSRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:42:32 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)) 11:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:42:32 INFO - Running setup.py (path:/tmp/pip-kXT1oe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:42:32 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)) 11:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:42:32 INFO - Running setup.py (path:/tmp/pip-eyGMPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:42:32 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)) 11:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:42:32 INFO - Running setup.py (path:/tmp/pip-t2uVp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:42:32 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)) 11:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:42:32 INFO - Running setup.py (path:/tmp/pip-fYJ1bD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:42:32 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)) 11:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:42:32 INFO - Running setup.py (path:/tmp/pip-X0JwQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:42:32 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)) 11:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:42:32 INFO - Running setup.py (path:/tmp/pip-1vYn3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:42:32 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)) 11:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:42:32 INFO - Running setup.py (path:/tmp/pip-kEQyxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:42:33 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)) 11:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:42:33 INFO - Running setup.py (path:/tmp/pip-vyETo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:42:33 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)) 11:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:42:33 INFO - Running setup.py (path:/tmp/pip-np2y4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:42:33 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)) 11:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:33 INFO - Running setup.py (path:/tmp/pip-QXp9Bl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:33 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)) 11:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:42:33 INFO - Running setup.py (path:/tmp/pip-zNdMkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:42:33 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)) 11:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:42:33 INFO - Running setup.py (path:/tmp/pip-4Ee8Hb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:42:33 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)) 11:42:33 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)) 11:42:33 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)) 11:42:33 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)) 11:42:33 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)) 11:42:33 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)) 11:42:33 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)) 11:42:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:42:33 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 11:42:33 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 11:42:33 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 11:42:33 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 11:42:34 INFO - Downloading blessings-1.6.tar.gz 11:42:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:42:34 INFO - Installing collected packages: blessings 11:42:34 INFO - Running setup.py install for blessings 11:42:34 INFO - Successfully installed blessings 11:42:34 INFO - Cleaning up... 11:42:34 INFO - Return code: 0 11:42:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:42:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:42:34 INFO - Reading from file tmpfile_stdout 11:42:34 INFO - Current package versions: 11:42:34 INFO - argparse == 1.2.1 11:42:34 INFO - blessings == 1.6 11:42:34 INFO - blobuploader == 1.2.4 11:42:34 INFO - docopt == 0.6.1 11:42:34 INFO - functools32 == 3.2.3-2 11:42:34 INFO - jsonschema == 2.5.1 11:42:34 INFO - manifestparser == 1.1 11:42:34 INFO - mozInstall == 1.13 11:42:34 INFO - mozcrash == 1.0 11:42:34 INFO - mozdebug == 0.1 11:42:34 INFO - mozdevice == 0.51 11:42:34 INFO - mozfile == 1.2 11:42:34 INFO - mozhttpd == 0.7 11:42:34 INFO - mozinfo == 0.10 11:42:34 INFO - mozleak == 0.1 11:42:34 INFO - mozlog == 3.5 11:42:34 INFO - moznetwork == 0.27 11:42:34 INFO - mozprocess == 0.25 11:42:34 INFO - mozprofile == 0.28 11:42:34 INFO - mozrunner == 6.13 11:42:34 INFO - mozscreenshot == 0.1 11:42:34 INFO - mozsystemmonitor == 0.3 11:42:34 INFO - moztest == 0.8 11:42:34 INFO - mozversion == 1.4 11:42:34 INFO - psutil == 3.1.1 11:42:34 INFO - requests == 1.2.3 11:42:34 INFO - wsgiref == 0.1.2 11:42:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42:34 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')]} 11:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:34 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')]} 11:42:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:34 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 0x21881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f2d60>, '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 0x24f3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f3ef0>, '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': '3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530', '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 11:42:34 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 11:42:34 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 11:42:34 INFO - Using env: {'DISPLAY': ':0', 11:42:34 INFO - 'HOME': '/home/cltbld', 11:42:34 INFO - 'LANG': 'en_US.UTF-8', 11:42:34 INFO - 'LANGUAGE': 'en_US:en', 11:42:34 INFO - 'LOGNAME': 'cltbld', 11:42:34 INFO - 'MAIL': '/var/mail/cltbld', 11:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:34 INFO - 'MOZ_NO_REMOTE': '1', 11:42:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:34 INFO - 'NO_EM_RESTART': '1', 11:42:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:34 INFO - 'PWD': '/builds/slave/test', 11:42:34 INFO - 'SHELL': '/bin/bash', 11:42:34 INFO - 'SHLVL': '1', 11:42:34 INFO - 'TERM': 'linux', 11:42:34 INFO - 'TMOUT': '86400', 11:42:34 INFO - 'USER': 'cltbld', 11:42:34 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530', 11:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:34 INFO - '_': '/tools/buildbot/bin/python'} 11:42:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:35 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)) 11:42:35 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)) 11:42:35 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)) 11:42:35 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)) 11:42:35 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)) 11:42:35 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)) 11:42:35 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)) 11:42:35 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)) 11:42:35 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)) 11:42:35 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:42:35 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 11:42:35 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 11:42:35 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 11:42:35 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 11:42:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:42:36 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)) 11:42:36 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)) 11:42:36 INFO - Installing collected packages: simplejson 11:42:36 INFO - Running setup.py install for simplejson 11:42:36 INFO - building 'simplejson._speedups' extension 11:42:36 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 11:42:37 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 11:42:37 INFO - Successfully installed simplejson 11:42:37 INFO - Cleaning up... 11:42:37 INFO - Return code: 0 11:42:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:42:37 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')]} 11:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:37 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')]} 11:42:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:37 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 0x21881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f2d60>, '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 0x24f3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f3ef0>, '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': '3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530', '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 11:42:37 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 11:42:37 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 11:42:37 INFO - Using env: {'DISPLAY': ':0', 11:42:37 INFO - 'HOME': '/home/cltbld', 11:42:37 INFO - 'LANG': 'en_US.UTF-8', 11:42:37 INFO - 'LANGUAGE': 'en_US:en', 11:42:37 INFO - 'LOGNAME': 'cltbld', 11:42:37 INFO - 'MAIL': '/var/mail/cltbld', 11:42:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:37 INFO - 'MOZ_NO_REMOTE': '1', 11:42:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:37 INFO - 'NO_EM_RESTART': '1', 11:42:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:37 INFO - 'PWD': '/builds/slave/test', 11:42:37 INFO - 'SHELL': '/bin/bash', 11:42:37 INFO - 'SHLVL': '1', 11:42:37 INFO - 'TERM': 'linux', 11:42:37 INFO - 'TMOUT': '86400', 11:42:37 INFO - 'USER': 'cltbld', 11:42:37 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530', 11:42:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:37 INFO - '_': '/tools/buildbot/bin/python'} 11:42:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:42:37 INFO - Cleaning up... 11:42:37 INFO - Return code: 0 11:42:37 INFO - Running post-action listener: _resource_record_post_action 11:42:37 INFO - Running post-action listener: _start_resource_monitoring 11:42:37 INFO - Starting resource monitoring. 11:42:37 INFO - [mozharness: 2017-09-27 18:42:37.707039Z] Finished create-virtualenv step (success) 11:42:37 INFO - [mozharness: 2017-09-27 18:42:37.707557Z] Running install step. 11:42:37 INFO - Running pre-action listener: _resource_record_pre_action 11:42:37 INFO - Running main action method: install 11:42:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:42:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:42:37 INFO - Reading from file tmpfile_stdout 11:42:37 INFO - Detecting whether we're running mozinstall >=1.0... 11:42:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:42:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:42:38 INFO - Reading from file tmpfile_stdout 11:42:38 INFO - Output received: 11:42:38 INFO - Usage: mozinstall [options] installer 11:42:38 INFO - Options: 11:42:38 INFO - -h, --help show this help message and exit 11:42:38 INFO - -d DEST, --destination=DEST 11:42:38 INFO - Directory to install application into. [default: 11:42:38 INFO - "/builds/slave/test"] 11:42:38 INFO - --app=APP Application being installed. [default: firefox] 11:42:38 INFO - mkdir: /builds/slave/test/build/application 11:42:38 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'] 11:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:42:55 INFO - Reading from file tmpfile_stdout 11:42:55 INFO - Output received: 11:42:55 INFO - /builds/slave/test/build/application/firefox/firefox 11:42:55 INFO - Running post-action listener: _resource_record_post_action 11:42:55 INFO - [mozharness: 2017-09-27 18:42:55.696384Z] Finished install step (success) 11:42:55 INFO - [mozharness: 2017-09-27 18:42:55.696610Z] Running setup-mitmproxy step. 11:42:55 INFO - Running pre-action listener: _resource_record_pre_action 11:42:55 INFO - Running main action method: setup_mitmproxy 11:42:55 INFO - Skipping: mitmproxy is not required 11:42:55 INFO - Running post-action listener: _resource_record_post_action 11:42:55 INFO - [mozharness: 2017-09-27 18:42:55.697137Z] Finished setup-mitmproxy step (success) 11:42:55 INFO - [mozharness: 2017-09-27 18:42:55.697239Z] Running run-tests step. 11:42:55 INFO - Running pre-action listener: _resource_record_pre_action 11:42:55 INFO - Running pre-action listener: _set_gcov_prefix 11:42:55 INFO - Running main action method: run_tests 11:42:55 WARNING - Try message not found. 11:42:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:42:55 INFO - Python 2.7.3 11:42:55 INFO - Return code: 0 11:42:55 INFO - grabbing minidump binary from tooltool 11:42: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')]} 11:42: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 0x24f2d60>, '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 0x24f3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f3ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:42: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 11:42: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 11:42: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 11:42:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:42:55 INFO - Return code: 0 11:42:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:42:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:42:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:42:55 INFO - ENV: RUST_BACKTRACE is now full 11:42:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:42:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:42: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/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 11:42: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/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 11:42:55 INFO - Using env: {'DISPLAY': ':0', 11:42:55 INFO - 'HOME': '/home/cltbld', 11:42:55 INFO - 'LANG': 'en_US.UTF-8', 11:42:55 INFO - 'LANGUAGE': 'en_US:en', 11:42:55 INFO - 'LOGNAME': 'cltbld', 11:42:55 INFO - 'MAIL': '/var/mail/cltbld', 11:42:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:42:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:55 INFO - 'MOZ_NO_REMOTE': '1', 11:42:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:42:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:55 INFO - 'NO_EM_RESTART': '1', 11:42:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:55 INFO - 'PWD': '/builds/slave/test', 11:42:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:42:55 INFO - 'RUST_BACKTRACE': 'full', 11:42:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:42:55 INFO - 'SHELL': '/bin/bash', 11:42:55 INFO - 'SHLVL': '1', 11:42:55 INFO - 'TERM': 'linux', 11:42:55 INFO - 'TMOUT': '86400', 11:42:55 INFO - 'USER': 'cltbld', 11:42:55 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530', 11:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:55 INFO - '_': '/tools/buildbot/bin/python'} 11:42: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/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 11:42:56 INFO - mozversion application_buildid: 20170927172229 11:42:56 INFO - mozversion application_changeset: 6100472d3aa833dff22a4edb0934fe600f43ddb8 11:42:56 INFO - mozversion application_display_name: Nightly 11:42:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:42:56 INFO - mozversion application_name: Firefox 11:42:56 INFO - mozversion application_remotingname: firefox 11:42:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:42:56 INFO - mozversion application_vendor: Mozilla 11:42:56 INFO - mozversion application_version: 58.0a1 11:42:56 INFO - mozversion platform_buildid: 20170927172229 11:42:56 INFO - mozversion platform_changeset: 6100472d3aa833dff22a4edb0934fe600f43ddb8 11:42:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:42:56 INFO - mozversion platform_version: 58.0a1 11:42:56 INFO - using testdate: 1506537776 11:42:56 INFO - actual date: 1506537776 11:42:56 INFO - starting webserver on 'localhost:41254' 11:42:56 INFO - SUITE-START | Running 2 tests 11:42:56 INFO - TEST-START | dromaeo_css 11:42:56 INFO - Initialising browser for dromaeo_css test... 11:42:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41254/getInfo.html -profile /tmp/tmpX5rNXg/profile 11:42:56 INFO - TEST-INFO | started process 13627 (/builds/slave/test/build/application/firefox/firefox http://localhost:41254/getInfo.html) 11:43:00 INFO - TEST-INFO | 13627: exit 0 11:43:00 INFO - Browser initialized. 11:43:00 INFO - Running cycle 1/1 for dromaeo_css test... 11:43:00 INFO - Using env: {'DISPLAY': ':0', 11:43:00 INFO - 'HOME': '/home/cltbld', 11:43:00 INFO - 'JSGC_DISABLE_POISONING': '1', 11:43:00 INFO - 'LANG': 'en_US.UTF-8', 11:43:00 INFO - 'LANGUAGE': 'en_US:en', 11:43:00 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:43:00 INFO - 'LOGNAME': 'cltbld', 11:43:00 INFO - 'MAIL': '/var/mail/cltbld', 11:43:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:43:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:43:00 INFO - 'MOZ_CRASHREPORTER': '1', 11:43:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:00 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:43:00 INFO - 'MOZ_NO_REMOTE': '1', 11:43:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:43:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:00 INFO - 'NO_EM_RESTART': '1', 11:43:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:00 INFO - 'PWD': '/builds/slave/test', 11:43:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:43:00 INFO - 'RUST_BACKTRACE': 'full', 11:43:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:43:00 INFO - 'SHELL': '/bin/bash', 11:43:00 INFO - 'SHLVL': '1', 11:43:00 INFO - 'TERM': 'linux', 11:43:00 INFO - 'TMOUT': '86400', 11:43:00 INFO - 'USER': 'cltbld', 11:43:00 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530', 11:43:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:00 INFO - '_': '/tools/buildbot/bin/python'} 11:43:00 INFO - TEST-INFO | started process 13862 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX5rNXg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:43:01 INFO - PID 13862 | 11:43:01 INFO - PID 13862 | (/builds/slave/test/build/application/firefox/firefox:13913): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:43:01 INFO - PID 13862 | 11:43:12 INFO - PID 13862 | RSS: Main: 146440192 11:43:12 INFO - PID 13862 | 11:46:09 INFO - PID 13862 | Cycle 1(1): loaded http://localhost:41254/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41254/tests/dromaeo/cssquery-ext.html) 11:46:11 INFO - PID 13862 | RSS: Main: 147087360 11:46:11 INFO - PID 13862 | 11:49:12 INFO - PID 13862 | Cycle 1(1): loaded http://localhost:41254/tests/dromaeo/cssquery-ext.html (next: http://localhost:41254/tests/dromaeo/cssquery-jquery.html) 11:49:13 INFO - PID 13862 | RSS: Main: 146452480 11:49:13 INFO - PID 13862 | 11:52:15 INFO - PID 13862 | Cycle 1(1): loaded http://localhost:41254/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41254/tests/dromaeo/cssquery-mootools.html) 11:52:15 INFO - PID 13862 | RSS: Main: 149315584 11:52:15 INFO - PID 13862 | 11:55:17 INFO - PID 13862 | Cycle 1(1): loaded http://localhost:41254/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41254/tests/dromaeo/cssquery-prototype.html) 11:55:17 INFO - PID 13862 | RSS: Main: 147484672 11:55:17 INFO - PID 13862 | 11:58:20 INFO - PID 13862 | Cycle 1(1): loaded http://localhost:41254/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41254/tests/dromaeo/cssquery-yui.html) 11:58:21 INFO - PID 13862 | RSS: Main: 148942848 11:58:21 INFO - PID 13862 | 12:01:22 INFO - PID 13862 | Cycle 1(1): loaded http://localhost:41254/tests/dromaeo/cssquery-yui.html (next: http://localhost:41254/tests/dromaeo/cssquery-dojo.html) 12:01:23 INFO - PID 13862 | RSS: Main: 151035904 12:01:23 INFO - PID 13862 | 12:01:23 INFO - PID 13862 | __start_tp_report 12:01:23 INFO - PID 13862 | _x_x_mozilla_page_load 12:01:23 INFO - PID 13862 | _x_x_mozilla_page_load_details 12:01:23 INFO - PID 13862 | |i|pagename|runs| 12:01:23 INFO - PID 13862 | |0;dojo.html;3866.922661546769;3929.4302326162706;3933.115049113948;3950.980245098774;3956.5845586213427;6199.814005579834;6208.317085120644;6289.0566415037765;6314.905276420845;6382.712777924993;6306.1171435998995;6308.71610777515;6308.810735677926;6310.148130002448;6349.682515874211;5698.886022279552;5700.201971723962;5727.398623144572;5750.913736293938;5770.047942089571;5570.359408667994;5691.800786972457;5733.512651424634;5785.247917770684;5790.68151251681;5635.690037047961;5719.914201286984;5728.97135514324;5787.594868359217;5811.360750317462;5525.723713814334;5595.132754423071;5623.718814059322;5678.9432105678825;5684.118961560965;5582.804601838916;5639.323281206241;5645.15322701594;5653.321601407816;5666.291713535808;6239.126522286883;6249.5625306228585;6257.8748425031245;6267.153934218868;6274.780382686584;6851.2806155353965;6869.690863911136;6901.75843845463;6930.168379794457;6941.236463988957;6761.391474767245;6822.454203663695;6865.656717164122;6915.135608048994;6923.446124310043;6422.518311126638;6445;6475.449586785129;6477.676116194171;6484.93515064848;7091.964540177266;7107.253738357502;7112.893306600405;7113.5376200547835;7220.133583969957;6701.832454188684;6750.122484077038;6760.966195168992;6831.795046148623;6907.827304317332;6838.794836154824;6886.793396198122;6887.655617219119;6888.345607167311;6902.344277293649;6874.759383421556;6888.655567221619;6905;6935.930640693629;6950.582965022115;6839.658017099126;6848.452123830081;6878.828029299208;6946.756863509753;6948.27043160471;4938.456769755324;4946.233333833262;5015.4733752956145;5045.672031317952;5063.265826455144;4579.771011449414;4600.056988317387;4645.605123564535;4652.883677908079;4671.556202160789;6301.6534090625455;6377;6457.935420645827;6459.386358295955;6463.353664633499;6747.966260168668;6841.863162736718;6850.965745171242;6892.414144797648;6932.514723969273;6302.212223472066;6383.744650214032;6391.041343798374;6397.328280530571;6407.679616019181;5560.138178582326;5619;5628.943710562842;5638.943610563924;5639.097744360883;7034.683439245144;7042.788716338416;7097.574145551283;7110;7225.8554828903125;6816.897746533905;6841.726330946905;6913.654317284015;6924.723011079501;6927.376536111774;7046.2249152594195;7169.713211471482;7215.494915355875;7273.0908636420445;7276.7089316426745;6784.151981002375;6802;6805.115335006418;6806.55757375769;6813.523053386215;6738.797836064926;6837.384635382839;6863.2793556677825;6934.9653251735435;6963.373296403145;6629.436497897733;6631.303713110054;6643.335666433318;6713.597184168965;6720.9327906722265;6419.422251997343;6598.1422415085735;6636.9004464932095;6701.530892837454;6719.462443004646;6408.519361048034;6434.356564343529;6476.676166191766;6493.610383377012;6495.253045899593;6414.775482858077;6589.934100658932;6609.900851487136;6611.636360000246;6620.900686489803;6312.400321969406;6329.050642403677;6431;6435.839104022437;6452.903206451813 12:01:23 INFO - PID 13862 | |1;ext.html;962.6823148361046;996.5415908682007;1017.9083882450581;1021.1116328793951;1024.426321260094;41725.79137104314;42370.788146059305;42606.78696606513;42661.57338426615;42747;39508.80245598768;43348.133037339234;43809;43976.78011609946;44066.33900491495;8160.836783264331;8275.213854683825;8279.172082791703;8295.294899933513;8330.708425205119;8055.436119471639;8221.83556328873;8229.382796290272;8257.339412846957;8286.088530261666;8241.381896357767;8306.916930830675;8309.210624990616;8311.83376332473;8316.875246871301;8193.426460147792;8235.38234632405;8263.545504997222;8271.586420678972;8292.751217463485;7981.920180798175;7983.840323193562;8002.239787220205;8021.318187954031;8042.798930026737;39172.21655566901;39252.21495570101;39354.40968385476;39573.60426395728;39622;3737.738358314919;3768.679662228714;3777.1312598102318;3777.1501412182315;3777.414500752388;31786.841065794753;31947.361052779048;31982.520262196085;32092;32256.032319030466;5394.595405344615;5413.242146099549;5415.783368665248;5452.372977107604;5555.138953462219;205797;206619;206627;207312;207433.9999999985;49948.75025624849;50035;50130;50152.74923625431;50345.24482132771;55533.72233138808;56416;56546.434535654116;56573.43426565764;56695.43304566984;15701.764473532907;15827.208639567976;15883.126428046337;15895.602609934844;16002.199890005453;12831.935840320926;12862.614121576367;13758.380872860746;13989.930050349887;13990.580282591538;15999.920000399923;16045.277962491717;16063.277152528164;16094.19529023544;16199.838001620068;5997.610155339889;6225.595336303126;6290.528210384239;6294.590851594723;6300.117983482316;1096.2490693874722;1096.8903109689127;1108.6895669212633;1109.7392112853472;1122.3882983773863;25778.742212577636;25782;25805.74194258071;25899.611505827426;26070;1202.4168278384977;1210.2073142091945;1219.8475190601175;1226.466487078124;1235.6540168752763;13609.659758506117;13708.24604646754;13794.65513362154;13879;13931.721365572632;301791;302003;302828;303917;304318;55854.44145558574;56550.71724641351;58132.41867581355;62866;63045.36954630395;1512.9092254464767;1545.7758624999312;1547.9071255724693;1549.7985261915878;1553.2389129326548;29715.702842971292;29802.552961705158;29945.850270748506;29952.850235748683;30359.241018974702;40263;40658.79670601628;40699;40739.79630101831;40851.387229190994;254794;257092;257836;258433;258739;35226.823865880506;35391.469127962584;35402.46896296609;35817;35862;43816;45540.54459455496;46210.53789462197;46229;46304;33698.66301336955;33850.83074584611;33910.15224619404;34000.31999359949;34012.31975360528;33060.834695826365;33137.50293745644;33299.83350083234;33323;33432;39009.2198156041;39373.80313098531;39396.60603394044;39441.60558394379;39468.40797387984;31784.841075794473;32401;32629;33007;33105.50341744924;25209;25339.366515837253;25606.231813045637;25980.480390392466;26154.86922565375 12:01:23 INFO - PID 13862 | |2;jquery.html;586.3030061716106;607.8510764862609;612.5773216480628;639.2424976402963;647.3461803578385;23293.301200963997;23436.88281558592;24321.14875979341;24353.269401917947;24357.999999999956;25134.62298065526;25842.612360814604;26200.213993580175;26201.475970480627;26202.737972620267;6649.268580456146;6780.72877084916;6785.457163426939;6786.8303292417595;6790.762323318685;6389.1694079769795;6604.306547812483;6636.070950066995;6653.567518111307;6721.563098398613;6543;6613.272540020594;6615.040819081254;6615.17310336208;6623.23832759234;6520.347965203489;6552.344765523457;6579.80260592183;6584.209894812653;6746.123004009447;6286.057091436275;6314.463270622003;6315;6323.6521991290465;6336.556441049129;30189;30819;30840.845795771103;30858.228544286347;30925;2273.3634582316977;2288.8054515366216;2305.7002589663234;2308.1459859851793;2309.7459279479244;20042;20905.686414703792;20905.790942090538;20927.68608470874;21036.579268414545;2571.961420578693;2574.304937666838;2609.8042646801564;2616.973830261692;2627.868606569683;136561.3171934134;143229;148702;150157;154600;15498.380064797508;15846.286917088759;16289.918550407172;16334.18329083541;16561;26067;26072.478550429263;26122;26215.475690486084;26337.209883703137;10735.141188704885;10860.294080884718;10959.56161753521;10963.342199468058;10977.12183025356;9937.950310248403;10043.397396156253;10071.798564028679;10121.392716437038;10168.440735759455;9769.16962058233;9809.607615695435;9923.1069203772;10055.245856560787;10091.243156763272;2995.7011688227462;3018.7434068104017;3027.9394412112074;3042.893498727534;3069.4474994501206;1020.8825985011819;1055.8152323343384;1057.7831544533506;1060.0830281806182;1060.188955449082;20918.163273469196;21069.15723371048;21177.364679059654;21286.254981075588;21637.89181054116;1089.54239219528;1094.124700239805;1096.3750662122513;1099.983500247497;1107.95568177272;11364.94317528407;11393.86061393854;11399.772004559862;11460.312381256985;11585.76828463426;605069;620590;648271;656641;661799;129374;131382.34308828396;133083.3345833284;134188;134728;1193.3436609864539;1303.4619149403604;1342.926139062361;1354.3160703844692;1368.4321006782075;22750.544989100457;23025.19411820578;23034;23290.53418931646;23886.761132388452;65993;67488.78923766816;69339.30660693531;69586.65206674137;69818;87366.56316718376;88223;89274.55362723145;89918;92806;21473.141074356852;21906;21913.12347506082;21991.450213744785;22022.779772202073;24272.75727242705;24290.63564046576;24324.635130472703;24347.75652243455;24436.51126977415;19883.60232795365;20001.799981999993;20025.799742002393;20110.296139635044;20112.49718757043;17050;17705.468835934942;17755.556111097325;18035.639287214446;18251.908740456212;20231.59536809226;20243.898780506002;20312.59374812525;20435.59128817445;20654.793452065285;21457.78542214558;21539.784602153777;21546.6767998477;21565.568688625826;21572.568548629253;19408.708869367252;19473.61052778965;19663.70504442406;19744.80255197487;19766.90116549408 12:01:23 INFO - PID 13862 | |3;mootools.html;1424.5370254667232;1473.550567077041;1491.7613181890886;1506.0737646347495;1506.615812967693;16390.262438190297;16884.57788555285;16992.405265815698;17014.659706805858;17098.316067357322;16865.494035178934;16885.24016419261;16916.661666766657;16919;16929.66140677186;2552.132275026491;2553.2850801775535;2611.8694065296754;2612.9869350653316;2621.960670589933;2538.6953565572067;2578.6389905413257;2589.3656054266635;2592.10572352539;2592.6629538160014;2597.480503899218;2630.4213073123883;2685.9462810743776;2686.811923165379;2686.946261074787;2561.0908127614803;2629.526685196664;2636.301380134266;2657.2958166086005;2659.4016346322114;2576.111241621656;2704.067096851583;2706.594010898381;2708.769754570864;2709.525832979221;16549.089800060992;16707.66584668312;16713.749293760604;16715.582110447336;16717.749233761504;8104.1490643482175;8469.618867150994;8513.233808957162;8524.701635442792;8554;5424.945750542523;5445.564354851603;5464.3442786865435;5563.221149039137;5594.188842617838;2100.2964007057503;2131.82945364372;2173.673948907661;2193.385851961453;2202.713647225866;30257.697423025707;30481.23796905073;30495.23761905948;30506.08481745529;30550;6809.795706128824;6957.721691132399;7033.577985320897;7191.388731957738;7267.7819665410125;19845.206191752168;19868.403947881587;19881.403557893285;19902.60194796096;19906.60186796256;8138.145494722969;8469.576521173916;8478.279346255636;8483.915160848435;8485.193906578865;7596.81007974805;7709.190534993857;7719.228077192236;7780.260875216845;7781.377489800802;5145.279660847485;5281.102212623863;5334.06653835585;5342.946570534323;5363.088274993261;1528.8776897848145;1541.213980869742;1546.0646308982903;1549.0782984124428;1553.867921226686;935.7660584853786;953.7091187187974;955.350361754;958.5303201431249;964.7925695975399;8110.148434414419;8395.748127556182;8449.11284315138;8503.532305723245;8585.613647385757;777.3237283563336;784.7724159993652;801.4550105927908;807.112176605729;807.1524898856178;5611.719414029364;5860.238169037998;5869.765209391577;5933.406659334032;6027.457528822427;23485;24649.87675061613;24843;25447;25459.236222913343;24219.273421797374;24628;25047;25069.247922562354;25209;12474.81287780684;12612.117151799286;12732.23606583608;12846.614601561969;12851.807222891664;9689.757756056155;9712.611495540099;9758;9841.311108222642;9983.251256155672;21214.78785212128;21236.150553978285;21465.570688585827;21469.141234350453;21961.560768784217;21761.238356657443;22107.557848843255;22212.88893555522;22348.32955011352;22594.887025564767;12127.75744485123;12197.69505762363;12305.26168429897;12452.564160254347;12455.314957677414;15489.07065576069;15535.223238838238;15605.141717205208;15721.68556628838;15753;11933;12029.27824330508;12105.394730263628;12184;12489.687757806127;11808.114391420506;12053.879461205626;12083.75832483363;12312.507499699912;12458.501659933863;9752.219822414332;9918.801623967625;10015.399076055168;10109.292349535755;10112.039356261143;8195.67217311301;8237.629306681094;8283.58582070906;8304.252617264476;8314.417990740832;8342.207490288412;8346.499210047417;8412.789680258042;8480.618372173143;8501.744947651581 12:01:23 INFO - PID 13862 | |4;prototype.html;559.1528833816768;572.9770809167634;582.6009183709162;584.859633687915;590.4066413254681;6164.938350616492;6255.529950461643;6256;6270.341614130519;6291.15069465622;6112.838560673469;6115;6168.167297414848;6176.197094377724;6178.752849885999;5077.086124497589;5114.156164232916;5125.538701516863;5154.639175257734;5156.432792392834;4847.175980083377;4936.407631084275;5092.185250359943;5101.15830887903;5133.230015497668;4872.707637541741;4934.975325123387;4969.2049272116465;4983.327250821129;4988.2766998785155;4900.901981960359;4924.581410580105;4973.303737476756;4974.527419895104;4975.527324904128;4423.955760442386;4524.411826462539;4540.296254080623;4542.659300552472;4558.475775285851;6014.2181516403025;6074.119252708377;6130.141780150782;6142.385761423867;6149.754009839601;5822.679752613604;5868.002439585281;5879.235699359098;5892.793752218695;5900.085486749518;6676.165479315086;6683.2982536833415;6688.464922806213;6695.497837662146;6713.865722685519;5066.746662666888;5070.847874563769;5075.390953085616;5086.440491545927;5091.905240373338;6732.326767323278;6736;6838.897416538756;6877.727620390194;6889.689963951634;5197;5200.557952573998;5209.895802083937;5210.947890521122;5219.8255392536375;5292.311999440049;5300.178472336794;5304.4960728731485;5317.282166907496;5323.121684922022;5765.88468230633;5785.971070144622;5871.530277577784;5873.2658417697785;5882.117682347682;6611.603303801788;6616.437602803816;6657.833554161088;6694.263631000586;6695.526984063498;1821.6720990221888;1831.7801863776433;1834.9449516514526;1835.5135888989428;1837.2375464182483;1253.6865783554113;1293.5666551705096;1303.478608556585;1305.6670549009941;1318.7692153873033;6168.290646575611;6172.611162488404;6178.135061091451;6207.937920620826;6237.126802247689;6540.901886471706;6564.245111812203;6666.266710661824;6678.933210667831;6682.264950855402;6155.061155735929;6206.6345404011045;6226.128342032119;6259.902932517658;6263.154474146023;3547.5033495310677;3575.6245594212232;3579.552555930509;3590.982045089758;3596.604373518911;6945.513814032969;7014.649267536603;7077.256888026786;7097.361237488651;7141.750038748619;6787.626680532618;6884.139482564679;6886.414654754301;6907.654617269116;6926.515143939876;7060.575620823896;7063.1524217094275;7066.3640272374705;7102.254263302279;7135.5005149640065;6698.464122870061;6702.19573651165;6738.2587915328295;6761;6813.727450901908;6660.433863121495;6696;6717.429018533284;6719.865602688016;6720.294369091175;6997.040828568009;7013.266045419219;7034.261402552658;7059.647017649199;7124.786256412316;5248.265242865926;5256.684598924076;5257.973710131425;5271.341082364705;5287.9735601321745;6520.282768895512;6673.532852700265;6749.257581665915;6763.222229443677;6834.248232694499;6427.678616069272;6448.1295025171;6469.708863101077;6530.738770449128;6560.606363618198;6332.556721029668;6378.202724659418;6402.391772781578;6490.740370385321;6536.3136870629805;6240.781572644935;6337.144485494399;6427.967860160669;6466.547341686037;6472.449841763315;6471.320511346429;6507.381798729113;6522.15212022453;6558.213014438298;6565.770198043046;6232.844178895564;6264.937350626436;6402.295747467681;6410.967945160244;6449.774257900951 12:01:23 INFO - PID 13862 | |5;yui.html;966.8646389505466;985.3053597213965;996.1781530237554;1005.316384858296;1005.33647792457;18139.909300453495;18607.06964651767;18677.159527821263;18686.906565467187;18691.3458028969;19311.517212069706;19708.704369434436;19949.202031918743;20406.285779997703;20668.379948601567;1070.5182667799502;1088.9128869690446;1090.6128324444826;1091;1091.1052936591998;1062.2086545523596;1090.5365219781602;1091.0780390569955;1093.5516438260315;1094.141099237099;1164.0512981919708;1170.4849866058908;1170.7365842685413;1172.0330727150092;1172.2731906218157;1162.0993729859342;1163.069544364505;1163.1044096045998;1167.807311793553;1169.029705344562;792.124702204062;819.3240576524391;823.9464434811719;824.0358780227089;824.2540500846743;21180.682289765668;21306;21346.5730685387;21454.57090858174;21533.461663458384;22731.659025114637;22985.655215171784;23261.418464538354;23396;23401.36190466668;18320.17559209839;18731.344402945833;18824.717629235573;19140.904295478435;19175.520611984673;3925.60743925608;3931.960680393188;3947.743396679207;3947.921041579152;3950.5654378018394;153971;155729;156855.21572392178;157186.21406893007;158549;17893.28426862937;17907.641847163246;17939.192736326895;18088.909555452137;18168.45494635163;33733.987980360136;34528.48207276843;35074.82462587671;35088.298234035174;35106.29787404238;9155.13026262504;9273.67542136022;9278.211352035018;9286.303527235485;9311.580978855967;4814.7833347499445;4847.903041939212;4857.6842505237755;4880.341153944243;4894.706317620954;5952.8809423812145;5982.102684597346;6068.241469816273;6112.297085835097;6160.656737000493;1118.8657361116718;1145.381493993251;1155.3010428690689;1163.552032467506;1168.1764356128908;756.5687558091835;763.9121501027453;764.4572353628874;770.9614519274014;788.4953629677011;12544.435500402322;12751.489940402465;12792.2964236966;12947.870521294666;12951.222926624432;766.4941138848445;768.2624680306968;777.1567848883911;778.1673609238061;781.5935713428985;6036.698165091816;6196.10156527301;6253.593516421418;6280.623162610258;6352;140804;141624;141961.29019354837;145637.27181364025;147907;127137.36431317969;129249.96001919132;130142.34928825295;130954;136907;116341;116520;117356;119128.40435797766;120159;11859.229150105215;11942.820857686967;11971.700707482383;12085.15403921717;12304.75390492203;52413;52504;53268.09747551179;54388.18417723817;54550.727246363516;69954.30045699478;70755;71035;71044;71757.48848790268;17183.914080429517;18033.278668853098;18123.637527249117;18154.90922545379;18159.636807263516;18741;19071;19152.329668461538;19254.133563989373;19376.031198440305;17496.387626433014;17583.736243956097;17591.384301549384;17680.734788978432;17693.469195924143;17056.232469539147;17347.479575612753;17465.12674366302;17486.47540573785;17523.123843807505;17655.911720441316;17729.202185901406;17819.376321828673;17848.732269015716;18128.72806907924;13298.667533311746;13555.79666305026;13701;13763.931180344034;13832.37754301079;13349.332533373487;13474.393652285868;13610.59168224955;13697.520586779416;13720.588382348546 12:01:23 INFO - PID 13862 | __end_tp_report 12:01:23 INFO - PID 13862 | __start_cc_report 12:01:23 INFO - PID 13862 | _x_x_mozilla_cycle_collect,264 12:01:23 INFO - PID 13862 | __end_cc_report 12:01:23 INFO - PID 13862 | __startTimestamp1506538883128__endTimestamp 12:01:23 INFO - PID 13862 | 12:01:23 INFO - PID 13862 | ------- Summary: start ------- 12:01:23 INFO - PID 13862 | Number of tests: 6 12:01:23 INFO - PID 13862 | 12:01:23 INFO - PID 13862 | [#0] dojo.html Cycles:165 Average:6317.92 Median:6476.68 stddev:746.07 (11.5%) stddev-sans-first:723.15 12:01:23 INFO - PID 13862 | Values: 3866.9 3929.4 3933.1 3951.0 3956.6 6199.8 6208.3 6289.1 6314.9 6382.7 6306.1 6308.7 6308.8 6310.1 6349.7 5698.9 5700.2 5727.4 5750.9 5770.0 5570.4 5691.8 5733.5 5785.2 5790.7 5635.7 5719.9 5729.0 5787.6 5811.4 5525.7 5595.1 5623.7 5678.9 5684.1 5582.8 5639.3 5645.2 5653.3 5666.3 6239.1 6249.6 6257.9 6267.2 6274.8 6851.3 6869.7 6901.8 6930.2 6941.2 6761.4 6822.5 6865.7 6915.1 6923.4 6422.5 6445.0 6475.4 6477.7 6484.9 7092.0 7107.3 7112.9 7113.5 7220.1 6701.8 6750.1 6761.0 6831.8 6907.8 6838.8 6886.8 6887.7 6888.3 6902.3 6874.8 6888.7 6905.0 6935.9 6950.6 6839.7 6848.5 6878.8 6946.8 6948.3 4938.5 4946.2 5015.5 5045.7 5063.3 4579.8 4600.1 4645.6 4652.9 4671.6 6301.7 6377.0 6457.9 6459.4 6463.4 6748.0 6841.9 6851.0 6892.4 6932.5 6302.2 6383.7 6391.0 6397.3 6407.7 5560.1 5619.0 5628.9 5638.9 5639.1 7034.7 7042.8 7097.6 7110.0 7225.9 6816.9 6841.7 6913.7 6924.7 6927.4 7046.2 7169.7 7215.5 7273.1 7276.7 6784.2 6802.0 6805.1 6806.6 6813.5 6738.8 6837.4 6863.3 6935.0 6963.4 6629.4 6631.3 6643.3 6713.6 6720.9 6419.4 6598.1 6636.9 6701.5 6719.5 6408.5 6434.4 6476.7 6493.6 6495.3 6414.8 6589.9 6609.9 6611.6 6620.9 6312.4 6329.1 6431.0 6435.8 6452.9 12:01:23 INFO - PID 13862 | 12:01:23 INFO - PID 13862 | [#1] ext.html Cycles:180 Average:43126.42 Median:35609.73 stddev:67406.49 (189.3%) stddev-sans-first:67521.24 12:01:23 INFO - PID 13862 | Values: 962.7 996.5 1017.9 1021.1 1024.4 41725.8 42370.8 42606.8 42661.6 42747.0 39508.8 43348.1 43809.0 43976.8 44066.3 8160.8 8275.2 8279.2 8295.3 8330.7 8055.4 8221.8 8229.4 8257.3 8286.1 8241.4 8306.9 8309.2 8311.8 8316.9 8193.4 8235.4 8263.5 8271.6 8292.8 7981.9 7983.8 8002.2 8021.3 8042.8 39172.2 39252.2 39354.4 39573.6 39622.0 3737.7 3768.7 3777.1 3777.2 3777.4 31786.8 31947.4 31982.5 32092.0 32256.0 5394.6 5413.2 5415.8 5452.4 5555.1 205797.0 206619.0 206627.0 207312.0 207434.0 49948.8 50035.0 50130.0 50152.7 50345.2 55533.7 56416.0 56546.4 56573.4 56695.4 15701.8 15827.2 15883.1 15895.6 16002.2 12831.9 12862.6 13758.4 13989.9 13990.6 15999.9 16045.3 16063.3 16094.2 16199.8 5997.6 6225.6 6290.5 6294.6 6300.1 1096.2 1096.9 1108.7 1109.7 1122.4 25778.7 25782.0 25805.7 25899.6 26070.0 1202.4 1210.2 1219.8 1226.5 1235.7 13609.7 13708.2 13794.7 13879.0 13931.7 301791.0 302003.0 302828.0 303917.0 304318.0 55854.4 56550.7 58132.4 62866.0 63045.4 1512.9 1545.8 1547.9 1549.8 1553.2 29715.7 29802.6 29945.9 29952.9 30359.2 40263.0 40658.8 40699.0 40739.8 40851.4 254794.0 257092.0 257836.0 258433.0 258739.0 35226.8 35391.5 35402.5 35817.0 35862.0 43816.0 45540.5 46210.5 46229.0 46304.0 33698.7 33850.8 33910.2 34000.3 34012.3 33060.8 33137.5 33299.8 33323.0 33432.0 39009.2 39373.8 39396.6 39441.6 39468.4 31784.8 32401.0 32629.0 33007.0 33105.5 25209.0 25339.4 25606.2 25980.5 26154.9 12:01:23 INFO - PID 13862 | 12:01:23 INFO - PID 13862 | [#2] jquery.html Cycles:180 Average:41566.83 Median:12669.85 stddev:106499.33 (840.6%) stddev-sans-first:106753.64 12:01:23 INFO - PID 13862 | Values: 586.3 607.9 612.6 639.2 647.3 23293.3 23436.9 24321.1 24353.3 24358.0 25134.6 25842.6 26200.2 26201.5 26202.7 6649.3 6780.7 6785.5 6786.8 6790.8 6389.2 6604.3 6636.1 6653.6 6721.6 6543.0 6613.3 6615.0 6615.2 6623.2 6520.3 6552.3 6579.8 6584.2 6746.1 6286.1 6314.5 6315.0 6323.7 6336.6 30189.0 30819.0 30840.8 30858.2 30925.0 2273.4 2288.8 2305.7 2308.1 2309.7 20042.0 20905.7 20905.8 20927.7 21036.6 2572.0 2574.3 2609.8 2617.0 2627.9 136561.3 143229.0 148702.0 150157.0 154600.0 15498.4 15846.3 16289.9 16334.2 16561.0 26067.0 26072.5 26122.0 26215.5 26337.2 10735.1 10860.3 10959.6 10963.3 10977.1 9938.0 10043.4 10071.8 10121.4 10168.4 9769.2 9809.6 9923.1 10055.2 10091.2 2995.7 3018.7 3027.9 3042.9 3069.4 1020.9 1055.8 1057.8 1060.1 1060.2 20918.2 21069.2 21177.4 21286.3 21637.9 1089.5 1094.1 1096.4 1100.0 1108.0 11364.9 11393.9 11399.8 11460.3 11585.8 605069.0 620590.0 648271.0 656641.0 661799.0 129374.0 131382.3 133083.3 134188.0 134728.0 1193.3 1303.5 1342.9 1354.3 1368.4 22750.5 23025.2 23034.0 23290.5 23886.8 65993.0 67488.8 69339.3 69586.7 69818.0 87366.6 88223.0 89274.6 89918.0 92806.0 21473.1 21906.0 21913.1 21991.5 22022.8 24272.8 24290.6 24324.6 24347.8 24436.5 19883.6 20001.8 20025.8 20110.3 20112.5 17050.0 17705.5 17755.6 18035.6 18251.9 20231.6 20243.9 20312.6 20435.6 20654.8 21457.8 21539.8 21546.7 21565.6 21572.6 19408.7 19473.6 19663.7 19744.8 19766.9 12:01:23 INFO - PID 13862 | 12:01:23 INFO - PID 13862 | [#3] mootools.html Cycles:180 Average:10339.32 Median:2592.38 stddev:7759.60 (299.3%) stddev-sans-first:7752.46 12:01:23 INFO - PID 13862 | Values: 1424.5 1473.6 1491.8 1506.1 1506.6 16390.3 16884.6 16992.4 17014.7 17098.3 16865.5 16885.2 16916.7 16919.0 16929.7 2552.1 2553.3 2611.9 2613.0 2622.0 2538.7 2578.6 2589.4 2592.1 2592.7 2597.5 2630.4 2685.9 2686.8 2686.9 2561.1 2629.5 2636.3 2657.3 2659.4 2576.1 2704.1 2706.6 2708.8 2709.5 16549.1 16707.7 16713.7 16715.6 16717.7 8104.1 8469.6 8513.2 8524.7 8554.0 5424.9 5445.6 5464.3 5563.2 5594.2 2100.3 2131.8 2173.7 2193.4 2202.7 30257.7 30481.2 30495.2 30506.1 30550.0 6809.8 6957.7 7033.6 7191.4 7267.8 19845.2 19868.4 19881.4 19902.6 19906.6 8138.1 8469.6 8478.3 8483.9 8485.2 7596.8 7709.2 7719.2 7780.3 7781.4 5145.3 5281.1 5334.1 5342.9 5363.1 1528.9 1541.2 1546.1 1549.1 1553.9 935.8 953.7 955.4 958.5 964.8 8110.1 8395.7 8449.1 8503.5 8585.6 777.3 784.8 801.5 807.1 807.2 5611.7 5860.2 5869.8 5933.4 6027.5 23485.0 24649.9 24843.0 25447.0 25459.2 24219.3 24628.0 25047.0 25069.2 25209.0 12474.8 12612.1 12732.2 12846.6 12851.8 9689.8 9712.6 9758.0 9841.3 9983.3 21214.8 21236.2 21465.6 21469.1 21961.6 21761.2 22107.6 22212.9 22348.3 22594.9 12127.8 12197.7 12305.3 12452.6 12455.3 15489.1 15535.2 15605.1 15721.7 15753.0 11933.0 12029.3 12105.4 12184.0 12489.7 11808.1 12053.9 12083.8 12312.5 12458.5 9752.2 9918.8 10015.4 10109.3 10112.0 8195.7 8237.6 8283.6 8304.3 8314.4 8342.2 8346.5 8412.8 8480.6 8501.7 12:01:23 INFO - PID 13862 | 12:01:23 INFO - PID 13862 | [#4] prototype.html Cycles:180 Average:5625.49 Median:6207.29 stddev:1561.55 (25.2%) stddev-sans-first:1518.92 12:01:23 INFO - PID 13862 | Values: 559.2 573.0 582.6 584.9 590.4 6164.9 6255.5 6256.0 6270.3 6291.2 6112.8 6115.0 6168.2 6176.2 6178.8 5077.1 5114.2 5125.5 5154.6 5156.4 4847.2 4936.4 5092.2 5101.2 5133.2 4872.7 4935.0 4969.2 4983.3 4988.3 4900.9 4924.6 4973.3 4974.5 4975.5 4424.0 4524.4 4540.3 4542.7 4558.5 6014.2 6074.1 6130.1 6142.4 6149.8 5822.7 5868.0 5879.2 5892.8 5900.1 6676.2 6683.3 6688.5 6695.5 6713.9 5066.7 5070.8 5075.4 5086.4 5091.9 6732.3 6736.0 6838.9 6877.7 6889.7 5197.0 5200.6 5209.9 5210.9 5219.8 5292.3 5300.2 5304.5 5317.3 5323.1 5765.9 5786.0 5871.5 5873.3 5882.1 6611.6 6616.4 6657.8 6694.3 6695.5 1821.7 1831.8 1834.9 1835.5 1837.2 1253.7 1293.6 1303.5 1305.7 1318.8 6168.3 6172.6 6178.1 6207.9 6237.1 6540.9 6564.2 6666.3 6678.9 6682.3 6155.1 6206.6 6226.1 6259.9 6263.2 3547.5 3575.6 3579.6 3591.0 3596.6 6945.5 7014.6 7077.3 7097.4 7141.8 6787.6 6884.1 6886.4 6907.7 6926.5 7060.6 7063.2 7066.4 7102.3 7135.5 6698.5 6702.2 6738.3 6761.0 6813.7 6660.4 6696.0 6717.4 6719.9 6720.3 6997.0 7013.3 7034.3 7059.6 7124.8 5248.3 5256.7 5258.0 5271.3 5288.0 6520.3 6673.5 6749.3 6763.2 6834.2 6427.7 6448.1 6469.7 6530.7 6560.6 6332.6 6378.2 6402.4 6490.7 6536.3 6240.8 6337.1 6428.0 6466.5 6472.4 6471.3 6507.4 6522.2 6558.2 6565.8 6232.8 6264.9 6402.3 6411.0 6449.8 12:01:23 INFO - PID 13862 | 12:01:23 INFO - PID 13862 | [#5] yui.html Cycles:180 Average:28028.96 Median:18157.27 stddev:41574.12 (229.0%) stddev-sans-first:41641.09 12:01:23 INFO - PID 13862 | Values: 966.9 985.3 996.2 1005.3 1005.3 18139.9 18607.1 18677.2 18686.9 18691.3 19311.5 19708.7 19949.2 20406.3 20668.4 1070.5 1088.9 1090.6 1091.0 1091.1 1062.2 1090.5 1091.1 1093.6 1094.1 1164.1 1170.5 1170.7 1172.0 1172.3 1162.1 1163.1 1163.1 1167.8 1169.0 792.1 819.3 823.9 824.0 824.3 21180.7 21306.0 21346.6 21454.6 21533.5 22731.7 22985.7 23261.4 23396.0 23401.4 18320.2 18731.3 18824.7 19140.9 19175.5 3925.6 3932.0 3947.7 3947.9 3950.6 153971.0 155729.0 156855.2 157186.2 158549.0 17893.3 17907.6 17939.2 18088.9 18168.5 33734.0 34528.5 35074.8 35088.3 35106.3 9155.1 9273.7 9278.2 9286.3 9311.6 4814.8 4847.9 4857.7 4880.3 4894.7 5952.9 5982.1 6068.2 6112.3 6160.7 1118.9 1145.4 1155.3 1163.6 1168.2 756.6 763.9 764.5 771.0 788.5 12544.4 12751.5 12792.3 12947.9 12951.2 766.5 768.3 777.2 778.2 781.6 6036.7 6196.1 6253.6 6280.6 6352.0 140804.0 141624.0 141961.3 145637.3 147907.0 127137.4 129250.0 130142.3 130954.0 136907.0 116341.0 116520.0 117356.0 119128.4 120159.0 11859.2 11942.8 11971.7 12085.2 12304.8 52413.0 52504.0 53268.1 54388.2 54550.7 69954.3 70755.0 71035.0 71044.0 71757.5 17183.9 18033.3 18123.6 18154.9 18159.6 18741.0 19071.0 19152.3 19254.1 19376.0 17496.4 17583.7 17591.4 17680.7 17693.5 17056.2 17347.5 17465.1 17486.5 17523.1 17655.9 17729.2 17819.4 17848.7 18128.7 13298.7 13555.8 13701.0 13763.9 13832.4 13349.3 13474.4 13610.6 13697.5 13720.6 12:01:23 INFO - PID 13862 | -------- Summary: end -------- 12:01:23 INFO - PID 13862 | 12:01:23 INFO - TEST-INFO | 13862: exit 0 12:01:23 INFO - TEST-OK | dromaeo_css | took 1107740ms 12:01:23 INFO - TEST-START | kraken 12:01:23 INFO - Initialising browser for kraken test... 12:01:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41254/getInfo.html -profile /tmp/tmpjAItWj/profile 12:01:23 INFO - TEST-INFO | started process 14237 (/builds/slave/test/build/application/firefox/firefox http://localhost:41254/getInfo.html) 12:01:28 INFO - TEST-INFO | 14237: exit 0 12:01:28 INFO - Browser initialized. 12:01:28 INFO - Running cycle 1/1 for kraken test... 12:01:28 INFO - Using env: {'DISPLAY': ':0', 12:01:28 INFO - 'HOME': '/home/cltbld', 12:01:28 INFO - 'JSGC_DISABLE_POISONING': '1', 12:01:28 INFO - 'LANG': 'en_US.UTF-8', 12:01:28 INFO - 'LANGUAGE': 'en_US:en', 12:01:28 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:01:28 INFO - 'LOGNAME': 'cltbld', 12:01:28 INFO - 'MAIL': '/var/mail/cltbld', 12:01:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:01:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:01:28 INFO - 'MOZ_CRASHREPORTER': '1', 12:01:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:28 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:01:28 INFO - 'MOZ_NO_REMOTE': '1', 12:01:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:01:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:28 INFO - 'NO_EM_RESTART': '1', 12:01:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:28 INFO - 'PWD': '/builds/slave/test', 12:01:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:01:28 INFO - 'RUST_BACKTRACE': 'full', 12:01:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:01:28 INFO - 'SHELL': '/bin/bash', 12:01:28 INFO - 'SHLVL': '1', 12:01:28 INFO - 'TERM': 'linux', 12:01:28 INFO - 'TMOUT': '86400', 12:01:28 INFO - 'USER': 'cltbld', 12:01:28 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530', 12:01:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:28 INFO - '_': '/tools/buildbot/bin/python'} 12:01:28 INFO - TEST-INFO | started process 14479 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjAItWj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:01:29 INFO - PID 14479 | 12:01:29 INFO - PID 14479 | (/builds/slave/test/build/application/firefox/firefox:14528): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:01:29 INFO - PID 14479 | 12:01:40 INFO - PID 14479 | RSS: Main: 145367040 12:01:40 INFO - PID 14479 | 12:01:42 INFO - PID 14479 | Cycle 1(1): loaded http://localhost:41254/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41254/tests/kraken/driver.html?testName=audio-beat-detection) 12:01:43 INFO - PID 14479 | RSS: Main: 150773760 12:01:43 INFO - PID 14479 | 12:01:46 INFO - PID 14479 | Cycle 1(1): loaded http://localhost:41254/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41254/tests/kraken/driver.html?testName=audio-dft) 12:01:46 INFO - PID 14479 | RSS: Main: 151085056 12:01:46 INFO - PID 14479 | 12:01:49 INFO - PID 14479 | Cycle 1(1): loaded http://localhost:41254/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41254/tests/kraken/driver.html?testName=audio-fft) 12:01:50 INFO - PID 14479 | RSS: Main: 148283392 12:01:50 INFO - PID 14479 | 12:01:52 INFO - PID 14479 | Cycle 1(1): loaded http://localhost:41254/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41254/tests/kraken/driver.html?testName=audio-oscillator) 12:01:52 INFO - PID 14479 | RSS: Main: 148979712 12:01:52 INFO - PID 14479 | 12:01:54 INFO - PID 14479 | Cycle 1(1): loaded http://localhost:41254/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41254/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:01:55 INFO - PID 14479 | RSS: Main: 148910080 12:01:55 INFO - PID 14479 | 12:01:58 INFO - PID 14479 | Cycle 1(1): loaded http://localhost:41254/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41254/tests/kraken/driver.html?testName=imaging-darkroom) 12:01:59 INFO - PID 14479 | RSS: Main: 148815872 12:01:59 INFO - PID 14479 | 12:02:02 INFO - PID 14479 | Cycle 1(1): loaded http://localhost:41254/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41254/tests/kraken/driver.html?testName=imaging-desaturate) 12:02:03 INFO - PID 14479 | RSS: Main: 151388160 12:02:03 INFO - PID 14479 | 12:02:06 INFO - PID 14479 | Cycle 1(1): loaded http://localhost:41254/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41254/tests/kraken/driver.html?testName=json-parse-financial) 12:02:06 INFO - PID 14479 | RSS: Main: 151457792 12:02:06 INFO - PID 14479 | 12:02:08 INFO - PID 14479 | Cycle 1(1): loaded http://localhost:41254/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41254/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:02:09 INFO - PID 14479 | RSS: Main: 151347200 12:02:09 INFO - PID 14479 | 12:02:10 INFO - PID 14479 | Cycle 1(1): loaded http://localhost:41254/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41254/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:02:11 INFO - PID 14479 | RSS: Main: 151183360 12:02:11 INFO - PID 14479 | 12:02:13 INFO - PID 14479 | Cycle 1(1): loaded http://localhost:41254/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41254/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:02:13 INFO - PID 14479 | RSS: Main: 148348928 12:02:13 INFO - PID 14479 | 12:02:16 INFO - PID 14479 | Cycle 1(1): loaded http://localhost:41254/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41254/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:02:16 INFO - PID 14479 | RSS: Main: 148348928 12:02:16 INFO - PID 14479 | 12:02:19 INFO - PID 14479 | Cycle 1(1): loaded http://localhost:41254/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41254/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:02:20 INFO - PID 14479 | RSS: Main: 148692992 12:02:20 INFO - PID 14479 | 12:02:21 INFO - PID 14479 | Cycle 1(1): loaded http://localhost:41254/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41254/tests/kraken/driver.html?testName=ai-astar) 12:02:22 INFO - PID 14479 | RSS: Main: 149843968 12:02:22 INFO - PID 14479 | 12:02:22 INFO - PID 14479 | __start_tp_report 12:02:22 INFO - PID 14479 | _x_x_mozilla_page_load 12:02:22 INFO - PID 14479 | _x_x_mozilla_page_load_details 12:02:22 INFO - PID 14479 | |i|pagename|runs| 12:02:22 INFO - PID 14479 | |0;ai-astar;108;106;106;107;107;109;107;107;107;105 12:02:22 INFO - PID 14479 | |1;audio-beat-detection;117;115;113;115;114;112;142;118;114;112 12:02:22 INFO - PID 14479 | |2;audio-dft;162;163;161;161;162;161;162;162;166;166 12:02:22 INFO - PID 14479 | |3;audio-fft;74;73;74;73;73;74;73;74;73;76 12:02:22 INFO - PID 14479 | |4;audio-oscillator;79;78;80;78;77;78;79;79;79;78 12:02:22 INFO - PID 14479 | |5;imaging-gaussian-blur;113;114;113;113;112;114;114;114;111;114 12:02:22 INFO - PID 14479 | |6;imaging-darkroom;151;150;150;149;149;150;151;151;150;151 12:02:22 INFO - PID 14479 | |7;imaging-desaturate;97;95;94;94;94;93;95;95;94;94 12:02:22 INFO - PID 14479 | |8;json-parse-financial;45;44;47;42;49;43;45;45;44;43 12:02:22 INFO - PID 14479 | |9;json-stringify-tinderbox;36;37;37;38;38;38;38;37;38;38 12:02:22 INFO - PID 14479 | |10;stanford-crypto-aes;72;73;70;70;70;72;71;71;73;70 12:02:22 INFO - PID 14479 | |11;stanford-crypto-ccm;103;110;113;104;106;119;116;114;103;105 12:02:22 INFO - PID 14479 | |12;stanford-crypto-pbkdf2;172;161;150;151;149;154;149;151;150;151 12:02:22 INFO - PID 14479 | |13;stanford-crypto-sha256-iterative;61;59;59;60;60;59;61;61;61;63 12:02:22 INFO - PID 14479 | __end_tp_report 12:02:22 INFO - PID 14479 | __start_cc_report 12:02:22 INFO - PID 14479 | _x_x_mozilla_cycle_collect,682 12:02:22 INFO - PID 14479 | __end_cc_report 12:02:22 INFO - PID 14479 | __startTimestamp1506538942204__endTimestamp 12:02:22 INFO - PID 14479 | 12:02:22 INFO - PID 14479 | ------- Summary: start ------- 12:02:22 INFO - PID 14479 | Number of tests: 14 12:02:22 INFO - PID 14479 | 12:02:22 INFO - PID 14479 | [#0] ai-astar Cycles:10 Average:106.90 Median:107.00 stddev:1.10 (1.0%) stddev-sans-first:1.09 12:02:22 INFO - PID 14479 | Values: 108.0 106.0 106.0 107.0 107.0 109.0 107.0 107.0 107.0 105.0 12:02:22 INFO - PID 14479 | 12:02:22 INFO - PID 14479 | [#1] audio-beat-detection Cycles:10 Average:117.20 Median:115.00 stddev:8.93 (7.8%) stddev-sans-first:9.47 12:02:22 INFO - PID 14479 | Values: 117.0 115.0 113.0 115.0 114.0 112.0 142.0 118.0 114.0 112.0 12:02:22 INFO - PID 14479 | 12:02:22 INFO - PID 14479 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.00 stddev:1.90 (1.2%) stddev-sans-first:2.00 12:02:22 INFO - PID 14479 | Values: 162.0 163.0 161.0 161.0 162.0 161.0 162.0 162.0 166.0 166.0 12:02:22 INFO - PID 14479 | 12:02:22 INFO - PID 14479 | [#3] audio-fft Cycles:10 Average:73.70 Median:74.00 stddev:0.95 (1.3%) stddev-sans-first:1.00 12:02:22 INFO - PID 14479 | Values: 74.0 73.0 74.0 73.0 73.0 74.0 73.0 74.0 73.0 76.0 12:02:22 INFO - PID 14479 | 12:02:22 INFO - PID 14479 | [#4] audio-oscillator Cycles:10 Average:78.50 Median:79.00 stddev:0.85 (1.1%) stddev-sans-first:0.88 12:02:22 INFO - PID 14479 | Values: 79.0 78.0 80.0 78.0 77.0 78.0 79.0 79.0 79.0 78.0 12:02:22 INFO - PID 14479 | 12:02:22 INFO - PID 14479 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:114.00 stddev:1.03 (0.9%) stddev-sans-first:1.09 12:02:22 INFO - PID 14479 | Values: 113.0 114.0 113.0 113.0 112.0 114.0 114.0 114.0 111.0 114.0 12:02:22 INFO - PID 14479 | 12:02:22 INFO - PID 14479 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:150.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 12:02:22 INFO - PID 14479 | Values: 151.0 150.0 150.0 149.0 149.0 150.0 151.0 151.0 150.0 151.0 12:02:22 INFO - PID 14479 | 12:02:22 INFO - PID 14479 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:1.08 (1.1%) stddev-sans-first:0.67 12:02:22 INFO - PID 14479 | Values: 97.0 95.0 94.0 94.0 94.0 93.0 95.0 95.0 94.0 94.0 12:02:22 INFO - PID 14479 | 12:02:22 INFO - PID 14479 | [#8] json-parse-financial Cycles:10 Average:44.70 Median:45.00 stddev:2.06 (4.6%) stddev-sans-first:2.18 12:02:22 INFO - PID 14479 | Values: 45.0 44.0 47.0 42.0 49.0 43.0 45.0 45.0 44.0 43.0 12:02:22 INFO - PID 14479 | 12:02:22 INFO - PID 14479 | [#9] json-stringify-tinderbox Cycles:10 Average:37.50 Median:38.00 stddev:0.71 (1.9%) stddev-sans-first:0.50 12:02:22 INFO - PID 14479 | Values: 36.0 37.0 37.0 38.0 38.0 38.0 38.0 37.0 38.0 38.0 12:02:22 INFO - PID 14479 | 12:02:22 INFO - PID 14479 | [#10] stanford-crypto-aes Cycles:10 Average:71.20 Median:71.50 stddev:1.23 (1.7%) stddev-sans-first:1.27 12:02:22 INFO - PID 14479 | Values: 72.0 73.0 70.0 70.0 70.0 72.0 71.0 71.0 73.0 70.0 12:02:22 INFO - PID 14479 | 12:02:22 INFO - PID 14479 | [#11] stanford-crypto-ccm Cycles:10 Average:109.30 Median:111.50 stddev:5.89 (5.3%) stddev-sans-first:5.79 12:02:22 INFO - PID 14479 | Values: 103.0 110.0 113.0 104.0 106.0 119.0 116.0 114.0 103.0 105.0 12:02:22 INFO - PID 14479 | 12:02:22 INFO - PID 14479 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.80 Median:151.00 stddev:7.32 (4.8%) stddev-sans-first:3.77 12:02:22 INFO - PID 14479 | Values: 172.0 161.0 150.0 151.0 149.0 154.0 149.0 151.0 150.0 151.0 12:02:22 INFO - PID 14479 | 12:02:22 INFO - PID 14479 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.40 Median:61.00 stddev:1.26 (2.1%) stddev-sans-first:1.32 12:02:22 INFO - PID 14479 | Values: 61.0 59.0 59.0 60.0 60.0 59.0 61.0 61.0 61.0 63.0 12:02:22 INFO - PID 14479 | -------- Summary: end -------- 12:02:22 INFO - PID 14479 | 12:02:22 INFO - PID 14479 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:02:22 INFO - TEST-INFO | 14479: exit 0 12:02:22 INFO - TEST-OK | kraken | took 59056ms 12:02:22 INFO - SUITE-END | took 1166s 12:02:22 INFO - Completed test suite (00:19:26) 12:02:22 INFO - javascript benchmark 12:02:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9111.678226740209, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3866.922661546769, 3929.4302326162706, 3933.115049113948, 3950.980245098774, 3956.5845586213427, 6199.814005579834, 6208.317085120644, 6289.0566415037765, 6314.905276420845, 6382.712777924993, 6306.1171435998995, 6308.71610777515, 6308.810735677926, 6310.148130002448, 6349.682515874211, 5698.886022279552, 5700.201971723962, 5727.398623144572, 5750.913736293938, 5770.047942089571, 5570.359408667994, 5691.800786972457, 5733.512651424634, 5785.247917770684, 5790.68151251681, 5635.690037047961, 5719.914201286984, 5728.97135514324, 5787.594868359217, 5811.360750317462, 5525.723713814334, 5595.132754423071, 5623.718814059322, 5678.9432105678825, 5684.118961560965, 5582.804601838916, 5639.323281206241, 5645.15322701594, 5653.321601407816, 5666.291713535808, 6239.126522286883, 6249.5625306228585, 6257.8748425031245, 6267.153934218868, 6274.780382686584, 6851.2806155353965, 6869.690863911136, 6901.75843845463, 6930.168379794457, 6941.236463988957, 6761.391474767245, 6822.454203663695, 6865.656717164122, 6915.135608048994, 6923.446124310043, 6422.518311126638, 6445.0, 6475.449586785129, 6477.676116194171, 6484.93515064848, 7091.964540177266, 7107.253738357502, 7112.893306600405, 7113.5376200547835, 7220.133583969957, 6701.832454188684, 6750.122484077038, 6760.966195168992, 6831.795046148623, 6907.827304317332, 6838.794836154824, 6886.793396198122, 6887.655617219119, 6888.345607167311, 6902.344277293649, 6874.759383421556, 6888.655567221619, 6905.0, 6935.930640693629, 6950.582965022115, 6839.658017099126, 6848.452123830081, 6878.828029299208, 6946.756863509753, 6948.27043160471, 4938.456769755324, 4946.233333833262, 5015.4733752956145, 5045.672031317952, 5063.265826455144, 4579.771011449414, 4600.056988317387, 4645.605123564535, 4652.883677908079, 4671.556202160789, 6301.6534090625455, 6377.0, 6457.935420645827, 6459.386358295955, 6463.353664633499, 6747.966260168668, 6841.863162736718, 6850.965745171242, 6892.414144797648, 6932.514723969273, 6302.212223472066, 6383.744650214032, 6391.041343798374, 6397.328280530571, 6407.679616019181, 5560.138178582326, 5619.0, 5628.943710562842, 5638.943610563924, 5639.097744360883, 7034.683439245144, 7042.788716338416, 7097.574145551283, 7110.0, 7225.8554828903125, 6816.897746533905, 6841.726330946905, 6913.654317284015, 6924.723011079501, 6927.376536111774, 7046.2249152594195, 7169.713211471482, 7215.494915355875, 7273.0908636420445, 7276.7089316426745, 6784.151981002375, 6802.0, 6805.115335006418, 6806.55757375769, 6813.523053386215, 6738.797836064926, 6837.384635382839, 6863.2793556677825, 6934.9653251735435, 6963.373296403145, 6629.436497897733, 6631.303713110054, 6643.335666433318, 6713.597184168965, 6720.9327906722265, 6419.422251997343, 6598.1422415085735, 6636.9004464932095, 6701.530892837454, 6719.462443004646, 6408.519361048034, 6434.356564343529, 6476.676166191766, 6493.610383377012, 6495.253045899593, 6414.775482858077, 6589.934100658932, 6609.900851487136, 6611.636360000246, 6620.900686489803, 6312.400321969406, 6329.050642403677, 6431.0, 6435.839104022437, 6452.903206451813], "value": 6267.847148252813, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [962.6823148361046, 996.5415908682007, 1017.9083882450581, 1021.1116328793951, 1024.426321260094, 41725.79137104314, 42370.788146059305, 42606.78696606513, 42661.57338426615, 42747.0, 39508.80245598768, 43348.133037339234, 43809.0, 43976.78011609946, 44066.33900491495, 8160.836783264331, 8275.213854683825, 8279.172082791703, 8295.294899933513, 8330.708425205119, 8055.436119471639, 8221.83556328873, 8229.382796290272, 8257.339412846957, 8286.088530261666, 8241.381896357767, 8306.916930830675, 8309.210624990616, 8311.83376332473, 8316.875246871301, 8193.426460147792, 8235.38234632405, 8263.545504997222, 8271.586420678972, 8292.751217463485, 7981.920180798175, 7983.840323193562, 8002.239787220205, 8021.318187954031, 8042.798930026737, 39172.21655566901, 39252.21495570101, 39354.40968385476, 39573.60426395728, 39622.0, 3737.738358314919, 3768.679662228714, 3777.1312598102318, 3777.1501412182315, 3777.414500752388, 31786.841065794753, 31947.361052779048, 31982.520262196085, 32092.0, 32256.032319030466, 5394.595405344615, 5413.242146099549, 5415.783368665248, 5452.372977107604, 5555.138953462219, 205797.0, 206619.0, 206627.0, 207312.0, 207433.9999999985, 49948.75025624849, 50035.0, 50130.0, 50152.74923625431, 50345.24482132771, 55533.72233138808, 56416.0, 56546.434535654116, 56573.43426565764, 56695.43304566984, 15701.764473532907, 15827.208639567976, 15883.126428046337, 15895.602609934844, 16002.199890005453, 12831.935840320926, 12862.614121576367, 13758.380872860746, 13989.930050349887, 13990.580282591538, 15999.920000399923, 16045.277962491717, 16063.277152528164, 16094.19529023544, 16199.838001620068, 5997.610155339889, 6225.595336303126, 6290.528210384239, 6294.590851594723, 6300.117983482316, 1096.2490693874722, 1096.8903109689127, 1108.6895669212633, 1109.7392112853472, 1122.3882983773863, 25778.742212577636, 25782.0, 25805.74194258071, 25899.611505827426, 26070.0, 1202.4168278384977, 1210.2073142091945, 1219.8475190601175, 1226.466487078124, 1235.6540168752763, 13609.659758506117, 13708.24604646754, 13794.65513362154, 13879.0, 13931.721365572632, 301791.0, 302003.0, 302828.0, 303917.0, 304318.0, 55854.44145558574, 56550.71724641351, 58132.41867581355, 62866.0, 63045.36954630395, 1512.9092254464767, 1545.7758624999312, 1547.9071255724693, 1549.7985261915878, 1553.2389129326548, 29715.702842971292, 29802.552961705158, 29945.850270748506, 29952.850235748683, 30359.241018974702, 40263.0, 40658.79670601628, 40699.0, 40739.79630101831, 40851.387229190994, 254794.0, 257092.0, 257836.0, 258433.0, 258739.0, 35226.823865880506, 35391.469127962584, 35402.46896296609, 35817.0, 35862.0, 43816.0, 45540.54459455496, 46210.53789462197, 46229.0, 46304.0, 33698.66301336955, 33850.83074584611, 33910.15224619404, 34000.31999359949, 34012.31975360528, 33060.834695826365, 33137.50293745644, 33299.83350083234, 33323.0, 33432.0, 39009.2198156041, 39373.80313098531, 39396.60603394044, 39441.60558394379, 39468.40797387984, 31784.841075794473, 32401.0, 32629.0, 33007.0, 33105.50341744924, 25209.0, 25339.366515837253, 25606.231813045637, 25980.480390392466, 26154.86922565375], "value": 18649.352089948025, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.3030061716106, 607.8510764862609, 612.5773216480628, 639.2424976402963, 647.3461803578385, 23293.301200963997, 23436.88281558592, 24321.14875979341, 24353.269401917947, 24357.999999999956, 25134.62298065526, 25842.612360814604, 26200.213993580175, 26201.475970480627, 26202.737972620267, 6649.268580456146, 6780.72877084916, 6785.457163426939, 6786.8303292417595, 6790.762323318685, 6389.1694079769795, 6604.306547812483, 6636.070950066995, 6653.567518111307, 6721.563098398613, 6543.0, 6613.272540020594, 6615.040819081254, 6615.17310336208, 6623.23832759234, 6520.347965203489, 6552.344765523457, 6579.80260592183, 6584.209894812653, 6746.123004009447, 6286.057091436275, 6314.463270622003, 6315.0, 6323.6521991290465, 6336.556441049129, 30189.0, 30819.0, 30840.845795771103, 30858.228544286347, 30925.0, 2273.3634582316977, 2288.8054515366216, 2305.7002589663234, 2308.1459859851793, 2309.7459279479244, 20042.0, 20905.686414703792, 20905.790942090538, 20927.68608470874, 21036.579268414545, 2571.961420578693, 2574.304937666838, 2609.8042646801564, 2616.973830261692, 2627.868606569683, 136561.3171934134, 143229.0, 148702.0, 150157.0, 154600.0, 15498.380064797508, 15846.286917088759, 16289.918550407172, 16334.18329083541, 16561.0, 26067.0, 26072.478550429263, 26122.0, 26215.475690486084, 26337.209883703137, 10735.141188704885, 10860.294080884718, 10959.56161753521, 10963.342199468058, 10977.12183025356, 9937.950310248403, 10043.397396156253, 10071.798564028679, 10121.392716437038, 10168.440735759455, 9769.16962058233, 9809.607615695435, 9923.1069203772, 10055.245856560787, 10091.243156763272, 2995.7011688227462, 3018.7434068104017, 3027.9394412112074, 3042.893498727534, 3069.4474994501206, 1020.8825985011819, 1055.8152323343384, 1057.7831544533506, 1060.0830281806182, 1060.188955449082, 20918.163273469196, 21069.15723371048, 21177.364679059654, 21286.254981075588, 21637.89181054116, 1089.54239219528, 1094.124700239805, 1096.3750662122513, 1099.983500247497, 1107.95568177272, 11364.94317528407, 11393.86061393854, 11399.772004559862, 11460.312381256985, 11585.76828463426, 605069.0, 620590.0, 648271.0, 656641.0, 661799.0, 129374.0, 131382.34308828396, 133083.3345833284, 134188.0, 134728.0, 1193.3436609864539, 1303.4619149403604, 1342.926139062361, 1354.3160703844692, 1368.4321006782075, 22750.544989100457, 23025.19411820578, 23034.0, 23290.53418931646, 23886.761132388452, 65993.0, 67488.78923766816, 69339.30660693531, 69586.65206674137, 69818.0, 87366.56316718376, 88223.0, 89274.55362723145, 89918.0, 92806.0, 21473.141074356852, 21906.0, 21913.12347506082, 21991.450213744785, 22022.779772202073, 24272.75727242705, 24290.63564046576, 24324.635130472703, 24347.75652243455, 24436.51126977415, 19883.60232795365, 20001.799981999993, 20025.799742002393, 20110.296139635044, 20112.49718757043, 17050.0, 17705.468835934942, 17755.556111097325, 18035.639287214446, 18251.908740456212, 20231.59536809226, 20243.898780506002, 20312.59374812525, 20435.59128817445, 20654.793452065285, 21457.78542214558, 21539.784602153777, 21546.6767998477, 21565.568688625826, 21572.568548629253, 19408.708869367252, 19473.61052778965, 19663.70504442406, 19744.80255197487, 19766.90116549408], "value": 13269.928074734566, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1424.5370254667232, 1473.550567077041, 1491.7613181890886, 1506.0737646347495, 1506.615812967693, 16390.262438190297, 16884.57788555285, 16992.405265815698, 17014.659706805858, 17098.316067357322, 16865.494035178934, 16885.24016419261, 16916.661666766657, 16919.0, 16929.66140677186, 2552.132275026491, 2553.2850801775535, 2611.8694065296754, 2612.9869350653316, 2621.960670589933, 2538.6953565572067, 2578.6389905413257, 2589.3656054266635, 2592.10572352539, 2592.6629538160014, 2597.480503899218, 2630.4213073123883, 2685.9462810743776, 2686.811923165379, 2686.946261074787, 2561.0908127614803, 2629.526685196664, 2636.301380134266, 2657.2958166086005, 2659.4016346322114, 2576.111241621656, 2704.067096851583, 2706.594010898381, 2708.769754570864, 2709.525832979221, 16549.089800060992, 16707.66584668312, 16713.749293760604, 16715.582110447336, 16717.749233761504, 8104.1490643482175, 8469.618867150994, 8513.233808957162, 8524.701635442792, 8554.0, 5424.945750542523, 5445.564354851603, 5464.3442786865435, 5563.221149039137, 5594.188842617838, 2100.2964007057503, 2131.82945364372, 2173.673948907661, 2193.385851961453, 2202.713647225866, 30257.697423025707, 30481.23796905073, 30495.23761905948, 30506.08481745529, 30550.0, 6809.795706128824, 6957.721691132399, 7033.577985320897, 7191.388731957738, 7267.7819665410125, 19845.206191752168, 19868.403947881587, 19881.403557893285, 19902.60194796096, 19906.60186796256, 8138.145494722969, 8469.576521173916, 8478.279346255636, 8483.915160848435, 8485.193906578865, 7596.81007974805, 7709.190534993857, 7719.228077192236, 7780.260875216845, 7781.377489800802, 5145.279660847485, 5281.102212623863, 5334.06653835585, 5342.946570534323, 5363.088274993261, 1528.8776897848145, 1541.213980869742, 1546.0646308982903, 1549.0782984124428, 1553.867921226686, 935.7660584853786, 953.7091187187974, 955.350361754, 958.5303201431249, 964.7925695975399, 8110.148434414419, 8395.748127556182, 8449.11284315138, 8503.532305723245, 8585.613647385757, 777.3237283563336, 784.7724159993652, 801.4550105927908, 807.112176605729, 807.1524898856178, 5611.719414029364, 5860.238169037998, 5869.765209391577, 5933.406659334032, 6027.457528822427, 23485.0, 24649.87675061613, 24843.0, 25447.0, 25459.236222913343, 24219.273421797374, 24628.0, 25047.0, 25069.247922562354, 25209.0, 12474.81287780684, 12612.117151799286, 12732.23606583608, 12846.614601561969, 12851.807222891664, 9689.757756056155, 9712.611495540099, 9758.0, 9841.311108222642, 9983.251256155672, 21214.78785212128, 21236.150553978285, 21465.570688585827, 21469.141234350453, 21961.560768784217, 21761.238356657443, 22107.557848843255, 22212.88893555522, 22348.32955011352, 22594.887025564767, 12127.75744485123, 12197.69505762363, 12305.26168429897, 12452.564160254347, 12455.314957677414, 15489.07065576069, 15535.223238838238, 15605.141717205208, 15721.68556628838, 15753.0, 11933.0, 12029.27824330508, 12105.394730263628, 12184.0, 12489.687757806127, 11808.114391420506, 12053.879461205626, 12083.75832483363, 12312.507499699912, 12458.501659933863, 9752.219822414332, 9918.801623967625, 10015.399076055168, 10109.292349535755, 10112.039356261143, 8195.67217311301, 8237.629306681094, 8283.58582070906, 8304.252617264476, 8314.417990740832, 8342.207490288412, 8346.499210047417, 8412.789680258042, 8480.618372173143, 8501.744947651581], "value": 7139.465273714317, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.1528833816768, 572.9770809167634, 582.6009183709162, 584.859633687915, 590.4066413254681, 6164.938350616492, 6255.529950461643, 6256.0, 6270.341614130519, 6291.15069465622, 6112.838560673469, 6115.0, 6168.167297414848, 6176.197094377724, 6178.752849885999, 5077.086124497589, 5114.156164232916, 5125.538701516863, 5154.639175257734, 5156.432792392834, 4847.175980083377, 4936.407631084275, 5092.185250359943, 5101.15830887903, 5133.230015497668, 4872.707637541741, 4934.975325123387, 4969.2049272116465, 4983.327250821129, 4988.2766998785155, 4900.901981960359, 4924.581410580105, 4973.303737476756, 4974.527419895104, 4975.527324904128, 4423.955760442386, 4524.411826462539, 4540.296254080623, 4542.659300552472, 4558.475775285851, 6014.2181516403025, 6074.119252708377, 6130.141780150782, 6142.385761423867, 6149.754009839601, 5822.679752613604, 5868.002439585281, 5879.235699359098, 5892.793752218695, 5900.085486749518, 6676.165479315086, 6683.2982536833415, 6688.464922806213, 6695.497837662146, 6713.865722685519, 5066.746662666888, 5070.847874563769, 5075.390953085616, 5086.440491545927, 5091.905240373338, 6732.326767323278, 6736.0, 6838.897416538756, 6877.727620390194, 6889.689963951634, 5197.0, 5200.557952573998, 5209.895802083937, 5210.947890521122, 5219.8255392536375, 5292.311999440049, 5300.178472336794, 5304.4960728731485, 5317.282166907496, 5323.121684922022, 5765.88468230633, 5785.971070144622, 5871.530277577784, 5873.2658417697785, 5882.117682347682, 6611.603303801788, 6616.437602803816, 6657.833554161088, 6694.263631000586, 6695.526984063498, 1821.6720990221888, 1831.7801863776433, 1834.9449516514526, 1835.5135888989428, 1837.2375464182483, 1253.6865783554113, 1293.5666551705096, 1303.478608556585, 1305.6670549009941, 1318.7692153873033, 6168.290646575611, 6172.611162488404, 6178.135061091451, 6207.937920620826, 6237.126802247689, 6540.901886471706, 6564.245111812203, 6666.266710661824, 6678.933210667831, 6682.264950855402, 6155.061155735929, 6206.6345404011045, 6226.128342032119, 6259.902932517658, 6263.154474146023, 3547.5033495310677, 3575.6245594212232, 3579.552555930509, 3590.982045089758, 3596.604373518911, 6945.513814032969, 7014.649267536603, 7077.256888026786, 7097.361237488651, 7141.750038748619, 6787.626680532618, 6884.139482564679, 6886.414654754301, 6907.654617269116, 6926.515143939876, 7060.575620823896, 7063.1524217094275, 7066.3640272374705, 7102.254263302279, 7135.5005149640065, 6698.464122870061, 6702.19573651165, 6738.2587915328295, 6761.0, 6813.727450901908, 6660.433863121495, 6696.0, 6717.429018533284, 6719.865602688016, 6720.294369091175, 6997.040828568009, 7013.266045419219, 7034.261402552658, 7059.647017649199, 7124.786256412316, 5248.265242865926, 5256.684598924076, 5257.973710131425, 5271.341082364705, 5287.9735601321745, 6520.282768895512, 6673.532852700265, 6749.257581665915, 6763.222229443677, 6834.248232694499, 6427.678616069272, 6448.1295025171, 6469.708863101077, 6530.738770449128, 6560.606363618198, 6332.556721029668, 6378.202724659418, 6402.391772781578, 6490.740370385321, 6536.3136870629805, 6240.781572644935, 6337.144485494399, 6427.967860160669, 6466.547341686037, 6472.449841763315, 6471.320511346429, 6507.381798729113, 6522.15212022453, 6558.213014438298, 6565.770198043046, 6232.844178895564, 6264.937350626436, 6402.295747467681, 6410.967945160244, 6449.774257900951], "value": 5180.787283212331, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [966.8646389505466, 985.3053597213965, 996.1781530237554, 1005.316384858296, 1005.33647792457, 18139.909300453495, 18607.06964651767, 18677.159527821263, 18686.906565467187, 18691.3458028969, 19311.517212069706, 19708.704369434436, 19949.202031918743, 20406.285779997703, 20668.379948601567, 1070.5182667799502, 1088.9128869690446, 1090.6128324444826, 1091.0, 1091.1052936591998, 1062.2086545523596, 1090.5365219781602, 1091.0780390569955, 1093.5516438260315, 1094.141099237099, 1164.0512981919708, 1170.4849866058908, 1170.7365842685413, 1172.0330727150092, 1172.2731906218157, 1162.0993729859342, 1163.069544364505, 1163.1044096045998, 1167.807311793553, 1169.029705344562, 792.124702204062, 819.3240576524391, 823.9464434811719, 824.0358780227089, 824.2540500846743, 21180.682289765668, 21306.0, 21346.5730685387, 21454.57090858174, 21533.461663458384, 22731.659025114637, 22985.655215171784, 23261.418464538354, 23396.0, 23401.36190466668, 18320.17559209839, 18731.344402945833, 18824.717629235573, 19140.904295478435, 19175.520611984673, 3925.60743925608, 3931.960680393188, 3947.743396679207, 3947.921041579152, 3950.5654378018394, 153971.0, 155729.0, 156855.21572392178, 157186.21406893007, 158549.0, 17893.28426862937, 17907.641847163246, 17939.192736326895, 18088.909555452137, 18168.45494635163, 33733.987980360136, 34528.48207276843, 35074.82462587671, 35088.298234035174, 35106.29787404238, 9155.13026262504, 9273.67542136022, 9278.211352035018, 9286.303527235485, 9311.580978855967, 4814.7833347499445, 4847.903041939212, 4857.6842505237755, 4880.341153944243, 4894.706317620954, 5952.8809423812145, 5982.102684597346, 6068.241469816273, 6112.297085835097, 6160.656737000493, 1118.8657361116718, 1145.381493993251, 1155.3010428690689, 1163.552032467506, 1168.1764356128908, 756.5687558091835, 763.9121501027453, 764.4572353628874, 770.9614519274014, 788.4953629677011, 12544.435500402322, 12751.489940402465, 12792.2964236966, 12947.870521294666, 12951.222926624432, 766.4941138848445, 768.2624680306968, 777.1567848883911, 778.1673609238061, 781.5935713428985, 6036.698165091816, 6196.10156527301, 6253.593516421418, 6280.623162610258, 6352.0, 140804.0, 141624.0, 141961.29019354837, 145637.27181364025, 147907.0, 127137.36431317969, 129249.96001919132, 130142.34928825295, 130954.0, 136907.0, 116341.0, 116520.0, 117356.0, 119128.40435797766, 120159.0, 11859.229150105215, 11942.820857686967, 11971.700707482383, 12085.15403921717, 12304.75390492203, 52413.0, 52504.0, 53268.09747551179, 54388.18417723817, 54550.727246363516, 69954.30045699478, 70755.0, 71035.0, 71044.0, 71757.48848790268, 17183.914080429517, 18033.278668853098, 18123.637527249117, 18154.90922545379, 18159.636807263516, 18741.0, 19071.0, 19152.329668461538, 19254.133563989373, 19376.031198440305, 17496.387626433014, 17583.736243956097, 17591.384301549384, 17680.734788978432, 17693.469195924143, 17056.232469539147, 17347.479575612753, 17465.12674366302, 17486.47540573785, 17523.123843807505, 17655.911720441316, 17729.202185901406, 17819.376321828673, 17848.732269015716, 18128.72806907924, 13298.667533311746, 13555.79666305026, 13701.0, 13763.931180344034, 13832.37754301079, 13349.332533373487, 13474.393652285868, 13610.59168224955, 13697.520586779416, 13720.588382348546], "value": 9973.568311363457, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1373.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 106.0, 106.0, 107.0, 107.0, 109.0, 107.0, 107.0, 107.0, 105.0], "value": 106.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 113.0, 115.0, 114.0, 112.0, 142.0, 118.0, 114.0, 112.0], "value": 117.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 161.0, 162.0, 161.0, 162.0, 162.0, 166.0, 166.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 73.0, 73.0, 74.0, 73.0, 74.0, 73.0, 76.0], "value": 73.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 80.0, 78.0, 77.0, 78.0, 79.0, 79.0, 79.0, 78.0], "value": 78.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 113.0, 112.0, 114.0, 114.0, 114.0, 111.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 149.0, 149.0, 150.0, 151.0, 151.0, 150.0, 151.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 94.0, 94.0, 94.0, 93.0, 95.0, 95.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 44.0, 47.0, 42.0, 49.0, 43.0, 45.0, 45.0, 44.0, 43.0], "value": 44.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 37.0, 37.0, 38.0, 38.0, 38.0, 38.0, 37.0, 38.0, 38.0], "value": 37.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 70.0, 70.0, 70.0, 72.0, 71.0, 71.0, 73.0, 70.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 113.0, 104.0, 106.0, 119.0, 116.0, 114.0, 103.0, 105.0], "value": 109.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 161.0, 150.0, 151.0, 149.0, 154.0, 149.0, 151.0, 150.0, 151.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 59.0, 60.0, 60.0, 59.0, 61.0, 61.0, 61.0, 63.0], "value": 60.4, "unit": "score"}]}]} 12:02:22 INFO - Return code: 0 12:02:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:02:22 INFO - # TBPL SUCCESS # 12:02:22 INFO - Running post-action listener: _package_coverage_data 12:02:22 INFO - Running post-action listener: _resource_record_post_action 12:02:22 INFO - [mozharness: 2017-09-27 19:02:22.995451Z] Finished run-tests step (success) 12:02:22 INFO - Running post-run listener: _resource_record_post_run 12:02:23 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 319594496; Read time: 12; Write time: 173764 12:02:23 INFO - TinderboxPrint: CPU usage
13.1% 12:02:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 12:02:23 INFO - TinderboxPrint: I/O write bytes / time
319,594,496 / 173,764 12:02:23 INFO - TinderboxPrint: CPU idle
8,211.5 (86.9%) 12:02:23 INFO - TinderboxPrint: CPU user
1,187.5 (12.6%) 12:02:23 INFO - TinderboxPrint: Swap in / out
0 / 0 12:02:23 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 11714560; Read time: 0; Write time: 2788 12:02:23 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:02:23 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 4096; Write bytes: 307879936; Read time: 12; Write time: 170976 12:02:23 INFO - Running post-run listener: _upload_blobber_files 12:02:23 INFO - Blob upload gear active. 12:02:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:02:23 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 12:02:23 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'] 12:02:23 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 12:02:24 INFO - (blobuploader) - INFO - Open directory for files ... 12:02:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:02:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:02:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:02:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:02:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:02:25 INFO - (blobuploader) - INFO - Done attempting. 12:02:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:02:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:02:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:02:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:02:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:02:32 INFO - (blobuploader) - INFO - Done attempting. 12:02:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:02:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:02:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:02:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:02:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:02:33 INFO - (blobuploader) - INFO - Done attempting. 12:02:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:02:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:02:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:02:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:02:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:02:34 INFO - (blobuploader) - INFO - Done attempting. 12:02:34 INFO - (blobuploader) - INFO - Iteration through files over. 12:02:34 INFO - Return code: 0 12:02:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:02:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:02:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1b8dd89a1fc1256719abec43464d02695fa792049e773a8e6dd10508d89dd1118cdfb4ec58d2c4dc0fbf3d8d20d3e9fbc16e97b3548b5adc0e1c0bfd229291b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5655b33f7ae5d8ba1135515d41b08189a9884830c5a5f9391fe3136f0499905294950f026e012c6fc3fe65d1a35fa39d02fe00d8879145e5756000f574e3a6b1", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e1daddf2e5d36399d88fca3529fe28e45e2a82618b96d74f2f30ebb934dce4688e6ec094d796fa3c7f6627cc3bcbc70431e31461f0f92a361e0cb5c4fe7de37", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bff248f52c5cc6c2ca0b3fc49f99bb7093eae8505a30606cea9b445842425edadca94554dda0bc1f09f73ab605da0d25850a03b7d98992a02f84b4d2a5b08da"} 12:02:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:02:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:02:34 INFO - Contents: 12:02:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1b8dd89a1fc1256719abec43464d02695fa792049e773a8e6dd10508d89dd1118cdfb4ec58d2c4dc0fbf3d8d20d3e9fbc16e97b3548b5adc0e1c0bfd229291b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5655b33f7ae5d8ba1135515d41b08189a9884830c5a5f9391fe3136f0499905294950f026e012c6fc3fe65d1a35fa39d02fe00d8879145e5756000f574e3a6b1", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e1daddf2e5d36399d88fca3529fe28e45e2a82618b96d74f2f30ebb934dce4688e6ec094d796fa3c7f6627cc3bcbc70431e31461f0f92a361e0cb5c4fe7de37", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bff248f52c5cc6c2ca0b3fc49f99bb7093eae8505a30606cea9b445842425edadca94554dda0bc1f09f73ab605da0d25850a03b7d98992a02f84b4d2a5b08da"} 12:02:34 INFO - Running post-run listener: copy_logs_to_upload_dir 12:02:34 INFO - Copying logs to upload dir... 12:02:34 INFO - mkdir: /builds/slave/test/build/upload/logs 12:02:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.034229 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-27 12:02:34.361756) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 12:02:34.364885) ========= 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=3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530 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/e1b8dd89a1fc1256719abec43464d02695fa792049e773a8e6dd10508d89dd1118cdfb4ec58d2c4dc0fbf3d8d20d3e9fbc16e97b3548b5adc0e1c0bfd229291b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5655b33f7ae5d8ba1135515d41b08189a9884830c5a5f9391fe3136f0499905294950f026e012c6fc3fe65d1a35fa39d02fe00d8879145e5756000f574e3a6b1", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e1daddf2e5d36399d88fca3529fe28e45e2a82618b96d74f2f30ebb934dce4688e6ec094d796fa3c7f6627cc3bcbc70431e31461f0f92a361e0cb5c4fe7de37", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bff248f52c5cc6c2ca0b3fc49f99bb7093eae8505a30606cea9b445842425edadca94554dda0bc1f09f73ab605da0d25850a03b7d98992a02f84b4d2a5b08da"} build_url:https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011338 build_url: 'https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1b8dd89a1fc1256719abec43464d02695fa792049e773a8e6dd10508d89dd1118cdfb4ec58d2c4dc0fbf3d8d20d3e9fbc16e97b3548b5adc0e1c0bfd229291b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5655b33f7ae5d8ba1135515d41b08189a9884830c5a5f9391fe3136f0499905294950f026e012c6fc3fe65d1a35fa39d02fe00d8879145e5756000f574e3a6b1", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e1daddf2e5d36399d88fca3529fe28e45e2a82618b96d74f2f30ebb934dce4688e6ec094d796fa3c7f6627cc3bcbc70431e31461f0f92a361e0cb5c4fe7de37", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bff248f52c5cc6c2ca0b3fc49f99bb7093eae8505a30606cea9b445842425edadca94554dda0bc1f09f73ab605da0d25850a03b7d98992a02f84b4d2a5b08da"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 12:02:34.392205) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 12:02:34.392540) ========= 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=3a3620fb28aea1604ab609ef000001d2-1506536904.785280-804178530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004609 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 12:02:34.442953) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 12:02:34.443308) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 12:02:34.443696) ========= ========= Total master_lag: 0.28 =========