builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-051 starttime: 1506621117.22 results: success (0) revision: 2429ebbd68a92488797166e6e1a498f1e407a81c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-28 10:51:57.219926) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-28 10:51:57.220364) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-28 10:51:57.220629) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-28 10:51:57.241428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 10:51:57.241711) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-28 10:51:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.5M=0s 2017-09-28 10:51:57 (36.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130537 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 10:51:57.395296) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 10:51:57.395618) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015756 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 10:51:57.444923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-28 10:51:57.445258) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2429ebbd68a92488797166e6e1a498f1e407a81c --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 2429ebbd68a92488797166e6e1a498f1e407a81c --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=5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-28 10:51:57,517 truncating revision to first 12 chars 2017-09-28 10:51:57,518 Setting DEBUG logging. 2017-09-28 10:51:57,518 attempt 1/10 2017-09-28 10:51:57,518 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2429ebbd68a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-28 10:51:58,840 unpacking tar archive at: mozilla-beta-2429ebbd68a9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.606690 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-28 10:51:59.071246) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-28 10:51:59.071546) ========= script_repo_revision: 2429ebbd68a92488797166e6e1a498f1e407a81c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-28 10:51:59.071902) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-28 10:51:59.075363) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-28 10:51:59.090192) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-28 10:51:59.090577) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:51:59 INFO - MultiFileLogger online at 20170928 10:51:59 in /builds/slave/test 10:51:59 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 10:51:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:51:59 INFO - {'append_to_log': False, 10:51:59 INFO - 'base_work_dir': '/builds/slave/test', 10:51:59 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 10:51:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:51:59 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 10:51:59 INFO - 'buildbot_json_path': 'buildprops.json', 10:51:59 INFO - 'code_coverage': False, 10:51:59 INFO - 'config_files': ('talos/linux_config.py',), 10:51:59 INFO - 'default_actions': ('clobber', 10:51:59 INFO - 'read-buildbot-config', 10:51:59 INFO - 'download-and-extract', 10:51:59 INFO - 'populate-webroot', 10:51:59 INFO - 'create-virtualenv', 10:51:59 INFO - 'install', 10:51:59 INFO - 'setup-mitmproxy', 10:51:59 INFO - 'run-tests'), 10:51:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:51:59 INFO - 'disable_ccov_upload': False, 10:51:59 INFO - 'disable_stylo': False, 10:51:59 INFO - 'download_minidump_stackwalk': True, 10:51:59 INFO - 'download_symbols': 'ondemand', 10:51:59 INFO - 'enable_stylo': False, 10:51:59 INFO - 'enable_webrender': False, 10:51:59 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 10:51:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:51:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:51:59 INFO - 'gecko_profile': False, 10:51:59 INFO - 'gecko_profile_interval': 0, 10:51:59 INFO - 'installer_path': 'installer.exe', 10:51:59 INFO - 'log_level': 'info', 10:51:59 INFO - 'log_name': 'talos', 10:51:59 INFO - 'log_to_console': True, 10:51:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:51:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:51:59 INFO - 'opt_config_files': (), 10:51:59 INFO - 'pip_index': False, 10:51:59 INFO - 'suite': 'dromaeojs-e10s', 10:51:59 INFO - 'system_bits': '32', 10:51:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:51:59 INFO - 'title': 'talos-linux64-ix-051', 10:51:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:51:59 INFO - 'use_talos_json': True, 10:51:59 INFO - 'verify': 'False', 10:51:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:51:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:51:59 INFO - 'work_dir': 'build'} 10:51:59 INFO - [mozharness: 2017-09-28 17:51:59.301999Z] Running clobber step. 10:51:59 INFO - Running pre-action listener: _resource_record_pre_action 10:51:59 INFO - Running main action method: clobber 10:51:59 INFO - rmtree: /builds/slave/test/build 10:51:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:52:00 INFO - Running post-action listener: _resource_record_post_action 10:52:00 INFO - [mozharness: 2017-09-28 17:52:00.306524Z] Finished clobber step (success) 10:52:00 INFO - [mozharness: 2017-09-28 17:52:00.306622Z] Running read-buildbot-config step. 10:52:00 INFO - Running pre-action listener: _resource_record_pre_action 10:52:00 INFO - Running main action method: read_buildbot_config 10:52:00 INFO - Using buildbot properties: 10:52:00 INFO - { 10:52:00 INFO - "project": "", 10:52:00 INFO - "product": "firefox", 10:52:00 INFO - "who": "ryanvm@gmail.com", 10:52:00 INFO - "installer_path": "public/build/target.tar.bz2", 10:52:00 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 10:52:00 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 10:52:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 10:52:00 INFO - "stage_platform": "linux64", 10:52:00 INFO - "basedir": "/builds/slave/test", 10:52:00 INFO - "buildnumber": 135, 10:52:00 INFO - "platform": "ubuntu64_hw", 10:52:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:52:00 INFO - "slavebuilddir": "test", 10:52:00 INFO - "taskId": "aRRsreLJSjm2MuAauCpv6g", 10:52:00 INFO - "branch": "mozilla-beta", 10:52:00 INFO - "script_repo_revision": "production", 10:52:00 INFO - "revision": "2429ebbd68a92488797166e6e1a498f1e407a81c", 10:52:00 INFO - "slavename": "talos-linux64-ix-051", 10:52:00 INFO - "repo_path": "releases/mozilla-beta" 10:52:00 INFO - } 10:52:00 INFO - Finding installer, test and symbols from parent task. 10:52:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aRRsreLJSjm2MuAauCpv6g'}, attempt #1 10:52:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aRRsreLJSjm2MuAauCpv6g'}, attempt #1 10:52:01 INFO - Task dependencies: aJYDI15yQUKmZn7DPjEj8w 10:52:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aJYDI15yQUKmZn7DPjEj8w'}, attempt #1 10:52:02 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aJYDI15yQUKmZn7DPjEj8w/artifacts/public/build/target.tar.bz2 10:52:02 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/aJYDI15yQUKmZn7DPjEj8w/artifacts/public/build/target.test_packages.json 10:52:02 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aJYDI15yQUKmZn7DPjEj8w/artifacts/public/build/target.crashreporter-symbols.zip 10:52:02 INFO - Running post-action listener: _resource_record_post_action 10:52:02 INFO - [mozharness: 2017-09-28 17:52:02.002165Z] Finished read-buildbot-config step (success) 10:52:02 INFO - [mozharness: 2017-09-28 17:52:02.002384Z] Running download-and-extract step. 10:52:02 INFO - Running pre-action listener: _resource_record_pre_action 10:52:02 INFO - Running main action method: download_and_extract 10:52:02 INFO - mkdir: /builds/slave/test/build/tests 10:52:02 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')]} 10:52:02 INFO - trying https://queue.taskcluster.net/v1/task/aJYDI15yQUKmZn7DPjEj8w/artifacts/public/build/target.test_packages.json 10:52:02 INFO - Downloading https://queue.taskcluster.net/v1/task/aJYDI15yQUKmZn7DPjEj8w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:52:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aJYDI15yQUKmZn7DPjEj8w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:52:02 INFO - Downloaded 989 bytes. 10:52:02 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:52:02 INFO - Using the following test package requirements: 10:52:02 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:52:02 INFO - u'common': [u'target.common.tests.zip'], 10:52:02 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:52:02 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:52:02 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:52:02 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:52:02 INFO - u'mozbase': [u'target.common.tests.zip'], 10:52:02 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:52:02 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:52:02 INFO - u'web-platform': [u'target.common.tests.zip', 10:52:02 INFO - u'target.web-platform.tests.tar.gz'], 10:52:02 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:52:02 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 10:52:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aJYDI15yQUKmZn7DPjEj8w/artifacts/public/build/target.common.tests.zip 10:52:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aJYDI15yQUKmZn7DPjEj8w/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:52:02 INFO - Fetch https://queue.taskcluster.net/v1/task/aJYDI15yQUKmZn7DPjEj8w/artifacts/public/build/target.common.tests.zip into memory 10:52:05 INFO - Content-Length response header: 55176138 10:52:05 INFO - Bytes received: 55176138 10:52:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aJYDI15yQUKmZn7DPjEj8w/artifacts/public/build/target.talos.tests.zip 10:52:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aJYDI15yQUKmZn7DPjEj8w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:52:16 INFO - Fetch https://queue.taskcluster.net/v1/task/aJYDI15yQUKmZn7DPjEj8w/artifacts/public/build/target.talos.tests.zip into memory 10:52:18 INFO - Content-Length response header: 14509184 10:52:18 INFO - Bytes received: 14509184 10:52:18 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')]} 10:52:18 INFO - trying https://queue.taskcluster.net/v1/task/aJYDI15yQUKmZn7DPjEj8w/artifacts/public/build/target.tar.bz2 10:52:18 INFO - Downloading https://queue.taskcluster.net/v1/task/aJYDI15yQUKmZn7DPjEj8w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:52:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aJYDI15yQUKmZn7DPjEj8w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:52:20 INFO - Downloaded 53458974 bytes. 10:52:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aJYDI15yQUKmZn7DPjEj8w/artifacts/public/build/target.tar.bz2 10:52:20 INFO - mkdir: /builds/slave/test/properties 10:52:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:52:20 INFO - Writing to file /builds/slave/test/properties/build_url 10:52:20 INFO - Contents: 10:52:20 INFO - build_url:https://queue.taskcluster.net/v1/task/aJYDI15yQUKmZn7DPjEj8w/artifacts/public/build/target.tar.bz2 10:52:20 INFO - Running post-action listener: _resource_record_post_action 10:52:20 INFO - Running post-action listener: find_tests_for_verification 10:52:20 INFO - Running post-action listener: set_extra_try_arguments 10:52:20 INFO - [mozharness: 2017-09-28 17:52:20.389201Z] Finished download-and-extract step (success) 10:52:20 INFO - [mozharness: 2017-09-28 17:52:20.389301Z] Running populate-webroot step. 10:52:20 INFO - Running pre-action listener: _resource_record_pre_action 10:52:20 INFO - Running main action method: populate_webroot 10:52:20 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:52:20 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:52:20 INFO - 'tests': ['tresize', 10:52:20 INFO - 'tcanvasmark']}, 10:52:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:52:20 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:52:20 INFO - 'tests': ['dromaeo_css', 10:52:20 INFO - 'kraken']}, 10:52:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:52:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:52:20 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:52:20 INFO - 'talos_options': ['--disable-stylo'], 10:52:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:52:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:52:20 INFO - 'tests': ['damp', 'tps']}, 10:52:20 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:52:20 INFO - 'talos_options': ['--disable-stylo'], 10:52:20 INFO - 'tests': ['damp', 'tps']}, 10:52:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:52:20 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:52:20 INFO - 'tests': ['dromaeo_dom']}, 10:52:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:52:20 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:52:20 INFO - 'tests': ['basic_compositor_video', 10:52:20 INFO - 'glvideo']}, 10:52:20 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:52:20 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:52:20 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:52:20 INFO - 'talos_options': ['--disable-stylo'], 10:52:20 INFO - 'tests': ['ts_paint_webext', 10:52:20 INFO - 'tp5o_webext']}, 10:52:20 INFO - 'other-e10s': {'tests': ['a11yr', 10:52:20 INFO - 'ts_paint', 10:52:20 INFO - 'tpaint', 10:52:20 INFO - 'sessionrestore', 10:52:20 INFO - 'sessionrestore_many_windows', 10:52:20 INFO - 'sessionrestore_no_auto_restore', 10:52:20 INFO - 'tabpaint']}, 10:52:20 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:52:20 INFO - 'tests': ['a11yr', 10:52:20 INFO - 'ts_paint', 10:52:20 INFO - 'tpaint', 10:52:20 INFO - 'sessionrestore', 10:52:20 INFO - 'sessionrestore_many_windows', 10:52:20 INFO - 'sessionrestore_no_auto_restore', 10:52:20 INFO - 'tabpaint']}, 10:52:20 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:52:20 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 10:52:20 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:52:20 INFO - 'tests': ['perf_reftest_singletons']}, 10:52:20 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:52:20 INFO - 'tests': ['bloom_basic']}, 10:52:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:52:20 INFO - 'tsvgr_opacity', 10:52:20 INFO - 'tart', 10:52:20 INFO - 'tscrollx', 10:52:20 INFO - 'tsvg_static']}, 10:52:20 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:52:20 INFO - 'tests': ['tsvgx', 10:52:20 INFO - 'tsvgr_opacity', 10:52:20 INFO - 'tart', 10:52:20 INFO - 'tscrollx', 10:52:20 INFO - 'tsvg_static']}, 10:52:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:52:20 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:52:20 INFO - 'talos_options': ['--disable-stylo'], 10:52:20 INFO - 'tests': ['tp5o']}, 10:52:20 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:52:20 INFO - 'talos_options': ['--mitmproxy', 10:52:20 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:52:20 INFO - '--firstNonBlankPaint'], 10:52:20 INFO - 'tests': ['tp6_google', 10:52:20 INFO - 'tp6_youtube', 10:52:20 INFO - 'tp6_amazon', 10:52:20 INFO - 'tp6_facebook']}, 10:52:20 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:52:20 INFO - 'talos_options': ['--disable-stylo', 10:52:20 INFO - '--mitmproxy', 10:52:20 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:52:20 INFO - '--firstNonBlankPaint'], 10:52:20 INFO - 'tests': ['tp6_google', 10:52:20 INFO - 'tp6_youtube', 10:52:20 INFO - 'tp6_amazon', 10:52:20 INFO - 'tp6_facebook']}, 10:52:20 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:52:20 INFO - 'talos_options': ['--stylo-threads=1', 10:52:20 INFO - '--mitmproxy', 10:52:20 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:52:20 INFO - '--firstNonBlankPaint'], 10:52:20 INFO - 'tests': ['tp6_google', 10:52:20 INFO - 'tp6_youtube', 10:52:20 INFO - 'tp6_amazon', 10:52:20 INFO - 'tp6_facebook']}, 10:52:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:52:20 INFO - 'talos_options': ['--xperf_path', 10:52:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:52:20 INFO - 'tests': ['tp5n']}, 10:52:20 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:52:20 INFO - 'talos_options': ['--disable-stylo', 10:52:20 INFO - '--xperf_path', 10:52:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:52:20 INFO - 'tests': ['tp5n']}}} 10:52:20 INFO - Running post-action listener: _resource_record_post_action 10:52:20 INFO - [mozharness: 2017-09-28 17:52:20.404575Z] Finished populate-webroot step (success) 10:52:20 INFO - [mozharness: 2017-09-28 17:52:20.404666Z] Running create-virtualenv step. 10:52:20 INFO - Running pre-action listener: _resource_record_pre_action 10:52:20 INFO - Running main action method: create_virtualenv 10:52:20 INFO - Creating virtualenv /builds/slave/test/build/venv 10:52:20 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:52:20 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 10:52:20 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:52:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:52:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:52:21 INFO - Installing distribute.............................................................................................................................................................................................done. 10:52:21 INFO - Installing pip...............done. 10:52:21 INFO - Return code: 0 10:52:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:52:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:52:21 INFO - Reading from file tmpfile_stdout 10:52:21 INFO - Output received: 10:52:21 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 10:52:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:52: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')]} 10:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52: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')]} 10:52:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750090>, '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 0x1750d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174af90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263', '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 10:52:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:52:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:52:21 INFO - Using env: {'DISPLAY': ':0', 10:52:21 INFO - 'HOME': '/home/cltbld', 10:52:21 INFO - 'LANG': 'en_US.UTF-8', 10:52:21 INFO - 'LANGUAGE': 'en_US:en', 10:52:21 INFO - 'LOGNAME': 'cltbld', 10:52:21 INFO - 'MAIL': '/var/mail/cltbld', 10:52:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:21 INFO - 'MOZ_NO_REMOTE': '1', 10:52:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:21 INFO - 'NO_EM_RESTART': '1', 10:52:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:21 INFO - 'PWD': '/builds/slave/test', 10:52:21 INFO - 'SHELL': '/bin/bash', 10:52:21 INFO - 'SHLVL': '1', 10:52:21 INFO - 'TERM': 'linux', 10:52:21 INFO - 'TMOUT': '86400', 10:52:21 INFO - 'USER': 'cltbld', 10:52:21 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263', 10:52:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:21 INFO - '_': '/tools/buildbot/bin/python'} 10:52:29 INFO - Ignoring indexes: http://pypi.python.org/simple/ 10:52:29 INFO - Downloading/unpacking pip>=1.5 10:52:29 INFO - Running setup.py egg_info for package pip 10:52:29 INFO - warning: no files found matching 'pip/cacert.pem' 10:52:29 INFO - warning: no files found matching '*.html' under directory 'docs' 10:52:29 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 10:52:29 INFO - no previously-included directories found matching 'docs/_build/_sources' 10:52:29 INFO - Installing collected packages: pip 10:52:29 INFO - Found existing installation: pip 1.1 10:52:29 INFO - Uninstalling pip: 10:52:29 INFO - Successfully uninstalled pip 10:52:29 INFO - Running setup.py install for pip 10:52:29 INFO - warning: no files found matching 'pip/cacert.pem' 10:52:29 INFO - warning: no files found matching '*.html' under directory 'docs' 10:52:29 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 10:52:29 INFO - no previously-included directories found matching 'docs/_build/_sources' 10:52:29 INFO - Installing pip script to /builds/slave/test/build/venv/bin 10:52:29 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 10:52:29 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 10:52:29 INFO - Successfully installed pip 10:52:29 INFO - Cleaning up... 10:52:29 INFO - Return code: 0 10:52:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:52:29 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')]} 10:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:29 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')]} 10:52:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x13e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750090>, '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 0x1750d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174af90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263', '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 10:52:29 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 10:52:29 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 10:52:29 INFO - Using env: {'DISPLAY': ':0', 10:52:29 INFO - 'HOME': '/home/cltbld', 10:52:29 INFO - 'LANG': 'en_US.UTF-8', 10:52:29 INFO - 'LANGUAGE': 'en_US:en', 10:52:29 INFO - 'LOGNAME': 'cltbld', 10:52:29 INFO - 'MAIL': '/var/mail/cltbld', 10:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:29 INFO - 'MOZ_NO_REMOTE': '1', 10:52:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:29 INFO - 'NO_EM_RESTART': '1', 10:52:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:29 INFO - 'PWD': '/builds/slave/test', 10:52:29 INFO - 'SHELL': '/bin/bash', 10:52:29 INFO - 'SHLVL': '1', 10:52:29 INFO - 'TERM': 'linux', 10:52:29 INFO - 'TMOUT': '86400', 10:52:29 INFO - 'USER': 'cltbld', 10:52:29 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263', 10:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:29 INFO - '_': '/tools/buildbot/bin/python'} 10:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:29 INFO - Downloading/unpacking psutil>=3.1.1 10:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:52:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:31 INFO - Installing collected packages: psutil 10:52:31 INFO - Running setup.py install for psutil 10:52:31 INFO - building 'psutil._psutil_linux' extension 10:52:31 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 10:52:31 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 10:52:31 INFO - building 'psutil._psutil_posix' extension 10:52:31 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 10:52:31 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 10:52:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:31 INFO - Successfully installed psutil 10:52:31 INFO - Cleaning up... 10:52:31 INFO - Return code: 0 10:52:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:31 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 0x13e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750090>, '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 0x1750d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174af90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263', '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 10:52:31 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 10:52:31 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 10:52:31 INFO - Using env: {'DISPLAY': ':0', 10:52:31 INFO - 'HOME': '/home/cltbld', 10:52:31 INFO - 'LANG': 'en_US.UTF-8', 10:52:31 INFO - 'LANGUAGE': 'en_US:en', 10:52:31 INFO - 'LOGNAME': 'cltbld', 10:52:31 INFO - 'MAIL': '/var/mail/cltbld', 10:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:31 INFO - 'MOZ_NO_REMOTE': '1', 10:52:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:31 INFO - 'NO_EM_RESTART': '1', 10:52:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:31 INFO - 'PWD': '/builds/slave/test', 10:52:31 INFO - 'SHELL': '/bin/bash', 10:52:31 INFO - 'SHLVL': '1', 10:52:31 INFO - 'TERM': 'linux', 10:52:31 INFO - 'TMOUT': '86400', 10:52:31 INFO - 'USER': 'cltbld', 10:52:31 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263', 10:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:31 INFO - '_': '/tools/buildbot/bin/python'} 10:52:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:52:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:52:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:52:33 INFO - Installing collected packages: mozsystemmonitor 10:52:33 INFO - Running setup.py install for mozsystemmonitor 10:52:33 INFO - Successfully installed mozsystemmonitor 10:52:33 INFO - Cleaning up... 10:52:33 INFO - Return code: 0 10:52:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:33 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 0x13e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750090>, '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 0x1750d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174af90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263', '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 10:52:33 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 10:52:33 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 10:52:33 INFO - Using env: {'DISPLAY': ':0', 10:52:33 INFO - 'HOME': '/home/cltbld', 10:52:33 INFO - 'LANG': 'en_US.UTF-8', 10:52:33 INFO - 'LANGUAGE': 'en_US:en', 10:52:33 INFO - 'LOGNAME': 'cltbld', 10:52:33 INFO - 'MAIL': '/var/mail/cltbld', 10:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:33 INFO - 'MOZ_NO_REMOTE': '1', 10:52:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:33 INFO - 'NO_EM_RESTART': '1', 10:52:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:33 INFO - 'PWD': '/builds/slave/test', 10:52:33 INFO - 'SHELL': '/bin/bash', 10:52:33 INFO - 'SHLVL': '1', 10:52:33 INFO - 'TERM': 'linux', 10:52:33 INFO - 'TMOUT': '86400', 10:52:33 INFO - 'USER': 'cltbld', 10:52:33 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263', 10:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:33 INFO - '_': '/tools/buildbot/bin/python'} 10:52:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:33 INFO - Downloading/unpacking jsonschema==2.5.1 10:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:52:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:34 INFO - Downloading functools32-3.2.3-2.tar.gz 10:52:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:52:34 INFO - warning: no files found matching '*.txt' 10:52:34 INFO - no previously-included directories found matching 'build' 10:52:34 INFO - no previously-included directories found matching 'dist' 10:52:34 INFO - no previously-included directories found matching '.git*' 10:52:34 INFO - Installing collected packages: jsonschema, functools32 10:52:34 INFO - Running setup.py install for functools32 10:52:34 INFO - warning: no files found matching '*.txt' 10:52:34 INFO - no previously-included directories found matching 'build' 10:52:34 INFO - no previously-included directories found matching 'dist' 10:52:34 INFO - no previously-included directories found matching '.git*' 10:52:34 INFO - Successfully installed jsonschema functools32 10:52:34 INFO - Cleaning up... 10:52:34 INFO - Return code: 0 10:52:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:34 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 0x13e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750090>, '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 0x1750d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174af90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263', '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 10:52:34 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 10:52:34 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 10:52:34 INFO - Using env: {'DISPLAY': ':0', 10:52:34 INFO - 'HOME': '/home/cltbld', 10:52:34 INFO - 'LANG': 'en_US.UTF-8', 10:52:34 INFO - 'LANGUAGE': 'en_US:en', 10:52:34 INFO - 'LOGNAME': 'cltbld', 10:52:34 INFO - 'MAIL': '/var/mail/cltbld', 10:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:34 INFO - 'MOZ_NO_REMOTE': '1', 10:52:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:34 INFO - 'NO_EM_RESTART': '1', 10:52:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:34 INFO - 'PWD': '/builds/slave/test', 10:52:34 INFO - 'SHELL': '/bin/bash', 10:52:34 INFO - 'SHLVL': '1', 10:52:34 INFO - 'TERM': 'linux', 10:52:34 INFO - 'TMOUT': '86400', 10:52:34 INFO - 'USER': 'cltbld', 10:52:34 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263', 10:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:34 INFO - '_': '/tools/buildbot/bin/python'} 10:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:52:35 INFO - Cleaning up... 10:52:35 INFO - Return code: 0 10:52:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:52:35 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')]} 10:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:35 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')]} 10:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:35 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 0x13e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750090>, '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 0x1750d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174af90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263', '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 10:52:35 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 10:52:35 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 10:52:35 INFO - Using env: {'DISPLAY': ':0', 10:52:35 INFO - 'HOME': '/home/cltbld', 10:52:35 INFO - 'LANG': 'en_US.UTF-8', 10:52:35 INFO - 'LANGUAGE': 'en_US:en', 10:52:35 INFO - 'LOGNAME': 'cltbld', 10:52:35 INFO - 'MAIL': '/var/mail/cltbld', 10:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:35 INFO - 'MOZ_NO_REMOTE': '1', 10:52:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:35 INFO - 'NO_EM_RESTART': '1', 10:52:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:35 INFO - 'PWD': '/builds/slave/test', 10:52:35 INFO - 'SHELL': '/bin/bash', 10:52:35 INFO - 'SHLVL': '1', 10:52:35 INFO - 'TERM': 'linux', 10:52:35 INFO - 'TMOUT': '86400', 10:52:35 INFO - 'USER': 'cltbld', 10:52:35 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263', 10:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:35 INFO - '_': '/tools/buildbot/bin/python'} 10:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:35 INFO - Downloading/unpacking blobuploader==1.2.4 10:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:36 INFO - Downloading blobuploader-1.2.4.tar.gz 10:52:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:52:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:52:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:36 INFO - Downloading docopt-0.6.1.tar.gz 10:52:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:52:37 INFO - Installing collected packages: blobuploader, requests, docopt 10:52:37 INFO - Running setup.py install for blobuploader 10:52:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:52:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:52:37 INFO - Running setup.py install for requests 10:52:37 INFO - Running setup.py install for docopt 10:52:37 INFO - Successfully installed blobuploader requests docopt 10:52:37 INFO - Cleaning up... 10:52:37 INFO - Return code: 0 10:52:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:37 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 0x13e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750090>, '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 0x1750d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174af90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263', '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 10:52:37 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 10:52:37 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 10:52:37 INFO - Using env: {'DISPLAY': ':0', 10:52:37 INFO - 'HOME': '/home/cltbld', 10:52:37 INFO - 'LANG': 'en_US.UTF-8', 10:52:37 INFO - 'LANGUAGE': 'en_US:en', 10:52:37 INFO - 'LOGNAME': 'cltbld', 10:52:37 INFO - 'MAIL': '/var/mail/cltbld', 10:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:37 INFO - 'MOZ_NO_REMOTE': '1', 10:52:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:37 INFO - 'NO_EM_RESTART': '1', 10:52:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:37 INFO - 'PWD': '/builds/slave/test', 10:52:37 INFO - 'SHELL': '/bin/bash', 10:52:37 INFO - 'SHLVL': '1', 10:52:37 INFO - 'TERM': 'linux', 10:52:37 INFO - 'TMOUT': '86400', 10:52:37 INFO - 'USER': 'cltbld', 10:52:37 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263', 10:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:37 INFO - '_': '/tools/buildbot/bin/python'} 10:52:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:52:37 INFO - Running setup.py (path:/tmp/pip-7YHJEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:52:37 INFO - Running setup.py (path:/tmp/pip-KZFe08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:52:37 INFO - Running setup.py (path:/tmp/pip-gwk_4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:52:38 INFO - Running setup.py (path:/tmp/pip-KYRsN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:52:38 INFO - Running setup.py (path:/tmp/pip-7Wm1gZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:52:38 INFO - Running setup.py (path:/tmp/pip-3lw_ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:52:38 INFO - Running setup.py (path:/tmp/pip-16yTat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:52:38 INFO - Running setup.py (path:/tmp/pip-EBIelV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:52:38 INFO - Running setup.py (path:/tmp/pip-caYtjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:52:38 INFO - Running setup.py (path:/tmp/pip-ePXkQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:52:38 INFO - Running setup.py (path:/tmp/pip-bvebuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:52:38 INFO - Running setup.py (path:/tmp/pip-1oKmQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:52:38 INFO - Running setup.py (path:/tmp/pip-H3nQ5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:52:38 INFO - Running setup.py (path:/tmp/pip-XHlMr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:38 INFO - Running setup.py (path:/tmp/pip-lsvuY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:52:38 INFO - Running setup.py (path:/tmp/pip-QA3G9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:52:38 INFO - Running setup.py (path:/tmp/pip-zE9HWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:52:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:52:39 INFO - Running setup.py install for manifestparser 10:52:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:52:39 INFO - Running setup.py install for mozcrash 10:52:39 INFO - Running setup.py install for mozdebug 10:52:39 INFO - Running setup.py install for mozdevice 10:52:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:52:39 INFO - Running setup.py install for mozfile 10:52:39 INFO - Running setup.py install for mozhttpd 10:52:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:52:39 INFO - Running setup.py install for mozinfo 10:52:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:52:39 INFO - Running setup.py install for mozInstall 10:52:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:52:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:52:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:52:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:52:39 INFO - Running setup.py install for mozleak 10:52:39 INFO - Running setup.py install for mozlog 10:52:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:52:40 INFO - Running setup.py install for moznetwork 10:52:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:52:40 INFO - Running setup.py install for mozprocess 10:52:40 INFO - Running setup.py install for mozprofile 10:52:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:52:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:52:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:52:40 INFO - Running setup.py install for mozrunner 10:52:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:52:40 INFO - Running setup.py install for mozscreenshot 10:52:40 INFO - Running setup.py install for moztest 10:52:40 INFO - Running setup.py install for mozversion 10:52:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:52:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:52:40 INFO - Cleaning up... 10:52:40 INFO - Return code: 0 10:52:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:40 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')]} 10:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:40 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')]} 10:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:40 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 0x13e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750090>, '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 0x1750d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174af90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263', '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 10:52:40 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 10:52:40 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 10:52:40 INFO - Using env: {'DISPLAY': ':0', 10:52:40 INFO - 'HOME': '/home/cltbld', 10:52:40 INFO - 'LANG': 'en_US.UTF-8', 10:52:40 INFO - 'LANGUAGE': 'en_US:en', 10:52:40 INFO - 'LOGNAME': 'cltbld', 10:52:40 INFO - 'MAIL': '/var/mail/cltbld', 10:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:40 INFO - 'MOZ_NO_REMOTE': '1', 10:52:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:40 INFO - 'NO_EM_RESTART': '1', 10:52:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:40 INFO - 'PWD': '/builds/slave/test', 10:52:40 INFO - 'SHELL': '/bin/bash', 10:52:40 INFO - 'SHLVL': '1', 10:52:40 INFO - 'TERM': 'linux', 10:52:40 INFO - 'TMOUT': '86400', 10:52:40 INFO - 'USER': 'cltbld', 10:52:40 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263', 10:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:40 INFO - '_': '/tools/buildbot/bin/python'} 10:52:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:52:41 INFO - Running setup.py (path:/tmp/pip-FzjeXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:52:41 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)) 10:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:52:41 INFO - Running setup.py (path:/tmp/pip-HjWVn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:52:41 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)) 10:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:52:41 INFO - Running setup.py (path:/tmp/pip-RMWKaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:52:41 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)) 10:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:52:41 INFO - Running setup.py (path:/tmp/pip-1gkBUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:52:41 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)) 10:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:52:41 INFO - Running setup.py (path:/tmp/pip-CIHKep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:52:41 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)) 10:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:52:41 INFO - Running setup.py (path:/tmp/pip-WOipSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:52:41 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)) 10:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:52:41 INFO - Running setup.py (path:/tmp/pip-TWM5GH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:52:41 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)) 10:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:52:41 INFO - Running setup.py (path:/tmp/pip-dxtokA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:52:41 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)) 10:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:52:41 INFO - Running setup.py (path:/tmp/pip-XM7E0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:52:41 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)) 10:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:52:41 INFO - Running setup.py (path:/tmp/pip-n3N0ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:52:41 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)) 10:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:52:41 INFO - Running setup.py (path:/tmp/pip-GMBHVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:52:41 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)) 10:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:52:41 INFO - Running setup.py (path:/tmp/pip-FuafoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:52:41 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)) 10:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:52:41 INFO - Running setup.py (path:/tmp/pip-bUpqLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:52:41 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)) 10:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:52:41 INFO - Running setup.py (path:/tmp/pip-6pMiHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:52:42 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)) 10:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:42 INFO - Running setup.py (path:/tmp/pip-m46lKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:42 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)) 10:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:52:42 INFO - Running setup.py (path:/tmp/pip-58kiMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:52:42 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)) 10:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:52:42 INFO - Running setup.py (path:/tmp/pip-bedbP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:52:42 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)) 10:52:42 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)) 10:52:42 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)) 10:52:42 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)) 10:52:42 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)) 10:52:42 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)) 10:52:42 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)) 10:52:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:52:42 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 10:52:42 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 10:52:42 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 10:52:42 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 10:52:43 INFO - Downloading blessings-1.6.tar.gz 10:52:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:52:43 INFO - Installing collected packages: blessings 10:52:43 INFO - Running setup.py install for blessings 10:52:43 INFO - Successfully installed blessings 10:52:43 INFO - Cleaning up... 10:52:43 INFO - Return code: 0 10:52:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:52:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:52:43 INFO - Reading from file tmpfile_stdout 10:52:43 INFO - Current package versions: 10:52:43 INFO - argparse == 1.2.1 10:52:43 INFO - blessings == 1.6 10:52:43 INFO - blobuploader == 1.2.4 10:52:43 INFO - docopt == 0.6.1 10:52:43 INFO - functools32 == 3.2.3-2 10:52:43 INFO - jsonschema == 2.5.1 10:52:43 INFO - manifestparser == 1.1 10:52:43 INFO - mozInstall == 1.13 10:52:43 INFO - mozcrash == 1.0 10:52:43 INFO - mozdebug == 0.1 10:52:43 INFO - mozdevice == 0.51 10:52:43 INFO - mozfile == 1.2 10:52:43 INFO - mozhttpd == 0.7 10:52:43 INFO - mozinfo == 0.10 10:52:43 INFO - mozleak == 0.1 10:52:43 INFO - mozlog == 3.5 10:52:43 INFO - moznetwork == 0.27 10:52:43 INFO - mozprocess == 0.25 10:52:43 INFO - mozprofile == 0.28 10:52:43 INFO - mozrunner == 6.13 10:52:43 INFO - mozscreenshot == 0.1 10:52:43 INFO - mozsystemmonitor == 0.3 10:52:43 INFO - moztest == 0.8 10:52:43 INFO - mozversion == 1.4 10:52:43 INFO - psutil == 3.1.1 10:52:43 INFO - requests == 1.2.3 10:52:43 INFO - wsgiref == 0.1.2 10:52:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:43 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')]} 10:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:43 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')]} 10:52:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:43 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 0x13e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750090>, '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 0x1750d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174af90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263', '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 10:52:43 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 10:52:43 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 10:52:43 INFO - Using env: {'DISPLAY': ':0', 10:52:43 INFO - 'HOME': '/home/cltbld', 10:52:43 INFO - 'LANG': 'en_US.UTF-8', 10:52:43 INFO - 'LANGUAGE': 'en_US:en', 10:52:43 INFO - 'LOGNAME': 'cltbld', 10:52:43 INFO - 'MAIL': '/var/mail/cltbld', 10:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:43 INFO - 'MOZ_NO_REMOTE': '1', 10:52:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:43 INFO - 'NO_EM_RESTART': '1', 10:52:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:43 INFO - 'PWD': '/builds/slave/test', 10:52:43 INFO - 'SHELL': '/bin/bash', 10:52:43 INFO - 'SHLVL': '1', 10:52:43 INFO - 'TERM': 'linux', 10:52:43 INFO - 'TMOUT': '86400', 10:52:43 INFO - 'USER': 'cltbld', 10:52:43 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263', 10:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:43 INFO - '_': '/tools/buildbot/bin/python'} 10:52:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:43 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)) 10:52:44 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)) 10:52:44 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)) 10:52:44 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)) 10:52:44 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)) 10:52:44 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)) 10:52:44 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)) 10:52:44 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)) 10:52:44 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)) 10:52:44 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:52:44 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 10:52:44 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 10:52:44 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 10:52:44 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 10:52:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:52:45 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)) 10:52:45 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)) 10:52:45 INFO - Installing collected packages: simplejson 10:52:45 INFO - Running setup.py install for simplejson 10:52:45 INFO - building 'simplejson._speedups' extension 10:52:45 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 10:52:46 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 10:52:46 INFO - Successfully installed simplejson 10:52:46 INFO - Cleaning up... 10:52:46 INFO - Return code: 0 10:52:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:52:46 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')]} 10:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:46 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')]} 10:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:46 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 0x13e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750090>, '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 0x1750d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174af90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263', '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 10:52:46 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 10:52:46 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 10:52:46 INFO - Using env: {'DISPLAY': ':0', 10:52:46 INFO - 'HOME': '/home/cltbld', 10:52:46 INFO - 'LANG': 'en_US.UTF-8', 10:52:46 INFO - 'LANGUAGE': 'en_US:en', 10:52:46 INFO - 'LOGNAME': 'cltbld', 10:52:46 INFO - 'MAIL': '/var/mail/cltbld', 10:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:46 INFO - 'MOZ_NO_REMOTE': '1', 10:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:46 INFO - 'NO_EM_RESTART': '1', 10:52:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:46 INFO - 'PWD': '/builds/slave/test', 10:52:46 INFO - 'SHELL': '/bin/bash', 10:52:46 INFO - 'SHLVL': '1', 10:52:46 INFO - 'TERM': 'linux', 10:52:46 INFO - 'TMOUT': '86400', 10:52:46 INFO - 'USER': 'cltbld', 10:52:46 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263', 10:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:46 INFO - '_': '/tools/buildbot/bin/python'} 10:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:52:46 INFO - Cleaning up... 10:52:46 INFO - Return code: 0 10:52:46 INFO - Running post-action listener: _resource_record_post_action 10:52:46 INFO - Running post-action listener: _start_resource_monitoring 10:52:46 INFO - Starting resource monitoring. 10:52:46 INFO - [mozharness: 2017-09-28 17:52:46.551943Z] Finished create-virtualenv step (success) 10:52:46 INFO - [mozharness: 2017-09-28 17:52:46.552463Z] Running install step. 10:52:46 INFO - Running pre-action listener: _resource_record_pre_action 10:52:46 INFO - Running main action method: install 10:52:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:52:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:52:46 INFO - Reading from file tmpfile_stdout 10:52:46 INFO - Detecting whether we're running mozinstall >=1.0... 10:52:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:52:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:52:46 INFO - Reading from file tmpfile_stdout 10:52:46 INFO - Output received: 10:52:46 INFO - Usage: mozinstall [options] installer 10:52:46 INFO - Options: 10:52:46 INFO - -h, --help show this help message and exit 10:52:46 INFO - -d DEST, --destination=DEST 10:52:46 INFO - Directory to install application into. [default: 10:52:46 INFO - "/builds/slave/test"] 10:52:46 INFO - --app=APP Application being installed. [default: firefox] 10:52:46 INFO - mkdir: /builds/slave/test/build/application 10:52:46 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'] 10:52:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:53:01 INFO - Reading from file tmpfile_stdout 10:53:01 INFO - Output received: 10:53:01 INFO - /builds/slave/test/build/application/firefox/firefox 10:53:01 INFO - Running post-action listener: _resource_record_post_action 10:53:01 INFO - [mozharness: 2017-09-28 17:53:01.474097Z] Finished install step (success) 10:53:01 INFO - [mozharness: 2017-09-28 17:53:01.474244Z] Running setup-mitmproxy step. 10:53:01 INFO - Running pre-action listener: _resource_record_pre_action 10:53:01 INFO - Running main action method: setup_mitmproxy 10:53:01 INFO - Skipping: mitmproxy is not required 10:53:01 INFO - Running post-action listener: _resource_record_post_action 10:53:01 INFO - [mozharness: 2017-09-28 17:53:01.474780Z] Finished setup-mitmproxy step (success) 10:53:01 INFO - [mozharness: 2017-09-28 17:53:01.474882Z] Running run-tests step. 10:53:01 INFO - Running pre-action listener: _resource_record_pre_action 10:53:01 INFO - Running pre-action listener: _set_gcov_prefix 10:53:01 INFO - Running main action method: run_tests 10:53:01 WARNING - Try message not found. 10:53:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:53:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:53:01 INFO - Python 2.7.3 10:53:01 INFO - Return code: 0 10:53:01 INFO - grabbing minidump binary from tooltool 10:53:01 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')]} 10:53:01 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 0x1750090>, '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 0x1750d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174af90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:53:01 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 10:53:01 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 10:53:01 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 10:53:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:53:01 INFO - Return code: 0 10:53:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:53:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:53:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:53:01 INFO - ENV: RUST_BACKTRACE is now full 10:53:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:53:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:53:01 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/aJYDI15yQUKmZn7DPjEj8w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 10:53:01 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/aJYDI15yQUKmZn7DPjEj8w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 10:53:01 INFO - Using env: {'DISPLAY': ':0', 10:53:01 INFO - 'HOME': '/home/cltbld', 10:53:01 INFO - 'LANG': 'en_US.UTF-8', 10:53:01 INFO - 'LANGUAGE': 'en_US:en', 10:53:01 INFO - 'LOGNAME': 'cltbld', 10:53:01 INFO - 'MAIL': '/var/mail/cltbld', 10:53:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:53:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:01 INFO - 'MOZ_NO_REMOTE': '1', 10:53:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:53:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:01 INFO - 'NO_EM_RESTART': '1', 10:53:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:01 INFO - 'PWD': '/builds/slave/test', 10:53:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:53:01 INFO - 'RUST_BACKTRACE': 'full', 10:53:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:53:01 INFO - 'SHELL': '/bin/bash', 10:53:01 INFO - 'SHLVL': '1', 10:53:01 INFO - 'TERM': 'linux', 10:53:01 INFO - 'TMOUT': '86400', 10:53:01 INFO - 'USER': 'cltbld', 10:53:01 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263', 10:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:01 INFO - '_': '/tools/buildbot/bin/python'} 10:53:01 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/aJYDI15yQUKmZn7DPjEj8w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 10:53:01 INFO - mozversion application_buildid: 20170928163523 10:53:01 INFO - mozversion application_changeset: 2429ebbd68a92488797166e6e1a498f1e407a81c 10:53:01 INFO - mozversion application_display_name: Firefox 10:53:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:53:01 INFO - mozversion application_name: Firefox 10:53:01 INFO - mozversion application_remotingname: firefox 10:53:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:53:01 INFO - mozversion application_vendor: Mozilla 10:53:01 INFO - mozversion application_version: 57.0 10:53:01 INFO - mozversion platform_buildid: 20170928163523 10:53:01 INFO - mozversion platform_changeset: 2429ebbd68a92488797166e6e1a498f1e407a81c 10:53:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:53:01 INFO - mozversion platform_version: 57.0 10:53:01 INFO - using testdate: 1506621181 10:53:01 INFO - actual date: 1506621181 10:53:01 INFO - starting webserver on 'localhost:59879' 10:53:01 INFO - SUITE-START | Running 2 tests 10:53:01 INFO - TEST-START | dromaeo_css 10:53:01 INFO - Initialising browser for dromaeo_css test... 10:53:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59879/getInfo.html -profile /tmp/tmpldIWOJ/profile 10:53:01 INFO - TEST-INFO | started process 965 (/builds/slave/test/build/application/firefox/firefox http://localhost:59879/getInfo.html) 10:53:06 INFO - TEST-INFO | 965: exit 0 10:53:06 INFO - Browser initialized. 10:53:06 INFO - Running cycle 1/1 for dromaeo_css test... 10:53:06 INFO - Using env: {'DISPLAY': ':0', 10:53:06 INFO - 'HOME': '/home/cltbld', 10:53:06 INFO - 'JSGC_DISABLE_POISONING': '1', 10:53:06 INFO - 'LANG': 'en_US.UTF-8', 10:53:06 INFO - 'LANGUAGE': 'en_US:en', 10:53:06 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 10:53:06 INFO - 'LOGNAME': 'cltbld', 10:53:06 INFO - 'MAIL': '/var/mail/cltbld', 10:53:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:53:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:53:06 INFO - 'MOZ_CRASHREPORTER': '1', 10:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:06 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 10:53:06 INFO - 'MOZ_NO_REMOTE': '1', 10:53:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:53:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:06 INFO - 'NO_EM_RESTART': '1', 10:53:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:06 INFO - 'PWD': '/builds/slave/test', 10:53:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:53:06 INFO - 'RUST_BACKTRACE': 'full', 10:53:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:53:06 INFO - 'SHELL': '/bin/bash', 10:53:06 INFO - 'SHLVL': '1', 10:53:06 INFO - 'TERM': 'linux', 10:53:06 INFO - 'TMOUT': '86400', 10:53:06 INFO - 'USER': 'cltbld', 10:53:06 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263', 10:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:06 INFO - '_': '/tools/buildbot/bin/python'} 10:53:06 INFO - TEST-INFO | started process 1158 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpldIWOJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:53:07 INFO - PID 1158 | 10:53:07 INFO - PID 1158 | (/builds/slave/test/build/application/firefox/firefox:1212): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:53:07 INFO - PID 1158 | 10:53:17 INFO - PID 1158 | RSS: Main: 142970880 10:53:17 INFO - PID 1158 | 10:56:15 INFO - PID 1158 | Cycle 1(1): loaded http://localhost:59879/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59879/tests/dromaeo/cssquery-ext.html) 10:56:16 INFO - PID 1158 | RSS: Main: 146354176 10:56:16 INFO - PID 1158 | 10:59:17 INFO - PID 1158 | Cycle 1(1): loaded http://localhost:59879/tests/dromaeo/cssquery-ext.html (next: http://localhost:59879/tests/dromaeo/cssquery-jquery.html) 10:59:18 INFO - PID 1158 | RSS: Main: 144977920 10:59:18 INFO - PID 1158 | 11:02:19 INFO - PID 1158 | Cycle 1(1): loaded http://localhost:59879/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59879/tests/dromaeo/cssquery-mootools.html) 11:02:20 INFO - PID 1158 | RSS: Main: 146092032 11:02:20 INFO - PID 1158 | 11:05:22 INFO - PID 1158 | Cycle 1(1): loaded http://localhost:59879/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59879/tests/dromaeo/cssquery-prototype.html) 11:05:22 INFO - PID 1158 | RSS: Main: 146075648 11:05:22 INFO - PID 1158 | 11:08:25 INFO - PID 1158 | Cycle 1(1): loaded http://localhost:59879/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59879/tests/dromaeo/cssquery-yui.html) 11:08:26 INFO - PID 1158 | RSS: Main: 146763776 11:08:26 INFO - PID 1158 | 11:11:27 INFO - PID 1158 | Cycle 1(1): loaded http://localhost:59879/tests/dromaeo/cssquery-yui.html (next: http://localhost:59879/tests/dromaeo/cssquery-dojo.html) 11:11:27 INFO - PID 1158 | RSS: Main: 149229568 11:11:27 INFO - PID 1158 | 11:11:27 INFO - PID 1158 | __start_tp_report 11:11:27 INFO - PID 1158 | _x_x_mozilla_page_load 11:11:27 INFO - PID 1158 | _x_x_mozilla_page_load_details 11:11:27 INFO - PID 1158 | |i|pagename|runs| 11:11:27 INFO - PID 1158 | |0;dojo.html;3927.4108883667445;3979.621935916087;3984.8804535863933;3996.940045899312;3998.040470287131;6497.5126865485045;6526.902096468551;6542.37847404497;6584.6707664616815;6605.438537724299;6520.70656820443;6523.151990241274;6595.175603049619;6610.008498725194;6620.437262832665;5758.395368486312;5841.948449279139;5850.912236316459;5900.409959004108;5937.732802023897;5749.827505174831;5861.062230043194;5865.853353666171;5918.230630018092;5965.373635768247;5834.620749651259;5926;5932.88134237315;5940.2277703898435;5945.464908158265;5846;5852.619579727326;5866.2960444746905;5919.993601087804;5935.990881550147;5685.45988131131;5727.083666613364;5811.070228763378;5817.301923769175;5819.738111784937;6461.547691661585;6499.675016249169;6513.902291465632;6519.771807986745;6596.208454985384;7097.751578694772;7105.964470177668;7190.06529151207;7191.280871912819;7203.279672032807;6940.479464040217;7128.6079265640365;7134.92865071353;7171.13946326439;7205.92794072063;6537.444317233041;6565.113709649232;6566.868662626768;6567.54027218095;6610.438112760373;7178.425725941912;7178.9949407082;7247.60138192394;7253.854922901618;7300.342969132804;6888.758893438706;6909.75815846453;6916.585004899622;6992.4406047517095;7001.404880585105;7062.646867656596;7150.10623672041;7161.391281741006;7175.103112110986;7188.964055179691;6962.164540255202;7064.7174113035935;7150.356467917913;7160.462965277625;7168.139823221247;6984.301569843076;7023.367896889305;7048.929510704827;7129;7135.678894449762;5276.314079169761;5279.709615971158;5280.419153893069;5298.549623282064;5319.414864364917;4755.096531658974;4772.928406073912;4778.020505796303;4796.880077998078;4822.517748225149;6582.308857569982;6609.735610575523;6677.131972843499;6683.064370988066;6690.19717633887;6613.941769316983;7031.8593628127155;7146.964265178744;7151.642417879085;7159.176694680178;6615.933840661628;6635.469162466991;6658.733650654017;6699.5310328276555;6700.798976030727;5922.703864806743;5929.940700592939;5988.341282458926;6000.369961154103;6012.038073908154;7286.162091359562;7361;7373.483856130019;7375.668094935633;7381.963090184622;7035.155781306378;7045.471589630695;7047.1895731989425;7052.506324557232;7053.858922821412;7294.197638259893;7395.852082958203;7474.3646790021285;7482.176960534446;7555.584442855696;6916.031755554327;6921.861562768817;6980.95285707148;7006.614636195059;7047.788566343018;7024.929750702428;7041.577505349491;7045.26024767392;7130.215676275502;7144.607046612278;6746.156730408699;6821.556598821061;6857.177138743383;6921.550099243533;6936.34104760047;6807.591544507345;6852.280510546321;6880.105586273752;6885.655717214219;6895.275996020547;6734.393904548614;6739.292374300824;6741.325867413416;6823.965880170567;6825.146856642919;6771.187457505131;6857.074294970314;6908.516403851682;6957.443404527525;6962.930370696431;6723.7310507581105;6798.592084474947;6804.013418054454;6812.318768123347;6812.557183783038 11:11:27 INFO - PID 1158 | |1;ext.html;958.3195930889068;982.8132654795593;991.8462638291065;1022.9283950123493;1035.6219979707405;45248.09503809926;45743.542564574345;45968.3104753429;46071.53928460714;46101.30848037274;42899.571004289945;43261;43275;43321.13357732844;43350.78324608372;8027.638756255953;8032.477888937229;8065.879011814827;8092.190780921919;8114.9594252028655;8099.797505062362;8141.837163256731;8188.222118898725;8189.344852411822;8201;8156.632951517196;8163.755087347389;8221.218984196492;8874.86687699685;9045.05026972165;8948.284137269004;9010.14403631654;9014.819703605957;9017.864732029026;9028.548572571379;8813.823723525558;8908.198262156373;8913.331500137516;8943.776405589848;8944.418612790148;41701.37447938283;41901.79049104766;42011.1597768046;42052.36921446181;42070.36894446586;3816.637419445148;3877.8254978526033;3879.1271963807917;3883.514560679915;3883.76697398157;34698.826505867306;34703.30593388118;34800.47799283013;34801.12997175091;34852.82573587141;5420.620556561043;5649.8587535311535;5706.201131841545;5712.0860662293835;5729.369769325371;229902;230427;231326;231402;231519;51337.74331128395;51588;51737.741311293954;51785.48214517882;51789.48210517922;60652.393476065554;61033.69483152556;61251.08123378153;61365.69317153386;61392.69303653543;18851.05744712759;18891.622167556572;18892.433227003214;18917.62164756697;18957.81042189588;15683.921580392025;15688.529344119695;15698.136602486744;15705.136217507918;15729.921350393175;15690.76463853043;15803.20983950798;15803.20983950798;15912.840871591136;15915.522534323989;6058.757649693963;6126.05046217828;6189.81430557084;6206.503479721611;6294.087357333161;1078.805814953316;1114.8606424196976;1118.2395970739813;1119.8152304869768;1124.3310230412892;26878.193654190407;26931.461370772475;26940.965474519006;27086.1874143776;27212.727872721414;1219.9817002744967;1246.1775228349245;1251.0429521415942;1251.355551890777;1255.9058070644555;14067.226302553458;14192.219427931357;14342.85657143436;14447.349869255908;14557.41770329175;307699;311197;319615;322832;338031;56459.153112703345;56565.15152272719;56851.71574142185;57012.144817827764;57137.14294285589;1513.1450730337324;1527.3814105287154;1530.984690153084;1537.2774795845935;1564.4211641692418;31614.841925790224;31839.840800795846;32141.357172855944;32348.514772277966;32797.836010819796;43647.56352436562;43912.560874390845;43976.78011609922;44001.55998439975;44015.55984440115;270368;272344;272625;272989;273388;37214.62785372112;38971.22057558889;39205;39208;39214.2157156861;46451.76774116108;48252.758736206095;48256.27615585699;48346.51653483561;48593.5140648589;35431.82284088563;35651.46522802108;36067.81966090153;36209;36372.818135909154;35456;35487.290254195286;35761.46357804583;35987;36497.635023649425;41117.177656447304;41894;41912.3713144297;41981.160376792905;42070.7896460528;34507.10210938423;34931.12672183216;35183.82408087943;35362.46956295709;35761;25787.613185801853;25993.22020339393;26308.342291442867;26347.20958371252;26725.06462273889 11:11:27 INFO - PID 1158 | |2;jquery.html;649.5175577348938;650.636772366258;651.2131952695079;651.9595943582707;655.4339759840223;24186.395340116505;24658.260252192416;24863;24899.253022409357;24946.87526562369;26151.08471203508;26439.471210575775;26500.072497462592;26507.072252471167;26536.33659158522;6501.414872661459;6704.765333213339;6873;6894.310568943116;6905.827354316132;6820.965895170517;6907.585544867299;6919.411849992756;6919.861602767942;6932.23745388007;6494.51291153163;6718.832029199285;6724.966375168117;6856.00587914752;6884.690188941485;6730.764423245188;6740.662966851687;6753.223379311368;6754.527183097161;6765.695543700496;6256.343083976162;6286.339934306923;6343;6344.555881088326;6362.77730279438;29659.703402966126;30237;30814;30848;30916.845415773;2262.2534563593977;2307.5384923015295;2310.8844557772213;2311.722593288816;2316.2009106858277;20463.693044604344;21103.89448052765;21123.47191320214;21137.68293475599;21144;2544.631028500857;2564.5383830910428;2616.856072915989;2624.7637712605765;2645.8809353579136;141529;148396;169300;175666;175823;22085.447863803533;22497.88751056234;23613.70124643161;23892;24606.507869842502;49559.256611150864;49629;49658.75170624124;49742.75128624406;49847.50152498428;13083.672908177181;13289;13432.723891230318;13592.796108058386;13634.522791702242;11066.889331106586;11136.944315278533;11153.163512736577;11162.720931976766;11350.318980861175;12189.512419503299;12581.74836503283;12707.745845083231;12777.744445111046;13067.281299528428;4386;4391.275439552438;4412.683341245872;4527.569880861313;4689.366935463737;1051.831706926888;1060.8966674658423;1078.245228340165;1084.4089970965842;1090.155129774431;21727.565448690937;21857.562848742935;22132.336029918806;22331;22408.887955560444;1133.0935251798528;1145.398665700514;1150.5742875136252;1156.8322593223936;1166.5158959031908;11730.941345293219;12222.388880555936;12273.877261227452;12282.263064215997;12288.508459661693;607467;628707;634863;640358;651184;136217;138934;142872.28563857113;142875;143753;1284.9421776020101;1305.3277562055548;1329.8736620021082;1355.6204262806627;1378.3246209357342;22161.002754875746;22519;22619.88690056539;22621.773782261967;22711.772882271627;65338.673306633165;65389.999999998094;65639;65945;66765.33234667592;81412.59293703493;81618.59190704009;81994;82323.5883820577;82888.58555707183;16185;16324.673506529565;16370.590735231715;16450.588735281715;16605.58486037859;24363.51272974566;24428.389290267885;24553.386165346008;24569.262922112364;24694.629580556666;20033.398998030083;20306.79693203049;20348.79651203469;20387.18451261933;20445.897770511052;17709.38017169393;17896.642067158846;17988.370407036215;18101.818981810015;18162.72755908689;20405.285814996405;20440.79559204389;20486.38540843777;20577;20635.277765278144;16041.117738524494;16057.759133612772;16148.11185384768;16224.432144874872;16265.105419202058;19759.308424205658;19882.801171988096;19953.900230498755;20046.599068018266;20113.899430502755 11:11:27 INFO - PID 1158 | |3;mootools.html;1291.5415027665179;1351.8918486521077;1359.8300212473441;1428.6356978970362;1466.3401469338787;17879.10604469776;18354.08229588522;18451.723224151632;18463.723044154332;18472;17091.487255382326;17201;17215.397461088865;17277.568060798454;17311.653766924654;3021.27489402544;3078.8614512346885;3113.5796667449945;3115.1900505868525;3119.516474946387;3015.336625942289;3036.772242081842;3059.296361836779;3065.371598822236;3066.969330306702;2942.0585412667956;2980.478416277154;3114.2525793809436;3122.594062771848;3123.687631236881;3062.418140553299;3118.220444888755;3128.077217220914;3129.04564107947;3129.342838004022;2922.3570814420796;2928.8389138597367;2959.6004539387122;2965.1252880400334;2968.925776855596;17494.387696430564;17525.211365488583;17701.557461063578;17710.380136695283;17713.468595942144;8909.55452227386;9087.7273681789;9255.120763527455;9276.814463710689;9299.023602521705;5761.164631128505;5999.610025348338;6136.01823708209;6145.692715364258;6179.907301390483;2006.6889632107047;2030.309694703793;2057.1360028787794;2079.178724403867;2114.260008996854;31927.52108718371;31970.200744981328;32006.679933200834;32046;32251.19372015695;7453.726613382862;7528.924710752932;7532.43506736986;7740.496867703581;7798.1811909749795;19944.102515386843;20058.799412005694;20065.29771457992;20077.29729459462;20142.496437589176;8897.73306800797;9026.954865225633;9031.683891063913;9041.367104302768;9062.320325975446;8269.751907442665;8272;8323.95838020806;8360.372972027122;8451.943507061616;6020.036794112921;6185.907211391833;6188.381161883865;6231.096491008869;6233.407826256498;1641.5978085368922;1657.8342165783324;1721;1724;1795.4523870219448;968.6803354892868;986.6645340584236;997.3218211616025;1003.5835128421769;1022.7903279827766;10337.173026157889;10428.895711042944;10589.788204235872;10684.572617095384;10802.351858888493;1068.3589846092282;1101.2566517600587;1122.5846436818429;1126.4142645824124;1137.1016896651718;5708.114779389041;5767.423257674283;5834.8541286467325;5940.732667029907;6298.811035668938;26747.732522674523;27332;27335;27753.861230693718;27809.72190278071;25993.310434821677;26389.73610263911;26465.470690586466;26668.59997100045;26720.599191012152;13146.671333216555;13148.408321625358;13302.201867887958;13350.599482015556;13354.666133346744;10179.847302290324;10229.84655230187;10275.588976440858;10481.737956551147;10601;22367;23100.537989240456;23155;23296.53406931818;23643.172488962802;23187.768122319234;23256.069757209523;23278.534429311658;23280.76719232786;24181.15365962183;12912.354382281037;13010.154339967872;13050.282234477196;13114.409851556893;13188.472461101832;15905.8409415909;16147.111908845127;16252.268647911109;16255.187240637684;16280.755788663417;13169.670758230737;13692.383842726902;13783.448662053806;13848.238346891017;13856.099353541988;13022.674433139247;13055.934720326337;13133.474661013835;13243.139195952232;13421.731565368442;10680.57277708883;11276.097912166842;11326.546938122712;11349.262297950607;11351.602693905674;8332.708355207538;8345.791355216168;8444.831103378021;8470.49177049379;8557.957210213908;8499.617517211616;8557.44376615518;8588.785280368042;8712.738617841474;8757.080506546721 11:11:27 INFO - PID 1158 | |4;prototype.html;569.0752527143392;577.001786908648;583.9065749480081;607.8389226854882;618.0852338538962;6195.907061394077;6357.968210158942;6363.0773537836985;6365.204349456318;6376.42612164905;6243.875122497559;6258.15254059403;6262.749490020405;6297.464715499188;6329.082283068964;5144.742762861861;5177.637565370425;5210.6613070150315;5223.973880130594;5230.843074707765;4924.655274130812;5059.62052846038;5075.847724568269;5122.769475373617;5209.400918894337;5038.2190760432195;5063.594912406998;5071.797128114871;5078.238264260353;5090.898182036357;4978.651494395375;5004.774785134659;5020.895403011332;5046.123709485595;5059.8988020239385;4614.515475875019;4632.351470794091;4653.278741795028;4667.789949452283;4677.2750223715375;6291.842703932392;6342.112104305401;6356.9364306357265;6377;6379.840503987438;5983.431574000463;6001.879962400728;6064.332923378425;6064.727087281083;6083.756649734005;6705.161854768154;6711.28862140156;6810.114685090956;6868.347506986828;6877.65611719412;4943.233798761162;5210.452902445227;5239.266502689627;5249.921251181236;5265.025615394227;6861.2160838182435;6989.720411183546;7150.284971502861;7189.964050179768;7238.891416628755;5718.485336319668;5764.135379692996;5849.970750146222;5866.970665146647;5898.8230353089475;5924.348321684612;5955.464008239279;5961.225040744762;5985.700714964234;5990.580659353891;6347.682615869188;6366.363363663597;6404.1674582304;6404.295527491972;6406.615603063831;6725.327467253333;6758.290379510179;6825.69284382204;6886.208086070066;6954.40887524556;2017.213286818142;2020.7272018277638;2030.5532782787764;2035.4300795777206;2039.21490226261;1521.4979056911193;1566.7806507089017;1567.1145802621481;1571.3793051744497;1574.3387777133632;6299.338569450233;6357.523185761086;6467.805965821033;6471.288158302583;6518.934810651833;6759.425448836806;6769.289224631441;6819.897701534481;6839.829004274933;6871.244163142051;6400.3599640036555;6469.353064693493;6475.740970361227;6509.177430319518;6546.836329091716;3638.6179451157777;3659.8719044833833;3665.8350374233223;3671.6511931367013;3681.7238707097076;7225.385842203366;7265.273472652692;7272.818179545554;7306.465642215088;7350.191478937312;7082.291770822876;7093.645317734093;7105.147382314155;7112.395446387011;7145.499815013003;7201.459890508233;7258.891116633255;7291.9270807292305;7310.268973102648;7351.963240183765;6839.871421215643;6878.931210688029;6889.793306200822;6890.483213758888;6905.309469053054;6813.863722725617;6826.464045589702;6889.448844092561;6908.654567271717;6943.993120997528;7193.568385896863;7199.172095208908;7272.163701174432;7274.927250727425;7289.4168466523615;5831.271091113611;5860.501857342174;5870.706464676835;5882;5886.38192989747;6543.247526534319;6660.966695166493;6862.176538815374;6922.7923162305215;7035.22612512613;6653.168353955755;6712.160979877515;6730;6751.122354093936;6751.628660423527;6562.475001999733;6619.702113404812;6757.729690812509;6764.323567643196;6770.119884414995;6636.037774522763;6665.200175978914;6677.632730199885;6717.764878229238;6786.457083433214;6790.388865002174;6803.591784492946;6812.863742725217;6820.283870193558;6896.724056073325;6641.535092543476;6690.565113267622;6694;6709.429698475684;6735.932640673726 11:11:27 INFO - PID 1158 | |5;yui.html;993.1756641987151;1012.6759436980166;1026.1175389165317;1028.269928350871;1044.8171569975252;21577.24479643213;21869.234576789815;21972.670409943825;21985.67021494675;22025.33923982281;20058.799412005876;20117.899410502927;21323.786762132375;21483.355499335004;21495.355139345844;1059.3061544688242;1088.151242031217;1089.3246187363845;1089.4226060188114;1090.5365219781581;1043.8486419469211;1060.1095080132686;1062.5271754069404;1094.0700404656059;1099.9725006874853;1130.3669944830922;1137.732632831284;1139.2879450343535;1142.5486932661593;1146.0201527693828;1125.291066628019;1126.487448211066;1129.271619805221;1130.9717257068598;1140.8973192412682;839.6263662670053;840.4033136473112;840.6511297811401;844.4342290665269;844.9873251901226;22056;22082.4479388015;22368.440788980242;22386.776132238796;22507.212247571257;22864.77135228643;22879.970401331815;23248.140148788058;23332.183373581844;23370.182043628392;18126.81873181278;18356.173972171284;18445;18469;18521.722174167397;4037.6366127048705;4044.1911617676583;4061.8375264989363;4070.837166513336;4073.083556199861;164347;168897;169997;172159;172272;18124.63750724978;18368.63262734738;18373.17320720571;18381.908090459463;18425.723614145798;35292.823535882155;35873;36245.09387265339;36264.637353626655;36279.81860090682;8990.28077753778;9412.576434060484;9496.382735122195;9584.856227156599;9605.37565058269;5013.423456302499;5013.473585273567;5033.043721692867;5052.898942021139;5066.923996140061;6307.905381419282;6405.135306733531;6410.61536307823;6483.189601299838;6533.281339052701;1168.0888906652824;1183.9348835813942;1192.9582464613698;1197.1679682620495;1201.531402752927;765.9157492675802;776.1617453150584;793.4208028139491;798.7723498802814;801.1227705662291;13076.803847942288;13410.329483525784;13434.992375571872;13490.055696101179;13542.322883855768;754.1515794730927;758.8482303539314;774.5623722596715;776.3013288040809;783.9137694853562;6282.434580887742;6322.525810564226;6472.385123413268;6493.155889734304;6534.313897040837;150198;155258;158947;159496;160144;134429.3278533601;136201;137828;139737.3013134928;144110;116041.41979290219;120019.39990299992;120307;121232.39383803024;121776.39111804384;11915.82126268124;11949.283043017273;12003.459844307201;12094.213876098025;12145.81781273264;53855;54248.728756355966;54702.452975469736;55366;55430.72284638551;67625.66187169033;67677;68184;68186;70166.64916675384;17831.375901843374;18363.724544132117;18434.631307374046;18498.81501185025;18631.627367452846;20241.19035238574;20334;20358.389248322575;20376.490587735425;20540.178392864716;18335.174917128494;18785.436436906915;18847.15187816579;19097.140628671466;19130.426087217405;16060.759088613913;16310.673786524441;16454;16585.336586536403;16606.50180494587;16893.91553042227;17100.657986839946;17102.144892755063;17131.14344282806;17280.395186168425;13856.861431385558;13876.861231387556;14010.859891400956;14034.438622454987;14070.507532236323;12921.870781292067;13134.671633208864;13193.40629671648;13207;13242.139260948008 11:11:27 INFO - PID 1158 | __end_tp_report 11:11:27 INFO - PID 1158 | __start_cc_report 11:11:27 INFO - PID 1158 | _x_x_mozilla_cycle_collect,227 11:11:27 INFO - PID 1158 | __end_cc_report 11:11:27 INFO - PID 1158 | __startTimestamp1506622287843__endTimestamp 11:11:27 INFO - PID 1158 | 11:11:27 INFO - PID 1158 | ------- Summary: start ------- 11:11:27 INFO - PID 1158 | Number of tests: 6 11:11:27 INFO - PID 1158 | 11:11:27 INFO - PID 1158 | [#0] dojo.html Cycles:165 Average:6536.40 Median:6798.59 stddev:765.20 (11.3%) stddev-sans-first:739.67 11:11:27 INFO - PID 1158 | Values: 3927.4 3979.6 3984.9 3996.9 3998.0 6497.5 6526.9 6542.4 6584.7 6605.4 6520.7 6523.2 6595.2 6610.0 6620.4 5758.4 5841.9 5850.9 5900.4 5937.7 5749.8 5861.1 5865.9 5918.2 5965.4 5834.6 5926.0 5932.9 5940.2 5945.5 5846.0 5852.6 5866.3 5920.0 5936.0 5685.5 5727.1 5811.1 5817.3 5819.7 6461.5 6499.7 6513.9 6519.8 6596.2 7097.8 7106.0 7190.1 7191.3 7203.3 6940.5 7128.6 7134.9 7171.1 7205.9 6537.4 6565.1 6566.9 6567.5 6610.4 7178.4 7179.0 7247.6 7253.9 7300.3 6888.8 6909.8 6916.6 6992.4 7001.4 7062.6 7150.1 7161.4 7175.1 7189.0 6962.2 7064.7 7150.4 7160.5 7168.1 6984.3 7023.4 7048.9 7129.0 7135.7 5276.3 5279.7 5280.4 5298.5 5319.4 4755.1 4772.9 4778.0 4796.9 4822.5 6582.3 6609.7 6677.1 6683.1 6690.2 6613.9 7031.9 7147.0 7151.6 7159.2 6615.9 6635.5 6658.7 6699.5 6700.8 5922.7 5929.9 5988.3 6000.4 6012.0 7286.2 7361.0 7373.5 7375.7 7382.0 7035.2 7045.5 7047.2 7052.5 7053.9 7294.2 7395.9 7474.4 7482.2 7555.6 6916.0 6921.9 6981.0 7006.6 7047.8 7024.9 7041.6 7045.3 7130.2 7144.6 6746.2 6821.6 6857.2 6921.6 6936.3 6807.6 6852.3 6880.1 6885.7 6895.3 6734.4 6739.3 6741.3 6824.0 6825.1 6771.2 6857.1 6908.5 6957.4 6962.9 6723.7 6798.6 6804.0 6812.3 6812.6 11:11:27 INFO - PID 1158 | 11:11:27 INFO - PID 1158 | [#1] ext.html Cycles:180 Average:45867.27 Median:3881.32 stddev:72083.58 (1857.2%) stddev-sans-first:72206.93 11:11:27 INFO - PID 1158 | Values: 958.3 982.8 991.8 1022.9 1035.6 45248.1 45743.5 45968.3 46071.5 46101.3 42899.6 43261.0 43275.0 43321.1 43350.8 8027.6 8032.5 8065.9 8092.2 8115.0 8099.8 8141.8 8188.2 8189.3 8201.0 8156.6 8163.8 8221.2 8874.9 9045.1 8948.3 9010.1 9014.8 9017.9 9028.5 8813.8 8908.2 8913.3 8943.8 8944.4 41701.4 41901.8 42011.2 42052.4 42070.4 3816.6 3877.8 3879.1 3883.5 3883.8 34698.8 34703.3 34800.5 34801.1 34852.8 5420.6 5649.9 5706.2 5712.1 5729.4 229902.0 230427.0 231326.0 231402.0 231519.0 51337.7 51588.0 51737.7 51785.5 51789.5 60652.4 61033.7 61251.1 61365.7 61392.7 18851.1 18891.6 18892.4 18917.6 18957.8 15683.9 15688.5 15698.1 15705.1 15729.9 15690.8 15803.2 15803.2 15912.8 15915.5 6058.8 6126.1 6189.8 6206.5 6294.1 1078.8 1114.9 1118.2 1119.8 1124.3 26878.2 26931.5 26941.0 27086.2 27212.7 1220.0 1246.2 1251.0 1251.4 1255.9 14067.2 14192.2 14342.9 14447.3 14557.4 307699.0 311197.0 319615.0 322832.0 338031.0 56459.2 56565.2 56851.7 57012.1 57137.1 1513.1 1527.4 1531.0 1537.3 1564.4 31614.8 31839.8 32141.4 32348.5 32797.8 43647.6 43912.6 43976.8 44001.6 44015.6 270368.0 272344.0 272625.0 272989.0 273388.0 37214.6 38971.2 39205.0 39208.0 39214.2 46451.8 48252.8 48256.3 48346.5 48593.5 35431.8 35651.5 36067.8 36209.0 36372.8 35456.0 35487.3 35761.5 35987.0 36497.6 41117.2 41894.0 41912.4 41981.2 42070.8 34507.1 34931.1 35183.8 35362.5 35761.0 25787.6 25993.2 26308.3 26347.2 26725.1 11:11:27 INFO - PID 1158 | 11:11:27 INFO - PID 1158 | [#2] jquery.html Cycles:180 Average:42666.38 Median:12442.01 stddev:106024.23 (852.1%) stddev-sans-first:106274.72 11:11:27 INFO - PID 1158 | Values: 649.5 650.6 651.2 652.0 655.4 24186.4 24658.3 24863.0 24899.3 24946.9 26151.1 26439.5 26500.1 26507.1 26536.3 6501.4 6704.8 6873.0 6894.3 6905.8 6821.0 6907.6 6919.4 6919.9 6932.2 6494.5 6718.8 6725.0 6856.0 6884.7 6730.8 6740.7 6753.2 6754.5 6765.7 6256.3 6286.3 6343.0 6344.6 6362.8 29659.7 30237.0 30814.0 30848.0 30916.8 2262.3 2307.5 2310.9 2311.7 2316.2 20463.7 21103.9 21123.5 21137.7 21144.0 2544.6 2564.5 2616.9 2624.8 2645.9 141529.0 148396.0 169300.0 175666.0 175823.0 22085.4 22497.9 23613.7 23892.0 24606.5 49559.3 49629.0 49658.8 49742.8 49847.5 13083.7 13289.0 13432.7 13592.8 13634.5 11066.9 11136.9 11153.2 11162.7 11350.3 12189.5 12581.7 12707.7 12777.7 13067.3 4386.0 4391.3 4412.7 4527.6 4689.4 1051.8 1060.9 1078.2 1084.4 1090.2 21727.6 21857.6 22132.3 22331.0 22408.9 1133.1 1145.4 1150.6 1156.8 1166.5 11730.9 12222.4 12273.9 12282.3 12288.5 607467.0 628707.0 634863.0 640358.0 651184.0 136217.0 138934.0 142872.3 142875.0 143753.0 1284.9 1305.3 1329.9 1355.6 1378.3 22161.0 22519.0 22619.9 22621.8 22711.8 65338.7 65390.0 65639.0 65945.0 66765.3 81412.6 81618.6 81994.0 82323.6 82888.6 16185.0 16324.7 16370.6 16450.6 16605.6 24363.5 24428.4 24553.4 24569.3 24694.6 20033.4 20306.8 20348.8 20387.2 20445.9 17709.4 17896.6 17988.4 18101.8 18162.7 20405.3 20440.8 20486.4 20577.0 20635.3 16041.1 16057.8 16148.1 16224.4 16265.1 19759.3 19882.8 19953.9 20046.6 20113.9 11:11:27 INFO - PID 1158 | 11:11:27 INFO - PID 1158 | [#3] mootools.html Cycles:180 Average:11081.24 Median:23912.16 stddev:8194.11 (34.3%) stddev-sans-first:8184.08 11:11:27 INFO - PID 1158 | Values: 1291.5 1351.9 1359.8 1428.6 1466.3 17879.1 18354.1 18451.7 18463.7 18472.0 17091.5 17201.0 17215.4 17277.6 17311.7 3021.3 3078.9 3113.6 3115.2 3119.5 3015.3 3036.8 3059.3 3065.4 3067.0 2942.1 2980.5 3114.3 3122.6 3123.7 3062.4 3118.2 3128.1 3129.0 3129.3 2922.4 2928.8 2959.6 2965.1 2968.9 17494.4 17525.2 17701.6 17710.4 17713.5 8909.6 9087.7 9255.1 9276.8 9299.0 5761.2 5999.6 6136.0 6145.7 6179.9 2006.7 2030.3 2057.1 2079.2 2114.3 31927.5 31970.2 32006.7 32046.0 32251.2 7453.7 7528.9 7532.4 7740.5 7798.2 19944.1 20058.8 20065.3 20077.3 20142.5 8897.7 9027.0 9031.7 9041.4 9062.3 8269.8 8272.0 8324.0 8360.4 8451.9 6020.0 6185.9 6188.4 6231.1 6233.4 1641.6 1657.8 1721.0 1724.0 1795.5 968.7 986.7 997.3 1003.6 1022.8 10337.2 10428.9 10589.8 10684.6 10802.4 1068.4 1101.3 1122.6 1126.4 1137.1 5708.1 5767.4 5834.9 5940.7 6298.8 26747.7 27332.0 27335.0 27753.9 27809.7 25993.3 26389.7 26465.5 26668.6 26720.6 13146.7 13148.4 13302.2 13350.6 13354.7 10179.8 10229.8 10275.6 10481.7 10601.0 22367.0 23100.5 23155.0 23296.5 23643.2 23187.8 23256.1 23278.5 23280.8 24181.2 12912.4 13010.2 13050.3 13114.4 13188.5 15905.8 16147.1 16252.3 16255.2 16280.8 13169.7 13692.4 13783.4 13848.2 13856.1 13022.7 13055.9 13133.5 13243.1 13421.7 10680.6 11276.1 11326.5 11349.3 11351.6 8332.7 8345.8 8444.8 8470.5 8558.0 8499.6 8557.4 8588.8 8712.7 8757.1 11:11:27 INFO - PID 1158 | 11:11:27 INFO - PID 1158 | [#4] prototype.html Cycles:180 Average:5850.38 Median:6404.23 stddev:1588.52 (24.8%) stddev-sans-first:1542.72 11:11:27 INFO - PID 1158 | Values: 569.1 577.0 583.9 607.8 618.1 6195.9 6358.0 6363.1 6365.2 6376.4 6243.9 6258.2 6262.7 6297.5 6329.1 5144.7 5177.6 5210.7 5224.0 5230.8 4924.7 5059.6 5075.8 5122.8 5209.4 5038.2 5063.6 5071.8 5078.2 5090.9 4978.7 5004.8 5020.9 5046.1 5059.9 4614.5 4632.4 4653.3 4667.8 4677.3 6291.8 6342.1 6356.9 6377.0 6379.8 5983.4 6001.9 6064.3 6064.7 6083.8 6705.2 6711.3 6810.1 6868.3 6877.7 4943.2 5210.5 5239.3 5249.9 5265.0 6861.2 6989.7 7150.3 7190.0 7238.9 5718.5 5764.1 5850.0 5867.0 5898.8 5924.3 5955.5 5961.2 5985.7 5990.6 6347.7 6366.4 6404.2 6404.3 6406.6 6725.3 6758.3 6825.7 6886.2 6954.4 2017.2 2020.7 2030.6 2035.4 2039.2 1521.5 1566.8 1567.1 1571.4 1574.3 6299.3 6357.5 6467.8 6471.3 6518.9 6759.4 6769.3 6819.9 6839.8 6871.2 6400.4 6469.4 6475.7 6509.2 6546.8 3638.6 3659.9 3665.8 3671.7 3681.7 7225.4 7265.3 7272.8 7306.5 7350.2 7082.3 7093.6 7105.1 7112.4 7145.5 7201.5 7258.9 7291.9 7310.3 7352.0 6839.9 6878.9 6889.8 6890.5 6905.3 6813.9 6826.5 6889.4 6908.7 6944.0 7193.6 7199.2 7272.2 7274.9 7289.4 5831.3 5860.5 5870.7 5882.0 5886.4 6543.2 6661.0 6862.2 6922.8 7035.2 6653.2 6712.2 6730.0 6751.1 6751.6 6562.5 6619.7 6757.7 6764.3 6770.1 6636.0 6665.2 6677.6 6717.8 6786.5 6790.4 6803.6 6812.9 6820.3 6896.7 6641.5 6690.6 6694.0 6709.4 6735.9 11:11:27 INFO - PID 1158 | 11:11:27 INFO - PID 1158 | [#5] yui.html Cycles:180 Average:29240.59 Median:18457.00 stddev:44313.27 (240.1%) stddev-sans-first:44386.83 11:11:27 INFO - PID 1158 | Values: 993.2 1012.7 1026.1 1028.3 1044.8 21577.2 21869.2 21972.7 21985.7 22025.3 20058.8 20117.9 21323.8 21483.4 21495.4 1059.3 1088.2 1089.3 1089.4 1090.5 1043.8 1060.1 1062.5 1094.1 1100.0 1130.4 1137.7 1139.3 1142.5 1146.0 1125.3 1126.5 1129.3 1131.0 1140.9 839.6 840.4 840.7 844.4 845.0 22056.0 22082.4 22368.4 22386.8 22507.2 22864.8 22880.0 23248.1 23332.2 23370.2 18126.8 18356.2 18445.0 18469.0 18521.7 4037.6 4044.2 4061.8 4070.8 4073.1 164347.0 168897.0 169997.0 172159.0 172272.0 18124.6 18368.6 18373.2 18381.9 18425.7 35292.8 35873.0 36245.1 36264.6 36279.8 8990.3 9412.6 9496.4 9584.9 9605.4 5013.4 5013.5 5033.0 5052.9 5066.9 6307.9 6405.1 6410.6 6483.2 6533.3 1168.1 1183.9 1193.0 1197.2 1201.5 765.9 776.2 793.4 798.8 801.1 13076.8 13410.3 13435.0 13490.1 13542.3 754.2 758.8 774.6 776.3 783.9 6282.4 6322.5 6472.4 6493.2 6534.3 150198.0 155258.0 158947.0 159496.0 160144.0 134429.3 136201.0 137828.0 139737.3 144110.0 116041.4 120019.4 120307.0 121232.4 121776.4 11915.8 11949.3 12003.5 12094.2 12145.8 53855.0 54248.7 54702.5 55366.0 55430.7 67625.7 67677.0 68184.0 68186.0 70166.6 17831.4 18363.7 18434.6 18498.8 18631.6 20241.2 20334.0 20358.4 20376.5 20540.2 18335.2 18785.4 18847.2 19097.1 19130.4 16060.8 16310.7 16454.0 16585.3 16606.5 16893.9 17100.7 17102.1 17131.1 17280.4 13856.9 13876.9 14010.9 14034.4 14070.5 12921.9 13134.7 13193.4 13207.0 13242.1 11:11:27 INFO - PID 1158 | -------- Summary: end -------- 11:11:27 INFO - PID 1158 | 11:11:28 INFO - TEST-INFO | 1158: exit 0 11:11:28 INFO - TEST-OK | dromaeo_css | took 1106580ms 11:11:28 INFO - TEST-START | kraken 11:11:28 INFO - Initialising browser for kraken test... 11:11:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59879/getInfo.html -profile /tmp/tmpBMNMTK/profile 11:11:28 INFO - TEST-INFO | started process 1599 (/builds/slave/test/build/application/firefox/firefox http://localhost:59879/getInfo.html) 11:11:32 INFO - TEST-INFO | 1599: exit 0 11:11:32 INFO - Browser initialized. 11:11:32 INFO - Running cycle 1/1 for kraken test... 11:11:32 INFO - Using env: {'DISPLAY': ':0', 11:11:32 INFO - 'HOME': '/home/cltbld', 11:11:32 INFO - 'JSGC_DISABLE_POISONING': '1', 11:11:32 INFO - 'LANG': 'en_US.UTF-8', 11:11:32 INFO - 'LANGUAGE': 'en_US:en', 11:11:32 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:11:32 INFO - 'LOGNAME': 'cltbld', 11:11:32 INFO - 'MAIL': '/var/mail/cltbld', 11:11:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:11:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:11:32 INFO - 'MOZ_CRASHREPORTER': '1', 11:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:32 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:11:32 INFO - 'MOZ_NO_REMOTE': '1', 11:11:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:11:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:32 INFO - 'NO_EM_RESTART': '1', 11:11:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:32 INFO - 'PWD': '/builds/slave/test', 11:11:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:11:32 INFO - 'RUST_BACKTRACE': 'full', 11:11:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:11:32 INFO - 'SHELL': '/bin/bash', 11:11:32 INFO - 'SHLVL': '1', 11:11:32 INFO - 'TERM': 'linux', 11:11:32 INFO - 'TMOUT': '86400', 11:11:32 INFO - 'USER': 'cltbld', 11:11:32 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263', 11:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:32 INFO - '_': '/tools/buildbot/bin/python'} 11:11:32 INFO - TEST-INFO | started process 1790 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBMNMTK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:11:33 INFO - PID 1790 | 11:11:33 INFO - PID 1790 | (/builds/slave/test/build/application/firefox/firefox:1839): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:11:33 INFO - PID 1790 | 11:11:43 INFO - PID 1790 | RSS: Main: 143630336 11:11:43 INFO - PID 1790 | 11:11:46 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:59879/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59879/tests/kraken/driver.html?testName=audio-beat-detection) 11:11:47 INFO - PID 1790 | RSS: Main: 149266432 11:11:47 INFO - PID 1790 | 11:11:49 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:59879/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59879/tests/kraken/driver.html?testName=audio-dft) 11:11:50 INFO - PID 1790 | RSS: Main: 149684224 11:11:50 INFO - PID 1790 | 11:11:53 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:59879/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59879/tests/kraken/driver.html?testName=audio-fft) 11:11:54 INFO - PID 1790 | RSS: Main: 151535616 11:11:54 INFO - PID 1790 | 11:11:56 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:59879/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59879/tests/kraken/driver.html?testName=audio-oscillator) 11:11:56 INFO - PID 1790 | RSS: Main: 151101440 11:11:56 INFO - PID 1790 | 11:11:58 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:59879/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59879/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:11:59 INFO - PID 1790 | RSS: Main: 150925312 11:11:59 INFO - PID 1790 | 11:12:02 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:59879/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59879/tests/kraken/driver.html?testName=imaging-darkroom) 11:12:03 INFO - PID 1790 | RSS: Main: 150978560 11:12:03 INFO - PID 1790 | 11:12:06 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:59879/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59879/tests/kraken/driver.html?testName=imaging-desaturate) 11:12:07 INFO - PID 1790 | RSS: Main: 154030080 11:12:07 INFO - PID 1790 | 11:12:10 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:59879/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59879/tests/kraken/driver.html?testName=json-parse-financial) 11:12:10 INFO - PID 1790 | RSS: Main: 153722880 11:12:10 INFO - PID 1790 | 11:12:12 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:59879/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59879/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:12:12 INFO - PID 1790 | RSS: Main: 154095616 11:12:12 INFO - PID 1790 | 11:12:14 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:59879/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59879/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:12:14 INFO - PID 1790 | RSS: Main: 153636864 11:12:14 INFO - PID 1790 | 11:12:16 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:59879/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59879/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:12:17 INFO - PID 1790 | RSS: Main: 150126592 11:12:17 INFO - PID 1790 | 11:12:19 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:59879/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59879/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:12:20 INFO - PID 1790 | RSS: Main: 150380544 11:12:20 INFO - PID 1790 | 11:12:23 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:59879/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59879/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:12:23 INFO - PID 1790 | RSS: Main: 150740992 11:12:23 INFO - PID 1790 | 11:12:25 INFO - PID 1790 | Cycle 1(1): loaded http://localhost:59879/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59879/tests/kraken/driver.html?testName=ai-astar) 11:12:25 INFO - PID 1790 | RSS: Main: 152637440 11:12:25 INFO - PID 1790 | 11:12:25 INFO - PID 1790 | __start_tp_report 11:12:25 INFO - PID 1790 | _x_x_mozilla_page_load 11:12:25 INFO - PID 1790 | _x_x_mozilla_page_load_details 11:12:25 INFO - PID 1790 | |i|pagename|runs| 11:12:25 INFO - PID 1790 | |0;ai-astar;105;106;104;104;105;105;112;105;107;106 11:12:25 INFO - PID 1790 | |1;audio-beat-detection;120;109;111;111;112;114;112;114;115;137 11:12:25 INFO - PID 1790 | |2;audio-dft;175;177;173;174;175;174;177;172;176;174 11:12:25 INFO - PID 1790 | |3;audio-fft;75;74;72;72;76;73;74;73;73;75 11:12:25 INFO - PID 1790 | |4;audio-oscillator;79;79;77;77;76;78;78;78;78;77 11:12:25 INFO - PID 1790 | |5;imaging-gaussian-blur;118;113;114;114;115;115;110;114;113;121 11:12:25 INFO - PID 1790 | |6;imaging-darkroom;148;150;148;149;149;150;149;148;149;149 11:12:25 INFO - PID 1790 | |7;imaging-desaturate;95;95;95;95;94;95;94;95;94;95 11:12:25 INFO - PID 1790 | |8;json-parse-financial;44;45;42;43;45;44;45;45;47;44 11:12:25 INFO - PID 1790 | |9;json-stringify-tinderbox;40;39;38;39;38;39;38;38;38;39 11:12:25 INFO - PID 1790 | |10;stanford-crypto-aes;68;69;69;72;69;68;69;73;70;68 11:12:25 INFO - PID 1790 | |11;stanford-crypto-ccm;101;104;101;102;104;110;106;104;101;109 11:12:25 INFO - PID 1790 | |12;stanford-crypto-pbkdf2;153;150;148;144;158;145;157;148;148;151 11:12:25 INFO - PID 1790 | |13;stanford-crypto-sha256-iterative;68;57;61;59;59;58;58;57;61;61 11:12:25 INFO - PID 1790 | __end_tp_report 11:12:25 INFO - PID 1790 | __start_cc_report 11:12:25 INFO - PID 1790 | _x_x_mozilla_cycle_collect,679 11:12:25 INFO - PID 1790 | __end_cc_report 11:12:25 INFO - PID 1790 | __startTimestamp1506622345603__endTimestamp 11:12:25 INFO - PID 1790 | 11:12:25 INFO - PID 1790 | ------- Summary: start ------- 11:12:25 INFO - PID 1790 | Number of tests: 14 11:12:25 INFO - PID 1790 | 11:12:25 INFO - PID 1790 | [#0] ai-astar Cycles:10 Average:105.90 Median:105.50 stddev:2.33 (2.2%) stddev-sans-first:2.45 11:12:25 INFO - PID 1790 | Values: 105.0 106.0 104.0 104.0 105.0 105.0 112.0 105.0 107.0 106.0 11:12:25 INFO - PID 1790 | 11:12:25 INFO - PID 1790 | [#1] audio-beat-detection Cycles:10 Average:115.50 Median:114.00 stddev:8.13 (7.1%) stddev-sans-first:8.46 11:12:25 INFO - PID 1790 | Values: 120.0 109.0 111.0 111.0 112.0 114.0 112.0 114.0 115.0 137.0 11:12:25 INFO - PID 1790 | 11:12:25 INFO - PID 1790 | [#2] audio-dft Cycles:10 Average:174.70 Median:175.00 stddev:1.64 (0.9%) stddev-sans-first:1.73 11:12:25 INFO - PID 1790 | Values: 175.0 177.0 173.0 174.0 175.0 174.0 177.0 172.0 176.0 174.0 11:12:25 INFO - PID 1790 | 11:12:25 INFO - PID 1790 | [#3] audio-fft Cycles:10 Average:73.70 Median:74.00 stddev:1.34 (1.8%) stddev-sans-first:1.33 11:12:25 INFO - PID 1790 | Values: 75.0 74.0 72.0 72.0 76.0 73.0 74.0 73.0 73.0 75.0 11:12:25 INFO - PID 1790 | 11:12:25 INFO - PID 1790 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:78.00 stddev:0.95 (1.2%) stddev-sans-first:0.88 11:12:25 INFO - PID 1790 | Values: 79.0 79.0 77.0 77.0 76.0 78.0 78.0 78.0 78.0 77.0 11:12:25 INFO - PID 1790 | 11:12:25 INFO - PID 1790 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.50 stddev:2.98 (2.6%) stddev-sans-first:2.92 11:12:25 INFO - PID 1790 | Values: 118.0 113.0 114.0 114.0 115.0 115.0 110.0 114.0 113.0 121.0 11:12:25 INFO - PID 1790 | 11:12:25 INFO - PID 1790 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 11:12:25 INFO - PID 1790 | Values: 148.0 150.0 148.0 149.0 149.0 150.0 149.0 148.0 149.0 149.0 11:12:25 INFO - PID 1790 | 11:12:25 INFO - PID 1790 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:12:25 INFO - PID 1790 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 95.0 11:12:25 INFO - PID 1790 | 11:12:25 INFO - PID 1790 | [#8] json-parse-financial Cycles:10 Average:44.40 Median:45.00 stddev:1.35 (3.0%) stddev-sans-first:1.42 11:12:25 INFO - PID 1790 | Values: 44.0 45.0 42.0 43.0 45.0 44.0 45.0 45.0 47.0 44.0 11:12:25 INFO - PID 1790 | 11:12:25 INFO - PID 1790 | [#9] json-stringify-tinderbox Cycles:10 Average:38.60 Median:39.00 stddev:0.70 (1.8%) stddev-sans-first:0.53 11:12:25 INFO - PID 1790 | Values: 40.0 39.0 38.0 39.0 38.0 39.0 38.0 38.0 38.0 39.0 11:12:25 INFO - PID 1790 | 11:12:25 INFO - PID 1790 | [#10] stanford-crypto-aes Cycles:10 Average:69.50 Median:69.00 stddev:1.72 (2.5%) stddev-sans-first:1.73 11:12:25 INFO - PID 1790 | Values: 68.0 69.0 69.0 72.0 69.0 68.0 69.0 73.0 70.0 68.0 11:12:25 INFO - PID 1790 | 11:12:25 INFO - PID 1790 | [#11] stanford-crypto-ccm Cycles:10 Average:104.20 Median:104.00 stddev:3.26 (3.1%) stddev-sans-first:3.24 11:12:25 INFO - PID 1790 | Values: 101.0 104.0 101.0 102.0 104.0 110.0 106.0 104.0 101.0 109.0 11:12:25 INFO - PID 1790 | 11:12:25 INFO - PID 1790 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.20 Median:150.50 stddev:4.66 (3.1%) stddev-sans-first:4.83 11:12:25 INFO - PID 1790 | Values: 153.0 150.0 148.0 144.0 158.0 145.0 157.0 148.0 148.0 151.0 11:12:25 INFO - PID 1790 | 11:12:25 INFO - PID 1790 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.90 Median:60.00 stddev:3.25 (5.4%) stddev-sans-first:1.66 11:12:25 INFO - PID 1790 | Values: 68.0 57.0 61.0 59.0 59.0 58.0 58.0 57.0 61.0 61.0 11:12:25 INFO - PID 1790 | -------- Summary: end -------- 11:12:25 INFO - PID 1790 | 11:12:25 INFO - PID 1790 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:12:26 INFO - TEST-INFO | 1790: exit 0 11:12:26 INFO - TEST-OK | kraken | took 57742ms 11:12:26 INFO - SUITE-END | took 1164s 11:12:26 INFO - Completed test suite (00:19:24) 11:12:26 INFO - javascript benchmark 11:12:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9548.2749308889, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3927.4108883667445, 3979.621935916087, 3984.8804535863933, 3996.940045899312, 3998.040470287131, 6497.5126865485045, 6526.902096468551, 6542.37847404497, 6584.6707664616815, 6605.438537724299, 6520.70656820443, 6523.151990241274, 6595.175603049619, 6610.008498725194, 6620.437262832665, 5758.395368486312, 5841.948449279139, 5850.912236316459, 5900.409959004108, 5937.732802023897, 5749.827505174831, 5861.062230043194, 5865.853353666171, 5918.230630018092, 5965.373635768247, 5834.620749651259, 5926.0, 5932.88134237315, 5940.2277703898435, 5945.464908158265, 5846.0, 5852.619579727326, 5866.2960444746905, 5919.993601087804, 5935.990881550147, 5685.45988131131, 5727.083666613364, 5811.070228763378, 5817.301923769175, 5819.738111784937, 6461.547691661585, 6499.675016249169, 6513.902291465632, 6519.771807986745, 6596.208454985384, 7097.751578694772, 7105.964470177668, 7190.06529151207, 7191.280871912819, 7203.279672032807, 6940.479464040217, 7128.6079265640365, 7134.92865071353, 7171.13946326439, 7205.92794072063, 6537.444317233041, 6565.113709649232, 6566.868662626768, 6567.54027218095, 6610.438112760373, 7178.425725941912, 7178.9949407082, 7247.60138192394, 7253.854922901618, 7300.342969132804, 6888.758893438706, 6909.75815846453, 6916.585004899622, 6992.4406047517095, 7001.404880585105, 7062.646867656596, 7150.10623672041, 7161.391281741006, 7175.103112110986, 7188.964055179691, 6962.164540255202, 7064.7174113035935, 7150.356467917913, 7160.462965277625, 7168.139823221247, 6984.301569843076, 7023.367896889305, 7048.929510704827, 7129.0, 7135.678894449762, 5276.314079169761, 5279.709615971158, 5280.419153893069, 5298.549623282064, 5319.414864364917, 4755.096531658974, 4772.928406073912, 4778.020505796303, 4796.880077998078, 4822.517748225149, 6582.308857569982, 6609.735610575523, 6677.131972843499, 6683.064370988066, 6690.19717633887, 6613.941769316983, 7031.8593628127155, 7146.964265178744, 7151.642417879085, 7159.176694680178, 6615.933840661628, 6635.469162466991, 6658.733650654017, 6699.5310328276555, 6700.798976030727, 5922.703864806743, 5929.940700592939, 5988.341282458926, 6000.369961154103, 6012.038073908154, 7286.162091359562, 7361.0, 7373.483856130019, 7375.668094935633, 7381.963090184622, 7035.155781306378, 7045.471589630695, 7047.1895731989425, 7052.506324557232, 7053.858922821412, 7294.197638259893, 7395.852082958203, 7474.3646790021285, 7482.176960534446, 7555.584442855696, 6916.031755554327, 6921.861562768817, 6980.95285707148, 7006.614636195059, 7047.788566343018, 7024.929750702428, 7041.577505349491, 7045.26024767392, 7130.215676275502, 7144.607046612278, 6746.156730408699, 6821.556598821061, 6857.177138743383, 6921.550099243533, 6936.34104760047, 6807.591544507345, 6852.280510546321, 6880.105586273752, 6885.655717214219, 6895.275996020547, 6734.393904548614, 6739.292374300824, 6741.325867413416, 6823.965880170567, 6825.146856642919, 6771.187457505131, 6857.074294970314, 6908.516403851682, 6957.443404527525, 6962.930370696431, 6723.7310507581105, 6798.592084474947, 6804.013418054454, 6812.318768123347, 6812.557183783038], "value": 6484.862316815403, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [958.3195930889068, 982.8132654795593, 991.8462638291065, 1022.9283950123493, 1035.6219979707405, 45248.09503809926, 45743.542564574345, 45968.3104753429, 46071.53928460714, 46101.30848037274, 42899.571004289945, 43261.0, 43275.0, 43321.13357732844, 43350.78324608372, 8027.638756255953, 8032.477888937229, 8065.879011814827, 8092.190780921919, 8114.9594252028655, 8099.797505062362, 8141.837163256731, 8188.222118898725, 8189.344852411822, 8201.0, 8156.632951517196, 8163.755087347389, 8221.218984196492, 8874.86687699685, 9045.05026972165, 8948.284137269004, 9010.14403631654, 9014.819703605957, 9017.864732029026, 9028.548572571379, 8813.823723525558, 8908.198262156373, 8913.331500137516, 8943.776405589848, 8944.418612790148, 41701.37447938283, 41901.79049104766, 42011.1597768046, 42052.36921446181, 42070.36894446586, 3816.637419445148, 3877.8254978526033, 3879.1271963807917, 3883.514560679915, 3883.76697398157, 34698.826505867306, 34703.30593388118, 34800.47799283013, 34801.12997175091, 34852.82573587141, 5420.620556561043, 5649.8587535311535, 5706.201131841545, 5712.0860662293835, 5729.369769325371, 229902.0, 230427.0, 231326.0, 231402.0, 231519.0, 51337.74331128395, 51588.0, 51737.741311293954, 51785.48214517882, 51789.48210517922, 60652.393476065554, 61033.69483152556, 61251.08123378153, 61365.69317153386, 61392.69303653543, 18851.05744712759, 18891.622167556572, 18892.433227003214, 18917.62164756697, 18957.81042189588, 15683.921580392025, 15688.529344119695, 15698.136602486744, 15705.136217507918, 15729.921350393175, 15690.76463853043, 15803.20983950798, 15803.20983950798, 15912.840871591136, 15915.522534323989, 6058.757649693963, 6126.05046217828, 6189.81430557084, 6206.503479721611, 6294.087357333161, 1078.805814953316, 1114.8606424196976, 1118.2395970739813, 1119.8152304869768, 1124.3310230412892, 26878.193654190407, 26931.461370772475, 26940.965474519006, 27086.1874143776, 27212.727872721414, 1219.9817002744967, 1246.1775228349245, 1251.0429521415942, 1251.355551890777, 1255.9058070644555, 14067.226302553458, 14192.219427931357, 14342.85657143436, 14447.349869255908, 14557.41770329175, 307699.0, 311197.0, 319615.0, 322832.0, 338031.0, 56459.153112703345, 56565.15152272719, 56851.71574142185, 57012.144817827764, 57137.14294285589, 1513.1450730337324, 1527.3814105287154, 1530.984690153084, 1537.2774795845935, 1564.4211641692418, 31614.841925790224, 31839.840800795846, 32141.357172855944, 32348.514772277966, 32797.836010819796, 43647.56352436562, 43912.560874390845, 43976.78011609922, 44001.55998439975, 44015.55984440115, 270368.0, 272344.0, 272625.0, 272989.0, 273388.0, 37214.62785372112, 38971.22057558889, 39205.0, 39208.0, 39214.2157156861, 46451.76774116108, 48252.758736206095, 48256.27615585699, 48346.51653483561, 48593.5140648589, 35431.82284088563, 35651.46522802108, 36067.81966090153, 36209.0, 36372.818135909154, 35456.0, 35487.290254195286, 35761.46357804583, 35987.0, 36497.635023649425, 41117.177656447304, 41894.0, 41912.3713144297, 41981.160376792905, 42070.7896460528, 34507.10210938423, 34931.12672183216, 35183.82408087943, 35362.46956295709, 35761.0, 25787.613185801853, 25993.22020339393, 26308.342291442867, 26347.20958371252, 26725.06462273889], "value": 19575.272313083973, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.5175577348938, 650.636772366258, 651.2131952695079, 651.9595943582707, 655.4339759840223, 24186.395340116505, 24658.260252192416, 24863.0, 24899.253022409357, 24946.87526562369, 26151.08471203508, 26439.471210575775, 26500.072497462592, 26507.072252471167, 26536.33659158522, 6501.414872661459, 6704.765333213339, 6873.0, 6894.310568943116, 6905.827354316132, 6820.965895170517, 6907.585544867299, 6919.411849992756, 6919.861602767942, 6932.23745388007, 6494.51291153163, 6718.832029199285, 6724.966375168117, 6856.00587914752, 6884.690188941485, 6730.764423245188, 6740.662966851687, 6753.223379311368, 6754.527183097161, 6765.695543700496, 6256.343083976162, 6286.339934306923, 6343.0, 6344.555881088326, 6362.77730279438, 29659.703402966126, 30237.0, 30814.0, 30848.0, 30916.845415773, 2262.2534563593977, 2307.5384923015295, 2310.8844557772213, 2311.722593288816, 2316.2009106858277, 20463.693044604344, 21103.89448052765, 21123.47191320214, 21137.68293475599, 21144.0, 2544.631028500857, 2564.5383830910428, 2616.856072915989, 2624.7637712605765, 2645.8809353579136, 141529.0, 148396.0, 169300.0, 175666.0, 175823.0, 22085.447863803533, 22497.88751056234, 23613.70124643161, 23892.0, 24606.507869842502, 49559.256611150864, 49629.0, 49658.75170624124, 49742.75128624406, 49847.50152498428, 13083.672908177181, 13289.0, 13432.723891230318, 13592.796108058386, 13634.522791702242, 11066.889331106586, 11136.944315278533, 11153.163512736577, 11162.720931976766, 11350.318980861175, 12189.512419503299, 12581.74836503283, 12707.745845083231, 12777.744445111046, 13067.281299528428, 4386.0, 4391.275439552438, 4412.683341245872, 4527.569880861313, 4689.366935463737, 1051.831706926888, 1060.8966674658423, 1078.245228340165, 1084.4089970965842, 1090.155129774431, 21727.565448690937, 21857.562848742935, 22132.336029918806, 22331.0, 22408.887955560444, 1133.0935251798528, 1145.398665700514, 1150.5742875136252, 1156.8322593223936, 1166.5158959031908, 11730.941345293219, 12222.388880555936, 12273.877261227452, 12282.263064215997, 12288.508459661693, 607467.0, 628707.0, 634863.0, 640358.0, 651184.0, 136217.0, 138934.0, 142872.28563857113, 142875.0, 143753.0, 1284.9421776020101, 1305.3277562055548, 1329.8736620021082, 1355.6204262806627, 1378.3246209357342, 22161.002754875746, 22519.0, 22619.88690056539, 22621.773782261967, 22711.772882271627, 65338.673306633165, 65389.999999998094, 65639.0, 65945.0, 66765.33234667592, 81412.59293703493, 81618.59190704009, 81994.0, 82323.5883820577, 82888.58555707183, 16185.0, 16324.673506529565, 16370.590735231715, 16450.588735281715, 16605.58486037859, 24363.51272974566, 24428.389290267885, 24553.386165346008, 24569.262922112364, 24694.629580556666, 20033.398998030083, 20306.79693203049, 20348.79651203469, 20387.18451261933, 20445.897770511052, 17709.38017169393, 17896.642067158846, 17988.370407036215, 18101.818981810015, 18162.72755908689, 20405.285814996405, 20440.79559204389, 20486.38540843777, 20577.0, 20635.277765278144, 16041.117738524494, 16057.759133612772, 16148.11185384768, 16224.432144874872, 16265.105419202058, 19759.308424205658, 19882.801171988096, 19953.900230498755, 20046.599068018266, 20113.899430502755], "value": 13956.706951424347, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1291.5415027665179, 1351.8918486521077, 1359.8300212473441, 1428.6356978970362, 1466.3401469338787, 17879.10604469776, 18354.08229588522, 18451.723224151632, 18463.723044154332, 18472.0, 17091.487255382326, 17201.0, 17215.397461088865, 17277.568060798454, 17311.653766924654, 3021.27489402544, 3078.8614512346885, 3113.5796667449945, 3115.1900505868525, 3119.516474946387, 3015.336625942289, 3036.772242081842, 3059.296361836779, 3065.371598822236, 3066.969330306702, 2942.0585412667956, 2980.478416277154, 3114.2525793809436, 3122.594062771848, 3123.687631236881, 3062.418140553299, 3118.220444888755, 3128.077217220914, 3129.04564107947, 3129.342838004022, 2922.3570814420796, 2928.8389138597367, 2959.6004539387122, 2965.1252880400334, 2968.925776855596, 17494.387696430564, 17525.211365488583, 17701.557461063578, 17710.380136695283, 17713.468595942144, 8909.55452227386, 9087.7273681789, 9255.120763527455, 9276.814463710689, 9299.023602521705, 5761.164631128505, 5999.610025348338, 6136.01823708209, 6145.692715364258, 6179.907301390483, 2006.6889632107047, 2030.309694703793, 2057.1360028787794, 2079.178724403867, 2114.260008996854, 31927.52108718371, 31970.200744981328, 32006.679933200834, 32046.0, 32251.19372015695, 7453.726613382862, 7528.924710752932, 7532.43506736986, 7740.496867703581, 7798.1811909749795, 19944.102515386843, 20058.799412005694, 20065.29771457992, 20077.29729459462, 20142.496437589176, 8897.73306800797, 9026.954865225633, 9031.683891063913, 9041.367104302768, 9062.320325975446, 8269.751907442665, 8272.0, 8323.95838020806, 8360.372972027122, 8451.943507061616, 6020.036794112921, 6185.907211391833, 6188.381161883865, 6231.096491008869, 6233.407826256498, 1641.5978085368922, 1657.8342165783324, 1721.0, 1724.0, 1795.4523870219448, 968.6803354892868, 986.6645340584236, 997.3218211616025, 1003.5835128421769, 1022.7903279827766, 10337.173026157889, 10428.895711042944, 10589.788204235872, 10684.572617095384, 10802.351858888493, 1068.3589846092282, 1101.2566517600587, 1122.5846436818429, 1126.4142645824124, 1137.1016896651718, 5708.114779389041, 5767.423257674283, 5834.8541286467325, 5940.732667029907, 6298.811035668938, 26747.732522674523, 27332.0, 27335.0, 27753.861230693718, 27809.72190278071, 25993.310434821677, 26389.73610263911, 26465.470690586466, 26668.59997100045, 26720.599191012152, 13146.671333216555, 13148.408321625358, 13302.201867887958, 13350.599482015556, 13354.666133346744, 10179.847302290324, 10229.84655230187, 10275.588976440858, 10481.737956551147, 10601.0, 22367.0, 23100.537989240456, 23155.0, 23296.53406931818, 23643.172488962802, 23187.768122319234, 23256.069757209523, 23278.534429311658, 23280.76719232786, 24181.15365962183, 12912.354382281037, 13010.154339967872, 13050.282234477196, 13114.409851556893, 13188.472461101832, 15905.8409415909, 16147.111908845127, 16252.268647911109, 16255.187240637684, 16280.755788663417, 13169.670758230737, 13692.383842726902, 13783.448662053806, 13848.238346891017, 13856.099353541988, 13022.674433139247, 13055.934720326337, 13133.474661013835, 13243.139195952232, 13421.731565368442, 10680.57277708883, 11276.097912166842, 11326.546938122712, 11349.262297950607, 11351.602693905674, 8332.708355207538, 8345.791355216168, 8444.831103378021, 8470.49177049379, 8557.957210213908, 8499.617517211616, 8557.44376615518, 8588.785280368042, 8712.738617841474, 8757.080506546721], "value": 7750.076104468068, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.0752527143392, 577.001786908648, 583.9065749480081, 607.8389226854882, 618.0852338538962, 6195.907061394077, 6357.968210158942, 6363.0773537836985, 6365.204349456318, 6376.42612164905, 6243.875122497559, 6258.15254059403, 6262.749490020405, 6297.464715499188, 6329.082283068964, 5144.742762861861, 5177.637565370425, 5210.6613070150315, 5223.973880130594, 5230.843074707765, 4924.655274130812, 5059.62052846038, 5075.847724568269, 5122.769475373617, 5209.400918894337, 5038.2190760432195, 5063.594912406998, 5071.797128114871, 5078.238264260353, 5090.898182036357, 4978.651494395375, 5004.774785134659, 5020.895403011332, 5046.123709485595, 5059.8988020239385, 4614.515475875019, 4632.351470794091, 4653.278741795028, 4667.789949452283, 4677.2750223715375, 6291.842703932392, 6342.112104305401, 6356.9364306357265, 6377.0, 6379.840503987438, 5983.431574000463, 6001.879962400728, 6064.332923378425, 6064.727087281083, 6083.756649734005, 6705.161854768154, 6711.28862140156, 6810.114685090956, 6868.347506986828, 6877.65611719412, 4943.233798761162, 5210.452902445227, 5239.266502689627, 5249.921251181236, 5265.025615394227, 6861.2160838182435, 6989.720411183546, 7150.284971502861, 7189.964050179768, 7238.891416628755, 5718.485336319668, 5764.135379692996, 5849.970750146222, 5866.970665146647, 5898.8230353089475, 5924.348321684612, 5955.464008239279, 5961.225040744762, 5985.700714964234, 5990.580659353891, 6347.682615869188, 6366.363363663597, 6404.1674582304, 6404.295527491972, 6406.615603063831, 6725.327467253333, 6758.290379510179, 6825.69284382204, 6886.208086070066, 6954.40887524556, 2017.213286818142, 2020.7272018277638, 2030.5532782787764, 2035.4300795777206, 2039.21490226261, 1521.4979056911193, 1566.7806507089017, 1567.1145802621481, 1571.3793051744497, 1574.3387777133632, 6299.338569450233, 6357.523185761086, 6467.805965821033, 6471.288158302583, 6518.934810651833, 6759.425448836806, 6769.289224631441, 6819.897701534481, 6839.829004274933, 6871.244163142051, 6400.3599640036555, 6469.353064693493, 6475.740970361227, 6509.177430319518, 6546.836329091716, 3638.6179451157777, 3659.8719044833833, 3665.8350374233223, 3671.6511931367013, 3681.7238707097076, 7225.385842203366, 7265.273472652692, 7272.818179545554, 7306.465642215088, 7350.191478937312, 7082.291770822876, 7093.645317734093, 7105.147382314155, 7112.395446387011, 7145.499815013003, 7201.459890508233, 7258.891116633255, 7291.9270807292305, 7310.268973102648, 7351.963240183765, 6839.871421215643, 6878.931210688029, 6889.793306200822, 6890.483213758888, 6905.309469053054, 6813.863722725617, 6826.464045589702, 6889.448844092561, 6908.654567271717, 6943.993120997528, 7193.568385896863, 7199.172095208908, 7272.163701174432, 7274.927250727425, 7289.4168466523615, 5831.271091113611, 5860.501857342174, 5870.706464676835, 5882.0, 5886.38192989747, 6543.247526534319, 6660.966695166493, 6862.176538815374, 6922.7923162305215, 7035.22612512613, 6653.168353955755, 6712.160979877515, 6730.0, 6751.122354093936, 6751.628660423527, 6562.475001999733, 6619.702113404812, 6757.729690812509, 6764.323567643196, 6770.119884414995, 6636.037774522763, 6665.200175978914, 6677.632730199885, 6717.764878229238, 6786.457083433214, 6790.388865002174, 6803.591784492946, 6812.863742725217, 6820.283870193558, 6896.724056073325, 6641.535092543476, 6690.565113267622, 6694.0, 6709.429698475684, 6735.932640673726], "value": 5410.154433463293, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [993.1756641987151, 1012.6759436980166, 1026.1175389165317, 1028.269928350871, 1044.8171569975252, 21577.24479643213, 21869.234576789815, 21972.670409943825, 21985.67021494675, 22025.33923982281, 20058.799412005876, 20117.899410502927, 21323.786762132375, 21483.355499335004, 21495.355139345844, 1059.3061544688242, 1088.151242031217, 1089.3246187363845, 1089.4226060188114, 1090.5365219781581, 1043.8486419469211, 1060.1095080132686, 1062.5271754069404, 1094.0700404656059, 1099.9725006874853, 1130.3669944830922, 1137.732632831284, 1139.2879450343535, 1142.5486932661593, 1146.0201527693828, 1125.291066628019, 1126.487448211066, 1129.271619805221, 1130.9717257068598, 1140.8973192412682, 839.6263662670053, 840.4033136473112, 840.6511297811401, 844.4342290665269, 844.9873251901226, 22056.0, 22082.4479388015, 22368.440788980242, 22386.776132238796, 22507.212247571257, 22864.77135228643, 22879.970401331815, 23248.140148788058, 23332.183373581844, 23370.182043628392, 18126.81873181278, 18356.173972171284, 18445.0, 18469.0, 18521.722174167397, 4037.6366127048705, 4044.1911617676583, 4061.8375264989363, 4070.837166513336, 4073.083556199861, 164347.0, 168897.0, 169997.0, 172159.0, 172272.0, 18124.63750724978, 18368.63262734738, 18373.17320720571, 18381.908090459463, 18425.723614145798, 35292.823535882155, 35873.0, 36245.09387265339, 36264.637353626655, 36279.81860090682, 8990.28077753778, 9412.576434060484, 9496.382735122195, 9584.856227156599, 9605.37565058269, 5013.423456302499, 5013.473585273567, 5033.043721692867, 5052.898942021139, 5066.923996140061, 6307.905381419282, 6405.135306733531, 6410.61536307823, 6483.189601299838, 6533.281339052701, 1168.0888906652824, 1183.9348835813942, 1192.9582464613698, 1197.1679682620495, 1201.531402752927, 765.9157492675802, 776.1617453150584, 793.4208028139491, 798.7723498802814, 801.1227705662291, 13076.803847942288, 13410.329483525784, 13434.992375571872, 13490.055696101179, 13542.322883855768, 754.1515794730927, 758.8482303539314, 774.5623722596715, 776.3013288040809, 783.9137694853562, 6282.434580887742, 6322.525810564226, 6472.385123413268, 6493.155889734304, 6534.313897040837, 150198.0, 155258.0, 158947.0, 159496.0, 160144.0, 134429.3278533601, 136201.0, 137828.0, 139737.3013134928, 144110.0, 116041.41979290219, 120019.39990299992, 120307.0, 121232.39383803024, 121776.39111804384, 11915.82126268124, 11949.283043017273, 12003.459844307201, 12094.213876098025, 12145.81781273264, 53855.0, 54248.728756355966, 54702.452975469736, 55366.0, 55430.72284638551, 67625.66187169033, 67677.0, 68184.0, 68186.0, 70166.64916675384, 17831.375901843374, 18363.724544132117, 18434.631307374046, 18498.81501185025, 18631.627367452846, 20241.19035238574, 20334.0, 20358.389248322575, 20376.490587735425, 20540.178392864716, 18335.174917128494, 18785.436436906915, 18847.15187816579, 19097.140628671466, 19130.426087217405, 16060.759088613913, 16310.673786524441, 16454.0, 16585.336586536403, 16606.50180494587, 16893.91553042227, 17100.657986839946, 17102.144892755063, 17131.14344282806, 17280.395186168425, 13856.861431385558, 13876.861231387556, 14010.859891400956, 14034.438622454987, 14070.507532236323, 12921.870781292067, 13134.671633208864, 13193.40629671648, 13207.0, 13242.139260948008], "value": 10200.373643750801, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1372.6000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 106.0, 104.0, 104.0, 105.0, 105.0, 112.0, 105.0, 107.0, 106.0], "value": 105.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 109.0, 111.0, 111.0, 112.0, 114.0, 112.0, 114.0, 115.0, 137.0], "value": 115.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 177.0, 173.0, 174.0, 175.0, 174.0, 177.0, 172.0, 176.0, 174.0], "value": 174.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 72.0, 72.0, 76.0, 73.0, 74.0, 73.0, 73.0, 75.0], "value": 73.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 77.0, 77.0, 76.0, 78.0, 78.0, 78.0, 78.0, 77.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 113.0, 114.0, 114.0, 115.0, 115.0, 110.0, 114.0, 113.0, 121.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 148.0, 149.0, 149.0, 150.0, 149.0, 148.0, 149.0, 149.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 45.0, 42.0, 43.0, 45.0, 44.0, 45.0, 45.0, 47.0, 44.0], "value": 44.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [40.0, 39.0, 38.0, 39.0, 38.0, 39.0, 38.0, 38.0, 38.0, 39.0], "value": 38.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 72.0, 69.0, 68.0, 69.0, 73.0, 70.0, 68.0], "value": 69.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 104.0, 101.0, 102.0, 104.0, 110.0, 106.0, 104.0, 101.0, 109.0], "value": 104.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 150.0, 148.0, 144.0, 158.0, 145.0, 157.0, 148.0, 148.0, 151.0], "value": 150.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 57.0, 61.0, 59.0, 59.0, 58.0, 58.0, 57.0, 61.0, 61.0], "value": 59.9, "unit": "score"}]}]} 11:12:26 INFO - Return code: 0 11:12:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:12:26 INFO - # TBPL SUCCESS # 11:12:26 INFO - Running post-action listener: _package_coverage_data 11:12:26 INFO - Running post-action listener: _resource_record_post_action 11:12:26 INFO - [mozharness: 2017-09-28 18:12:26.419418Z] Finished run-tests step (success) 11:12:26 INFO - Running post-run listener: _resource_record_post_run 11:12:26 INFO - Total resource usage - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288280576; Read time: 0; Write time: 173556 11:12:26 INFO - TinderboxPrint: CPU usage
13.0% 11:12:26 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:12:26 INFO - TinderboxPrint: I/O write bytes / time
288,280,576 / 173,556 11:12:26 INFO - TinderboxPrint: CPU idle
8,173.2 (86.9%) 11:12:26 INFO - TinderboxPrint: CPU user
1,178.7 (12.5%) 11:12:26 INFO - TinderboxPrint: Swap in / out
0 / 0 11:12:26 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 1544192; Read time: 0; Write time: 96 11:12:26 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:12:26 INFO - run-tests - Wall time: 1165s; CPU: 13.0%; Read bytes: 0; Write bytes: 286736384; Read time: 0; Write time: 173460 11:12:27 INFO - Running post-run listener: _upload_blobber_files 11:12:27 INFO - Blob upload gear active. 11:12:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:12:27 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 11:12:27 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'] 11:12:27 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 11:12:27 INFO - (blobuploader) - INFO - Open directory for files ... 11:12:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:12:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:12:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:28 INFO - (blobuploader) - INFO - Done attempting. 11:12:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:12:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:12:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:29 INFO - (blobuploader) - INFO - Done attempting. 11:12:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:12:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:12:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:36 INFO - (blobuploader) - INFO - Done attempting. 11:12:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:12:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:12:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:37 INFO - (blobuploader) - INFO - Done attempting. 11:12:37 INFO - (blobuploader) - INFO - Iteration through files over. 11:12:37 INFO - Return code: 0 11:12:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:12:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:12:37 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c1345ad9d29fbbc611325d99f6e760c182c93aa14392aece9a443ad6d50ef6045533faf633b82fc234c7c6b0eb7f18b65c44bf6f344ed28b4f932b9087c4069f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ec928c6303853149c55f04064eaab940595426c33803eb11ee0eab518781f981f6d2696a06227001a28941c24088414af788981a9b2ef4e862cbe7053a232740", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6092c9c89874c141eecf4db083ee5bc48922120880d18e79214ba64d77a362d04207825479e6e2c6a86a9a59db78391cec1a0a7fd1fa3eec4452bad77f37ea88", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3203c933c8874889b59c8f2f653a970b8d494e696921494f737ae140869cac25eb990bfcc49f6ac0bbd71068bfd82c138040049a7fe06b18f040eca28c5cb268"} 11:12:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:12:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:12:37 INFO - Contents: 11:12:37 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c1345ad9d29fbbc611325d99f6e760c182c93aa14392aece9a443ad6d50ef6045533faf633b82fc234c7c6b0eb7f18b65c44bf6f344ed28b4f932b9087c4069f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ec928c6303853149c55f04064eaab940595426c33803eb11ee0eab518781f981f6d2696a06227001a28941c24088414af788981a9b2ef4e862cbe7053a232740", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6092c9c89874c141eecf4db083ee5bc48922120880d18e79214ba64d77a362d04207825479e6e2c6a86a9a59db78391cec1a0a7fd1fa3eec4452bad77f37ea88", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3203c933c8874889b59c8f2f653a970b8d494e696921494f737ae140869cac25eb990bfcc49f6ac0bbd71068bfd82c138040049a7fe06b18f040eca28c5cb268"} 11:12:37 INFO - Running post-run listener: copy_logs_to_upload_dir 11:12:37 INFO - Copying logs to upload dir... 11:12:37 INFO - mkdir: /builds/slave/test/build/upload/logs 11:12:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.546723 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-28 11:12:37.674134) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-28 11:12:37.678410) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263 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/c1345ad9d29fbbc611325d99f6e760c182c93aa14392aece9a443ad6d50ef6045533faf633b82fc234c7c6b0eb7f18b65c44bf6f344ed28b4f932b9087c4069f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ec928c6303853149c55f04064eaab940595426c33803eb11ee0eab518781f981f6d2696a06227001a28941c24088414af788981a9b2ef4e862cbe7053a232740", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6092c9c89874c141eecf4db083ee5bc48922120880d18e79214ba64d77a362d04207825479e6e2c6a86a9a59db78391cec1a0a7fd1fa3eec4452bad77f37ea88", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3203c933c8874889b59c8f2f653a970b8d494e696921494f737ae140869cac25eb990bfcc49f6ac0bbd71068bfd82c138040049a7fe06b18f040eca28c5cb268"} build_url:https://queue.taskcluster.net/v1/task/aJYDI15yQUKmZn7DPjEj8w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011409 build_url: 'https://queue.taskcluster.net/v1/task/aJYDI15yQUKmZn7DPjEj8w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c1345ad9d29fbbc611325d99f6e760c182c93aa14392aece9a443ad6d50ef6045533faf633b82fc234c7c6b0eb7f18b65c44bf6f344ed28b4f932b9087c4069f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ec928c6303853149c55f04064eaab940595426c33803eb11ee0eab518781f981f6d2696a06227001a28941c24088414af788981a9b2ef4e862cbe7053a232740", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6092c9c89874c141eecf4db083ee5bc48922120880d18e79214ba64d77a362d04207825479e6e2c6a86a9a59db78391cec1a0a7fd1fa3eec4452bad77f37ea88", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3203c933c8874889b59c8f2f653a970b8d494e696921494f737ae140869cac25eb990bfcc49f6ac0bbd71068bfd82c138040049a7fe06b18f040eca28c5cb268"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-28 11:12:37.709469) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 11:12:37.709786) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1506620974.633040-676712263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004640 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 11:12:37.791677) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-28 11:12:37.791966) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-28 11:12:37.795258) ========= ========= Total master_lag: 0.21 =========