builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-051 starttime: 1505775506.21 results: success (0) revision: 948dc86aabc97e16d51ad19ea90debab6f93a628 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:26.208441) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:26.208883) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:26.209157) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:26.440268) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:26.440562) ========= 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-1505772765.210758-788889504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-18 15:58:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 108M=0s 2017-09-18 15:58:26 (108 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122740 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:26.597019) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:26.600331) ========= 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-1505772765.210758-788889504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017695 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:26.664233) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:26.664577) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 948dc86aabc97e16d51ad19ea90debab6f93a628 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 948dc86aabc97e16d51ad19ea90debab6f93a628 --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-1505772765.210758-788889504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-18 15:58:26,607 truncating revision to first 12 chars 2017-09-18 15:58:26,607 Setting DEBUG logging. 2017-09-18 15:58:26,607 attempt 1/10 2017-09-18 15:58:26,607 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/948dc86aabc9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-18 15:58:26,871 unpacking tar archive at: mozilla-central-948dc86aabc9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.567648 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:27.255458) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:27.255767) ========= script_repo_revision: 948dc86aabc97e16d51ad19ea90debab6f93a628 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:27.256173) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:27.256454) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:27.270225) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-18 15:58:27.270599) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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-1505772765.210758-788889504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:58:27 INFO - MultiFileLogger online at 20170918 15:58:27 in /builds/slave/test 15:58:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:58:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:58:27 INFO - {'append_to_log': False, 15:58:27 INFO - 'base_work_dir': '/builds/slave/test', 15:58:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:58:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:58:27 INFO - 'branch': 'Firefox-Non-PGO', 15:58:27 INFO - 'buildbot_json_path': 'buildprops.json', 15:58:27 INFO - 'code_coverage': False, 15:58:27 INFO - 'config_files': ('talos/linux_config.py',), 15:58:27 INFO - 'default_actions': ('clobber', 15:58:27 INFO - 'read-buildbot-config', 15:58:27 INFO - 'download-and-extract', 15:58:27 INFO - 'populate-webroot', 15:58:27 INFO - 'create-virtualenv', 15:58:27 INFO - 'install', 15:58:27 INFO - 'setup-mitmproxy', 15:58:27 INFO - 'run-tests'), 15:58:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:58:27 INFO - 'disable_ccov_upload': False, 15:58:27 INFO - 'disable_stylo': False, 15:58:27 INFO - 'download_minidump_stackwalk': True, 15:58:27 INFO - 'download_symbols': 'ondemand', 15:58:27 INFO - 'enable_stylo': False, 15:58:27 INFO - 'enable_webrender': False, 15:58:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:58:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:58:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:58:27 INFO - 'gecko_profile': False, 15:58:27 INFO - 'gecko_profile_interval': 0, 15:58:27 INFO - 'installer_path': 'installer.exe', 15:58:27 INFO - 'log_level': 'info', 15:58:27 INFO - 'log_name': 'talos', 15:58:27 INFO - 'log_to_console': True, 15:58:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:58:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:58:27 INFO - 'opt_config_files': (), 15:58:27 INFO - 'pip_index': False, 15:58:27 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 15:58:27 INFO - 'system_bits': '32', 15:58:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:58:27 INFO - 'title': 'talos-linux64-ix-051', 15:58:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:58:27 INFO - 'use_talos_json': True, 15:58:27 INFO - 'verify': 'False', 15:58:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:58:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:58:27 INFO - 'work_dir': 'build'} 15:58:27 INFO - [mozharness: 2017-09-18 22:58:27.354320Z] Running clobber step. 15:58:27 INFO - Running pre-action listener: _resource_record_pre_action 15:58:27 INFO - Running main action method: clobber 15:58:27 INFO - rmtree: /builds/slave/test/build 15:58:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:58:28 INFO - Running post-action listener: _resource_record_post_action 15:58:28 INFO - [mozharness: 2017-09-18 22:58:28.343153Z] Finished clobber step (success) 15:58:28 INFO - [mozharness: 2017-09-18 22:58:28.343250Z] Running read-buildbot-config step. 15:58:28 INFO - Running pre-action listener: _resource_record_pre_action 15:58:28 INFO - Running main action method: read_buildbot_config 15:58:28 INFO - Using buildbot properties: 15:58:28 INFO - { 15:58:28 INFO - "project": "", 15:58:28 INFO - "product": "firefox", 15:58:28 INFO - "who": "kwierso@gmail.com", 15:58:28 INFO - "installer_path": "public/build/target.tar.bz2", 15:58:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 15:58:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:58:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 15:58:28 INFO - "stage_platform": "linux64", 15:58:28 INFO - "basedir": "/builds/slave/test", 15:58:28 INFO - "buildnumber": 40, 15:58:28 INFO - "platform": "ubuntu64_hw", 15:58:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:58:28 INFO - "slavebuilddir": "test", 15:58:28 INFO - "taskId": "ewjMsJ-QSNyc-d1OFU8yeQ", 15:58:28 INFO - "branch": "mozilla-central", 15:58:28 INFO - "script_repo_revision": "production", 15:58:28 INFO - "revision": "948dc86aabc97e16d51ad19ea90debab6f93a628", 15:58:28 INFO - "slavename": "talos-linux64-ix-051", 15:58:28 INFO - "repo_path": "mozilla-central" 15:58:28 INFO - } 15:58:28 INFO - Finding installer, test and symbols from parent task. 15:58:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ewjMsJ-QSNyc-d1OFU8yeQ'}, attempt #1 15:58:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ewjMsJ-QSNyc-d1OFU8yeQ'}, attempt #1 15:58:29 INFO - Task dependencies: TRftx86zRh69GCHnj0hY_Q 15:58:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q'}, attempt #1 15:58:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.tar.bz2 15:58:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.test_packages.json 15:58:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.crashreporter-symbols.zip 15:58:29 INFO - Running post-action listener: _resource_record_post_action 15:58:29 INFO - [mozharness: 2017-09-18 22:58:29.703304Z] Finished read-buildbot-config step (success) 15:58:29 INFO - [mozharness: 2017-09-18 22:58:29.703520Z] Running download-and-extract step. 15:58:29 INFO - Running pre-action listener: _resource_record_pre_action 15:58:29 INFO - Running main action method: download_and_extract 15:58:29 INFO - mkdir: /builds/slave/test/build/tests 15:58: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')]} 15:58:29 INFO - trying https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.test_packages.json 15:58:29 INFO - Downloading https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:58:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:58:30 INFO - Downloaded 989 bytes. 15:58:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:58:30 INFO - Using the following test package requirements: 15:58:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:58:30 INFO - u'common': [u'target.common.tests.zip'], 15:58:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:58:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:58:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:58:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:58:30 INFO - u'mozbase': [u'target.common.tests.zip'], 15:58:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:58:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:58:30 INFO - u'web-platform': [u'target.common.tests.zip', 15:58:30 INFO - u'target.web-platform.tests.tar.gz'], 15:58:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:58:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:58:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.common.tests.zip 15:58:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:58:30 INFO - Fetch https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.common.tests.zip into memory 15:58:34 INFO - Content-Length response header: 54731251 15:58:34 INFO - Bytes received: 54731251 15:58:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.talos.tests.zip 15:58:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:58:45 INFO - Fetch https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.talos.tests.zip into memory 15:58:46 INFO - Content-Length response header: 14508748 15:58:46 INFO - Bytes received: 14508748 15:58: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')]} 15:58:46 INFO - trying https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.tar.bz2 15:58:46 INFO - Downloading https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:58:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:58:51 INFO - Downloaded 61376718 bytes. 15:58:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.tar.bz2 15:58:51 INFO - mkdir: /builds/slave/test/properties 15:58:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:58:51 INFO - Writing to file /builds/slave/test/properties/build_url 15:58:51 INFO - Contents: 15:58:51 INFO - build_url:https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.tar.bz2 15:58:51 INFO - Running post-action listener: _resource_record_post_action 15:58:51 INFO - Running post-action listener: find_tests_for_verification 15:58:51 INFO - Running post-action listener: set_extra_try_arguments 15:58:51 INFO - [mozharness: 2017-09-18 22:58:51.422370Z] Finished download-and-extract step (success) 15:58:51 INFO - [mozharness: 2017-09-18 22:58:51.422597Z] Running populate-webroot step. 15:58:51 INFO - Running pre-action listener: _resource_record_pre_action 15:58:51 INFO - Running main action method: populate_webroot 15:58:51 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:58:51 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['tresize', 15:58:51 INFO - 'tcanvasmark']}, 15:58:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:58:51 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['dromaeo_css', 15:58:51 INFO - 'kraken']}, 15:58:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:58:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:58:51 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:58:51 INFO - 'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:58:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:58:51 INFO - 'tests': ['damp', 'tps']}, 15:58:51 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:58:51 INFO - 'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['damp', 'tps']}, 15:58:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:58:51 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['dromaeo_dom']}, 15:58:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:58:51 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['basic_compositor_video', 15:58:51 INFO - 'glvideo']}, 15:58:51 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:58:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:58:51 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:58:51 INFO - 'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['ts_paint_webext', 15:58:51 INFO - 'tp5o_webext']}, 15:58:51 INFO - 'other-e10s': {'tests': ['a11yr', 15:58:51 INFO - 'ts_paint', 15:58:51 INFO - 'tpaint', 15:58:51 INFO - 'sessionrestore', 15:58:51 INFO - 'sessionrestore_many_windows', 15:58:51 INFO - 'sessionrestore_no_auto_restore', 15:58:51 INFO - 'tabpaint']}, 15:58:51 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['a11yr', 15:58:51 INFO - 'ts_paint', 15:58:51 INFO - 'tpaint', 15:58:51 INFO - 'sessionrestore', 15:58:51 INFO - 'sessionrestore_many_windows', 15:58:51 INFO - 'sessionrestore_no_auto_restore', 15:58:51 INFO - 'tabpaint']}, 15:58:51 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:58:51 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 15:58:51 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['perf_reftest_singletons']}, 15:58:51 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['bloom_basic']}, 15:58:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:58:51 INFO - 'tsvgr_opacity', 15:58:51 INFO - 'tart', 15:58:51 INFO - 'tscrollx', 15:58:51 INFO - 'tsvg_static']}, 15:58:51 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['tsvgx', 15:58:51 INFO - 'tsvgr_opacity', 15:58:51 INFO - 'tart', 15:58:51 INFO - 'tscrollx', 15:58:51 INFO - 'tsvg_static']}, 15:58:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:58:51 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:58:51 INFO - 'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['tp5o']}, 15:58:51 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:58:51 INFO - 'talos_options': ['--mitmproxy', 15:58:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:58:51 INFO - '--firstNonBlankPaint'], 15:58:51 INFO - 'tests': ['tp6_google', 15:58:51 INFO - 'tp6_youtube', 15:58:51 INFO - 'tp6_amazon', 15:58:51 INFO - 'tp6_facebook']}, 15:58:51 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:58:51 INFO - 'talos_options': ['--disable-stylo', 15:58:51 INFO - '--mitmproxy', 15:58:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:58:51 INFO - '--firstNonBlankPaint'], 15:58:51 INFO - 'tests': ['tp6_google', 15:58:51 INFO - 'tp6_youtube', 15:58:51 INFO - 'tp6_amazon', 15:58:51 INFO - 'tp6_facebook']}, 15:58:51 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:58:51 INFO - 'talos_options': ['--stylo-threads=1', 15:58:51 INFO - '--mitmproxy', 15:58:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:58:51 INFO - '--firstNonBlankPaint'], 15:58:51 INFO - 'tests': ['tp6_google', 15:58:51 INFO - 'tp6_youtube', 15:58:51 INFO - 'tp6_amazon', 15:58:51 INFO - 'tp6_facebook']}, 15:58:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:58:51 INFO - 'talos_options': ['--xperf_path', 15:58:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:58:51 INFO - 'tests': ['tp5n']}, 15:58:51 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:58:51 INFO - 'talos_options': ['--disable-stylo', 15:58:51 INFO - '--xperf_path', 15:58:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:58:51 INFO - 'tests': ['tp5n']}}} 15:58:51 INFO - Running post-action listener: _resource_record_post_action 15:58:51 INFO - [mozharness: 2017-09-18 22:58:51.446925Z] Finished populate-webroot step (success) 15:58:51 INFO - [mozharness: 2017-09-18 22:58:51.447014Z] Running create-virtualenv step. 15:58:51 INFO - Running pre-action listener: _resource_record_pre_action 15:58:51 INFO - Running main action method: create_virtualenv 15:58:51 INFO - Creating virtualenv /builds/slave/test/build/venv 15:58:51 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:58:51 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:58:51 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:58:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:58:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:58:52 INFO - Installing distribute.............................................................................................................................................................................................done. 15:58:52 INFO - Installing pip...............done. 15:58:52 INFO - Return code: 0 15:58:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:58:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:58:52 INFO - Reading from file tmpfile_stdout 15:58:52 INFO - Output received: 15:58:52 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:58:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee6090>, '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 0xee6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0f90>, '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-1505772765.210758-788889504', '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 15:58:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:58:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:58:52 INFO - Using env: {'DISPLAY': ':0', 15:58:52 INFO - 'HOME': '/home/cltbld', 15:58:52 INFO - 'LANG': 'en_US.UTF-8', 15:58:52 INFO - 'LANGUAGE': 'en_US:en', 15:58:52 INFO - 'LOGNAME': 'cltbld', 15:58:52 INFO - 'MAIL': '/var/mail/cltbld', 15:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:52 INFO - 'MOZ_NO_REMOTE': '1', 15:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:52 INFO - 'NO_EM_RESTART': '1', 15:58:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:52 INFO - 'PWD': '/builds/slave/test', 15:58:52 INFO - 'SHELL': '/bin/bash', 15:58:52 INFO - 'SHLVL': '1', 15:58:52 INFO - 'TERM': 'linux', 15:58:52 INFO - 'TMOUT': '86400', 15:58:52 INFO - 'USER': 'cltbld', 15:58:52 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1505772765.210758-788889504', 15:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:52 INFO - '_': '/tools/buildbot/bin/python'} 15:58:53 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:58:53 INFO - Downloading/unpacking pip>=1.5 15:58:53 INFO - Running setup.py egg_info for package pip 15:58:53 INFO - warning: no files found matching 'pip/cacert.pem' 15:58:53 INFO - warning: no files found matching '*.html' under directory 'docs' 15:58:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:58:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:58:53 INFO - Installing collected packages: pip 15:58:53 INFO - Found existing installation: pip 1.1 15:58:53 INFO - Uninstalling pip: 15:58:53 INFO - Successfully uninstalled pip 15:58:53 INFO - Running setup.py install for pip 15:58:53 INFO - warning: no files found matching 'pip/cacert.pem' 15:58:53 INFO - warning: no files found matching '*.html' under directory 'docs' 15:58:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:58:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:58:53 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:58:53 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:58:53 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:58:53 INFO - Successfully installed pip 15:58:53 INFO - Cleaning up... 15:58:53 INFO - Return code: 0 15:58:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:58:53 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')]} 15:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:53 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')]} 15:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:53 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 0xb761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee6090>, '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 0xee6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0f90>, '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-1505772765.210758-788889504', '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 15:58:53 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 15:58:53 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 15:58:53 INFO - Using env: {'DISPLAY': ':0', 15:58:53 INFO - 'HOME': '/home/cltbld', 15:58:53 INFO - 'LANG': 'en_US.UTF-8', 15:58:53 INFO - 'LANGUAGE': 'en_US:en', 15:58:53 INFO - 'LOGNAME': 'cltbld', 15:58:53 INFO - 'MAIL': '/var/mail/cltbld', 15:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:53 INFO - 'MOZ_NO_REMOTE': '1', 15:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:53 INFO - 'NO_EM_RESTART': '1', 15:58:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:53 INFO - 'PWD': '/builds/slave/test', 15:58:53 INFO - 'SHELL': '/bin/bash', 15:58:53 INFO - 'SHLVL': '1', 15:58:53 INFO - 'TERM': 'linux', 15:58:53 INFO - 'TMOUT': '86400', 15:58:53 INFO - 'USER': 'cltbld', 15:58:53 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1505772765.210758-788889504', 15:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:53 INFO - '_': '/tools/buildbot/bin/python'} 15:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:53 INFO - Downloading/unpacking psutil>=3.1.1 15:58:53 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 15:58:53 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 15:58:53 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 15:58:53 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 15:58:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:58:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:58:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:58:55 INFO - Installing collected packages: psutil 15:58:55 INFO - Running setup.py install for psutil 15:58:55 INFO - building 'psutil._psutil_linux' extension 15:58:55 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 15:58:55 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 15:58:55 INFO - building 'psutil._psutil_posix' extension 15:58:55 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 15:58:55 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 15:58:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:58:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:58:55 INFO - Successfully installed psutil 15:58:55 INFO - Cleaning up... 15:58:55 INFO - Return code: 0 15:58:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:55 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 0xb761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee6090>, '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 0xee6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0f90>, '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-1505772765.210758-788889504', '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 15:58:55 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 15:58:55 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 15:58:55 INFO - Using env: {'DISPLAY': ':0', 15:58:55 INFO - 'HOME': '/home/cltbld', 15:58:55 INFO - 'LANG': 'en_US.UTF-8', 15:58:55 INFO - 'LANGUAGE': 'en_US:en', 15:58:55 INFO - 'LOGNAME': 'cltbld', 15:58:55 INFO - 'MAIL': '/var/mail/cltbld', 15:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:55 INFO - 'MOZ_NO_REMOTE': '1', 15:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:55 INFO - 'NO_EM_RESTART': '1', 15:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:55 INFO - 'PWD': '/builds/slave/test', 15:58:55 INFO - 'SHELL': '/bin/bash', 15:58:55 INFO - 'SHLVL': '1', 15:58:55 INFO - 'TERM': 'linux', 15:58:55 INFO - 'TMOUT': '86400', 15:58:55 INFO - 'USER': 'cltbld', 15:58:55 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1505772765.210758-788889504', 15:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:55 INFO - '_': '/tools/buildbot/bin/python'} 15:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:58:55 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 15:58:55 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 15:58:55 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 15:58:55 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 15:58:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:58:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:58:57 INFO - Installing collected packages: mozsystemmonitor 15:58:57 INFO - Running setup.py install for mozsystemmonitor 15:58:57 INFO - Successfully installed mozsystemmonitor 15:58:57 INFO - Cleaning up... 15:58:57 INFO - Return code: 0 15:58:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:57 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 0xb761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee6090>, '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 0xee6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0f90>, '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-1505772765.210758-788889504', '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 15:58:57 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 15:58:57 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 15:58:57 INFO - Using env: {'DISPLAY': ':0', 15:58:57 INFO - 'HOME': '/home/cltbld', 15:58:57 INFO - 'LANG': 'en_US.UTF-8', 15:58:57 INFO - 'LANGUAGE': 'en_US:en', 15:58:57 INFO - 'LOGNAME': 'cltbld', 15:58:57 INFO - 'MAIL': '/var/mail/cltbld', 15:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:57 INFO - 'MOZ_NO_REMOTE': '1', 15:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:57 INFO - 'NO_EM_RESTART': '1', 15:58:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:57 INFO - 'PWD': '/builds/slave/test', 15:58:57 INFO - 'SHELL': '/bin/bash', 15:58:57 INFO - 'SHLVL': '1', 15:58:57 INFO - 'TERM': 'linux', 15:58:57 INFO - 'TMOUT': '86400', 15:58:57 INFO - 'USER': 'cltbld', 15:58:57 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1505772765.210758-788889504', 15:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:57 INFO - '_': '/tools/buildbot/bin/python'} 15:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:58 INFO - Downloading/unpacking jsonschema==2.5.1 15:58:58 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 15:58:58 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 15:58:58 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 15:58:58 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 15:58:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:58:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:58:59 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 15:58:59 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 15:58:59 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 15:58:59 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 15:58:59 INFO - Downloading functools32-3.2.3-2.tar.gz 15:58:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:58:59 INFO - warning: no files found matching '*.txt' 15:58:59 INFO - no previously-included directories found matching 'build' 15:58:59 INFO - no previously-included directories found matching 'dist' 15:58:59 INFO - no previously-included directories found matching '.git*' 15:58:59 INFO - Installing collected packages: jsonschema, functools32 15:58:59 INFO - Running setup.py install for functools32 15:58:59 INFO - warning: no files found matching '*.txt' 15:58:59 INFO - no previously-included directories found matching 'build' 15:58:59 INFO - no previously-included directories found matching 'dist' 15:58:59 INFO - no previously-included directories found matching '.git*' 15:58:59 INFO - Successfully installed jsonschema functools32 15:58:59 INFO - Cleaning up... 15:58:59 INFO - Return code: 0 15:58:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:58:59 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')]} 15:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:59 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')]} 15:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:59 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 0xb761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee6090>, '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 0xee6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0f90>, '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-1505772765.210758-788889504', '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 15:58:59 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 15:58:59 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 15:58:59 INFO - Using env: {'DISPLAY': ':0', 15:58:59 INFO - 'HOME': '/home/cltbld', 15:58:59 INFO - 'LANG': 'en_US.UTF-8', 15:58:59 INFO - 'LANGUAGE': 'en_US:en', 15:58:59 INFO - 'LOGNAME': 'cltbld', 15:58:59 INFO - 'MAIL': '/var/mail/cltbld', 15:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:59 INFO - 'MOZ_NO_REMOTE': '1', 15:58:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:59 INFO - 'NO_EM_RESTART': '1', 15:58:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:59 INFO - 'PWD': '/builds/slave/test', 15:58:59 INFO - 'SHELL': '/bin/bash', 15:58:59 INFO - 'SHLVL': '1', 15:58:59 INFO - 'TERM': 'linux', 15:58:59 INFO - 'TMOUT': '86400', 15:58:59 INFO - 'USER': 'cltbld', 15:58:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1505772765.210758-788889504', 15:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:59 INFO - '_': '/tools/buildbot/bin/python'} 15:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:58:59 INFO - Cleaning up... 15:58:59 INFO - Return code: 0 15:58:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:58:59 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')]} 15:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:59 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')]} 15:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:59 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 0xb761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee6090>, '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 0xee6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0f90>, '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-1505772765.210758-788889504', '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 15:58:59 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 15:58:59 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 15:58:59 INFO - Using env: {'DISPLAY': ':0', 15:58:59 INFO - 'HOME': '/home/cltbld', 15:58:59 INFO - 'LANG': 'en_US.UTF-8', 15:58:59 INFO - 'LANGUAGE': 'en_US:en', 15:58:59 INFO - 'LOGNAME': 'cltbld', 15:58:59 INFO - 'MAIL': '/var/mail/cltbld', 15:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:59 INFO - 'MOZ_NO_REMOTE': '1', 15:58:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:59 INFO - 'NO_EM_RESTART': '1', 15:58:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:59 INFO - 'PWD': '/builds/slave/test', 15:58:59 INFO - 'SHELL': '/bin/bash', 15:58:59 INFO - 'SHLVL': '1', 15:58:59 INFO - 'TERM': 'linux', 15:58:59 INFO - 'TMOUT': '86400', 15:58:59 INFO - 'USER': 'cltbld', 15:58:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1505772765.210758-788889504', 15:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:59 INFO - '_': '/tools/buildbot/bin/python'} 15:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:00 INFO - Downloading/unpacking blobuploader==1.2.4 15:59:00 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 15:59:00 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 15:59:00 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 15:59:00 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 15:59:01 INFO - Downloading blobuploader-1.2.4.tar.gz 15:59:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:59:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:59:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:01 INFO - Downloading docopt-0.6.1.tar.gz 15:59:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:59:01 INFO - Installing collected packages: blobuploader, requests, docopt 15:59:01 INFO - Running setup.py install for blobuploader 15:59:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:59:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:59:01 INFO - Running setup.py install for requests 15:59:02 INFO - Running setup.py install for docopt 15:59:02 INFO - Successfully installed blobuploader requests docopt 15:59:02 INFO - Cleaning up... 15:59:02 INFO - Return code: 0 15:59:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59: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')]} 15:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59: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')]} 15:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:02 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 0xb761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee6090>, '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 0xee6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0f90>, '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-1505772765.210758-788889504', '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 15:59:02 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 15:59:02 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 15:59:02 INFO - Using env: {'DISPLAY': ':0', 15:59:02 INFO - 'HOME': '/home/cltbld', 15:59:02 INFO - 'LANG': 'en_US.UTF-8', 15:59:02 INFO - 'LANGUAGE': 'en_US:en', 15:59:02 INFO - 'LOGNAME': 'cltbld', 15:59:02 INFO - 'MAIL': '/var/mail/cltbld', 15:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:02 INFO - 'MOZ_NO_REMOTE': '1', 15:59:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:02 INFO - 'NO_EM_RESTART': '1', 15:59:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:02 INFO - 'PWD': '/builds/slave/test', 15:59:02 INFO - 'SHELL': '/bin/bash', 15:59:02 INFO - 'SHLVL': '1', 15:59:02 INFO - 'TERM': 'linux', 15:59:02 INFO - 'TMOUT': '86400', 15:59:02 INFO - 'USER': 'cltbld', 15:59:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1505772765.210758-788889504', 15:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:02 INFO - '_': '/tools/buildbot/bin/python'} 15:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:59:02 INFO - Running setup.py (path:/tmp/pip-hEIgev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:59:02 INFO - Running setup.py (path:/tmp/pip-m2D1lG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:59:02 INFO - Running setup.py (path:/tmp/pip-NKq7yY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:59:02 INFO - Running setup.py (path:/tmp/pip-KRFI4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:59:02 INFO - Running setup.py (path:/tmp/pip-1g1RAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:59:02 INFO - Running setup.py (path:/tmp/pip-c_7Acc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:59:02 INFO - Running setup.py (path:/tmp/pip-x55xNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:59:03 INFO - Running setup.py (path:/tmp/pip-99Vf3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:59:03 INFO - Running setup.py (path:/tmp/pip-TyrGEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:59:03 INFO - Running setup.py (path:/tmp/pip-PEQjlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:59:03 INFO - Running setup.py (path:/tmp/pip-8hV2Kx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:59:03 INFO - Running setup.py (path:/tmp/pip-Ncxsfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:59:03 INFO - Running setup.py (path:/tmp/pip-7aT9WC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:59:03 INFO - Running setup.py (path:/tmp/pip-feSU7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:03 INFO - Running setup.py (path:/tmp/pip-4OG_gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:59:03 INFO - Running setup.py (path:/tmp/pip-G9_fBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:59:03 INFO - Running setup.py (path:/tmp/pip-yjW23g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:59:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:59:03 INFO - Running setup.py install for manifestparser 15:59:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:59:03 INFO - Running setup.py install for mozcrash 15:59:03 INFO - Running setup.py install for mozdebug 15:59:04 INFO - Running setup.py install for mozdevice 15:59:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:59:04 INFO - Running setup.py install for mozfile 15:59:04 INFO - Running setup.py install for mozhttpd 15:59:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:59:04 INFO - Running setup.py install for mozinfo 15:59:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:59:04 INFO - Running setup.py install for mozInstall 15:59:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:59:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:59:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:59:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:59:04 INFO - Running setup.py install for mozleak 15:59:04 INFO - Running setup.py install for mozlog 15:59:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:59:04 INFO - Running setup.py install for moznetwork 15:59:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:59:04 INFO - Running setup.py install for mozprocess 15:59:04 INFO - Running setup.py install for mozprofile 15:59:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:59:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:59:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:59:05 INFO - Running setup.py install for mozrunner 15:59:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:59:05 INFO - Running setup.py install for mozscreenshot 15:59:05 INFO - Running setup.py install for moztest 15:59:05 INFO - Running setup.py install for mozversion 15:59:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:59:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:59:05 INFO - Cleaning up... 15:59:05 INFO - Return code: 0 15:59:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:05 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 0xb761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee6090>, '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 0xee6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0f90>, '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-1505772765.210758-788889504', '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 15:59:05 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 15:59:05 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 15:59:05 INFO - Using env: {'DISPLAY': ':0', 15:59:05 INFO - 'HOME': '/home/cltbld', 15:59:05 INFO - 'LANG': 'en_US.UTF-8', 15:59:05 INFO - 'LANGUAGE': 'en_US:en', 15:59:05 INFO - 'LOGNAME': 'cltbld', 15:59:05 INFO - 'MAIL': '/var/mail/cltbld', 15:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:05 INFO - 'MOZ_NO_REMOTE': '1', 15:59:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:05 INFO - 'NO_EM_RESTART': '1', 15:59:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:05 INFO - 'PWD': '/builds/slave/test', 15:59:05 INFO - 'SHELL': '/bin/bash', 15:59:05 INFO - 'SHLVL': '1', 15:59:05 INFO - 'TERM': 'linux', 15:59:05 INFO - 'TMOUT': '86400', 15:59:05 INFO - 'USER': 'cltbld', 15:59:05 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1505772765.210758-788889504', 15:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:05 INFO - '_': '/tools/buildbot/bin/python'} 15:59:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:59:05 INFO - Running setup.py (path:/tmp/pip-XF2aRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:59:05 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)) 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:59:05 INFO - Running setup.py (path:/tmp/pip-eRN6oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:59:05 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)) 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:59:05 INFO - Running setup.py (path:/tmp/pip-K42Mq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:59:05 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)) 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:59:05 INFO - Running setup.py (path:/tmp/pip-eopujN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:59:06 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)) 15:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:59:06 INFO - Running setup.py (path:/tmp/pip-kyWkKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:59:06 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)) 15:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:59:06 INFO - Running setup.py (path:/tmp/pip-qmcQPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:59:06 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)) 15:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:59:06 INFO - Running setup.py (path:/tmp/pip-wYnkW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:59:06 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)) 15:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:59:06 INFO - Running setup.py (path:/tmp/pip-lV6dZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:59:06 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)) 15:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:59:06 INFO - Running setup.py (path:/tmp/pip-TmIdHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:59:06 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)) 15:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:59:06 INFO - Running setup.py (path:/tmp/pip-u6OTSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:59:06 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)) 15:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:59:06 INFO - Running setup.py (path:/tmp/pip-u6Xnhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:59:06 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)) 15:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:59:06 INFO - Running setup.py (path:/tmp/pip-xHvKb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:59:06 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)) 15:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:59:06 INFO - Running setup.py (path:/tmp/pip-C0itcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:59:06 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)) 15:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:59:06 INFO - Running setup.py (path:/tmp/pip-A0Se1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:59:06 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)) 15:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:06 INFO - Running setup.py (path:/tmp/pip-UFG35Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:06 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)) 15:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:59:06 INFO - Running setup.py (path:/tmp/pip-SG2mzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:59:06 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)) 15:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:59:06 INFO - Running setup.py (path:/tmp/pip-sUCmSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:59:06 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)) 15:59:06 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)) 15:59:06 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)) 15:59:06 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)) 15:59:06 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)) 15:59:06 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)) 15:59:06 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)) 15:59:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:59:06 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 15:59:06 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 15:59:06 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 15:59:06 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 15:59:08 INFO - Downloading blessings-1.6.tar.gz 15:59:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:59:08 INFO - Installing collected packages: blessings 15:59:08 INFO - Running setup.py install for blessings 15:59:08 INFO - Successfully installed blessings 15:59:08 INFO - Cleaning up... 15:59:08 INFO - Return code: 0 15:59:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:59:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:59:08 INFO - Reading from file tmpfile_stdout 15:59:08 INFO - Current package versions: 15:59:08 INFO - argparse == 1.2.1 15:59:08 INFO - blessings == 1.6 15:59:08 INFO - blobuploader == 1.2.4 15:59:08 INFO - docopt == 0.6.1 15:59:08 INFO - functools32 == 3.2.3-2 15:59:08 INFO - jsonschema == 2.5.1 15:59:08 INFO - manifestparser == 1.1 15:59:08 INFO - mozInstall == 1.13 15:59:08 INFO - mozcrash == 1.0 15:59:08 INFO - mozdebug == 0.1 15:59:08 INFO - mozdevice == 0.51 15:59:08 INFO - mozfile == 1.2 15:59:08 INFO - mozhttpd == 0.7 15:59:08 INFO - mozinfo == 0.10 15:59:08 INFO - mozleak == 0.1 15:59:08 INFO - mozlog == 3.5 15:59:08 INFO - moznetwork == 0.27 15:59:08 INFO - mozprocess == 0.25 15:59:08 INFO - mozprofile == 0.28 15:59:08 INFO - mozrunner == 6.13 15:59:08 INFO - mozscreenshot == 0.1 15:59:08 INFO - mozsystemmonitor == 0.3 15:59:08 INFO - moztest == 0.8 15:59:08 INFO - mozversion == 1.4 15:59:08 INFO - psutil == 3.1.1 15:59:08 INFO - requests == 1.2.3 15:59:08 INFO - wsgiref == 0.1.2 15:59:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:08 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 0xb761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee6090>, '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 0xee6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0f90>, '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-1505772765.210758-788889504', '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 15:59:08 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 15:59:08 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 15:59:08 INFO - Using env: {'DISPLAY': ':0', 15:59:08 INFO - 'HOME': '/home/cltbld', 15:59:08 INFO - 'LANG': 'en_US.UTF-8', 15:59:08 INFO - 'LANGUAGE': 'en_US:en', 15:59:08 INFO - 'LOGNAME': 'cltbld', 15:59:08 INFO - 'MAIL': '/var/mail/cltbld', 15:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:08 INFO - 'MOZ_NO_REMOTE': '1', 15:59:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:08 INFO - 'NO_EM_RESTART': '1', 15:59:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:08 INFO - 'PWD': '/builds/slave/test', 15:59:08 INFO - 'SHELL': '/bin/bash', 15:59:08 INFO - 'SHLVL': '1', 15:59:08 INFO - 'TERM': 'linux', 15:59:08 INFO - 'TMOUT': '86400', 15:59:08 INFO - 'USER': 'cltbld', 15:59:08 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1505772765.210758-788889504', 15:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:08 INFO - '_': '/tools/buildbot/bin/python'} 15:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:08 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)) 15:59:08 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)) 15:59:08 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)) 15:59:08 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)) 15:59:08 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)) 15:59:08 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)) 15:59:08 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)) 15:59:08 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)) 15:59:08 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)) 15:59:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:59:08 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 15:59:08 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 15:59:08 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 15:59:08 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 15:59:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:59:09 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)) 15:59:09 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)) 15:59:09 INFO - Installing collected packages: simplejson 15:59:09 INFO - Running setup.py install for simplejson 15:59:10 INFO - building 'simplejson._speedups' extension 15:59:10 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 15:59:10 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 15:59:10 INFO - Successfully installed simplejson 15:59:10 INFO - Cleaning up... 15:59:11 INFO - Return code: 0 15:59:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee6090>, '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 0xee6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0f90>, '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-1505772765.210758-788889504', '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 15:59:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:59:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:59:11 INFO - Using env: {'DISPLAY': ':0', 15:59:11 INFO - 'HOME': '/home/cltbld', 15:59:11 INFO - 'LANG': 'en_US.UTF-8', 15:59:11 INFO - 'LANGUAGE': 'en_US:en', 15:59:11 INFO - 'LOGNAME': 'cltbld', 15:59:11 INFO - 'MAIL': '/var/mail/cltbld', 15:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:11 INFO - 'MOZ_NO_REMOTE': '1', 15:59:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:11 INFO - 'NO_EM_RESTART': '1', 15:59:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:11 INFO - 'PWD': '/builds/slave/test', 15:59:11 INFO - 'SHELL': '/bin/bash', 15:59:11 INFO - 'SHLVL': '1', 15:59:11 INFO - 'TERM': 'linux', 15:59:11 INFO - 'TMOUT': '86400', 15:59:11 INFO - 'USER': 'cltbld', 15:59:11 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1505772765.210758-788889504', 15:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:11 INFO - '_': '/tools/buildbot/bin/python'} 15:59:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:59:11 INFO - Cleaning up... 15:59:11 INFO - Return code: 0 15:59:11 INFO - Running post-action listener: _resource_record_post_action 15:59:11 INFO - Running post-action listener: _start_resource_monitoring 15:59:11 INFO - Starting resource monitoring. 15:59:11 INFO - [mozharness: 2017-09-18 22:59:11.266203Z] Finished create-virtualenv step (success) 15:59:11 INFO - [mozharness: 2017-09-18 22:59:11.266674Z] Running install step. 15:59:11 INFO - Running pre-action listener: _resource_record_pre_action 15:59:11 INFO - Running main action method: install 15:59:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:59:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:59:11 INFO - Reading from file tmpfile_stdout 15:59:11 INFO - Detecting whether we're running mozinstall >=1.0... 15:59:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:59:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:59:11 INFO - Reading from file tmpfile_stdout 15:59:11 INFO - Output received: 15:59:11 INFO - Usage: mozinstall [options] installer 15:59:11 INFO - Options: 15:59:11 INFO - -h, --help show this help message and exit 15:59:11 INFO - -d DEST, --destination=DEST 15:59:11 INFO - Directory to install application into. [default: 15:59:11 INFO - "/builds/slave/test"] 15:59:11 INFO - --app=APP Application being installed. [default: firefox] 15:59:11 INFO - mkdir: /builds/slave/test/build/application 15:59:11 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'] 15:59:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:59:29 INFO - Reading from file tmpfile_stdout 15:59:29 INFO - Output received: 15:59:29 INFO - /builds/slave/test/build/application/firefox/firefox 15:59:29 INFO - Running post-action listener: _resource_record_post_action 15:59:29 INFO - [mozharness: 2017-09-18 22:59:29.372920Z] Finished install step (success) 15:59:29 INFO - [mozharness: 2017-09-18 22:59:29.373172Z] Running setup-mitmproxy step. 15:59:29 INFO - Running pre-action listener: _resource_record_pre_action 15:59:29 INFO - Running main action method: setup_mitmproxy 15:59:29 INFO - Skipping: mitmproxy is not required 15:59:29 INFO - Running post-action listener: _resource_record_post_action 15:59:29 INFO - [mozharness: 2017-09-18 22:59:29.374299Z] Finished setup-mitmproxy step (success) 15:59:29 INFO - [mozharness: 2017-09-18 22:59:29.374518Z] Running run-tests step. 15:59:29 INFO - Running pre-action listener: _resource_record_pre_action 15:59:29 INFO - Running pre-action listener: _set_gcov_prefix 15:59:29 INFO - Running main action method: run_tests 15:59:29 WARNING - Try message not found. 15:59:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:59:29 INFO - Python 2.7.3 15:59:29 INFO - Return code: 0 15:59:29 INFO - grabbing minidump binary from tooltool 15:59: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')]} 15:59:29 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 0xee6090>, '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 0xee6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:59:29 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 15:59:29 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 15:59:29 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 15:59:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:59:29 INFO - Return code: 0 15:59:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:59:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:59:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:59:29 INFO - ENV: RUST_BACKTRACE is now full 15:59:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:59:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:59:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/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-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 15:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/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-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 15:59:29 INFO - Using env: {'DISPLAY': ':0', 15:59:29 INFO - 'HOME': '/home/cltbld', 15:59:29 INFO - 'LANG': 'en_US.UTF-8', 15:59:29 INFO - 'LANGUAGE': 'en_US:en', 15:59:29 INFO - 'LOGNAME': 'cltbld', 15:59:29 INFO - 'MAIL': '/var/mail/cltbld', 15:59:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:59:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:29 INFO - 'MOZ_NO_REMOTE': '1', 15:59:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:59:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:29 INFO - 'NO_EM_RESTART': '1', 15:59:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:29 INFO - 'PWD': '/builds/slave/test', 15:59:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:59:29 INFO - 'RUST_BACKTRACE': 'full', 15:59:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:59:29 INFO - 'SHELL': '/bin/bash', 15:59:29 INFO - 'SHLVL': '1', 15:59:29 INFO - 'TERM': 'linux', 15:59:29 INFO - 'TMOUT': '86400', 15:59:29 INFO - 'USER': 'cltbld', 15:59:29 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1505772765.210758-788889504', 15:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:29 INFO - '_': '/tools/buildbot/bin/python'} 15:59:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/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-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 15:59:29 INFO - mozversion application_buildid: 20170918220821 15:59:29 INFO - mozversion application_changeset: 948dc86aabc97e16d51ad19ea90debab6f93a628 15:59:29 INFO - mozversion application_display_name: Nightly 15:59:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:59:29 INFO - mozversion application_name: Firefox 15:59:29 INFO - mozversion application_remotingname: firefox 15:59:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:59:29 INFO - mozversion application_vendor: Mozilla 15:59:29 INFO - mozversion application_version: 57.0a1 15:59:29 INFO - mozversion platform_buildid: 20170918220821 15:59:29 INFO - mozversion platform_changeset: 948dc86aabc97e16d51ad19ea90debab6f93a628 15:59:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:59:29 INFO - mozversion platform_version: 57.0a1 15:59:29 INFO - using testdate: 1505775569 15:59:29 INFO - actual date: 1505775569 15:59:29 INFO - starting webserver on 'localhost:60297' 15:59:29 INFO - SUITE-START | Running 2 tests 15:59:29 INFO - TEST-START | dromaeo_css 15:59:29 INFO - Initialising browser for dromaeo_css test... 15:59:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60297/getInfo.html -profile /tmp/tmpQGG36P/profile 15:59:29 INFO - TEST-INFO | started process 22088 (/builds/slave/test/build/application/firefox/firefox http://localhost:60297/getInfo.html) 15:59:35 INFO - TEST-INFO | 22088: exit 0 15:59:35 INFO - Browser initialized. 15:59:35 INFO - Running cycle 1/1 for dromaeo_css test... 15:59:35 INFO - Using env: {'DISPLAY': ':0', 15:59:35 INFO - 'HOME': '/home/cltbld', 15:59:35 INFO - 'JSGC_DISABLE_POISONING': '1', 15:59:35 INFO - 'LANG': 'en_US.UTF-8', 15:59:35 INFO - 'LANGUAGE': 'en_US:en', 15:59:35 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:59:35 INFO - 'LOGNAME': 'cltbld', 15:59:35 INFO - 'MAIL': '/var/mail/cltbld', 15:59:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:59:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:59:35 INFO - 'MOZ_CRASHREPORTER': '1', 15:59:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:35 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:59:35 INFO - 'MOZ_NO_REMOTE': '1', 15:59:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:59:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:35 INFO - 'NO_EM_RESTART': '1', 15:59:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:35 INFO - 'PWD': '/builds/slave/test', 15:59:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:59:35 INFO - 'RUST_BACKTRACE': 'full', 15:59:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:59:35 INFO - 'SHELL': '/bin/bash', 15:59:35 INFO - 'SHLVL': '1', 15:59:35 INFO - 'STYLO_FORCE_DISABLED': '1', 15:59:35 INFO - 'TERM': 'linux', 15:59:35 INFO - 'TMOUT': '86400', 15:59:35 INFO - 'USER': 'cltbld', 15:59:35 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1505772765.210758-788889504', 15:59:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:35 INFO - '_': '/tools/buildbot/bin/python'} 15:59:35 INFO - TEST-INFO | started process 22321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQGG36P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:59:36 INFO - PID 22321 | 15:59:36 INFO - PID 22321 | (/builds/slave/test/build/application/firefox/firefox:22370): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:59:36 INFO - PID 22321 | 15:59:47 INFO - PID 22321 | RSS: Main: 150642688 15:59:47 INFO - PID 22321 | 16:02:44 INFO - PID 22321 | Cycle 1(1): loaded http://localhost:60297/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60297/tests/dromaeo/cssquery-ext.html) 16:02:45 INFO - PID 22321 | RSS: Main: 157020160 16:02:45 INFO - PID 22321 | 16:05:47 INFO - PID 22321 | Cycle 1(1): loaded http://localhost:60297/tests/dromaeo/cssquery-ext.html (next: http://localhost:60297/tests/dromaeo/cssquery-jquery.html) 16:05:48 INFO - PID 22321 | RSS: Main: 154873856 16:05:48 INFO - PID 22321 | 16:08:49 INFO - PID 22321 | Cycle 1(1): loaded http://localhost:60297/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60297/tests/dromaeo/cssquery-mootools.html) 16:08:50 INFO - PID 22321 | RSS: Main: 157057024 16:08:50 INFO - PID 22321 | 16:11:52 INFO - PID 22321 | Cycle 1(1): loaded http://localhost:60297/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60297/tests/dromaeo/cssquery-prototype.html) 16:11:52 INFO - PID 22321 | RSS: Main: 155529216 16:11:52 INFO - PID 22321 | 16:14:56 INFO - PID 22321 | Cycle 1(1): loaded http://localhost:60297/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60297/tests/dromaeo/cssquery-yui.html) 16:14:56 INFO - PID 22321 | RSS: Main: 156966912 16:14:56 INFO - PID 22321 | 16:17:58 INFO - PID 22321 | Cycle 1(1): loaded http://localhost:60297/tests/dromaeo/cssquery-yui.html (next: http://localhost:60297/tests/dromaeo/cssquery-dojo.html) 16:17:58 INFO - PID 22321 | RSS: Main: 157446144 16:17:58 INFO - PID 22321 | 16:17:58 INFO - PID 22321 | __start_tp_report 16:17:58 INFO - PID 22321 | _x_x_mozilla_page_load 16:17:58 INFO - PID 22321 | _x_x_mozilla_page_load_details 16:17:58 INFO - PID 22321 | |i|pagename|runs| 16:17:58 INFO - PID 22321 | |0;dojo.html;3127.3432579158375;3148.228683972427;3161.035884055363;3181.570487984123;3185.155933677577;6198.72105755241;6291.937080629193;6297.370262973706;6341.7146228419715;6407.519436042292;6336.714847831847;6368.808935731936;6438.645874476902;6442.871142577145;6468.579542329757;1195.1734159959335;5549.833504994836;5844.327902291248;5898.351181370046;5951.285845698522;5633.63381380209;5756.597038207327;5763.5101016413655;5785.652860828342;5898.292204935414;5739.770409183628;5785.074388097926;5792.044312688401;5793.681347525884;5800.187973683666;5745.195672605839;5754.1944127822135;5769.451902069297;5778.191053252548;5828.504577110908;5805.158252053471;5827.737751801179;5847.26909136358;5877.706114694248;5880.500157486619;6296.244450665949;6332.113504109382;6350.7777227796805;6391.680415979183;6441.066045423388;6599.703013364362;6675.532712710112;6739.764108256237;6760.729570817161;6866.210385805646;6823.351781580742;6914.585124892472;6943.305669433016;6956.513044086916;6962.930370696279;6298.6535740534255;6421.775237866699;6430.196225471816;6435.935640643627;6439.517036222255;7016.36852683261;7032.613206273704;7035.1909530404655;7108.609026503592;7113.430925525946;6496.123023391876;6632.535722499379;6645.867082658319;6694.49791265657;6786.93213067863;6843.213030501456;6876.17485901695;6876.587404755731;6877.2091209510545;6879.6560171991205;6748.055272261888;6815.386615204656;6831.555948863308;6841.692123854438;6861.622610756356;6806.319368063253;6813.250542440328;6882.105326307548;6900.654967251718;6905.516613837083;5167.767450464738;5258.526732594085;5328.973355133199;5384.380796208407;5396.730163491809;4608.654350923627;4666.2767271073035;4696.882577935579;4702.177119004161;4704.788284527204;5842.912356314659;5891.970540147272;5900.940990590125;5903.557233207526;5908.379620139909;6821.147356580427;6827.795166145023;6830.043793868862;6945.7221711132;6950.513464057569;5706.914396284059;5798.449147330997;5823.825285241365;5889;5900.970495147497;5733.111367738007;5741.598088133874;5742.856428589235;5745.827625171251;5817.418258174233;6601;6669.0329902164885;6669.966650166718;6669.966650166815;6681.599104053772;6686.231083425371;6774.932250677627;6817.965910170417;6912.758053468306;6925.376716095475;6416.582922110048;6476.6114033158165;6576.868462630816;6629.171353580802;6630.071789949315;6525.771597994048;6549.934500654933;6563.343665633399;6574.868502629825;6579.736810527525;6679.465642748665;6690.799276021728;6707.228668702966;6844.555103918229;6879.828004299932;6562.114114594468;6566.146400967844;6641.800745977628;6654.134962455044;6662.06731057662;6423.068655044899;6555.573887697285;6568.80293591193;6644.933550664625;6661.16735408074;6414.973604223302;6428.967855160694;6429.807105786834;6446.161998940108;6486.2216534016225;6608.867822643617;6720.865582688417;6737.124173857367;6779.6271205084195;6791.286914874065;6221.035739460391;6325.399087086719;6425.389587989133;6454.354564543508;6539.738410463528 16:17:58 INFO - PID 22321 | |1;ext.html;836.5399030533205;839.844628743682;855.1064137975815;892.3441270666063;892.8437523433399;41727.37408938864;42279;42396.364054539205;42552.57447425525;42610.57389426105;42223.155536889244;43528.347074793826;43538.56461435385;43592.564074359245;43596.564034359646;7815.53106813593;7902.2097790220805;7924.603769811515;7930.206979302053;7935.801604959894;7885.763427097197;7898.644560994769;7953.045634523865;7996.520208787462;8013.719519816807;8022.037355517346;8044.517328960281;8047.678092876278;8077.474964127313;8081.878771818428;7942.880856787153;7954.363650907942;7985;7992.160823113548;7993.880091798569;7541.7360392386;7555.584442855641;7584.848303033908;7595.772126836204;7595.962020189919;38239.808800956096;38483;38567;38601.22797544061;38864.41703374452;3497.9650203497895;3506.947395789065;3514.525539052246;3524.3832329342517;3539.7699149555197;31591.684083159103;31723.682763172303;31859.203519911956;31914.840425797724;31956.840215799006;5055.140626093573;5214.504622060898;5274.235235890813;5286.3392075990505;5301.867453313659;184164;184515;184542;185412;185498;46409.76795116003;46910.5308946913;47057;47062.5293747065;47111.29333060007;50154.49845501571;57881;58787.118193227136;58838.11742823861;59011;16023.67952640964;16096.436624718079;16150.434734784461;16153.919230404008;16157.515274541782;12898.613041608767;13364.866351336363;13676.794848077287;13703.657408564866;13782.517611883535;14805.555833325017;14842.847787070814;14899.47851825181;14989.850101498845;15032.924835375972;5681.176229446707;5761.164631128463;5787.363390027093;5841.240638716939;5972.343042265347;969.9806003879883;981.5484876956538;1003.242551873331;1004.9899501005043;1007.8941711120374;23002.654960175612;23140.65289020666;23155.421114472272;23535.17626883051;23805.523889522112;1083.9783204336027;1101.8595753395357;1106.6292791914798;1111.6109361723331;1111.8054340490382;12627.179233349987;12627.936860315824;12639.557615483414;12654.81017784734;12750.68123296925;230921;231912;231926;233127;233343;54112.729436352565;54754.72622636941;58248.70875645679;58826;59204;1380.8342998840203;1414.872661460453;1418.3404716806735;1434.0463591711396;1438.3311760031636;27522.862385687942;27613;27806.165815025583;27940;27948;40193.39709904295;40699.59300407077;40712.18575628412;40756.79621601873;40760.59239407568;203785;205021;205537;205564;205805;34511.65488345084;35299.64700352964;35574.466383004794;35841.28317433689;36169.63830361663;44306.77846610746;45162.548374515834;45338;45474.31788523109;46247;32039.67960320367;32206.19484512906;32367.51448728318;32620.510692339158;32646.51030234596;31823.840880795447;31901;32008.35983280368;32026.039218823473;32386;36870.89387318385;36947;37188.628113718514;37282.06794830043;37425.81287093547;31500.212494687818;31650.68349316477;31653.683463165074;31760.68239317577;32080.83959580187;23397.41506462352;23459.41351466227;23599.41001474977;24112.87943560271;24215.757842422056 16:17:58 INFO - PID 22321 | |2;jquery.html;559.8908212898485;561.2647431864258;566.3967874213962;566.4081035318093;567.2002476508125;21963.890180549093;22490.662640060393;22581.435464113365;22593.661095083546;22619.321420357395;23926.684032378213;24058.157964471247;24092.156774512896;24242.636360454562;24408.633870491958;6326.936730632692;6462.095306657072;6489.156409666737;6495.837604059889;6499.480041596685;6346.460550853183;6387.169667943184;6453.935460645381;6460.41856232939;6461.321561236073;6151.8769624607485;6393.264774550939;6401;6424.743010279583;6439.00195469703;6425.421712045938;6432.614043157402;6433.581817181892;6444.677766111676;6476.190476190476;5665.8583535411535;5827.825165245049;5836.066229403275;5866;6007.849803754897;26793.598096028574;27203.183904482896;27218.727812721816;27228.45543089127;27293.72706272932;2040.3470889315424;2060.814526692605;2067.9483012924647;2069.6067747128;2071.606394784986;18552;18932.43202703921;19260.614787704166;19422.22311107554;19459.124339404618;2430.878456077207;2472.4684192898435;2482.987585062081;2497.225859983411;2517.4461618444097;121608;127273;127484.36257818744;131474;139205;13857.168569885838;14015.85984140166;14370.568882933529;14496.202708851115;14609.050411723203;22177.1129154832;22201.333959981228;22210.11159553632;22216.555668886533;22281.888590556944;9781.364211326241;10193;10218.948905255425;10358.326708763907;10424.791504170025;9575.377600455948;9667.129958303645;9767.16979056774;9790.216782657513;9802.705918822447;8772.736817895473;8796.07641197665;8838.911610883808;8934.821303574023;9163.770905727277;2463.322586288749;2575.549278876189;2616.7252438494065;2651.3636727185335;2698.595210718408;948.7106432538142;971.2861047130353;972.873526441558;985.6451677396132;989.6140505202833;18124.184411701506;18365.173567189508;18579.535511612048;18730.906345468185;19008.619827603372;1008.6419321141036;1019.108280254777;1026.3585259212991;1026.861373714539;1035.6271742172812;10273;10375.377477351383;10435.16518678504;10495.475226238657;10594;425642;452514;456571;465065;469321;105438;107590.46204769083;107920;108391.45804271086;109239;1117.8267368557886;1144.0790163918125;1145.6849366424133;1146.48408216303;1151.3609946479785;16568.751468727736;16573.41993030238;17064.82935170682;17174.82825171732;17276.740848887024;52030;54509;54750;54751;55262.44737552573;64485.827208362425;66393.33606663872;66843.33156668372;67370;67574;13539.458421663418;13941;14017.929910350384;14021.5092471763;14026.859731402963;21644.89177554165;21766.56466870622;21799.455013624785;21859.890700546395;21931.780682192973;17322.48032559025;17373.218205180543;17798.377056803467;17802.732959005367;17847.821521784615;14952.626184345478;15340.232988350315;15781;15804.446844360393;16090;17266.827331727025;17365.131743413032;17437.30250789954;17556.824431755518;17884;13608.31958402056;13613.455461781417;13730.45078196901;13740.862591373958;13829.446822127002;17142.914285428495;17375.391861284796;17409.82590174082;17435.738463922797;17441.215145318743 16:17:58 INFO - PID 22321 | |3;mootools.html;1311.8360204974379;1412.717456508698;1420.325345460906;1427.2667841084324;1442.560019194146;14539.927300363497;15205.08769473831;15224.314905829237;15224.619384515365;15237.619059523517;15023.173725445096;15094.849051509482;15095.320710568023;15112.093274403516;15148.091114533136;2755.2973991632107;2772.875220615067;2833.5891295762103;2843.9715602844017;2844.388456481856;2770.0581802187253;2801.5097357962277;2823.7035111313326;2828.61813655156;2829.745322920937;2759.351552385188;2791.1905547391334;2875.4249150169944;2879.6688380836263;2886.2062932693466;2786.233785708926;2790.4558611070847;2813.8311701297885;2814.1698199031334;2815.0991682661556;2496.2261698873226;2659.6143559184;2689.421774318531;2702.9188324670095;2704.391511909824;15167.08997460145;15292.694146117126;15315.923420382938;15319.617009574738;15350.309236084291;8258.545779982098;8527.403081784278;8532.57337133141;8554.743357699279;8565.057843637194;5645.096784514499;5686.260786097822;5741.971290143564;5800.709964501758;5846.7076646167525;1901.3345329134831;1922.3656193456127;1944.9222031118738;2001.029500692163;2007.1268997985924;25756.613650795254;25960.350991225372;26055.08807191739;26073.608895866768;26105.477890442275;6798.960311906507;6855.691493882788;6906.689198986058;7015.89476157858;7057.964710176519;16284.674306513803;16856.241469133918;16935.153242337834;16935.407260745815;17247;7980.521168729895;8116.6347514362;8164.428490005761;8211.917880821235;8218.794530136794;7314.707411703473;7388.408927285912;7468.477206595595;7478.5138965967035;7565.356944659656;4927.162382395001;5059.772310246048;5108;5113.463086375877;5145.511176438233;1428.3074556650402;1429.9142051476945;1439.0358459831937;1446.978295325571;1450.7461194290956;811.5049819610033;828.4987582512614;840.4033136473173;852.0074113657644;867.1848462445281;7182.784516464514;7276.527025743416;7330.926690733131;7350.63246837656;7364.96317518409;705.1643802094432;717.1645033535872;719.2914978745931;737.5058710663868;741.4624397311906;5056.620753443506;5548.334199896039;5553.389127196006;5645.858853528613;5699.5725320600295;21067.367978960654;21347;21638.242661507087;21659.67510487344;21660.241891533722;20283.492912677008;21136.577268454854;21263.68104478434;21371.57256854854;21379;10210.540525676362;10659.680209593724;10704.625338113128;10724.78550428987;10733.08768754649;8305.37709671765;8597.312215022657;8673.479591224546;8704.477731336141;8818.426802257833;18227.908860455613;18418;18430.447086587425;18653.533661658566;18854.52863678419;18690.158942847876;18704.438866834018;19344.8065519343;19440.708389374453;20111.899440502704;11104.555817767521;11104.888951110386;11264;11270.098392128446;11271;13466.326683665582;13553.25457099869;13555.186688798703;13624.795628065389;13663.453461861414;10516.15870730355;10575.524101415302;10601.787964240826;10705.464726763475;10973.780524389627;10979.725506862393;11172.273802202832;11403.315801051964;11427.542898284308;11563.190576659554;9987.051230133126;10068.748281292734;10170.644027459299;10178.236632252463;10194.031567001122;6882.655867206719;6911.688973996082;6959.0605268290155;7132;7153.892691609734;6903.309669033057;7052.153741551047;7107.182673992557;7155.892661610184;7176.641167941478 16:17:58 INFO - PID 22321 | |4;prototype.html;503.3255437713463;503.3431372059461;523.7221180320021;529.8607992815446;533.8318429694646;6326.746930122801;6338.207724034496;6363.204599425072;6363.968180159099;6418.293987661354;6149.661768602737;6201.883660941029;6261.906071408921;6276.654783986879;6341.651209183493;5145.408278048035;5151.35608048992;5175.611829112813;5181.1710126379785;5186.5591424728755;4801.783919723621;5112.565431938289;5171.120909445403;5172.741362931857;5220.79116835328;4916.139675556781;4943.9752801235945;4959.6528243023;4968.205087186051;4968.22992436173;4953.529414705597;4976.626752993522;4978.751062446863;4979.253112033188;4982.302477653131;4442.378067070613;4452.888677783081;4457.621102206316;4465.9106817863785;4476.8880777980485;6182.659953702545;6216.409441103088;6230.576290833514;6237.500999919996;6239.908016097165;5653.519450846683;5681.7727290908315;5682.886342273131;5702.572307076985;5713.628614140068;6460.773872914426;6489.513286503484;6542.640154791485;6547.508936829757;6621.9006714899315;4635.258358662598;4779.852835319533;4822.951770482286;4867.78094985723;4891.9755401222765;6721.966390168067;6779.220389655204;6779.5593286436715;6785.42323902464;6811.9659401702675;4899.6570240083565;4919.680220785637;4922.50774922512;4943.876403089879;4966.8758281043265;5010.949890501049;5024.196128619476;5044.621653376012;5059.269582939963;5087.821926232564;5539.2857499824795;5619.775208991595;5624.690642014729;5625.746841392147;5635.69003704792;6589.341065893373;6613.5370524062855;6661.367170118831;6679.632620205838;6692.19693636757;1735.4446577095462;1736.765536652561;1736.947891563255;1746.2840235503384;1757.8769486135848;1138.8861113888545;1179.5753528729651;1210.7457433938796;1213.5570516761318;1218.939053047344;5686.346070201897;5700.40145784695;5700.515456186271;5723.627964182315;5757.654540727486;6579.671016449159;6606.273309935903;6609.834754131089;6709.496787740939;6735.158105236846;5682.9147562785765;5684.744186511534;5714.457126572969;5733;5770.307563092372;3552.8934131976084;3555.6622120898473;3561.2343346180696;3576.3204991051616;3613.94579081314;6323.1779868617705;6383.308268422706;6419.293877673452;6443.9045362288525;6503.317151699098;6808.799864063981;6884.691908537362;6887.5178737487895;6949.861002780017;6966.860662786716;6436.227652681709;6438.227412710411;6446.5165112615805;6463.515236357198;6464.321246269168;6055.515558755201;6489.772857949949;6588.8352791180605;6606;6628.966855165693;6570.507211959027;6577.210734711865;6589.341065893564;6685.39831415175;6694.665266736546;6313.747450101944;6389.393007664265;6393.789061914525;6407.359264073555;6543.443807276244;4919.532644398776;4935.580475659609;4954.405471343318;4964.156093464047;4977.8257760978195;6469.77355792545;6475.838104047437;6567.638779867153;6771.86456270862;6862.656867156722;6142.14010038586;6472.644004579794;6500.934990650222;6580.934190658224;6600.867982640224;6388.201474815648;6408.743650253938;6429.5499315049365;6456.741730330922;6515.381038801306;6426.196725409324;6440.937245354464;6512.283648798723;6524.869502609827;6566.179227596551;6492.837679058061;6498.577592456475;6526.608403495806;6591.34086591337;6620.966895165493;6242.625442473466;6304.968475157595;6336.524760643062;6401.55189136756;6441.516886233645 16:17:58 INFO - PID 22321 | |5;yui.html;899.0604817965226;901.2789768185454;931.5994122527311;931.8648795924591;935.9064093590638;19126.521836954067;20082.397528074143;20160.89919550404;20162.59674806503;20259.392218233475;16399.344026238938;16422.67154656906;16460.917695411506;16471.176441177922;16527.66944661109;947.9526023698804;967.7000129959699;970.4322971061937;974.064897698207;974.1038244814752;985.9309848310621;986.8174387738292;988.7923536057436;989.1888651305932;989.3816364772017;979.6130528441262;995.7560397702537;1001.0640051551786;1001.5593139018845;1002.4987506246877;987.2644879564698;992.8312186928204;994.0506815990784;994.0854413939194;997.0577803975247;747.7083937264471;754.5510421299318;755.4485225785207;756.1115689065326;756.9432292578078;19611.313604023933;19939.800601994084;20209.8989505053;20338;20381;21431.67852482214;21620.567588648297;22076.33770986873;22269.888650556644;22279.554408911732;17274.222659980205;17390.826091739047;17396.47810565685;17504.82495175045;17524.38664646744;3772.4718539404507;3785.6782173515285;3811.4473401356927;3813.790241536742;3824.445455408978;124549;135124.999999999;136764.999999999;138104.30947845196;139518;15438.691226175413;15565.22173891301;15640.296186671627;15658;15670.373185072698;31250.687493124777;31615;32031.839840801113;32100;32378.67621323804;8461.661533538589;8662.480251184823;8704.434211776213;8716.43343182691;8742.431741936882;4214.620684138381;4266.210751011073;4306.892327691833;4309.741415515079;4309.784510774512;5503.174523821459;5584.078627026576;5600.0759874620235;5606.131049687224;5616.157576363578;1005.653049697853;1048.339546085961;1049.7375656085978;1054.0882136951482;1069.2782371898936;656.2485953583121;686.6189264957897;690.068407649679;696.8362434827811;699.3915293694519;11336.71658208535;11441.942790285995;11777.234479758788;11948.701282467833;11973.341466219268;640.6316368088368;642.6690254518926;643.4755674125666;645.502962718704;657.7927952694886;5534.916976245359;5534.944650553523;5617.747201375866;5652.7738890443925;5712.143178523254;120679.39660301643;121013;122846;125017;126315.3684231573;108939.45530272298;109258;109796;109914;112931;97510.51244743873;99052;99184;99507;99754;10029.749256268651;10376.792464150825;10440.26918115755;10586.206034547286;10687.57249710034;43646;44323.77838110789;44470.3329450065;45017.54982450134;45422.54577454183;57447.7127614376;58585.414145858;59207.40792592019;59535;60255;14423.134611923319;14591.635209119857;14702.926485367932;14732.926335368255;14779.482718104815;17485.47543573695;17496.212670430115;17628.118594069987;17660.116994149983;17725;15093.622659433602;15415.075095494307;15450.381984720934;15481.458148964732;15624.687506250038;16686.49940501787;16891.662166756843;16953.152342382586;16993.490195294162;17159.828401715822;15794.052356858625;15835.208239587744;16038.839611603735;16083.75874361862;16287.755683664991;10399.116075133395;10664.306820056672;10819.242653014213;10871.67384978452;11033.22767406306;11708.590199342982;11918.702032448911;12166.817497737718;12189.517015366955;12257.877421225674 16:17:58 INFO - PID 22321 | __end_tp_report 16:17:58 INFO - PID 22321 | __start_cc_report 16:17:58 INFO - PID 22321 | _x_x_mozilla_cycle_collect,283 16:17:58 INFO - PID 22321 | __end_cc_report 16:17:58 INFO - PID 22321 | __startTimestamp1505776678497__endTimestamp 16:17:58 INFO - PID 22321 | 16:17:58 INFO - PID 22321 | ------- Summary: start ------- 16:17:58 INFO - PID 22321 | Number of tests: 6 16:17:58 INFO - PID 22321 | 16:17:58 INFO - PID 22321 | [#0] dojo.html Cycles:165 Average:6213.46 Median:6446.16 stddev:858.23 (13.3%) stddev-sans-first:826.01 16:17:58 INFO - PID 22321 | Values: 3127.3 3148.2 3161.0 3181.6 3185.2 6198.7 6291.9 6297.4 6341.7 6407.5 6336.7 6368.8 6438.6 6442.9 6468.6 1195.2 5549.8 5844.3 5898.4 5951.3 5633.6 5756.6 5763.5 5785.7 5898.3 5739.8 5785.1 5792.0 5793.7 5800.2 5745.2 5754.2 5769.5 5778.2 5828.5 5805.2 5827.7 5847.3 5877.7 5880.5 6296.2 6332.1 6350.8 6391.7 6441.1 6599.7 6675.5 6739.8 6760.7 6866.2 6823.4 6914.6 6943.3 6956.5 6962.9 6298.7 6421.8 6430.2 6435.9 6439.5 7016.4 7032.6 7035.2 7108.6 7113.4 6496.1 6632.5 6645.9 6694.5 6786.9 6843.2 6876.2 6876.6 6877.2 6879.7 6748.1 6815.4 6831.6 6841.7 6861.6 6806.3 6813.3 6882.1 6900.7 6905.5 5167.8 5258.5 5329.0 5384.4 5396.7 4608.7 4666.3 4696.9 4702.2 4704.8 5842.9 5892.0 5900.9 5903.6 5908.4 6821.1 6827.8 6830.0 6945.7 6950.5 5706.9 5798.4 5823.8 5889.0 5901.0 5733.1 5741.6 5742.9 5745.8 5817.4 6601.0 6669.0 6670.0 6670.0 6681.6 6686.2 6774.9 6818.0 6912.8 6925.4 6416.6 6476.6 6576.9 6629.2 6630.1 6525.8 6549.9 6563.3 6574.9 6579.7 6679.5 6690.8 6707.2 6844.6 6879.8 6562.1 6566.1 6641.8 6654.1 6662.1 6423.1 6555.6 6568.8 6644.9 6661.2 6415.0 6429.0 6429.8 6446.2 6486.2 6608.9 6720.9 6737.1 6779.6 6791.3 6221.0 6325.4 6425.4 6454.4 6539.7 16:17:58 INFO - PID 22321 | 16:17:58 INFO - PID 22321 | [#1] ext.html Cycles:180 Average:38448.74 Median:35707.87 stddev:53990.52 (151.2%) stddev-sans-first:54068.11 16:17:58 INFO - PID 22321 | Values: 836.5 839.8 855.1 892.3 892.8 41727.4 42279.0 42396.4 42552.6 42610.6 42223.2 43528.3 43538.6 43592.6 43596.6 7815.5 7902.2 7924.6 7930.2 7935.8 7885.8 7898.6 7953.0 7996.5 8013.7 8022.0 8044.5 8047.7 8077.5 8081.9 7942.9 7954.4 7985.0 7992.2 7993.9 7541.7 7555.6 7584.8 7595.8 7596.0 38239.8 38483.0 38567.0 38601.2 38864.4 3498.0 3506.9 3514.5 3524.4 3539.8 31591.7 31723.7 31859.2 31914.8 31956.8 5055.1 5214.5 5274.2 5286.3 5301.9 184164.0 184515.0 184542.0 185412.0 185498.0 46409.8 46910.5 47057.0 47062.5 47111.3 50154.5 57881.0 58787.1 58838.1 59011.0 16023.7 16096.4 16150.4 16153.9 16157.5 12898.6 13364.9 13676.8 13703.7 13782.5 14805.6 14842.8 14899.5 14989.9 15032.9 5681.2 5761.2 5787.4 5841.2 5972.3 970.0 981.5 1003.2 1005.0 1007.9 23002.7 23140.7 23155.4 23535.2 23805.5 1084.0 1101.9 1106.6 1111.6 1111.8 12627.2 12627.9 12639.6 12654.8 12750.7 230921.0 231912.0 231926.0 233127.0 233343.0 54112.7 54754.7 58248.7 58826.0 59204.0 1380.8 1414.9 1418.3 1434.0 1438.3 27522.9 27613.0 27806.2 27940.0 27948.0 40193.4 40699.6 40712.2 40756.8 40760.6 203785.0 205021.0 205537.0 205564.0 205805.0 34511.7 35299.6 35574.5 35841.3 36169.6 44306.8 45162.5 45338.0 45474.3 46247.0 32039.7 32206.2 32367.5 32620.5 32646.5 31823.8 31901.0 32008.4 32026.0 32386.0 36870.9 36947.0 37188.6 37282.1 37425.8 31500.2 31650.7 31653.7 31760.7 32080.8 23397.4 23459.4 23599.4 24112.9 24215.8 16:17:58 INFO - PID 22321 | 16:17:58 INFO - PID 22321 | [#2] jquery.html Cycles:180 Average:32658.58 Median:22189.22 stddev:76533.47 (344.9%) stddev-sans-first:76710.22 16:17:58 INFO - PID 22321 | Values: 559.9 561.3 566.4 566.4 567.2 21963.9 22490.7 22581.4 22593.7 22619.3 23926.7 24058.2 24092.2 24242.6 24408.6 6326.9 6462.1 6489.2 6495.8 6499.5 6346.5 6387.2 6453.9 6460.4 6461.3 6151.9 6393.3 6401.0 6424.7 6439.0 6425.4 6432.6 6433.6 6444.7 6476.2 5665.9 5827.8 5836.1 5866.0 6007.8 26793.6 27203.2 27218.7 27228.5 27293.7 2040.3 2060.8 2067.9 2069.6 2071.6 18552.0 18932.4 19260.6 19422.2 19459.1 2430.9 2472.5 2483.0 2497.2 2517.4 121608.0 127273.0 127484.4 131474.0 139205.0 13857.2 14015.9 14370.6 14496.2 14609.1 22177.1 22201.3 22210.1 22216.6 22281.9 9781.4 10193.0 10218.9 10358.3 10424.8 9575.4 9667.1 9767.2 9790.2 9802.7 8772.7 8796.1 8838.9 8934.8 9163.8 2463.3 2575.5 2616.7 2651.4 2698.6 948.7 971.3 972.9 985.6 989.6 18124.2 18365.2 18579.5 18730.9 19008.6 1008.6 1019.1 1026.4 1026.9 1035.6 10273.0 10375.4 10435.2 10495.5 10594.0 425642.0 452514.0 456571.0 465065.0 469321.0 105438.0 107590.5 107920.0 108391.5 109239.0 1117.8 1144.1 1145.7 1146.5 1151.4 16568.8 16573.4 17064.8 17174.8 17276.7 52030.0 54509.0 54750.0 54751.0 55262.4 64485.8 66393.3 66843.3 67370.0 67574.0 13539.5 13941.0 14017.9 14021.5 14026.9 21644.9 21766.6 21799.5 21859.9 21931.8 17322.5 17373.2 17798.4 17802.7 17847.8 14952.6 15340.2 15781.0 15804.4 16090.0 17266.8 17365.1 17437.3 17556.8 17884.0 13608.3 13613.5 13730.5 13740.9 13829.4 17142.9 17375.4 17409.8 17435.7 17441.2 16:17:58 INFO - PID 22321 | 16:17:58 INFO - PID 22321 | [#3] mootools.html Cycles:180 Average:9270.25 Median:2674.52 stddev:6574.25 (245.8%) stddev-sans-first:6565.50 16:17:58 INFO - PID 22321 | Values: 1311.8 1412.7 1420.3 1427.3 1442.6 14539.9 15205.1 15224.3 15224.6 15237.6 15023.2 15094.8 15095.3 15112.1 15148.1 2755.3 2772.9 2833.6 2844.0 2844.4 2770.1 2801.5 2823.7 2828.6 2829.7 2759.4 2791.2 2875.4 2879.7 2886.2 2786.2 2790.5 2813.8 2814.2 2815.1 2496.2 2659.6 2689.4 2702.9 2704.4 15167.1 15292.7 15315.9 15319.6 15350.3 8258.5 8527.4 8532.6 8554.7 8565.1 5645.1 5686.3 5742.0 5800.7 5846.7 1901.3 1922.4 1944.9 2001.0 2007.1 25756.6 25960.4 26055.1 26073.6 26105.5 6799.0 6855.7 6906.7 7015.9 7058.0 16284.7 16856.2 16935.2 16935.4 17247.0 7980.5 8116.6 8164.4 8211.9 8218.8 7314.7 7388.4 7468.5 7478.5 7565.4 4927.2 5059.8 5108.0 5113.5 5145.5 1428.3 1429.9 1439.0 1447.0 1450.7 811.5 828.5 840.4 852.0 867.2 7182.8 7276.5 7330.9 7350.6 7365.0 705.2 717.2 719.3 737.5 741.5 5056.6 5548.3 5553.4 5645.9 5699.6 21067.4 21347.0 21638.2 21659.7 21660.2 20283.5 21136.6 21263.7 21371.6 21379.0 10210.5 10659.7 10704.6 10724.8 10733.1 8305.4 8597.3 8673.5 8704.5 8818.4 18227.9 18418.0 18430.4 18653.5 18854.5 18690.2 18704.4 19344.8 19440.7 20111.9 11104.6 11104.9 11264.0 11270.1 11271.0 13466.3 13553.3 13555.2 13624.8 13663.5 10516.2 10575.5 10601.8 10705.5 10973.8 10979.7 11172.3 11403.3 11427.5 11563.2 9987.1 10068.7 10170.6 10178.2 10194.0 6882.7 6911.7 6959.1 7132.0 7153.9 6903.3 7052.2 7107.2 7155.9 7176.6 16:17:58 INFO - PID 22321 | 16:17:58 INFO - PID 22321 | [#4] prototype.html Cycles:180 Average:5492.91 Median:6223.49 stddev:1536.70 (24.7%) stddev-sans-first:1494.68 16:17:58 INFO - PID 22321 | Values: 503.3 503.3 523.7 529.9 533.8 6326.7 6338.2 6363.2 6364.0 6418.3 6149.7 6201.9 6261.9 6276.7 6341.7 5145.4 5151.4 5175.6 5181.2 5186.6 4801.8 5112.6 5171.1 5172.7 5220.8 4916.1 4944.0 4959.7 4968.2 4968.2 4953.5 4976.6 4978.8 4979.3 4982.3 4442.4 4452.9 4457.6 4465.9 4476.9 6182.7 6216.4 6230.6 6237.5 6239.9 5653.5 5681.8 5682.9 5702.6 5713.6 6460.8 6489.5 6542.6 6547.5 6621.9 4635.3 4779.9 4823.0 4867.8 4892.0 6722.0 6779.2 6779.6 6785.4 6812.0 4899.7 4919.7 4922.5 4943.9 4966.9 5010.9 5024.2 5044.6 5059.3 5087.8 5539.3 5619.8 5624.7 5625.7 5635.7 6589.3 6613.5 6661.4 6679.6 6692.2 1735.4 1736.8 1736.9 1746.3 1757.9 1138.9 1179.6 1210.7 1213.6 1218.9 5686.3 5700.4 5700.5 5723.6 5757.7 6579.7 6606.3 6609.8 6709.5 6735.2 5682.9 5684.7 5714.5 5733.0 5770.3 3552.9 3555.7 3561.2 3576.3 3613.9 6323.2 6383.3 6419.3 6443.9 6503.3 6808.8 6884.7 6887.5 6949.9 6966.9 6436.2 6438.2 6446.5 6463.5 6464.3 6055.5 6489.8 6588.8 6606.0 6629.0 6570.5 6577.2 6589.3 6685.4 6694.7 6313.7 6389.4 6393.8 6407.4 6543.4 4919.5 4935.6 4954.4 4964.2 4977.8 6469.8 6475.8 6567.6 6771.9 6862.7 6142.1 6472.6 6500.9 6580.9 6600.9 6388.2 6408.7 6429.5 6456.7 6515.4 6426.2 6440.9 6512.3 6524.9 6566.2 6492.8 6498.6 6526.6 6591.3 6621.0 6242.6 6305.0 6336.5 6401.6 6441.5 16:17:58 INFO - PID 22321 | 16:17:58 INFO - PID 22321 | [#5] yui.html Cycles:180 Average:24320.24 Median:20298.70 stddev:35297.57 (173.9%) stddev-sans-first:35352.78 16:17:58 INFO - PID 22321 | Values: 899.1 901.3 931.6 931.9 935.9 19126.5 20082.4 20160.9 20162.6 20259.4 16399.3 16422.7 16460.9 16471.2 16527.7 948.0 967.7 970.4 974.1 974.1 985.9 986.8 988.8 989.2 989.4 979.6 995.8 1001.1 1001.6 1002.5 987.3 992.8 994.1 994.1 997.1 747.7 754.6 755.4 756.1 756.9 19611.3 19939.8 20209.9 20338.0 20381.0 21431.7 21620.6 22076.3 22269.9 22279.6 17274.2 17390.8 17396.5 17504.8 17524.4 3772.5 3785.7 3811.4 3813.8 3824.4 124549.0 135125.0 136765.0 138104.3 139518.0 15438.7 15565.2 15640.3 15658.0 15670.4 31250.7 31615.0 32031.8 32100.0 32378.7 8461.7 8662.5 8704.4 8716.4 8742.4 4214.6 4266.2 4306.9 4309.7 4309.8 5503.2 5584.1 5600.1 5606.1 5616.2 1005.7 1048.3 1049.7 1054.1 1069.3 656.2 686.6 690.1 696.8 699.4 11336.7 11441.9 11777.2 11948.7 11973.3 640.6 642.7 643.5 645.5 657.8 5534.9 5534.9 5617.7 5652.8 5712.1 120679.4 121013.0 122846.0 125017.0 126315.4 108939.5 109258.0 109796.0 109914.0 112931.0 97510.5 99052.0 99184.0 99507.0 99754.0 10029.7 10376.8 10440.3 10586.2 10687.6 43646.0 44323.8 44470.3 45017.5 45422.5 57447.7 58585.4 59207.4 59535.0 60255.0 14423.1 14591.6 14702.9 14732.9 14779.5 17485.5 17496.2 17628.1 17660.1 17725.0 15093.6 15415.1 15450.4 15481.5 15624.7 16686.5 16891.7 16953.2 16993.5 17159.8 15794.1 15835.2 16038.8 16083.8 16287.8 10399.1 10664.3 10819.2 10871.7 11033.2 11708.6 11918.7 12166.8 12189.5 12257.9 16:17:58 INFO - PID 22321 | -------- Summary: end -------- 16:17:58 INFO - PID 22321 | 16:17:59 INFO - TEST-INFO | 22321: exit 0 16:17:59 INFO - TEST-OK | dromaeo_css | took 1109428ms 16:17:59 INFO - TEST-START | kraken 16:17:59 INFO - Initialising browser for kraken test... 16:17:59 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60297/getInfo.html -profile /tmp/tmpZ0VOZn/profile 16:17:59 INFO - TEST-INFO | started process 22694 (/builds/slave/test/build/application/firefox/firefox http://localhost:60297/getInfo.html) 16:18:04 INFO - TEST-INFO | 22694: exit 0 16:18:04 INFO - Browser initialized. 16:18:04 INFO - Running cycle 1/1 for kraken test... 16:18:04 INFO - Using env: {'DISPLAY': ':0', 16:18:04 INFO - 'HOME': '/home/cltbld', 16:18:04 INFO - 'JSGC_DISABLE_POISONING': '1', 16:18:04 INFO - 'LANG': 'en_US.UTF-8', 16:18:04 INFO - 'LANGUAGE': 'en_US:en', 16:18:04 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:18:04 INFO - 'LOGNAME': 'cltbld', 16:18:04 INFO - 'MAIL': '/var/mail/cltbld', 16:18:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:18:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:18:04 INFO - 'MOZ_CRASHREPORTER': '1', 16:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:04 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:18:04 INFO - 'MOZ_NO_REMOTE': '1', 16:18:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:04 INFO - 'NO_EM_RESTART': '1', 16:18:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:04 INFO - 'PWD': '/builds/slave/test', 16:18:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:18:04 INFO - 'RUST_BACKTRACE': 'full', 16:18:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:18:04 INFO - 'SHELL': '/bin/bash', 16:18:04 INFO - 'SHLVL': '1', 16:18:04 INFO - 'STYLO_FORCE_DISABLED': '1', 16:18:04 INFO - 'TERM': 'linux', 16:18:04 INFO - 'TMOUT': '86400', 16:18:04 INFO - 'USER': 'cltbld', 16:18:04 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1505772765.210758-788889504', 16:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:04 INFO - '_': '/tools/buildbot/bin/python'} 16:18:04 INFO - TEST-INFO | started process 22933 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ0VOZn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:18:05 INFO - PID 22933 | 16:18:05 INFO - PID 22933 | (/builds/slave/test/build/application/firefox/firefox:22982): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:18:05 INFO - PID 22933 | 16:18:15 INFO - PID 22933 | RSS: Main: 155041792 16:18:15 INFO - PID 22933 | 16:18:18 INFO - PID 22933 | Cycle 1(1): loaded http://localhost:60297/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60297/tests/kraken/driver.html?testName=audio-beat-detection) 16:18:19 INFO - PID 22933 | RSS: Main: 161435648 16:18:19 INFO - PID 22933 | 16:18:21 INFO - PID 22933 | Cycle 1(1): loaded http://localhost:60297/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60297/tests/kraken/driver.html?testName=audio-dft) 16:18:22 INFO - PID 22933 | RSS: Main: 161628160 16:18:22 INFO - PID 22933 | 16:18:25 INFO - PID 22933 | Cycle 1(1): loaded http://localhost:60297/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60297/tests/kraken/driver.html?testName=audio-fft) 16:18:26 INFO - PID 22933 | RSS: Main: 157478912 16:18:26 INFO - PID 22933 | 16:18:28 INFO - PID 22933 | Cycle 1(1): loaded http://localhost:60297/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60297/tests/kraken/driver.html?testName=audio-oscillator) 16:18:28 INFO - PID 22933 | RSS: Main: 157822976 16:18:28 INFO - PID 22933 | 16:18:30 INFO - PID 22933 | Cycle 1(1): loaded http://localhost:60297/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60297/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:18:31 INFO - PID 22933 | RSS: Main: 157736960 16:18:31 INFO - PID 22933 | 16:18:34 INFO - PID 22933 | Cycle 1(1): loaded http://localhost:60297/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60297/tests/kraken/driver.html?testName=imaging-darkroom) 16:18:35 INFO - PID 22933 | RSS: Main: 160415744 16:18:35 INFO - PID 22933 | 16:18:39 INFO - PID 22933 | Cycle 1(1): loaded http://localhost:60297/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60297/tests/kraken/driver.html?testName=imaging-desaturate) 16:18:39 INFO - PID 22933 | RSS: Main: 160694272 16:18:39 INFO - PID 22933 | 16:18:42 INFO - PID 22933 | Cycle 1(1): loaded http://localhost:60297/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60297/tests/kraken/driver.html?testName=json-parse-financial) 16:18:43 INFO - PID 22933 | RSS: Main: 160342016 16:18:43 INFO - PID 22933 | 16:18:44 INFO - PID 22933 | Cycle 1(1): loaded http://localhost:60297/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60297/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:18:45 INFO - PID 22933 | RSS: Main: 160542720 16:18:45 INFO - PID 22933 | 16:18:47 INFO - PID 22933 | Cycle 1(1): loaded http://localhost:60297/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60297/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:18:47 INFO - PID 22933 | RSS: Main: 160751616 16:18:47 INFO - PID 22933 | 16:18:49 INFO - PID 22933 | Cycle 1(1): loaded http://localhost:60297/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60297/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:18:50 INFO - PID 22933 | RSS: Main: 157609984 16:18:50 INFO - PID 22933 | 16:18:53 INFO - PID 22933 | Cycle 1(1): loaded http://localhost:60297/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:18:53 INFO - PID 22933 | RSS: Main: 158285824 16:18:53 INFO - PID 22933 | 16:18:56 INFO - PID 22933 | Cycle 1(1): loaded http://localhost:60297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:18:57 INFO - PID 22933 | RSS: Main: 158498816 16:18:57 INFO - PID 22933 | 16:18:59 INFO - PID 22933 | Cycle 1(1): loaded http://localhost:60297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60297/tests/kraken/driver.html?testName=ai-astar) 16:18:59 INFO - PID 22933 | RSS: Main: 159899648 16:18:59 INFO - PID 22933 | 16:18:59 INFO - PID 22933 | __start_tp_report 16:18:59 INFO - PID 22933 | _x_x_mozilla_page_load 16:18:59 INFO - PID 22933 | _x_x_mozilla_page_load_details 16:18:59 INFO - PID 22933 | |i|pagename|runs| 16:18:59 INFO - PID 22933 | |0;ai-astar;108;108;108;106;107;108;107;106;109;107 16:18:59 INFO - PID 22933 | |1;audio-beat-detection;122;118;121;114;115;116;116;117;116;117 16:18:59 INFO - PID 22933 | |2;audio-dft;163;162;164;164;164;163;163;168;163;164 16:18:59 INFO - PID 22933 | |3;audio-fft;75;77;77;75;74;75;75;73;73;75 16:18:59 INFO - PID 22933 | |4;audio-oscillator;81;78;82;83;83;81;80;79;78;79 16:18:59 INFO - PID 22933 | |5;imaging-gaussian-blur;113;114;113;114;114;115;114;111;113;114 16:18:59 INFO - PID 22933 | |6;imaging-darkroom;149;147;147;149;149;148;148;148;149;148 16:18:59 INFO - PID 22933 | |7;imaging-desaturate;94;93;94;93;94;94;94;94;93;94 16:18:59 INFO - PID 22933 | |8;json-parse-financial;54;52;54;56;54;53;53;55;52;52 16:18:59 INFO - PID 22933 | |9;json-stringify-tinderbox;39;38;37;38;37;38;38;38;37;38 16:18:59 INFO - PID 22933 | |10;stanford-crypto-aes;74;73;77;74;75;75;73;73;73;76 16:18:59 INFO - PID 22933 | |11;stanford-crypto-ccm;112;116;121;118;111;129;115;113;112;115 16:18:59 INFO - PID 22933 | |12;stanford-crypto-pbkdf2;177;181;175;168;170;170;165;167;173;167 16:18:59 INFO - PID 22933 | |13;stanford-crypto-sha256-iterative;68;65;66;66;68;63;64;64;67;63 16:18:59 INFO - PID 22933 | __end_tp_report 16:18:59 INFO - PID 22933 | __start_cc_report 16:18:59 INFO - PID 22933 | _x_x_mozilla_cycle_collect,730 16:18:59 INFO - PID 22933 | __end_cc_report 16:18:59 INFO - PID 22933 | __startTimestamp1505776739269__endTimestamp 16:18:59 INFO - PID 22933 | 16:18:59 INFO - PID 22933 | ------- Summary: start ------- 16:18:59 INFO - PID 22933 | Number of tests: 14 16:18:59 INFO - PID 22933 | 16:18:59 INFO - PID 22933 | [#0] ai-astar Cycles:10 Average:107.40 Median:108.00 stddev:0.97 (0.9%) stddev-sans-first:1.00 16:18:59 INFO - PID 22933 | Values: 108.0 108.0 108.0 106.0 107.0 108.0 107.0 106.0 109.0 107.0 16:18:59 INFO - PID 22933 | 16:18:59 INFO - PID 22933 | [#1] audio-beat-detection Cycles:10 Average:117.20 Median:117.00 stddev:2.53 (2.2%) stddev-sans-first:2.00 16:18:59 INFO - PID 22933 | Values: 122.0 118.0 121.0 114.0 115.0 116.0 116.0 117.0 116.0 117.0 16:18:59 INFO - PID 22933 | 16:18:59 INFO - PID 22933 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:1.62 (1.0%) stddev-sans-first:1.69 16:18:59 INFO - PID 22933 | Values: 163.0 162.0 164.0 164.0 164.0 163.0 163.0 168.0 163.0 164.0 16:18:59 INFO - PID 22933 | 16:18:59 INFO - PID 22933 | [#3] audio-fft Cycles:10 Average:74.90 Median:75.00 stddev:1.37 (1.8%) stddev-sans-first:1.45 16:18:59 INFO - PID 22933 | Values: 75.0 77.0 77.0 75.0 74.0 75.0 75.0 73.0 73.0 75.0 16:18:59 INFO - PID 22933 | 16:18:59 INFO - PID 22933 | [#4] audio-oscillator Cycles:10 Average:80.40 Median:81.00 stddev:1.90 (2.3%) stddev-sans-first:2.00 16:18:59 INFO - PID 22933 | Values: 81.0 78.0 82.0 83.0 83.0 81.0 80.0 79.0 78.0 79.0 16:18:59 INFO - PID 22933 | 16:18:59 INFO - PID 22933 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:1.08 (0.9%) stddev-sans-first:1.13 16:18:59 INFO - PID 22933 | Values: 113.0 114.0 113.0 114.0 114.0 115.0 114.0 111.0 113.0 114.0 16:18:59 INFO - PID 22933 | 16:18:59 INFO - PID 22933 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 16:18:59 INFO - PID 22933 | Values: 149.0 147.0 147.0 149.0 149.0 148.0 148.0 148.0 149.0 148.0 16:18:59 INFO - PID 22933 | 16:18:59 INFO - PID 22933 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 16:18:59 INFO - PID 22933 | Values: 94.0 93.0 94.0 93.0 94.0 94.0 94.0 94.0 93.0 94.0 16:18:59 INFO - PID 22933 | 16:18:59 INFO - PID 22933 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:54.00 stddev:1.35 (2.5%) stddev-sans-first:1.42 16:18:59 INFO - PID 22933 | Values: 54.0 52.0 54.0 56.0 54.0 53.0 53.0 55.0 52.0 52.0 16:18:59 INFO - PID 22933 | 16:18:59 INFO - PID 22933 | [#9] json-stringify-tinderbox Cycles:10 Average:37.80 Median:38.00 stddev:0.63 (1.7%) stddev-sans-first:0.50 16:18:59 INFO - PID 22933 | Values: 39.0 38.0 37.0 38.0 37.0 38.0 38.0 38.0 37.0 38.0 16:18:59 INFO - PID 22933 | 16:18:59 INFO - PID 22933 | [#10] stanford-crypto-aes Cycles:10 Average:74.30 Median:74.50 stddev:1.42 (1.9%) stddev-sans-first:1.50 16:18:59 INFO - PID 22933 | Values: 74.0 73.0 77.0 74.0 75.0 75.0 73.0 73.0 73.0 76.0 16:18:59 INFO - PID 22933 | 16:18:59 INFO - PID 22933 | [#11] stanford-crypto-ccm Cycles:10 Average:116.20 Median:115.50 stddev:5.43 (4.7%) stddev-sans-first:5.55 16:18:59 INFO - PID 22933 | Values: 112.0 116.0 121.0 118.0 111.0 129.0 115.0 113.0 112.0 115.0 16:18:59 INFO - PID 22933 | 16:18:59 INFO - PID 22933 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:171.50 stddev:5.10 (3.0%) stddev-sans-first:4.97 16:18:59 INFO - PID 22933 | Values: 177.0 181.0 175.0 168.0 170.0 170.0 165.0 167.0 173.0 167.0 16:18:59 INFO - PID 22933 | 16:18:59 INFO - PID 22933 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:66.00 stddev:1.90 (2.9%) stddev-sans-first:1.76 16:18:59 INFO - PID 22933 | Values: 68.0 65.0 66.0 66.0 68.0 63.0 64.0 64.0 67.0 63.0 16:18:59 INFO - PID 22933 | -------- Summary: end -------- 16:18:59 INFO - PID 22933 | 16:18:59 INFO - PID 22933 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:18:59 INFO - TEST-INFO | 22933: exit 0 16:18:59 INFO - TEST-OK | kraken | took 60716ms 16:18:59 INFO - SUITE-END | took 1170s 16:18:59 INFO - Completed test suite (00:19:30) 16:18:59 INFO - javascript benchmark 16:18:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8470.74638983009, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3127.3432579158375, 3148.228683972427, 3161.035884055363, 3181.570487984123, 3185.155933677577, 6198.72105755241, 6291.937080629193, 6297.370262973706, 6341.7146228419715, 6407.519436042292, 6336.714847831847, 6368.808935731936, 6438.645874476902, 6442.871142577145, 6468.579542329757, 1195.1734159959335, 5549.833504994836, 5844.327902291248, 5898.351181370046, 5951.285845698522, 5633.63381380209, 5756.597038207327, 5763.5101016413655, 5785.652860828342, 5898.292204935414, 5739.770409183628, 5785.074388097926, 5792.044312688401, 5793.681347525884, 5800.187973683666, 5745.195672605839, 5754.1944127822135, 5769.451902069297, 5778.191053252548, 5828.504577110908, 5805.158252053471, 5827.737751801179, 5847.26909136358, 5877.706114694248, 5880.500157486619, 6296.244450665949, 6332.113504109382, 6350.7777227796805, 6391.680415979183, 6441.066045423388, 6599.703013364362, 6675.532712710112, 6739.764108256237, 6760.729570817161, 6866.210385805646, 6823.351781580742, 6914.585124892472, 6943.305669433016, 6956.513044086916, 6962.930370696279, 6298.6535740534255, 6421.775237866699, 6430.196225471816, 6435.935640643627, 6439.517036222255, 7016.36852683261, 7032.613206273704, 7035.1909530404655, 7108.609026503592, 7113.430925525946, 6496.123023391876, 6632.535722499379, 6645.867082658319, 6694.49791265657, 6786.93213067863, 6843.213030501456, 6876.17485901695, 6876.587404755731, 6877.2091209510545, 6879.6560171991205, 6748.055272261888, 6815.386615204656, 6831.555948863308, 6841.692123854438, 6861.622610756356, 6806.319368063253, 6813.250542440328, 6882.105326307548, 6900.654967251718, 6905.516613837083, 5167.767450464738, 5258.526732594085, 5328.973355133199, 5384.380796208407, 5396.730163491809, 4608.654350923627, 4666.2767271073035, 4696.882577935579, 4702.177119004161, 4704.788284527204, 5842.912356314659, 5891.970540147272, 5900.940990590125, 5903.557233207526, 5908.379620139909, 6821.147356580427, 6827.795166145023, 6830.043793868862, 6945.7221711132, 6950.513464057569, 5706.914396284059, 5798.449147330997, 5823.825285241365, 5889.0, 5900.970495147497, 5733.111367738007, 5741.598088133874, 5742.856428589235, 5745.827625171251, 5817.418258174233, 6601.0, 6669.0329902164885, 6669.966650166718, 6669.966650166815, 6681.599104053772, 6686.231083425371, 6774.932250677627, 6817.965910170417, 6912.758053468306, 6925.376716095475, 6416.582922110048, 6476.6114033158165, 6576.868462630816, 6629.171353580802, 6630.071789949315, 6525.771597994048, 6549.934500654933, 6563.343665633399, 6574.868502629825, 6579.736810527525, 6679.465642748665, 6690.799276021728, 6707.228668702966, 6844.555103918229, 6879.828004299932, 6562.114114594468, 6566.146400967844, 6641.800745977628, 6654.134962455044, 6662.06731057662, 6423.068655044899, 6555.573887697285, 6568.80293591193, 6644.933550664625, 6661.16735408074, 6414.973604223302, 6428.967855160694, 6429.807105786834, 6446.161998940108, 6486.2216534016225, 6608.867822643617, 6720.865582688417, 6737.124173857367, 6779.6271205084195, 6791.286914874065, 6221.035739460391, 6325.399087086719, 6425.389587989133, 6454.354564543508, 6539.738410463528], "value": 6149.989718538822, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [836.5399030533205, 839.844628743682, 855.1064137975815, 892.3441270666063, 892.8437523433399, 41727.37408938864, 42279.0, 42396.364054539205, 42552.57447425525, 42610.57389426105, 42223.155536889244, 43528.347074793826, 43538.56461435385, 43592.564074359245, 43596.564034359646, 7815.53106813593, 7902.2097790220805, 7924.603769811515, 7930.206979302053, 7935.801604959894, 7885.763427097197, 7898.644560994769, 7953.045634523865, 7996.520208787462, 8013.719519816807, 8022.037355517346, 8044.517328960281, 8047.678092876278, 8077.474964127313, 8081.878771818428, 7942.880856787153, 7954.363650907942, 7985.0, 7992.160823113548, 7993.880091798569, 7541.7360392386, 7555.584442855641, 7584.848303033908, 7595.772126836204, 7595.962020189919, 38239.808800956096, 38483.0, 38567.0, 38601.22797544061, 38864.41703374452, 3497.9650203497895, 3506.947395789065, 3514.525539052246, 3524.3832329342517, 3539.7699149555197, 31591.684083159103, 31723.682763172303, 31859.203519911956, 31914.840425797724, 31956.840215799006, 5055.140626093573, 5214.504622060898, 5274.235235890813, 5286.3392075990505, 5301.867453313659, 184164.0, 184515.0, 184542.0, 185412.0, 185498.0, 46409.76795116003, 46910.5308946913, 47057.0, 47062.5293747065, 47111.29333060007, 50154.49845501571, 57881.0, 58787.118193227136, 58838.11742823861, 59011.0, 16023.67952640964, 16096.436624718079, 16150.434734784461, 16153.919230404008, 16157.515274541782, 12898.613041608767, 13364.866351336363, 13676.794848077287, 13703.657408564866, 13782.517611883535, 14805.555833325017, 14842.847787070814, 14899.47851825181, 14989.850101498845, 15032.924835375972, 5681.176229446707, 5761.164631128463, 5787.363390027093, 5841.240638716939, 5972.343042265347, 969.9806003879883, 981.5484876956538, 1003.242551873331, 1004.9899501005043, 1007.8941711120374, 23002.654960175612, 23140.65289020666, 23155.421114472272, 23535.17626883051, 23805.523889522112, 1083.9783204336027, 1101.8595753395357, 1106.6292791914798, 1111.6109361723331, 1111.8054340490382, 12627.179233349987, 12627.936860315824, 12639.557615483414, 12654.81017784734, 12750.68123296925, 230921.0, 231912.0, 231926.0, 233127.0, 233343.0, 54112.729436352565, 54754.72622636941, 58248.70875645679, 58826.0, 59204.0, 1380.8342998840203, 1414.872661460453, 1418.3404716806735, 1434.0463591711396, 1438.3311760031636, 27522.862385687942, 27613.0, 27806.165815025583, 27940.0, 27948.0, 40193.39709904295, 40699.59300407077, 40712.18575628412, 40756.79621601873, 40760.59239407568, 203785.0, 205021.0, 205537.0, 205564.0, 205805.0, 34511.65488345084, 35299.64700352964, 35574.466383004794, 35841.28317433689, 36169.63830361663, 44306.77846610746, 45162.548374515834, 45338.0, 45474.31788523109, 46247.0, 32039.67960320367, 32206.19484512906, 32367.51448728318, 32620.510692339158, 32646.51030234596, 31823.840880795447, 31901.0, 32008.35983280368, 32026.039218823473, 32386.0, 36870.89387318385, 36947.0, 37188.628113718514, 37282.06794830043, 37425.81287093547, 31500.212494687818, 31650.68349316477, 31653.683463165074, 31760.68239317577, 32080.83959580187, 23397.41506462352, 23459.41351466227, 23599.41001474977, 24112.87943560271, 24215.757842422056], "value": 17583.781353754457, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.8908212898485, 561.2647431864258, 566.3967874213962, 566.4081035318093, 567.2002476508125, 21963.890180549093, 22490.662640060393, 22581.435464113365, 22593.661095083546, 22619.321420357395, 23926.684032378213, 24058.157964471247, 24092.156774512896, 24242.636360454562, 24408.633870491958, 6326.936730632692, 6462.095306657072, 6489.156409666737, 6495.837604059889, 6499.480041596685, 6346.460550853183, 6387.169667943184, 6453.935460645381, 6460.41856232939, 6461.321561236073, 6151.8769624607485, 6393.264774550939, 6401.0, 6424.743010279583, 6439.00195469703, 6425.421712045938, 6432.614043157402, 6433.581817181892, 6444.677766111676, 6476.190476190476, 5665.8583535411535, 5827.825165245049, 5836.066229403275, 5866.0, 6007.849803754897, 26793.598096028574, 27203.183904482896, 27218.727812721816, 27228.45543089127, 27293.72706272932, 2040.3470889315424, 2060.814526692605, 2067.9483012924647, 2069.6067747128, 2071.606394784986, 18552.0, 18932.43202703921, 19260.614787704166, 19422.22311107554, 19459.124339404618, 2430.878456077207, 2472.4684192898435, 2482.987585062081, 2497.225859983411, 2517.4461618444097, 121608.0, 127273.0, 127484.36257818744, 131474.0, 139205.0, 13857.168569885838, 14015.85984140166, 14370.568882933529, 14496.202708851115, 14609.050411723203, 22177.1129154832, 22201.333959981228, 22210.11159553632, 22216.555668886533, 22281.888590556944, 9781.364211326241, 10193.0, 10218.948905255425, 10358.326708763907, 10424.791504170025, 9575.377600455948, 9667.129958303645, 9767.16979056774, 9790.216782657513, 9802.705918822447, 8772.736817895473, 8796.07641197665, 8838.911610883808, 8934.821303574023, 9163.770905727277, 2463.322586288749, 2575.549278876189, 2616.7252438494065, 2651.3636727185335, 2698.595210718408, 948.7106432538142, 971.2861047130353, 972.873526441558, 985.6451677396132, 989.6140505202833, 18124.184411701506, 18365.173567189508, 18579.535511612048, 18730.906345468185, 19008.619827603372, 1008.6419321141036, 1019.108280254777, 1026.3585259212991, 1026.861373714539, 1035.6271742172812, 10273.0, 10375.377477351383, 10435.16518678504, 10495.475226238657, 10594.0, 425642.0, 452514.0, 456571.0, 465065.0, 469321.0, 105438.0, 107590.46204769083, 107920.0, 108391.45804271086, 109239.0, 1117.8267368557886, 1144.0790163918125, 1145.6849366424133, 1146.48408216303, 1151.3609946479785, 16568.751468727736, 16573.41993030238, 17064.82935170682, 17174.82825171732, 17276.740848887024, 52030.0, 54509.0, 54750.0, 54751.0, 55262.44737552573, 64485.827208362425, 66393.33606663872, 66843.33156668372, 67370.0, 67574.0, 13539.458421663418, 13941.0, 14017.929910350384, 14021.5092471763, 14026.859731402963, 21644.89177554165, 21766.56466870622, 21799.455013624785, 21859.890700546395, 21931.780682192973, 17322.48032559025, 17373.218205180543, 17798.377056803467, 17802.732959005367, 17847.821521784615, 14952.626184345478, 15340.232988350315, 15781.0, 15804.446844360393, 16090.0, 17266.827331727025, 17365.131743413032, 17437.30250789954, 17556.824431755518, 17884.0, 13608.31958402056, 13613.455461781417, 13730.45078196901, 13740.862591373958, 13829.446822127002, 17142.914285428495, 17375.391861284796, 17409.82590174082, 17435.738463922797, 17441.215145318743], "value": 11541.072565969429, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1311.8360204974379, 1412.717456508698, 1420.325345460906, 1427.2667841084324, 1442.560019194146, 14539.927300363497, 15205.08769473831, 15224.314905829237, 15224.619384515365, 15237.619059523517, 15023.173725445096, 15094.849051509482, 15095.320710568023, 15112.093274403516, 15148.091114533136, 2755.2973991632107, 2772.875220615067, 2833.5891295762103, 2843.9715602844017, 2844.388456481856, 2770.0581802187253, 2801.5097357962277, 2823.7035111313326, 2828.61813655156, 2829.745322920937, 2759.351552385188, 2791.1905547391334, 2875.4249150169944, 2879.6688380836263, 2886.2062932693466, 2786.233785708926, 2790.4558611070847, 2813.8311701297885, 2814.1698199031334, 2815.0991682661556, 2496.2261698873226, 2659.6143559184, 2689.421774318531, 2702.9188324670095, 2704.391511909824, 15167.08997460145, 15292.694146117126, 15315.923420382938, 15319.617009574738, 15350.309236084291, 8258.545779982098, 8527.403081784278, 8532.57337133141, 8554.743357699279, 8565.057843637194, 5645.096784514499, 5686.260786097822, 5741.971290143564, 5800.709964501758, 5846.7076646167525, 1901.3345329134831, 1922.3656193456127, 1944.9222031118738, 2001.029500692163, 2007.1268997985924, 25756.613650795254, 25960.350991225372, 26055.08807191739, 26073.608895866768, 26105.477890442275, 6798.960311906507, 6855.691493882788, 6906.689198986058, 7015.89476157858, 7057.964710176519, 16284.674306513803, 16856.241469133918, 16935.153242337834, 16935.407260745815, 17247.0, 7980.521168729895, 8116.6347514362, 8164.428490005761, 8211.917880821235, 8218.794530136794, 7314.707411703473, 7388.408927285912, 7468.477206595595, 7478.5138965967035, 7565.356944659656, 4927.162382395001, 5059.772310246048, 5108.0, 5113.463086375877, 5145.511176438233, 1428.3074556650402, 1429.9142051476945, 1439.0358459831937, 1446.978295325571, 1450.7461194290956, 811.5049819610033, 828.4987582512614, 840.4033136473173, 852.0074113657644, 867.1848462445281, 7182.784516464514, 7276.527025743416, 7330.926690733131, 7350.63246837656, 7364.96317518409, 705.1643802094432, 717.1645033535872, 719.2914978745931, 737.5058710663868, 741.4624397311906, 5056.620753443506, 5548.334199896039, 5553.389127196006, 5645.858853528613, 5699.5725320600295, 21067.367978960654, 21347.0, 21638.242661507087, 21659.67510487344, 21660.241891533722, 20283.492912677008, 21136.577268454854, 21263.68104478434, 21371.57256854854, 21379.0, 10210.540525676362, 10659.680209593724, 10704.625338113128, 10724.78550428987, 10733.08768754649, 8305.37709671765, 8597.312215022657, 8673.479591224546, 8704.477731336141, 8818.426802257833, 18227.908860455613, 18418.0, 18430.447086587425, 18653.533661658566, 18854.52863678419, 18690.158942847876, 18704.438866834018, 19344.8065519343, 19440.708389374453, 20111.899440502704, 11104.555817767521, 11104.888951110386, 11264.0, 11270.098392128446, 11271.0, 13466.326683665582, 13553.25457099869, 13555.186688798703, 13624.795628065389, 13663.453461861414, 10516.15870730355, 10575.524101415302, 10601.787964240826, 10705.464726763475, 10973.780524389627, 10979.725506862393, 11172.273802202832, 11403.315801051964, 11427.542898284308, 11563.190576659554, 9987.051230133126, 10068.748281292734, 10170.644027459299, 10178.236632252463, 10194.031567001122, 6882.655867206719, 6911.688973996082, 6959.0605268290155, 7132.0, 7153.892691609734, 6903.309669033057, 7052.153741551047, 7107.182673992557, 7155.892661610184, 7176.641167941478], "value": 6615.50853800443, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.3255437713463, 503.3431372059461, 523.7221180320021, 529.8607992815446, 533.8318429694646, 6326.746930122801, 6338.207724034496, 6363.204599425072, 6363.968180159099, 6418.293987661354, 6149.661768602737, 6201.883660941029, 6261.906071408921, 6276.654783986879, 6341.651209183493, 5145.408278048035, 5151.35608048992, 5175.611829112813, 5181.1710126379785, 5186.5591424728755, 4801.783919723621, 5112.565431938289, 5171.120909445403, 5172.741362931857, 5220.79116835328, 4916.139675556781, 4943.9752801235945, 4959.6528243023, 4968.205087186051, 4968.22992436173, 4953.529414705597, 4976.626752993522, 4978.751062446863, 4979.253112033188, 4982.302477653131, 4442.378067070613, 4452.888677783081, 4457.621102206316, 4465.9106817863785, 4476.8880777980485, 6182.659953702545, 6216.409441103088, 6230.576290833514, 6237.500999919996, 6239.908016097165, 5653.519450846683, 5681.7727290908315, 5682.886342273131, 5702.572307076985, 5713.628614140068, 6460.773872914426, 6489.513286503484, 6542.640154791485, 6547.508936829757, 6621.9006714899315, 4635.258358662598, 4779.852835319533, 4822.951770482286, 4867.78094985723, 4891.9755401222765, 6721.966390168067, 6779.220389655204, 6779.5593286436715, 6785.42323902464, 6811.9659401702675, 4899.6570240083565, 4919.680220785637, 4922.50774922512, 4943.876403089879, 4966.8758281043265, 5010.949890501049, 5024.196128619476, 5044.621653376012, 5059.269582939963, 5087.821926232564, 5539.2857499824795, 5619.775208991595, 5624.690642014729, 5625.746841392147, 5635.69003704792, 6589.341065893373, 6613.5370524062855, 6661.367170118831, 6679.632620205838, 6692.19693636757, 1735.4446577095462, 1736.765536652561, 1736.947891563255, 1746.2840235503384, 1757.8769486135848, 1138.8861113888545, 1179.5753528729651, 1210.7457433938796, 1213.5570516761318, 1218.939053047344, 5686.346070201897, 5700.40145784695, 5700.515456186271, 5723.627964182315, 5757.654540727486, 6579.671016449159, 6606.273309935903, 6609.834754131089, 6709.496787740939, 6735.158105236846, 5682.9147562785765, 5684.744186511534, 5714.457126572969, 5733.0, 5770.307563092372, 3552.8934131976084, 3555.6622120898473, 3561.2343346180696, 3576.3204991051616, 3613.94579081314, 6323.1779868617705, 6383.308268422706, 6419.293877673452, 6443.9045362288525, 6503.317151699098, 6808.799864063981, 6884.691908537362, 6887.5178737487895, 6949.861002780017, 6966.860662786716, 6436.227652681709, 6438.227412710411, 6446.5165112615805, 6463.515236357198, 6464.321246269168, 6055.515558755201, 6489.772857949949, 6588.8352791180605, 6606.0, 6628.966855165693, 6570.507211959027, 6577.210734711865, 6589.341065893564, 6685.39831415175, 6694.665266736546, 6313.747450101944, 6389.393007664265, 6393.789061914525, 6407.359264073555, 6543.443807276244, 4919.532644398776, 4935.580475659609, 4954.405471343318, 4964.156093464047, 4977.8257760978195, 6469.77355792545, 6475.838104047437, 6567.638779867153, 6771.86456270862, 6862.656867156722, 6142.14010038586, 6472.644004579794, 6500.934990650222, 6580.934190658224, 6600.867982640224, 6388.201474815648, 6408.743650253938, 6429.5499315049365, 6456.741730330922, 6515.381038801306, 6426.196725409324, 6440.937245354464, 6512.283648798723, 6524.869502609827, 6566.179227596551, 6492.837679058061, 6498.577592456475, 6526.608403495806, 6591.34086591337, 6620.966895165493, 6242.625442473466, 6304.968475157595, 6336.524760643062, 6401.55189136756, 6441.516886233645], "value": 5040.052285813214, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [899.0604817965226, 901.2789768185454, 931.5994122527311, 931.8648795924591, 935.9064093590638, 19126.521836954067, 20082.397528074143, 20160.89919550404, 20162.59674806503, 20259.392218233475, 16399.344026238938, 16422.67154656906, 16460.917695411506, 16471.176441177922, 16527.66944661109, 947.9526023698804, 967.7000129959699, 970.4322971061937, 974.064897698207, 974.1038244814752, 985.9309848310621, 986.8174387738292, 988.7923536057436, 989.1888651305932, 989.3816364772017, 979.6130528441262, 995.7560397702537, 1001.0640051551786, 1001.5593139018845, 1002.4987506246877, 987.2644879564698, 992.8312186928204, 994.0506815990784, 994.0854413939194, 997.0577803975247, 747.7083937264471, 754.5510421299318, 755.4485225785207, 756.1115689065326, 756.9432292578078, 19611.313604023933, 19939.800601994084, 20209.8989505053, 20338.0, 20381.0, 21431.67852482214, 21620.567588648297, 22076.33770986873, 22269.888650556644, 22279.554408911732, 17274.222659980205, 17390.826091739047, 17396.47810565685, 17504.82495175045, 17524.38664646744, 3772.4718539404507, 3785.6782173515285, 3811.4473401356927, 3813.790241536742, 3824.445455408978, 124549.0, 135124.999999999, 136764.999999999, 138104.30947845196, 139518.0, 15438.691226175413, 15565.22173891301, 15640.296186671627, 15658.0, 15670.373185072698, 31250.687493124777, 31615.0, 32031.839840801113, 32100.0, 32378.67621323804, 8461.661533538589, 8662.480251184823, 8704.434211776213, 8716.43343182691, 8742.431741936882, 4214.620684138381, 4266.210751011073, 4306.892327691833, 4309.741415515079, 4309.784510774512, 5503.174523821459, 5584.078627026576, 5600.0759874620235, 5606.131049687224, 5616.157576363578, 1005.653049697853, 1048.339546085961, 1049.7375656085978, 1054.0882136951482, 1069.2782371898936, 656.2485953583121, 686.6189264957897, 690.068407649679, 696.8362434827811, 699.3915293694519, 11336.71658208535, 11441.942790285995, 11777.234479758788, 11948.701282467833, 11973.341466219268, 640.6316368088368, 642.6690254518926, 643.4755674125666, 645.502962718704, 657.7927952694886, 5534.916976245359, 5534.944650553523, 5617.747201375866, 5652.7738890443925, 5712.143178523254, 120679.39660301643, 121013.0, 122846.0, 125017.0, 126315.3684231573, 108939.45530272298, 109258.0, 109796.0, 109914.0, 112931.0, 97510.51244743873, 99052.0, 99184.0, 99507.0, 99754.0, 10029.749256268651, 10376.792464150825, 10440.26918115755, 10586.206034547286, 10687.57249710034, 43646.0, 44323.77838110789, 44470.3329450065, 45017.54982450134, 45422.54577454183, 57447.7127614376, 58585.414145858, 59207.40792592019, 59535.0, 60255.0, 14423.134611923319, 14591.635209119857, 14702.926485367932, 14732.926335368255, 14779.482718104815, 17485.47543573695, 17496.212670430115, 17628.118594069987, 17660.116994149983, 17725.0, 15093.622659433602, 15415.075095494307, 15450.381984720934, 15481.458148964732, 15624.687506250038, 16686.49940501787, 16891.662166756843, 16953.152342382586, 16993.490195294162, 17159.828401715822, 15794.052356858625, 15835.208239587744, 16038.839611603735, 16083.75874361862, 16287.755683664991, 10399.116075133395, 10664.306820056672, 10819.242653014213, 10871.67384978452, 11033.22767406306, 11708.590199342982, 11918.702032448911, 12166.817497737718, 12189.517015366955, 12257.877421225674], "value": 8877.136624750487, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1417.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 108.0, 108.0, 106.0, 107.0, 108.0, 107.0, 106.0, 109.0, 107.0], "value": 107.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 118.0, 121.0, 114.0, 115.0, 116.0, 116.0, 117.0, 116.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 164.0, 164.0, 163.0, 163.0, 168.0, 163.0, 164.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 75.0, 74.0, 75.0, 75.0, 73.0, 73.0, 75.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 82.0, 83.0, 83.0, 81.0, 80.0, 79.0, 78.0, 79.0], "value": 80.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 114.0, 114.0, 115.0, 114.0, 111.0, 113.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 149.0, 149.0, 148.0, 148.0, 148.0, 149.0, 148.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 54.0, 56.0, 54.0, 53.0, 53.0, 55.0, 52.0, 52.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 38.0, 37.0, 38.0, 37.0, 38.0, 38.0, 38.0, 37.0, 38.0], "value": 37.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 77.0, 74.0, 75.0, 75.0, 73.0, 73.0, 73.0, 76.0], "value": 74.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 121.0, 118.0, 111.0, 129.0, 115.0, 113.0, 112.0, 115.0], "value": 116.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 181.0, 175.0, 168.0, 170.0, 170.0, 165.0, 167.0, 173.0, 167.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 66.0, 66.0, 68.0, 63.0, 64.0, 64.0, 67.0, 63.0], "value": 65.4, "unit": "score"}]}]} 16:18:59 INFO - Return code: 0 16:19:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:19:00 INFO - # TBPL SUCCESS # 16:19:00 INFO - Running post-action listener: _package_coverage_data 16:19:00 INFO - Running post-action listener: _resource_record_post_action 16:19:00 INFO - [mozharness: 2017-09-18 23:19:00.055740Z] Finished run-tests step (success) 16:19:00 INFO - Running post-run listener: _resource_record_post_run 16:19:00 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 348450816; Read time: 12; Write time: 211412 16:19:00 INFO - TinderboxPrint: CPU usage
13.1% 16:19:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:19:00 INFO - TinderboxPrint: I/O write bytes / time
348,450,816 / 211,412 16:19:00 INFO - TinderboxPrint: CPU idle
8,229.5 (86.9%) 16:19:00 INFO - TinderboxPrint: CPU user
1,192.3 (12.6%) 16:19:00 INFO - TinderboxPrint: Swap in / out
0 / 0 16:19:00 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13201408; Read time: 0; Write time: 1324 16:19:00 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:19:00 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 335249408; Read time: 0; Write time: 210088 16:19:00 INFO - Running post-run listener: _upload_blobber_files 16:19:00 INFO - Blob upload gear active. 16:19:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:19:00 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 16:19:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:19:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:19:01 INFO - (blobuploader) - INFO - Open directory for files ... 16:19:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:19:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:19:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:02 INFO - (blobuploader) - INFO - Done attempting. 16:19:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 16:19:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 16:19:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:03 INFO - (blobuploader) - INFO - Done attempting. 16:19:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:19:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:19:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:07 INFO - (blobuploader) - INFO - Done attempting. 16:19:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 16:19:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 16:19:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:08 INFO - (blobuploader) - INFO - Done attempting. 16:19:08 INFO - (blobuploader) - INFO - Iteration through files over. 16:19:08 INFO - Return code: 0 16:19:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:19:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:19:08 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/691f27e80708edf67d3e819956597ecef6df708f73c9c456d5a57d73d8d13b74d3f8a5abcdca70306f253c1a3831249b4c52f7c87ea9df8fa9277dca5ed30554", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e63fe85d3b22641ba83edec97e843b3b2a5175542c33975bd88f00b13522f0502b0632279e1f29c58fea703edec660847f2dc81dbcb36346061b187822d07238", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d74b18ab8b40c492c6113852d3fd549c44126e199658973c2e8652db29440e823487de5217ba6ea27daf72f105511ced5f1699ae53d8871760a938fb79b15d2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ae65dfa79deb38a1573655b109d66f4f4c579bdb822eaa5dc073a59a397abed265851e02d05ebc97b0e318938748ea079a8755dd68810effe6c41c98b72542d"} 16:19:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:19:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:19:08 INFO - Contents: 16:19:08 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/691f27e80708edf67d3e819956597ecef6df708f73c9c456d5a57d73d8d13b74d3f8a5abcdca70306f253c1a3831249b4c52f7c87ea9df8fa9277dca5ed30554", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e63fe85d3b22641ba83edec97e843b3b2a5175542c33975bd88f00b13522f0502b0632279e1f29c58fea703edec660847f2dc81dbcb36346061b187822d07238", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d74b18ab8b40c492c6113852d3fd549c44126e199658973c2e8652db29440e823487de5217ba6ea27daf72f105511ced5f1699ae53d8871760a938fb79b15d2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ae65dfa79deb38a1573655b109d66f4f4c579bdb822eaa5dc073a59a397abed265851e02d05ebc97b0e318938748ea079a8755dd68810effe6c41c98b72542d"} 16:19:08 INFO - Running post-run listener: copy_logs_to_upload_dir 16:19:08 INFO - Copying logs to upload dir... 16:19:08 INFO - mkdir: /builds/slave/test/build/upload/logs 16:19:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.967096 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-18 16:19:08.284474) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 16:19:08.288774) ========= 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-1505772765.210758-788889504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/691f27e80708edf67d3e819956597ecef6df708f73c9c456d5a57d73d8d13b74d3f8a5abcdca70306f253c1a3831249b4c52f7c87ea9df8fa9277dca5ed30554", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e63fe85d3b22641ba83edec97e843b3b2a5175542c33975bd88f00b13522f0502b0632279e1f29c58fea703edec660847f2dc81dbcb36346061b187822d07238", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d74b18ab8b40c492c6113852d3fd549c44126e199658973c2e8652db29440e823487de5217ba6ea27daf72f105511ced5f1699ae53d8871760a938fb79b15d2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ae65dfa79deb38a1573655b109d66f4f4c579bdb822eaa5dc073a59a397abed265851e02d05ebc97b0e318938748ea079a8755dd68810effe6c41c98b72542d"} build_url:https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011334 build_url: 'https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/691f27e80708edf67d3e819956597ecef6df708f73c9c456d5a57d73d8d13b74d3f8a5abcdca70306f253c1a3831249b4c52f7c87ea9df8fa9277dca5ed30554", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e63fe85d3b22641ba83edec97e843b3b2a5175542c33975bd88f00b13522f0502b0632279e1f29c58fea703edec660847f2dc81dbcb36346061b187822d07238", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d74b18ab8b40c492c6113852d3fd549c44126e199658973c2e8652db29440e823487de5217ba6ea27daf72f105511ced5f1699ae53d8871760a938fb79b15d2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ae65dfa79deb38a1573655b109d66f4f4c579bdb822eaa5dc073a59a397abed265851e02d05ebc97b0e318938748ea079a8755dd68810effe6c41c98b72542d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 16:19:08.319953) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 16:19:08.320301) ========= 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-1505772765.210758-788889504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 16:19:08.403482) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 16:19:08.403802) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 16:19:08.404141) ========= ========= Total master_lag: 0.25 =========