builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-063 starttime: 1506222930.71 results: success (0) revision: ff40c5dcaa41261b39a4e9795e02a9d51dd30ced ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 20:15:30.713160) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 20:15:30.713679) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 20:15:30.713993) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 20:15:30.894961) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:15:30.895255) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-23 20:15:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 228M=0s 2017-09-23 20:15:31 (228 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.260615 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:15:31.206409) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:15:31.206773) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019533 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:15:31.258131) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:15:31.258461) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ff40c5dcaa41261b39a4e9795e02a9d51dd30ced --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 ff40c5dcaa41261b39a4e9795e02a9d51dd30ced --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=769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-23 20:15:31,321 truncating revision to first 12 chars 2017-09-23 20:15:31,321 Setting DEBUG logging. 2017-09-23 20:15:31,321 attempt 1/10 2017-09-23 20:15:31,321 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ff40c5dcaa41?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-23 20:15:31,899 unpacking tar archive at: mozilla-central-ff40c5dcaa41/testing/mozharness/ program finished with exit code 0 elapsedTime=0.871008 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:15:32.146092) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 20:15:32.146433) ========= script_repo_revision: ff40c5dcaa41261b39a4e9795e02a9d51dd30ced ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 20:15:32.146862) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 20:15:32.147214) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 20:15:32.160681) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-23 20:15:32.160995) ========= /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=769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:15:32 INFO - MultiFileLogger online at 20170923 20:15:32 in /builds/slave/test 20:15:32 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 20:15:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:15:32 INFO - {'append_to_log': False, 20:15:32 INFO - 'base_work_dir': '/builds/slave/test', 20:15:32 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 20:15:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:15:32 INFO - 'branch': 'Firefox-Non-PGO', 20:15:32 INFO - 'buildbot_json_path': 'buildprops.json', 20:15:32 INFO - 'code_coverage': False, 20:15:32 INFO - 'config_files': ('talos/linux_config.py',), 20:15:32 INFO - 'default_actions': ('clobber', 20:15:32 INFO - 'read-buildbot-config', 20:15:32 INFO - 'download-and-extract', 20:15:32 INFO - 'populate-webroot', 20:15:32 INFO - 'create-virtualenv', 20:15:32 INFO - 'install', 20:15:32 INFO - 'setup-mitmproxy', 20:15:32 INFO - 'run-tests'), 20:15:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:15:32 INFO - 'disable_ccov_upload': False, 20:15:32 INFO - 'disable_stylo': False, 20:15:32 INFO - 'download_minidump_stackwalk': True, 20:15:32 INFO - 'download_symbols': 'ondemand', 20:15:32 INFO - 'enable_stylo': False, 20:15:32 INFO - 'enable_webrender': False, 20:15:32 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 20:15:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:15:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:15:32 INFO - 'gecko_profile': False, 20:15:32 INFO - 'gecko_profile_interval': 0, 20:15:32 INFO - 'installer_path': 'installer.exe', 20:15:32 INFO - 'log_level': 'info', 20:15:32 INFO - 'log_name': 'talos', 20:15:32 INFO - 'log_to_console': True, 20:15:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:15:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:15:32 INFO - 'opt_config_files': (), 20:15:32 INFO - 'pip_index': False, 20:15:32 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 20:15:32 INFO - 'system_bits': '32', 20:15:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:15:32 INFO - 'title': 'talos-linux64-ix-063', 20:15:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:15:32 INFO - 'use_talos_json': True, 20:15:32 INFO - 'verify': 'False', 20:15:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:15:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:15:32 INFO - 'work_dir': 'build'} 20:15:32 INFO - [mozharness: 2017-09-24 03:15:32.457056Z] Running clobber step. 20:15:32 INFO - Running pre-action listener: _resource_record_pre_action 20:15:32 INFO - Running main action method: clobber 20:15:32 INFO - rmtree: /builds/slave/test/build 20:15:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:15:33 INFO - Running post-action listener: _resource_record_post_action 20:15:33 INFO - [mozharness: 2017-09-24 03:15:33.421221Z] Finished clobber step (success) 20:15:33 INFO - [mozharness: 2017-09-24 03:15:33.421319Z] Running read-buildbot-config step. 20:15:33 INFO - Running pre-action listener: _resource_record_pre_action 20:15:33 INFO - Running main action method: read_buildbot_config 20:15:33 INFO - Using buildbot properties: 20:15:33 INFO - { 20:15:33 INFO - "project": "", 20:15:33 INFO - "product": "firefox", 20:15:33 INFO - "who": "philringnalda@gmail.com", 20:15:33 INFO - "installer_path": "public/build/target.tar.bz2", 20:15:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 20:15:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 20:15:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 20:15:33 INFO - "stage_platform": "linux64", 20:15:33 INFO - "basedir": "/builds/slave/test", 20:15:33 INFO - "buildnumber": 36, 20:15:33 INFO - "platform": "ubuntu64_hw", 20:15:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:15:33 INFO - "slavebuilddir": "test", 20:15:33 INFO - "taskId": "VFBuYh8pQIuLa6ELHkN9sA", 20:15:33 INFO - "branch": "mozilla-central", 20:15:33 INFO - "script_repo_revision": "production", 20:15:33 INFO - "revision": "ff40c5dcaa41261b39a4e9795e02a9d51dd30ced", 20:15:33 INFO - "slavename": "talos-linux64-ix-063", 20:15:33 INFO - "repo_path": "mozilla-central" 20:15:33 INFO - } 20:15:33 INFO - Finding installer, test and symbols from parent task. 20:15:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VFBuYh8pQIuLa6ELHkN9sA'}, attempt #1 20:15:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VFBuYh8pQIuLa6ELHkN9sA'}, attempt #1 20:15:34 INFO - Task dependencies: ShKXziekTvWG-QSzPkbAOw 20:15:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw'}, attempt #1 20:15:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.tar.bz2 20:15:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.test_packages.json 20:15:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.crashreporter-symbols.zip 20:15:34 INFO - Running post-action listener: _resource_record_post_action 20:15:34 INFO - [mozharness: 2017-09-24 03:15:34.787330Z] Finished read-buildbot-config step (success) 20:15:34 INFO - [mozharness: 2017-09-24 03:15:34.787548Z] Running download-and-extract step. 20:15:34 INFO - Running pre-action listener: _resource_record_pre_action 20:15:34 INFO - Running main action method: download_and_extract 20:15:34 INFO - mkdir: /builds/slave/test/build/tests 20:15: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')]} 20:15:34 INFO - trying https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.test_packages.json 20:15:34 INFO - Downloading https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 20:15:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 20:15:35 INFO - Downloaded 989 bytes. 20:15:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 20:15:35 INFO - Using the following test package requirements: 20:15:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 20:15:35 INFO - u'common': [u'target.common.tests.zip'], 20:15:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 20:15:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 20:15:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 20:15:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 20:15:35 INFO - u'mozbase': [u'target.common.tests.zip'], 20:15:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 20:15:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 20:15:35 INFO - u'web-platform': [u'target.common.tests.zip', 20:15:35 INFO - u'target.web-platform.tests.tar.gz'], 20:15:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 20:15:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 20:15:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.common.tests.zip 20:15:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:15:35 INFO - Fetch https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.common.tests.zip into memory 20:15:36 INFO - Content-Length response header: 54943875 20:15:36 INFO - Bytes received: 54943875 20:15:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.talos.tests.zip 20:15:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 20:15:47 INFO - Fetch https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.talos.tests.zip into memory 20:15:48 INFO - Content-Length response header: 14513823 20:15:48 INFO - Bytes received: 14513823 20:15:48 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')]} 20:15:48 INFO - trying https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.tar.bz2 20:15:48 INFO - Downloading https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 20:15:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 20:15:49 INFO - Downloaded 61526248 bytes. 20:15:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.tar.bz2 20:15:49 INFO - mkdir: /builds/slave/test/properties 20:15:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:15:49 INFO - Writing to file /builds/slave/test/properties/build_url 20:15:49 INFO - Contents: 20:15:49 INFO - build_url:https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.tar.bz2 20:15:49 INFO - Running post-action listener: _resource_record_post_action 20:15:49 INFO - Running post-action listener: find_tests_for_verification 20:15:49 INFO - Running post-action listener: set_extra_try_arguments 20:15:49 INFO - [mozharness: 2017-09-24 03:15:49.443801Z] Finished download-and-extract step (success) 20:15:49 INFO - [mozharness: 2017-09-24 03:15:49.443900Z] Running populate-webroot step. 20:15:49 INFO - Running pre-action listener: _resource_record_pre_action 20:15:49 INFO - Running main action method: populate_webroot 20:15:49 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:15:49 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:15:49 INFO - 'tests': ['tresize', 20:15:49 INFO - 'tcanvasmark']}, 20:15:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:15:49 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:15:49 INFO - 'tests': ['dromaeo_css', 20:15:49 INFO - 'kraken']}, 20:15:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:15:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:15:49 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:15:49 INFO - 'talos_options': ['--disable-stylo'], 20:15:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:15:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:15:49 INFO - 'tests': ['damp', 'tps']}, 20:15:49 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:15:49 INFO - 'talos_options': ['--disable-stylo'], 20:15:49 INFO - 'tests': ['damp', 'tps']}, 20:15:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:15:49 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:15:49 INFO - 'tests': ['dromaeo_dom']}, 20:15:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 20:15:49 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:15:49 INFO - 'tests': ['basic_compositor_video', 20:15:49 INFO - 'glvideo']}, 20:15:49 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 20:15:49 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 20:15:49 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:15:49 INFO - 'talos_options': ['--disable-stylo'], 20:15:49 INFO - 'tests': ['ts_paint_webext', 20:15:49 INFO - 'tp5o_webext']}, 20:15:49 INFO - 'other-e10s': {'tests': ['a11yr', 20:15:49 INFO - 'ts_paint', 20:15:49 INFO - 'tpaint', 20:15:49 INFO - 'sessionrestore', 20:15:49 INFO - 'sessionrestore_many_windows', 20:15:49 INFO - 'sessionrestore_no_auto_restore', 20:15:49 INFO - 'tabpaint']}, 20:15:49 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:15:49 INFO - 'tests': ['a11yr', 20:15:49 INFO - 'ts_paint', 20:15:49 INFO - 'tpaint', 20:15:49 INFO - 'sessionrestore', 20:15:49 INFO - 'sessionrestore_many_windows', 20:15:49 INFO - 'sessionrestore_no_auto_restore', 20:15:49 INFO - 'tabpaint']}, 20:15:49 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 20:15:49 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 20:15:49 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:15:49 INFO - 'tests': ['perf_reftest_singletons']}, 20:15:49 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:15:49 INFO - 'tests': ['perf_reftest']}, 20:15:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:15:49 INFO - 'tsvgr_opacity', 20:15:49 INFO - 'tart', 20:15:49 INFO - 'tscrollx', 20:15:49 INFO - 'tsvg_static']}, 20:15:49 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:15:49 INFO - 'tests': ['tsvgx', 20:15:49 INFO - 'tsvgr_opacity', 20:15:49 INFO - 'tart', 20:15:49 INFO - 'tscrollx', 20:15:49 INFO - 'tsvg_static']}, 20:15:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:15:49 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:15:49 INFO - 'talos_options': ['--disable-stylo'], 20:15:49 INFO - 'tests': ['tp5o']}, 20:15:49 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:15:49 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 20:15:49 INFO - 'talos_options': ['--mitmproxy', 20:15:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:15:49 INFO - '--firstNonBlankPaint'], 20:15:49 INFO - 'tests': ['tp6_google', 20:15:49 INFO - 'tp6_youtube', 20:15:49 INFO - 'tp6_amazon', 20:15:49 INFO - 'tp6_facebook']}, 20:15:49 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:15:49 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 20:15:49 INFO - 'talos_options': ['--disable-stylo', 20:15:49 INFO - '--mitmproxy', 20:15:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:15:49 INFO - '--firstNonBlankPaint'], 20:15:49 INFO - 'tests': ['tp6_google', 20:15:49 INFO - 'tp6_youtube', 20:15:49 INFO - 'tp6_amazon', 20:15:49 INFO - 'tp6_facebook']}, 20:15:49 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:15:49 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 20:15:49 INFO - 'talos_options': ['--stylo-threads=1', 20:15:49 INFO - '--mitmproxy', 20:15:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:15:49 INFO - '--firstNonBlankPaint'], 20:15:49 INFO - 'tests': ['tp6_google', 20:15:49 INFO - 'tp6_youtube', 20:15:49 INFO - 'tp6_amazon', 20:15:49 INFO - 'tp6_facebook']}, 20:15:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:15:49 INFO - 'talos_options': ['--xperf_path', 20:15:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:15:49 INFO - 'tests': ['tp5n']}, 20:15:49 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:15:49 INFO - 'talos_options': ['--disable-stylo', 20:15:49 INFO - '--xperf_path', 20:15:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:15:49 INFO - 'tests': ['tp5n']}}} 20:15:49 INFO - Running post-action listener: _resource_record_post_action 20:15:49 INFO - [mozharness: 2017-09-24 03:15:49.459236Z] Finished populate-webroot step (success) 20:15:49 INFO - [mozharness: 2017-09-24 03:15:49.459326Z] Running create-virtualenv step. 20:15:49 INFO - Running pre-action listener: _resource_record_pre_action 20:15:49 INFO - Running main action method: create_virtualenv 20:15:49 INFO - Creating virtualenv /builds/slave/test/build/venv 20:15:49 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:15:49 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 20:15:49 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 20:15:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:15:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:15:50 INFO - Installing distribute.............................................................................................................................................................................................done. 20:15:50 INFO - Installing pip...............done. 20:15:50 INFO - Return code: 0 20:15:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:15:50 INFO - Reading from file tmpfile_stdout 20:15:50 INFO - Output received: 20:15:50 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 20:15:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:15: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')]} 20:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15: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')]} 20:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c939c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c90d60>, '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 0x1c91a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c91ef0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268', '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 20:15:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:15:50 INFO - Using env: {'DISPLAY': ':0', 20:15:50 INFO - 'HOME': '/home/cltbld', 20:15:50 INFO - 'LANG': 'en_US.UTF-8', 20:15:50 INFO - 'LANGUAGE': 'en_US:en', 20:15:50 INFO - 'LOGNAME': 'cltbld', 20:15:50 INFO - 'MAIL': '/var/mail/cltbld', 20:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:50 INFO - 'MOZ_NO_REMOTE': '1', 20:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:50 INFO - 'NO_EM_RESTART': '1', 20:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:50 INFO - 'PWD': '/builds/slave/test', 20:15:50 INFO - 'SHELL': '/bin/bash', 20:15:50 INFO - 'SHLVL': '1', 20:15:50 INFO - 'TERM': 'linux', 20:15:50 INFO - 'TMOUT': '86400', 20:15:50 INFO - 'USER': 'cltbld', 20:15:50 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268', 20:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:50 INFO - '_': '/tools/buildbot/bin/python'} 20:15:53 INFO - Ignoring indexes: http://pypi.python.org/simple/ 20:15:53 INFO - Downloading/unpacking pip>=1.5 20:15:53 INFO - Running setup.py egg_info for package pip 20:15:53 INFO - warning: no files found matching 'pip/cacert.pem' 20:15:53 INFO - warning: no files found matching '*.html' under directory 'docs' 20:15:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 20:15:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 20:15:53 INFO - Installing collected packages: pip 20:15:53 INFO - Found existing installation: pip 1.1 20:15:53 INFO - Uninstalling pip: 20:15:53 INFO - Successfully uninstalled pip 20:15:53 INFO - Running setup.py install for pip 20:15:53 INFO - warning: no files found matching 'pip/cacert.pem' 20:15:53 INFO - warning: no files found matching '*.html' under directory 'docs' 20:15:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 20:15:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 20:15:53 INFO - Installing pip script to /builds/slave/test/build/venv/bin 20:15:53 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 20:15:53 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 20:15:53 INFO - Successfully installed pip 20:15:53 INFO - Cleaning up... 20:15:53 INFO - Return code: 0 20:15:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c939c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c90d60>, '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 0x1c91a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c91ef0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268', '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 20:15:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:15:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:15:53 INFO - Using env: {'DISPLAY': ':0', 20:15:53 INFO - 'HOME': '/home/cltbld', 20:15:53 INFO - 'LANG': 'en_US.UTF-8', 20:15:53 INFO - 'LANGUAGE': 'en_US:en', 20:15:53 INFO - 'LOGNAME': 'cltbld', 20:15:53 INFO - 'MAIL': '/var/mail/cltbld', 20:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:53 INFO - 'MOZ_NO_REMOTE': '1', 20:15:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:53 INFO - 'NO_EM_RESTART': '1', 20:15:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:53 INFO - 'PWD': '/builds/slave/test', 20:15:53 INFO - 'SHELL': '/bin/bash', 20:15:53 INFO - 'SHLVL': '1', 20:15:53 INFO - 'TERM': 'linux', 20:15:53 INFO - 'TMOUT': '86400', 20:15:53 INFO - 'USER': 'cltbld', 20:15:53 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268', 20:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:53 INFO - '_': '/tools/buildbot/bin/python'} 20:15:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:53 INFO - Downloading/unpacking psutil>=3.1.1 20:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:15:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:15:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:15:55 INFO - Installing collected packages: psutil 20:15:55 INFO - Running setup.py install for psutil 20:15:55 INFO - building 'psutil._psutil_linux' extension 20:15:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:15:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:15:56 INFO - building 'psutil._psutil_posix' extension 20:15:56 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 20:15:56 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 20:15:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:15:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:15:56 INFO - Successfully installed psutil 20:15:56 INFO - Cleaning up... 20:15:56 INFO - Return code: 0 20:15:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:15:56 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')]} 20:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:56 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')]} 20:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:56 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 0x19261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c939c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c90d60>, '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 0x1c91a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c91ef0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268', '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 20:15:56 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 20:15:56 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 20:15:56 INFO - Using env: {'DISPLAY': ':0', 20:15:56 INFO - 'HOME': '/home/cltbld', 20:15:56 INFO - 'LANG': 'en_US.UTF-8', 20:15:56 INFO - 'LANGUAGE': 'en_US:en', 20:15:56 INFO - 'LOGNAME': 'cltbld', 20:15:56 INFO - 'MAIL': '/var/mail/cltbld', 20:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:56 INFO - 'MOZ_NO_REMOTE': '1', 20:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:56 INFO - 'NO_EM_RESTART': '1', 20:15:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:56 INFO - 'PWD': '/builds/slave/test', 20:15:56 INFO - 'SHELL': '/bin/bash', 20:15:56 INFO - 'SHLVL': '1', 20:15:56 INFO - 'TERM': 'linux', 20:15:56 INFO - 'TMOUT': '86400', 20:15:56 INFO - 'USER': 'cltbld', 20:15:56 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268', 20:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:56 INFO - '_': '/tools/buildbot/bin/python'} 20:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:15:57 INFO - Installing collected packages: mozsystemmonitor 20:15:57 INFO - Running setup.py install for mozsystemmonitor 20:15:57 INFO - Successfully installed mozsystemmonitor 20:15:57 INFO - Cleaning up... 20:15:57 INFO - Return code: 0 20:15:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c939c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c90d60>, '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 0x1c91a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c91ef0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268', '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 20:15:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:15:57 INFO - Using env: {'DISPLAY': ':0', 20:15:57 INFO - 'HOME': '/home/cltbld', 20:15:57 INFO - 'LANG': 'en_US.UTF-8', 20:15:57 INFO - 'LANGUAGE': 'en_US:en', 20:15:57 INFO - 'LOGNAME': 'cltbld', 20:15:57 INFO - 'MAIL': '/var/mail/cltbld', 20:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:57 INFO - 'MOZ_NO_REMOTE': '1', 20:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:57 INFO - 'NO_EM_RESTART': '1', 20:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:57 INFO - 'PWD': '/builds/slave/test', 20:15:57 INFO - 'SHELL': '/bin/bash', 20:15:57 INFO - 'SHLVL': '1', 20:15:57 INFO - 'TERM': 'linux', 20:15:57 INFO - 'TMOUT': '86400', 20:15:57 INFO - 'USER': 'cltbld', 20:15:57 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268', 20:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:57 INFO - '_': '/tools/buildbot/bin/python'} 20:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:58 INFO - Downloading/unpacking jsonschema==2.5.1 20:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:15:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:59 INFO - Downloading functools32-3.2.3-2.tar.gz 20:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:15:59 INFO - warning: no files found matching '*.txt' 20:15:59 INFO - no previously-included directories found matching 'build' 20:15:59 INFO - no previously-included directories found matching 'dist' 20:15:59 INFO - no previously-included directories found matching '.git*' 20:15:59 INFO - Installing collected packages: jsonschema, functools32 20:15:59 INFO - Running setup.py install for functools32 20:15:59 INFO - warning: no files found matching '*.txt' 20:15:59 INFO - no previously-included directories found matching 'build' 20:15:59 INFO - no previously-included directories found matching 'dist' 20:15:59 INFO - no previously-included directories found matching '.git*' 20:15:59 INFO - Successfully installed jsonschema functools32 20:15:59 INFO - Cleaning up... 20:15:59 INFO - Return code: 0 20:15:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c939c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c90d60>, '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 0x1c91a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c91ef0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268', '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 20:15:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:15:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:15:59 INFO - Using env: {'DISPLAY': ':0', 20:15:59 INFO - 'HOME': '/home/cltbld', 20:15:59 INFO - 'LANG': 'en_US.UTF-8', 20:15:59 INFO - 'LANGUAGE': 'en_US:en', 20:15:59 INFO - 'LOGNAME': 'cltbld', 20:15:59 INFO - 'MAIL': '/var/mail/cltbld', 20:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:59 INFO - 'MOZ_NO_REMOTE': '1', 20:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:59 INFO - 'NO_EM_RESTART': '1', 20:15:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:59 INFO - 'PWD': '/builds/slave/test', 20:15:59 INFO - 'SHELL': '/bin/bash', 20:15:59 INFO - 'SHLVL': '1', 20:15:59 INFO - 'TERM': 'linux', 20:15:59 INFO - 'TMOUT': '86400', 20:15:59 INFO - 'USER': 'cltbld', 20:15:59 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268', 20:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:59 INFO - '_': '/tools/buildbot/bin/python'} 20:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:15:59 INFO - Cleaning up... 20:15:59 INFO - Return code: 0 20:15:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c939c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c90d60>, '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 0x1c91a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c91ef0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268', '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 20:15:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:15:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:15:59 INFO - Using env: {'DISPLAY': ':0', 20:15:59 INFO - 'HOME': '/home/cltbld', 20:15:59 INFO - 'LANG': 'en_US.UTF-8', 20:15:59 INFO - 'LANGUAGE': 'en_US:en', 20:15:59 INFO - 'LOGNAME': 'cltbld', 20:15:59 INFO - 'MAIL': '/var/mail/cltbld', 20:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:59 INFO - 'MOZ_NO_REMOTE': '1', 20:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:59 INFO - 'NO_EM_RESTART': '1', 20:15:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:59 INFO - 'PWD': '/builds/slave/test', 20:15:59 INFO - 'SHELL': '/bin/bash', 20:15:59 INFO - 'SHLVL': '1', 20:15:59 INFO - 'TERM': 'linux', 20:15:59 INFO - 'TMOUT': '86400', 20:15:59 INFO - 'USER': 'cltbld', 20:15:59 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268', 20:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:59 INFO - '_': '/tools/buildbot/bin/python'} 20:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:00 INFO - Downloading/unpacking blobuploader==1.2.4 20:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:01 INFO - Downloading blobuploader-1.2.4.tar.gz 20:16:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:16:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:16:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:01 INFO - Downloading docopt-0.6.1.tar.gz 20:16:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:16:01 INFO - Installing collected packages: blobuploader, requests, docopt 20:16:01 INFO - Running setup.py install for blobuploader 20:16:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:16:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:16:01 INFO - Running setup.py install for requests 20:16:02 INFO - Running setup.py install for docopt 20:16:02 INFO - Successfully installed blobuploader requests docopt 20:16:02 INFO - Cleaning up... 20:16:02 INFO - Return code: 0 20:16:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c939c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c90d60>, '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 0x1c91a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c91ef0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268', '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 20:16:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:16:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:16:02 INFO - Using env: {'DISPLAY': ':0', 20:16:02 INFO - 'HOME': '/home/cltbld', 20:16:02 INFO - 'LANG': 'en_US.UTF-8', 20:16:02 INFO - 'LANGUAGE': 'en_US:en', 20:16:02 INFO - 'LOGNAME': 'cltbld', 20:16:02 INFO - 'MAIL': '/var/mail/cltbld', 20:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:02 INFO - 'MOZ_NO_REMOTE': '1', 20:16:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:02 INFO - 'NO_EM_RESTART': '1', 20:16:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:02 INFO - 'PWD': '/builds/slave/test', 20:16:02 INFO - 'SHELL': '/bin/bash', 20:16:02 INFO - 'SHLVL': '1', 20:16:02 INFO - 'TERM': 'linux', 20:16:02 INFO - 'TMOUT': '86400', 20:16:02 INFO - 'USER': 'cltbld', 20:16:02 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268', 20:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:02 INFO - '_': '/tools/buildbot/bin/python'} 20:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:16:02 INFO - Running setup.py (path:/tmp/pip-qnMBtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:16:02 INFO - Running setup.py (path:/tmp/pip-VYr1ER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:16:02 INFO - Running setup.py (path:/tmp/pip-C_C_fj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:16:02 INFO - Running setup.py (path:/tmp/pip-Ru4p8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:16:02 INFO - Running setup.py (path:/tmp/pip-aWRNv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:16:02 INFO - Running setup.py (path:/tmp/pip-sQEMk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:16:02 INFO - Running setup.py (path:/tmp/pip-VgKNsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:16:03 INFO - Running setup.py (path:/tmp/pip-5n1BuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:16:03 INFO - Running setup.py (path:/tmp/pip-P0O4eY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:16:03 INFO - Running setup.py (path:/tmp/pip-AUxDFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:16:03 INFO - Running setup.py (path:/tmp/pip-HVehro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:16:03 INFO - Running setup.py (path:/tmp/pip-k12vDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:16:03 INFO - Running setup.py (path:/tmp/pip-MuHP6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:16:03 INFO - Running setup.py (path:/tmp/pip-IyxKrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:16:03 INFO - Running setup.py (path:/tmp/pip-0dvXo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:16:03 INFO - Running setup.py (path:/tmp/pip-bgXxDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:16:03 INFO - Running setup.py (path:/tmp/pip-uVJfrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:16:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:16:03 INFO - Running setup.py install for manifestparser 20:16:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:16:03 INFO - Running setup.py install for mozcrash 20:16:03 INFO - Running setup.py install for mozdebug 20:16:04 INFO - Running setup.py install for mozdevice 20:16:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:16:04 INFO - Running setup.py install for mozfile 20:16:04 INFO - Running setup.py install for mozhttpd 20:16:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:16:04 INFO - Running setup.py install for mozinfo 20:16:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:16:04 INFO - Running setup.py install for mozInstall 20:16:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:16:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:16:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:16:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:16:04 INFO - Running setup.py install for mozleak 20:16:04 INFO - Running setup.py install for mozlog 20:16:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:16:04 INFO - Running setup.py install for moznetwork 20:16:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:16:04 INFO - Running setup.py install for mozprocess 20:16:04 INFO - Running setup.py install for mozprofile 20:16:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:16:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:16:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:16:05 INFO - Running setup.py install for mozrunner 20:16:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:16:05 INFO - Running setup.py install for mozscreenshot 20:16:05 INFO - Running setup.py install for moztest 20:16:05 INFO - Running setup.py install for mozversion 20:16:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:16:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:16:05 INFO - Cleaning up... 20:16:05 INFO - Return code: 0 20:16:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c939c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c90d60>, '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 0x1c91a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c91ef0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268', '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 20:16:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:16:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:16:05 INFO - Using env: {'DISPLAY': ':0', 20:16:05 INFO - 'HOME': '/home/cltbld', 20:16:05 INFO - 'LANG': 'en_US.UTF-8', 20:16:05 INFO - 'LANGUAGE': 'en_US:en', 20:16:05 INFO - 'LOGNAME': 'cltbld', 20:16:05 INFO - 'MAIL': '/var/mail/cltbld', 20:16:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:05 INFO - 'MOZ_NO_REMOTE': '1', 20:16:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:05 INFO - 'NO_EM_RESTART': '1', 20:16:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:05 INFO - 'PWD': '/builds/slave/test', 20:16:05 INFO - 'SHELL': '/bin/bash', 20:16:05 INFO - 'SHLVL': '1', 20:16:05 INFO - 'TERM': 'linux', 20:16:05 INFO - 'TMOUT': '86400', 20:16:05 INFO - 'USER': 'cltbld', 20:16:05 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268', 20:16:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:05 INFO - '_': '/tools/buildbot/bin/python'} 20:16:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:16:05 INFO - Running setup.py (path:/tmp/pip-9MuWst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:16:05 INFO - Running setup.py (path:/tmp/pip-1CN63l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:16:05 INFO - Running setup.py (path:/tmp/pip-AbwGSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:16:05 INFO - Running setup.py (path:/tmp/pip-EYl69w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:16:06 INFO - Running setup.py (path:/tmp/pip-rtx9H9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:16:06 INFO - Running setup.py (path:/tmp/pip-Zqj5yn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:16:06 INFO - Running setup.py (path:/tmp/pip-W9KtKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:16:06 INFO - Running setup.py (path:/tmp/pip-HEym1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:16:06 INFO - Running setup.py (path:/tmp/pip-bNaIgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:16:06 INFO - Running setup.py (path:/tmp/pip-j4W7eX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:16:06 INFO - Running setup.py (path:/tmp/pip-UDVXn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:16:06 INFO - Running setup.py (path:/tmp/pip-hlM1vk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:16:06 INFO - Running setup.py (path:/tmp/pip-mVEPSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:16:06 INFO - Running setup.py (path:/tmp/pip-LB57Kx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:16:06 INFO - Running setup.py (path:/tmp/pip-VbBZp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:16:06 INFO - Running setup.py (path:/tmp/pip-dWKJ8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:16:06 INFO - Running setup.py (path:/tmp/pip-hqlLh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:16:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:08 INFO - Downloading blessings-1.6.tar.gz 20:16:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:16:08 INFO - Installing collected packages: blessings 20:16:08 INFO - Running setup.py install for blessings 20:16:08 INFO - Successfully installed blessings 20:16:08 INFO - Cleaning up... 20:16:08 INFO - Return code: 0 20:16:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:16:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:16:08 INFO - Reading from file tmpfile_stdout 20:16:08 INFO - Current package versions: 20:16:08 INFO - argparse == 1.2.1 20:16:08 INFO - blessings == 1.6 20:16:08 INFO - blobuploader == 1.2.4 20:16:08 INFO - docopt == 0.6.1 20:16:08 INFO - functools32 == 3.2.3-2 20:16:08 INFO - jsonschema == 2.5.1 20:16:08 INFO - manifestparser == 1.1 20:16:08 INFO - mozInstall == 1.13 20:16:08 INFO - mozcrash == 1.0 20:16:08 INFO - mozdebug == 0.1 20:16:08 INFO - mozdevice == 0.51 20:16:08 INFO - mozfile == 1.2 20:16:08 INFO - mozhttpd == 0.7 20:16:08 INFO - mozinfo == 0.10 20:16:08 INFO - mozleak == 0.1 20:16:08 INFO - mozlog == 3.5 20:16:08 INFO - moznetwork == 0.27 20:16:08 INFO - mozprocess == 0.25 20:16:08 INFO - mozprofile == 0.28 20:16:08 INFO - mozrunner == 6.13 20:16:08 INFO - mozscreenshot == 0.1 20:16:08 INFO - mozsystemmonitor == 0.3 20:16:08 INFO - moztest == 0.8 20:16:08 INFO - mozversion == 1.4 20:16:08 INFO - psutil == 3.1.1 20:16:08 INFO - requests == 1.2.3 20:16:08 INFO - wsgiref == 0.1.2 20:16:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c939c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c90d60>, '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 0x1c91a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c91ef0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268', '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 20:16:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:16:08 INFO - Using env: {'DISPLAY': ':0', 20:16:08 INFO - 'HOME': '/home/cltbld', 20:16:08 INFO - 'LANG': 'en_US.UTF-8', 20:16:08 INFO - 'LANGUAGE': 'en_US:en', 20:16:08 INFO - 'LOGNAME': 'cltbld', 20:16:08 INFO - 'MAIL': '/var/mail/cltbld', 20:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:08 INFO - 'MOZ_NO_REMOTE': '1', 20:16:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:08 INFO - 'NO_EM_RESTART': '1', 20:16:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:08 INFO - 'PWD': '/builds/slave/test', 20:16:08 INFO - 'SHELL': '/bin/bash', 20:16:08 INFO - 'SHLVL': '1', 20:16:08 INFO - 'TERM': 'linux', 20:16:08 INFO - 'TMOUT': '86400', 20:16:08 INFO - 'USER': 'cltbld', 20:16:08 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268', 20:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:08 INFO - '_': '/tools/buildbot/bin/python'} 20:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:16:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 20:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 20:16:10 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)) 20:16:10 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)) 20:16:10 INFO - Installing collected packages: simplejson 20:16:10 INFO - Running setup.py install for simplejson 20:16:10 INFO - building 'simplejson._speedups' extension 20:16:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 20:16:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 20:16:11 INFO - Successfully installed simplejson 20:16:11 INFO - Cleaning up... 20:16:11 INFO - Return code: 0 20:16:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:16: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')]} 20:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16: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')]} 20:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c939c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c90d60>, '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 0x1c91a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c91ef0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268', '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 20:16:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:16:11 INFO - Using env: {'DISPLAY': ':0', 20:16:11 INFO - 'HOME': '/home/cltbld', 20:16:11 INFO - 'LANG': 'en_US.UTF-8', 20:16:11 INFO - 'LANGUAGE': 'en_US:en', 20:16:11 INFO - 'LOGNAME': 'cltbld', 20:16:11 INFO - 'MAIL': '/var/mail/cltbld', 20:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:11 INFO - 'MOZ_NO_REMOTE': '1', 20:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:11 INFO - 'NO_EM_RESTART': '1', 20:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:11 INFO - 'PWD': '/builds/slave/test', 20:16:11 INFO - 'SHELL': '/bin/bash', 20:16:11 INFO - 'SHLVL': '1', 20:16:11 INFO - 'TERM': 'linux', 20:16:11 INFO - 'TMOUT': '86400', 20:16:11 INFO - 'USER': 'cltbld', 20:16:11 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268', 20:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:11 INFO - '_': '/tools/buildbot/bin/python'} 20:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:16:11 INFO - Cleaning up... 20:16:11 INFO - Return code: 0 20:16:11 INFO - Running post-action listener: _resource_record_post_action 20:16:11 INFO - Running post-action listener: _start_resource_monitoring 20:16:11 INFO - Starting resource monitoring. 20:16:11 INFO - [mozharness: 2017-09-24 03:16:11.357651Z] Finished create-virtualenv step (success) 20:16:11 INFO - [mozharness: 2017-09-24 03:16:11.358586Z] Running install step. 20:16:11 INFO - Running pre-action listener: _resource_record_pre_action 20:16:11 INFO - Running main action method: install 20:16:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:16:11 INFO - Reading from file tmpfile_stdout 20:16:11 INFO - Detecting whether we're running mozinstall >=1.0... 20:16:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:16:11 INFO - Reading from file tmpfile_stdout 20:16:11 INFO - Output received: 20:16:11 INFO - Usage: mozinstall [options] installer 20:16:11 INFO - Options: 20:16:11 INFO - -h, --help show this help message and exit 20:16:11 INFO - -d DEST, --destination=DEST 20:16:11 INFO - Directory to install application into. [default: 20:16:11 INFO - "/builds/slave/test"] 20:16:11 INFO - --app=APP Application being installed. [default: firefox] 20:16:11 INFO - mkdir: /builds/slave/test/build/application 20:16:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 20:16:29 INFO - Reading from file tmpfile_stdout 20:16:29 INFO - Output received: 20:16:29 INFO - /builds/slave/test/build/application/firefox/firefox 20:16:29 INFO - Running post-action listener: _resource_record_post_action 20:16:29 INFO - [mozharness: 2017-09-24 03:16:29.719767Z] Finished install step (success) 20:16:29 INFO - [mozharness: 2017-09-24 03:16:29.719913Z] Running setup-mitmproxy step. 20:16:29 INFO - Running pre-action listener: _resource_record_pre_action 20:16:29 INFO - Running main action method: setup_mitmproxy 20:16:29 INFO - Skipping: mitmproxy is not required 20:16:29 INFO - Running post-action listener: _resource_record_post_action 20:16:29 INFO - [mozharness: 2017-09-24 03:16:29.720599Z] Finished setup-mitmproxy step (success) 20:16:29 INFO - [mozharness: 2017-09-24 03:16:29.720739Z] Running run-tests step. 20:16:29 INFO - Running pre-action listener: _resource_record_pre_action 20:16:29 INFO - Running pre-action listener: _set_gcov_prefix 20:16:29 INFO - Running main action method: run_tests 20:16:29 WARNING - Try message not found. 20:16:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:16:29 INFO - Python 2.7.3 20:16:29 INFO - Return code: 0 20:16:29 INFO - grabbing minidump binary from tooltool 20:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c90d60>, '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 0x1c91a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c91ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:16:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:16:29 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:16:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:16:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:16:29 INFO - Return code: 0 20:16:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:16:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:16:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:16:29 INFO - ENV: RUST_BACKTRACE is now full 20:16:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:16:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:16:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 20:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 20:16:29 INFO - Using env: {'DISPLAY': ':0', 20:16:29 INFO - 'HOME': '/home/cltbld', 20:16:29 INFO - 'LANG': 'en_US.UTF-8', 20:16:29 INFO - 'LANGUAGE': 'en_US:en', 20:16:29 INFO - 'LOGNAME': 'cltbld', 20:16:29 INFO - 'MAIL': '/var/mail/cltbld', 20:16:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:16:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:29 INFO - 'MOZ_NO_REMOTE': '1', 20:16:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:16:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:29 INFO - 'NO_EM_RESTART': '1', 20:16:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:29 INFO - 'PWD': '/builds/slave/test', 20:16:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:16:29 INFO - 'RUST_BACKTRACE': 'full', 20:16:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 20:16:29 INFO - 'SHELL': '/bin/bash', 20:16:29 INFO - 'SHLVL': '1', 20:16:29 INFO - 'TERM': 'linux', 20:16:29 INFO - 'TMOUT': '86400', 20:16:29 INFO - 'USER': 'cltbld', 20:16:29 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268', 20:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:29 INFO - '_': '/tools/buildbot/bin/python'} 20:16:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 20:16:30 INFO - mozversion application_buildid: 20170924022042 20:16:30 INFO - mozversion application_changeset: ff40c5dcaa41261b39a4e9795e02a9d51dd30ced 20:16:30 INFO - mozversion application_display_name: Nightly 20:16:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:16:30 INFO - mozversion application_name: Firefox 20:16:30 INFO - mozversion application_remotingname: firefox 20:16:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:16:30 INFO - mozversion application_vendor: Mozilla 20:16:30 INFO - mozversion application_version: 58.0a1 20:16:30 INFO - mozversion platform_buildid: 20170924022042 20:16:30 INFO - mozversion platform_changeset: ff40c5dcaa41261b39a4e9795e02a9d51dd30ced 20:16:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:16:30 INFO - mozversion platform_version: 58.0a1 20:16:30 INFO - using testdate: 1506222990 20:16:30 INFO - actual date: 1506222990 20:16:30 INFO - starting webserver on 'localhost:36625' 20:16:30 INFO - SUITE-START | Running 2 tests 20:16:30 INFO - TEST-START | dromaeo_css 20:16:30 INFO - Initialising browser for dromaeo_css test... 20:16:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36625/getInfo.html -profile /tmp/tmp7wNAJG/profile 20:16:30 INFO - TEST-INFO | started process 3540 (/builds/slave/test/build/application/firefox/firefox http://localhost:36625/getInfo.html) 20:16:37 INFO - TEST-INFO | 3540: exit 0 20:16:37 INFO - Browser initialized. 20:16:37 INFO - Running cycle 1/1 for dromaeo_css test... 20:16:37 INFO - Using env: {'DISPLAY': ':0', 20:16:37 INFO - 'HOME': '/home/cltbld', 20:16:37 INFO - 'JSGC_DISABLE_POISONING': '1', 20:16:37 INFO - 'LANG': 'en_US.UTF-8', 20:16:37 INFO - 'LANGUAGE': 'en_US:en', 20:16:37 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 20:16:37 INFO - 'LOGNAME': 'cltbld', 20:16:37 INFO - 'MAIL': '/var/mail/cltbld', 20:16:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:16:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:16:37 INFO - 'MOZ_CRASHREPORTER': '1', 20:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:37 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 20:16:37 INFO - 'MOZ_NO_REMOTE': '1', 20:16:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:37 INFO - 'NO_EM_RESTART': '1', 20:16:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:37 INFO - 'PWD': '/builds/slave/test', 20:16:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:16:37 INFO - 'RUST_BACKTRACE': 'full', 20:16:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 20:16:37 INFO - 'SHELL': '/bin/bash', 20:16:37 INFO - 'SHLVL': '1', 20:16:37 INFO - 'STYLO_FORCE_DISABLED': '1', 20:16:37 INFO - 'TERM': 'linux', 20:16:37 INFO - 'TMOUT': '86400', 20:16:37 INFO - 'USER': 'cltbld', 20:16:37 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268', 20:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:37 INFO - '_': '/tools/buildbot/bin/python'} 20:16:37 INFO - TEST-INFO | started process 3776 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7wNAJG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:16:38 INFO - PID 3776 | 20:16:38 INFO - PID 3776 | (/builds/slave/test/build/application/firefox/firefox:3825): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:16:38 INFO - PID 3776 | 20:16:48 INFO - PID 3776 | RSS: Main: 151826432 20:16:48 INFO - PID 3776 | 20:19:45 INFO - PID 3776 | Cycle 1(1): loaded http://localhost:36625/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36625/tests/dromaeo/cssquery-ext.html) 20:19:47 INFO - PID 3776 | RSS: Main: 153387008 20:19:47 INFO - PID 3776 | 20:22:48 INFO - PID 3776 | Cycle 1(1): loaded http://localhost:36625/tests/dromaeo/cssquery-ext.html (next: http://localhost:36625/tests/dromaeo/cssquery-jquery.html) 20:22:49 INFO - PID 3776 | RSS: Main: 151347200 20:22:49 INFO - PID 3776 | 20:25:51 INFO - PID 3776 | Cycle 1(1): loaded http://localhost:36625/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36625/tests/dromaeo/cssquery-mootools.html) 20:25:51 INFO - PID 3776 | RSS: Main: 154484736 20:25:51 INFO - PID 3776 | 20:28:53 INFO - PID 3776 | Cycle 1(1): loaded http://localhost:36625/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36625/tests/dromaeo/cssquery-prototype.html) 20:28:54 INFO - PID 3776 | RSS: Main: 153722880 20:28:54 INFO - PID 3776 | 20:31:57 INFO - PID 3776 | Cycle 1(1): loaded http://localhost:36625/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36625/tests/dromaeo/cssquery-yui.html) 20:31:58 INFO - PID 3776 | RSS: Main: 154284032 20:31:58 INFO - PID 3776 | 20:34:59 INFO - PID 3776 | Cycle 1(1): loaded http://localhost:36625/tests/dromaeo/cssquery-yui.html (next: http://localhost:36625/tests/dromaeo/cssquery-dojo.html) 20:35:00 INFO - PID 3776 | RSS: Main: 157175808 20:35:00 INFO - PID 3776 | 20:35:00 INFO - PID 3776 | __start_tp_report 20:35:00 INFO - PID 3776 | _x_x_mozilla_page_load 20:35:00 INFO - PID 3776 | _x_x_mozilla_page_load_details 20:35:00 INFO - PID 3776 | |i|pagename|runs| 20:35:00 INFO - PID 3776 | |0;dojo.html;3116.6260048794143;3149.1025057858515;3156.9526457103148;3166.9049928502145;3185.076327864919;6148.569600127993;6260.718267677954;6332.746690132389;6333.588316759413;6412.358764123591;6174.166487524194;6219.440250377465;6355.046742988554;6406.263279722833;6422.421982021617;5712;5841.766329346831;5894.263217097863;5924.437178468039;5947.464728174464;5751.281089863767;5853.209816674737;5930.051191809312;5940.435658612447;5943.613665111754;5646.548276137899;5742.6841523716175;5781.566382521307;5817.127430885359;5865.530757539386;5785.479306862402;5814.3313518945015;5823.650580965155;5846.7368968396095;5848.210491583624;5722.62802917809;5768.192453056576;5788.942110578882;5790.986577348947;5830.271216097988;6143.170671959273;6278.152449419361;6291.496680265568;6331.620102793847;6363.490920726377;6634.966825165891;6647.700853461557;6675.6662166891465;6677.198736151693;6695.096162018114;6731.798046058626;6747.696353664097;6747.865042699119;6823.249442561314;6974.0236366908675;6293.150424692653;6306.180196574462;6309.495240380758;6366.554341196118;6376.840578985516;6883.208431030395;6907.516473846783;6977.1278590176225;6982.650867456607;7005.159380874327;6515.543911926215;6600.933990660032;6655.5341126121675;6691;6760.087388202628;6781.355771201728;6810.523263371616;6843.8973415398805;6860.485463590251;6904.689288982008;6693.598384096969;6722.428593569503;6792.490563207681;6802.285759995229;6850.794476165723;6568.901466478007;6813.420859226922;6835.521513494008;6890.931090689029;6905.343992320822;5222.97388513055;5263.5525980292105;5276.15581506957;5278.076336641073;5372.5433338166695;4617.699849509771;4633.559811817872;4655.953440465552;4694.976525117421;4696.412948381452;5766.452187042224;5776.220210271644;5779.739911703899;5826.941730582725;5872.559558033165;6603.174603174603;6771.762988295386;6807.591544507345;6840.863182736317;6892.931070689329;5732.627379220337;5737.540996720252;5766.250387449605;5773.8267851963665;5807.767689292466;5845.210896528999;5885.941140588625;5889.146073819358;5892.734826932799;5893.381194974551;6561.048647946021;6574.539782215199;6650.567713098633;6664.833379165462;6679.131712877295;6825.35159159879;6831.11195544576;6846.246912839683;6910.274421185703;6941.895871561931;6404;6512.739490420519;6569.85027620155;6668.199816022108;6679.0649309097735;6691.866162676622;6755.560888542229;6769.796906092825;6777.695003724943;6801.829954251183;6884.621345826027;6943.444524437932;6944.826379340557;6954.026436299024;6959.338862808025;6588.110605068446;6595.043718660671;6599.208095028627;6694.899576506259;6699.564528305645;6404.583702059351;6520.902186467112;6533.18335208099;6533.379328963741;6533.901991470037;6515.250746164252;6518.902216466662;6606.47148228131;6609;6614.437772789367;6711.563748356341;6752.797416077526;6757.155355580552;6795.116634837439;6797.354251346114;6438.484921206386;6439.259485159267;6457.257415397289;6543.672816359068;6545.607263564201 20:35:00 INFO - PID 3776 | |1;ext.html;845.9915400845991;866.9219770220678;872.8647059705744;875.8905136857893;877.5919197573127;39268.607313926856;42860.785696071514;43029.7848510757;43056.3541546877;43147.137057258835;37966.8101659492;38150.42774358387;38255.808720956426;38346;38547.42178867312;7256.600886951229;7356.448266380016;7384.852302953937;7962.1639727828615;8196.959015204915;8001.919980800176;8107.837843243161;8108.635111419971;8112.22933821286;8115.675372985073;8108.06757222921;8123.268905798477;8174.223448772357;8177.713780017701;8209.917900821005;8047.718329858485;8062.596870156469;8080.595970201525;8101.432899696994;8105.230003149692;8017.078036025873;8043.718469853586;8073;8074.677012919535;8094.392920530984;38072.42891356632;38175.618243817764;38588;38681;38764.41853372202;3496.3531746626954;3530.682238598513;3543.5039094526787;3544.6987006104514;3553.9644603553893;32245.35509289801;32272.838635806904;32283.838580806947;32379.6762032379;32461.350772984646;5144.305518754995;5186.429492755794;5206.739663016834;5219;5256.395514515842;180622;181741;181787.9999999987;182506;183059.99999999866;41945;42853;47894.5210547897;48543.757281213366;48748;51676.74161629168;52484;52861.2070818938;52878.73560632172;52922.470775292524;15415.691686166214;15704.29330680122;15717.21413929299;15721.528354149394;15724.842751572567;12730.872691272969;12757.681057973625;12794.168379055332;12804.871951280367;12806.295653739135;14129.152250864776;14163.78754318686;14177.362018709182;14223.502177423741;14237.71860532557;5817.894600025981;5945.227120474397;5958.433948774859;6049.274087109575;6068.150458935753;1001.9749506262402;1025.103034844511;1035.5081336365317;1041.6979076067855;1043.5617040842865;22855.542889142125;22909.623000514224;22913.770862291498;22985;23164.768352316598;1102.2449622008949;1121.900960136183;1125.1280257800106;1131.5813149134872;1150.344303746873;12047.698807529881;12141.635750927486;12181.817272740738;12211.444619276204;12286.324252166038;224037;224307;225924;226040;226292;52600.73699631477;52609.210861837106;52822.73588632109;52839.73580132152;53040;1458.1105525629357;1463.897527173109;1482.4218554763652;1493.1787516865681;1494.775783632442;22348.553028939656;22725;22750.544989099795;22813.885930570905;23141.958611862843;29589.704102959557;29595.556066658588;29605;29618.111456656334;29665.555016674334;193043;193571;193669;194801;195370;29651.85174074116;30150.698493015665;33196.83401583073;33580.664193357756;34033;41740.791296043324;42825.78587107169;42998.35502467528;43087.491937782026;43579;31922.20194495156;32006.839965800023;32201.35597287994;32384.35231295408;32524.512132317563;30819;30998;31140.844295779283;31173.285469299408;32252.516212256367;33842;34728;34998.47502287417;35133;35237.64762352344;30443.2389190272;30610.234744131576;30903.381932361677;30923.381532369676;30947.845260773553;22846.42883927915;23013.424664383525;23314.883425582764;23551.646725299477;23570.292891213292 20:35:00 INFO - PID 3776 | |2;jquery.html;578.1674388880012;578.7308901360869;582.170407169783;585.8271809816105;601.2994860986951;21783.564328713415;22360.88819555902;22361.776382236174;22362.552748945032;22410.43973900653;22893.656595151046;23897.641535376984;24074;24291.514169716596;24334.26997190087;6497.805065848021;6550.606963582177;6599.175103112111;6608.801735947929;6631.668416579176;6516.283208847023;6612.834679133012;6619.437347825441;6621.867562648744;6848.452123830081;7096;7123.536970096953;7127;7132.144142702883;7139.1433028036445;7055.89416158758;7113.679884405188;7142.285771422842;7150.463715221379;7151.678174482109;6563.212414510289;6833.863322733518;6919.4464442844455;6924.549904256207;7016.789496315118;30292;30783.846080769454;30805.537916931265;30863.382732345228;30927.226819329473;2104.147820132833;2123.8938053097436;2132.2856842957626;2142.7535833379047;2146.5170336674278;20425.4893627659;20930.5813883723;21069.262575809928;21148.154073837028;21306.46733831651;2506.987465062681;2509.9372515687073;2545.6308835218974;2569.0751329521545;2569.665943427361;125538;128814;131469;131694;134994.999999999;19822.20711171537;20366.389008329774;20540.897295513427;21570.78429215719;21753.564928701337;41682.79158604187;41684.166316673494;41697.37453938193;41716.95707607334;41730.1653966925;11491.712707182387;11556.364399958084;11568.76862462746;11660.416979151178;11667.416629168678;9632.90367096334;9639.277054220822;9666.130048295687;9724.562394692255;9763.658271960589;11090.500927458284;11152.721181970353;11273.970685276565;11339;11598.88401115995;3742.1954279829424;3773.584905660375;3832.310184166821;3988.960110398917;3997.200559888034;935.5462600638684;956.9186619137312;962.1965658674944;962.5476026267643;979.0454307050569;18458.446246612624;18560.721589176173;18655.440336789918;18753.343632973054;18853.434396968114;1015.7105225010985;1023.4831410137981;1023.5752162852482;1033.421284080917;1034.2450011491503;10196.490175491195;10240.180785537139;10251.48742562869;10323.896761032294;10566.207534434794;419871;423443;425286;426955;430400;104219.47890260651;104289.47855260676;108879;110190.44904775586;110438;1160.2342453980332;1206.3726862031695;1239.9132060755842;1271.650296168561;1279.0726723125845;19294.22823087061;19307.227710891406;19774.40676779699;19832.107555159764;20100.19599216015;57736;57855.421445786684;58981;60677.69661151666;61007;75114.62442687752;76417.61791191009;76436;77039.22960770545;77088.61455692686;14005.089669171472;14128.78806817919;14276.857231427968;14310;14418.062825916282;21854.45363865916;21862.125514979223;21869.562608748056;21990.89004555031;22052.88973555122;17198;17351.219195135996;17381.478555642843;17532.474025779247;17636.294548217928;15617.219139043229;16249.67500650004;16318.18409079565;16422.83577164213;16754;16260.756088658443;16708.83291167073;17049.659006820042;17573;17865.553361165556;14134.50529231472;14143.151410915378;14154.292285385483;14177.43290268419;14253.287335633384;16884.071376074433;17016.829831701525;17111.657766844346;17112.229949652046;17463.126843657512 20:35:00 INFO - PID 3776 | |3;mootools.html;1336.9465221391144;1376.7728324826405;1383.087162472767;1389.2150934721888;1392.8885689144863;14954.102753834764;15567.922160389182;15693.45072922448;15718.449854255088;15721.292541835617;15297.847021529782;15385;15438.382464701399;15451;15500.767488487681;2776.819506732061;2887.826730396183;2888.4078763853463;2890.9277268068363;2892.7975041747086;2755.077049188524;2870.225039239404;2871.928201794951;2872.1957851801426;2874.7700183985335;2642.748938850806;2910.3888183481495;2918.5622156676563;2920.722531359528;2924.38587896542;2841.2186648671573;2850.657921049477;2863.3986862758848;2876.0365277631913;2877.1080964900843;2812.9015484457946;2862.484752744526;2875.0368626509935;2877.568364745284;2879.280179955011;15077.24613769318;15261.38954441821;15315.923420382938;15407.922960385238;15428;8241.711540096068;8498.065212826585;8504.192101750386;8511.616977235977;8512.106228845943;5467.808626698046;5656.91514627281;5663.66018038919;5689.943100568983;5832.62087964281;1922.356010736405;1948.7758907725652;1958.0601311370622;1966.9409917702492;1985.592953444555;27358.452830943268;27519.862400688067;27542.586861196898;27570.5864412032;27593.862030689717;6808;6891.38202443711;7041.5775053496955;7080.779614922251;7098.467614928798;18296.817031829778;18323.633527329377;18340.633187336178;18361.265549378142;18375.54061148482;7971.561564113914;8454.36592255571;8788;8828.337874659426;8835.823283534293;7670.808229794188;7767.844643107106;7775.300222979959;7778.688852445952;7818.4136189785995;5294.391145018295;5405.378381486101;5417.024935511646;5448;5474.890502190014;1430.0061457287086;1441.243347242685;1564.108458178827;1584.081232884924;1602.6233835048988;716.924722904098;892.7634176943116;909.0818273543769;916.1067958740175;921.7833809054866;8341.916580834113;8548.615312310962;8602.741917742478;8603.31173506118;8737.432066915757;968.9757756056014;982.3123813330698;989.5398639632606;991.4794732765212;997.8154041502345;5264.42091369949;5457.181422786613;5517.36550296721;5627.296587926509;5740.0815869460685;22309.888450557966;22377.664335034988;23224.3032709019;23228.65157022646;23304.184353547545;22375.664365034536;23000.4249893754;23034.53930921372;23186.65220021701;23368;11913.761724765456;12069.155159138776;12096.395180240777;12257.26456412618;12258.938705306417;8356.122607126164;8510.106438824081;8522.872156917776;8535.146485351415;8575.356848236283;18788.530286742942;19108.904455477634;19296.13167407442;19325.4202373929;19676.90161549183;20098.698519521928;20366.28717994863;20408.38774836757;20488.078036488096;20787.168513259905;11161.832572511257;11378.54485820558;11403.657890263305;11427.942860285646;11439.942800286279;14633.707325853211;14778.926105369404;14816.851831481546;14821.333040013442;14968.625784355478;11090.944545277222;11180.385078820418;11215.327080375204;11481.942590286995;11587.130965177477;10797.136229101496;10879.673609791718;11039.944800275947;11310.4910279036;11415.543378264776;10375.584976601154;10429.895701042893;10433.21750868703;10577.153827693612;10578.576856925636;6783.457323414016;6858.897116543356;6956.513044086865;7050.330218629222;7083.043789088407;7043.190033146254;7083.858322833617;7089.0784198053925;7140.821479463055;7189.892151617625 20:35:00 INFO - PID 3776 | |4;prototype.html;508.5931254996002;521.8356217791394;536.0913252037795;542.967421954683;547.9698616576087;6193.938060619393;6262.154609127766;6262.3111457739615;6334.524910631698;6343.651099189543;6117;6224.564280500367;6253.812385628427;6280.340564240746;6293.842653933654;5174.637775355726;5185.144451165553;5198;5209.218617207421;5245.763940622662;4864.270359446076;5005.54950054495;5052.292679024939;5146.562542183919;5218.504242096995;4954.281629163787;4987.226979818134;4989.600831933455;4990.950090499103;4997.700137991732;4936.111499930011;4967.652264341497;4973.676711013809;4975.800967961295;5015.172496538067;4391.231534481453;4440.356148358503;4441.578050085237;4498.280275155959;4503.144402563536;5959.344472108065;6022.3676513966275;6102.206713127265;6134.202553667995;6197.814065577994;5667.914981275243;5669.319681638189;5678.176664383641;5722.771089156428;5733.856653583652;6532.869342613169;6547.3125321841;6567.737290508374;6574.830305999057;6593.736250549972;4740.312654665088;4909.337239472661;4917.114919314522;4917.188663870457;4928.1129396708575;6624.834379140512;6691.364320389555;6732.956391759285;6769.593824370603;6779.373035426122;5043.949560504348;5058.266551350033;5059.367579052619;5073.441921388644;5077.339945807022;5079;5112.514311140436;5155.278261043457;5165.61257905651;5184.507471790174;5680.6200310815;5685.943140568624;5737.655740655574;5738.540916726652;5757.769689212385;6573.244076931119;6636.435902948207;6646.734130634817;6657.700403481855;6691.397774200345;1757.323430479249;1779.9377021804175;1780.1455301455374;1787.5441762350777;1793.1482545790645;1170.7658468306372;1217.5190799634095;1228.9016878649686;1238.975220495585;1244.7012716948047;5611.074172761449;5638.887222255532;5684.801031963944;5699.316082070178;5706.42935706426;6621.437177839841;6665.7666981656375;6678.7328506859185;6700.731970721214;6719.697613607399;5480.342358916876;5574.526165275997;5592.245046918695;5692.715364231772;5725.541956643458;3440.2259491614686;3538.398472259722;3557.4485954677066;3567.161716996504;3568.286342731464;6362.395572420613;6406.391392817675;6424.807255782334;6446;6487.967560162263;6724.335237295588;6732.730690772314;6802.285759995229;6804.727810887608;6857.622830744357;6365.777197798055;6404.49494368823;6453.935460645427;6469.417752402306;6489.448396886318;6556.246031706415;6617.834554136185;6628.270890201978;6635.535512514078;6745.460363171032;6519.217693876765;6565.606063636197;6576.8355791103695;6578.375054369827;6624.801255962136;6376.649284289409;6437.5171862111465;6443;6444.548881578245;6518.902216466662;4986.9251961221335;4996.225585034325;5042.168042272984;5043.394792624908;5059.418166910852;6430.292667806444;6466;6563.0811686362995;6687.431568316748;6805.897911531232;6232.376762323732;6300;6451.258105317761;6468.482521398183;6484.610923344614;6390.392912673288;6409.839754006187;6480.675966201766;6511.153550038464;6525.3800888915475;6337.4613157882095;6341.302456729663;6400.679966001589;6404.135441715309;6414.03789431589;6330.3669633036325;6350.491960643045;6454.709538070892;6551.181102362205;6555.737770489127;6267;6311.495080393465;6318.684065796784;6319.178506794087;6337.96831015842 20:35:00 INFO - PID 3776 | |5;yui.html;892.799120197956;913.3058875254806;925.1581061234278;937.2127412973101;944.3672739264692;17994.91002544987;18521;18610.069496525153;18643.067846607682;18656.533586660324;17869;18098.909505452455;18395.44813655589;18930;18945.14746836392;953.6233187890779;972.6060945317158;985.4235272365675;986.896375880533;987.5753426026805;987.284218941269;993.0218734546465;993.3295025857553;995.1839491616877;997.2221667099637;1024.08856118055;1059.6926891201542;1067.1249575348218;1067.9038886500214;1070.1920050362005;1063.261033581661;1063.8723353197588;1065.3554599467288;1067.4449286371043;1068.1401471815186;731.7621772923768;749.62144117221;756.2853103816896;756.7389250708496;757.0952711509748;17626.64746705059;17664.20511076992;17682.557936051573;17692.469225923243;17718.114094295364;21753.34739957788;21821.23625673094;21956.670649940264;22171.556568868695;22221;17423.912880435644;17768.822311776847;17786;17931.372401966;17964.922104673762;3623.5108260385036;3627.963720362789;3646.726495512847;3655.4334078217653;3660.5973342932257;139588;141302.29348853292;142149.99999999895;142284;142852;16409.6718065638;16568.254428550743;16803.495895123167;16854.241559129867;16915.915420422818;30549.694503054685;30560.235994100327;31114.222144446117;31902;32049.51925721116;8906.109389061043;8947.821043579092;8949.731508054769;8963.596638151299;8977.46135231875;4027.3958906163725;4049.250888585621;4157.667386609064;4179.393987871802;4234.216669916013;5557.44425557441;5693.259876216065;5693.971530142323;5711.8000869969355;5723.484886360165;978.9902100979042;997.7356000659686;1013.0983424751977;1015.4922538730634;1031.3141760729181;658.8484648530865;676.922153952292;692.975745848903;694.9617771022643;695.6591270277629;11536.192466527431;11702.648920532398;11802.645920622395;12553.246805191719;12787.680307992374;659.745997790854;659.9869200776784;660.930602286753;671.1174805131237;676.4081428749844;5582.748776304995;5669.177969194444;5749.597528173072;5820.534357251409;5846.678432686158;117639;118620;125369;125412;126024;106618;106642.46678766556;106929.46535267273;107348;107904.46047769868;91775.99999999866;92052.53973730089;92217.53891230501;92443.53778231065;95723.52138239265;10414.271001029856;10449.164066874784;10475.481055247099;10498;10560.471976400995;44290;44470;45193.54806452025;45764;45966.310505341775;56017.43982560122;56126.719366402904;57299.14051289317;57730;58665.12002319883;15019.77470337924;15246.695066098395;15329.693406131591;15385.38458461649;15392.230388480755;16189.514314570582;16493.752593711342;16634.833651663812;17034.574135646708;17044.14779261007;15987.200639967723;16058;16069.598260043593;16208.837911620732;16242.918785405996;15147.848521514643;15307.234638267819;15453.613659658598;15568.455104071303;15593.92203039023;14914.77627835605;15228.77156842626;15235.238238088274;15350.23248837576;15369;12107.213031152947;12191.573294934635;12547.49810007626;12594.118411711459;12605;11239.60661376848;11508.194426390073;11522.308661480338;11764.882351176379;11791.88208117908 20:35:00 INFO - PID 3776 | __end_tp_report 20:35:00 INFO - PID 3776 | __start_cc_report 20:35:00 INFO - PID 3776 | _x_x_mozilla_cycle_collect,311 20:35:00 INFO - PID 3776 | __end_cc_report 20:35:00 INFO - PID 3776 | __startTimestamp1506224100048__endTimestamp 20:35:00 INFO - PID 3776 | 20:35:00 INFO - PID 3776 | ------- Summary: start ------- 20:35:00 INFO - PID 3776 | Number of tests: 6 20:35:00 INFO - PID 3776 | 20:35:00 INFO - PID 3776 | [#0] dojo.html Cycles:165 Average:6238.81 Median:6515.54 stddev:761.12 (11.7%) stddev-sans-first:722.98 20:35:00 INFO - PID 3776 | Values: 3116.6 3149.1 3157.0 3166.9 3185.1 6148.6 6260.7 6332.7 6333.6 6412.4 6174.2 6219.4 6355.0 6406.3 6422.4 5712.0 5841.8 5894.3 5924.4 5947.5 5751.3 5853.2 5930.1 5940.4 5943.6 5646.5 5742.7 5781.6 5817.1 5865.5 5785.5 5814.3 5823.7 5846.7 5848.2 5722.6 5768.2 5788.9 5791.0 5830.3 6143.2 6278.2 6291.5 6331.6 6363.5 6635.0 6647.7 6675.7 6677.2 6695.1 6731.8 6747.7 6747.9 6823.2 6974.0 6293.2 6306.2 6309.5 6366.6 6376.8 6883.2 6907.5 6977.1 6982.7 7005.2 6515.5 6600.9 6655.5 6691.0 6760.1 6781.4 6810.5 6843.9 6860.5 6904.7 6693.6 6722.4 6792.5 6802.3 6850.8 6568.9 6813.4 6835.5 6890.9 6905.3 5223.0 5263.6 5276.2 5278.1 5372.5 4617.7 4633.6 4656.0 4695.0 4696.4 5766.5 5776.2 5779.7 5826.9 5872.6 6603.2 6771.8 6807.6 6840.9 6892.9 5732.6 5737.5 5766.3 5773.8 5807.8 5845.2 5885.9 5889.1 5892.7 5893.4 6561.0 6574.5 6650.6 6664.8 6679.1 6825.4 6831.1 6846.2 6910.3 6941.9 6404.0 6512.7 6569.9 6668.2 6679.1 6691.9 6755.6 6769.8 6777.7 6801.8 6884.6 6943.4 6944.8 6954.0 6959.3 6588.1 6595.0 6599.2 6694.9 6699.6 6404.6 6520.9 6533.2 6533.4 6533.9 6515.3 6518.9 6606.5 6609.0 6614.4 6711.6 6752.8 6757.2 6795.1 6797.4 6438.5 6439.3 6457.3 6543.7 6545.6 20:35:00 INFO - PID 3776 | 20:35:00 INFO - PID 3776 | [#1] ext.html Cycles:180 Average:36684.25 Median:32492.93 stddev:52110.98 (160.4%) stddev-sans-first:52187.69 20:35:00 INFO - PID 3776 | Values: 846.0 866.9 872.9 875.9 877.6 39268.6 42860.8 43029.8 43056.4 43147.1 37966.8 38150.4 38255.8 38346.0 38547.4 7256.6 7356.4 7384.9 7962.2 8197.0 8001.9 8107.8 8108.6 8112.2 8115.7 8108.1 8123.3 8174.2 8177.7 8209.9 8047.7 8062.6 8080.6 8101.4 8105.2 8017.1 8043.7 8073.0 8074.7 8094.4 38072.4 38175.6 38588.0 38681.0 38764.4 3496.4 3530.7 3543.5 3544.7 3554.0 32245.4 32272.8 32283.8 32379.7 32461.4 5144.3 5186.4 5206.7 5219.0 5256.4 180622.0 181741.0 181788.0 182506.0 183060.0 41945.0 42853.0 47894.5 48543.8 48748.0 51676.7 52484.0 52861.2 52878.7 52922.5 15415.7 15704.3 15717.2 15721.5 15724.8 12730.9 12757.7 12794.2 12804.9 12806.3 14129.2 14163.8 14177.4 14223.5 14237.7 5817.9 5945.2 5958.4 6049.3 6068.2 1002.0 1025.1 1035.5 1041.7 1043.6 22855.5 22909.6 22913.8 22985.0 23164.8 1102.2 1121.9 1125.1 1131.6 1150.3 12047.7 12141.6 12181.8 12211.4 12286.3 224037.0 224307.0 225924.0 226040.0 226292.0 52600.7 52609.2 52822.7 52839.7 53040.0 1458.1 1463.9 1482.4 1493.2 1494.8 22348.6 22725.0 22750.5 22813.9 23142.0 29589.7 29595.6 29605.0 29618.1 29665.6 193043.0 193571.0 193669.0 194801.0 195370.0 29651.9 30150.7 33196.8 33580.7 34033.0 41740.8 42825.8 42998.4 43087.5 43579.0 31922.2 32006.8 32201.4 32384.4 32524.5 30819.0 30998.0 31140.8 31173.3 32252.5 33842.0 34728.0 34998.5 35133.0 35237.6 30443.2 30610.2 30903.4 30923.4 30947.8 22846.4 23013.4 23314.9 23551.6 23570.3 20:35:00 INFO - PID 3776 | 20:35:00 INFO - PID 3776 | [#2] jquery.html Cycles:180 Average:33484.15 Median:21819.01 stddev:72184.90 (330.8%) stddev-sans-first:72345.12 20:35:00 INFO - PID 3776 | Values: 578.2 578.7 582.2 585.8 601.3 21783.6 22360.9 22361.8 22362.6 22410.4 22893.7 23897.6 24074.0 24291.5 24334.3 6497.8 6550.6 6599.2 6608.8 6631.7 6516.3 6612.8 6619.4 6621.9 6848.5 7096.0 7123.5 7127.0 7132.1 7139.1 7055.9 7113.7 7142.3 7150.5 7151.7 6563.2 6833.9 6919.4 6924.5 7016.8 30292.0 30783.8 30805.5 30863.4 30927.2 2104.1 2123.9 2132.3 2142.8 2146.5 20425.5 20930.6 21069.3 21148.2 21306.5 2507.0 2509.9 2545.6 2569.1 2569.7 125538.0 128814.0 131469.0 131694.0 134995.0 19822.2 20366.4 20540.9 21570.8 21753.6 41682.8 41684.2 41697.4 41717.0 41730.2 11491.7 11556.4 11568.8 11660.4 11667.4 9632.9 9639.3 9666.1 9724.6 9763.7 11090.5 11152.7 11274.0 11339.0 11598.9 3742.2 3773.6 3832.3 3989.0 3997.2 935.5 956.9 962.2 962.5 979.0 18458.4 18560.7 18655.4 18753.3 18853.4 1015.7 1023.5 1023.6 1033.4 1034.2 10196.5 10240.2 10251.5 10323.9 10566.2 419871.0 423443.0 425286.0 426955.0 430400.0 104219.5 104289.5 108879.0 110190.4 110438.0 1160.2 1206.4 1239.9 1271.7 1279.1 19294.2 19307.2 19774.4 19832.1 20100.2 57736.0 57855.4 58981.0 60677.7 61007.0 75114.6 76417.6 76436.0 77039.2 77088.6 14005.1 14128.8 14276.9 14310.0 14418.1 21854.5 21862.1 21869.6 21990.9 22052.9 17198.0 17351.2 17381.5 17532.5 17636.3 15617.2 16249.7 16318.2 16422.8 16754.0 16260.8 16708.8 17049.7 17573.0 17865.6 14134.5 14143.2 14154.3 14177.4 14253.3 16884.1 17016.8 17111.7 17112.2 17463.1 20:35:00 INFO - PID 3776 | 20:35:00 INFO - PID 3776 | [#3] mootools.html Cycles:180 Average:9703.37 Median:27582.22 stddev:7000.85 (25.4%) stddev-sans-first:6992.27 20:35:00 INFO - PID 3776 | Values: 1336.9 1376.8 1383.1 1389.2 1392.9 14954.1 15567.9 15693.5 15718.4 15721.3 15297.8 15385.0 15438.4 15451.0 15500.8 2776.8 2887.8 2888.4 2890.9 2892.8 2755.1 2870.2 2871.9 2872.2 2874.8 2642.7 2910.4 2918.6 2920.7 2924.4 2841.2 2850.7 2863.4 2876.0 2877.1 2812.9 2862.5 2875.0 2877.6 2879.3 15077.2 15261.4 15315.9 15407.9 15428.0 8241.7 8498.1 8504.2 8511.6 8512.1 5467.8 5656.9 5663.7 5689.9 5832.6 1922.4 1948.8 1958.1 1966.9 1985.6 27358.5 27519.9 27542.6 27570.6 27593.9 6808.0 6891.4 7041.6 7080.8 7098.5 18296.8 18323.6 18340.6 18361.3 18375.5 7971.6 8454.4 8788.0 8828.3 8835.8 7670.8 7767.8 7775.3 7778.7 7818.4 5294.4 5405.4 5417.0 5448.0 5474.9 1430.0 1441.2 1564.1 1584.1 1602.6 716.9 892.8 909.1 916.1 921.8 8341.9 8548.6 8602.7 8603.3 8737.4 969.0 982.3 989.5 991.5 997.8 5264.4 5457.2 5517.4 5627.3 5740.1 22309.9 22377.7 23224.3 23228.7 23304.2 22375.7 23000.4 23034.5 23186.7 23368.0 11913.8 12069.2 12096.4 12257.3 12258.9 8356.1 8510.1 8522.9 8535.1 8575.4 18788.5 19108.9 19296.1 19325.4 19676.9 20098.7 20366.3 20408.4 20488.1 20787.2 11161.8 11378.5 11403.7 11427.9 11439.9 14633.7 14778.9 14816.9 14821.3 14968.6 11090.9 11180.4 11215.3 11481.9 11587.1 10797.1 10879.7 11039.9 11310.5 11415.5 10375.6 10429.9 10433.2 10577.2 10578.6 6783.5 6858.9 6956.5 7050.3 7083.0 7043.2 7083.9 7089.1 7140.8 7189.9 20:35:00 INFO - PID 3776 | 20:35:00 INFO - PID 3776 | [#4] prototype.html Cycles:180 Average:5489.50 Median:6195.88 stddev:1518.43 (24.5%) stddev-sans-first:1475.95 20:35:00 INFO - PID 3776 | Values: 508.6 521.8 536.1 543.0 548.0 6193.9 6262.2 6262.3 6334.5 6343.7 6117.0 6224.6 6253.8 6280.3 6293.8 5174.6 5185.1 5198.0 5209.2 5245.8 4864.3 5005.5 5052.3 5146.6 5218.5 4954.3 4987.2 4989.6 4991.0 4997.7 4936.1 4967.7 4973.7 4975.8 5015.2 4391.2 4440.4 4441.6 4498.3 4503.1 5959.3 6022.4 6102.2 6134.2 6197.8 5667.9 5669.3 5678.2 5722.8 5733.9 6532.9 6547.3 6567.7 6574.8 6593.7 4740.3 4909.3 4917.1 4917.2 4928.1 6624.8 6691.4 6733.0 6769.6 6779.4 5043.9 5058.3 5059.4 5073.4 5077.3 5079.0 5112.5 5155.3 5165.6 5184.5 5680.6 5685.9 5737.7 5738.5 5757.8 6573.2 6636.4 6646.7 6657.7 6691.4 1757.3 1779.9 1780.1 1787.5 1793.1 1170.8 1217.5 1228.9 1239.0 1244.7 5611.1 5638.9 5684.8 5699.3 5706.4 6621.4 6665.8 6678.7 6700.7 6719.7 5480.3 5574.5 5592.2 5692.7 5725.5 3440.2 3538.4 3557.4 3567.2 3568.3 6362.4 6406.4 6424.8 6446.0 6488.0 6724.3 6732.7 6802.3 6804.7 6857.6 6365.8 6404.5 6453.9 6469.4 6489.4 6556.2 6617.8 6628.3 6635.5 6745.5 6519.2 6565.6 6576.8 6578.4 6624.8 6376.6 6437.5 6443.0 6444.5 6518.9 4986.9 4996.2 5042.2 5043.4 5059.4 6430.3 6466.0 6563.1 6687.4 6805.9 6232.4 6300.0 6451.3 6468.5 6484.6 6390.4 6409.8 6480.7 6511.2 6525.4 6337.5 6341.3 6400.7 6404.1 6414.0 6330.4 6350.5 6454.7 6551.2 6555.7 6267.0 6311.5 6318.7 6319.2 6338.0 20:35:00 INFO - PID 3776 | 20:35:00 INFO - PID 3776 | [#5] yui.html Cycles:180 Average:24174.58 Median:18247.18 stddev:35250.21 (193.2%) stddev-sans-first:35305.75 20:35:00 INFO - PID 3776 | Values: 892.8 913.3 925.2 937.2 944.4 17994.9 18521.0 18610.1 18643.1 18656.5 17869.0 18098.9 18395.4 18930.0 18945.1 953.6 972.6 985.4 986.9 987.6 987.3 993.0 993.3 995.2 997.2 1024.1 1059.7 1067.1 1067.9 1070.2 1063.3 1063.9 1065.4 1067.4 1068.1 731.8 749.6 756.3 756.7 757.1 17626.6 17664.2 17682.6 17692.5 17718.1 21753.3 21821.2 21956.7 22171.6 22221.0 17423.9 17768.8 17786.0 17931.4 17964.9 3623.5 3628.0 3646.7 3655.4 3660.6 139588.0 141302.3 142150.0 142284.0 142852.0 16409.7 16568.3 16803.5 16854.2 16915.9 30549.7 30560.2 31114.2 31902.0 32049.5 8906.1 8947.8 8949.7 8963.6 8977.5 4027.4 4049.3 4157.7 4179.4 4234.2 5557.4 5693.3 5694.0 5711.8 5723.5 979.0 997.7 1013.1 1015.5 1031.3 658.8 676.9 693.0 695.0 695.7 11536.2 11702.6 11802.6 12553.2 12787.7 659.7 660.0 660.9 671.1 676.4 5582.7 5669.2 5749.6 5820.5 5846.7 117639.0 118620.0 125369.0 125412.0 126024.0 106618.0 106642.5 106929.5 107348.0 107904.5 91776.0 92052.5 92217.5 92443.5 95723.5 10414.3 10449.2 10475.5 10498.0 10560.5 44290.0 44470.0 45193.5 45764.0 45966.3 56017.4 56126.7 57299.1 57730.0 58665.1 15019.8 15246.7 15329.7 15385.4 15392.2 16189.5 16493.8 16634.8 17034.6 17044.1 15987.2 16058.0 16069.6 16208.8 16242.9 15147.8 15307.2 15453.6 15568.5 15593.9 14914.8 15228.8 15235.2 15350.2 15369.0 12107.2 12191.6 12547.5 12594.1 12605.0 11239.6 11508.2 11522.3 11764.9 11791.9 20:35:00 INFO - PID 3776 | -------- Summary: end -------- 20:35:00 INFO - PID 3776 | 20:35:00 INFO - TEST-INFO | 3776: exit 0 20:35:00 INFO - TEST-OK | dromaeo_css | took 1110565ms 20:35:00 INFO - TEST-START | kraken 20:35:00 INFO - Initialising browser for kraken test... 20:35:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36625/getInfo.html -profile /tmp/tmp9yQ_sB/profile 20:35:00 INFO - TEST-INFO | started process 4143 (/builds/slave/test/build/application/firefox/firefox http://localhost:36625/getInfo.html) 20:35:06 INFO - TEST-INFO | 4143: exit 0 20:35:06 INFO - Browser initialized. 20:35:06 INFO - Running cycle 1/1 for kraken test... 20:35:06 INFO - Using env: {'DISPLAY': ':0', 20:35:06 INFO - 'HOME': '/home/cltbld', 20:35:06 INFO - 'JSGC_DISABLE_POISONING': '1', 20:35:06 INFO - 'LANG': 'en_US.UTF-8', 20:35:06 INFO - 'LANGUAGE': 'en_US:en', 20:35:06 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 20:35:06 INFO - 'LOGNAME': 'cltbld', 20:35:06 INFO - 'MAIL': '/var/mail/cltbld', 20:35:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:35:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:35:06 INFO - 'MOZ_CRASHREPORTER': '1', 20:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:06 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 20:35:06 INFO - 'MOZ_NO_REMOTE': '1', 20:35:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:35:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:06 INFO - 'NO_EM_RESTART': '1', 20:35:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:06 INFO - 'PWD': '/builds/slave/test', 20:35:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:35:06 INFO - 'RUST_BACKTRACE': 'full', 20:35:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 20:35:06 INFO - 'SHELL': '/bin/bash', 20:35:06 INFO - 'SHLVL': '1', 20:35:06 INFO - 'STYLO_FORCE_DISABLED': '1', 20:35:06 INFO - 'TERM': 'linux', 20:35:06 INFO - 'TMOUT': '86400', 20:35:06 INFO - 'USER': 'cltbld', 20:35:06 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268', 20:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:06 INFO - '_': '/tools/buildbot/bin/python'} 20:35:06 INFO - TEST-INFO | started process 4380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9yQ_sB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:35:07 INFO - PID 4380 | 20:35:07 INFO - PID 4380 | (/builds/slave/test/build/application/firefox/firefox:4430): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:35:07 INFO - PID 4380 | 20:35:17 INFO - PID 4380 | RSS: Main: 151457792 20:35:17 INFO - PID 4380 | 20:35:20 INFO - PID 4380 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36625/tests/kraken/driver.html?testName=audio-beat-detection) 20:35:21 INFO - PID 4380 | RSS: Main: 156397568 20:35:21 INFO - PID 4380 | 20:35:23 INFO - PID 4380 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36625/tests/kraken/driver.html?testName=audio-dft) 20:35:24 INFO - PID 4380 | RSS: Main: 157974528 20:35:24 INFO - PID 4380 | 20:35:27 INFO - PID 4380 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36625/tests/kraken/driver.html?testName=audio-fft) 20:35:28 INFO - PID 4380 | RSS: Main: 154497024 20:35:28 INFO - PID 4380 | 20:35:30 INFO - PID 4380 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36625/tests/kraken/driver.html?testName=audio-oscillator) 20:35:30 INFO - PID 4380 | RSS: Main: 155160576 20:35:30 INFO - PID 4380 | 20:35:32 INFO - PID 4380 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36625/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:35:33 INFO - PID 4380 | RSS: Main: 154914816 20:35:33 INFO - PID 4380 | 20:35:36 INFO - PID 4380 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36625/tests/kraken/driver.html?testName=imaging-darkroom) 20:35:37 INFO - PID 4380 | RSS: Main: 157585408 20:35:37 INFO - PID 4380 | 20:35:40 INFO - PID 4380 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36625/tests/kraken/driver.html?testName=imaging-desaturate) 20:35:41 INFO - PID 4380 | RSS: Main: 157941760 20:35:41 INFO - PID 4380 | 20:35:44 INFO - PID 4380 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36625/tests/kraken/driver.html?testName=json-parse-financial) 20:35:45 INFO - PID 4380 | RSS: Main: 157732864 20:35:45 INFO - PID 4380 | 20:35:46 INFO - PID 4380 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36625/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:35:47 INFO - PID 4380 | RSS: Main: 157757440 20:35:47 INFO - PID 4380 | 20:35:49 INFO - PID 4380 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36625/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:35:49 INFO - PID 4380 | RSS: Main: 157880320 20:35:49 INFO - PID 4380 | 20:35:51 INFO - PID 4380 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36625/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:35:52 INFO - PID 4380 | RSS: Main: 154615808 20:35:52 INFO - PID 4380 | 20:35:55 INFO - PID 4380 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:35:55 INFO - PID 4380 | RSS: Main: 155369472 20:35:55 INFO - PID 4380 | 20:35:58 INFO - PID 4380 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:35:59 INFO - PID 4380 | RSS: Main: 155185152 20:35:59 INFO - PID 4380 | 20:36:00 INFO - PID 4380 | Cycle 1(1): loaded http://localhost:36625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36625/tests/kraken/driver.html?testName=ai-astar) 20:36:01 INFO - PID 4380 | RSS: Main: 156225536 20:36:01 INFO - PID 4380 | 20:36:01 INFO - PID 4380 | __start_tp_report 20:36:01 INFO - PID 4380 | _x_x_mozilla_page_load 20:36:01 INFO - PID 4380 | _x_x_mozilla_page_load_details 20:36:01 INFO - PID 4380 | |i|pagename|runs| 20:36:01 INFO - PID 4380 | |0;ai-astar;110;106;108;107;108;99;108;108;106;107 20:36:01 INFO - PID 4380 | |1;audio-beat-detection;117;121;120;120;120;126;154;117;116;117 20:36:01 INFO - PID 4380 | |2;audio-dft;169;162;163;162;163;167;164;164;166;165 20:36:01 INFO - PID 4380 | |3;audio-fft;76;74;74;74;73;74;75;73;74;75 20:36:01 INFO - PID 4380 | |4;audio-oscillator;80;79;81;89;78;79;79;79;78;79 20:36:01 INFO - PID 4380 | |5;imaging-gaussian-blur;112;115;114;114;114;114;113;114;115;116 20:36:01 INFO - PID 4380 | |6;imaging-darkroom;158;148;148;148;152;148;148;148;149;148 20:36:01 INFO - PID 4380 | |7;imaging-desaturate;94;94;94;94;94;95;95;100;95;95 20:36:01 INFO - PID 4380 | |8;json-parse-financial;55;54;55;54;55;67;57;52;51;53 20:36:01 INFO - PID 4380 | |9;json-stringify-tinderbox;37;36;37;44;42;42;38;37;38;37 20:36:01 INFO - PID 4380 | |10;stanford-crypto-aes;77;74;74;74;73;74;79;75;74;76 20:36:01 INFO - PID 4380 | |11;stanford-crypto-ccm;117;115;117;121;118;116;117;113;114;109 20:36:01 INFO - PID 4380 | |12;stanford-crypto-pbkdf2;166;167;172;168;171;170;169;174;169;173 20:36:01 INFO - PID 4380 | |13;stanford-crypto-sha256-iterative;65;65;71;63;66;64;70;66;69;67 20:36:01 INFO - PID 4380 | __end_tp_report 20:36:01 INFO - PID 4380 | __start_cc_report 20:36:01 INFO - PID 4380 | _x_x_mozilla_cycle_collect,775 20:36:01 INFO - PID 4380 | __end_cc_report 20:36:01 INFO - PID 4380 | __startTimestamp1506224161226__endTimestamp 20:36:01 INFO - PID 4380 | 20:36:01 INFO - PID 4380 | ------- Summary: start ------- 20:36:01 INFO - PID 4380 | Number of tests: 14 20:36:01 INFO - PID 4380 | 20:36:01 INFO - PID 4380 | [#0] ai-astar Cycles:10 Average:106.70 Median:108.00 stddev:2.95 (2.7%) stddev-sans-first:2.87 20:36:01 INFO - PID 4380 | Values: 110.0 106.0 108.0 107.0 108.0 99.0 108.0 108.0 106.0 107.0 20:36:01 INFO - PID 4380 | 20:36:01 INFO - PID 4380 | [#1] audio-beat-detection Cycles:10 Average:122.80 Median:120.00 stddev:11.34 (9.5%) stddev-sans-first:11.83 20:36:01 INFO - PID 4380 | Values: 117.0 121.0 120.0 120.0 120.0 126.0 154.0 117.0 116.0 117.0 20:36:01 INFO - PID 4380 | 20:36:01 INFO - PID 4380 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.50 stddev:2.27 (1.4%) stddev-sans-first:1.73 20:36:01 INFO - PID 4380 | Values: 169.0 162.0 163.0 162.0 163.0 167.0 164.0 164.0 166.0 165.0 20:36:01 INFO - PID 4380 | 20:36:01 INFO - PID 4380 | [#3] audio-fft Cycles:10 Average:74.20 Median:74.00 stddev:0.92 (1.2%) stddev-sans-first:0.71 20:36:01 INFO - PID 4380 | Values: 76.0 74.0 74.0 74.0 73.0 74.0 75.0 73.0 74.0 75.0 20:36:01 INFO - PID 4380 | 20:36:01 INFO - PID 4380 | [#4] audio-oscillator Cycles:10 Average:80.10 Median:79.00 stddev:3.25 (4.1%) stddev-sans-first:3.44 20:36:01 INFO - PID 4380 | Values: 80.0 79.0 81.0 89.0 78.0 79.0 79.0 79.0 78.0 79.0 20:36:01 INFO - PID 4380 | 20:36:01 INFO - PID 4380 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:1.10 (1.0%) stddev-sans-first:0.87 20:36:01 INFO - PID 4380 | Values: 112.0 115.0 114.0 114.0 114.0 114.0 113.0 114.0 115.0 116.0 20:36:01 INFO - PID 4380 | 20:36:01 INFO - PID 4380 | [#6] imaging-darkroom Cycles:10 Average:149.50 Median:148.00 stddev:3.24 (2.2%) stddev-sans-first:1.33 20:36:01 INFO - PID 4380 | Values: 158.0 148.0 148.0 148.0 152.0 148.0 148.0 148.0 149.0 148.0 20:36:01 INFO - PID 4380 | 20:36:01 INFO - PID 4380 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:94.50 stddev:1.83 (1.9%) stddev-sans-first:1.90 20:36:01 INFO - PID 4380 | Values: 94.0 94.0 94.0 94.0 94.0 95.0 95.0 100.0 95.0 95.0 20:36:01 INFO - PID 4380 | 20:36:01 INFO - PID 4380 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:4.45 (8.1%) stddev-sans-first:4.72 20:36:01 INFO - PID 4380 | Values: 55.0 54.0 55.0 54.0 55.0 67.0 57.0 52.0 51.0 53.0 20:36:01 INFO - PID 4380 | 20:36:01 INFO - PID 4380 | [#9] json-stringify-tinderbox Cycles:10 Average:38.80 Median:38.00 stddev:2.78 (7.3%) stddev-sans-first:2.87 20:36:01 INFO - PID 4380 | Values: 37.0 36.0 37.0 44.0 42.0 42.0 38.0 37.0 38.0 37.0 20:36:01 INFO - PID 4380 | 20:36:01 INFO - PID 4380 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:74.50 stddev:1.83 (2.5%) stddev-sans-first:1.79 20:36:01 INFO - PID 4380 | Values: 77.0 74.0 74.0 74.0 73.0 74.0 79.0 75.0 74.0 76.0 20:36:01 INFO - PID 4380 | 20:36:01 INFO - PID 4380 | [#11] stanford-crypto-ccm Cycles:10 Average:115.70 Median:117.00 stddev:3.23 (2.8%) stddev-sans-first:3.40 20:36:01 INFO - PID 4380 | Values: 117.0 115.0 117.0 121.0 118.0 116.0 117.0 113.0 114.0 109.0 20:36:01 INFO - PID 4380 | 20:36:01 INFO - PID 4380 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.90 Median:170.50 stddev:2.60 (1.5%) stddev-sans-first:2.35 20:36:01 INFO - PID 4380 | Values: 166.0 167.0 172.0 168.0 171.0 170.0 169.0 174.0 169.0 173.0 20:36:01 INFO - PID 4380 | 20:36:01 INFO - PID 4380 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:2.63 (4.0%) stddev-sans-first:2.73 20:36:01 INFO - PID 4380 | Values: 65.0 65.0 71.0 63.0 66.0 64.0 70.0 66.0 69.0 67.0 20:36:01 INFO - PID 4380 | -------- Summary: end -------- 20:36:01 INFO - PID 4380 | 20:36:01 INFO - PID 4380 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 20:36:01 INFO - TEST-INFO | 4380: exit 0 20:36:01 INFO - TEST-OK | kraken | took 61124ms 20:36:01 INFO - SUITE-END | took 1171s 20:36:01 INFO - Completed test suite (00:19:31) 20:36:01 INFO - javascript benchmark 20:36:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8612.170852297113, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3116.6260048794143, 3149.1025057858515, 3156.9526457103148, 3166.9049928502145, 3185.076327864919, 6148.569600127993, 6260.718267677954, 6332.746690132389, 6333.588316759413, 6412.358764123591, 6174.166487524194, 6219.440250377465, 6355.046742988554, 6406.263279722833, 6422.421982021617, 5712.0, 5841.766329346831, 5894.263217097863, 5924.437178468039, 5947.464728174464, 5751.281089863767, 5853.209816674737, 5930.051191809312, 5940.435658612447, 5943.613665111754, 5646.548276137899, 5742.6841523716175, 5781.566382521307, 5817.127430885359, 5865.530757539386, 5785.479306862402, 5814.3313518945015, 5823.650580965155, 5846.7368968396095, 5848.210491583624, 5722.62802917809, 5768.192453056576, 5788.942110578882, 5790.986577348947, 5830.271216097988, 6143.170671959273, 6278.152449419361, 6291.496680265568, 6331.620102793847, 6363.490920726377, 6634.966825165891, 6647.700853461557, 6675.6662166891465, 6677.198736151693, 6695.096162018114, 6731.798046058626, 6747.696353664097, 6747.865042699119, 6823.249442561314, 6974.0236366908675, 6293.150424692653, 6306.180196574462, 6309.495240380758, 6366.554341196118, 6376.840578985516, 6883.208431030395, 6907.516473846783, 6977.1278590176225, 6982.650867456607, 7005.159380874327, 6515.543911926215, 6600.933990660032, 6655.5341126121675, 6691.0, 6760.087388202628, 6781.355771201728, 6810.523263371616, 6843.8973415398805, 6860.485463590251, 6904.689288982008, 6693.598384096969, 6722.428593569503, 6792.490563207681, 6802.285759995229, 6850.794476165723, 6568.901466478007, 6813.420859226922, 6835.521513494008, 6890.931090689029, 6905.343992320822, 5222.97388513055, 5263.5525980292105, 5276.15581506957, 5278.076336641073, 5372.5433338166695, 4617.699849509771, 4633.559811817872, 4655.953440465552, 4694.976525117421, 4696.412948381452, 5766.452187042224, 5776.220210271644, 5779.739911703899, 5826.941730582725, 5872.559558033165, 6603.174603174603, 6771.762988295386, 6807.591544507345, 6840.863182736317, 6892.931070689329, 5732.627379220337, 5737.540996720252, 5766.250387449605, 5773.8267851963665, 5807.767689292466, 5845.210896528999, 5885.941140588625, 5889.146073819358, 5892.734826932799, 5893.381194974551, 6561.048647946021, 6574.539782215199, 6650.567713098633, 6664.833379165462, 6679.131712877295, 6825.35159159879, 6831.11195544576, 6846.246912839683, 6910.274421185703, 6941.895871561931, 6404.0, 6512.739490420519, 6569.85027620155, 6668.199816022108, 6679.0649309097735, 6691.866162676622, 6755.560888542229, 6769.796906092825, 6777.695003724943, 6801.829954251183, 6884.621345826027, 6943.444524437932, 6944.826379340557, 6954.026436299024, 6959.338862808025, 6588.110605068446, 6595.043718660671, 6599.208095028627, 6694.899576506259, 6699.564528305645, 6404.583702059351, 6520.902186467112, 6533.18335208099, 6533.379328963741, 6533.901991470037, 6515.250746164252, 6518.902216466662, 6606.47148228131, 6609.0, 6614.437772789367, 6711.563748356341, 6752.797416077526, 6757.155355580552, 6795.116634837439, 6797.354251346114, 6438.484921206386, 6439.259485159267, 6457.257415397289, 6543.672816359068, 6545.607263564201], "value": 6179.830517105487, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [845.9915400845991, 866.9219770220678, 872.8647059705744, 875.8905136857893, 877.5919197573127, 39268.607313926856, 42860.785696071514, 43029.7848510757, 43056.3541546877, 43147.137057258835, 37966.8101659492, 38150.42774358387, 38255.808720956426, 38346.0, 38547.42178867312, 7256.600886951229, 7356.448266380016, 7384.852302953937, 7962.1639727828615, 8196.959015204915, 8001.919980800176, 8107.837843243161, 8108.635111419971, 8112.22933821286, 8115.675372985073, 8108.06757222921, 8123.268905798477, 8174.223448772357, 8177.713780017701, 8209.917900821005, 8047.718329858485, 8062.596870156469, 8080.595970201525, 8101.432899696994, 8105.230003149692, 8017.078036025873, 8043.718469853586, 8073.0, 8074.677012919535, 8094.392920530984, 38072.42891356632, 38175.618243817764, 38588.0, 38681.0, 38764.41853372202, 3496.3531746626954, 3530.682238598513, 3543.5039094526787, 3544.6987006104514, 3553.9644603553893, 32245.35509289801, 32272.838635806904, 32283.838580806947, 32379.6762032379, 32461.350772984646, 5144.305518754995, 5186.429492755794, 5206.739663016834, 5219.0, 5256.395514515842, 180622.0, 181741.0, 181787.9999999987, 182506.0, 183059.99999999866, 41945.0, 42853.0, 47894.5210547897, 48543.757281213366, 48748.0, 51676.74161629168, 52484.0, 52861.2070818938, 52878.73560632172, 52922.470775292524, 15415.691686166214, 15704.29330680122, 15717.21413929299, 15721.528354149394, 15724.842751572567, 12730.872691272969, 12757.681057973625, 12794.168379055332, 12804.871951280367, 12806.295653739135, 14129.152250864776, 14163.78754318686, 14177.362018709182, 14223.502177423741, 14237.71860532557, 5817.894600025981, 5945.227120474397, 5958.433948774859, 6049.274087109575, 6068.150458935753, 1001.9749506262402, 1025.103034844511, 1035.5081336365317, 1041.6979076067855, 1043.5617040842865, 22855.542889142125, 22909.623000514224, 22913.770862291498, 22985.0, 23164.768352316598, 1102.2449622008949, 1121.900960136183, 1125.1280257800106, 1131.5813149134872, 1150.344303746873, 12047.698807529881, 12141.635750927486, 12181.817272740738, 12211.444619276204, 12286.324252166038, 224037.0, 224307.0, 225924.0, 226040.0, 226292.0, 52600.73699631477, 52609.210861837106, 52822.73588632109, 52839.73580132152, 53040.0, 1458.1105525629357, 1463.897527173109, 1482.4218554763652, 1493.1787516865681, 1494.775783632442, 22348.553028939656, 22725.0, 22750.544989099795, 22813.885930570905, 23141.958611862843, 29589.704102959557, 29595.556066658588, 29605.0, 29618.111456656334, 29665.555016674334, 193043.0, 193571.0, 193669.0, 194801.0, 195370.0, 29651.85174074116, 30150.698493015665, 33196.83401583073, 33580.664193357756, 34033.0, 41740.791296043324, 42825.78587107169, 42998.35502467528, 43087.491937782026, 43579.0, 31922.20194495156, 32006.839965800023, 32201.35597287994, 32384.35231295408, 32524.512132317563, 30819.0, 30998.0, 31140.844295779283, 31173.285469299408, 32252.516212256367, 33842.0, 34728.0, 34998.47502287417, 35133.0, 35237.64762352344, 30443.2389190272, 30610.234744131576, 30903.381932361677, 30923.381532369676, 30947.845260773553, 22846.42883927915, 23013.424664383525, 23314.883425582764, 23551.646725299477, 23570.292891213292], "value": 17011.133643691664, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.1674388880012, 578.7308901360869, 582.170407169783, 585.8271809816105, 601.2994860986951, 21783.564328713415, 22360.88819555902, 22361.776382236174, 22362.552748945032, 22410.43973900653, 22893.656595151046, 23897.641535376984, 24074.0, 24291.514169716596, 24334.26997190087, 6497.805065848021, 6550.606963582177, 6599.175103112111, 6608.801735947929, 6631.668416579176, 6516.283208847023, 6612.834679133012, 6619.437347825441, 6621.867562648744, 6848.452123830081, 7096.0, 7123.536970096953, 7127.0, 7132.144142702883, 7139.1433028036445, 7055.89416158758, 7113.679884405188, 7142.285771422842, 7150.463715221379, 7151.678174482109, 6563.212414510289, 6833.863322733518, 6919.4464442844455, 6924.549904256207, 7016.789496315118, 30292.0, 30783.846080769454, 30805.537916931265, 30863.382732345228, 30927.226819329473, 2104.147820132833, 2123.8938053097436, 2132.2856842957626, 2142.7535833379047, 2146.5170336674278, 20425.4893627659, 20930.5813883723, 21069.262575809928, 21148.154073837028, 21306.46733831651, 2506.987465062681, 2509.9372515687073, 2545.6308835218974, 2569.0751329521545, 2569.665943427361, 125538.0, 128814.0, 131469.0, 131694.0, 134994.999999999, 19822.20711171537, 20366.389008329774, 20540.897295513427, 21570.78429215719, 21753.564928701337, 41682.79158604187, 41684.166316673494, 41697.37453938193, 41716.95707607334, 41730.1653966925, 11491.712707182387, 11556.364399958084, 11568.76862462746, 11660.416979151178, 11667.416629168678, 9632.90367096334, 9639.277054220822, 9666.130048295687, 9724.562394692255, 9763.658271960589, 11090.500927458284, 11152.721181970353, 11273.970685276565, 11339.0, 11598.88401115995, 3742.1954279829424, 3773.584905660375, 3832.310184166821, 3988.960110398917, 3997.200559888034, 935.5462600638684, 956.9186619137312, 962.1965658674944, 962.5476026267643, 979.0454307050569, 18458.446246612624, 18560.721589176173, 18655.440336789918, 18753.343632973054, 18853.434396968114, 1015.7105225010985, 1023.4831410137981, 1023.5752162852482, 1033.421284080917, 1034.2450011491503, 10196.490175491195, 10240.180785537139, 10251.48742562869, 10323.896761032294, 10566.207534434794, 419871.0, 423443.0, 425286.0, 426955.0, 430400.0, 104219.47890260651, 104289.47855260676, 108879.0, 110190.44904775586, 110438.0, 1160.2342453980332, 1206.3726862031695, 1239.9132060755842, 1271.650296168561, 1279.0726723125845, 19294.22823087061, 19307.227710891406, 19774.40676779699, 19832.107555159764, 20100.19599216015, 57736.0, 57855.421445786684, 58981.0, 60677.69661151666, 61007.0, 75114.62442687752, 76417.61791191009, 76436.0, 77039.22960770545, 77088.61455692686, 14005.089669171472, 14128.78806817919, 14276.857231427968, 14310.0, 14418.062825916282, 21854.45363865916, 21862.125514979223, 21869.562608748056, 21990.89004555031, 22052.88973555122, 17198.0, 17351.219195135996, 17381.478555642843, 17532.474025779247, 17636.294548217928, 15617.219139043229, 16249.67500650004, 16318.18409079565, 16422.83577164213, 16754.0, 16260.756088658443, 16708.83291167073, 17049.659006820042, 17573.0, 17865.553361165556, 14134.50529231472, 14143.151410915378, 14154.292285385483, 14177.43290268419, 14253.287335633384, 16884.071376074433, 17016.829831701525, 17111.657766844346, 17112.229949652046, 17463.126843657512], "value": 12513.594647988262, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.9465221391144, 1376.7728324826405, 1383.087162472767, 1389.2150934721888, 1392.8885689144863, 14954.102753834764, 15567.922160389182, 15693.45072922448, 15718.449854255088, 15721.292541835617, 15297.847021529782, 15385.0, 15438.382464701399, 15451.0, 15500.767488487681, 2776.819506732061, 2887.826730396183, 2888.4078763853463, 2890.9277268068363, 2892.7975041747086, 2755.077049188524, 2870.225039239404, 2871.928201794951, 2872.1957851801426, 2874.7700183985335, 2642.748938850806, 2910.3888183481495, 2918.5622156676563, 2920.722531359528, 2924.38587896542, 2841.2186648671573, 2850.657921049477, 2863.3986862758848, 2876.0365277631913, 2877.1080964900843, 2812.9015484457946, 2862.484752744526, 2875.0368626509935, 2877.568364745284, 2879.280179955011, 15077.24613769318, 15261.38954441821, 15315.923420382938, 15407.922960385238, 15428.0, 8241.711540096068, 8498.065212826585, 8504.192101750386, 8511.616977235977, 8512.106228845943, 5467.808626698046, 5656.91514627281, 5663.66018038919, 5689.943100568983, 5832.62087964281, 1922.356010736405, 1948.7758907725652, 1958.0601311370622, 1966.9409917702492, 1985.592953444555, 27358.452830943268, 27519.862400688067, 27542.586861196898, 27570.5864412032, 27593.862030689717, 6808.0, 6891.38202443711, 7041.5775053496955, 7080.779614922251, 7098.467614928798, 18296.817031829778, 18323.633527329377, 18340.633187336178, 18361.265549378142, 18375.54061148482, 7971.561564113914, 8454.36592255571, 8788.0, 8828.337874659426, 8835.823283534293, 7670.808229794188, 7767.844643107106, 7775.300222979959, 7778.688852445952, 7818.4136189785995, 5294.391145018295, 5405.378381486101, 5417.024935511646, 5448.0, 5474.890502190014, 1430.0061457287086, 1441.243347242685, 1564.108458178827, 1584.081232884924, 1602.6233835048988, 716.924722904098, 892.7634176943116, 909.0818273543769, 916.1067958740175, 921.7833809054866, 8341.916580834113, 8548.615312310962, 8602.741917742478, 8603.31173506118, 8737.432066915757, 968.9757756056014, 982.3123813330698, 989.5398639632606, 991.4794732765212, 997.8154041502345, 5264.42091369949, 5457.181422786613, 5517.36550296721, 5627.296587926509, 5740.0815869460685, 22309.888450557966, 22377.664335034988, 23224.3032709019, 23228.65157022646, 23304.184353547545, 22375.664365034536, 23000.4249893754, 23034.53930921372, 23186.65220021701, 23368.0, 11913.761724765456, 12069.155159138776, 12096.395180240777, 12257.26456412618, 12258.938705306417, 8356.122607126164, 8510.106438824081, 8522.872156917776, 8535.146485351415, 8575.356848236283, 18788.530286742942, 19108.904455477634, 19296.13167407442, 19325.4202373929, 19676.90161549183, 20098.698519521928, 20366.28717994863, 20408.38774836757, 20488.078036488096, 20787.168513259905, 11161.832572511257, 11378.54485820558, 11403.657890263305, 11427.942860285646, 11439.942800286279, 14633.707325853211, 14778.926105369404, 14816.851831481546, 14821.333040013442, 14968.625784355478, 11090.944545277222, 11180.385078820418, 11215.327080375204, 11481.942590286995, 11587.130965177477, 10797.136229101496, 10879.673609791718, 11039.944800275947, 11310.4910279036, 11415.543378264776, 10375.584976601154, 10429.895701042893, 10433.21750868703, 10577.153827693612, 10578.576856925636, 6783.457323414016, 6858.897116543356, 6956.513044086865, 7050.330218629222, 7083.043789088407, 7043.190033146254, 7083.858322833617, 7089.0784198053925, 7140.821479463055, 7189.892151617625], "value": 6909.241674549455, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.5931254996002, 521.8356217791394, 536.0913252037795, 542.967421954683, 547.9698616576087, 6193.938060619393, 6262.154609127766, 6262.3111457739615, 6334.524910631698, 6343.651099189543, 6117.0, 6224.564280500367, 6253.812385628427, 6280.340564240746, 6293.842653933654, 5174.637775355726, 5185.144451165553, 5198.0, 5209.218617207421, 5245.763940622662, 4864.270359446076, 5005.54950054495, 5052.292679024939, 5146.562542183919, 5218.504242096995, 4954.281629163787, 4987.226979818134, 4989.600831933455, 4990.950090499103, 4997.700137991732, 4936.111499930011, 4967.652264341497, 4973.676711013809, 4975.800967961295, 5015.172496538067, 4391.231534481453, 4440.356148358503, 4441.578050085237, 4498.280275155959, 4503.144402563536, 5959.344472108065, 6022.3676513966275, 6102.206713127265, 6134.202553667995, 6197.814065577994, 5667.914981275243, 5669.319681638189, 5678.176664383641, 5722.771089156428, 5733.856653583652, 6532.869342613169, 6547.3125321841, 6567.737290508374, 6574.830305999057, 6593.736250549972, 4740.312654665088, 4909.337239472661, 4917.114919314522, 4917.188663870457, 4928.1129396708575, 6624.834379140512, 6691.364320389555, 6732.956391759285, 6769.593824370603, 6779.373035426122, 5043.949560504348, 5058.266551350033, 5059.367579052619, 5073.441921388644, 5077.339945807022, 5079.0, 5112.514311140436, 5155.278261043457, 5165.61257905651, 5184.507471790174, 5680.6200310815, 5685.943140568624, 5737.655740655574, 5738.540916726652, 5757.769689212385, 6573.244076931119, 6636.435902948207, 6646.734130634817, 6657.700403481855, 6691.397774200345, 1757.323430479249, 1779.9377021804175, 1780.1455301455374, 1787.5441762350777, 1793.1482545790645, 1170.7658468306372, 1217.5190799634095, 1228.9016878649686, 1238.975220495585, 1244.7012716948047, 5611.074172761449, 5638.887222255532, 5684.801031963944, 5699.316082070178, 5706.42935706426, 6621.437177839841, 6665.7666981656375, 6678.7328506859185, 6700.731970721214, 6719.697613607399, 5480.342358916876, 5574.526165275997, 5592.245046918695, 5692.715364231772, 5725.541956643458, 3440.2259491614686, 3538.398472259722, 3557.4485954677066, 3567.161716996504, 3568.286342731464, 6362.395572420613, 6406.391392817675, 6424.807255782334, 6446.0, 6487.967560162263, 6724.335237295588, 6732.730690772314, 6802.285759995229, 6804.727810887608, 6857.622830744357, 6365.777197798055, 6404.49494368823, 6453.935460645427, 6469.417752402306, 6489.448396886318, 6556.246031706415, 6617.834554136185, 6628.270890201978, 6635.535512514078, 6745.460363171032, 6519.217693876765, 6565.606063636197, 6576.8355791103695, 6578.375054369827, 6624.801255962136, 6376.649284289409, 6437.5171862111465, 6443.0, 6444.548881578245, 6518.902216466662, 4986.9251961221335, 4996.225585034325, 5042.168042272984, 5043.394792624908, 5059.418166910852, 6430.292667806444, 6466.0, 6563.0811686362995, 6687.431568316748, 6805.897911531232, 6232.376762323732, 6300.0, 6451.258105317761, 6468.482521398183, 6484.610923344614, 6390.392912673288, 6409.839754006187, 6480.675966201766, 6511.153550038464, 6525.3800888915475, 6337.4613157882095, 6341.302456729663, 6400.679966001589, 6404.135441715309, 6414.03789431589, 6330.3669633036325, 6350.491960643045, 6454.709538070892, 6551.181102362205, 6555.737770489127, 6267.0, 6311.495080393465, 6318.684065796784, 6319.178506794087, 6337.96831015842], "value": 5047.0290696820075, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [892.799120197956, 913.3058875254806, 925.1581061234278, 937.2127412973101, 944.3672739264692, 17994.91002544987, 18521.0, 18610.069496525153, 18643.067846607682, 18656.533586660324, 17869.0, 18098.909505452455, 18395.44813655589, 18930.0, 18945.14746836392, 953.6233187890779, 972.6060945317158, 985.4235272365675, 986.896375880533, 987.5753426026805, 987.284218941269, 993.0218734546465, 993.3295025857553, 995.1839491616877, 997.2221667099637, 1024.08856118055, 1059.6926891201542, 1067.1249575348218, 1067.9038886500214, 1070.1920050362005, 1063.261033581661, 1063.8723353197588, 1065.3554599467288, 1067.4449286371043, 1068.1401471815186, 731.7621772923768, 749.62144117221, 756.2853103816896, 756.7389250708496, 757.0952711509748, 17626.64746705059, 17664.20511076992, 17682.557936051573, 17692.469225923243, 17718.114094295364, 21753.34739957788, 21821.23625673094, 21956.670649940264, 22171.556568868695, 22221.0, 17423.912880435644, 17768.822311776847, 17786.0, 17931.372401966, 17964.922104673762, 3623.5108260385036, 3627.963720362789, 3646.726495512847, 3655.4334078217653, 3660.5973342932257, 139588.0, 141302.29348853292, 142149.99999999895, 142284.0, 142852.0, 16409.6718065638, 16568.254428550743, 16803.495895123167, 16854.241559129867, 16915.915420422818, 30549.694503054685, 30560.235994100327, 31114.222144446117, 31902.0, 32049.51925721116, 8906.109389061043, 8947.821043579092, 8949.731508054769, 8963.596638151299, 8977.46135231875, 4027.3958906163725, 4049.250888585621, 4157.667386609064, 4179.393987871802, 4234.216669916013, 5557.44425557441, 5693.259876216065, 5693.971530142323, 5711.8000869969355, 5723.484886360165, 978.9902100979042, 997.7356000659686, 1013.0983424751977, 1015.4922538730634, 1031.3141760729181, 658.8484648530865, 676.922153952292, 692.975745848903, 694.9617771022643, 695.6591270277629, 11536.192466527431, 11702.648920532398, 11802.645920622395, 12553.246805191719, 12787.680307992374, 659.745997790854, 659.9869200776784, 660.930602286753, 671.1174805131237, 676.4081428749844, 5582.748776304995, 5669.177969194444, 5749.597528173072, 5820.534357251409, 5846.678432686158, 117639.0, 118620.0, 125369.0, 125412.0, 126024.0, 106618.0, 106642.46678766556, 106929.46535267273, 107348.0, 107904.46047769868, 91775.99999999866, 92052.53973730089, 92217.53891230501, 92443.53778231065, 95723.52138239265, 10414.271001029856, 10449.164066874784, 10475.481055247099, 10498.0, 10560.471976400995, 44290.0, 44470.0, 45193.54806452025, 45764.0, 45966.310505341775, 56017.43982560122, 56126.719366402904, 57299.14051289317, 57730.0, 58665.12002319883, 15019.77470337924, 15246.695066098395, 15329.693406131591, 15385.38458461649, 15392.230388480755, 16189.514314570582, 16493.752593711342, 16634.833651663812, 17034.574135646708, 17044.14779261007, 15987.200639967723, 16058.0, 16069.598260043593, 16208.837911620732, 16242.918785405996, 15147.848521514643, 15307.234638267819, 15453.613659658598, 15568.455104071303, 15593.92203039023, 14914.77627835605, 15228.77156842626, 15235.238238088274, 15350.23248837576, 15369.0, 12107.213031152947, 12191.573294934635, 12547.49810007626, 12594.118411711459, 12605.0, 11239.60661376848, 11508.194426390073, 11522.308661480338, 11764.882351176379, 11791.88208117908], "value": 8893.896121767326, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1428.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 108.0, 107.0, 108.0, 99.0, 108.0, 108.0, 106.0, 107.0], "value": 106.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 121.0, 120.0, 120.0, 120.0, 126.0, 154.0, 117.0, 116.0, 117.0], "value": 122.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 162.0, 163.0, 162.0, 163.0, 167.0, 164.0, 164.0, 166.0, 165.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 74.0, 74.0, 73.0, 74.0, 75.0, 73.0, 74.0, 75.0], "value": 74.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 81.0, 89.0, 78.0, 79.0, 79.0, 79.0, 78.0, 79.0], "value": 80.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 115.0, 116.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 148.0, 148.0, 148.0, 152.0, 148.0, 148.0, 148.0, 149.0, 148.0], "value": 149.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 100.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 54.0, 55.0, 67.0, 57.0, 52.0, 51.0, 53.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 36.0, 37.0, 44.0, 42.0, 42.0, 38.0, 37.0, 38.0, 37.0], "value": 38.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 74.0, 74.0, 73.0, 74.0, 79.0, 75.0, 74.0, 76.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 117.0, 121.0, 118.0, 116.0, 117.0, 113.0, 114.0, 109.0], "value": 115.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 172.0, 168.0, 171.0, 170.0, 169.0, 174.0, 169.0, 173.0], "value": 169.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 71.0, 63.0, 66.0, 64.0, 70.0, 66.0, 69.0, 67.0], "value": 66.6, "unit": "score"}]}]} 20:36:01 INFO - Return code: 0 20:36:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:36:02 INFO - # TBPL SUCCESS # 20:36:02 INFO - Running post-action listener: _package_coverage_data 20:36:02 INFO - Running post-action listener: _resource_record_post_action 20:36:02 INFO - [mozharness: 2017-09-24 03:36:02.023009Z] Finished run-tests step (success) 20:36:02 INFO - Running post-run listener: _resource_record_post_run 20:36:02 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 9011200; Write bytes: 334602240; Read time: 2764; Write time: 191836 20:36:02 INFO - TinderboxPrint: CPU usage
13.1% 20:36:02 INFO - TinderboxPrint: I/O read bytes / time
9,011,200 / 2,764 20:36:02 INFO - TinderboxPrint: I/O write bytes / time
334,602,240 / 191,836 20:36:02 INFO - TinderboxPrint: CPU idle
8,241.2 (86.9%) 20:36:02 INFO - TinderboxPrint: CPU user
1,193.2 (12.6%) 20:36:02 INFO - TinderboxPrint: Swap in / out
0 / 0 20:36:02 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 170299392; Read time: 152; Write time: 140224 20:36:02 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 20:36:02 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 6770688; Write bytes: 163909632; Read time: 2428; Write time: 51596 20:36:02 INFO - Running post-run listener: _upload_blobber_files 20:36:02 INFO - Blob upload gear active. 20:36:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:36:02 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 20:36:02 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'] 20:36:02 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 20:36:03 INFO - (blobuploader) - INFO - Open directory for files ... 20:36:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:36:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:36:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:36:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:36:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:36:04 INFO - (blobuploader) - INFO - Done attempting. 20:36:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 20:36:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:36:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:36:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 20:36:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:36:05 INFO - (blobuploader) - INFO - Done attempting. 20:36:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 20:36:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:36:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:36:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 20:36:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:36:05 INFO - (blobuploader) - INFO - Done attempting. 20:36:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:36:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:36:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:36:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:36:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:36:12 INFO - (blobuploader) - INFO - Done attempting. 20:36:12 INFO - (blobuploader) - INFO - Iteration through files over. 20:36:12 INFO - Return code: 0 20:36:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:36:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:36:12 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/facbebf467008a253c33ae15969decc133e6db977b9a57d56bb305cbe2f6e4d95fb517814310d68e834ad98d5383900ec9b2f47c06ed2b377aa30e4841ee5944", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43e92781d223aa31426a3eddfc7a63fba123e8db5d72f0160768a4cea0991b82aa0c71290e2828d53d1558bcd3e15af4734f3654f4a928da4689a6f8411816b3", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35e11563a6d85b63664ba47bd9f5f9367662c48db7d03c741392db66426ec7b08f6dce82e0979bfe123256ed4ba8f29b83f7d7230ed97c416f995041ce85fdb7", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5cd05cfe83c2514e92f42f31b3142f03b6f16fcc274f5c52a8c33101d2ace88e1cd920d018a51bd48780a687239de25af6670d51b7b787c6ffdc99e2b64b5853"} 20:36:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:36:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:36:12 INFO - Contents: 20:36:12 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/facbebf467008a253c33ae15969decc133e6db977b9a57d56bb305cbe2f6e4d95fb517814310d68e834ad98d5383900ec9b2f47c06ed2b377aa30e4841ee5944", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43e92781d223aa31426a3eddfc7a63fba123e8db5d72f0160768a4cea0991b82aa0c71290e2828d53d1558bcd3e15af4734f3654f4a928da4689a6f8411816b3", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35e11563a6d85b63664ba47bd9f5f9367662c48db7d03c741392db66426ec7b08f6dce82e0979bfe123256ed4ba8f29b83f7d7230ed97c416f995041ce85fdb7", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5cd05cfe83c2514e92f42f31b3142f03b6f16fcc274f5c52a8c33101d2ace88e1cd920d018a51bd48780a687239de25af6670d51b7b787c6ffdc99e2b64b5853"} 20:36:12 INFO - Running post-run listener: copy_logs_to_upload_dir 20:36:12 INFO - Copying logs to upload dir... 20:36:12 INFO - mkdir: /builds/slave/test/build/upload/logs 20:36:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.843943 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-23 20:36:13.036277) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 20:36:13.040127) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268 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/facbebf467008a253c33ae15969decc133e6db977b9a57d56bb305cbe2f6e4d95fb517814310d68e834ad98d5383900ec9b2f47c06ed2b377aa30e4841ee5944", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43e92781d223aa31426a3eddfc7a63fba123e8db5d72f0160768a4cea0991b82aa0c71290e2828d53d1558bcd3e15af4734f3654f4a928da4689a6f8411816b3", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35e11563a6d85b63664ba47bd9f5f9367662c48db7d03c741392db66426ec7b08f6dce82e0979bfe123256ed4ba8f29b83f7d7230ed97c416f995041ce85fdb7", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5cd05cfe83c2514e92f42f31b3142f03b6f16fcc274f5c52a8c33101d2ace88e1cd920d018a51bd48780a687239de25af6670d51b7b787c6ffdc99e2b64b5853"} build_url:https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011429 build_url: 'https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/facbebf467008a253c33ae15969decc133e6db977b9a57d56bb305cbe2f6e4d95fb517814310d68e834ad98d5383900ec9b2f47c06ed2b377aa30e4841ee5944", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43e92781d223aa31426a3eddfc7a63fba123e8db5d72f0160768a4cea0991b82aa0c71290e2828d53d1558bcd3e15af4734f3654f4a928da4689a6f8411816b3", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35e11563a6d85b63664ba47bd9f5f9367662c48db7d03c741392db66426ec7b08f6dce82e0979bfe123256ed4ba8f29b83f7d7230ed97c416f995041ce85fdb7", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5cd05cfe83c2514e92f42f31b3142f03b6f16fcc274f5c52a8c33101d2ace88e1cd920d018a51bd48780a687239de25af6670d51b7b787c6ffdc99e2b64b5853"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 20:36:13.068907) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:36:13.069248) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1506217442.952297-2003284268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:36:13.153755) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 20:36:13.154065) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 20:36:13.154373) ========= ========= Total master_lag: 0.23 =========