builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-058 starttime: 1505598193.09 results: success (0) revision: 45b63125a4301eb89e7a4d70d0da1c650f11c7e4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 14:43:13.088552) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 14:43:13.089053) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 14:43:13.089328) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 14:43:13.107390) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 14:43:13.107791) ========= 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=0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-16 14:43:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2017-09-16 14:43:13 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.074308 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 14:43:13.198795) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 14:43:13.199104) ========= 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=0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021406 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 14:43:13.248551) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-16 14:43:13.251959) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 45b63125a4301eb89e7a4d70d0da1c650f11c7e4 --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 45b63125a4301eb89e7a4d70d0da1c650f11c7e4 --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=0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-16 14:43:13,302 truncating revision to first 12 chars 2017-09-16 14:43:13,302 Setting DEBUG logging. 2017-09-16 14:43:13,302 attempt 1/10 2017-09-16 14:43:13,302 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/45b63125a430?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-16 14:43:13,714 unpacking tar archive at: mozilla-central-45b63125a430/testing/mozharness/ program finished with exit code 0 elapsedTime=1.061082 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-16 14:43:14.329482) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 14:43:14.329833) ========= script_repo_revision: 45b63125a4301eb89e7a4d70d0da1c650f11c7e4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 14:43:14.330235) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 14:43:14.330506) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 14:43:14.343572) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-16 14:43:14.343994) ========= /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=0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:43:14 INFO - MultiFileLogger online at 20170916 14:43:14 in /builds/slave/test 14:43:14 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 14:43:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:43:14 INFO - {'append_to_log': False, 14:43:14 INFO - 'base_work_dir': '/builds/slave/test', 14:43:14 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:43:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:43:14 INFO - 'branch': 'Firefox-Non-PGO', 14:43:14 INFO - 'buildbot_json_path': 'buildprops.json', 14:43:14 INFO - 'code_coverage': False, 14:43:14 INFO - 'config_files': ('talos/linux_config.py',), 14:43:14 INFO - 'default_actions': ('clobber', 14:43:14 INFO - 'read-buildbot-config', 14:43:14 INFO - 'download-and-extract', 14:43:14 INFO - 'populate-webroot', 14:43:14 INFO - 'create-virtualenv', 14:43:14 INFO - 'install', 14:43:14 INFO - 'setup-mitmproxy', 14:43:14 INFO - 'run-tests'), 14:43:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:43:14 INFO - 'disable_ccov_upload': False, 14:43:14 INFO - 'disable_stylo': False, 14:43:14 INFO - 'download_minidump_stackwalk': True, 14:43:14 INFO - 'download_symbols': 'ondemand', 14:43:14 INFO - 'enable_stylo': False, 14:43:14 INFO - 'enable_webrender': False, 14:43:14 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 14:43:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:43:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:43:14 INFO - 'gecko_profile': False, 14:43:14 INFO - 'gecko_profile_interval': 0, 14:43:14 INFO - 'installer_path': 'installer.exe', 14:43:14 INFO - 'log_level': 'info', 14:43:14 INFO - 'log_name': 'talos', 14:43:14 INFO - 'log_to_console': True, 14:43:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:43:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:43:14 INFO - 'opt_config_files': (), 14:43:14 INFO - 'pip_index': False, 14:43:14 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 14:43:14 INFO - 'system_bits': '32', 14:43:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:43:14 INFO - 'title': 'talos-linux64-ix-058', 14:43:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:43:14 INFO - 'use_talos_json': True, 14:43:14 INFO - 'verify': 'False', 14:43:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:43:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:43:14 INFO - 'work_dir': 'build'} 14:43:14 INFO - [mozharness: 2017-09-16 21:43:14.542044Z] Running clobber step. 14:43:14 INFO - Running pre-action listener: _resource_record_pre_action 14:43:14 INFO - Running main action method: clobber 14:43:14 INFO - rmtree: /builds/slave/test/build 14:43:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:43:15 INFO - Running post-action listener: _resource_record_post_action 14:43:15 INFO - [mozharness: 2017-09-16 21:43:15.618678Z] Finished clobber step (success) 14:43:15 INFO - [mozharness: 2017-09-16 21:43:15.618775Z] Running read-buildbot-config step. 14:43:15 INFO - Running pre-action listener: _resource_record_pre_action 14:43:15 INFO - Running main action method: read_buildbot_config 14:43:15 INFO - Using buildbot properties: 14:43:15 INFO - { 14:43:15 INFO - "project": "", 14:43:15 INFO - "product": "firefox", 14:43:15 INFO - "who": "ryanvm@gmail.com", 14:43:15 INFO - "installer_path": "public/build/target.tar.bz2", 14:43:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 14:43:15 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 14:43:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 14:43:15 INFO - "stage_platform": "linux64", 14:43:15 INFO - "basedir": "/builds/slave/test", 14:43:15 INFO - "buildnumber": 27, 14:43:15 INFO - "platform": "ubuntu64_hw", 14:43:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:43:15 INFO - "slavebuilddir": "test", 14:43:15 INFO - "taskId": "ff3xSNk3SK6oMyHT5UGJYw", 14:43:15 INFO - "branch": "mozilla-central", 14:43:15 INFO - "script_repo_revision": "production", 14:43:15 INFO - "revision": "45b63125a4301eb89e7a4d70d0da1c650f11c7e4", 14:43:15 INFO - "slavename": "talos-linux64-ix-058", 14:43:15 INFO - "repo_path": "mozilla-central" 14:43:15 INFO - } 14:43:15 INFO - Finding installer, test and symbols from parent task. 14:43:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ff3xSNk3SK6oMyHT5UGJYw'}, attempt #1 14:43:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ff3xSNk3SK6oMyHT5UGJYw'}, attempt #1 14:43:16 INFO - Task dependencies: YmktQZGVQlizREbTDMsobw 14:43:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw'}, attempt #1 14:43:16 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.tar.bz2 14:43:16 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.test_packages.json 14:43:16 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.crashreporter-symbols.zip 14:43:16 INFO - Running post-action listener: _resource_record_post_action 14:43:16 INFO - [mozharness: 2017-09-16 21:43:16.983418Z] Finished read-buildbot-config step (success) 14:43:16 INFO - [mozharness: 2017-09-16 21:43:16.983635Z] Running download-and-extract step. 14:43:16 INFO - Running pre-action listener: _resource_record_pre_action 14:43:16 INFO - Running main action method: download_and_extract 14:43:16 INFO - mkdir: /builds/slave/test/build/tests 14:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:16 INFO - trying https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.test_packages.json 14:43:16 INFO - Downloading https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:43:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:43:17 INFO - Downloaded 989 bytes. 14:43:17 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:43:17 INFO - Using the following test package requirements: 14:43:17 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:43:17 INFO - u'common': [u'target.common.tests.zip'], 14:43:17 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:43:17 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:43:17 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:43:17 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:43:17 INFO - u'mozbase': [u'target.common.tests.zip'], 14:43:17 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:43:17 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:43:17 INFO - u'web-platform': [u'target.common.tests.zip', 14:43:17 INFO - u'target.web-platform.tests.tar.gz'], 14:43:17 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:43:17 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 14:43:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.common.tests.zip 14:43:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:43:17 INFO - Fetch https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.common.tests.zip into memory 14:43:18 INFO - Content-Length response header: 54731132 14:43:18 INFO - Bytes received: 54731132 14:43:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.talos.tests.zip 14:43:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:43:29 INFO - Fetch https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.talos.tests.zip into memory 14:43:30 INFO - Content-Length response header: 14508748 14:43:30 INFO - Bytes received: 14508748 14:43:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:30 INFO - trying https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.tar.bz2 14:43:30 INFO - Downloading https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:43:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:43:31 INFO - Downloaded 61464140 bytes. 14:43:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.tar.bz2 14:43:31 INFO - mkdir: /builds/slave/test/properties 14:43:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:43:31 INFO - Writing to file /builds/slave/test/properties/build_url 14:43:31 INFO - Contents: 14:43:31 INFO - build_url:https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.tar.bz2 14:43:31 INFO - Running post-action listener: _resource_record_post_action 14:43:31 INFO - Running post-action listener: find_tests_for_verification 14:43:31 INFO - Running post-action listener: set_extra_try_arguments 14:43:31 INFO - [mozharness: 2017-09-16 21:43:31.634777Z] Finished download-and-extract step (success) 14:43:31 INFO - [mozharness: 2017-09-16 21:43:31.634872Z] Running populate-webroot step. 14:43:31 INFO - Running pre-action listener: _resource_record_pre_action 14:43:31 INFO - Running main action method: populate_webroot 14:43:31 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:43:31 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:43:31 INFO - 'tests': ['tresize', 14:43:31 INFO - 'tcanvasmark']}, 14:43:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:43:31 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:43:31 INFO - 'tests': ['dromaeo_css', 14:43:31 INFO - 'kraken']}, 14:43:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:43:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:43:31 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:43:31 INFO - 'talos_options': ['--disable-stylo'], 14:43:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:43:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:43:31 INFO - 'tests': ['damp', 'tps']}, 14:43:31 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:43:31 INFO - 'talos_options': ['--disable-stylo'], 14:43:31 INFO - 'tests': ['damp', 'tps']}, 14:43:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:43:31 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:43:31 INFO - 'tests': ['dromaeo_dom']}, 14:43:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:43:31 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:43:31 INFO - 'tests': ['basic_compositor_video', 14:43:31 INFO - 'glvideo']}, 14:43:31 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:43:31 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:43:31 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:43:31 INFO - 'talos_options': ['--disable-stylo'], 14:43:31 INFO - 'tests': ['ts_paint_webext', 14:43:31 INFO - 'tp5o_webext']}, 14:43:31 INFO - 'other-e10s': {'tests': ['a11yr', 14:43:31 INFO - 'ts_paint', 14:43:31 INFO - 'tpaint', 14:43:31 INFO - 'sessionrestore', 14:43:31 INFO - 'sessionrestore_many_windows', 14:43:31 INFO - 'sessionrestore_no_auto_restore', 14:43:31 INFO - 'tabpaint']}, 14:43:31 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:43:31 INFO - 'tests': ['a11yr', 14:43:31 INFO - 'ts_paint', 14:43:31 INFO - 'tpaint', 14:43:31 INFO - 'sessionrestore', 14:43:31 INFO - 'sessionrestore_many_windows', 14:43:31 INFO - 'sessionrestore_no_auto_restore', 14:43:31 INFO - 'tabpaint']}, 14:43:31 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 14:43:31 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 14:43:31 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:43:31 INFO - 'tests': ['perf_reftest_singletons']}, 14:43:31 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:43:31 INFO - 'tests': ['bloom_basic']}, 14:43:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:43:31 INFO - 'tsvgr_opacity', 14:43:31 INFO - 'tart', 14:43:31 INFO - 'tscrollx', 14:43:31 INFO - 'tsvg_static']}, 14:43:31 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:43:31 INFO - 'tests': ['tsvgx', 14:43:31 INFO - 'tsvgr_opacity', 14:43:31 INFO - 'tart', 14:43:31 INFO - 'tscrollx', 14:43:31 INFO - 'tsvg_static']}, 14:43:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:43:31 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:43:31 INFO - 'talos_options': ['--disable-stylo'], 14:43:31 INFO - 'tests': ['tp5o']}, 14:43:31 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:43:31 INFO - 'talos_options': ['--mitmproxy', 14:43:31 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:43:31 INFO - '--firstNonBlankPaint'], 14:43:31 INFO - 'tests': ['tp6_google', 14:43:31 INFO - 'tp6_youtube', 14:43:31 INFO - 'tp6_amazon', 14:43:31 INFO - 'tp6_facebook']}, 14:43:31 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:43:31 INFO - 'talos_options': ['--disable-stylo', 14:43:31 INFO - '--mitmproxy', 14:43:31 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:43:31 INFO - '--firstNonBlankPaint'], 14:43:31 INFO - 'tests': ['tp6_google', 14:43:31 INFO - 'tp6_youtube', 14:43:31 INFO - 'tp6_amazon', 14:43:31 INFO - 'tp6_facebook']}, 14:43:31 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:43:31 INFO - 'talos_options': ['--stylo-threads=1', 14:43:31 INFO - '--mitmproxy', 14:43:31 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:43:31 INFO - '--firstNonBlankPaint'], 14:43:31 INFO - 'tests': ['tp6_google', 14:43:31 INFO - 'tp6_youtube', 14:43:31 INFO - 'tp6_amazon', 14:43:31 INFO - 'tp6_facebook']}, 14:43:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:43:31 INFO - 'talos_options': ['--xperf_path', 14:43:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:43:31 INFO - 'tests': ['tp5n']}, 14:43:31 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:43:31 INFO - 'talos_options': ['--disable-stylo', 14:43:31 INFO - '--xperf_path', 14:43:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:43:31 INFO - 'tests': ['tp5n']}}} 14:43:31 INFO - Running post-action listener: _resource_record_post_action 14:43:31 INFO - [mozharness: 2017-09-16 21:43:31.649882Z] Finished populate-webroot step (success) 14:43:31 INFO - [mozharness: 2017-09-16 21:43:31.649972Z] Running create-virtualenv step. 14:43:31 INFO - Running pre-action listener: _resource_record_pre_action 14:43:31 INFO - Running main action method: create_virtualenv 14:43:31 INFO - Creating virtualenv /builds/slave/test/build/venv 14:43:31 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:43:31 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 14:43:31 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 14:43:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:43:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:43:32 INFO - Installing distribute.............................................................................................................................................................................................done. 14:43:33 INFO - Installing pip...............done. 14:43:33 INFO - Return code: 0 14:43:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:43:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:43:33 INFO - Reading from file tmpfile_stdout 14:43:33 INFO - Output received: 14:43:33 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 14:43:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:43:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d55a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc090>, '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 0x1efcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441', '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 14:43:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:43:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:43:33 INFO - Using env: {'DISPLAY': ':0', 14:43:33 INFO - 'HOME': '/home/cltbld', 14:43:33 INFO - 'LANG': 'en_US.UTF-8', 14:43:33 INFO - 'LANGUAGE': 'en_US:en', 14:43:33 INFO - 'LOGNAME': 'cltbld', 14:43:33 INFO - 'MAIL': '/var/mail/cltbld', 14:43:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:33 INFO - 'MOZ_NO_REMOTE': '1', 14:43:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:33 INFO - 'NO_EM_RESTART': '1', 14:43:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:33 INFO - 'PWD': '/builds/slave/test', 14:43:33 INFO - 'SHELL': '/bin/bash', 14:43:33 INFO - 'SHLVL': '1', 14:43:33 INFO - 'TERM': 'linux', 14:43:33 INFO - 'TMOUT': '86400', 14:43:33 INFO - 'USER': 'cltbld', 14:43:33 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441', 14:43:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:33 INFO - '_': '/tools/buildbot/bin/python'} 14:43:34 INFO - Ignoring indexes: http://pypi.python.org/simple/ 14:43:34 INFO - Downloading/unpacking pip>=1.5 14:43:34 INFO - Running setup.py egg_info for package pip 14:43:34 INFO - warning: no files found matching 'pip/cacert.pem' 14:43:34 INFO - warning: no files found matching '*.html' under directory 'docs' 14:43:34 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 14:43:34 INFO - no previously-included directories found matching 'docs/_build/_sources' 14:43:34 INFO - Installing collected packages: pip 14:43:34 INFO - Found existing installation: pip 1.1 14:43:34 INFO - Uninstalling pip: 14:43:34 INFO - Successfully uninstalled pip 14:43:34 INFO - Running setup.py install for pip 14:43:34 INFO - warning: no files found matching 'pip/cacert.pem' 14:43:34 INFO - warning: no files found matching '*.html' under directory 'docs' 14:43:34 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 14:43:34 INFO - no previously-included directories found matching 'docs/_build/_sources' 14:43:34 INFO - Installing pip script to /builds/slave/test/build/venv/bin 14:43:34 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 14:43:34 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 14:43:34 INFO - Successfully installed pip 14:43:34 INFO - Cleaning up... 14:43:34 INFO - Return code: 0 14:43:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:43:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d55a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc090>, '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 0x1efcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441', '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 14:43:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:43:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:43:34 INFO - Using env: {'DISPLAY': ':0', 14:43:34 INFO - 'HOME': '/home/cltbld', 14:43:34 INFO - 'LANG': 'en_US.UTF-8', 14:43:34 INFO - 'LANGUAGE': 'en_US:en', 14:43:34 INFO - 'LOGNAME': 'cltbld', 14:43:34 INFO - 'MAIL': '/var/mail/cltbld', 14:43:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:34 INFO - 'MOZ_NO_REMOTE': '1', 14:43:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:34 INFO - 'NO_EM_RESTART': '1', 14:43:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:34 INFO - 'PWD': '/builds/slave/test', 14:43:34 INFO - 'SHELL': '/bin/bash', 14:43:34 INFO - 'SHLVL': '1', 14:43:34 INFO - 'TERM': 'linux', 14:43:34 INFO - 'TMOUT': '86400', 14:43:34 INFO - 'USER': 'cltbld', 14:43:34 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441', 14:43:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:34 INFO - '_': '/tools/buildbot/bin/python'} 14:43:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:34 INFO - Downloading/unpacking psutil>=3.1.1 14:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:43:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:43:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:43:36 INFO - Installing collected packages: psutil 14:43:36 INFO - Running setup.py install for psutil 14:43:36 INFO - building 'psutil._psutil_linux' extension 14:43:36 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 14:43:36 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 14:43:36 INFO - building 'psutil._psutil_posix' extension 14:43:36 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 14:43:36 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 14:43:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:43:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:43:36 INFO - Successfully installed psutil 14:43:36 INFO - Cleaning up... 14:43:36 INFO - Return code: 0 14:43:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:43:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:36 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 0x1b8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d55a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc090>, '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 0x1efcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441', '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 14:43:36 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 14:43:36 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 14:43:36 INFO - Using env: {'DISPLAY': ':0', 14:43:36 INFO - 'HOME': '/home/cltbld', 14:43:36 INFO - 'LANG': 'en_US.UTF-8', 14:43:36 INFO - 'LANGUAGE': 'en_US:en', 14:43:36 INFO - 'LOGNAME': 'cltbld', 14:43:36 INFO - 'MAIL': '/var/mail/cltbld', 14:43:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:36 INFO - 'MOZ_NO_REMOTE': '1', 14:43:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:36 INFO - 'NO_EM_RESTART': '1', 14:43:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:36 INFO - 'PWD': '/builds/slave/test', 14:43:36 INFO - 'SHELL': '/bin/bash', 14:43:36 INFO - 'SHLVL': '1', 14:43:36 INFO - 'TERM': 'linux', 14:43:36 INFO - 'TMOUT': '86400', 14:43:36 INFO - 'USER': 'cltbld', 14:43:36 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441', 14:43:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:36 INFO - '_': '/tools/buildbot/bin/python'} 14:43:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:43:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:43:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:43:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:43:38 INFO - Installing collected packages: mozsystemmonitor 14:43:38 INFO - Running setup.py install for mozsystemmonitor 14:43:38 INFO - Successfully installed mozsystemmonitor 14:43:38 INFO - Cleaning up... 14:43:39 INFO - Return code: 0 14:43:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:43:39 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')]} 14:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:39 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')]} 14:43:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:39 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 0x1b8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d55a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc090>, '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 0x1efcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441', '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 14:43:39 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 14:43:39 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 14:43:39 INFO - Using env: {'DISPLAY': ':0', 14:43:39 INFO - 'HOME': '/home/cltbld', 14:43:39 INFO - 'LANG': 'en_US.UTF-8', 14:43:39 INFO - 'LANGUAGE': 'en_US:en', 14:43:39 INFO - 'LOGNAME': 'cltbld', 14:43:39 INFO - 'MAIL': '/var/mail/cltbld', 14:43:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:39 INFO - 'MOZ_NO_REMOTE': '1', 14:43:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:39 INFO - 'NO_EM_RESTART': '1', 14:43:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:39 INFO - 'PWD': '/builds/slave/test', 14:43:39 INFO - 'SHELL': '/bin/bash', 14:43:39 INFO - 'SHLVL': '1', 14:43:39 INFO - 'TERM': 'linux', 14:43:39 INFO - 'TMOUT': '86400', 14:43:39 INFO - 'USER': 'cltbld', 14:43:39 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441', 14:43:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:39 INFO - '_': '/tools/buildbot/bin/python'} 14:43:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:39 INFO - Downloading/unpacking jsonschema==2.5.1 14:43:39 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 14:43:39 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 14:43:39 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 14:43:39 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 14:43:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:43:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:43:40 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 14:43:40 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 14:43:40 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 14:43:40 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 14:43:41 INFO - Downloading functools32-3.2.3-2.tar.gz 14:43:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:43:41 INFO - warning: no files found matching '*.txt' 14:43:41 INFO - no previously-included directories found matching 'build' 14:43:41 INFO - no previously-included directories found matching 'dist' 14:43:41 INFO - no previously-included directories found matching '.git*' 14:43:41 INFO - Installing collected packages: jsonschema, functools32 14:43:41 INFO - Running setup.py install for functools32 14:43:41 INFO - warning: no files found matching '*.txt' 14:43:41 INFO - no previously-included directories found matching 'build' 14:43:41 INFO - no previously-included directories found matching 'dist' 14:43:41 INFO - no previously-included directories found matching '.git*' 14:43:41 INFO - Successfully installed jsonschema functools32 14:43:41 INFO - Cleaning up... 14:43:41 INFO - Return code: 0 14:43:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:43:41 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')]} 14:43:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:41 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')]} 14:43:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:41 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 0x1b8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d55a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc090>, '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 0x1efcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441', '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 14:43:41 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 14:43:41 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 14:43:41 INFO - Using env: {'DISPLAY': ':0', 14:43:41 INFO - 'HOME': '/home/cltbld', 14:43:41 INFO - 'LANG': 'en_US.UTF-8', 14:43:41 INFO - 'LANGUAGE': 'en_US:en', 14:43:41 INFO - 'LOGNAME': 'cltbld', 14:43:41 INFO - 'MAIL': '/var/mail/cltbld', 14:43:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:41 INFO - 'MOZ_NO_REMOTE': '1', 14:43:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:41 INFO - 'NO_EM_RESTART': '1', 14:43:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:41 INFO - 'PWD': '/builds/slave/test', 14:43:41 INFO - 'SHELL': '/bin/bash', 14:43:41 INFO - 'SHLVL': '1', 14:43:41 INFO - 'TERM': 'linux', 14:43:41 INFO - 'TMOUT': '86400', 14:43:41 INFO - 'USER': 'cltbld', 14:43:41 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441', 14:43:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:41 INFO - '_': '/tools/buildbot/bin/python'} 14:43:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:43:41 INFO - Cleaning up... 14:43:41 INFO - Return code: 0 14:43:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:43:41 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')]} 14:43:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:41 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')]} 14:43:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:41 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 0x1b8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d55a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc090>, '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 0x1efcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441', '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 14:43:41 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 14:43:41 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 14:43:41 INFO - Using env: {'DISPLAY': ':0', 14:43:41 INFO - 'HOME': '/home/cltbld', 14:43:41 INFO - 'LANG': 'en_US.UTF-8', 14:43:41 INFO - 'LANGUAGE': 'en_US:en', 14:43:41 INFO - 'LOGNAME': 'cltbld', 14:43:41 INFO - 'MAIL': '/var/mail/cltbld', 14:43:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:41 INFO - 'MOZ_NO_REMOTE': '1', 14:43:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:41 INFO - 'NO_EM_RESTART': '1', 14:43:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:41 INFO - 'PWD': '/builds/slave/test', 14:43:41 INFO - 'SHELL': '/bin/bash', 14:43:41 INFO - 'SHLVL': '1', 14:43:41 INFO - 'TERM': 'linux', 14:43:41 INFO - 'TMOUT': '86400', 14:43:41 INFO - 'USER': 'cltbld', 14:43:41 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441', 14:43:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:41 INFO - '_': '/tools/buildbot/bin/python'} 14:43:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:41 INFO - Downloading/unpacking blobuploader==1.2.4 14:43:41 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 14:43:41 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 14:43:41 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 14:43:41 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 14:43:42 INFO - Downloading blobuploader-1.2.4.tar.gz 14:43:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:43:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:43:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:43:43 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 14:43:43 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 14:43:43 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 14:43:43 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 14:43:43 INFO - Downloading docopt-0.6.1.tar.gz 14:43:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:43:43 INFO - Installing collected packages: blobuploader, requests, docopt 14:43:43 INFO - Running setup.py install for blobuploader 14:43:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:43:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:43:43 INFO - Running setup.py install for requests 14:43:43 INFO - Running setup.py install for docopt 14:43:44 INFO - Successfully installed blobuploader requests docopt 14:43:44 INFO - Cleaning up... 14:43:44 INFO - Return code: 0 14:43:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:43:44 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')]} 14:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:44 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')]} 14:43:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:44 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 0x1b8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d55a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc090>, '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 0x1efcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441', '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 14:43:44 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 14:43:44 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 14:43:44 INFO - Using env: {'DISPLAY': ':0', 14:43:44 INFO - 'HOME': '/home/cltbld', 14:43:44 INFO - 'LANG': 'en_US.UTF-8', 14:43:44 INFO - 'LANGUAGE': 'en_US:en', 14:43:44 INFO - 'LOGNAME': 'cltbld', 14:43:44 INFO - 'MAIL': '/var/mail/cltbld', 14:43:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:44 INFO - 'MOZ_NO_REMOTE': '1', 14:43:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:44 INFO - 'NO_EM_RESTART': '1', 14:43:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:44 INFO - 'PWD': '/builds/slave/test', 14:43:44 INFO - 'SHELL': '/bin/bash', 14:43:44 INFO - 'SHLVL': '1', 14:43:44 INFO - 'TERM': 'linux', 14:43:44 INFO - 'TMOUT': '86400', 14:43:44 INFO - 'USER': 'cltbld', 14:43:44 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441', 14:43:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:44 INFO - '_': '/tools/buildbot/bin/python'} 14:43:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:43:44 INFO - Running setup.py (path:/tmp/pip-EbFQ6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:43:44 INFO - Running setup.py (path:/tmp/pip-IGRBG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:43:44 INFO - Running setup.py (path:/tmp/pip-wFzfpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:43:44 INFO - Running setup.py (path:/tmp/pip-uzOiPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:43:44 INFO - Running setup.py (path:/tmp/pip-hgW0SB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:43:44 INFO - Running setup.py (path:/tmp/pip-BCu_Ab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:43:44 INFO - Running setup.py (path:/tmp/pip-2qhk9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:43:44 INFO - Running setup.py (path:/tmp/pip-brpVpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:43:44 INFO - Running setup.py (path:/tmp/pip-iWP5h2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:43:44 INFO - Running setup.py (path:/tmp/pip-Oxzf3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:43:44 INFO - Running setup.py (path:/tmp/pip-PnYe6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:43:45 INFO - Running setup.py (path:/tmp/pip-0mWO69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:43:45 INFO - Running setup.py (path:/tmp/pip-OS79GP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:43:45 INFO - Running setup.py (path:/tmp/pip-wf2jSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:43:45 INFO - Running setup.py (path:/tmp/pip-L86aeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:43:45 INFO - Running setup.py (path:/tmp/pip-9v1j4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:43:45 INFO - Running setup.py (path:/tmp/pip-MJupru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:43:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:43:45 INFO - Running setup.py install for manifestparser 14:43:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:43:45 INFO - Running setup.py install for mozcrash 14:43:45 INFO - Running setup.py install for mozdebug 14:43:45 INFO - Running setup.py install for mozdevice 14:43:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:43:45 INFO - Running setup.py install for mozfile 14:43:45 INFO - Running setup.py install for mozhttpd 14:43:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:43:46 INFO - Running setup.py install for mozinfo 14:43:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:43:46 INFO - Running setup.py install for mozInstall 14:43:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:43:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:43:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:43:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:43:46 INFO - Running setup.py install for mozleak 14:43:46 INFO - Running setup.py install for mozlog 14:43:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:43:46 INFO - Running setup.py install for moznetwork 14:43:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:43:46 INFO - Running setup.py install for mozprocess 14:43:46 INFO - Running setup.py install for mozprofile 14:43:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:43:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:43:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:43:46 INFO - Running setup.py install for mozrunner 14:43:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:43:46 INFO - Running setup.py install for mozscreenshot 14:43:47 INFO - Running setup.py install for moztest 14:43:47 INFO - Running setup.py install for mozversion 14:43:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:43:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:43:47 INFO - Cleaning up... 14:43:47 INFO - Return code: 0 14:43:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:47 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 0x1b8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d55a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc090>, '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 0x1efcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441', '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 14:43:47 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 14:43:47 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 14:43:47 INFO - Using env: {'DISPLAY': ':0', 14:43:47 INFO - 'HOME': '/home/cltbld', 14:43:47 INFO - 'LANG': 'en_US.UTF-8', 14:43:47 INFO - 'LANGUAGE': 'en_US:en', 14:43:47 INFO - 'LOGNAME': 'cltbld', 14:43:47 INFO - 'MAIL': '/var/mail/cltbld', 14:43:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:47 INFO - 'MOZ_NO_REMOTE': '1', 14:43:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:47 INFO - 'NO_EM_RESTART': '1', 14:43:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:47 INFO - 'PWD': '/builds/slave/test', 14:43:47 INFO - 'SHELL': '/bin/bash', 14:43:47 INFO - 'SHLVL': '1', 14:43:47 INFO - 'TERM': 'linux', 14:43:47 INFO - 'TMOUT': '86400', 14:43:47 INFO - 'USER': 'cltbld', 14:43:47 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441', 14:43:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:47 INFO - '_': '/tools/buildbot/bin/python'} 14:43:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:43:47 INFO - Running setup.py (path:/tmp/pip-AIxb2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:43:47 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)) 14:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:43:47 INFO - Running setup.py (path:/tmp/pip-B5Mc91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:43:47 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)) 14:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:43:47 INFO - Running setup.py (path:/tmp/pip-64rhX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:43:47 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)) 14:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:43:47 INFO - Running setup.py (path:/tmp/pip-NSJXPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:43:47 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)) 14:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:43:47 INFO - Running setup.py (path:/tmp/pip-ozwDUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:43:47 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)) 14:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:43:47 INFO - Running setup.py (path:/tmp/pip-DjDC4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:43:47 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)) 14:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:43:47 INFO - Running setup.py (path:/tmp/pip-28cGnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:43:47 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)) 14:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:43:47 INFO - Running setup.py (path:/tmp/pip-V8wocI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:43:48 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)) 14:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:43:48 INFO - Running setup.py (path:/tmp/pip-3eq_V5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:43:48 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)) 14:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:43:48 INFO - Running setup.py (path:/tmp/pip-HZNQ5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:43:48 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)) 14:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:43:48 INFO - Running setup.py (path:/tmp/pip-SRh6iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:43:48 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)) 14:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:43:48 INFO - Running setup.py (path:/tmp/pip-JC2KDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:43:48 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)) 14:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:43:48 INFO - Running setup.py (path:/tmp/pip-G6A3Sm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:43:48 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)) 14:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:43:48 INFO - Running setup.py (path:/tmp/pip-n48yBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:43:48 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)) 14:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:43:48 INFO - Running setup.py (path:/tmp/pip-KGQJ36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:43:48 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)) 14:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:43:48 INFO - Running setup.py (path:/tmp/pip-zCxpB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:43:48 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)) 14:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:43:48 INFO - Running setup.py (path:/tmp/pip-ChRCku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:43:48 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)) 14:43:48 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)) 14:43:48 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)) 14:43:48 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)) 14:43:48 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)) 14:43:48 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)) 14:43:48 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)) 14:43:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:43:48 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 14:43:48 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 14:43:48 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 14:43:48 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 14:43:49 INFO - Downloading blessings-1.6.tar.gz 14:43:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:43:49 INFO - Installing collected packages: blessings 14:43:49 INFO - Running setup.py install for blessings 14:43:49 INFO - Successfully installed blessings 14:43:49 INFO - Cleaning up... 14:43:50 INFO - Return code: 0 14:43:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:43:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:43:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:43:50 INFO - Reading from file tmpfile_stdout 14:43:50 INFO - Current package versions: 14:43:50 INFO - argparse == 1.2.1 14:43:50 INFO - blessings == 1.6 14:43:50 INFO - blobuploader == 1.2.4 14:43:50 INFO - docopt == 0.6.1 14:43:50 INFO - functools32 == 3.2.3-2 14:43:50 INFO - jsonschema == 2.5.1 14:43:50 INFO - manifestparser == 1.1 14:43:50 INFO - mozInstall == 1.13 14:43:50 INFO - mozcrash == 1.0 14:43:50 INFO - mozdebug == 0.1 14:43:50 INFO - mozdevice == 0.51 14:43:50 INFO - mozfile == 1.2 14:43:50 INFO - mozhttpd == 0.7 14:43:50 INFO - mozinfo == 0.10 14:43:50 INFO - mozleak == 0.1 14:43:50 INFO - mozlog == 3.5 14:43:50 INFO - moznetwork == 0.27 14:43:50 INFO - mozprocess == 0.25 14:43:50 INFO - mozprofile == 0.28 14:43:50 INFO - mozrunner == 6.13 14:43:50 INFO - mozscreenshot == 0.1 14:43:50 INFO - mozsystemmonitor == 0.3 14:43:50 INFO - moztest == 0.8 14:43:50 INFO - mozversion == 1.4 14:43:50 INFO - psutil == 3.1.1 14:43:50 INFO - requests == 1.2.3 14:43:50 INFO - wsgiref == 0.1.2 14:43:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:50 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 0x1b8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d55a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc090>, '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 0x1efcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441', '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 14:43:50 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 14:43:50 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 14:43:50 INFO - Using env: {'DISPLAY': ':0', 14:43:50 INFO - 'HOME': '/home/cltbld', 14:43:50 INFO - 'LANG': 'en_US.UTF-8', 14:43:50 INFO - 'LANGUAGE': 'en_US:en', 14:43:50 INFO - 'LOGNAME': 'cltbld', 14:43:50 INFO - 'MAIL': '/var/mail/cltbld', 14:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:50 INFO - 'MOZ_NO_REMOTE': '1', 14:43:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:50 INFO - 'NO_EM_RESTART': '1', 14:43:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:50 INFO - 'PWD': '/builds/slave/test', 14:43:50 INFO - 'SHELL': '/bin/bash', 14:43:50 INFO - 'SHLVL': '1', 14:43:50 INFO - 'TERM': 'linux', 14:43:50 INFO - 'TMOUT': '86400', 14:43:50 INFO - 'USER': 'cltbld', 14:43:50 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441', 14:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:50 INFO - '_': '/tools/buildbot/bin/python'} 14:43:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:50 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)) 14:43:50 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)) 14:43:50 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)) 14:43:50 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)) 14:43:50 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)) 14:43:50 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)) 14:43:50 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)) 14:43:50 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)) 14:43:50 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)) 14:43:50 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 14:43:51 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)) 14:43:51 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)) 14:43:51 INFO - Installing collected packages: simplejson 14:43:51 INFO - Running setup.py install for simplejson 14:43:51 INFO - building 'simplejson._speedups' extension 14:43:51 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 14:43:52 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 14:43:52 INFO - Successfully installed simplejson 14:43:52 INFO - Cleaning up... 14:43:52 INFO - Return code: 0 14:43:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:43: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')]} 14:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43: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')]} 14:43:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d55a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc090>, '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 0x1efcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441', '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 14:43:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:43:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:43:52 INFO - Using env: {'DISPLAY': ':0', 14:43:52 INFO - 'HOME': '/home/cltbld', 14:43:52 INFO - 'LANG': 'en_US.UTF-8', 14:43:52 INFO - 'LANGUAGE': 'en_US:en', 14:43:52 INFO - 'LOGNAME': 'cltbld', 14:43:52 INFO - 'MAIL': '/var/mail/cltbld', 14:43:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:52 INFO - 'MOZ_NO_REMOTE': '1', 14:43:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:52 INFO - 'NO_EM_RESTART': '1', 14:43:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:52 INFO - 'PWD': '/builds/slave/test', 14:43:52 INFO - 'SHELL': '/bin/bash', 14:43:52 INFO - 'SHLVL': '1', 14:43:52 INFO - 'TERM': 'linux', 14:43:52 INFO - 'TMOUT': '86400', 14:43:52 INFO - 'USER': 'cltbld', 14:43:52 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441', 14:43:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:52 INFO - '_': '/tools/buildbot/bin/python'} 14:43:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:43:52 INFO - Cleaning up... 14:43:52 INFO - Return code: 0 14:43:52 INFO - Running post-action listener: _resource_record_post_action 14:43:52 INFO - Running post-action listener: _start_resource_monitoring 14:43:52 INFO - Starting resource monitoring. 14:43:52 INFO - [mozharness: 2017-09-16 21:43:52.939297Z] Finished create-virtualenv step (success) 14:43:52 INFO - [mozharness: 2017-09-16 21:43:52.939880Z] Running install step. 14:43:52 INFO - Running pre-action listener: _resource_record_pre_action 14:43:52 INFO - Running main action method: install 14:43:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:43:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:43:53 INFO - Reading from file tmpfile_stdout 14:43:53 INFO - Detecting whether we're running mozinstall >=1.0... 14:43:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:43:53 INFO - Reading from file tmpfile_stdout 14:43:53 INFO - Output received: 14:43:53 INFO - Usage: mozinstall [options] installer 14:43:53 INFO - Options: 14:43:53 INFO - -h, --help show this help message and exit 14:43:53 INFO - -d DEST, --destination=DEST 14:43:53 INFO - Directory to install application into. [default: 14:43:53 INFO - "/builds/slave/test"] 14:43:53 INFO - --app=APP Application being installed. [default: firefox] 14:43:53 INFO - mkdir: /builds/slave/test/build/application 14:43:53 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'] 14:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:44:11 INFO - Reading from file tmpfile_stdout 14:44:11 INFO - Output received: 14:44:11 INFO - /builds/slave/test/build/application/firefox/firefox 14:44:11 INFO - Running post-action listener: _resource_record_post_action 14:44:11 INFO - [mozharness: 2017-09-16 21:44:11.059987Z] Finished install step (success) 14:44:11 INFO - [mozharness: 2017-09-16 21:44:11.060238Z] Running setup-mitmproxy step. 14:44:11 INFO - Running pre-action listener: _resource_record_pre_action 14:44:11 INFO - Running main action method: setup_mitmproxy 14:44:11 INFO - Skipping: mitmproxy is not required 14:44:11 INFO - Running post-action listener: _resource_record_post_action 14:44:11 INFO - [mozharness: 2017-09-16 21:44:11.061370Z] Finished setup-mitmproxy step (success) 14:44:11 INFO - [mozharness: 2017-09-16 21:44:11.061591Z] Running run-tests step. 14:44:11 INFO - Running pre-action listener: _resource_record_pre_action 14:44:11 INFO - Running pre-action listener: _set_gcov_prefix 14:44:11 INFO - Running main action method: run_tests 14:44:11 WARNING - Try message not found. 14:44:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:44:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:44:11 INFO - Python 2.7.3 14:44:11 INFO - Return code: 0 14:44:11 INFO - grabbing minidump binary from tooltool 14:44: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')]} 14:44:11 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 0x1efc090>, '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 0x1efcd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:44:11 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 14:44:11 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 14:44:11 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 14:44:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:44:11 INFO - Return code: 0 14:44:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:44:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:44:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:44:11 INFO - ENV: RUST_BACKTRACE is now full 14:44:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:44:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:44:11 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/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 14:44:11 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/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 14:44:11 INFO - Using env: {'DISPLAY': ':0', 14:44:11 INFO - 'HOME': '/home/cltbld', 14:44:11 INFO - 'LANG': 'en_US.UTF-8', 14:44:11 INFO - 'LANGUAGE': 'en_US:en', 14:44:11 INFO - 'LOGNAME': 'cltbld', 14:44:11 INFO - 'MAIL': '/var/mail/cltbld', 14:44:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:44:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:44:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:44:11 INFO - 'MOZ_NO_REMOTE': '1', 14:44:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:44:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:44:11 INFO - 'NO_EM_RESTART': '1', 14:44:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:44:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:44:11 INFO - 'PWD': '/builds/slave/test', 14:44:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:44:11 INFO - 'RUST_BACKTRACE': 'full', 14:44:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:44:11 INFO - 'SHELL': '/bin/bash', 14:44:11 INFO - 'SHLVL': '1', 14:44:11 INFO - 'TERM': 'linux', 14:44:11 INFO - 'TMOUT': '86400', 14:44:11 INFO - 'USER': 'cltbld', 14:44:11 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441', 14:44:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:44:11 INFO - '_': '/tools/buildbot/bin/python'} 14:44:11 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/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 14:44:11 INFO - mozversion application_buildid: 20170916205151 14:44:11 INFO - mozversion application_changeset: 45b63125a4301eb89e7a4d70d0da1c650f11c7e4 14:44:11 INFO - mozversion application_display_name: Nightly 14:44:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:44:11 INFO - mozversion application_name: Firefox 14:44:11 INFO - mozversion application_remotingname: firefox 14:44:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:44:11 INFO - mozversion application_vendor: Mozilla 14:44:11 INFO - mozversion application_version: 57.0a1 14:44:11 INFO - mozversion platform_buildid: 20170916205151 14:44:11 INFO - mozversion platform_changeset: 45b63125a4301eb89e7a4d70d0da1c650f11c7e4 14:44:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:44:11 INFO - mozversion platform_version: 57.0a1 14:44:11 INFO - using testdate: 1505598251 14:44:11 INFO - actual date: 1505598251 14:44:11 INFO - starting webserver on 'localhost:37160' 14:44:11 INFO - SUITE-START | Running 2 tests 14:44:11 INFO - TEST-START | dromaeo_css 14:44:11 INFO - Initialising browser for dromaeo_css test... 14:44:11 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37160/getInfo.html -profile /tmp/tmpKHseac/profile 14:44:11 INFO - TEST-INFO | started process 5823 (/builds/slave/test/build/application/firefox/firefox http://localhost:37160/getInfo.html) 14:44:16 INFO - TEST-INFO | 5823: exit 0 14:44:17 INFO - Browser initialized. 14:44:17 INFO - Running cycle 1/1 for dromaeo_css test... 14:44:17 INFO - Using env: {'DISPLAY': ':0', 14:44:17 INFO - 'HOME': '/home/cltbld', 14:44:17 INFO - 'JSGC_DISABLE_POISONING': '1', 14:44:17 INFO - 'LANG': 'en_US.UTF-8', 14:44:17 INFO - 'LANGUAGE': 'en_US:en', 14:44:17 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:44:17 INFO - 'LOGNAME': 'cltbld', 14:44:17 INFO - 'MAIL': '/var/mail/cltbld', 14:44:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:44:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:44:17 INFO - 'MOZ_CRASHREPORTER': '1', 14:44:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:44:17 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:44:17 INFO - 'MOZ_NO_REMOTE': '1', 14:44:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:44:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:44:17 INFO - 'NO_EM_RESTART': '1', 14:44:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:44:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:44:17 INFO - 'PWD': '/builds/slave/test', 14:44:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:44:17 INFO - 'RUST_BACKTRACE': 'full', 14:44:17 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:44:17 INFO - 'SHELL': '/bin/bash', 14:44:17 INFO - 'SHLVL': '1', 14:44:17 INFO - 'STYLO_FORCE_DISABLED': '1', 14:44:17 INFO - 'TERM': 'linux', 14:44:17 INFO - 'TMOUT': '86400', 14:44:17 INFO - 'USER': 'cltbld', 14:44:17 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441', 14:44:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:44:17 INFO - '_': '/tools/buildbot/bin/python'} 14:44:17 INFO - TEST-INFO | started process 6053 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKHseac/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:44:17 INFO - PID 6053 | 14:44:17 INFO - PID 6053 | (/builds/slave/test/build/application/firefox/firefox:6102): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:44:17 INFO - PID 6053 | 14:44:28 INFO - PID 6053 | RSS: Main: 156971008 14:44:28 INFO - PID 6053 | 14:47:25 INFO - PID 6053 | Cycle 1(1): loaded http://localhost:37160/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37160/tests/dromaeo/cssquery-ext.html) 14:47:27 INFO - PID 6053 | RSS: Main: 156561408 14:47:27 INFO - PID 6053 | 14:50:28 INFO - PID 6053 | Cycle 1(1): loaded http://localhost:37160/tests/dromaeo/cssquery-ext.html (next: http://localhost:37160/tests/dromaeo/cssquery-jquery.html) 14:50:29 INFO - PID 6053 | RSS: Main: 155828224 14:50:29 INFO - PID 6053 | 14:53:31 INFO - PID 6053 | Cycle 1(1): loaded http://localhost:37160/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37160/tests/dromaeo/cssquery-mootools.html) 14:53:31 INFO - PID 6053 | RSS: Main: 157896704 14:53:31 INFO - PID 6053 | 14:56:33 INFO - PID 6053 | Cycle 1(1): loaded http://localhost:37160/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37160/tests/dromaeo/cssquery-prototype.html) 14:56:34 INFO - PID 6053 | RSS: Main: 156676096 14:56:34 INFO - PID 6053 | 14:59:37 INFO - PID 6053 | Cycle 1(1): loaded http://localhost:37160/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37160/tests/dromaeo/cssquery-yui.html) 14:59:38 INFO - PID 6053 | RSS: Main: 158359552 14:59:38 INFO - PID 6053 | 15:02:39 INFO - PID 6053 | Cycle 1(1): loaded http://localhost:37160/tests/dromaeo/cssquery-yui.html (next: http://localhost:37160/tests/dromaeo/cssquery-dojo.html) 15:02:39 INFO - PID 6053 | RSS: Main: 160862208 15:02:39 INFO - PID 6053 | 15:02:39 INFO - PID 6053 | __start_tp_report 15:02:39 INFO - PID 6053 | _x_x_mozilla_page_load 15:02:39 INFO - PID 6053 | _x_x_mozilla_page_load_details 15:02:39 INFO - PID 6053 | |i|pagename|runs| 15:02:39 INFO - PID 6053 | |0;dojo.html;3096.969030309697;3123.500239961606;3170.2549900773315;3181.634112077109;3193.185737636902;6161.291451483081;6268.623882567043;6342.397472240142;6379.744810207586;6380.425761681454;6269.968650156743;6352.618842869431;6442.226932768074;6445.516586256026;6451.129097571827;1207.272102818098;5500.669959802404;5834.56240781941;5872.677002764846;5950.137230101633;5643.943560564403;5702.914456283159;5719.25649665545;5863.736131874076;5866.442687944638;5677.858053548653;5716.828495145152;5730.426957304237;5734.053881109591;5738.7991420300505;5653.830385088454;5806.390329015435;5812.593118481708;5816.651000939957;5816.941830581683;5776.9422305776825;5801.390853960315;5861.6189947653265;5864.1203819427;5884.235049443545;6188.412100850457;6288.717007734663;6317.873642527124;6356.904646430307;6398.520110991648;6598.769043083469;6670.266270710218;6674.03226532155;6674.599524028574;6676.566023208476;6724.361185687352;6762.526623136382;6786.3892249697765;6885.862282754367;6896.896546551806;6332.746690132389;6362.713677884506;6366.586171898812;6369.140166077566;6371;6959.060526828915;6972.965135174291;6979.162500499972;7045.964770176116;7064.08166938305;6500.9349906501275;6594.340565943367;6597.043428702811;6610.735570577219;6695.564788288746;6797.082393876863;6812.4550035997;6820.215675197316;6822.079019332426;6823.044773731682;6719.596824190564;6788.864222715518;6797.9660101700165;6802.863942721118;6814.352636499525;6782.186137663413;6795.898061529081;6858.622775747382;6865.107536020385;6890.379865812101;5096.159133742891;5249.343832020997;5267.3152490176035;5296.629235953524;5361.705106219196;4596.103759766814;4627.5603817637275;4627.814887404466;4628.028114096078;4655.5577220164705;5853.473187413068;5862.208601838783;5924.822255332347;5940.079287710412;5941.049432090931;6800.251972283045;6829.7268109276065;6885.586864788129;6889.793306200822;6914.343137401939;5759.395263497357;5859.44335288147;5876.177335173079;5932.822015339547;5939.495142912814;5708.343540492813;5758;5762.798302059407;5770.826875193751;5781.479666829921;6618.305077966744;6637.5685580438085;6696.229933557704;6710.127683401127;6711.261761206263;6756.594604323756;6782.2200446948245;6785.59286442815;6873.450123990169;6881.518293719491;6434.2922278548385;6555.639439830855;6577.901331480128;6584.901226481702;6677.532572719863;6693.598384096775;6711.731530738716;6718.328167183243;6720.1263835703;6720.630365329758;6823.283555226828;6823.55646882951;6898.758543450955;6912.55068420551;6933.514653974174;6548.574342667712;6569.704363303567;6586.2755096940255;6664.66676666155;6672.499562532927;6404.807855764335;6531.477481801539;6536.182977127859;6536.477081833537;6538.574992625464;6390.137331460193;6432.967835160982;6477.902831457626;6549.869002619826;6581.868362632817;6617.147198784348;6700.597964121973;6728.831779205559;6758.695858686469;6760.290169532325;6191.535634827496;6319.988801791691;6414.647194404352;6422.293547709842;6514.9348506514325 15:02:39 INFO - PID 6053 | |1;ext.html;832.5213002523549;870.1342164546278;872.0712441250066;884.5179377239403;889.10644801974;41224;41953.79023104888;42400.787996059975;42465.78767106164;42558.57441425585;38647.806760966225;38897.80551097241;38964.85693286868;38985.61014389855;39040.414393784115;7017.964910175442;7132.821679458003;7142.8571428571395;7144;7150.74972375967;6984.057152284453;7051.330123638246;7054.6825392857445;7065.682044307992;7067.717291308367;7637.427192960522;7810.101838288584;7833.804154896116;7835.059792824841;7842.843143137134;7741.109772376164;7760.767176984699;7768.57272849993;7784.260495252942;7820.374370050411;7543;7631.275028872248;7653.579053152074;7726.961365193194;7737.651805668702;38448.423273650915;38556.22887542262;38564;38591.42112868309;38621.227575448334;3544.220271540257;3583.372909740811;3587.856485740567;3603.6756691897594;3605.06268370223;31511.36977260465;32038.83980580082;32114.839425802955;32264.516032259537;32281.35437291241;5246.081935661244;5249.711265880375;5259.500347466985;5284.550813180885;5298.125809241509;177366;183458;183624;183664;184038;41345;47205;47617;47627.04745905132;47908;50132.74668133253;50463.49536504588;50486.24270635944;50520;50689;15810.60473488172;15928.681426371408;16032.797540184532;16123.113228772296;16135.919320403324;13390.866091339156;13403.597892063253;13411.597652070453;13420.127691700009;13426.932865335611;13744.106633068819;13774.035817492679;13778.448862045407;13861.237631930138;13975.720485590231;5490.231367608538;5590.888182236333;5617.662940223599;5730.08318669011;5751.309842818889;997.5760301871676;1013.8631284776461;1019.8470229465639;1020.4744556553233;1033.8862725100232;22721.659175112385;22749.02759585834;22895.885520572625;23031.309060728207;23079.88460057689;1125.6172901213463;1127.430647523012;1133.6485689436302;1135.3074624479061;1135.6706555099095;12118.212316199419;12209.877901220874;12232.266064036186;12287.447064882102;12326.691832704255;205684;208937;208986;209000;211329;51662.74168629133;51731.741341293055;52028.739856300475;52120;52144.47855521472;1407.6340151560669;1452.8982971192127;1476.3430273528177;1478.3199728125182;1489.3149151390264;22034.33896983093;22483.43791405228;22687.092516299163;22750;22807.31578052661;37193.628063719014;37326.440103399014;37368.25263494769;37421;37425;183183.08408458406;183835;183883;184303;184383;31006.37987240288;31611.683883160873;33892.32215355728;33988.49017264693;34271.657283426845;41648.79175604103;41974;41976.790116049226;42183;42422.575774241865;31959;32079.35841283208;32249.838750806095;32404;32463;30989.69010309868;31073.844630777607;31149.065528034196;31454.21364465815;31554.211144721565;34594.308113837076;34725.47911781376;35052.47421288734;35400.82299588485;35452.936411907685;30568;30841.8457907709;31273.37453250968;31280.21799455032;31607.683923161392;22729.545409092058;23409.76590234144;23762.049518019085;23835.761642383353;23877.76122238825 15:02:39 INFO - PID 6053 | |2;jquery.html;554.7143221241062;566.9603127781056;567.9545636349093;568.8634727665361;590.2150140313383;22003.899805009765;22484.32547023592;22489.887550562245;22517.437064073405;22824.88587557062;24216.87891560544;24760.3809904752;25142.371440713992;25283.11509097182;25683.486330273383;6443.677816109188;6632.801015969529;6647.867042659144;6652.634105124216;6662.900056499157;6520.31536688648;6628.270890202074;6636.469082473414;6640.236372817116;6889.586624802528;7174.533655312414;7195.388391986688;7198.604076775775;7202.20775714671;7204.819879503002;7161.64191790411;7170.06789117414;7173.067501224859;7178.7128514859605;7180.281971802778;6690.698918548677;6942.826429339257;6968.477364197705;6986.510944233905;7031.578105313698;30909.690903090905;31634.36731265385;31647;31649.84175079133;31660.683393166004;2086.2593779208464;2112;2114.6616541353465;2119.311223852254;2121.7029615853794;18773;20338.5932281355;20654.380368588965;20839.89580052105;20847.166113355448;2504.5491811473926;2527.671402717653;2568.935776605581;2579.638850560923;2580.9870950645313;122612.38693806563;128751.35624321912;136962;143239;143448;19676.50808729793;21167.68248476274;21683.34949951504;21855.453613659785;21977.780222197893;42566.36150457684;42573.57426425696;42593.36109958353;42656;42668.359974600404;11244.493997769956;11565.710857228636;11709;11714.531418743154;11765.764684706259;9466.290028247771;9681.757956051155;9716.368436051634;9791.755206119762;9813.11681948628;10781.191410644233;10827.891721082846;11122.721931951766;11200.38397888124;11434.714132146762;3801.5248093988253;3878;3964.980175099106;4015.3221496956303;4220.134872351161;937.2923442800642;970.6069042037985;975.205207755691;984.9803003940025;985.3693636072919;19817.504562386057;19848.20607175697;19901.104450299772;19910.800891991184;19957.700634490495;1027.5889644142253;1031.2471895516164;1032.2361452525076;1036.1400037968467;1038.9324693894873;10702.304350217211;10788.298760580537;10841.078508326722;10958.890411095786;11057.778844423066;405974;407070;409229;436261;437848;108014.45992769986;110435;110472.4476377613;110907.44546277217;110923;1052.1740433759614;1078.541619811577;1086.8315411111291;1090.8363745438248;1093.5407129005837;16808.159592020107;16995.23521441563;17232.052237126576;17338.653226935137;17425.73861392055;52577.21134183067;53237.7338113307;53690.73154634202;55429.44570554243;56772;64705.67647161734;65107;65277;65382;66488.66755666191;19396;19734.40796776099;19907.10418031221;19967.900160499106;20077.49806254797;21757.673634895807;21869.234576789735;22235.332940011827;22361.77010264451;22469.550608987403;17298.65402691914;17463.56341091483;17626.73559896577;17660.646787063928;17907.462776116736;16112.597185070466;16290;16738.828282020142;16783;16858.831411685725;17951.820481795014;18136.45590632283;18334.266629334677;18456;18640.440786776417;19514.902425488348;19565.413037608894;19693.70459443081;19707;19766.50583735418;17769;17826.91086544559;17857.374991875742;17921;18057.097145142427 15:02:39 INFO - PID 6053 | |3;mootools.html;1306.1705816806327;1369.3495589594943;1387.9653008674782;1387.9861201387982;1404.1645221093445;14870.33083511242;15500.37998480061;15510.224488775544;15526.068435893825;15547;15149;15287.923560382182;15315.617109572266;15319.387224511034;15323.463678771246;2621.1743300860167;2636.6572345595046;2683.9597406038924;2697.0425498947884;2698.757111859932;2678.571428571429;2680.7855371570226;2708.8103832731717;2709.972900270992;2727.263638817528;2646.57654775236;2671.6259723638705;2749.175247425764;2767.7370649788236;2778.541540645791;2666.786657067449;2668.7598116169543;2692.3807524269428;2697.8920843166447;2712.91861244162;2639.7756190723812;2663.733626637321;2668.3062403774966;2674.7860171186258;2746.7665248453904;14857;15031;15032.849671503254;15033.398664053424;15059.17174555399;8042.919570804275;8341.499510029418;8349.95825020877;8351.958240208822;8373.41386102973;5496.477834605706;5596.1605759136455;5702;5715.371309155989;5719.8570035749435;1861.5625328047897;1915;1915.6551820672273;1934.0136530369473;1947.6202140582593;26142.477150457074;26618.20145395641;26620.866895665593;26776.73223267762;26832.329191770168;7145.964270178616;7376.815579610553;7454.142773581108;7553.169151393342;7554.811129721691;16629.833701663072;20013.39959801208;20085.196592136443;20093;20118.29585964484;7772.961135194288;8041.155678653774;8043.356531477468;8048.0342358917305;8048.195180482022;7253.673584688701;7331;7397.667104980289;7398.815029624195;7403.444741644398;5187.429382767892;5278.551323137576;5308;5401.297831281908;5409.566464886808;1531.5788158256569;1535.5009621872937;1545.1115608524917;1545.652228248635;1560.492839827038;858.8797568340437;866.3718803867272;877.1666916429417;886.822635472908;894.9507777072193;7225.060742103493;7228.987941688168;7250.456215783837;7291;8457.873131903027;718.4037249083249;720.5193327711603;725.2493669052506;727.0838743183521;740.0268646729534;4938.135826230396;5064.594832413398;5331;5350.6254562180275;5508.55931525477;20377.796222037887;21023.894880525804;21125.68311475329;21313.89343053275;21980.560388792455;21113.366599001747;21252.681209781866;21465.46336341573;21641.350759476925;21896.781032189792;10315.587376505006;10464.947675261576;10647.36115833068;10668.679939601825;10697.893021069845;7890.921090789018;8037.477563958324;8153.266206041485;8211.096779354148;8236.588170591327;17964.550886227426;18343.54141146482;18516.72224916654;18806.52983675364;18808.435746927615;19100;19290.614187715888;19306.90346548258;19518.902405487883;19707.40877773669;11117.666470005914;11170.720731981766;11201.887981120084;11316.717082072684;11336.773264534828;14054.297285135906;14181.14913105217;14189.503367382093;14213.431462741788;14235.359408826835;11618.94190529042;11790.587329443428;11836.526538938346;11908.52365905354;11919.52321907114;11290.096792256436;11535.307881527135;11561.19071665009;11689.707757306136;11839;9617.903820961701;9782.706518804447;9785.461799601091;9790.412575245507;9791.020897910152;6698.933010669831;6814.522983391115;6816.079829222991;6894.586324820527;6929.549579277331;6730.226024007302;6853.862922741617;6861.313868613299;6887.793366199022;6923.065386172802 15:02:39 INFO - PID 6053 | |4;prototype.html;499.3109508877748;501.6407419524334;524.9737513124344;525.1545012529829;529.756649239591;6304.180456540649;6316.778912738055;6329.4619957303685;6382.617042977425;6409.77565785197;6203.596766210193;6237.5321850861255;6253.468455181315;6268.905966410507;6304.558680892339;5156.473328069256;5169.457206993258;5198.896022079556;5229.86925326868;5243.951209758064;4851.514848515138;4983.216112531955;5162.8193013244545;5175.58595312376;5175.948240517584;4927.728974906378;4937.753112344386;4962.87592810179;4965.577925876287;5009.824656137036;4888.999999999982;4909.7790599423115;4933.161362568372;4946.159152944008;4957.950420495785;4379.956200437987;4415;4429.357743127261;4691.929621055687;4775.594074503671;6053.424924632153;6065.605735627214;6111.908321375183;6166.537509686791;6189.907151392733;5964.254468191476;5971.910421343683;5980.760769569212;5985.6408615483215;6011.639301641915;6563.835904102388;6602;6605.735770569171;6637.56855804376;6685.022411665052;5059.19052951526;5254.8160814371695;5328.946710532884;5333.013392522395;5350.528604633718;6768.93231067688;6777;6888.380045795852;6900.102986611759;6947.235804061549;5455.063452474394;5469.945300546943;5482.342118945672;5495.04356863058;5530.032244357221;5387.326584176978;5502.642328248651;5509.283793106951;5527.2538207342295;5540.728301396408;5921.342024233221;5928.762849486058;5944.7324870380935;6017.518598512109;6019.518438524908;6678.6326752028135;6688.130543029375;6688.398044176048;6694.59832410057;6712.865742685119;1899.3352326685826;1926.268018153093;1927.816857398545;1929.0258419498064;1940.592475580144;1336.365226517416;1374.9656258593616;1428.5357258890901;1430.4778755754076;1443.7617793064028;5745.597808153473;5746.626469279484;5772.393898640582;5812.599629216871;5854.209681692917;6557.442617377576;6598.142241508669;6602.8349291268105;6618.834529136714;6693.330666933365;5709.942900571024;5731.512821410227;5742.454466825645;5760.070376423945;5769.451902069297;3512.5258090157504;3522.260325331658;3523.4010218262956;3533.4559117435406;3582.176099497078;6344.809655710336;6369.840753981095;6490.318516555788;6500.154979852683;6527.281998980108;6799.422049125781;6868.416184624263;6875.48433867452;6913;6952.339527744856;6527.997121324244;6587.969534014407;6602.801915942433;6606.207255129415;6640.882652755419;6630.436412904957;6723;6730.394264516217;6786.660666966533;6819.249882513019;6536.705848236936;6541.280459149585;6579.440747536513;6599.835004124935;6627.768028119185;6424.743010279536;6527.15147030883;6530.542861999805;6534.183227096613;6573.967130164318;5451.563874890078;5485.753141108739;5496.395396506461;5520.972395137998;5522.9447705524035;6276.215473065867;6462.416707906593;6569.441597464269;6870.244273130052;6894.620795856276;6163.291221509584;6411.166548348685;6422.967885160544;6446.613203207635;6458.54790164684;6322.778702745381;6387.584806987531;6399.392057754506;6443;6454.579992401664;6402.583832050902;6410.391012853772;6464.41820236181;6494.935050649433;6503.6097834130105;6415.486761059197;6567.047778072058;6578.539502234989;6632.966835165793;6637.800865974028;6280.874382512416;6298.181236439417;6338.971529110825;6385;6421.646809425526 15:02:39 INFO - PID 6053 | |5;yui.html;890.9955450222748;903.9502827344495;906.4923642760051;914.3690853311215;926.8563372677236;21157;22018.11927522899;22854.31437056891;22894.198703045397;22929.968151433204;20147.496312592193;20614.48463788406;20708.48228794281;20731.585368292664;20784.792152078473;939.037486576258;950.1828427552299;951.5432592355673;954.5942974235957;954.8138113067954;940.5814412586368;960.231814548362;970.3595626886256;971.3880255439099;972.7422233108232;1013.5287091502449;1021.4177918586408;1022.8056669232859;1023.5138309303096;1025.318163421324;1010.161565900301;1024.8309029010204;1026.8767747870265;1026.9024442677971;1027.275770581738;751.4026349052516;754.9094108706936;756.8826831841073;758.5600351796;759.1914610939388;19987.500312492157;20240.49398765028;20568.177272909066;20581.176752929863;20581.38255852327;21524.354269371943;21534.246301379535;22019.22932697348;22042;22044.88977555118;17388.56528586783;17392.565185870328;17413.390531331344;17438.04090775007;17442.65114697699;3589.228315912065;3663.60782902498;3686.096906257984;3708.2027364116843;3733.701303895682;140522.29738851343;140556.2972185143;140946;142375.28812355976;146144.26927865294;16222.51332460028;16372.345106195618;16391.754123688155;16487.752683709754;16515.091669958027;24807.13175038865;25905.870470647904;28823.711762882103;28875.278118047216;29318.120456386343;8803.735887923373;9152.63389464414;9171.862422063674;9174.86237706435;9203.217726493189;3920.2943470175073;4031.717779755389;4071.5521292657786;4091.5499295077516;4219.07180420307;5365.946340536622;5482.945170548243;5537.473939975695;5541.418151094158;5569.275994120739;1104.845321654969;1118.7091356247433;1134.3024040215373;1135.211028335299;1135.699623930595;682.8941514065327;696.1263614164293;699.1644984243779;705.368695017956;706.8586282743369;11506.424678766196;11918.225315354473;12439.315837628836;12458.439370228361;13032.218066916015;668.6756922892394;676.7597502886503;689;697.2434908124742;699.5942353434996;5378.838634840961;5453.400125986138;5525.889482210333;5549.72251387429;5568.303962004749;122524.38737806432;123010;124092;126230.36884815517;128679;109520;110427;110787.44606276917;111509.44245278722;111974;93688;93778.53110734402;98230.50884745673;98602;98792.50603746936;10409.531571079471;10422.791544168922;10649.9467502662;10821.621243256448;10894.618688346187;44354.77822610866;44390;44608.55391446044;44793.32810007787;45797.31304030376;55853.72073139608;58235;58334.4166558346;58985.41014589799;59301.703491482265;15405.152716600247;15406.537803865902;15621.297041632926;15661.963944687117;15662.138582377624;16568;16928.576785579968;16972.575685607466;16972.830271697127;17013.659726805643;15203.619909502351;15508.92245538765;15595.688086238439;15608.375664973273;15613.219339032776;14253.786193207317;14332.785008225093;14422.639434013814;14435.061720988522;14460.927695361455;15504.767428488807;15553;15733.763993540335;15900;16091.597710057342;11227.775444491228;11237.943810280896;11250.268732532359;11721.296722196696;11801.05591552691;11657.18399712012;11664.950154486138;11706.297622142358;11772.352520611448;11781.175317727677 15:02:39 INFO - PID 6053 | __end_tp_report 15:02:39 INFO - PID 6053 | __start_cc_report 15:02:39 INFO - PID 6053 | _x_x_mozilla_cycle_collect,272 15:02:39 INFO - PID 6053 | __end_cc_report 15:02:39 INFO - PID 6053 | __startTimestamp1505599359923__endTimestamp 15:02:39 INFO - PID 6053 | 15:02:39 INFO - PID 6053 | ------- Summary: start ------- 15:02:39 INFO - PID 6053 | Number of tests: 6 15:02:39 INFO - PID 6053 | 15:02:39 INFO - PID 6053 | [#0] dojo.html Cycles:165 Average:6200.69 Median:6451.13 stddev:858.33 (13.3%) stddev-sans-first:825.71 15:02:39 INFO - PID 6053 | Values: 3097.0 3123.5 3170.3 3181.6 3193.2 6161.3 6268.6 6342.4 6379.7 6380.4 6270.0 6352.6 6442.2 6445.5 6451.1 1207.3 5500.7 5834.6 5872.7 5950.1 5643.9 5702.9 5719.3 5863.7 5866.4 5677.9 5716.8 5730.4 5734.1 5738.8 5653.8 5806.4 5812.6 5816.7 5816.9 5776.9 5801.4 5861.6 5864.1 5884.2 6188.4 6288.7 6317.9 6356.9 6398.5 6598.8 6670.3 6674.0 6674.6 6676.6 6724.4 6762.5 6786.4 6885.9 6896.9 6332.7 6362.7 6366.6 6369.1 6371.0 6959.1 6973.0 6979.2 7046.0 7064.1 6500.9 6594.3 6597.0 6610.7 6695.6 6797.1 6812.5 6820.2 6822.1 6823.0 6719.6 6788.9 6798.0 6802.9 6814.4 6782.2 6795.9 6858.6 6865.1 6890.4 5096.2 5249.3 5267.3 5296.6 5361.7 4596.1 4627.6 4627.8 4628.0 4655.6 5853.5 5862.2 5924.8 5940.1 5941.0 6800.3 6829.7 6885.6 6889.8 6914.3 5759.4 5859.4 5876.2 5932.8 5939.5 5708.3 5758.0 5762.8 5770.8 5781.5 6618.3 6637.6 6696.2 6710.1 6711.3 6756.6 6782.2 6785.6 6873.5 6881.5 6434.3 6555.6 6577.9 6584.9 6677.5 6693.6 6711.7 6718.3 6720.1 6720.6 6823.3 6823.6 6898.8 6912.6 6933.5 6548.6 6569.7 6586.3 6664.7 6672.5 6404.8 6531.5 6536.2 6536.5 6538.6 6390.1 6433.0 6477.9 6549.9 6581.9 6617.1 6700.6 6728.8 6758.7 6760.3 6191.5 6320.0 6414.6 6422.3 6514.9 15:02:39 INFO - PID 6053 | 15:02:39 INFO - PID 6053 | [#1] ext.html Cycles:180 Average:36063.30 Median:34888.98 stddev:49655.19 (142.3%) stddev-sans-first:49724.01 15:02:39 INFO - PID 6053 | Values: 832.5 870.1 872.1 884.5 889.1 41224.0 41953.8 42400.8 42465.8 42558.6 38647.8 38897.8 38964.9 38985.6 39040.4 7018.0 7132.8 7142.9 7144.0 7150.7 6984.1 7051.3 7054.7 7065.7 7067.7 7637.4 7810.1 7833.8 7835.1 7842.8 7741.1 7760.8 7768.6 7784.3 7820.4 7543.0 7631.3 7653.6 7727.0 7737.7 38448.4 38556.2 38564.0 38591.4 38621.2 3544.2 3583.4 3587.9 3603.7 3605.1 31511.4 32038.8 32114.8 32264.5 32281.4 5246.1 5249.7 5259.5 5284.6 5298.1 177366.0 183458.0 183624.0 183664.0 184038.0 41345.0 47205.0 47617.0 47627.0 47908.0 50132.7 50463.5 50486.2 50520.0 50689.0 15810.6 15928.7 16032.8 16123.1 16135.9 13390.9 13403.6 13411.6 13420.1 13426.9 13744.1 13774.0 13778.4 13861.2 13975.7 5490.2 5590.9 5617.7 5730.1 5751.3 997.6 1013.9 1019.8 1020.5 1033.9 22721.7 22749.0 22895.9 23031.3 23079.9 1125.6 1127.4 1133.6 1135.3 1135.7 12118.2 12209.9 12232.3 12287.4 12326.7 205684.0 208937.0 208986.0 209000.0 211329.0 51662.7 51731.7 52028.7 52120.0 52144.5 1407.6 1452.9 1476.3 1478.3 1489.3 22034.3 22483.4 22687.1 22750.0 22807.3 37193.6 37326.4 37368.3 37421.0 37425.0 183183.1 183835.0 183883.0 184303.0 184383.0 31006.4 31611.7 33892.3 33988.5 34271.7 41648.8 41974.0 41976.8 42183.0 42422.6 31959.0 32079.4 32249.8 32404.0 32463.0 30989.7 31073.8 31149.1 31454.2 31554.2 34594.3 34725.5 35052.5 35400.8 35452.9 30568.0 30841.8 31273.4 31280.2 31607.7 22729.5 23409.8 23762.0 23835.8 23877.8 15:02:39 INFO - PID 6053 | 15:02:39 INFO - PID 6053 | [#2] jquery.html Cycles:180 Average:33511.16 Median:21923.51 stddev:71296.26 (325.2%) stddev-sans-first:71453.33 15:02:39 INFO - PID 6053 | Values: 554.7 567.0 568.0 568.9 590.2 22003.9 22484.3 22489.9 22517.4 22824.9 24216.9 24760.4 25142.4 25283.1 25683.5 6443.7 6632.8 6647.9 6652.6 6662.9 6520.3 6628.3 6636.5 6640.2 6889.6 7174.5 7195.4 7198.6 7202.2 7204.8 7161.6 7170.1 7173.1 7178.7 7180.3 6690.7 6942.8 6968.5 6986.5 7031.6 30909.7 31634.4 31647.0 31649.8 31660.7 2086.3 2112.0 2114.7 2119.3 2121.7 18773.0 20338.6 20654.4 20839.9 20847.2 2504.5 2527.7 2568.9 2579.6 2581.0 122612.4 128751.4 136962.0 143239.0 143448.0 19676.5 21167.7 21683.3 21855.5 21977.8 42566.4 42573.6 42593.4 42656.0 42668.4 11244.5 11565.7 11709.0 11714.5 11765.8 9466.3 9681.8 9716.4 9791.8 9813.1 10781.2 10827.9 11122.7 11200.4 11434.7 3801.5 3878.0 3965.0 4015.3 4220.1 937.3 970.6 975.2 985.0 985.4 19817.5 19848.2 19901.1 19910.8 19957.7 1027.6 1031.2 1032.2 1036.1 1038.9 10702.3 10788.3 10841.1 10958.9 11057.8 405974.0 407070.0 409229.0 436261.0 437848.0 108014.5 110435.0 110472.4 110907.4 110923.0 1052.2 1078.5 1086.8 1090.8 1093.5 16808.2 16995.2 17232.1 17338.7 17425.7 52577.2 53237.7 53690.7 55429.4 56772.0 64705.7 65107.0 65277.0 65382.0 66488.7 19396.0 19734.4 19907.1 19967.9 20077.5 21757.7 21869.2 22235.3 22361.8 22469.6 17298.7 17463.6 17626.7 17660.6 17907.5 16112.6 16290.0 16738.8 16783.0 16858.8 17951.8 18136.5 18334.3 18456.0 18640.4 19514.9 19565.4 19693.7 19707.0 19766.5 17769.0 17826.9 17857.4 17921.0 18057.1 15:02:39 INFO - PID 6053 | 15:02:39 INFO - PID 6053 | [#3] mootools.html Cycles:180 Average:9380.85 Median:2670.19 stddev:6764.09 (253.3%) stddev-sans-first:6755.86 15:02:39 INFO - PID 6053 | Values: 1306.2 1369.3 1388.0 1388.0 1404.2 14870.3 15500.4 15510.2 15526.1 15547.0 15149.0 15287.9 15315.6 15319.4 15323.5 2621.2 2636.7 2684.0 2697.0 2698.8 2678.6 2680.8 2708.8 2710.0 2727.3 2646.6 2671.6 2749.2 2767.7 2778.5 2666.8 2668.8 2692.4 2697.9 2712.9 2639.8 2663.7 2668.3 2674.8 2746.8 14857.0 15031.0 15032.8 15033.4 15059.2 8042.9 8341.5 8350.0 8352.0 8373.4 5496.5 5596.2 5702.0 5715.4 5719.9 1861.6 1915.0 1915.7 1934.0 1947.6 26142.5 26618.2 26620.9 26776.7 26832.3 7146.0 7376.8 7454.1 7553.2 7554.8 16629.8 20013.4 20085.2 20093.0 20118.3 7773.0 8041.2 8043.4 8048.0 8048.2 7253.7 7331.0 7397.7 7398.8 7403.4 5187.4 5278.6 5308.0 5401.3 5409.6 1531.6 1535.5 1545.1 1545.7 1560.5 858.9 866.4 877.2 886.8 895.0 7225.1 7229.0 7250.5 7291.0 8457.9 718.4 720.5 725.2 727.1 740.0 4938.1 5064.6 5331.0 5350.6 5508.6 20377.8 21023.9 21125.7 21313.9 21980.6 21113.4 21252.7 21465.5 21641.4 21896.8 10315.6 10464.9 10647.4 10668.7 10697.9 7890.9 8037.5 8153.3 8211.1 8236.6 17964.6 18343.5 18516.7 18806.5 18808.4 19100.0 19290.6 19306.9 19518.9 19707.4 11117.7 11170.7 11201.9 11316.7 11336.8 14054.3 14181.1 14189.5 14213.4 14235.4 11618.9 11790.6 11836.5 11908.5 11919.5 11290.1 11535.3 11561.2 11689.7 11839.0 9617.9 9782.7 9785.5 9790.4 9791.0 6698.9 6814.5 6816.1 6894.6 6929.5 6730.2 6853.9 6861.3 6887.8 6923.1 15:02:39 INFO - PID 6053 | 15:02:39 INFO - PID 6053 | [#4] prototype.html Cycles:180 Average:5592.00 Median:6196.75 stddev:1507.54 (24.3%) stddev-sans-first:1462.51 15:02:39 INFO - PID 6053 | Values: 499.3 501.6 525.0 525.2 529.8 6304.2 6316.8 6329.5 6382.6 6409.8 6203.6 6237.5 6253.5 6268.9 6304.6 5156.5 5169.5 5198.9 5229.9 5244.0 4851.5 4983.2 5162.8 5175.6 5175.9 4927.7 4937.8 4962.9 4965.6 5009.8 4889.0 4909.8 4933.2 4946.2 4958.0 4380.0 4415.0 4429.4 4691.9 4775.6 6053.4 6065.6 6111.9 6166.5 6189.9 5964.3 5971.9 5980.8 5985.6 6011.6 6563.8 6602.0 6605.7 6637.6 6685.0 5059.2 5254.8 5328.9 5333.0 5350.5 6768.9 6777.0 6888.4 6900.1 6947.2 5455.1 5469.9 5482.3 5495.0 5530.0 5387.3 5502.6 5509.3 5527.3 5540.7 5921.3 5928.8 5944.7 6017.5 6019.5 6678.6 6688.1 6688.4 6694.6 6712.9 1899.3 1926.3 1927.8 1929.0 1940.6 1336.4 1375.0 1428.5 1430.5 1443.8 5745.6 5746.6 5772.4 5812.6 5854.2 6557.4 6598.1 6602.8 6618.8 6693.3 5709.9 5731.5 5742.5 5760.1 5769.5 3512.5 3522.3 3523.4 3533.5 3582.2 6344.8 6369.8 6490.3 6500.2 6527.3 6799.4 6868.4 6875.5 6913.0 6952.3 6528.0 6588.0 6602.8 6606.2 6640.9 6630.4 6723.0 6730.4 6786.7 6819.2 6536.7 6541.3 6579.4 6599.8 6627.8 6424.7 6527.2 6530.5 6534.2 6574.0 5451.6 5485.8 5496.4 5521.0 5522.9 6276.2 6462.4 6569.4 6870.2 6894.6 6163.3 6411.2 6423.0 6446.6 6458.5 6322.8 6387.6 6399.4 6443.0 6454.6 6402.6 6410.4 6464.4 6494.9 6503.6 6415.5 6567.0 6578.5 6633.0 6637.8 6280.9 6298.2 6339.0 6385.0 6421.6 15:02:39 INFO - PID 6053 | 15:02:39 INFO - PID 6053 | [#5] yui.html Cycles:180 Average:24558.13 Median:20597.93 stddev:35923.23 (174.4%) stddev-sans-first:35980.05 15:02:39 INFO - PID 6053 | Values: 891.0 904.0 906.5 914.4 926.9 21157.0 22018.1 22854.3 22894.2 22930.0 20147.5 20614.5 20708.5 20731.6 20784.8 939.0 950.2 951.5 954.6 954.8 940.6 960.2 970.4 971.4 972.7 1013.5 1021.4 1022.8 1023.5 1025.3 1010.2 1024.8 1026.9 1026.9 1027.3 751.4 754.9 756.9 758.6 759.2 19987.5 20240.5 20568.2 20581.2 20581.4 21524.4 21534.2 22019.2 22042.0 22044.9 17388.6 17392.6 17413.4 17438.0 17442.7 3589.2 3663.6 3686.1 3708.2 3733.7 140522.3 140556.3 140946.0 142375.3 146144.3 16222.5 16372.3 16391.8 16487.8 16515.1 24807.1 25905.9 28823.7 28875.3 29318.1 8803.7 9152.6 9171.9 9174.9 9203.2 3920.3 4031.7 4071.6 4091.5 4219.1 5365.9 5482.9 5537.5 5541.4 5569.3 1104.8 1118.7 1134.3 1135.2 1135.7 682.9 696.1 699.2 705.4 706.9 11506.4 11918.2 12439.3 12458.4 13032.2 668.7 676.8 689.0 697.2 699.6 5378.8 5453.4 5525.9 5549.7 5568.3 122524.4 123010.0 124092.0 126230.4 128679.0 109520.0 110427.0 110787.4 111509.4 111974.0 93688.0 93778.5 98230.5 98602.0 98792.5 10409.5 10422.8 10649.9 10821.6 10894.6 44354.8 44390.0 44608.6 44793.3 45797.3 55853.7 58235.0 58334.4 58985.4 59301.7 15405.2 15406.5 15621.3 15662.0 15662.1 16568.0 16928.6 16972.6 16972.8 17013.7 15203.6 15508.9 15595.7 15608.4 15613.2 14253.8 14332.8 14422.6 14435.1 14460.9 15504.8 15553.0 15733.8 15900.0 16091.6 11227.8 11237.9 11250.3 11721.3 11801.1 11657.2 11665.0 11706.3 11772.4 11781.2 15:02:39 INFO - PID 6053 | -------- Summary: end -------- 15:02:39 INFO - PID 6053 | 15:02:40 INFO - TEST-INFO | 6053: exit 0 15:02:40 INFO - TEST-OK | dromaeo_css | took 1109135ms 15:02:40 INFO - TEST-START | kraken 15:02:40 INFO - Initialising browser for kraken test... 15:02:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37160/getInfo.html -profile /tmp/tmpFWh43v/profile 15:02:40 INFO - TEST-INFO | started process 6426 (/builds/slave/test/build/application/firefox/firefox http://localhost:37160/getInfo.html) 15:02:45 INFO - TEST-INFO | 6426: exit 0 15:02:45 INFO - Browser initialized. 15:02:45 INFO - Running cycle 1/1 for kraken test... 15:02:45 INFO - Using env: {'DISPLAY': ':0', 15:02:45 INFO - 'HOME': '/home/cltbld', 15:02:45 INFO - 'JSGC_DISABLE_POISONING': '1', 15:02:45 INFO - 'LANG': 'en_US.UTF-8', 15:02:45 INFO - 'LANGUAGE': 'en_US:en', 15:02:45 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:02:45 INFO - 'LOGNAME': 'cltbld', 15:02:45 INFO - 'MAIL': '/var/mail/cltbld', 15:02:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:02:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:02:45 INFO - 'MOZ_CRASHREPORTER': '1', 15:02:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:45 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:02:45 INFO - 'MOZ_NO_REMOTE': '1', 15:02:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:02:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:45 INFO - 'NO_EM_RESTART': '1', 15:02:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:45 INFO - 'PWD': '/builds/slave/test', 15:02:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:02:45 INFO - 'RUST_BACKTRACE': 'full', 15:02:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:02:45 INFO - 'SHELL': '/bin/bash', 15:02:45 INFO - 'SHLVL': '1', 15:02:45 INFO - 'STYLO_FORCE_DISABLED': '1', 15:02:45 INFO - 'TERM': 'linux', 15:02:45 INFO - 'TMOUT': '86400', 15:02:45 INFO - 'USER': 'cltbld', 15:02:45 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441', 15:02:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:45 INFO - '_': '/tools/buildbot/bin/python'} 15:02:45 INFO - TEST-INFO | started process 6657 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFWh43v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:02:46 INFO - PID 6657 | 15:02:46 INFO - PID 6657 | (/builds/slave/test/build/application/firefox/firefox:6706): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:02:46 INFO - PID 6657 | 15:02:56 INFO - PID 6657 | RSS: Main: 156635136 15:02:56 INFO - PID 6657 | 15:02:59 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:37160/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37160/tests/kraken/driver.html?testName=audio-beat-detection) 15:03:00 INFO - PID 6657 | RSS: Main: 162983936 15:03:00 INFO - PID 6657 | 15:03:03 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:37160/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37160/tests/kraken/driver.html?testName=audio-dft) 15:03:03 INFO - PID 6657 | RSS: Main: 163119104 15:03:03 INFO - PID 6657 | 15:03:06 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:37160/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37160/tests/kraken/driver.html?testName=audio-fft) 15:03:07 INFO - PID 6657 | RSS: Main: 158711808 15:03:07 INFO - PID 6657 | 15:03:09 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:37160/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37160/tests/kraken/driver.html?testName=audio-oscillator) 15:03:10 INFO - PID 6657 | RSS: Main: 159756288 15:03:10 INFO - PID 6657 | 15:03:12 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:37160/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37160/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:03:12 INFO - PID 6657 | RSS: Main: 160047104 15:03:12 INFO - PID 6657 | 15:03:15 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:37160/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37160/tests/kraken/driver.html?testName=imaging-darkroom) 15:03:16 INFO - PID 6657 | RSS: Main: 162340864 15:03:16 INFO - PID 6657 | 15:03:20 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:37160/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37160/tests/kraken/driver.html?testName=imaging-desaturate) 15:03:20 INFO - PID 6657 | RSS: Main: 162594816 15:03:20 INFO - PID 6657 | 15:03:23 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:37160/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37160/tests/kraken/driver.html?testName=json-parse-financial) 15:03:24 INFO - PID 6657 | RSS: Main: 162213888 15:03:24 INFO - PID 6657 | 15:03:26 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:37160/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37160/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:03:26 INFO - PID 6657 | RSS: Main: 162160640 15:03:26 INFO - PID 6657 | 15:03:28 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:37160/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37160/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:03:28 INFO - PID 6657 | RSS: Main: 162779136 15:03:28 INFO - PID 6657 | 15:03:30 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:37160/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37160/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:03:31 INFO - PID 6657 | RSS: Main: 159268864 15:03:31 INFO - PID 6657 | 15:03:34 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:37160/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37160/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:03:34 INFO - PID 6657 | RSS: Main: 159309824 15:03:34 INFO - PID 6657 | 15:03:37 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:37160/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37160/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:03:38 INFO - PID 6657 | RSS: Main: 159825920 15:03:38 INFO - PID 6657 | 15:03:40 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:37160/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37160/tests/kraken/driver.html?testName=ai-astar) 15:03:40 INFO - PID 6657 | RSS: Main: 161210368 15:03:40 INFO - PID 6657 | 15:03:40 INFO - PID 6657 | __start_tp_report 15:03:40 INFO - PID 6657 | _x_x_mozilla_page_load 15:03:40 INFO - PID 6657 | _x_x_mozilla_page_load_details 15:03:40 INFO - PID 6657 | |i|pagename|runs| 15:03:40 INFO - PID 6657 | |0;ai-astar;108;109;107;107;107;107;109;107;109;109 15:03:40 INFO - PID 6657 | |1;audio-beat-detection;119;118;116;119;116;120;123;118;125;147 15:03:40 INFO - PID 6657 | |2;audio-dft;162;164;165;168;163;166;167;165;168;166 15:03:40 INFO - PID 6657 | |3;audio-fft;75;75;74;74;73;76;74;76;76;74 15:03:40 INFO - PID 6657 | |4;audio-oscillator;80;80;79;78;79;79;80;80;79;79 15:03:40 INFO - PID 6657 | |5;imaging-gaussian-blur;115;115;117;115;114;113;115;118;115;116 15:03:40 INFO - PID 6657 | |6;imaging-darkroom;148;149;150;147;148;148;147;148;148;148 15:03:40 INFO - PID 6657 | |7;imaging-desaturate;94;98;98;94;94;93;95;96;95;100 15:03:40 INFO - PID 6657 | |8;json-parse-financial;55;55;56;56;56;55;57;70;56;56 15:03:40 INFO - PID 6657 | |9;json-stringify-tinderbox;36;37;37;38;38;37;37;37;37;38 15:03:40 INFO - PID 6657 | |10;stanford-crypto-aes;76;73;73;77;72;73;72;74;72;77 15:03:40 INFO - PID 6657 | |11;stanford-crypto-ccm;122;117;111;116;115;121;116;113;116;120 15:03:40 INFO - PID 6657 | |12;stanford-crypto-pbkdf2;168;168;173;171;166;169;168;164;166;175 15:03:40 INFO - PID 6657 | |13;stanford-crypto-sha256-iterative;68;68;66;68;68;65;65;66;65;67 15:03:40 INFO - PID 6657 | __end_tp_report 15:03:40 INFO - PID 6657 | __start_cc_report 15:03:40 INFO - PID 6657 | _x_x_mozilla_cycle_collect,781 15:03:40 INFO - PID 6657 | __end_cc_report 15:03:40 INFO - PID 6657 | __startTimestamp1505599420473__endTimestamp 15:03:40 INFO - PID 6657 | 15:03:40 INFO - PID 6657 | ------- Summary: start ------- 15:03:40 INFO - PID 6657 | Number of tests: 14 15:03:40 INFO - PID 6657 | 15:03:40 INFO - PID 6657 | [#0] ai-astar Cycles:10 Average:107.90 Median:108.50 stddev:0.99 (0.9%) stddev-sans-first:1.05 15:03:40 INFO - PID 6657 | Values: 108.0 109.0 107.0 107.0 107.0 107.0 109.0 107.0 109.0 109.0 15:03:40 INFO - PID 6657 | 15:03:40 INFO - PID 6657 | [#1] audio-beat-detection Cycles:10 Average:122.10 Median:119.50 stddev:9.19 (7.7%) stddev-sans-first:9.68 15:03:40 INFO - PID 6657 | Values: 119.0 118.0 116.0 119.0 116.0 120.0 123.0 118.0 125.0 147.0 15:03:40 INFO - PID 6657 | 15:03:40 INFO - PID 6657 | [#2] audio-dft Cycles:10 Average:165.40 Median:166.00 stddev:2.01 (1.2%) stddev-sans-first:1.72 15:03:40 INFO - PID 6657 | Values: 162.0 164.0 165.0 168.0 163.0 166.0 167.0 165.0 168.0 166.0 15:03:40 INFO - PID 6657 | 15:03:40 INFO - PID 6657 | [#3] audio-fft Cycles:10 Average:74.70 Median:75.00 stddev:1.06 (1.4%) stddev-sans-first:1.12 15:03:40 INFO - PID 6657 | Values: 75.0 75.0 74.0 74.0 73.0 76.0 74.0 76.0 76.0 74.0 15:03:40 INFO - PID 6657 | 15:03:40 INFO - PID 6657 | [#4] audio-oscillator Cycles:10 Average:79.30 Median:79.50 stddev:0.67 (0.8%) stddev-sans-first:0.67 15:03:40 INFO - PID 6657 | Values: 80.0 80.0 79.0 78.0 79.0 79.0 80.0 80.0 79.0 79.0 15:03:40 INFO - PID 6657 | 15:03:40 INFO - PID 6657 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.00 stddev:1.42 (1.2%) stddev-sans-first:1.50 15:03:40 INFO - PID 6657 | Values: 115.0 115.0 117.0 115.0 114.0 113.0 115.0 118.0 115.0 116.0 15:03:40 INFO - PID 6657 | 15:03:40 INFO - PID 6657 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 15:03:40 INFO - PID 6657 | Values: 148.0 149.0 150.0 147.0 148.0 148.0 147.0 148.0 148.0 148.0 15:03:40 INFO - PID 6657 | 15:03:40 INFO - PID 6657 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:95.00 stddev:2.26 (2.4%) stddev-sans-first:2.32 15:03:40 INFO - PID 6657 | Values: 94.0 98.0 98.0 94.0 94.0 93.0 95.0 96.0 95.0 100.0 15:03:40 INFO - PID 6657 | 15:03:40 INFO - PID 6657 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:56.00 stddev:4.54 (8.1%) stddev-sans-first:4.75 15:03:40 INFO - PID 6657 | Values: 55.0 55.0 56.0 56.0 56.0 55.0 57.0 70.0 56.0 56.0 15:03:40 INFO - PID 6657 | 15:03:40 INFO - PID 6657 | [#9] json-stringify-tinderbox Cycles:10 Average:37.20 Median:37.00 stddev:0.63 (1.7%) stddev-sans-first:0.50 15:03:40 INFO - PID 6657 | Values: 36.0 37.0 37.0 38.0 38.0 37.0 37.0 37.0 37.0 38.0 15:03:40 INFO - PID 6657 | 15:03:40 INFO - PID 6657 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:73.50 stddev:2.02 (2.8%) stddev-sans-first:2.00 15:03:40 INFO - PID 6657 | Values: 76.0 73.0 73.0 77.0 72.0 73.0 72.0 74.0 72.0 77.0 15:03:40 INFO - PID 6657 | 15:03:40 INFO - PID 6657 | [#11] stanford-crypto-ccm Cycles:10 Average:116.70 Median:116.50 stddev:3.47 (3.0%) stddev-sans-first:3.10 15:03:40 INFO - PID 6657 | Values: 122.0 117.0 111.0 116.0 115.0 121.0 116.0 113.0 116.0 120.0 15:03:40 INFO - PID 6657 | 15:03:40 INFO - PID 6657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.80 Median:168.50 stddev:3.36 (2.0%) stddev-sans-first:3.55 15:03:40 INFO - PID 6657 | Values: 168.0 168.0 173.0 171.0 166.0 169.0 168.0 164.0 166.0 175.0 15:03:40 INFO - PID 6657 | 15:03:40 INFO - PID 6657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.50 stddev:1.35 (2.0%) stddev-sans-first:1.33 15:03:40 INFO - PID 6657 | Values: 68.0 68.0 66.0 68.0 68.0 65.0 65.0 66.0 65.0 67.0 15:03:40 INFO - PID 6657 | -------- Summary: end -------- 15:03:40 INFO - PID 6657 | 15:03:40 INFO - PID 6657 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:03:41 INFO - TEST-INFO | 6657: exit 0 15:03:41 INFO - TEST-OK | kraken | took 60602ms 15:03:41 INFO - SUITE-END | took 1169s 15:03:41 INFO - Completed test suite (00:19:30) 15:03:41 INFO - javascript benchmark 15:03:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8599.18718274407, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3096.969030309697, 3123.500239961606, 3170.2549900773315, 3181.634112077109, 3193.185737636902, 6161.291451483081, 6268.623882567043, 6342.397472240142, 6379.744810207586, 6380.425761681454, 6269.968650156743, 6352.618842869431, 6442.226932768074, 6445.516586256026, 6451.129097571827, 1207.272102818098, 5500.669959802404, 5834.56240781941, 5872.677002764846, 5950.137230101633, 5643.943560564403, 5702.914456283159, 5719.25649665545, 5863.736131874076, 5866.442687944638, 5677.858053548653, 5716.828495145152, 5730.426957304237, 5734.053881109591, 5738.7991420300505, 5653.830385088454, 5806.390329015435, 5812.593118481708, 5816.651000939957, 5816.941830581683, 5776.9422305776825, 5801.390853960315, 5861.6189947653265, 5864.1203819427, 5884.235049443545, 6188.412100850457, 6288.717007734663, 6317.873642527124, 6356.904646430307, 6398.520110991648, 6598.769043083469, 6670.266270710218, 6674.03226532155, 6674.599524028574, 6676.566023208476, 6724.361185687352, 6762.526623136382, 6786.3892249697765, 6885.862282754367, 6896.896546551806, 6332.746690132389, 6362.713677884506, 6366.586171898812, 6369.140166077566, 6371.0, 6959.060526828915, 6972.965135174291, 6979.162500499972, 7045.964770176116, 7064.08166938305, 6500.9349906501275, 6594.340565943367, 6597.043428702811, 6610.735570577219, 6695.564788288746, 6797.082393876863, 6812.4550035997, 6820.215675197316, 6822.079019332426, 6823.044773731682, 6719.596824190564, 6788.864222715518, 6797.9660101700165, 6802.863942721118, 6814.352636499525, 6782.186137663413, 6795.898061529081, 6858.622775747382, 6865.107536020385, 6890.379865812101, 5096.159133742891, 5249.343832020997, 5267.3152490176035, 5296.629235953524, 5361.705106219196, 4596.103759766814, 4627.5603817637275, 4627.814887404466, 4628.028114096078, 4655.5577220164705, 5853.473187413068, 5862.208601838783, 5924.822255332347, 5940.079287710412, 5941.049432090931, 6800.251972283045, 6829.7268109276065, 6885.586864788129, 6889.793306200822, 6914.343137401939, 5759.395263497357, 5859.44335288147, 5876.177335173079, 5932.822015339547, 5939.495142912814, 5708.343540492813, 5758.0, 5762.798302059407, 5770.826875193751, 5781.479666829921, 6618.305077966744, 6637.5685580438085, 6696.229933557704, 6710.127683401127, 6711.261761206263, 6756.594604323756, 6782.2200446948245, 6785.59286442815, 6873.450123990169, 6881.518293719491, 6434.2922278548385, 6555.639439830855, 6577.901331480128, 6584.901226481702, 6677.532572719863, 6693.598384096775, 6711.731530738716, 6718.328167183243, 6720.1263835703, 6720.630365329758, 6823.283555226828, 6823.55646882951, 6898.758543450955, 6912.55068420551, 6933.514653974174, 6548.574342667712, 6569.704363303567, 6586.2755096940255, 6664.66676666155, 6672.499562532927, 6404.807855764335, 6531.477481801539, 6536.182977127859, 6536.477081833537, 6538.574992625464, 6390.137331460193, 6432.967835160982, 6477.902831457626, 6549.869002619826, 6581.868362632817, 6617.147198784348, 6700.597964121973, 6728.831779205559, 6758.695858686469, 6760.290169532325, 6191.535634827496, 6319.988801791691, 6414.647194404352, 6422.293547709842, 6514.9348506514325], "value": 6136.823546020538, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [832.5213002523549, 870.1342164546278, 872.0712441250066, 884.5179377239403, 889.10644801974, 41224.0, 41953.79023104888, 42400.787996059975, 42465.78767106164, 42558.57441425585, 38647.806760966225, 38897.80551097241, 38964.85693286868, 38985.61014389855, 39040.414393784115, 7017.964910175442, 7132.821679458003, 7142.8571428571395, 7144.0, 7150.74972375967, 6984.057152284453, 7051.330123638246, 7054.6825392857445, 7065.682044307992, 7067.717291308367, 7637.427192960522, 7810.101838288584, 7833.804154896116, 7835.059792824841, 7842.843143137134, 7741.109772376164, 7760.767176984699, 7768.57272849993, 7784.260495252942, 7820.374370050411, 7543.0, 7631.275028872248, 7653.579053152074, 7726.961365193194, 7737.651805668702, 38448.423273650915, 38556.22887542262, 38564.0, 38591.42112868309, 38621.227575448334, 3544.220271540257, 3583.372909740811, 3587.856485740567, 3603.6756691897594, 3605.06268370223, 31511.36977260465, 32038.83980580082, 32114.839425802955, 32264.516032259537, 32281.35437291241, 5246.081935661244, 5249.711265880375, 5259.500347466985, 5284.550813180885, 5298.125809241509, 177366.0, 183458.0, 183624.0, 183664.0, 184038.0, 41345.0, 47205.0, 47617.0, 47627.04745905132, 47908.0, 50132.74668133253, 50463.49536504588, 50486.24270635944, 50520.0, 50689.0, 15810.60473488172, 15928.681426371408, 16032.797540184532, 16123.113228772296, 16135.919320403324, 13390.866091339156, 13403.597892063253, 13411.597652070453, 13420.127691700009, 13426.932865335611, 13744.106633068819, 13774.035817492679, 13778.448862045407, 13861.237631930138, 13975.720485590231, 5490.231367608538, 5590.888182236333, 5617.662940223599, 5730.08318669011, 5751.309842818889, 997.5760301871676, 1013.8631284776461, 1019.8470229465639, 1020.4744556553233, 1033.8862725100232, 22721.659175112385, 22749.02759585834, 22895.885520572625, 23031.309060728207, 23079.88460057689, 1125.6172901213463, 1127.430647523012, 1133.6485689436302, 1135.3074624479061, 1135.6706555099095, 12118.212316199419, 12209.877901220874, 12232.266064036186, 12287.447064882102, 12326.691832704255, 205684.0, 208937.0, 208986.0, 209000.0, 211329.0, 51662.74168629133, 51731.741341293055, 52028.739856300475, 52120.0, 52144.47855521472, 1407.6340151560669, 1452.8982971192127, 1476.3430273528177, 1478.3199728125182, 1489.3149151390264, 22034.33896983093, 22483.43791405228, 22687.092516299163, 22750.0, 22807.31578052661, 37193.628063719014, 37326.440103399014, 37368.25263494769, 37421.0, 37425.0, 183183.08408458406, 183835.0, 183883.0, 184303.0, 184383.0, 31006.37987240288, 31611.683883160873, 33892.32215355728, 33988.49017264693, 34271.657283426845, 41648.79175604103, 41974.0, 41976.790116049226, 42183.0, 42422.575774241865, 31959.0, 32079.35841283208, 32249.838750806095, 32404.0, 32463.0, 30989.69010309868, 31073.844630777607, 31149.065528034196, 31454.21364465815, 31554.211144721565, 34594.308113837076, 34725.47911781376, 35052.47421288734, 35400.82299588485, 35452.936411907685, 30568.0, 30841.8457907709, 31273.37453250968, 31280.21799455032, 31607.683923161392, 22729.545409092058, 23409.76590234144, 23762.049518019085, 23835.761642383353, 23877.76122238825], "value": 16890.86360968296, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.7143221241062, 566.9603127781056, 567.9545636349093, 568.8634727665361, 590.2150140313383, 22003.899805009765, 22484.32547023592, 22489.887550562245, 22517.437064073405, 22824.88587557062, 24216.87891560544, 24760.3809904752, 25142.371440713992, 25283.11509097182, 25683.486330273383, 6443.677816109188, 6632.801015969529, 6647.867042659144, 6652.634105124216, 6662.900056499157, 6520.31536688648, 6628.270890202074, 6636.469082473414, 6640.236372817116, 6889.586624802528, 7174.533655312414, 7195.388391986688, 7198.604076775775, 7202.20775714671, 7204.819879503002, 7161.64191790411, 7170.06789117414, 7173.067501224859, 7178.7128514859605, 7180.281971802778, 6690.698918548677, 6942.826429339257, 6968.477364197705, 6986.510944233905, 7031.578105313698, 30909.690903090905, 31634.36731265385, 31647.0, 31649.84175079133, 31660.683393166004, 2086.2593779208464, 2112.0, 2114.6616541353465, 2119.311223852254, 2121.7029615853794, 18773.0, 20338.5932281355, 20654.380368588965, 20839.89580052105, 20847.166113355448, 2504.5491811473926, 2527.671402717653, 2568.935776605581, 2579.638850560923, 2580.9870950645313, 122612.38693806563, 128751.35624321912, 136962.0, 143239.0, 143448.0, 19676.50808729793, 21167.68248476274, 21683.34949951504, 21855.453613659785, 21977.780222197893, 42566.36150457684, 42573.57426425696, 42593.36109958353, 42656.0, 42668.359974600404, 11244.493997769956, 11565.710857228636, 11709.0, 11714.531418743154, 11765.764684706259, 9466.290028247771, 9681.757956051155, 9716.368436051634, 9791.755206119762, 9813.11681948628, 10781.191410644233, 10827.891721082846, 11122.721931951766, 11200.38397888124, 11434.714132146762, 3801.5248093988253, 3878.0, 3964.980175099106, 4015.3221496956303, 4220.134872351161, 937.2923442800642, 970.6069042037985, 975.205207755691, 984.9803003940025, 985.3693636072919, 19817.504562386057, 19848.20607175697, 19901.104450299772, 19910.800891991184, 19957.700634490495, 1027.5889644142253, 1031.2471895516164, 1032.2361452525076, 1036.1400037968467, 1038.9324693894873, 10702.304350217211, 10788.298760580537, 10841.078508326722, 10958.890411095786, 11057.778844423066, 405974.0, 407070.0, 409229.0, 436261.0, 437848.0, 108014.45992769986, 110435.0, 110472.4476377613, 110907.44546277217, 110923.0, 1052.1740433759614, 1078.541619811577, 1086.8315411111291, 1090.8363745438248, 1093.5407129005837, 16808.159592020107, 16995.23521441563, 17232.052237126576, 17338.653226935137, 17425.73861392055, 52577.21134183067, 53237.7338113307, 53690.73154634202, 55429.44570554243, 56772.0, 64705.67647161734, 65107.0, 65277.0, 65382.0, 66488.66755666191, 19396.0, 19734.40796776099, 19907.10418031221, 19967.900160499106, 20077.49806254797, 21757.673634895807, 21869.234576789735, 22235.332940011827, 22361.77010264451, 22469.550608987403, 17298.65402691914, 17463.56341091483, 17626.73559896577, 17660.646787063928, 17907.462776116736, 16112.597185070466, 16290.0, 16738.828282020142, 16783.0, 16858.831411685725, 17951.820481795014, 18136.45590632283, 18334.266629334677, 18456.0, 18640.440786776417, 19514.902425488348, 19565.413037608894, 19693.70459443081, 19707.0, 19766.50583735418, 17769.0, 17826.91086544559, 17857.374991875742, 17921.0, 18057.097145142427], "value": 12716.996760320973, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1306.1705816806327, 1369.3495589594943, 1387.9653008674782, 1387.9861201387982, 1404.1645221093445, 14870.33083511242, 15500.37998480061, 15510.224488775544, 15526.068435893825, 15547.0, 15149.0, 15287.923560382182, 15315.617109572266, 15319.387224511034, 15323.463678771246, 2621.1743300860167, 2636.6572345595046, 2683.9597406038924, 2697.0425498947884, 2698.757111859932, 2678.571428571429, 2680.7855371570226, 2708.8103832731717, 2709.972900270992, 2727.263638817528, 2646.57654775236, 2671.6259723638705, 2749.175247425764, 2767.7370649788236, 2778.541540645791, 2666.786657067449, 2668.7598116169543, 2692.3807524269428, 2697.8920843166447, 2712.91861244162, 2639.7756190723812, 2663.733626637321, 2668.3062403774966, 2674.7860171186258, 2746.7665248453904, 14857.0, 15031.0, 15032.849671503254, 15033.398664053424, 15059.17174555399, 8042.919570804275, 8341.499510029418, 8349.95825020877, 8351.958240208822, 8373.41386102973, 5496.477834605706, 5596.1605759136455, 5702.0, 5715.371309155989, 5719.8570035749435, 1861.5625328047897, 1915.0, 1915.6551820672273, 1934.0136530369473, 1947.6202140582593, 26142.477150457074, 26618.20145395641, 26620.866895665593, 26776.73223267762, 26832.329191770168, 7145.964270178616, 7376.815579610553, 7454.142773581108, 7553.169151393342, 7554.811129721691, 16629.833701663072, 20013.39959801208, 20085.196592136443, 20093.0, 20118.29585964484, 7772.961135194288, 8041.155678653774, 8043.356531477468, 8048.0342358917305, 8048.195180482022, 7253.673584688701, 7331.0, 7397.667104980289, 7398.815029624195, 7403.444741644398, 5187.429382767892, 5278.551323137576, 5308.0, 5401.297831281908, 5409.566464886808, 1531.5788158256569, 1535.5009621872937, 1545.1115608524917, 1545.652228248635, 1560.492839827038, 858.8797568340437, 866.3718803867272, 877.1666916429417, 886.822635472908, 894.9507777072193, 7225.060742103493, 7228.987941688168, 7250.456215783837, 7291.0, 8457.873131903027, 718.4037249083249, 720.5193327711603, 725.2493669052506, 727.0838743183521, 740.0268646729534, 4938.135826230396, 5064.594832413398, 5331.0, 5350.6254562180275, 5508.55931525477, 20377.796222037887, 21023.894880525804, 21125.68311475329, 21313.89343053275, 21980.560388792455, 21113.366599001747, 21252.681209781866, 21465.46336341573, 21641.350759476925, 21896.781032189792, 10315.587376505006, 10464.947675261576, 10647.36115833068, 10668.679939601825, 10697.893021069845, 7890.921090789018, 8037.477563958324, 8153.266206041485, 8211.096779354148, 8236.588170591327, 17964.550886227426, 18343.54141146482, 18516.72224916654, 18806.52983675364, 18808.435746927615, 19100.0, 19290.614187715888, 19306.90346548258, 19518.902405487883, 19707.40877773669, 11117.666470005914, 11170.720731981766, 11201.887981120084, 11316.717082072684, 11336.773264534828, 14054.297285135906, 14181.14913105217, 14189.503367382093, 14213.431462741788, 14235.359408826835, 11618.94190529042, 11790.587329443428, 11836.526538938346, 11908.52365905354, 11919.52321907114, 11290.096792256436, 11535.307881527135, 11561.19071665009, 11689.707757306136, 11839.0, 9617.903820961701, 9782.706518804447, 9785.461799601091, 9790.412575245507, 9791.020897910152, 6698.933010669831, 6814.522983391115, 6816.079829222991, 6894.586324820527, 6929.549579277331, 6730.226024007302, 6853.862922741617, 6861.313868613299, 6887.793366199022, 6923.065386172802], "value": 6638.374675671108, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.3109508877748, 501.6407419524334, 524.9737513124344, 525.1545012529829, 529.756649239591, 6304.180456540649, 6316.778912738055, 6329.4619957303685, 6382.617042977425, 6409.77565785197, 6203.596766210193, 6237.5321850861255, 6253.468455181315, 6268.905966410507, 6304.558680892339, 5156.473328069256, 5169.457206993258, 5198.896022079556, 5229.86925326868, 5243.951209758064, 4851.514848515138, 4983.216112531955, 5162.8193013244545, 5175.58595312376, 5175.948240517584, 4927.728974906378, 4937.753112344386, 4962.87592810179, 4965.577925876287, 5009.824656137036, 4888.999999999982, 4909.7790599423115, 4933.161362568372, 4946.159152944008, 4957.950420495785, 4379.956200437987, 4415.0, 4429.357743127261, 4691.929621055687, 4775.594074503671, 6053.424924632153, 6065.605735627214, 6111.908321375183, 6166.537509686791, 6189.907151392733, 5964.254468191476, 5971.910421343683, 5980.760769569212, 5985.6408615483215, 6011.639301641915, 6563.835904102388, 6602.0, 6605.735770569171, 6637.56855804376, 6685.022411665052, 5059.19052951526, 5254.8160814371695, 5328.946710532884, 5333.013392522395, 5350.528604633718, 6768.93231067688, 6777.0, 6888.380045795852, 6900.102986611759, 6947.235804061549, 5455.063452474394, 5469.945300546943, 5482.342118945672, 5495.04356863058, 5530.032244357221, 5387.326584176978, 5502.642328248651, 5509.283793106951, 5527.2538207342295, 5540.728301396408, 5921.342024233221, 5928.762849486058, 5944.7324870380935, 6017.518598512109, 6019.518438524908, 6678.6326752028135, 6688.130543029375, 6688.398044176048, 6694.59832410057, 6712.865742685119, 1899.3352326685826, 1926.268018153093, 1927.816857398545, 1929.0258419498064, 1940.592475580144, 1336.365226517416, 1374.9656258593616, 1428.5357258890901, 1430.4778755754076, 1443.7617793064028, 5745.597808153473, 5746.626469279484, 5772.393898640582, 5812.599629216871, 5854.209681692917, 6557.442617377576, 6598.142241508669, 6602.8349291268105, 6618.834529136714, 6693.330666933365, 5709.942900571024, 5731.512821410227, 5742.454466825645, 5760.070376423945, 5769.451902069297, 3512.5258090157504, 3522.260325331658, 3523.4010218262956, 3533.4559117435406, 3582.176099497078, 6344.809655710336, 6369.840753981095, 6490.318516555788, 6500.154979852683, 6527.281998980108, 6799.422049125781, 6868.416184624263, 6875.48433867452, 6913.0, 6952.339527744856, 6527.997121324244, 6587.969534014407, 6602.801915942433, 6606.207255129415, 6640.882652755419, 6630.436412904957, 6723.0, 6730.394264516217, 6786.660666966533, 6819.249882513019, 6536.705848236936, 6541.280459149585, 6579.440747536513, 6599.835004124935, 6627.768028119185, 6424.743010279536, 6527.15147030883, 6530.542861999805, 6534.183227096613, 6573.967130164318, 5451.563874890078, 5485.753141108739, 5496.395396506461, 5520.972395137998, 5522.9447705524035, 6276.215473065867, 6462.416707906593, 6569.441597464269, 6870.244273130052, 6894.620795856276, 6163.291221509584, 6411.166548348685, 6422.967885160544, 6446.613203207635, 6458.54790164684, 6322.778702745381, 6387.584806987531, 6399.392057754506, 6443.0, 6454.579992401664, 6402.583832050902, 6410.391012853772, 6464.41820236181, 6494.935050649433, 6503.6097834130105, 6415.486761059197, 6567.047778072058, 6578.539502234989, 6632.966835165793, 6637.800865974028, 6280.874382512416, 6298.181236439417, 6338.971529110825, 6385.0, 6421.646809425526], "value": 5158.359098437619, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [890.9955450222748, 903.9502827344495, 906.4923642760051, 914.3690853311215, 926.8563372677236, 21157.0, 22018.11927522899, 22854.31437056891, 22894.198703045397, 22929.968151433204, 20147.496312592193, 20614.48463788406, 20708.48228794281, 20731.585368292664, 20784.792152078473, 939.037486576258, 950.1828427552299, 951.5432592355673, 954.5942974235957, 954.8138113067954, 940.5814412586368, 960.231814548362, 970.3595626886256, 971.3880255439099, 972.7422233108232, 1013.5287091502449, 1021.4177918586408, 1022.8056669232859, 1023.5138309303096, 1025.318163421324, 1010.161565900301, 1024.8309029010204, 1026.8767747870265, 1026.9024442677971, 1027.275770581738, 751.4026349052516, 754.9094108706936, 756.8826831841073, 758.5600351796, 759.1914610939388, 19987.500312492157, 20240.49398765028, 20568.177272909066, 20581.176752929863, 20581.38255852327, 21524.354269371943, 21534.246301379535, 22019.22932697348, 22042.0, 22044.88977555118, 17388.56528586783, 17392.565185870328, 17413.390531331344, 17438.04090775007, 17442.65114697699, 3589.228315912065, 3663.60782902498, 3686.096906257984, 3708.2027364116843, 3733.701303895682, 140522.29738851343, 140556.2972185143, 140946.0, 142375.28812355976, 146144.26927865294, 16222.51332460028, 16372.345106195618, 16391.754123688155, 16487.752683709754, 16515.091669958027, 24807.13175038865, 25905.870470647904, 28823.711762882103, 28875.278118047216, 29318.120456386343, 8803.735887923373, 9152.63389464414, 9171.862422063674, 9174.86237706435, 9203.217726493189, 3920.2943470175073, 4031.717779755389, 4071.5521292657786, 4091.5499295077516, 4219.07180420307, 5365.946340536622, 5482.945170548243, 5537.473939975695, 5541.418151094158, 5569.275994120739, 1104.845321654969, 1118.7091356247433, 1134.3024040215373, 1135.211028335299, 1135.699623930595, 682.8941514065327, 696.1263614164293, 699.1644984243779, 705.368695017956, 706.8586282743369, 11506.424678766196, 11918.225315354473, 12439.315837628836, 12458.439370228361, 13032.218066916015, 668.6756922892394, 676.7597502886503, 689.0, 697.2434908124742, 699.5942353434996, 5378.838634840961, 5453.400125986138, 5525.889482210333, 5549.72251387429, 5568.303962004749, 122524.38737806432, 123010.0, 124092.0, 126230.36884815517, 128679.0, 109520.0, 110427.0, 110787.44606276917, 111509.44245278722, 111974.0, 93688.0, 93778.53110734402, 98230.50884745673, 98602.0, 98792.50603746936, 10409.531571079471, 10422.791544168922, 10649.9467502662, 10821.621243256448, 10894.618688346187, 44354.77822610866, 44390.0, 44608.55391446044, 44793.32810007787, 45797.31304030376, 55853.72073139608, 58235.0, 58334.4166558346, 58985.41014589799, 59301.703491482265, 15405.152716600247, 15406.537803865902, 15621.297041632926, 15661.963944687117, 15662.138582377624, 16568.0, 16928.576785579968, 16972.575685607466, 16972.830271697127, 17013.659726805643, 15203.619909502351, 15508.92245538765, 15595.688086238439, 15608.375664973273, 15613.219339032776, 14253.786193207317, 14332.785008225093, 14422.639434013814, 14435.061720988522, 14460.927695361455, 15504.767428488807, 15553.0, 15733.763993540335, 15900.0, 16091.597710057342, 11227.775444491228, 11237.943810280896, 11250.268732532359, 11721.296722196696, 11801.05591552691, 11657.18399712012, 11664.950154486138, 11706.297622142358, 11772.352520611448, 11781.175317727677], "value": 8957.056832645127, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1428.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 109.0, 107.0, 107.0, 107.0, 107.0, 109.0, 107.0, 109.0, 109.0], "value": 107.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 116.0, 119.0, 116.0, 120.0, 123.0, 118.0, 125.0, 147.0], "value": 122.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 165.0, 168.0, 163.0, 166.0, 167.0, 165.0, 168.0, 166.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 74.0, 73.0, 76.0, 74.0, 76.0, 76.0, 74.0], "value": 74.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 78.0, 79.0, 79.0, 80.0, 80.0, 79.0, 79.0], "value": 79.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 117.0, 115.0, 114.0, 113.0, 115.0, 118.0, 115.0, 116.0], "value": 115.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 150.0, 147.0, 148.0, 148.0, 147.0, 148.0, 148.0, 148.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 98.0, 98.0, 94.0, 94.0, 93.0, 95.0, 96.0, 95.0, 100.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 56.0, 56.0, 55.0, 57.0, 70.0, 56.0, 56.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 37.0, 37.0, 38.0, 38.0, 37.0, 37.0, 37.0, 37.0, 38.0], "value": 37.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 73.0, 77.0, 72.0, 73.0, 72.0, 74.0, 72.0, 77.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 117.0, 111.0, 116.0, 115.0, 121.0, 116.0, 113.0, 116.0, 120.0], "value": 116.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 173.0, 171.0, 166.0, 169.0, 168.0, 164.0, 166.0, 175.0], "value": 168.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 68.0, 68.0, 65.0, 65.0, 66.0, 65.0, 67.0], "value": 66.6, "unit": "score"}]}]} 15:03:41 INFO - Return code: 0 15:03:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:03:41 INFO - # TBPL SUCCESS # 15:03:41 INFO - Running post-action listener: _package_coverage_data 15:03:41 INFO - Running post-action listener: _resource_record_post_action 15:03:41 INFO - [mozharness: 2017-09-16 22:03:41.747434Z] Finished run-tests step (success) 15:03:41 INFO - Running post-run listener: _resource_record_post_run 15:03:41 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 12288; Write bytes: 338149376; Read time: 184; Write time: 171464 15:03:41 INFO - TinderboxPrint: CPU usage
13.1% 15:03:41 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 184 15:03:41 INFO - TinderboxPrint: I/O write bytes / time
338,149,376 / 171,464 15:03:41 INFO - TinderboxPrint: CPU idle
8,229.5 (86.9%) 15:03:41 INFO - TinderboxPrint: CPU user
1,191.9 (12.6%) 15:03:41 INFO - TinderboxPrint: Swap in / out
0 / 0 15:03:41 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10014720; Read time: 0; Write time: 932 15:03:41 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:03:41 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 8192; Write bytes: 328134656; Read time: 168; Write time: 170532 15:03:42 INFO - Running post-run listener: _upload_blobber_files 15:03:42 INFO - Blob upload gear active. 15:03:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:03:42 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 15:03:42 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'] 15:03:42 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 15:03:42 INFO - (blobuploader) - INFO - Open directory for files ... 15:03:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 15:03:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:03:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:03:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 15:03:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:03:43 INFO - (blobuploader) - INFO - Done attempting. 15:03:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 15:03:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:03:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:03:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 15:03:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:03:44 INFO - (blobuploader) - INFO - Done attempting. 15:03:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:03:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:03:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:03:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:03:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:03:45 INFO - (blobuploader) - INFO - Done attempting. 15:03:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:03:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:03:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:03:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:03:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:03:51 INFO - (blobuploader) - INFO - Done attempting. 15:03:51 INFO - (blobuploader) - INFO - Iteration through files over. 15:03:51 INFO - Return code: 0 15:03:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:03:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:03:51 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6c1b898d677f0f957d1db499d1679c9d546bea6b8d49319c416b4b59472a8c18b97569520447597015f8baaf5c0967113e92c7d6dfcd5a489a008b04b21fe2a9", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6822064e1b4d17ca44905297aa64daa4fcb246b28286dfc679d75876af1ff8cdd05628cb8f9a8ed1516160886c58e6b136680d2fd8c492c682af81cde6df3aad", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8700b3d376c134f5c4bcc32491368f252c95be8cf9ef6fac7e917c13c4c2736fe7b90f1a13d294e40af7306fc5a69648f531ed9d74c9e8845bdb13740127c6ff", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dfe4c373f77580b7b9b4c8a9d1592d722951f69f5d46b58983db874891022756abaef5752692628f8f1b48c41088da229cf8544273909f975986de5e9bb38e2c"} 15:03:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:03:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:03:51 INFO - Contents: 15:03:51 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6c1b898d677f0f957d1db499d1679c9d546bea6b8d49319c416b4b59472a8c18b97569520447597015f8baaf5c0967113e92c7d6dfcd5a489a008b04b21fe2a9", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6822064e1b4d17ca44905297aa64daa4fcb246b28286dfc679d75876af1ff8cdd05628cb8f9a8ed1516160886c58e6b136680d2fd8c492c682af81cde6df3aad", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8700b3d376c134f5c4bcc32491368f252c95be8cf9ef6fac7e917c13c4c2736fe7b90f1a13d294e40af7306fc5a69648f531ed9d74c9e8845bdb13740127c6ff", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dfe4c373f77580b7b9b4c8a9d1592d722951f69f5d46b58983db874891022756abaef5752692628f8f1b48c41088da229cf8544273909f975986de5e9bb38e2c"} 15:03:51 INFO - Running post-run listener: copy_logs_to_upload_dir 15:03:51 INFO - Copying logs to upload dir... 15:03:51 INFO - mkdir: /builds/slave/test/build/upload/logs 15:03:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.680863 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-16 15:03:52.057791) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 15:03:52.061086) ========= 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=0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441 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/6c1b898d677f0f957d1db499d1679c9d546bea6b8d49319c416b4b59472a8c18b97569520447597015f8baaf5c0967113e92c7d6dfcd5a489a008b04b21fe2a9", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6822064e1b4d17ca44905297aa64daa4fcb246b28286dfc679d75876af1ff8cdd05628cb8f9a8ed1516160886c58e6b136680d2fd8c492c682af81cde6df3aad", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8700b3d376c134f5c4bcc32491368f252c95be8cf9ef6fac7e917c13c4c2736fe7b90f1a13d294e40af7306fc5a69648f531ed9d74c9e8845bdb13740127c6ff", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dfe4c373f77580b7b9b4c8a9d1592d722951f69f5d46b58983db874891022756abaef5752692628f8f1b48c41088da229cf8544273909f975986de5e9bb38e2c"} build_url:https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011243 build_url: 'https://queue.taskcluster.net/v1/task/YmktQZGVQlizREbTDMsobw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6c1b898d677f0f957d1db499d1679c9d546bea6b8d49319c416b4b59472a8c18b97569520447597015f8baaf5c0967113e92c7d6dfcd5a489a008b04b21fe2a9", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6822064e1b4d17ca44905297aa64daa4fcb246b28286dfc679d75876af1ff8cdd05628cb8f9a8ed1516160886c58e6b136680d2fd8c492c682af81cde6df3aad", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8700b3d376c134f5c4bcc32491368f252c95be8cf9ef6fac7e917c13c4c2736fe7b90f1a13d294e40af7306fc5a69648f531ed9d74c9e8845bdb13740127c6ff", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dfe4c373f77580b7b9b4c8a9d1592d722951f69f5d46b58983db874891022756abaef5752692628f8f1b48c41088da229cf8544273909f975986de5e9bb38e2c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 15:03:52.089996) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 15:03:52.090374) ========= 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=0e2a256762fed810e2f0f810000001b3-1505598192.282094-713043441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004388 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 15:03:52.175130) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 15:03:52.175590) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 15:03:52.175997) ========= ========= Total master_lag: 0.19 =========