builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-057 starttime: 1508941522.49 results: success (0) revision: 39a3a1dd8c6b87d09b9d4f8959eeb8e905d529a2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-25 07:25:22.487639) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-25 07:25:22.488347) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-25 07:25:22.488825) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-25 07:25:22.569151) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-25 07:25:22.569456) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-25 07:25:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2017-10-25 07:25:22 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.190674 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-25 07:25:22.779869) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-25 07:25:22.780143) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016935 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-25 07:25:22.829961) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-25 07:25:22.830307) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 39a3a1dd8c6b87d09b9d4f8959eeb8e905d529a2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 39a3a1dd8c6b87d09b9d4f8959eeb8e905d529a2 --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=934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-25 07:25:22,884 truncating revision to first 12 chars 2017-10-25 07:25:22,884 Setting DEBUG logging. 2017-10-25 07:25:22,884 attempt 1/10 2017-10-25 07:25:22,884 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/39a3a1dd8c6b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-25 07:25:23,289 unpacking tar archive at: mozilla-beta-39a3a1dd8c6b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.017121 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-25 07:25:23.862805) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-25 07:25:23.863120) ========= script_repo_revision: 39a3a1dd8c6b87d09b9d4f8959eeb8e905d529a2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-25 07:25:23.863516) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-25 07:25:23.863777) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-25 07:25:23.878818) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-10-25 07:25:23.879182) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 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', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] 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=934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:25:24 INFO - MultiFileLogger online at 20171025 07:25:24 in /builds/slave/test 07:25:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 07:25:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:25:24 INFO - {'append_to_log': False, 07:25:24 INFO - 'base_work_dir': '/builds/slave/test', 07:25:24 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 07:25:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:25:24 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 07:25:24 INFO - 'buildbot_json_path': 'buildprops.json', 07:25:24 INFO - 'code_coverage': False, 07:25:24 INFO - 'config_files': ('talos/linux_config.py',), 07:25:24 INFO - 'default_actions': ('clobber', 07:25:24 INFO - 'read-buildbot-config', 07:25:24 INFO - 'download-and-extract', 07:25:24 INFO - 'populate-webroot', 07:25:24 INFO - 'create-virtualenv', 07:25:24 INFO - 'install', 07:25:24 INFO - 'setup-mitmproxy', 07:25:24 INFO - 'run-tests'), 07:25:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:25:24 INFO - 'disable_ccov_upload': False, 07:25:24 INFO - 'disable_stylo': False, 07:25:24 INFO - 'download_minidump_stackwalk': True, 07:25:24 INFO - 'download_symbols': 'ondemand', 07:25:24 INFO - 'enable_stylo': False, 07:25:24 INFO - 'enable_webrender': False, 07:25:24 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 07:25:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:25:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:25:24 INFO - 'gecko_profile': False, 07:25:24 INFO - 'gecko_profile_interval': 0, 07:25:24 INFO - 'installer_path': 'installer.exe', 07:25:24 INFO - 'log_level': 'info', 07:25:24 INFO - 'log_name': 'talos', 07:25:24 INFO - 'log_to_console': True, 07:25:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:25:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:25:24 INFO - 'opt_config_files': (), 07:25:24 INFO - 'pip_index': False, 07:25:24 INFO - 'suite': 'dromaeojs-e10s', 07:25:24 INFO - 'system_bits': '32', 07:25:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:25:24 INFO - 'title': 'talos-linux64-ix-057', 07:25:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:25:24 INFO - 'use_talos_json': True, 07:25:24 INFO - 'verify': 'False', 07:25:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:25:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:25:24 INFO - 'work_dir': 'build'} 07:25:24 INFO - [mozharness: 2017-10-25 14:25:24.076818Z] Running clobber step. 07:25:24 INFO - Running pre-action listener: _resource_record_pre_action 07:25:24 INFO - Running main action method: clobber 07:25:24 INFO - rmtree: /builds/slave/test/build 07:25:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:25:25 INFO - Running post-action listener: _resource_record_post_action 07:25:25 INFO - [mozharness: 2017-10-25 14:25:25.158564Z] Finished clobber step (success) 07:25:25 INFO - [mozharness: 2017-10-25 14:25:25.158661Z] Running read-buildbot-config step. 07:25:25 INFO - Running pre-action listener: _resource_record_pre_action 07:25:25 INFO - Running main action method: read_buildbot_config 07:25:25 INFO - Using buildbot properties: 07:25:25 INFO - { 07:25:25 INFO - "project": "", 07:25:25 INFO - "product": "firefox", 07:25:25 INFO - "who": "ryanvm@gmail.com", 07:25:25 INFO - "installer_path": "public/build/target.tar.bz2", 07:25:25 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 07:25:25 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 07:25:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 07:25:25 INFO - "stage_platform": "linux64", 07:25:25 INFO - "basedir": "/builds/slave/test", 07:25:25 INFO - "buildnumber": 151, 07:25:25 INFO - "platform": "ubuntu64_hw", 07:25:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:25:25 INFO - "slavebuilddir": "test", 07:25:25 INFO - "taskId": "Ml1zapQUQzGqSvQF8YBfrA", 07:25:25 INFO - "branch": "mozilla-beta", 07:25:25 INFO - "script_repo_revision": "production", 07:25:25 INFO - "revision": "39a3a1dd8c6b87d09b9d4f8959eeb8e905d529a2", 07:25:25 INFO - "slavename": "talos-linux64-ix-057", 07:25:25 INFO - "repo_path": "releases/mozilla-beta" 07:25:25 INFO - } 07:25:25 INFO - Finding installer, test and symbols from parent task. 07:25:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ml1zapQUQzGqSvQF8YBfrA'}, attempt #1 07:25:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ml1zapQUQzGqSvQF8YBfrA'}, attempt #1 07:25:26 INFO - Task dependencies: GlCZVHavR8uTNolfr7_UzA 07:25:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GlCZVHavR8uTNolfr7_UzA'}, attempt #1 07:25:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GlCZVHavR8uTNolfr7_UzA/artifacts/public/build/target.tar.bz2 07:25:26 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/GlCZVHavR8uTNolfr7_UzA/artifacts/public/build/target.test_packages.json 07:25:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GlCZVHavR8uTNolfr7_UzA/artifacts/public/build/target.crashreporter-symbols.zip 07:25:26 INFO - Running post-action listener: _resource_record_post_action 07:25:26 INFO - [mozharness: 2017-10-25 14:25:26.519815Z] Finished read-buildbot-config step (success) 07:25:26 INFO - [mozharness: 2017-10-25 14:25:26.520033Z] Running download-and-extract step. 07:25:26 INFO - Running pre-action listener: _resource_record_pre_action 07:25:26 INFO - Running main action method: download_and_extract 07:25:26 INFO - mkdir: /builds/slave/test/build/tests 07:25:26 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')]} 07:25:26 INFO - trying https://queue.taskcluster.net/v1/task/GlCZVHavR8uTNolfr7_UzA/artifacts/public/build/target.test_packages.json 07:25:26 INFO - Downloading https://queue.taskcluster.net/v1/task/GlCZVHavR8uTNolfr7_UzA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:25:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GlCZVHavR8uTNolfr7_UzA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:25:27 INFO - Downloaded 989 bytes. 07:25:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:25:27 INFO - Using the following test package requirements: 07:25:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:25:27 INFO - u'common': [u'target.common.tests.zip'], 07:25:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:25:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:25:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:25:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:25:27 INFO - u'mozbase': [u'target.common.tests.zip'], 07:25:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:25:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:25:27 INFO - u'web-platform': [u'target.common.tests.zip', 07:25:27 INFO - u'target.web-platform.tests.tar.gz'], 07:25:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:25:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 07:25:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GlCZVHavR8uTNolfr7_UzA/artifacts/public/build/target.common.tests.zip 07:25:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GlCZVHavR8uTNolfr7_UzA/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:25:27 INFO - Fetch https://queue.taskcluster.net/v1/task/GlCZVHavR8uTNolfr7_UzA/artifacts/public/build/target.common.tests.zip into memory 07:25:29 INFO - Content-Length response header: 55178407 07:25:29 INFO - Bytes received: 55178407 07:25:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GlCZVHavR8uTNolfr7_UzA/artifacts/public/build/target.talos.tests.zip 07:25:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GlCZVHavR8uTNolfr7_UzA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:25:40 INFO - Fetch https://queue.taskcluster.net/v1/task/GlCZVHavR8uTNolfr7_UzA/artifacts/public/build/target.talos.tests.zip into memory 07:25:41 INFO - Content-Length response header: 14509096 07:25:41 INFO - Bytes received: 14509096 07:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:42 INFO - trying https://queue.taskcluster.net/v1/task/GlCZVHavR8uTNolfr7_UzA/artifacts/public/build/target.tar.bz2 07:25:42 INFO - Downloading https://queue.taskcluster.net/v1/task/GlCZVHavR8uTNolfr7_UzA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:25:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GlCZVHavR8uTNolfr7_UzA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:25:44 INFO - Downloaded 53573600 bytes. 07:25:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GlCZVHavR8uTNolfr7_UzA/artifacts/public/build/target.tar.bz2 07:25:44 INFO - mkdir: /builds/slave/test/properties 07:25:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:25:44 INFO - Writing to file /builds/slave/test/properties/build_url 07:25:44 INFO - Contents: 07:25:44 INFO - build_url:https://queue.taskcluster.net/v1/task/GlCZVHavR8uTNolfr7_UzA/artifacts/public/build/target.tar.bz2 07:25:44 INFO - Running post-action listener: _resource_record_post_action 07:25:44 INFO - Running post-action listener: find_tests_for_verification 07:25:44 INFO - Running post-action listener: set_extra_try_arguments 07:25:44 INFO - [mozharness: 2017-10-25 14:25:44.691668Z] Finished download-and-extract step (success) 07:25:44 INFO - [mozharness: 2017-10-25 14:25:44.691766Z] Running populate-webroot step. 07:25:44 INFO - Running pre-action listener: _resource_record_pre_action 07:25:44 INFO - Running main action method: populate_webroot 07:25:44 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:25:44 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:25:44 INFO - 'tests': ['tresize', 07:25:44 INFO - 'tcanvasmark']}, 07:25:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:25:44 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:25:44 INFO - 'tests': ['dromaeo_css', 07:25:44 INFO - 'kraken']}, 07:25:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:25:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:25:44 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:25:44 INFO - 'talos_options': ['--disable-stylo'], 07:25:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:25:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:25:44 INFO - 'tests': ['damp', 'tps']}, 07:25:44 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:25:44 INFO - 'talos_options': ['--disable-stylo'], 07:25:44 INFO - 'tests': ['damp', 'tps']}, 07:25:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:25:44 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:25:44 INFO - 'tests': ['dromaeo_dom']}, 07:25:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:25:44 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:25:44 INFO - 'tests': ['basic_compositor_video', 07:25:44 INFO - 'glvideo']}, 07:25:44 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:25:44 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:25:44 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:25:44 INFO - 'talos_options': ['--disable-stylo'], 07:25:44 INFO - 'tests': ['ts_paint_webext', 07:25:44 INFO - 'tp5o_webext']}, 07:25:44 INFO - 'other-e10s': {'tests': ['a11yr', 07:25:44 INFO - 'ts_paint', 07:25:44 INFO - 'tpaint', 07:25:44 INFO - 'sessionrestore', 07:25:44 INFO - 'sessionrestore_many_windows', 07:25:44 INFO - 'sessionrestore_no_auto_restore', 07:25:44 INFO - 'tabpaint']}, 07:25:44 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:25:44 INFO - 'tests': ['a11yr', 07:25:44 INFO - 'ts_paint', 07:25:44 INFO - 'tpaint', 07:25:44 INFO - 'sessionrestore', 07:25:44 INFO - 'sessionrestore_many_windows', 07:25:44 INFO - 'sessionrestore_no_auto_restore', 07:25:44 INFO - 'tabpaint']}, 07:25:44 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 07:25:44 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 07:25:44 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:25:44 INFO - 'tests': ['perf_reftest_singletons']}, 07:25:44 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:25:44 INFO - 'tests': ['bloom_basic']}, 07:25:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:25:44 INFO - 'tsvgr_opacity', 07:25:44 INFO - 'tart', 07:25:44 INFO - 'tscrollx', 07:25:44 INFO - 'tsvg_static']}, 07:25:44 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:25:44 INFO - 'tests': ['tsvgx', 07:25:44 INFO - 'tsvgr_opacity', 07:25:44 INFO - 'tart', 07:25:44 INFO - 'tscrollx', 07:25:44 INFO - 'tsvg_static']}, 07:25:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:25:44 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:25:44 INFO - 'talos_options': ['--disable-stylo'], 07:25:44 INFO - 'tests': ['tp5o']}, 07:25:44 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:25:44 INFO - 'talos_options': ['--mitmproxy', 07:25:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:25:44 INFO - '--firstNonBlankPaint'], 07:25:44 INFO - 'tests': ['tp6_google', 07:25:44 INFO - 'tp6_youtube', 07:25:44 INFO - 'tp6_amazon', 07:25:44 INFO - 'tp6_facebook']}, 07:25:44 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:25:44 INFO - 'talos_options': ['--disable-stylo', 07:25:44 INFO - '--mitmproxy', 07:25:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:25:44 INFO - '--firstNonBlankPaint'], 07:25:44 INFO - 'tests': ['tp6_google', 07:25:44 INFO - 'tp6_youtube', 07:25:44 INFO - 'tp6_amazon', 07:25:44 INFO - 'tp6_facebook']}, 07:25:44 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:25:44 INFO - 'talos_options': ['--stylo-threads=1', 07:25:44 INFO - '--mitmproxy', 07:25:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:25:44 INFO - '--firstNonBlankPaint'], 07:25:44 INFO - 'tests': ['tp6_google', 07:25:44 INFO - 'tp6_youtube', 07:25:44 INFO - 'tp6_amazon', 07:25:44 INFO - 'tp6_facebook']}, 07:25:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:25:44 INFO - 'talos_options': ['--xperf_path', 07:25:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:25:44 INFO - 'tests': ['tp5n']}, 07:25:44 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:25:44 INFO - 'talos_options': ['--disable-stylo', 07:25:44 INFO - '--xperf_path', 07:25:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:25:44 INFO - 'tests': ['tp5n']}}} 07:25:44 INFO - Running post-action listener: _resource_record_post_action 07:25:44 INFO - [mozharness: 2017-10-25 14:25:44.706804Z] Finished populate-webroot step (success) 07:25:44 INFO - [mozharness: 2017-10-25 14:25:44.706894Z] Running create-virtualenv step. 07:25:44 INFO - Running pre-action listener: _resource_record_pre_action 07:25:44 INFO - Running main action method: create_virtualenv 07:25:44 INFO - Creating virtualenv /builds/slave/test/build/venv 07:25:44 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:25:44 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 07:25:44 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:25:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:25:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:25:45 INFO - Installing distribute.............................................................................................................................................................................................done. 07:25:45 INFO - Installing pip...............done. 07:25:45 INFO - Return code: 0 07:25:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:25:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:25:45 INFO - Reading from file tmpfile_stdout 07:25:45 INFO - Output received: 07:25:45 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 07:25:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:25:45 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')]} 07:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:45 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')]} 07:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:45 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 0x25e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27afa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2952a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2956090>, '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 0x2956d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2950f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720', '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 07:25:45 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 07:25:45 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 07:25:45 INFO - Using env: {'DISPLAY': ':0', 07:25:45 INFO - 'HOME': '/home/cltbld', 07:25:45 INFO - 'LANG': 'en_US.UTF-8', 07:25:45 INFO - 'LANGUAGE': 'en_US:en', 07:25:45 INFO - 'LOGNAME': 'cltbld', 07:25:45 INFO - 'MAIL': '/var/mail/cltbld', 07:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:45 INFO - 'MOZ_NO_REMOTE': '1', 07:25:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:45 INFO - 'NO_EM_RESTART': '1', 07:25:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:45 INFO - 'PWD': '/builds/slave/test', 07:25:45 INFO - 'SHELL': '/bin/bash', 07:25:45 INFO - 'SHLVL': '1', 07:25:45 INFO - 'TERM': 'linux', 07:25:45 INFO - 'TMOUT': '86400', 07:25:45 INFO - 'USER': 'cltbld', 07:25:45 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720', 07:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:45 INFO - '_': '/tools/buildbot/bin/python'} 07:25:47 INFO - Ignoring indexes: http://pypi.python.org/simple/ 07:25:47 INFO - Downloading/unpacking pip>=1.5 07:25:47 INFO - Running setup.py egg_info for package pip 07:25:47 INFO - warning: no files found matching 'pip/cacert.pem' 07:25:47 INFO - warning: no files found matching '*.html' under directory 'docs' 07:25:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:25:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:25:47 INFO - Installing collected packages: pip 07:25:47 INFO - Found existing installation: pip 1.1 07:25:47 INFO - Uninstalling pip: 07:25:47 INFO - Successfully uninstalled pip 07:25:47 INFO - Running setup.py install for pip 07:25:47 INFO - warning: no files found matching 'pip/cacert.pem' 07:25:47 INFO - warning: no files found matching '*.html' under directory 'docs' 07:25:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:25:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:25:47 INFO - Installing pip script to /builds/slave/test/build/venv/bin 07:25:47 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 07:25:47 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 07:25:47 INFO - Successfully installed pip 07:25:47 INFO - Cleaning up... 07:25:47 INFO - Return code: 0 07:25:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:25:47 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')]} 07:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:47 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')]} 07:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:47 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 0x25e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27afa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2952a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2956090>, '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 0x2956d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2950f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720', '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 07:25:47 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 07:25:47 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 07:25:47 INFO - Using env: {'DISPLAY': ':0', 07:25:47 INFO - 'HOME': '/home/cltbld', 07:25:47 INFO - 'LANG': 'en_US.UTF-8', 07:25:47 INFO - 'LANGUAGE': 'en_US:en', 07:25:47 INFO - 'LOGNAME': 'cltbld', 07:25:47 INFO - 'MAIL': '/var/mail/cltbld', 07:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:47 INFO - 'MOZ_NO_REMOTE': '1', 07:25:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:47 INFO - 'NO_EM_RESTART': '1', 07:25:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:47 INFO - 'PWD': '/builds/slave/test', 07:25:47 INFO - 'SHELL': '/bin/bash', 07:25:47 INFO - 'SHLVL': '1', 07:25:47 INFO - 'TERM': 'linux', 07:25:47 INFO - 'TMOUT': '86400', 07:25:47 INFO - 'USER': 'cltbld', 07:25:47 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720', 07:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:47 INFO - '_': '/tools/buildbot/bin/python'} 07:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:47 INFO - Downloading/unpacking psutil>=3.1.1 07:25:47 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 07:25:47 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 07:25:47 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 07:25:47 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 07:25:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:25:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:25:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:25:48 INFO - Installing collected packages: psutil 07:25:48 INFO - Running setup.py install for psutil 07:25:48 INFO - building 'psutil._psutil_linux' extension 07:25:48 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 07:25:49 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 07:25:49 INFO - building 'psutil._psutil_posix' extension 07:25:49 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 07:25:49 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 07:25:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:25:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:25:50 INFO - Successfully installed psutil 07:25:50 INFO - Cleaning up... 07:25:50 INFO - Return code: 0 07:25:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:25:50 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')]} 07:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:50 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')]} 07:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:50 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 0x25e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27afa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2952a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2956090>, '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 0x2956d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2950f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720', '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 07:25:50 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 07:25:50 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 07:25:50 INFO - Using env: {'DISPLAY': ':0', 07:25:50 INFO - 'HOME': '/home/cltbld', 07:25:50 INFO - 'LANG': 'en_US.UTF-8', 07:25:50 INFO - 'LANGUAGE': 'en_US:en', 07:25:50 INFO - 'LOGNAME': 'cltbld', 07:25:50 INFO - 'MAIL': '/var/mail/cltbld', 07:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:50 INFO - 'MOZ_NO_REMOTE': '1', 07:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:50 INFO - 'NO_EM_RESTART': '1', 07:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:50 INFO - 'PWD': '/builds/slave/test', 07:25:50 INFO - 'SHELL': '/bin/bash', 07:25:50 INFO - 'SHLVL': '1', 07:25:50 INFO - 'TERM': 'linux', 07:25:50 INFO - 'TMOUT': '86400', 07:25:50 INFO - 'USER': 'cltbld', 07:25:50 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720', 07:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:50 INFO - '_': '/tools/buildbot/bin/python'} 07:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:25:50 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 07:25:50 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 07:25:50 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 07:25:50 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 07:25:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:25:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:25:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:25:51 INFO - Installing collected packages: mozsystemmonitor 07:25:51 INFO - Running setup.py install for mozsystemmonitor 07:25:51 INFO - Successfully installed mozsystemmonitor 07:25:51 INFO - Cleaning up... 07:25:52 INFO - Return code: 0 07:25:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:25:52 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')]} 07:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:52 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')]} 07:25:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:52 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 0x25e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27afa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2952a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2956090>, '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 0x2956d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2950f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720', '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 07:25:52 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 07:25:52 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 07:25:52 INFO - Using env: {'DISPLAY': ':0', 07:25:52 INFO - 'HOME': '/home/cltbld', 07:25:52 INFO - 'LANG': 'en_US.UTF-8', 07:25:52 INFO - 'LANGUAGE': 'en_US:en', 07:25:52 INFO - 'LOGNAME': 'cltbld', 07:25:52 INFO - 'MAIL': '/var/mail/cltbld', 07:25:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:52 INFO - 'MOZ_NO_REMOTE': '1', 07:25:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:52 INFO - 'NO_EM_RESTART': '1', 07:25:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:52 INFO - 'PWD': '/builds/slave/test', 07:25:52 INFO - 'SHELL': '/bin/bash', 07:25:52 INFO - 'SHLVL': '1', 07:25:52 INFO - 'TERM': 'linux', 07:25:52 INFO - 'TMOUT': '86400', 07:25:52 INFO - 'USER': 'cltbld', 07:25:52 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720', 07:25:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:52 INFO - '_': '/tools/buildbot/bin/python'} 07:25:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:52 INFO - Downloading/unpacking jsonschema==2.5.1 07:25:52 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 07:25:52 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 07:25:52 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 07:25:52 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 07:25:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:25:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:25:54 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 07:25:54 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 07:25:54 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 07:25:54 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 07:25:54 INFO - Downloading functools32-3.2.3-2.tar.gz 07:25:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:25:54 INFO - warning: no files found matching '*.txt' 07:25:54 INFO - no previously-included directories found matching 'build' 07:25:54 INFO - no previously-included directories found matching 'dist' 07:25:54 INFO - no previously-included directories found matching '.git*' 07:25:54 INFO - Installing collected packages: jsonschema, functools32 07:25:54 INFO - Running setup.py install for functools32 07:25:54 INFO - warning: no files found matching '*.txt' 07:25:54 INFO - no previously-included directories found matching 'build' 07:25:54 INFO - no previously-included directories found matching 'dist' 07:25:54 INFO - no previously-included directories found matching '.git*' 07:25:54 INFO - Successfully installed jsonschema functools32 07:25:54 INFO - Cleaning up... 07:25:54 INFO - Return code: 0 07:25:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:25: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')]} 07:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25: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')]} 07:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:54 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 0x25e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27afa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2952a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2956090>, '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 0x2956d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2950f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720', '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 07:25:54 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 07:25:54 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 07:25:54 INFO - Using env: {'DISPLAY': ':0', 07:25:54 INFO - 'HOME': '/home/cltbld', 07:25:54 INFO - 'LANG': 'en_US.UTF-8', 07:25:54 INFO - 'LANGUAGE': 'en_US:en', 07:25:54 INFO - 'LOGNAME': 'cltbld', 07:25:54 INFO - 'MAIL': '/var/mail/cltbld', 07:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:54 INFO - 'MOZ_NO_REMOTE': '1', 07:25:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:54 INFO - 'NO_EM_RESTART': '1', 07:25:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:54 INFO - 'PWD': '/builds/slave/test', 07:25:54 INFO - 'SHELL': '/bin/bash', 07:25:54 INFO - 'SHLVL': '1', 07:25:54 INFO - 'TERM': 'linux', 07:25:54 INFO - 'TMOUT': '86400', 07:25:54 INFO - 'USER': 'cltbld', 07:25:54 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720', 07:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:54 INFO - '_': '/tools/buildbot/bin/python'} 07:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:25:54 INFO - Cleaning up... 07:25:54 INFO - Return code: 0 07:25:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:25: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')]} 07:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25: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')]} 07:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:54 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 0x25e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27afa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2952a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2956090>, '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 0x2956d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2950f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720', '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 07:25:54 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 07:25:54 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 07:25:54 INFO - Using env: {'DISPLAY': ':0', 07:25:54 INFO - 'HOME': '/home/cltbld', 07:25:54 INFO - 'LANG': 'en_US.UTF-8', 07:25:54 INFO - 'LANGUAGE': 'en_US:en', 07:25:54 INFO - 'LOGNAME': 'cltbld', 07:25:54 INFO - 'MAIL': '/var/mail/cltbld', 07:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:54 INFO - 'MOZ_NO_REMOTE': '1', 07:25:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:54 INFO - 'NO_EM_RESTART': '1', 07:25:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:54 INFO - 'PWD': '/builds/slave/test', 07:25:54 INFO - 'SHELL': '/bin/bash', 07:25:54 INFO - 'SHLVL': '1', 07:25:54 INFO - 'TERM': 'linux', 07:25:54 INFO - 'TMOUT': '86400', 07:25:54 INFO - 'USER': 'cltbld', 07:25:54 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720', 07:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:54 INFO - '_': '/tools/buildbot/bin/python'} 07:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:54 INFO - Downloading/unpacking blobuploader==1.2.4 07:25:54 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 07:25:54 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 07:25:54 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 07:25:54 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 07:25:55 INFO - Downloading blobuploader-1.2.4.tar.gz 07:25:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:25:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:25:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:56 INFO - Downloading docopt-0.6.1.tar.gz 07:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:25:56 INFO - Installing collected packages: blobuploader, requests, docopt 07:25:56 INFO - Running setup.py install for blobuploader 07:25:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:25:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:25:56 INFO - Running setup.py install for requests 07:25:57 INFO - Running setup.py install for docopt 07:25:57 INFO - Successfully installed blobuploader requests docopt 07:25:57 INFO - Cleaning up... 07:25:57 INFO - Return code: 0 07:25:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:57 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')]} 07:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:57 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')]} 07:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:57 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 0x25e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27afa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2952a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2956090>, '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 0x2956d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2950f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720', '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 07:25:57 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 07:25:57 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 07:25:57 INFO - Using env: {'DISPLAY': ':0', 07:25:57 INFO - 'HOME': '/home/cltbld', 07:25:57 INFO - 'LANG': 'en_US.UTF-8', 07:25:57 INFO - 'LANGUAGE': 'en_US:en', 07:25:57 INFO - 'LOGNAME': 'cltbld', 07:25:57 INFO - 'MAIL': '/var/mail/cltbld', 07:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:57 INFO - 'MOZ_NO_REMOTE': '1', 07:25:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:57 INFO - 'NO_EM_RESTART': '1', 07:25:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:57 INFO - 'PWD': '/builds/slave/test', 07:25:57 INFO - 'SHELL': '/bin/bash', 07:25:57 INFO - 'SHLVL': '1', 07:25:57 INFO - 'TERM': 'linux', 07:25:57 INFO - 'TMOUT': '86400', 07:25:57 INFO - 'USER': 'cltbld', 07:25:57 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720', 07:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:57 INFO - '_': '/tools/buildbot/bin/python'} 07:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:25:57 INFO - Running setup.py (path:/tmp/pip-Oqz2z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:25:57 INFO - Running setup.py (path:/tmp/pip-pnCriH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:25:57 INFO - Running setup.py (path:/tmp/pip-bYDmxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:25:57 INFO - Running setup.py (path:/tmp/pip-AlctY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:25:57 INFO - Running setup.py (path:/tmp/pip-glyHy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:25:57 INFO - Running setup.py (path:/tmp/pip-Q7wfbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:25:57 INFO - Running setup.py (path:/tmp/pip-jcMfVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:25:57 INFO - Running setup.py (path:/tmp/pip-37jMqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:25:57 INFO - Running setup.py (path:/tmp/pip-xuOsk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:25:58 INFO - Running setup.py (path:/tmp/pip-FThsMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:25:58 INFO - Running setup.py (path:/tmp/pip-PCKOVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:25:58 INFO - Running setup.py (path:/tmp/pip-NFkXyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:25:58 INFO - Running setup.py (path:/tmp/pip-N9j_Kr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:25:58 INFO - Running setup.py (path:/tmp/pip-iyWWex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:58 INFO - Running setup.py (path:/tmp/pip-HiAtqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:25:58 INFO - Running setup.py (path:/tmp/pip-enGMVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:25:58 INFO - Running setup.py (path:/tmp/pip-qelDam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:25:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:25:58 INFO - Running setup.py install for manifestparser 07:25:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:25:58 INFO - Running setup.py install for mozcrash 07:25:58 INFO - Running setup.py install for mozdebug 07:25:58 INFO - Running setup.py install for mozdevice 07:25:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:25:59 INFO - Running setup.py install for mozfile 07:25:59 INFO - Running setup.py install for mozhttpd 07:25:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:25:59 INFO - Running setup.py install for mozinfo 07:25:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:25:59 INFO - Running setup.py install for mozInstall 07:25:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:25:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:25:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:25:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:25:59 INFO - Running setup.py install for mozleak 07:25:59 INFO - Running setup.py install for mozlog 07:25:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:25:59 INFO - Running setup.py install for moznetwork 07:25:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:25:59 INFO - Running setup.py install for mozprocess 07:25:59 INFO - Running setup.py install for mozprofile 07:25:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:25:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:25:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:25:59 INFO - Running setup.py install for mozrunner 07:26:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:26:00 INFO - Running setup.py install for mozscreenshot 07:26:00 INFO - Running setup.py install for moztest 07:26:00 INFO - Running setup.py install for mozversion 07:26:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:26:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:26:00 INFO - Cleaning up... 07:26:00 INFO - Return code: 0 07:26:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:00 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 0x25e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27afa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2952a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2956090>, '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 0x2956d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2950f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720', '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 07:26:00 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 07:26:00 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 07:26:00 INFO - Using env: {'DISPLAY': ':0', 07:26:00 INFO - 'HOME': '/home/cltbld', 07:26:00 INFO - 'LANG': 'en_US.UTF-8', 07:26:00 INFO - 'LANGUAGE': 'en_US:en', 07:26:00 INFO - 'LOGNAME': 'cltbld', 07:26:00 INFO - 'MAIL': '/var/mail/cltbld', 07:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:00 INFO - 'MOZ_NO_REMOTE': '1', 07:26:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:00 INFO - 'NO_EM_RESTART': '1', 07:26:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:00 INFO - 'PWD': '/builds/slave/test', 07:26:00 INFO - 'SHELL': '/bin/bash', 07:26:00 INFO - 'SHLVL': '1', 07:26:00 INFO - 'TERM': 'linux', 07:26:00 INFO - 'TMOUT': '86400', 07:26:00 INFO - 'USER': 'cltbld', 07:26:00 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720', 07:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:00 INFO - '_': '/tools/buildbot/bin/python'} 07:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:26:00 INFO - Running setup.py (path:/tmp/pip-AchDq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:26:00 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)) 07:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:26:00 INFO - Running setup.py (path:/tmp/pip-3BtVqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:26:00 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)) 07:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:26:00 INFO - Running setup.py (path:/tmp/pip-xkyLxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:26:00 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)) 07:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:26:00 INFO - Running setup.py (path:/tmp/pip-F3Pinm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:26:00 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)) 07:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:26:00 INFO - Running setup.py (path:/tmp/pip-rTL_zt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:26:00 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)) 07:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:26:00 INFO - Running setup.py (path:/tmp/pip-6z1lNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:26:01 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)) 07:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:26:01 INFO - Running setup.py (path:/tmp/pip-4c9uhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:26:01 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)) 07:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:26:01 INFO - Running setup.py (path:/tmp/pip-1KXOOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:26:01 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)) 07:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:26:01 INFO - Running setup.py (path:/tmp/pip-k6lY6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:26:01 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)) 07:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:26:01 INFO - Running setup.py (path:/tmp/pip-UIH8uC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:26:01 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)) 07:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:26:01 INFO - Running setup.py (path:/tmp/pip-Vkg8Z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:26:01 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)) 07:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:26:01 INFO - Running setup.py (path:/tmp/pip-6ADaGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:26:01 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)) 07:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:26:01 INFO - Running setup.py (path:/tmp/pip-3Aiory-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:26:01 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)) 07:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:26:01 INFO - Running setup.py (path:/tmp/pip-Ghrzb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:26:01 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)) 07:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:26:01 INFO - Running setup.py (path:/tmp/pip-QBXiU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:26:01 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)) 07:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:26:01 INFO - Running setup.py (path:/tmp/pip-KTugJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:26:01 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)) 07:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:26:01 INFO - Running setup.py (path:/tmp/pip-amXmgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:26:01 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)) 07:26:01 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)) 07:26:01 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)) 07:26:01 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)) 07:26:01 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)) 07:26:01 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)) 07:26:01 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)) 07:26:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:02 INFO - Downloading blessings-1.6.tar.gz 07:26:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:26:03 INFO - Installing collected packages: blessings 07:26:03 INFO - Running setup.py install for blessings 07:26:03 INFO - Successfully installed blessings 07:26:03 INFO - Cleaning up... 07:26:03 INFO - Return code: 0 07:26:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:26:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:26:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:26:03 INFO - Reading from file tmpfile_stdout 07:26:03 INFO - Current package versions: 07:26:03 INFO - argparse == 1.2.1 07:26:03 INFO - blessings == 1.6 07:26:03 INFO - blobuploader == 1.2.4 07:26:03 INFO - docopt == 0.6.1 07:26:03 INFO - functools32 == 3.2.3-2 07:26:03 INFO - jsonschema == 2.5.1 07:26:03 INFO - manifestparser == 1.1 07:26:03 INFO - mozInstall == 1.13 07:26:03 INFO - mozcrash == 1.0 07:26:03 INFO - mozdebug == 0.1 07:26:03 INFO - mozdevice == 0.51 07:26:03 INFO - mozfile == 1.2 07:26:03 INFO - mozhttpd == 0.7 07:26:03 INFO - mozinfo == 0.10 07:26:03 INFO - mozleak == 0.1 07:26:03 INFO - mozlog == 3.5 07:26:03 INFO - moznetwork == 0.27 07:26:03 INFO - mozprocess == 0.25 07:26:03 INFO - mozprofile == 0.28 07:26:03 INFO - mozrunner == 6.13 07:26:03 INFO - mozscreenshot == 0.1 07:26:03 INFO - mozsystemmonitor == 0.3 07:26:03 INFO - moztest == 0.8 07:26:03 INFO - mozversion == 1.4 07:26:03 INFO - psutil == 3.1.1 07:26:03 INFO - requests == 1.2.3 07:26:03 INFO - wsgiref == 0.1.2 07:26:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:26:03 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')]} 07:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:03 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')]} 07:26:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:03 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 0x25e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27afa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2952a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2956090>, '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 0x2956d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2950f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720', '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 07:26:03 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 07:26:03 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 07:26:03 INFO - Using env: {'DISPLAY': ':0', 07:26:03 INFO - 'HOME': '/home/cltbld', 07:26:03 INFO - 'LANG': 'en_US.UTF-8', 07:26:03 INFO - 'LANGUAGE': 'en_US:en', 07:26:03 INFO - 'LOGNAME': 'cltbld', 07:26:03 INFO - 'MAIL': '/var/mail/cltbld', 07:26:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:03 INFO - 'MOZ_NO_REMOTE': '1', 07:26:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:03 INFO - 'NO_EM_RESTART': '1', 07:26:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:03 INFO - 'PWD': '/builds/slave/test', 07:26:03 INFO - 'SHELL': '/bin/bash', 07:26:03 INFO - 'SHLVL': '1', 07:26:03 INFO - 'TERM': 'linux', 07:26:03 INFO - 'TMOUT': '86400', 07:26:03 INFO - 'USER': 'cltbld', 07:26:03 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720', 07:26:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:03 INFO - '_': '/tools/buildbot/bin/python'} 07:26:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:26:03 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)) 07:26:03 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)) 07:26:03 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)) 07:26:03 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)) 07:26:03 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)) 07:26:03 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)) 07:26:03 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)) 07:26:03 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)) 07:26:03 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)) 07:26:03 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:26:03 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 07:26:03 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 07:26:03 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 07:26:03 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 07:26:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 07:26:04 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)) 07:26:04 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)) 07:26:04 INFO - Installing collected packages: simplejson 07:26:04 INFO - Running setup.py install for simplejson 07:26:04 INFO - building 'simplejson._speedups' extension 07:26:04 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 07:26:05 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 07:26:05 INFO - Successfully installed simplejson 07:26:05 INFO - Cleaning up... 07:26:05 INFO - Return code: 0 07:26:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:26:05 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')]} 07:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:05 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')]} 07:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:05 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 0x25e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27afa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2952a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2956090>, '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 0x2956d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2950f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720', '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 07:26:05 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 07:26:05 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 07:26:05 INFO - Using env: {'DISPLAY': ':0', 07:26:05 INFO - 'HOME': '/home/cltbld', 07:26:05 INFO - 'LANG': 'en_US.UTF-8', 07:26:05 INFO - 'LANGUAGE': 'en_US:en', 07:26:05 INFO - 'LOGNAME': 'cltbld', 07:26:05 INFO - 'MAIL': '/var/mail/cltbld', 07:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:05 INFO - 'MOZ_NO_REMOTE': '1', 07:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:05 INFO - 'NO_EM_RESTART': '1', 07:26:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:05 INFO - 'PWD': '/builds/slave/test', 07:26:05 INFO - 'SHELL': '/bin/bash', 07:26:05 INFO - 'SHLVL': '1', 07:26:05 INFO - 'TERM': 'linux', 07:26:05 INFO - 'TMOUT': '86400', 07:26:05 INFO - 'USER': 'cltbld', 07:26:05 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720', 07:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:05 INFO - '_': '/tools/buildbot/bin/python'} 07:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:26:06 INFO - Cleaning up... 07:26:06 INFO - Return code: 0 07:26:06 INFO - Running post-action listener: _resource_record_post_action 07:26:06 INFO - Running post-action listener: _start_resource_monitoring 07:26:06 INFO - Starting resource monitoring. 07:26:06 INFO - [mozharness: 2017-10-25 14:26:06.103327Z] Finished create-virtualenv step (success) 07:26:06 INFO - [mozharness: 2017-10-25 14:26:06.103803Z] Running install step. 07:26:06 INFO - Running pre-action listener: _resource_record_pre_action 07:26:06 INFO - Running main action method: install 07:26:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:26:06 INFO - Reading from file tmpfile_stdout 07:26:06 INFO - Detecting whether we're running mozinstall >=1.0... 07:26:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:26:06 INFO - Reading from file tmpfile_stdout 07:26:06 INFO - Output received: 07:26:06 INFO - Usage: mozinstall [options] installer 07:26:06 INFO - Options: 07:26:06 INFO - -h, --help show this help message and exit 07:26:06 INFO - -d DEST, --destination=DEST 07:26:06 INFO - Directory to install application into. [default: 07:26:06 INFO - "/builds/slave/test"] 07:26:06 INFO - --app=APP Application being installed. [default: firefox] 07:26:06 INFO - mkdir: /builds/slave/test/build/application 07:26:06 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'] 07:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:26:21 INFO - Reading from file tmpfile_stdout 07:26:21 INFO - Output received: 07:26:21 INFO - /builds/slave/test/build/application/firefox/firefox 07:26:21 INFO - Running post-action listener: _resource_record_post_action 07:26:21 INFO - [mozharness: 2017-10-25 14:26:21.028182Z] Finished install step (success) 07:26:21 INFO - [mozharness: 2017-10-25 14:26:21.028406Z] Running setup-mitmproxy step. 07:26:21 INFO - Running pre-action listener: _resource_record_pre_action 07:26:21 INFO - Running main action method: setup_mitmproxy 07:26:21 INFO - Skipping: mitmproxy is not required 07:26:21 INFO - Running post-action listener: _resource_record_post_action 07:26:21 INFO - [mozharness: 2017-10-25 14:26:21.028939Z] Finished setup-mitmproxy step (success) 07:26:21 INFO - [mozharness: 2017-10-25 14:26:21.029043Z] Running run-tests step. 07:26:21 INFO - Running pre-action listener: _resource_record_pre_action 07:26:21 INFO - Running pre-action listener: _set_gcov_prefix 07:26:21 INFO - Running main action method: run_tests 07:26:21 WARNING - Try message not found. 07:26:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:26:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:26:21 INFO - Python 2.7.3 07:26:21 INFO - Return code: 0 07:26:21 INFO - grabbing minidump binary from tooltool 07:26:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:26:21 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 0x2956090>, '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 0x2956d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2950f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:26:21 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 07:26:21 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 07:26:21 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 07:26:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:26:21 INFO - Return code: 0 07:26:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:26:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:26:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:26:21 INFO - ENV: RUST_BACKTRACE is now full 07:26:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:26:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:26:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GlCZVHavR8uTNolfr7_UzA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 07:26:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GlCZVHavR8uTNolfr7_UzA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 07:26:21 INFO - Using env: {'DISPLAY': ':0', 07:26:21 INFO - 'HOME': '/home/cltbld', 07:26:21 INFO - 'LANG': 'en_US.UTF-8', 07:26:21 INFO - 'LANGUAGE': 'en_US:en', 07:26:21 INFO - 'LOGNAME': 'cltbld', 07:26:21 INFO - 'MAIL': '/var/mail/cltbld', 07:26:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:26:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:26:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:21 INFO - 'MOZ_NO_REMOTE': '1', 07:26:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:26:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:21 INFO - 'NO_EM_RESTART': '1', 07:26:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:21 INFO - 'PWD': '/builds/slave/test', 07:26:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:26:21 INFO - 'RUST_BACKTRACE': 'full', 07:26:21 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:26:21 INFO - 'SHELL': '/bin/bash', 07:26:21 INFO - 'SHLVL': '1', 07:26:21 INFO - 'TERM': 'linux', 07:26:21 INFO - 'TMOUT': '86400', 07:26:21 INFO - 'USER': 'cltbld', 07:26:21 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720', 07:26:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:21 INFO - '_': '/tools/buildbot/bin/python'} 07:26:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GlCZVHavR8uTNolfr7_UzA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 07:26:21 INFO - mozversion application_buildid: 20171025130235 07:26:21 INFO - mozversion application_changeset: 39a3a1dd8c6b87d09b9d4f8959eeb8e905d529a2 07:26:21 INFO - mozversion application_display_name: Firefox 07:26:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:26:21 INFO - mozversion application_name: Firefox 07:26:21 INFO - mozversion application_remotingname: firefox 07:26:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:26:21 INFO - mozversion application_vendor: Mozilla 07:26:21 INFO - mozversion application_version: 57.0 07:26:21 INFO - mozversion platform_buildid: 20171025130235 07:26:21 INFO - mozversion platform_changeset: 39a3a1dd8c6b87d09b9d4f8959eeb8e905d529a2 07:26:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:26:21 INFO - mozversion platform_version: 57.0 07:26:21 INFO - using testdate: 1508941581 07:26:21 INFO - actual date: 1508941581 07:26:21 INFO - starting webserver on 'localhost:37953' 07:26:21 INFO - SUITE-START | Running 2 tests 07:26:21 INFO - TEST-START | dromaeo_css 07:26:21 INFO - Initialising browser for dromaeo_css test... 07:26:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37953/getInfo.html -profile /tmp/tmpzK6nx9/profile 07:26:21 INFO - TEST-INFO | started process 28251 (/builds/slave/test/build/application/firefox/firefox http://localhost:37953/getInfo.html) 07:26:26 INFO - TEST-INFO | 28251: exit 0 07:26:26 INFO - Browser initialized. 07:26:26 INFO - Running cycle 1/1 for dromaeo_css test... 07:26:26 INFO - Using env: {'DISPLAY': ':0', 07:26:26 INFO - 'HOME': '/home/cltbld', 07:26:26 INFO - 'JSGC_DISABLE_POISONING': '1', 07:26:26 INFO - 'LANG': 'en_US.UTF-8', 07:26:26 INFO - 'LANGUAGE': 'en_US:en', 07:26:26 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:26:26 INFO - 'LOGNAME': 'cltbld', 07:26:26 INFO - 'MAIL': '/var/mail/cltbld', 07:26:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:26:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:26:26 INFO - 'MOZ_CRASHREPORTER': '1', 07:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:26 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:26:26 INFO - 'MOZ_NO_REMOTE': '1', 07:26:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:26:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:26 INFO - 'NO_EM_RESTART': '1', 07:26:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:26 INFO - 'PWD': '/builds/slave/test', 07:26:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:26:26 INFO - 'RUST_BACKTRACE': 'full', 07:26:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:26:26 INFO - 'SHELL': '/bin/bash', 07:26:26 INFO - 'SHLVL': '1', 07:26:26 INFO - 'TERM': 'linux', 07:26:26 INFO - 'TMOUT': '86400', 07:26:26 INFO - 'USER': 'cltbld', 07:26:26 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720', 07:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:26 INFO - '_': '/tools/buildbot/bin/python'} 07:26:26 INFO - TEST-INFO | started process 28488 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzK6nx9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:26:27 INFO - PID 28488 | 07:26:27 INFO - PID 28488 | (/builds/slave/test/build/application/firefox/firefox:28537): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:26:27 INFO - PID 28488 | 07:26:37 INFO - PID 28488 | RSS: Main: 142090240 07:26:37 INFO - PID 28488 | 07:29:35 INFO - PID 28488 | Cycle 1(1): loaded http://localhost:37953/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37953/tests/dromaeo/cssquery-ext.html) 07:29:36 INFO - PID 28488 | RSS: Main: 144900096 07:29:36 INFO - PID 28488 | 07:32:37 INFO - PID 28488 | Cycle 1(1): loaded http://localhost:37953/tests/dromaeo/cssquery-ext.html (next: http://localhost:37953/tests/dromaeo/cssquery-jquery.html) 07:32:38 INFO - PID 28488 | RSS: Main: 144707584 07:32:38 INFO - PID 28488 | 07:35:40 INFO - PID 28488 | Cycle 1(1): loaded http://localhost:37953/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37953/tests/dromaeo/cssquery-mootools.html) 07:35:40 INFO - PID 28488 | RSS: Main: 145637376 07:35:40 INFO - PID 28488 | 07:38:42 INFO - PID 28488 | Cycle 1(1): loaded http://localhost:37953/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37953/tests/dromaeo/cssquery-prototype.html) 07:38:42 INFO - PID 28488 | RSS: Main: 145563648 07:38:42 INFO - PID 28488 | 07:41:45 INFO - PID 28488 | Cycle 1(1): loaded http://localhost:37953/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37953/tests/dromaeo/cssquery-yui.html) 07:41:46 INFO - PID 28488 | RSS: Main: 146522112 07:41:46 INFO - PID 28488 | 07:44:47 INFO - PID 28488 | Cycle 1(1): loaded http://localhost:37953/tests/dromaeo/cssquery-yui.html (next: http://localhost:37953/tests/dromaeo/cssquery-dojo.html) 07:44:47 INFO - PID 28488 | RSS: Main: 148840448 07:44:47 INFO - PID 28488 | 07:44:47 INFO - PID 28488 | __start_tp_report 07:44:47 INFO - PID 28488 | _x_x_mozilla_page_load 07:44:47 INFO - PID 28488 | _x_x_mozilla_page_load_details 07:44:47 INFO - PID 28488 | |i|pagename|runs| 07:44:47 INFO - PID 28488 | |0;dojo.html;3940.566537680855;3950.6444420002204;3955.485786847711;3955.9912222383286;3977.5028121484816;6314.084457753623;6350.745970161194;6420.229572451312;6436.066770318301;6484.773032943848;6390.616563006223;6398.136251606032;6398.808035758934;6457.321981191978;6464.676766161697;5767.740451679684;5816.82549523515;5857.326407463132;5866.413358664121;5876.236089308384;5847.210626565402;5863.5309175265875;5880.647161170344;5903.439173278532;5922.1116832475045;5809.215755872967;5962.314333851619;5963.940360596382;5970.970145149268;5974.4921681657115;5871.412858714116;5898.233229680157;5924.140999555084;5965.164876917235;6007.969960150193;5761.5678824087945;5769.88460230793;5788.42115788422;5851.297844258674;5869.2369991901205;6221.657808820513;6369.172007638977;6402;6411.942029565116;6440.871182576369;6987.825304367431;7075;7093.290670932865;7104.68028938699;7122.287771222888;7023.648817559153;7027.367536921651;7075.080239568874;7135.678894449762;7161.104861892263;6445.742170313182;6559.34406559345;6654.70053847578;6664.8000559983275;6680.830854600377;7156.785296441115;7180.82047948795;7266.96366518164;7267.63661816907;7276.272372762787;6819.181698196149;6936;6993.2657071007825;6995.230524642286;7015.333543313377;6942.687579058955;7060.364567188978;7091.9290807091265;7113;7134.643267836587;6932.133483314586;6995.125609298838;7023.964880175668;7038.155421349368;7042.260562640951;6831.760888368983;6937.791866244021;6955.860882782316;7013.544119632207;7021.824454388681;5111.437741848394;5179.766910489037;5199.272101905736;5219.634625576173;5231.55531779803;4716.528347165325;4800;4821.927671084936;4829.637777166727;4852.539008794159;6555.8361040973405;6565.971166735629;6643.534952553275;6647.36849999259;6652.501062420338;6913.343232392915;6937.098177237028;7004;7011.3339232772805;7045.89431158533;6593.76921807744;6599.53803233769;6649.60102393858;6652.268250492442;6663.000549917454;5854.531637468992;5864.47219750216;5922.674252916131;5946.226990491208;5961.403859614091;7185.6047917364;7191.89212161818;7196.316349946746;7230.096237970254;7344.045274114331;6893.0694356261265;6901.102856628807;6999.195092564217;7065.788026359218;7088.184858741311;7314.926850731425;7336;7411.518251313647;7416.3325300721035;7455.329020388191;6963.582185068912;6965.582065076112;7051.5063945523325;7053.576785392893;7058.682359293742;6946.826329341807;7039.225685174729;7079.1505019395945;7079.362857342864;7167.7132914682825;6799.6600169990315;6856.314368563104;6858.554193977376;6889.379955803801;6890.069840571458;6775.322467753185;6803.4557235422035;6853.485988550979;6867.244603093556;6873.553219040747;6753.696083676345;6756.324367563401;6830.8633827324165;6841.62371069596;6850.417714494324;6697.397234248941;6783.796486105425;6865.828354290983;6893.0694356261265;6950.895736563854;6565.507586930904;6628.602283862983;6693.966530167318;6721.764738234138;6724.462043036643 07:44:47 INFO - PID 28488 | |1;ext.html;993.9602415903364;997.1972562087522;997.4862945583021;999.7300728803219;1022.4632068164212;47042.52957470424;47970.52029479708;48019;48237.51762482374;48279.51720482794;45289.77355113228;45528.544714552845;45530;45545;45549.31676024862;8083.312918401928;8197.918020819776;8212.753617391489;8217.589120543978;8222.38332125093;7965.72119975801;8003;8029.478083924555;8039.678412863478;8041.517508949452;8601.440906341099;8846.46921184731;8851.911480885205;8862;8863.202311791938;8684.826303473958;8713.7821554461;8761.693340733076;8779.253763430115;8792.69225577108;8721.956390218009;8795.34034947375;8798.824023519557;8829.381943263974;8853.380263381567;43370.78314608438;43481;43770.34344484835;43851.12297754027;43970.560294397284;3866.149447121629;3908.17928235071;3932.9016774580577;3932.941005884914;3933.724639275252;35235.647643523494;35640.82179589111;35650.28699425997;35650.64349356499;35722.64277357219;5354.866128346784;5441.59188060897;5441.863953401157;5478.91781623276;5484.588655850827;233010;234151;234735;234924;235285.82357088276;50492.49507504878;51469.94120235224;55513.722431387585;56097;57405.71297143488;59207;59489.70255148697;59506;59601;59669.10496342558;17953;18015.819841801414;18152.364667236583;18230.817691823177;18327.358542451217;14868.92565537187;14948.775768363483;14975.625609359853;14995.775063374058;15020.549383518512;15959.521214363587;16050.117243551484;16107.436239731553;16159.676806463805;16199.595010124605;6092.634441933409;6157.538184636171;6198.6280823150755;6241.18864547615;6381.054682621006;1108.9390083545482;1134.4894797341065;1134.6709454258173;1136.545381847251;1140.6749076513154;26848.59727104095;26922.730772692023;26981.325466863487;27242.318942026606;27309.590356144672;1228.3735294999615;1243.8569564500017;1248.925064496115;1251.12421305085;1251.8247445357658;14082.929585352007;14226.786598201035;14288.57134285973;14344.713105737826;14354.210518421378;299600;304645;320101;323402;323550;66917.66541167263;67364.6631766838;67698.66150669215;67896.32103678999;68054;1549.1557101379774;1562.1486289971992;1572.2060359518598;1589.4516391844795;1596.7365384711625;31855.6814431862;31934.84032579822;32287.838560807046;32508.837455813515;32778.83610581932;46170.7691461554;46456.7677161612;46571.30143047789;46619;46813.53186468092;266915;268268;268309;269303;269793;40005.59994400019;41573.58426415697;41591.58408415877;41801.163976720905;42015.7899210502;50749.746251269986;51997.480025199264;52075.739621301655;52542.21186682279;52578;37407.625923740416;37422.06444838901;37538.624613754604;37713;38121.809390953975;37261.25477490489;37370.626293736714;37648;37819;37821.810890945366;43941.340879887466;44664.33003504885;44800;44887.55112448834;45435.318470222315;36388.27223455569;36429.27141457209;36734;36950.8152459236;36960;26227.95088196527;26246.73753262443;26466.603000955387;26591.20226393211;26787.732122679303 07:44:47 INFO - PID 28488 | |2;jquery.html;645.0405735444733;650.141012320024;656.478099910571;656.6519744535398;657.4943379660576;24160;25002.249932502054;25021.49957000859;25026.62460063098;25049;27263.182104536896;27498.58752118715;27556.862215688892;27591.586126208123;27723.722762772366;6493.967530162355;6661.966690166567;6788.8302792430095;6813;6816.488763342769;6677.833054173636;6779.423748981342;6786.8303292417595;6791.252962174157;6797.558158719692;6541.116949211867;6765.323467653245;6772.593644381328;6834.692438840264;6868.62222577758;6755.898661520081;6810.9318906810795;6811.489138314621;6814;6814.48891333147;6319.05214217871;6358.713857876407;6367.808965731036;6378.425941665272;6384.489240860767;30461.543076853864;30546.694533054608;31128.53307200394;31511;31514;2283.8287128465267;2331.300609817065;2343.7890589846997;2346.62454007358;2348.3189874936247;20613.793862061488;20880.164793408247;21028.474288142766;21066.157353705832;21073.683894741593;2558.3476213565423;2606.244189185134;2641;2645.854478003709;2668;139085.3045734765;144301;161865;169523.15238423852;169913.15043424704;16307.59231019234;16384.590385240226;17048.91475542639;17122;17159.31362745476;27192.184234472603;27302.31744206371;27351.905923762828;27363.042293519633;27378.178654640393;11430;11646.301221926711;11655;11713.670280022568;11743.823842642367;10443.94778026105;10637.9468102659;10685.09176719972;10697.411642359744;10721.35671859691;9781.16860066888;9842.458664773507;10006.399616022916;10024.348417352994;10259.7435064124;2937.6474823021376;3034.635843698726;3083.2446050717717;3136.2316232523176;3148.763842711806;1058.3967138731005;1067.5783065689009;1069.8288273876142;1071.1484369925927;1074.0226393981438;21580.46048848791;21905.890470547864;22064.227752028924;22162.33512994613;22205.77794222037;1144.6451600004025;1161.0943464098018;1162.0529268646026;1163.2613290560387;1168.9298642081503;11796.52813887435;12012.879871201176;12128.636140915787;12208.267503949613;12277.631671049883;639512;648965;652322;655715;667496;136616;136796;138926;139679.30160349133;139801;1118.2284223885656;1279.7824369857146;1292.954746583865;1311.54096066376;1333.686583652841;22363.329100127023;22416.32751017407;22527.77472225257;22587.661185082565;22625;64682;65227;65475.672621636586;66039.66980165069;67736.322636773;81436;82289;84612.57693711492;84854.15145848709;86088;16183.919080404523;16396.75404868952;16508.42220522276;16530.66938661244;16598.585035374213;25054.749452505243;25212;25373.111941081974;25412.872935635205;25905.74094259109;18945;19215.615687685888;19215.90392048087;19871.900640496704;20431.489212769204;17852.375166869097;18061.458156255332;18401;18611.348602798837;18679.626407471504;20627.58744825065;20925;20980.685289720972;21014.2645007424;21160.259390921245;16139.112348820927;16205;16210.756838647194;16236.350545978028;16250.593735156715;19873;20023;20139.899300503403;20221.59556808826;20521.589568208252 07:44:47 INFO - PID 28488 | |3;mootools.html;1436.102435977514;1542.2211783049565;1545.5363390982702;1556.4474611512912;1559.0411896683543;17257.568560785985;17870.731939020927;17878.195481203344;17905.462836114923;17911.104444777742;17283.222254998524;17509;17518.299268029263;17534.82465175351;17558.561035974108;2968.1095671298526;3004.609400777901;3041.6654168041496;3043.6195475565555;3048.3141293209073;2983.925401864949;3010.3979204159145;3030.2424393901524;3039.848007599622;3045.330027393981;2976.583278341034;3026.8789248430035;3043.041441945791;3062.6477955035234;3073.3238687488715;2984.61200043994;3054.984725076383;3056.9082927511986;3062.5406189071705;3066.8159910405448;3015.321552650658;3025.3041800386036;3044.862981165853;3073.754099672021;3077.492213784723;17092.572685682833;17248.91375543127;17280;17290.91354543232;17369.044702541356;8717.520536370497;8918.866217006751;8959.910400895973;8978.775530611721;9040.005599384063;5603.915941260884;5798.565107616945;5835.416458354173;5916.911246331309;5962.642241465526;2074.1081335025933;2099.727035485377;2099.8110170084765;2154.2460138951396;2177.4882902517897;32243;32917;32926.67073329284;32928.67071329304;32959.99999999976;7514.323710866049;7732.226777322336;7751.728689495953;7793;7963.522188668699;24668.259952201464;24690.629640555406;24703;24745.752542474704;24752.876235618707;8806;8873.201411872962;8906.332025098014;8943.642254309754;8976.37165398429;7895.171007044292;8042.517448953082;8053.798655033671;8055.113937466874;8064.395170362246;5960.880782384328;6151.384861513813;6203;6240.563160578716;6301.275353334425;1752.1939907642372;1786.5087101047056;1821.5628249220356;1882.538777999399;1954.2964532768476;1015.4922538730634;1022.9693109206736;1032.200044965158;1032.2516175772655;1046.706922061824;9098.090190980849;9113.589888455035;9127.726168214964;9200.539973001323;9268.165865072042;1091.372460835023;1110.4503270880805;1113.2318700097069;1113.5378817790688;1117.575091758015;5506.8072617459;5530.668159910419;5610.186522954149;5615.691136987423;5663.915041274384;25638.87180564085;26111.08611198637;26615.33461663474;26634.6004809928;26984;26640.73359266421;26784.732152678225;26943.730562694513;27064.458710825675;27154.185374438403;12015.918567328983;12684.80972785409;12743.171693839871;12775.914047305898;12821.615351539469;10028.849567256351;10050.64822731201;10159.492025398848;10304.021117993778;10412.114970227312;21915.67126493136;22080.337589872328;22492.775072249722;22574.66138007964;22655.88672056629;23053.76946230516;23229.070837167;23309;23441.41396465102;23449.648255276526;14196.503122390666;14218.644533886736;14391.136531808124;14410.063345882483;14449.422023118957;15130.319135638703;15222.695546089237;15232.162231077396;15252.618684532976;15308.081515108684;13367.398467068811;13478.123921945042;13502;13516.932415338253;13623.386947587183;12553.246805191353;12631.747365052832;13045.412956416794;13065.281409522568;13256;10920.2901811382;10983.121350291798;11029.117670586173;11041.944790276319;11065.612703555336;8484.703035393732;8542.957285213533;8589.226969572768;8663.91336086631;8745.300375970035;8290.253877150844;8358.373122015752;8372;8403.285720713808;8489.10864359258 07:44:47 INFO - PID 28488 | |4;prototype.html;570.0622476026936;577.4265127527486;581.3750567164774;582.1471544187765;594.693732727645;6358.332375100611;6409.711562979665;6409.711562979665;6414.294427612965;6421.614703117816;6256.781012664557;6284.743051389717;6292.433680968712;6315.242170939482;6316.557840951135;5061.139606266944;5107.872303192413;5128.256402821588;5265.289185959904;5272.841814745554;5114.565261952738;5119.820806271781;5138.845834624967;5145.665531740425;5212.4266330703595;5078.720670363128;5098.26075219093;5125.410577783547;5137.974310128444;5158.3552055993005;5071;5131.255967884673;5132.307138536287;5199.324087868591;5212.661177023481;4690.812367505296;4714.127886341038;4718.433787945434;4729.219678753002;4758.8102974256435;6200.697853450781;6241.625502469821;6250;6300.684965751694;6306.274778400497;6026.276846778371;6033.909491357633;6064.878702425926;6077.392260773931;6083.48290395317;6831.3604734863775;6834.043233947252;6841.726330946756;6865.725370985155;6871.106756121722;4969.82605608802;5184.874201577335;5219.478052194788;5230.34620672416;5231.973840130775;6871.553349032297;6932.584044957319;7022.54353467023;7025.754098606575;7123.608201548913;5317.8936421271355;5324.361076670824;5333.7066461345;5342.519173274424;5366.248725178478;5343.759530821122;5396.9730151348995;5426.403095659474;5438.91841622376;5447.673139611636;5896.525868532867;5939.13882487037;6015.248093988252;6033.4871535919065;6082.5438092142385;6807.5575087619145;6819.215790184192;6829.7268109276065;6841.965790171117;6861.245263021064;1865.291189348039;1865.6362009408035;1877.8357418400406;1905.7236700678602;1911.120884393167;1301.8218512246433;1339.4776037345443;1344.6907211341447;1345.865413458666;1350.9864901351057;6350.523710721714;6410.358964103552;6420.293767685551;6421.229452465734;6454.322296158835;6840.828979275459;6882.621455819878;6887.311268873073;6895;6915.75794847188;6372.58578192416;6372.904406433907;6403.519736019724;6446;6486;3627.6372362763514;3652.3243200008083;3665.3585622515952;3677.6506231907924;3696.9075773105887;7115.786526404217;7143.607101609461;7203.171635261907;7212.963935180395;7225.963870180721;6908.378245957888;7029.89455158173;7111.2533184015965;7127.679254433563;7174.784756457315;7054.329838665421;7097.9541661253625;7098.57408555478;7153.213146553979;7229.240929702306;6834.692438840363;6933.077514964431;6941.2364639888565;6982.441404687715;6995.370416662525;6817.181938167253;6888.345607167311;6893.517453778188;6919.481038922;6926.480513961373;7216.242294559206;7290.854182916418;7295.343419092307;7301.744438944612;7342.706291748484;5423.186522021729;5423.864403389947;5429.782808687608;5447.727613619382;5451.863703407446;6730.798076057726;6901.240863505111;6925.861482770417;7023.157221133497;7025.332593403618;6557.9344206557325;6672.531163469547;6734.326567343226;6740.797776066725;6786.830329241809;6706.262311145868;6716.83207919806;6718;6728;6746.426553742791;6661.800145995628;6669.499787515859;6674.599524028574;6677.2988836173445;6688.431483323972;6702.899456508058;6727;6745.291744366771;6809.114815074008;6822.0324158991;6442.484601231797;6459;6491.415772580491;6527.3472652734345;6656.2345330287635 07:44:47 INFO - PID 28488 | |5;yui.html;1022.1618273016127;1040.729410353308;1041.2138835179444;1045.681067274481;1047.738065483629;19146.90426547867;19365.806341936575;19400.99999999998;19551.217951281968;20175.293864714702;20973.056212470437;21148;21156.047977840997;21199.788002119974;21214.15143394266;1067.8771941226762;1076.5962763963514;1078.412265315405;1078.6710053433699;1080.076534562949;1095.7041598768328;1104.690686607751;1134.4894797341187;1136.8749437561903;1137.8122609769378;1119.941655135897;1181.2971282087144;1188.8454500914868;1190.4285942747485;1198.4247561170644;1180.1502917899143;1186.163754553038;1186.1993154620598;1187.091874715843;1194.5102507971733;858.7252079334615;859.5873980489338;868.3140319147866;868.96524139035;875.448467465499;21276.5744685107;21303.36089917305;21312.680309795367;21350.466238344165;22758.54482910349;24122.67325297108;24221.878890605432;24338.63492047603;24567.508649826905;24585.754142458703;18802;19374;19414.417567472858;19494.122764475633;19521.609567808708;4158.688098392602;4213.094184750294;4213.262679031188;4215.030542975102;4216.051388437608;160179.1991040049;164603;164967.1751641246;165485;167769;17824.55438614045;18315.084245787923;18331.35840245585;18348.449546513624;18356.632867342578;34226.82886585551;34481.82759086188;34598.13504662403;34884.82557587196;35058.474122888176;9577.856332155023;9650.469224192597;9736.805263894683;9740.366876153028;9827.017298270115;4614.976925115353;4719.882002949954;4781.976090119597;4792.496787837227;4800.159972004885;6086.300075491286;6136.20229370179;6137.263528376623;6170.321264660884;6242.65665388408;1095.835624656308;1126.1497569335263;1133.6825688807148;1148.833419154218;1153.9076873850072;755.2938002967243;778.5095389904324;780.0872978615034;787.8778789287669;794.233564610154;13666.658333541542;13862.792058119136;13944.372503237379;14139.293035348192;14203.78694319586;666.8566258254499;710.5665544018145;716.8530451257479;729.6461216310086;734.5078797205884;6578.046183303394;6584.144061272004;6655.101561289164;6657.700403481855;6665.333466653296;149798.25100874645;153415;156168.2191589035;156444;161635;137713;139325;139558;140242;146082;112441.43779281215;113858;115326.42336788263;115561;116397.41801290939;12238.571649992207;12388.256704597752;12418.56535021306;12513.124081314585;12566.308853012806;57738.7113064432;58071;58209.4179058204;58799.70600146972;59263;73706;73951.63024184844;74522;75958.24041759732;77150;18091.36680216186;18641.161147748113;18730.15714292833;19157.329493467663;19179.232830686615;20188.192472300943;20281.898590507542;20547.075381608163;20572.279970200972;20643.17427302891;17884.91057544704;18021.639567208844;18073.548161296072;18173.54566135857;18188.181531830836;16174.110423926797;16539.173041347643;16646.583835404213;16737.66524669524;16821.243044063292;16806.243719032427;16902.323907044072;16937.32250709958;16970.151492425575;16983.150842458075;13097.148685335424;13246.403911824184;13312.733745325233;13416.396262168031;13428.19430834153;13336;13713;13739.519116831263;13773.862261377259;13815 07:44:47 INFO - PID 28488 | __end_tp_report 07:44:47 INFO - PID 28488 | __start_cc_report 07:44:47 INFO - PID 28488 | _x_x_mozilla_cycle_collect,260 07:44:47 INFO - PID 28488 | __end_cc_report 07:44:47 INFO - PID 28488 | __startTimestamp1508942687908__endTimestamp 07:44:47 INFO - PID 28488 | 07:44:47 INFO - PID 28488 | ------- Summary: start ------- 07:44:47 INFO - PID 28488 | Number of tests: 6 07:44:47 INFO - PID 28488 | 07:44:47 INFO - PID 28488 | [#0] dojo.html Cycles:165 Average:6495.10 Median:6756.32 stddev:752.53 (11.1%) stddev-sans-first:727.66 07:44:47 INFO - PID 28488 | Values: 3940.6 3950.6 3955.5 3956.0 3977.5 6314.1 6350.7 6420.2 6436.1 6484.8 6390.6 6398.1 6398.8 6457.3 6464.7 5767.7 5816.8 5857.3 5866.4 5876.2 5847.2 5863.5 5880.6 5903.4 5922.1 5809.2 5962.3 5963.9 5971.0 5974.5 5871.4 5898.2 5924.1 5965.2 6008.0 5761.6 5769.9 5788.4 5851.3 5869.2 6221.7 6369.2 6402.0 6411.9 6440.9 6987.8 7075.0 7093.3 7104.7 7122.3 7023.6 7027.4 7075.1 7135.7 7161.1 6445.7 6559.3 6654.7 6664.8 6680.8 7156.8 7180.8 7267.0 7267.6 7276.3 6819.2 6936.0 6993.3 6995.2 7015.3 6942.7 7060.4 7091.9 7113.0 7134.6 6932.1 6995.1 7024.0 7038.2 7042.3 6831.8 6937.8 6955.9 7013.5 7021.8 5111.4 5179.8 5199.3 5219.6 5231.6 4716.5 4800.0 4821.9 4829.6 4852.5 6555.8 6566.0 6643.5 6647.4 6652.5 6913.3 6937.1 7004.0 7011.3 7045.9 6593.8 6599.5 6649.6 6652.3 6663.0 5854.5 5864.5 5922.7 5946.2 5961.4 7185.6 7191.9 7196.3 7230.1 7344.0 6893.1 6901.1 6999.2 7065.8 7088.2 7314.9 7336.0 7411.5 7416.3 7455.3 6963.6 6965.6 7051.5 7053.6 7058.7 6946.8 7039.2 7079.2 7079.4 7167.7 6799.7 6856.3 6858.6 6889.4 6890.1 6775.3 6803.5 6853.5 6867.2 6873.6 6753.7 6756.3 6830.9 6841.6 6850.4 6697.4 6783.8 6865.8 6893.1 6950.9 6565.5 6628.6 6694.0 6721.8 6724.5 07:44:47 INFO - PID 28488 | 07:44:47 INFO - PID 28488 | [#1] ext.html Cycles:180 Average:46667.87 Median:21969.66 stddev:71458.95 (325.3%) stddev-sans-first:71577.12 07:44:47 INFO - PID 28488 | Values: 994.0 997.2 997.5 999.7 1022.5 47042.5 47970.5 48019.0 48237.5 48279.5 45289.8 45528.5 45530.0 45545.0 45549.3 8083.3 8197.9 8212.8 8217.6 8222.4 7965.7 8003.0 8029.5 8039.7 8041.5 8601.4 8846.5 8851.9 8862.0 8863.2 8684.8 8713.8 8761.7 8779.3 8792.7 8722.0 8795.3 8798.8 8829.4 8853.4 43370.8 43481.0 43770.3 43851.1 43970.6 3866.1 3908.2 3932.9 3932.9 3933.7 35235.6 35640.8 35650.3 35650.6 35722.6 5354.9 5441.6 5441.9 5478.9 5484.6 233010.0 234151.0 234735.0 234924.0 235285.8 50492.5 51469.9 55513.7 56097.0 57405.7 59207.0 59489.7 59506.0 59601.0 59669.1 17953.0 18015.8 18152.4 18230.8 18327.4 14868.9 14948.8 14975.6 14995.8 15020.5 15959.5 16050.1 16107.4 16159.7 16199.6 6092.6 6157.5 6198.6 6241.2 6381.1 1108.9 1134.5 1134.7 1136.5 1140.7 26848.6 26922.7 26981.3 27242.3 27309.6 1228.4 1243.9 1248.9 1251.1 1251.8 14082.9 14226.8 14288.6 14344.7 14354.2 299600.0 304645.0 320101.0 323402.0 323550.0 66917.7 67364.7 67698.7 67896.3 68054.0 1549.2 1562.1 1572.2 1589.5 1596.7 31855.7 31934.8 32287.8 32508.8 32778.8 46170.8 46456.8 46571.3 46619.0 46813.5 266915.0 268268.0 268309.0 269303.0 269793.0 40005.6 41573.6 41591.6 41801.2 42015.8 50749.7 51997.5 52075.7 52542.2 52578.0 37407.6 37422.1 37538.6 37713.0 38121.8 37261.3 37370.6 37648.0 37819.0 37821.8 43941.3 44664.3 44800.0 44887.6 45435.3 36388.3 36429.3 36734.0 36950.8 36960.0 26228.0 26246.7 26466.6 26591.2 26787.7 07:44:47 INFO - PID 28488 | 07:44:47 INFO - PID 28488 | [#2] jquery.html Cycles:180 Average:42157.16 Median:22557.72 stddev:109064.70 (483.5%) stddev-sans-first:109326.12 07:44:47 INFO - PID 28488 | Values: 645.0 650.1 656.5 656.7 657.5 24160.0 25002.2 25021.5 25026.6 25049.0 27263.2 27498.6 27556.9 27591.6 27723.7 6494.0 6662.0 6788.8 6813.0 6816.5 6677.8 6779.4 6786.8 6791.3 6797.6 6541.1 6765.3 6772.6 6834.7 6868.6 6755.9 6810.9 6811.5 6814.0 6814.5 6319.1 6358.7 6367.8 6378.4 6384.5 30461.5 30546.7 31128.5 31511.0 31514.0 2283.8 2331.3 2343.8 2346.6 2348.3 20613.8 20880.2 21028.5 21066.2 21073.7 2558.3 2606.2 2641.0 2645.9 2668.0 139085.3 144301.0 161865.0 169523.2 169913.2 16307.6 16384.6 17048.9 17122.0 17159.3 27192.2 27302.3 27351.9 27363.0 27378.2 11430.0 11646.3 11655.0 11713.7 11743.8 10443.9 10637.9 10685.1 10697.4 10721.4 9781.2 9842.5 10006.4 10024.3 10259.7 2937.6 3034.6 3083.2 3136.2 3148.8 1058.4 1067.6 1069.8 1071.1 1074.0 21580.5 21905.9 22064.2 22162.3 22205.8 1144.6 1161.1 1162.1 1163.3 1168.9 11796.5 12012.9 12128.6 12208.3 12277.6 639512.0 648965.0 652322.0 655715.0 667496.0 136616.0 136796.0 138926.0 139679.3 139801.0 1118.2 1279.8 1293.0 1311.5 1333.7 22363.3 22416.3 22527.8 22587.7 22625.0 64682.0 65227.0 65475.7 66039.7 67736.3 81436.0 82289.0 84612.6 84854.2 86088.0 16183.9 16396.8 16508.4 16530.7 16598.6 25054.7 25212.0 25373.1 25412.9 25905.7 18945.0 19215.6 19215.9 19871.9 20431.5 17852.4 18061.5 18401.0 18611.3 18679.6 20627.6 20925.0 20980.7 21014.3 21160.3 16139.1 16205.0 16210.8 16236.4 16250.6 19873.0 20023.0 20139.9 20221.6 20521.6 07:44:47 INFO - PID 28488 | 07:44:47 INFO - PID 28488 | [#3] mootools.html Cycles:180 Average:11079.67 Median:25874.98 stddev:8345.69 (32.3%) stddev-sans-first:8337.65 07:44:47 INFO - PID 28488 | Values: 1436.1 1542.2 1545.5 1556.4 1559.0 17257.6 17870.7 17878.2 17905.5 17911.1 17283.2 17509.0 17518.3 17534.8 17558.6 2968.1 3004.6 3041.7 3043.6 3048.3 2983.9 3010.4 3030.2 3039.8 3045.3 2976.6 3026.9 3043.0 3062.6 3073.3 2984.6 3055.0 3056.9 3062.5 3066.8 3015.3 3025.3 3044.9 3073.8 3077.5 17092.6 17248.9 17280.0 17290.9 17369.0 8717.5 8918.9 8959.9 8978.8 9040.0 5603.9 5798.6 5835.4 5916.9 5962.6 2074.1 2099.7 2099.8 2154.2 2177.5 32243.0 32917.0 32926.7 32928.7 32960.0 7514.3 7732.2 7751.7 7793.0 7963.5 24668.3 24690.6 24703.0 24745.8 24752.9 8806.0 8873.2 8906.3 8943.6 8976.4 7895.2 8042.5 8053.8 8055.1 8064.4 5960.9 6151.4 6203.0 6240.6 6301.3 1752.2 1786.5 1821.6 1882.5 1954.3 1015.5 1023.0 1032.2 1032.3 1046.7 9098.1 9113.6 9127.7 9200.5 9268.2 1091.4 1110.5 1113.2 1113.5 1117.6 5506.8 5530.7 5610.2 5615.7 5663.9 25638.9 26111.1 26615.3 26634.6 26984.0 26640.7 26784.7 26943.7 27064.5 27154.2 12015.9 12684.8 12743.2 12775.9 12821.6 10028.8 10050.6 10159.5 10304.0 10412.1 21915.7 22080.3 22492.8 22574.7 22655.9 23053.8 23229.1 23309.0 23441.4 23449.6 14196.5 14218.6 14391.1 14410.1 14449.4 15130.3 15222.7 15232.2 15252.6 15308.1 13367.4 13478.1 13502.0 13516.9 13623.4 12553.2 12631.7 13045.4 13065.3 13256.0 10920.3 10983.1 11029.1 11041.9 11065.6 8484.7 8543.0 8589.2 8663.9 8745.3 8290.3 8358.4 8372.0 8403.3 8489.1 07:44:47 INFO - PID 28488 | 07:44:47 INFO - PID 28488 | [#4] prototype.html Cycles:180 Average:5786.19 Median:6409.71 stddev:1606.94 (25.1%) stddev-sans-first:1563.03 07:44:47 INFO - PID 28488 | Values: 570.1 577.4 581.4 582.1 594.7 6358.3 6409.7 6409.7 6414.3 6421.6 6256.8 6284.7 6292.4 6315.2 6316.6 5061.1 5107.9 5128.3 5265.3 5272.8 5114.6 5119.8 5138.8 5145.7 5212.4 5078.7 5098.3 5125.4 5138.0 5158.4 5071.0 5131.3 5132.3 5199.3 5212.7 4690.8 4714.1 4718.4 4729.2 4758.8 6200.7 6241.6 6250.0 6300.7 6306.3 6026.3 6033.9 6064.9 6077.4 6083.5 6831.4 6834.0 6841.7 6865.7 6871.1 4969.8 5184.9 5219.5 5230.3 5232.0 6871.6 6932.6 7022.5 7025.8 7123.6 5317.9 5324.4 5333.7 5342.5 5366.2 5343.8 5397.0 5426.4 5438.9 5447.7 5896.5 5939.1 6015.2 6033.5 6082.5 6807.6 6819.2 6829.7 6842.0 6861.2 1865.3 1865.6 1877.8 1905.7 1911.1 1301.8 1339.5 1344.7 1345.9 1351.0 6350.5 6410.4 6420.3 6421.2 6454.3 6840.8 6882.6 6887.3 6895.0 6915.8 6372.6 6372.9 6403.5 6446.0 6486.0 3627.6 3652.3 3665.4 3677.7 3696.9 7115.8 7143.6 7203.2 7213.0 7226.0 6908.4 7029.9 7111.3 7127.7 7174.8 7054.3 7098.0 7098.6 7153.2 7229.2 6834.7 6933.1 6941.2 6982.4 6995.4 6817.2 6888.3 6893.5 6919.5 6926.5 7216.2 7290.9 7295.3 7301.7 7342.7 5423.2 5423.9 5429.8 5447.7 5451.9 6730.8 6901.2 6925.9 7023.2 7025.3 6557.9 6672.5 6734.3 6740.8 6786.8 6706.3 6716.8 6718.0 6728.0 6746.4 6661.8 6669.5 6674.6 6677.3 6688.4 6702.9 6727.0 6745.3 6809.1 6822.0 6442.5 6459.0 6491.4 6527.3 6656.2 07:44:47 INFO - PID 28488 | 07:44:47 INFO - PID 28488 | [#5] yui.html Cycles:180 Average:29232.60 Median:18498.90 stddev:43871.21 (237.2%) stddev-sans-first:43943.14 07:44:47 INFO - PID 28488 | Values: 1022.2 1040.7 1041.2 1045.7 1047.7 19146.9 19365.8 19401.0 19551.2 20175.3 20973.1 21148.0 21156.0 21199.8 21214.2 1067.9 1076.6 1078.4 1078.7 1080.1 1095.7 1104.7 1134.5 1136.9 1137.8 1119.9 1181.3 1188.8 1190.4 1198.4 1180.2 1186.2 1186.2 1187.1 1194.5 858.7 859.6 868.3 869.0 875.4 21276.6 21303.4 21312.7 21350.5 22758.5 24122.7 24221.9 24338.6 24567.5 24585.8 18802.0 19374.0 19414.4 19494.1 19521.6 4158.7 4213.1 4213.3 4215.0 4216.1 160179.2 164603.0 164967.2 165485.0 167769.0 17824.6 18315.1 18331.4 18348.4 18356.6 34226.8 34481.8 34598.1 34884.8 35058.5 9577.9 9650.5 9736.8 9740.4 9827.0 4615.0 4719.9 4782.0 4792.5 4800.2 6086.3 6136.2 6137.3 6170.3 6242.7 1095.8 1126.1 1133.7 1148.8 1153.9 755.3 778.5 780.1 787.9 794.2 13666.7 13862.8 13944.4 14139.3 14203.8 666.9 710.6 716.9 729.6 734.5 6578.0 6584.1 6655.1 6657.7 6665.3 149798.3 153415.0 156168.2 156444.0 161635.0 137713.0 139325.0 139558.0 140242.0 146082.0 112441.4 113858.0 115326.4 115561.0 116397.4 12238.6 12388.3 12418.6 12513.1 12566.3 57738.7 58071.0 58209.4 58799.7 59263.0 73706.0 73951.6 74522.0 75958.2 77150.0 18091.4 18641.2 18730.2 19157.3 19179.2 20188.2 20281.9 20547.1 20572.3 20643.2 17884.9 18021.6 18073.5 18173.5 18188.2 16174.1 16539.2 16646.6 16737.7 16821.2 16806.2 16902.3 16937.3 16970.2 16983.2 13097.1 13246.4 13312.7 13416.4 13428.2 13336.0 13713.0 13739.5 13773.9 13815.0 07:44:47 INFO - PID 28488 | -------- Summary: end -------- 07:44:47 INFO - PID 28488 | 07:44:48 INFO - TEST-INFO | 28488: exit 0 07:44:48 INFO - TEST-OK | dromaeo_css | took 1107143ms 07:44:48 INFO - TEST-START | kraken 07:44:48 INFO - Initialising browser for kraken test... 07:44:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37953/getInfo.html -profile /tmp/tmpX7jE5x/profile 07:44:48 INFO - TEST-INFO | started process 28860 (/builds/slave/test/build/application/firefox/firefox http://localhost:37953/getInfo.html) 07:44:53 INFO - TEST-INFO | 28860: exit 0 07:44:53 INFO - Browser initialized. 07:44:53 INFO - Running cycle 1/1 for kraken test... 07:44:53 INFO - Using env: {'DISPLAY': ':0', 07:44:53 INFO - 'HOME': '/home/cltbld', 07:44:53 INFO - 'JSGC_DISABLE_POISONING': '1', 07:44:53 INFO - 'LANG': 'en_US.UTF-8', 07:44:53 INFO - 'LANGUAGE': 'en_US:en', 07:44:53 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:44:53 INFO - 'LOGNAME': 'cltbld', 07:44:53 INFO - 'MAIL': '/var/mail/cltbld', 07:44:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:44:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:44:53 INFO - 'MOZ_CRASHREPORTER': '1', 07:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:53 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:44:53 INFO - 'MOZ_NO_REMOTE': '1', 07:44:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:53 INFO - 'NO_EM_RESTART': '1', 07:44:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:53 INFO - 'PWD': '/builds/slave/test', 07:44:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:44:53 INFO - 'RUST_BACKTRACE': 'full', 07:44:53 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:44:53 INFO - 'SHELL': '/bin/bash', 07:44:53 INFO - 'SHLVL': '1', 07:44:53 INFO - 'TERM': 'linux', 07:44:53 INFO - 'TMOUT': '86400', 07:44:53 INFO - 'USER': 'cltbld', 07:44:53 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720', 07:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:53 INFO - '_': '/tools/buildbot/bin/python'} 07:44:53 INFO - TEST-INFO | started process 29094 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX7jE5x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:44:54 INFO - PID 29094 | 07:44:54 INFO - PID 29094 | (/builds/slave/test/build/application/firefox/firefox:29141): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:44:54 INFO - PID 29094 | 07:45:04 INFO - PID 29094 | RSS: Main: 142118912 07:45:04 INFO - PID 29094 | 07:45:07 INFO - PID 29094 | Cycle 1(1): loaded http://localhost:37953/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37953/tests/kraken/driver.html?testName=audio-beat-detection) 07:45:08 INFO - PID 29094 | RSS: Main: 148258816 07:45:08 INFO - PID 29094 | 07:45:10 INFO - PID 29094 | Cycle 1(1): loaded http://localhost:37953/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37953/tests/kraken/driver.html?testName=audio-dft) 07:45:11 INFO - PID 29094 | RSS: Main: 148561920 07:45:11 INFO - PID 29094 | 07:45:14 INFO - PID 29094 | Cycle 1(1): loaded http://localhost:37953/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37953/tests/kraken/driver.html?testName=audio-fft) 07:45:14 INFO - PID 29094 | RSS: Main: 149803008 07:45:14 INFO - PID 29094 | 07:45:16 INFO - PID 29094 | Cycle 1(1): loaded http://localhost:37953/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37953/tests/kraken/driver.html?testName=audio-oscillator) 07:45:17 INFO - PID 29094 | RSS: Main: 149876736 07:45:17 INFO - PID 29094 | 07:45:19 INFO - PID 29094 | Cycle 1(1): loaded http://localhost:37953/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37953/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:45:20 INFO - PID 29094 | RSS: Main: 149893120 07:45:20 INFO - PID 29094 | 07:45:23 INFO - PID 29094 | Cycle 1(1): loaded http://localhost:37953/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37953/tests/kraken/driver.html?testName=imaging-darkroom) 07:45:23 INFO - PID 29094 | RSS: Main: 149438464 07:45:23 INFO - PID 29094 | 07:45:27 INFO - PID 29094 | Cycle 1(1): loaded http://localhost:37953/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37953/tests/kraken/driver.html?testName=imaging-desaturate) 07:45:27 INFO - PID 29094 | RSS: Main: 150380544 07:45:27 INFO - PID 29094 | 07:45:30 INFO - PID 29094 | Cycle 1(1): loaded http://localhost:37953/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37953/tests/kraken/driver.html?testName=json-parse-financial) 07:45:31 INFO - PID 29094 | RSS: Main: 151703552 07:45:31 INFO - PID 29094 | 07:45:32 INFO - PID 29094 | Cycle 1(1): loaded http://localhost:37953/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37953/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:45:33 INFO - PID 29094 | RSS: Main: 151896064 07:45:33 INFO - PID 29094 | 07:45:35 INFO - PID 29094 | Cycle 1(1): loaded http://localhost:37953/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37953/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:45:35 INFO - PID 29094 | RSS: Main: 152190976 07:45:35 INFO - PID 29094 | 07:45:37 INFO - PID 29094 | Cycle 1(1): loaded http://localhost:37953/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37953/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:45:38 INFO - PID 29094 | RSS: Main: 148987904 07:45:38 INFO - PID 29094 | 07:45:40 INFO - PID 29094 | Cycle 1(1): loaded http://localhost:37953/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37953/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:45:41 INFO - PID 29094 | RSS: Main: 148738048 07:45:41 INFO - PID 29094 | 07:45:43 INFO - PID 29094 | Cycle 1(1): loaded http://localhost:37953/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37953/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:45:44 INFO - PID 29094 | RSS: Main: 149409792 07:45:44 INFO - PID 29094 | 07:45:46 INFO - PID 29094 | Cycle 1(1): loaded http://localhost:37953/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37953/tests/kraken/driver.html?testName=ai-astar) 07:45:46 INFO - PID 29094 | RSS: Main: 150306816 07:45:46 INFO - PID 29094 | 07:45:46 INFO - PID 29094 | __start_tp_report 07:45:46 INFO - PID 29094 | _x_x_mozilla_page_load 07:45:46 INFO - PID 29094 | _x_x_mozilla_page_load_details 07:45:46 INFO - PID 29094 | |i|pagename|runs| 07:45:46 INFO - PID 29094 | |0;ai-astar;104;106;104;105;105;105;107;107;106;106 07:45:46 INFO - PID 29094 | |1;audio-beat-detection;111;114;116;112;111;112;116;111;115;110 07:45:46 INFO - PID 29094 | |2;audio-dft;163;162;161;163;161;161;160;161;160;166 07:45:46 INFO - PID 29094 | |3;audio-fft;73;73;73;80;75;75;73;75;74;75 07:45:46 INFO - PID 29094 | |4;audio-oscillator;77;77;77;77;77;81;77;77;77;76 07:45:46 INFO - PID 29094 | |5;imaging-gaussian-blur;117;114;116;113;113;110;113;114;114;113 07:45:46 INFO - PID 29094 | |6;imaging-darkroom;155;150;149;148;148;149;148;149;150;149 07:45:46 INFO - PID 29094 | |7;imaging-desaturate;94;95;94;94;94;95;93;99;99;94 07:45:46 INFO - PID 29094 | |8;json-parse-financial;46;44;43;45;44;44;44;46;48;44 07:45:46 INFO - PID 29094 | |9;json-stringify-tinderbox;37;39;38;38;37;38;37;38;38;37 07:45:46 INFO - PID 29094 | |10;stanford-crypto-aes;68;71;69;70;71;75;71;73;72;70 07:45:46 INFO - PID 29094 | |11;stanford-crypto-ccm;102;100;99;107;102;105;102;104;110;101 07:45:46 INFO - PID 29094 | |12;stanford-crypto-pbkdf2;147;152;152;154;149;157;152;158;149;153 07:45:46 INFO - PID 29094 | |13;stanford-crypto-sha256-iterative;59;58;59;57;59;60;56;56;57;58 07:45:46 INFO - PID 29094 | __end_tp_report 07:45:46 INFO - PID 29094 | __start_cc_report 07:45:46 INFO - PID 29094 | _x_x_mozilla_cycle_collect,680 07:45:46 INFO - PID 29094 | __end_cc_report 07:45:46 INFO - PID 29094 | __startTimestamp1508942746434__endTimestamp 07:45:46 INFO - PID 29094 | 07:45:46 INFO - PID 29094 | ------- Summary: start ------- 07:45:46 INFO - PID 29094 | Number of tests: 14 07:45:46 INFO - PID 29094 | 07:45:46 INFO - PID 29094 | [#0] ai-astar Cycles:10 Average:105.50 Median:106.00 stddev:1.08 (1.0%) stddev-sans-first:1.00 07:45:46 INFO - PID 29094 | Values: 104.0 106.0 104.0 105.0 105.0 105.0 107.0 107.0 106.0 106.0 07:45:46 INFO - PID 29094 | 07:45:46 INFO - PID 29094 | [#1] audio-beat-detection Cycles:10 Average:112.80 Median:113.00 stddev:2.25 (2.0%) stddev-sans-first:2.29 07:45:46 INFO - PID 29094 | Values: 111.0 114.0 116.0 112.0 111.0 112.0 116.0 111.0 115.0 110.0 07:45:46 INFO - PID 29094 | 07:45:46 INFO - PID 29094 | [#2] audio-dft Cycles:10 Average:161.80 Median:161.50 stddev:1.81 (1.1%) stddev-sans-first:1.87 07:45:46 INFO - PID 29094 | Values: 163.0 162.0 161.0 163.0 161.0 161.0 160.0 161.0 160.0 166.0 07:45:46 INFO - PID 29094 | 07:45:46 INFO - PID 29094 | [#3] audio-fft Cycles:10 Average:74.60 Median:75.00 stddev:2.12 (2.8%) stddev-sans-first:2.17 07:45:46 INFO - PID 29094 | Values: 73.0 73.0 73.0 80.0 75.0 75.0 73.0 75.0 74.0 75.0 07:45:46 INFO - PID 29094 | 07:45:46 INFO - PID 29094 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:77.00 stddev:1.34 (1.7%) stddev-sans-first:1.41 07:45:46 INFO - PID 29094 | Values: 77.0 77.0 77.0 77.0 77.0 81.0 77.0 77.0 77.0 76.0 07:45:46 INFO - PID 29094 | 07:45:46 INFO - PID 29094 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:1.89 (1.7%) stddev-sans-first:1.58 07:45:46 INFO - PID 29094 | Values: 117.0 114.0 116.0 113.0 113.0 110.0 113.0 114.0 114.0 113.0 07:45:46 INFO - PID 29094 | 07:45:46 INFO - PID 29094 | [#6] imaging-darkroom Cycles:10 Average:149.50 Median:149.00 stddev:2.07 (1.4%) stddev-sans-first:0.78 07:45:46 INFO - PID 29094 | Values: 155.0 150.0 149.0 148.0 148.0 149.0 148.0 149.0 150.0 149.0 07:45:46 INFO - PID 29094 | 07:45:46 INFO - PID 29094 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:94.50 stddev:2.13 (2.3%) stddev-sans-first:2.22 07:45:46 INFO - PID 29094 | Values: 94.0 95.0 94.0 94.0 94.0 95.0 93.0 99.0 99.0 94.0 07:45:46 INFO - PID 29094 | 07:45:46 INFO - PID 29094 | [#8] json-parse-financial Cycles:10 Average:44.80 Median:44.50 stddev:1.48 (3.3%) stddev-sans-first:1.50 07:45:46 INFO - PID 29094 | Values: 46.0 44.0 43.0 45.0 44.0 44.0 44.0 46.0 48.0 44.0 07:45:46 INFO - PID 29094 | 07:45:46 INFO - PID 29094 | [#9] json-stringify-tinderbox Cycles:10 Average:37.70 Median:38.00 stddev:0.67 (1.8%) stddev-sans-first:0.67 07:45:46 INFO - PID 29094 | Values: 37.0 39.0 38.0 38.0 37.0 38.0 37.0 38.0 38.0 37.0 07:45:46 INFO - PID 29094 | 07:45:46 INFO - PID 29094 | [#10] stanford-crypto-aes Cycles:10 Average:71.00 Median:71.00 stddev:2.00 (2.8%) stddev-sans-first:1.80 07:45:46 INFO - PID 29094 | Values: 68.0 71.0 69.0 70.0 71.0 75.0 71.0 73.0 72.0 70.0 07:45:46 INFO - PID 29094 | 07:45:46 INFO - PID 29094 | [#11] stanford-crypto-ccm Cycles:10 Average:103.20 Median:104.50 stddev:3.36 (3.2%) stddev-sans-first:3.54 07:45:46 INFO - PID 29094 | Values: 102.0 100.0 99.0 107.0 102.0 105.0 102.0 104.0 110.0 101.0 07:45:46 INFO - PID 29094 | 07:45:46 INFO - PID 29094 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.30 Median:152.50 stddev:3.47 (2.3%) stddev-sans-first:3.10 07:45:46 INFO - PID 29094 | Values: 147.0 152.0 152.0 154.0 149.0 157.0 152.0 158.0 149.0 153.0 07:45:46 INFO - PID 29094 | 07:45:46 INFO - PID 29094 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:57.90 Median:58.50 stddev:1.37 (2.3%) stddev-sans-first:1.39 07:45:46 INFO - PID 29094 | Values: 59.0 58.0 59.0 57.0 59.0 60.0 56.0 56.0 57.0 58.0 07:45:46 INFO - PID 29094 | -------- Summary: end -------- 07:45:46 INFO - PID 29094 | 07:45:46 INFO - PID 29094 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 07:45:47 INFO - TEST-INFO | 29094: exit 0 07:45:47 INFO - TEST-OK | kraken | took 58545ms 07:45:47 INFO - SUITE-END | took 1165s 07:45:47 INFO - Completed test suite (00:19:25) 07:45:47 INFO - javascript benchmark 07:45:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9473.596571795113, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3940.566537680855, 3950.6444420002204, 3955.485786847711, 3955.9912222383286, 3977.5028121484816, 6314.084457753623, 6350.745970161194, 6420.229572451312, 6436.066770318301, 6484.773032943848, 6390.616563006223, 6398.136251606032, 6398.808035758934, 6457.321981191978, 6464.676766161697, 5767.740451679684, 5816.82549523515, 5857.326407463132, 5866.413358664121, 5876.236089308384, 5847.210626565402, 5863.5309175265875, 5880.647161170344, 5903.439173278532, 5922.1116832475045, 5809.215755872967, 5962.314333851619, 5963.940360596382, 5970.970145149268, 5974.4921681657115, 5871.412858714116, 5898.233229680157, 5924.140999555084, 5965.164876917235, 6007.969960150193, 5761.5678824087945, 5769.88460230793, 5788.42115788422, 5851.297844258674, 5869.2369991901205, 6221.657808820513, 6369.172007638977, 6402.0, 6411.942029565116, 6440.871182576369, 6987.825304367431, 7075.0, 7093.290670932865, 7104.68028938699, 7122.287771222888, 7023.648817559153, 7027.367536921651, 7075.080239568874, 7135.678894449762, 7161.104861892263, 6445.742170313182, 6559.34406559345, 6654.70053847578, 6664.8000559983275, 6680.830854600377, 7156.785296441115, 7180.82047948795, 7266.96366518164, 7267.63661816907, 7276.272372762787, 6819.181698196149, 6936.0, 6993.2657071007825, 6995.230524642286, 7015.333543313377, 6942.687579058955, 7060.364567188978, 7091.9290807091265, 7113.0, 7134.643267836587, 6932.133483314586, 6995.125609298838, 7023.964880175668, 7038.155421349368, 7042.260562640951, 6831.760888368983, 6937.791866244021, 6955.860882782316, 7013.544119632207, 7021.824454388681, 5111.437741848394, 5179.766910489037, 5199.272101905736, 5219.634625576173, 5231.55531779803, 4716.528347165325, 4800.0, 4821.927671084936, 4829.637777166727, 4852.539008794159, 6555.8361040973405, 6565.971166735629, 6643.534952553275, 6647.36849999259, 6652.501062420338, 6913.343232392915, 6937.098177237028, 7004.0, 7011.3339232772805, 7045.89431158533, 6593.76921807744, 6599.53803233769, 6649.60102393858, 6652.268250492442, 6663.000549917454, 5854.531637468992, 5864.47219750216, 5922.674252916131, 5946.226990491208, 5961.403859614091, 7185.6047917364, 7191.89212161818, 7196.316349946746, 7230.096237970254, 7344.045274114331, 6893.0694356261265, 6901.102856628807, 6999.195092564217, 7065.788026359218, 7088.184858741311, 7314.926850731425, 7336.0, 7411.518251313647, 7416.3325300721035, 7455.329020388191, 6963.582185068912, 6965.582065076112, 7051.5063945523325, 7053.576785392893, 7058.682359293742, 6946.826329341807, 7039.225685174729, 7079.1505019395945, 7079.362857342864, 7167.7132914682825, 6799.6600169990315, 6856.314368563104, 6858.554193977376, 6889.379955803801, 6890.069840571458, 6775.322467753185, 6803.4557235422035, 6853.485988550979, 6867.244603093556, 6873.553219040747, 6753.696083676345, 6756.324367563401, 6830.8633827324165, 6841.62371069596, 6850.417714494324, 6697.397234248941, 6783.796486105425, 6865.828354290983, 6893.0694356261265, 6950.895736563854, 6565.507586930904, 6628.602283862983, 6693.966530167318, 6721.764738234138, 6724.462043036643], "value": 6444.869675251847, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [993.9602415903364, 997.1972562087522, 997.4862945583021, 999.7300728803219, 1022.4632068164212, 47042.52957470424, 47970.52029479708, 48019.0, 48237.51762482374, 48279.51720482794, 45289.77355113228, 45528.544714552845, 45530.0, 45545.0, 45549.31676024862, 8083.312918401928, 8197.918020819776, 8212.753617391489, 8217.589120543978, 8222.38332125093, 7965.72119975801, 8003.0, 8029.478083924555, 8039.678412863478, 8041.517508949452, 8601.440906341099, 8846.46921184731, 8851.911480885205, 8862.0, 8863.202311791938, 8684.826303473958, 8713.7821554461, 8761.693340733076, 8779.253763430115, 8792.69225577108, 8721.956390218009, 8795.34034947375, 8798.824023519557, 8829.381943263974, 8853.380263381567, 43370.78314608438, 43481.0, 43770.34344484835, 43851.12297754027, 43970.560294397284, 3866.149447121629, 3908.17928235071, 3932.9016774580577, 3932.941005884914, 3933.724639275252, 35235.647643523494, 35640.82179589111, 35650.28699425997, 35650.64349356499, 35722.64277357219, 5354.866128346784, 5441.59188060897, 5441.863953401157, 5478.91781623276, 5484.588655850827, 233010.0, 234151.0, 234735.0, 234924.0, 235285.82357088276, 50492.49507504878, 51469.94120235224, 55513.722431387585, 56097.0, 57405.71297143488, 59207.0, 59489.70255148697, 59506.0, 59601.0, 59669.10496342558, 17953.0, 18015.819841801414, 18152.364667236583, 18230.817691823177, 18327.358542451217, 14868.92565537187, 14948.775768363483, 14975.625609359853, 14995.775063374058, 15020.549383518512, 15959.521214363587, 16050.117243551484, 16107.436239731553, 16159.676806463805, 16199.595010124605, 6092.634441933409, 6157.538184636171, 6198.6280823150755, 6241.18864547615, 6381.054682621006, 1108.9390083545482, 1134.4894797341065, 1134.6709454258173, 1136.545381847251, 1140.6749076513154, 26848.59727104095, 26922.730772692023, 26981.325466863487, 27242.318942026606, 27309.590356144672, 1228.3735294999615, 1243.8569564500017, 1248.925064496115, 1251.12421305085, 1251.8247445357658, 14082.929585352007, 14226.786598201035, 14288.57134285973, 14344.713105737826, 14354.210518421378, 299600.0, 304645.0, 320101.0, 323402.0, 323550.0, 66917.66541167263, 67364.6631766838, 67698.66150669215, 67896.32103678999, 68054.0, 1549.1557101379774, 1562.1486289971992, 1572.2060359518598, 1589.4516391844795, 1596.7365384711625, 31855.6814431862, 31934.84032579822, 32287.838560807046, 32508.837455813515, 32778.83610581932, 46170.7691461554, 46456.7677161612, 46571.30143047789, 46619.0, 46813.53186468092, 266915.0, 268268.0, 268309.0, 269303.0, 269793.0, 40005.59994400019, 41573.58426415697, 41591.58408415877, 41801.163976720905, 42015.7899210502, 50749.746251269986, 51997.480025199264, 52075.739621301655, 52542.21186682279, 52578.0, 37407.625923740416, 37422.06444838901, 37538.624613754604, 37713.0, 38121.809390953975, 37261.25477490489, 37370.626293736714, 37648.0, 37819.0, 37821.810890945366, 43941.340879887466, 44664.33003504885, 44800.0, 44887.55112448834, 45435.318470222315, 36388.27223455569, 36429.27141457209, 36734.0, 36950.8152459236, 36960.0, 26227.95088196527, 26246.73753262443, 26466.603000955387, 26591.20226393211, 26787.732122679303], "value": 19961.574535630807, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.0405735444733, 650.141012320024, 656.478099910571, 656.6519744535398, 657.4943379660576, 24160.0, 25002.249932502054, 25021.49957000859, 25026.62460063098, 25049.0, 27263.182104536896, 27498.58752118715, 27556.862215688892, 27591.586126208123, 27723.722762772366, 6493.967530162355, 6661.966690166567, 6788.8302792430095, 6813.0, 6816.488763342769, 6677.833054173636, 6779.423748981342, 6786.8303292417595, 6791.252962174157, 6797.558158719692, 6541.116949211867, 6765.323467653245, 6772.593644381328, 6834.692438840264, 6868.62222577758, 6755.898661520081, 6810.9318906810795, 6811.489138314621, 6814.0, 6814.48891333147, 6319.05214217871, 6358.713857876407, 6367.808965731036, 6378.425941665272, 6384.489240860767, 30461.543076853864, 30546.694533054608, 31128.53307200394, 31511.0, 31514.0, 2283.8287128465267, 2331.300609817065, 2343.7890589846997, 2346.62454007358, 2348.3189874936247, 20613.793862061488, 20880.164793408247, 21028.474288142766, 21066.157353705832, 21073.683894741593, 2558.3476213565423, 2606.244189185134, 2641.0, 2645.854478003709, 2668.0, 139085.3045734765, 144301.0, 161865.0, 169523.15238423852, 169913.15043424704, 16307.59231019234, 16384.590385240226, 17048.91475542639, 17122.0, 17159.31362745476, 27192.184234472603, 27302.31744206371, 27351.905923762828, 27363.042293519633, 27378.178654640393, 11430.0, 11646.301221926711, 11655.0, 11713.670280022568, 11743.823842642367, 10443.94778026105, 10637.9468102659, 10685.09176719972, 10697.411642359744, 10721.35671859691, 9781.16860066888, 9842.458664773507, 10006.399616022916, 10024.348417352994, 10259.7435064124, 2937.6474823021376, 3034.635843698726, 3083.2446050717717, 3136.2316232523176, 3148.763842711806, 1058.3967138731005, 1067.5783065689009, 1069.8288273876142, 1071.1484369925927, 1074.0226393981438, 21580.46048848791, 21905.890470547864, 22064.227752028924, 22162.33512994613, 22205.77794222037, 1144.6451600004025, 1161.0943464098018, 1162.0529268646026, 1163.2613290560387, 1168.9298642081503, 11796.52813887435, 12012.879871201176, 12128.636140915787, 12208.267503949613, 12277.631671049883, 639512.0, 648965.0, 652322.0, 655715.0, 667496.0, 136616.0, 136796.0, 138926.0, 139679.30160349133, 139801.0, 1118.2284223885656, 1279.7824369857146, 1292.954746583865, 1311.54096066376, 1333.686583652841, 22363.329100127023, 22416.32751017407, 22527.77472225257, 22587.661185082565, 22625.0, 64682.0, 65227.0, 65475.672621636586, 66039.66980165069, 67736.322636773, 81436.0, 82289.0, 84612.57693711492, 84854.15145848709, 86088.0, 16183.919080404523, 16396.75404868952, 16508.42220522276, 16530.66938661244, 16598.585035374213, 25054.749452505243, 25212.0, 25373.111941081974, 25412.872935635205, 25905.74094259109, 18945.0, 19215.615687685888, 19215.90392048087, 19871.900640496704, 20431.489212769204, 17852.375166869097, 18061.458156255332, 18401.0, 18611.348602798837, 18679.626407471504, 20627.58744825065, 20925.0, 20980.685289720972, 21014.2645007424, 21160.259390921245, 16139.112348820927, 16205.0, 16210.756838647194, 16236.350545978028, 16250.593735156715, 19873.0, 20023.0, 20139.899300503403, 20221.59556808826, 20521.589568208252], "value": 13327.375159905589, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1436.102435977514, 1542.2211783049565, 1545.5363390982702, 1556.4474611512912, 1559.0411896683543, 17257.568560785985, 17870.731939020927, 17878.195481203344, 17905.462836114923, 17911.104444777742, 17283.222254998524, 17509.0, 17518.299268029263, 17534.82465175351, 17558.561035974108, 2968.1095671298526, 3004.609400777901, 3041.6654168041496, 3043.6195475565555, 3048.3141293209073, 2983.925401864949, 3010.3979204159145, 3030.2424393901524, 3039.848007599622, 3045.330027393981, 2976.583278341034, 3026.8789248430035, 3043.041441945791, 3062.6477955035234, 3073.3238687488715, 2984.61200043994, 3054.984725076383, 3056.9082927511986, 3062.5406189071705, 3066.8159910405448, 3015.321552650658, 3025.3041800386036, 3044.862981165853, 3073.754099672021, 3077.492213784723, 17092.572685682833, 17248.91375543127, 17280.0, 17290.91354543232, 17369.044702541356, 8717.520536370497, 8918.866217006751, 8959.910400895973, 8978.775530611721, 9040.005599384063, 5603.915941260884, 5798.565107616945, 5835.416458354173, 5916.911246331309, 5962.642241465526, 2074.1081335025933, 2099.727035485377, 2099.8110170084765, 2154.2460138951396, 2177.4882902517897, 32243.0, 32917.0, 32926.67073329284, 32928.67071329304, 32959.99999999976, 7514.323710866049, 7732.226777322336, 7751.728689495953, 7793.0, 7963.522188668699, 24668.259952201464, 24690.629640555406, 24703.0, 24745.752542474704, 24752.876235618707, 8806.0, 8873.201411872962, 8906.332025098014, 8943.642254309754, 8976.37165398429, 7895.171007044292, 8042.517448953082, 8053.798655033671, 8055.113937466874, 8064.395170362246, 5960.880782384328, 6151.384861513813, 6203.0, 6240.563160578716, 6301.275353334425, 1752.1939907642372, 1786.5087101047056, 1821.5628249220356, 1882.538777999399, 1954.2964532768476, 1015.4922538730634, 1022.9693109206736, 1032.200044965158, 1032.2516175772655, 1046.706922061824, 9098.090190980849, 9113.589888455035, 9127.726168214964, 9200.539973001323, 9268.165865072042, 1091.372460835023, 1110.4503270880805, 1113.2318700097069, 1113.5378817790688, 1117.575091758015, 5506.8072617459, 5530.668159910419, 5610.186522954149, 5615.691136987423, 5663.915041274384, 25638.87180564085, 26111.08611198637, 26615.33461663474, 26634.6004809928, 26984.0, 26640.73359266421, 26784.732152678225, 26943.730562694513, 27064.458710825675, 27154.185374438403, 12015.918567328983, 12684.80972785409, 12743.171693839871, 12775.914047305898, 12821.615351539469, 10028.849567256351, 10050.64822731201, 10159.492025398848, 10304.021117993778, 10412.114970227312, 21915.67126493136, 22080.337589872328, 22492.775072249722, 22574.66138007964, 22655.88672056629, 23053.76946230516, 23229.070837167, 23309.0, 23441.41396465102, 23449.648255276526, 14196.503122390666, 14218.644533886736, 14391.136531808124, 14410.063345882483, 14449.422023118957, 15130.319135638703, 15222.695546089237, 15232.162231077396, 15252.618684532976, 15308.081515108684, 13367.398467068811, 13478.123921945042, 13502.0, 13516.932415338253, 13623.386947587183, 12553.246805191353, 12631.747365052832, 13045.412956416794, 13065.281409522568, 13256.0, 10920.2901811382, 10983.121350291798, 11029.117670586173, 11041.944790276319, 11065.612703555336, 8484.703035393732, 8542.957285213533, 8589.226969572768, 8663.91336086631, 8745.300375970035, 8290.253877150844, 8358.373122015752, 8372.0, 8403.285720713808, 8489.10864359258], "value": 7741.509513515931, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.0622476026936, 577.4265127527486, 581.3750567164774, 582.1471544187765, 594.693732727645, 6358.332375100611, 6409.711562979665, 6409.711562979665, 6414.294427612965, 6421.614703117816, 6256.781012664557, 6284.743051389717, 6292.433680968712, 6315.242170939482, 6316.557840951135, 5061.139606266944, 5107.872303192413, 5128.256402821588, 5265.289185959904, 5272.841814745554, 5114.565261952738, 5119.820806271781, 5138.845834624967, 5145.665531740425, 5212.4266330703595, 5078.720670363128, 5098.26075219093, 5125.410577783547, 5137.974310128444, 5158.3552055993005, 5071.0, 5131.255967884673, 5132.307138536287, 5199.324087868591, 5212.661177023481, 4690.812367505296, 4714.127886341038, 4718.433787945434, 4729.219678753002, 4758.8102974256435, 6200.697853450781, 6241.625502469821, 6250.0, 6300.684965751694, 6306.274778400497, 6026.276846778371, 6033.909491357633, 6064.878702425926, 6077.392260773931, 6083.48290395317, 6831.3604734863775, 6834.043233947252, 6841.726330946756, 6865.725370985155, 6871.106756121722, 4969.82605608802, 5184.874201577335, 5219.478052194788, 5230.34620672416, 5231.973840130775, 6871.553349032297, 6932.584044957319, 7022.54353467023, 7025.754098606575, 7123.608201548913, 5317.8936421271355, 5324.361076670824, 5333.7066461345, 5342.519173274424, 5366.248725178478, 5343.759530821122, 5396.9730151348995, 5426.403095659474, 5438.91841622376, 5447.673139611636, 5896.525868532867, 5939.13882487037, 6015.248093988252, 6033.4871535919065, 6082.5438092142385, 6807.5575087619145, 6819.215790184192, 6829.7268109276065, 6841.965790171117, 6861.245263021064, 1865.291189348039, 1865.6362009408035, 1877.8357418400406, 1905.7236700678602, 1911.120884393167, 1301.8218512246433, 1339.4776037345443, 1344.6907211341447, 1345.865413458666, 1350.9864901351057, 6350.523710721714, 6410.358964103552, 6420.293767685551, 6421.229452465734, 6454.322296158835, 6840.828979275459, 6882.621455819878, 6887.311268873073, 6895.0, 6915.75794847188, 6372.58578192416, 6372.904406433907, 6403.519736019724, 6446.0, 6486.0, 3627.6372362763514, 3652.3243200008083, 3665.3585622515952, 3677.6506231907924, 3696.9075773105887, 7115.786526404217, 7143.607101609461, 7203.171635261907, 7212.963935180395, 7225.963870180721, 6908.378245957888, 7029.89455158173, 7111.2533184015965, 7127.679254433563, 7174.784756457315, 7054.329838665421, 7097.9541661253625, 7098.57408555478, 7153.213146553979, 7229.240929702306, 6834.692438840363, 6933.077514964431, 6941.2364639888565, 6982.441404687715, 6995.370416662525, 6817.181938167253, 6888.345607167311, 6893.517453778188, 6919.481038922, 6926.480513961373, 7216.242294559206, 7290.854182916418, 7295.343419092307, 7301.744438944612, 7342.706291748484, 5423.186522021729, 5423.864403389947, 5429.782808687608, 5447.727613619382, 5451.863703407446, 6730.798076057726, 6901.240863505111, 6925.861482770417, 7023.157221133497, 7025.332593403618, 6557.9344206557325, 6672.531163469547, 6734.326567343226, 6740.797776066725, 6786.830329241809, 6706.262311145868, 6716.83207919806, 6718.0, 6728.0, 6746.426553742791, 6661.800145995628, 6669.499787515859, 6674.599524028574, 6677.2988836173445, 6688.431483323972, 6702.899456508058, 6727.0, 6745.291744366771, 6809.114815074008, 6822.0324158991, 6442.484601231797, 6459.0, 6491.415772580491, 6527.3472652734345, 6656.2345330287635], "value": 5326.062344811324, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1022.1618273016127, 1040.729410353308, 1041.2138835179444, 1045.681067274481, 1047.738065483629, 19146.90426547867, 19365.806341936575, 19400.99999999998, 19551.217951281968, 20175.293864714702, 20973.056212470437, 21148.0, 21156.047977840997, 21199.788002119974, 21214.15143394266, 1067.8771941226762, 1076.5962763963514, 1078.412265315405, 1078.6710053433699, 1080.076534562949, 1095.7041598768328, 1104.690686607751, 1134.4894797341187, 1136.8749437561903, 1137.8122609769378, 1119.941655135897, 1181.2971282087144, 1188.8454500914868, 1190.4285942747485, 1198.4247561170644, 1180.1502917899143, 1186.163754553038, 1186.1993154620598, 1187.091874715843, 1194.5102507971733, 858.7252079334615, 859.5873980489338, 868.3140319147866, 868.96524139035, 875.448467465499, 21276.5744685107, 21303.36089917305, 21312.680309795367, 21350.466238344165, 22758.54482910349, 24122.67325297108, 24221.878890605432, 24338.63492047603, 24567.508649826905, 24585.754142458703, 18802.0, 19374.0, 19414.417567472858, 19494.122764475633, 19521.609567808708, 4158.688098392602, 4213.094184750294, 4213.262679031188, 4215.030542975102, 4216.051388437608, 160179.1991040049, 164603.0, 164967.1751641246, 165485.0, 167769.0, 17824.55438614045, 18315.084245787923, 18331.35840245585, 18348.449546513624, 18356.632867342578, 34226.82886585551, 34481.82759086188, 34598.13504662403, 34884.82557587196, 35058.474122888176, 9577.856332155023, 9650.469224192597, 9736.805263894683, 9740.366876153028, 9827.017298270115, 4614.976925115353, 4719.882002949954, 4781.976090119597, 4792.496787837227, 4800.159972004885, 6086.300075491286, 6136.20229370179, 6137.263528376623, 6170.321264660884, 6242.65665388408, 1095.835624656308, 1126.1497569335263, 1133.6825688807148, 1148.833419154218, 1153.9076873850072, 755.2938002967243, 778.5095389904324, 780.0872978615034, 787.8778789287669, 794.233564610154, 13666.658333541542, 13862.792058119136, 13944.372503237379, 14139.293035348192, 14203.78694319586, 666.8566258254499, 710.5665544018145, 716.8530451257479, 729.6461216310086, 734.5078797205884, 6578.046183303394, 6584.144061272004, 6655.101561289164, 6657.700403481855, 6665.333466653296, 149798.25100874645, 153415.0, 156168.2191589035, 156444.0, 161635.0, 137713.0, 139325.0, 139558.0, 140242.0, 146082.0, 112441.43779281215, 113858.0, 115326.42336788263, 115561.0, 116397.41801290939, 12238.571649992207, 12388.256704597752, 12418.56535021306, 12513.124081314585, 12566.308853012806, 57738.7113064432, 58071.0, 58209.4179058204, 58799.70600146972, 59263.0, 73706.0, 73951.63024184844, 74522.0, 75958.24041759732, 77150.0, 18091.36680216186, 18641.161147748113, 18730.15714292833, 19157.329493467663, 19179.232830686615, 20188.192472300943, 20281.898590507542, 20547.075381608163, 20572.279970200972, 20643.17427302891, 17884.91057544704, 18021.639567208844, 18073.548161296072, 18173.54566135857, 18188.181531830836, 16174.110423926797, 16539.173041347643, 16646.583835404213, 16737.66524669524, 16821.243044063292, 16806.243719032427, 16902.323907044072, 16937.32250709958, 16970.151492425575, 16983.150842458075, 13097.148685335424, 13246.403911824184, 13312.733745325233, 13416.396262168031, 13428.19430834153, 13336.0, 13713.0, 13739.519116831263, 13773.862261377259, 13815.0], "value": 10225.324126238764, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1357.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 106.0, 104.0, 105.0, 105.0, 105.0, 107.0, 107.0, 106.0, 106.0], "value": 105.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 116.0, 112.0, 111.0, 112.0, 116.0, 111.0, 115.0, 110.0], "value": 112.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 163.0, 161.0, 161.0, 160.0, 161.0, 160.0, 166.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 80.0, 75.0, 75.0, 73.0, 75.0, 74.0, 75.0], "value": 74.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 77.0, 77.0, 81.0, 77.0, 77.0, 77.0, 76.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 116.0, 113.0, 113.0, 110.0, 113.0, 114.0, 114.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 150.0, 149.0, 148.0, 148.0, 149.0, 148.0, 149.0, 150.0, 149.0], "value": 149.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 93.0, 99.0, 99.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 44.0, 43.0, 45.0, 44.0, 44.0, 44.0, 46.0, 48.0, 44.0], "value": 44.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 39.0, 38.0, 38.0, 37.0, 38.0, 37.0, 38.0, 38.0, 37.0], "value": 37.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 69.0, 70.0, 71.0, 75.0, 71.0, 73.0, 72.0, 70.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 100.0, 99.0, 107.0, 102.0, 105.0, 102.0, 104.0, 110.0, 101.0], "value": 103.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 152.0, 152.0, 154.0, 149.0, 157.0, 152.0, 158.0, 149.0, 153.0], "value": 152.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 59.0, 57.0, 59.0, 60.0, 56.0, 56.0, 57.0, 58.0], "value": 57.9, "unit": "score"}]}]} 07:45:47 INFO - Return code: 0 07:45:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:45:47 INFO - # TBPL SUCCESS # 07:45:47 INFO - Running post-action listener: _package_coverage_data 07:45:47 INFO - Running post-action listener: _resource_record_post_action 07:45:47 INFO - [mozharness: 2017-10-25 14:45:47.227339Z] Finished run-tests step (success) 07:45:47 INFO - Running post-run listener: _resource_record_post_run 07:45:47 INFO - Total resource usage - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292728832; Read time: 12; Write time: 143240 07:45:47 INFO - TinderboxPrint: CPU usage
13.0% 07:45:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 07:45:47 INFO - TinderboxPrint: I/O write bytes / time
292,728,832 / 143,240 07:45:47 INFO - TinderboxPrint: CPU idle
8,188.4 (86.9%) 07:45:47 INFO - TinderboxPrint: CPU user
1,179.2 (12.5%) 07:45:47 INFO - TinderboxPrint: Swap in / out
0 / 0 07:45:47 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9261056; Read time: 0; Write time: 1220 07:45:47 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 07:45:47 INFO - run-tests - Wall time: 1166s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283467776; Read time: 12; Write time: 142020 07:45:47 INFO - Running post-run listener: _upload_blobber_files 07:45:47 INFO - Blob upload gear active. 07:45:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:45:47 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 07:45:47 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:45:47 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:45:48 INFO - (blobuploader) - INFO - Open directory for files ... 07:45:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:45:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:45:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:49 INFO - (blobuploader) - INFO - Done attempting. 07:45:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:45:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:45:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:57 INFO - (blobuploader) - INFO - Done attempting. 07:45:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:45:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:45:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:58 INFO - (blobuploader) - INFO - Done attempting. 07:45:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:45:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:45:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:59 INFO - (blobuploader) - INFO - Done attempting. 07:45:59 INFO - (blobuploader) - INFO - Iteration through files over. 07:45:59 INFO - Return code: 0 07:45:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:45:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:45:59 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/262ea79eb56b60332ca00672f52aa88bcfad13a18b06a8049759980edb9491c9220f78496d5e461a2d8005723ac18dc88b92fb5cddf930a02fd2c0462c92a97a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2ce30e05c0b5cbc61dd68ebbc518acf19664fad986c64765b86fad285068a2041e7c03a736d6544a9872865913218d57b22b68169335e55d325627b0ee6ee348", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6c746b4c5721ef7c6e04b0f923e57c04e14fa6784465e89e92e2bdd369abcb5b2a054c8131438bda273a3df155aba58ccaad9dcf23535f93e484210a3456f8df", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/39ed4549d1ff350323ce4e111cd8af22574002bcf0748e3b192966bcd136f7effbb60567fac9d1ce275391e2df0f4b4dd65e889be9cc03d85df243becace1c46"} 07:45:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:45:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:45:59 INFO - Contents: 07:45:59 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/262ea79eb56b60332ca00672f52aa88bcfad13a18b06a8049759980edb9491c9220f78496d5e461a2d8005723ac18dc88b92fb5cddf930a02fd2c0462c92a97a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2ce30e05c0b5cbc61dd68ebbc518acf19664fad986c64765b86fad285068a2041e7c03a736d6544a9872865913218d57b22b68169335e55d325627b0ee6ee348", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6c746b4c5721ef7c6e04b0f923e57c04e14fa6784465e89e92e2bdd369abcb5b2a054c8131438bda273a3df155aba58ccaad9dcf23535f93e484210a3456f8df", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/39ed4549d1ff350323ce4e111cd8af22574002bcf0748e3b192966bcd136f7effbb60567fac9d1ce275391e2df0f4b4dd65e889be9cc03d85df243becace1c46"} 07:45:59 INFO - Running post-run listener: copy_logs_to_upload_dir 07:45:59 INFO - Copying logs to upload dir... 07:45:59 INFO - mkdir: /builds/slave/test/build/upload/logs 07:45:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.722134 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-10-25 07:45:59.640104) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-25 07:45:59.643676) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/262ea79eb56b60332ca00672f52aa88bcfad13a18b06a8049759980edb9491c9220f78496d5e461a2d8005723ac18dc88b92fb5cddf930a02fd2c0462c92a97a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2ce30e05c0b5cbc61dd68ebbc518acf19664fad986c64765b86fad285068a2041e7c03a736d6544a9872865913218d57b22b68169335e55d325627b0ee6ee348", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6c746b4c5721ef7c6e04b0f923e57c04e14fa6784465e89e92e2bdd369abcb5b2a054c8131438bda273a3df155aba58ccaad9dcf23535f93e484210a3456f8df", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/39ed4549d1ff350323ce4e111cd8af22574002bcf0748e3b192966bcd136f7effbb60567fac9d1ce275391e2df0f4b4dd65e889be9cc03d85df243becace1c46"} build_url:https://queue.taskcluster.net/v1/task/GlCZVHavR8uTNolfr7_UzA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011446 build_url: 'https://queue.taskcluster.net/v1/task/GlCZVHavR8uTNolfr7_UzA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/262ea79eb56b60332ca00672f52aa88bcfad13a18b06a8049759980edb9491c9220f78496d5e461a2d8005723ac18dc88b92fb5cddf930a02fd2c0462c92a97a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2ce30e05c0b5cbc61dd68ebbc518acf19664fad986c64765b86fad285068a2041e7c03a736d6544a9872865913218d57b22b68169335e55d325627b0ee6ee348", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6c746b4c5721ef7c6e04b0f923e57c04e14fa6784465e89e92e2bdd369abcb5b2a054c8131438bda273a3df155aba58ccaad9dcf23535f93e484210a3456f8df", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/39ed4549d1ff350323ce4e111cd8af22574002bcf0748e3b192966bcd136f7effbb60567fac9d1ce275391e2df0f4b4dd65e889be9cc03d85df243becace1c46"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-25 07:45:59.673493) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-25 07:45:59.673831) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1508939907.484060-1275333720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004600 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-25 07:45:59.759325) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-25 07:45:59.759666) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-25 07:45:59.759967) ========= ========= Total master_lag: 0.21 =========