builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-083 starttime: 1506222870.34 results: success (0) revision: ff40c5dcaa41261b39a4e9795e02a9d51dd30ced ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:30.335449) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:30.336020) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:30.336365) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:30.430777) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:30.431111) ========= 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=3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-23 20:14: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% 46.1M=0s 2017-09-23 20:14:30 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.248935 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:30.739887) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:30.740212) ========= 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=3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.077904 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:30.835338) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:30.835706) ========= 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=3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-23 20:14:30,891 truncating revision to first 12 chars 2017-09-23 20:14:30,891 Setting DEBUG logging. 2017-09-23 20:14:30,892 attempt 1/10 2017-09-23 20:14:30,892 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:14:31,497 unpacking tar archive at: mozilla-central-ff40c5dcaa41/testing/mozharness/ program finished with exit code 0 elapsedTime=0.907554 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:31.763608) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:31.764362) ========= script_repo_revision: ff40c5dcaa41261b39a4e9795e02a9d51dd30ced ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:31.765321) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:31.765815) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:31.780776) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-09-23 20:14:31.781414) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:14:32 INFO - MultiFileLogger online at 20170923 20:14:32 in /builds/slave/test 20:14:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 20:14:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:14:32 INFO - {'append_to_log': False, 20:14:32 INFO - 'base_work_dir': '/builds/slave/test', 20:14:32 INFO - 'blob_upload_branch': 'Firefox', 20:14:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:14:32 INFO - 'branch': 'Firefox', 20:14:32 INFO - 'buildbot_json_path': 'buildprops.json', 20:14:32 INFO - 'code_coverage': False, 20:14:32 INFO - 'config_files': ('talos/linux_config.py',), 20:14:32 INFO - 'default_actions': ('clobber', 20:14:32 INFO - 'read-buildbot-config', 20:14:32 INFO - 'download-and-extract', 20:14:32 INFO - 'populate-webroot', 20:14:32 INFO - 'create-virtualenv', 20:14:32 INFO - 'install', 20:14:32 INFO - 'setup-mitmproxy', 20:14:32 INFO - 'run-tests'), 20:14:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:14:32 INFO - 'disable_ccov_upload': False, 20:14:32 INFO - 'disable_stylo': False, 20:14:32 INFO - 'download_minidump_stackwalk': True, 20:14:32 INFO - 'download_symbols': 'ondemand', 20:14:32 INFO - 'enable_stylo': False, 20:14:32 INFO - 'enable_webrender': False, 20:14:32 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 20:14:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:14:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:14:32 INFO - 'gecko_profile': False, 20:14:32 INFO - 'gecko_profile_interval': 0, 20:14:32 INFO - 'installer_path': 'installer.exe', 20:14:32 INFO - 'log_level': 'info', 20:14:32 INFO - 'log_name': 'talos', 20:14:32 INFO - 'log_to_console': True, 20:14:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:14:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:14:32 INFO - 'opt_config_files': (), 20:14:32 INFO - 'pip_index': False, 20:14:32 INFO - 'suite': 'dromaeojs-e10s', 20:14:32 INFO - 'system_bits': '32', 20:14:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:14:32 INFO - 'title': 'talos-linux64-ix-083', 20:14:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:14:32 INFO - 'use_talos_json': True, 20:14:32 INFO - 'verify': 'False', 20:14:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:14:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:14:32 INFO - 'work_dir': 'build'} 20:14:32 INFO - [mozharness: 2017-09-24 03:14:32.066880Z] Running clobber step. 20:14:32 INFO - Running pre-action listener: _resource_record_pre_action 20:14:32 INFO - Running main action method: clobber 20:14:32 INFO - rmtree: /builds/slave/test/build 20:14:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:14:36 INFO - Running post-action listener: _resource_record_post_action 20:14:36 INFO - [mozharness: 2017-09-24 03:14:36.270329Z] Finished clobber step (success) 20:14:36 INFO - [mozharness: 2017-09-24 03:14:36.270425Z] Running read-buildbot-config step. 20:14:36 INFO - Running pre-action listener: _resource_record_pre_action 20:14:36 INFO - Running main action method: read_buildbot_config 20:14:36 INFO - Using buildbot properties: 20:14:36 INFO - { 20:14:36 INFO - "project": "", 20:14:36 INFO - "product": "firefox", 20:14:36 INFO - "who": "philringnalda@gmail.com", 20:14:36 INFO - "installer_path": "public/build/target.tar.bz2", 20:14:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 20:14:36 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 20:14:36 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 20:14:36 INFO - "stage_platform": "linux64-qr", 20:14:36 INFO - "basedir": "/builds/slave/test", 20:14:36 INFO - "buildnumber": 78, 20:14:36 INFO - "platform": "ubuntu64_hw_qr", 20:14:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:14:36 INFO - "slavebuilddir": "test", 20:14:36 INFO - "taskId": "ORta8Vc7T_G4_steGh4h4A", 20:14:36 INFO - "branch": "mozilla-central", 20:14:36 INFO - "script_repo_revision": "production", 20:14:36 INFO - "revision": "ff40c5dcaa41261b39a4e9795e02a9d51dd30ced", 20:14:36 INFO - "slavename": "talos-linux64-ix-083", 20:14:36 INFO - "repo_path": "mozilla-central" 20:14:36 INFO - } 20:14:36 INFO - Finding installer, test and symbols from parent task. 20:14:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ORta8Vc7T_G4_steGh4h4A'}, attempt #1 20:14:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ORta8Vc7T_G4_steGh4h4A'}, attempt #1 20:14:37 INFO - Task dependencies: ShKXziekTvWG-QSzPkbAOw 20:14:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw'}, attempt #1 20:14:37 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.tar.bz2 20:14:37 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.test_packages.json 20:14:37 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.crashreporter-symbols.zip 20:14:37 INFO - Running post-action listener: _resource_record_post_action 20:14:37 INFO - [mozharness: 2017-09-24 03:14:37.607811Z] Finished read-buildbot-config step (success) 20:14:37 INFO - [mozharness: 2017-09-24 03:14:37.608026Z] Running download-and-extract step. 20:14:37 INFO - Running pre-action listener: _resource_record_pre_action 20:14:37 INFO - Running main action method: download_and_extract 20:14:37 INFO - mkdir: /builds/slave/test/build/tests 20:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:14:37 INFO - trying https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.test_packages.json 20:14:37 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:14:37 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:14:38 INFO - Downloaded 989 bytes. 20:14:38 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 20:14:38 INFO - Using the following test package requirements: 20:14:38 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 20:14:38 INFO - u'common': [u'target.common.tests.zip'], 20:14:38 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 20:14:38 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 20:14:38 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 20:14:38 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 20:14:38 INFO - u'mozbase': [u'target.common.tests.zip'], 20:14:38 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 20:14:38 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 20:14:38 INFO - u'web-platform': [u'target.common.tests.zip', 20:14:38 INFO - u'target.web-platform.tests.tar.gz'], 20:14:38 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 20:14:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 20:14:38 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:14:38 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:14:38 INFO - Fetch https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.common.tests.zip into memory 20:14:39 INFO - Content-Length response header: 54943875 20:14:39 INFO - Bytes received: 54943875 20:14:50 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:14:50 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:14:50 INFO - Fetch https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.talos.tests.zip into memory 20:14:50 INFO - Content-Length response header: 14513823 20:14:50 INFO - Bytes received: 14513823 20:14:51 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:14:51 INFO - trying https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.tar.bz2 20:14:51 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:14:51 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:14:52 INFO - Downloaded 61526248 bytes. 20:14:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.tar.bz2 20:14:52 INFO - mkdir: /builds/slave/test/properties 20:14:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:14:52 INFO - Writing to file /builds/slave/test/properties/build_url 20:14:52 INFO - Contents: 20:14:52 INFO - build_url:https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.tar.bz2 20:14:52 INFO - Running post-action listener: _resource_record_post_action 20:14:52 INFO - Running post-action listener: find_tests_for_verification 20:14:52 INFO - Running post-action listener: set_extra_try_arguments 20:14:52 INFO - [mozharness: 2017-09-24 03:14:52.313352Z] Finished download-and-extract step (success) 20:14:52 INFO - [mozharness: 2017-09-24 03:14:52.313451Z] Running populate-webroot step. 20:14:52 INFO - Running pre-action listener: _resource_record_pre_action 20:14:52 INFO - Running main action method: populate_webroot 20:14:52 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:14:52 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:14:52 INFO - 'tests': ['tresize', 20:14:52 INFO - 'tcanvasmark']}, 20:14:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:14:52 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:14:52 INFO - 'tests': ['dromaeo_css', 20:14:52 INFO - 'kraken']}, 20:14:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:14:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:14:52 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:14:52 INFO - 'talos_options': ['--disable-stylo'], 20:14:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:14:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:14:52 INFO - 'tests': ['damp', 'tps']}, 20:14:52 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:14:52 INFO - 'talos_options': ['--disable-stylo'], 20:14:52 INFO - 'tests': ['damp', 'tps']}, 20:14:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:14:52 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:14:52 INFO - 'tests': ['dromaeo_dom']}, 20:14:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 20:14:52 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:14:52 INFO - 'tests': ['basic_compositor_video', 20:14:52 INFO - 'glvideo']}, 20:14:52 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 20:14:52 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 20:14:52 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:14:52 INFO - 'talos_options': ['--disable-stylo'], 20:14:52 INFO - 'tests': ['ts_paint_webext', 20:14:52 INFO - 'tp5o_webext']}, 20:14:52 INFO - 'other-e10s': {'tests': ['a11yr', 20:14:52 INFO - 'ts_paint', 20:14:52 INFO - 'tpaint', 20:14:52 INFO - 'sessionrestore', 20:14:52 INFO - 'sessionrestore_many_windows', 20:14:52 INFO - 'sessionrestore_no_auto_restore', 20:14:52 INFO - 'tabpaint']}, 20:14:52 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:14:52 INFO - 'tests': ['a11yr', 20:14:52 INFO - 'ts_paint', 20:14:52 INFO - 'tpaint', 20:14:52 INFO - 'sessionrestore', 20:14:52 INFO - 'sessionrestore_many_windows', 20:14:52 INFO - 'sessionrestore_no_auto_restore', 20:14:52 INFO - 'tabpaint']}, 20:14:52 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 20:14:52 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 20:14:52 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:14:52 INFO - 'tests': ['perf_reftest_singletons']}, 20:14:52 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:14:52 INFO - 'tests': ['perf_reftest']}, 20:14:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:14:52 INFO - 'tsvgr_opacity', 20:14:52 INFO - 'tart', 20:14:52 INFO - 'tscrollx', 20:14:52 INFO - 'tsvg_static']}, 20:14:52 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:14:52 INFO - 'tests': ['tsvgx', 20:14:52 INFO - 'tsvgr_opacity', 20:14:52 INFO - 'tart', 20:14:52 INFO - 'tscrollx', 20:14:52 INFO - 'tsvg_static']}, 20:14:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:14:52 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:14:52 INFO - 'talos_options': ['--disable-stylo'], 20:14:52 INFO - 'tests': ['tp5o']}, 20:14:52 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:14:52 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 20:14:52 INFO - 'talos_options': ['--mitmproxy', 20:14:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:14:52 INFO - '--firstNonBlankPaint'], 20:14:52 INFO - 'tests': ['tp6_google', 20:14:52 INFO - 'tp6_youtube', 20:14:52 INFO - 'tp6_amazon', 20:14:52 INFO - 'tp6_facebook']}, 20:14:52 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:14:52 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 20:14:52 INFO - 'talos_options': ['--disable-stylo', 20:14:52 INFO - '--mitmproxy', 20:14:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:14:52 INFO - '--firstNonBlankPaint'], 20:14:52 INFO - 'tests': ['tp6_google', 20:14:52 INFO - 'tp6_youtube', 20:14:52 INFO - 'tp6_amazon', 20:14:52 INFO - 'tp6_facebook']}, 20:14:52 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:14:52 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 20:14:52 INFO - 'talos_options': ['--stylo-threads=1', 20:14:52 INFO - '--mitmproxy', 20:14:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:14:52 INFO - '--firstNonBlankPaint'], 20:14:52 INFO - 'tests': ['tp6_google', 20:14:52 INFO - 'tp6_youtube', 20:14:52 INFO - 'tp6_amazon', 20:14:52 INFO - 'tp6_facebook']}, 20:14:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:14:52 INFO - 'talos_options': ['--xperf_path', 20:14:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:14:52 INFO - 'tests': ['tp5n']}, 20:14:52 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:14:52 INFO - 'talos_options': ['--disable-stylo', 20:14:52 INFO - '--xperf_path', 20:14:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:14:52 INFO - 'tests': ['tp5n']}}} 20:14:52 INFO - Running post-action listener: _resource_record_post_action 20:14:52 INFO - [mozharness: 2017-09-24 03:14:52.329044Z] Finished populate-webroot step (success) 20:14:52 INFO - [mozharness: 2017-09-24 03:14:52.329133Z] Running create-virtualenv step. 20:14:52 INFO - Running pre-action listener: _resource_record_pre_action 20:14:52 INFO - Running main action method: create_virtualenv 20:14:52 INFO - Creating virtualenv /builds/slave/test/build/venv 20:14:52 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:14:52 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 20:14:52 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 20:14:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:14:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:14:53 INFO - Installing distribute.............................................................................................................................................................................................done. 20:14:53 INFO - Installing pip...............done. 20:14:53 INFO - Return code: 0 20:14:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:14:53 INFO - Reading from file tmpfile_stdout 20:14:53 INFO - Output received: 20:14:53 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:14:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:14: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:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14: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:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf849c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81d60>, '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 0xf82a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf82ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745', '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:14: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', 'pip>=1.5'] in /builds/slave/test/build 20:14: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 pip>=1.5 20:14:53 INFO - Using env: {'DISPLAY': ':0', 20:14:53 INFO - 'HOME': '/home/cltbld', 20:14:53 INFO - 'LANG': 'en_US.UTF-8', 20:14:53 INFO - 'LANGUAGE': 'en_US:en', 20:14:53 INFO - 'LOGNAME': 'cltbld', 20:14:53 INFO - 'MAIL': '/var/mail/cltbld', 20:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:53 INFO - 'MOZ_NO_REMOTE': '1', 20:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:53 INFO - 'NO_EM_RESTART': '1', 20:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:53 INFO - 'PWD': '/builds/slave/test', 20:14:53 INFO - 'SHELL': '/bin/bash', 20:14:53 INFO - 'SHLVL': '1', 20:14:53 INFO - 'TERM': 'linux', 20:14:53 INFO - 'TMOUT': '86400', 20:14:53 INFO - 'USER': 'cltbld', 20:14:53 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745', 20:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:53 INFO - '_': '/tools/buildbot/bin/python'} 20:14:55 INFO - Ignoring indexes: http://pypi.python.org/simple/ 20:14:55 INFO - Downloading/unpacking pip>=1.5 20:14:55 INFO - Running setup.py egg_info for package pip 20:14:55 INFO - warning: no files found matching 'pip/cacert.pem' 20:14:55 INFO - warning: no files found matching '*.html' under directory 'docs' 20:14:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 20:14:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 20:14:55 INFO - Installing collected packages: pip 20:14:55 INFO - Found existing installation: pip 1.1 20:14:55 INFO - Uninstalling pip: 20:14:55 INFO - Successfully uninstalled pip 20:14:55 INFO - Running setup.py install for pip 20:14:55 INFO - warning: no files found matching 'pip/cacert.pem' 20:14:55 INFO - warning: no files found matching '*.html' under directory 'docs' 20:14:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 20:14:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 20:14:55 INFO - Installing pip script to /builds/slave/test/build/venv/bin 20:14:55 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 20:14:55 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 20:14:55 INFO - Successfully installed pip 20:14:55 INFO - Cleaning up... 20:14:55 INFO - Return code: 0 20:14:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf849c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81d60>, '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 0xf82a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf82ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745', '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:14:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:14:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:14:55 INFO - Using env: {'DISPLAY': ':0', 20:14:55 INFO - 'HOME': '/home/cltbld', 20:14:55 INFO - 'LANG': 'en_US.UTF-8', 20:14:55 INFO - 'LANGUAGE': 'en_US:en', 20:14:55 INFO - 'LOGNAME': 'cltbld', 20:14:55 INFO - 'MAIL': '/var/mail/cltbld', 20:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:55 INFO - 'MOZ_NO_REMOTE': '1', 20:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:55 INFO - 'NO_EM_RESTART': '1', 20:14:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:55 INFO - 'PWD': '/builds/slave/test', 20:14:55 INFO - 'SHELL': '/bin/bash', 20:14:55 INFO - 'SHLVL': '1', 20:14:55 INFO - 'TERM': 'linux', 20:14:55 INFO - 'TMOUT': '86400', 20:14:55 INFO - 'USER': 'cltbld', 20:14:55 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745', 20:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:55 INFO - '_': '/tools/buildbot/bin/python'} 20:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:55 INFO - Downloading/unpacking psutil>=3.1.1 20:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:14:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:14:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:14:56 INFO - Installing collected packages: psutil 20:14:56 INFO - Running setup.py install for psutil 20:14:56 INFO - building 'psutil._psutil_linux' extension 20:14:56 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:14:58 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:14:58 INFO - building 'psutil._psutil_posix' extension 20:14:58 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:14:58 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:14:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:14:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:14:58 INFO - Successfully installed psutil 20:14:58 INFO - Cleaning up... 20:14:58 INFO - Return code: 0 20:14:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:14:58 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:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:58 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:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:58 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 0xc171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf849c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81d60>, '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 0xf82a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf82ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745', '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:14:58 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:14:58 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:14:58 INFO - Using env: {'DISPLAY': ':0', 20:14:58 INFO - 'HOME': '/home/cltbld', 20:14:58 INFO - 'LANG': 'en_US.UTF-8', 20:14:58 INFO - 'LANGUAGE': 'en_US:en', 20:14:58 INFO - 'LOGNAME': 'cltbld', 20:14:58 INFO - 'MAIL': '/var/mail/cltbld', 20:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:58 INFO - 'MOZ_NO_REMOTE': '1', 20:14:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:58 INFO - 'NO_EM_RESTART': '1', 20:14:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:58 INFO - 'PWD': '/builds/slave/test', 20:14:58 INFO - 'SHELL': '/bin/bash', 20:14:58 INFO - 'SHLVL': '1', 20:14:58 INFO - 'TERM': 'linux', 20:14:58 INFO - 'TMOUT': '86400', 20:14:58 INFO - 'USER': 'cltbld', 20:14:58 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745', 20:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:58 INFO - '_': '/tools/buildbot/bin/python'} 20:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:14: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:14: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:14: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:14: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:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:15:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:15:00 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:00 INFO - Installing collected packages: mozsystemmonitor 20:15:00 INFO - Running setup.py install for mozsystemmonitor 20:15:00 INFO - Successfully installed mozsystemmonitor 20:15:00 INFO - Cleaning up... 20:15:00 INFO - Return code: 0 20:15:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:00 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 0xc171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf849c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81d60>, '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 0xf82a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf82ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745', '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:00 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:00 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:00 INFO - Using env: {'DISPLAY': ':0', 20:15:00 INFO - 'HOME': '/home/cltbld', 20:15:00 INFO - 'LANG': 'en_US.UTF-8', 20:15:00 INFO - 'LANGUAGE': 'en_US:en', 20:15:00 INFO - 'LOGNAME': 'cltbld', 20:15:00 INFO - 'MAIL': '/var/mail/cltbld', 20:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:00 INFO - 'MOZ_NO_REMOTE': '1', 20:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:00 INFO - 'NO_EM_RESTART': '1', 20:15:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:00 INFO - 'PWD': '/builds/slave/test', 20:15:00 INFO - 'SHELL': '/bin/bash', 20:15:00 INFO - 'SHLVL': '1', 20:15:00 INFO - 'TERM': 'linux', 20:15:00 INFO - 'TMOUT': '86400', 20:15:00 INFO - 'USER': 'cltbld', 20:15:00 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745', 20:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:00 INFO - '_': '/tools/buildbot/bin/python'} 20:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:00 INFO - Downloading/unpacking jsonschema==2.5.1 20:15: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:15: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:15: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:15: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:15:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:15:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:15: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:15: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:15: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:15: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:15:01 INFO - Downloading functools32-3.2.3-2.tar.gz 20:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:15:01 INFO - warning: no files found matching '*.txt' 20:15:01 INFO - no previously-included directories found matching 'build' 20:15:01 INFO - no previously-included directories found matching 'dist' 20:15:01 INFO - no previously-included directories found matching '.git*' 20:15:01 INFO - Installing collected packages: jsonschema, functools32 20:15:01 INFO - Running setup.py install for functools32 20:15:02 INFO - warning: no files found matching '*.txt' 20:15:02 INFO - no previously-included directories found matching 'build' 20:15:02 INFO - no previously-included directories found matching 'dist' 20:15:02 INFO - no previously-included directories found matching '.git*' 20:15:02 INFO - Successfully installed jsonschema functools32 20:15:02 INFO - Cleaning up... 20:15:02 INFO - Return code: 0 20:15:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:15: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:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15: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:15:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:02 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 0xc171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf849c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81d60>, '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 0xf82a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf82ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745', '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:02 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:02 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:02 INFO - Using env: {'DISPLAY': ':0', 20:15:02 INFO - 'HOME': '/home/cltbld', 20:15:02 INFO - 'LANG': 'en_US.UTF-8', 20:15:02 INFO - 'LANGUAGE': 'en_US:en', 20:15:02 INFO - 'LOGNAME': 'cltbld', 20:15:02 INFO - 'MAIL': '/var/mail/cltbld', 20:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:02 INFO - 'MOZ_NO_REMOTE': '1', 20:15:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:02 INFO - 'NO_EM_RESTART': '1', 20:15:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:02 INFO - 'PWD': '/builds/slave/test', 20:15:02 INFO - 'SHELL': '/bin/bash', 20:15:02 INFO - 'SHLVL': '1', 20:15:02 INFO - 'TERM': 'linux', 20:15:02 INFO - 'TMOUT': '86400', 20:15:02 INFO - 'USER': 'cltbld', 20:15:02 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745', 20:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:02 INFO - '_': '/tools/buildbot/bin/python'} 20:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:15:02 INFO - Cleaning up... 20:15:02 INFO - Return code: 0 20:15:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:15: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:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15: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:15:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:02 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 0xc171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf849c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81d60>, '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 0xf82a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf82ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745', '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:02 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:02 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:02 INFO - Using env: {'DISPLAY': ':0', 20:15:02 INFO - 'HOME': '/home/cltbld', 20:15:02 INFO - 'LANG': 'en_US.UTF-8', 20:15:02 INFO - 'LANGUAGE': 'en_US:en', 20:15:02 INFO - 'LOGNAME': 'cltbld', 20:15:02 INFO - 'MAIL': '/var/mail/cltbld', 20:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:02 INFO - 'MOZ_NO_REMOTE': '1', 20:15:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:02 INFO - 'NO_EM_RESTART': '1', 20:15:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:02 INFO - 'PWD': '/builds/slave/test', 20:15:02 INFO - 'SHELL': '/bin/bash', 20:15:02 INFO - 'SHLVL': '1', 20:15:02 INFO - 'TERM': 'linux', 20:15:02 INFO - 'TMOUT': '86400', 20:15:02 INFO - 'USER': 'cltbld', 20:15:02 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745', 20:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:02 INFO - '_': '/tools/buildbot/bin/python'} 20:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:02 INFO - Downloading/unpacking blobuploader==1.2.4 20:15:02 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:02 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:02 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:02 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:03 INFO - Downloading blobuploader-1.2.4.tar.gz 20:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:15:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:15:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:15:04 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:04 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:04 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:04 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:04 INFO - Downloading docopt-0.6.1.tar.gz 20:15:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:15:04 INFO - Installing collected packages: blobuploader, requests, docopt 20:15:04 INFO - Running setup.py install for blobuploader 20:15:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:15:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:15:04 INFO - Running setup.py install for requests 20:15:04 INFO - Running setup.py install for docopt 20:15:04 INFO - Successfully installed blobuploader requests docopt 20:15:04 INFO - Cleaning up... 20:15:04 INFO - Return code: 0 20:15:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:15:04 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:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:04 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:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:04 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 0xc171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf849c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81d60>, '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 0xf82a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf82ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745', '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:04 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:15:04 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:15:04 INFO - Using env: {'DISPLAY': ':0', 20:15:04 INFO - 'HOME': '/home/cltbld', 20:15:04 INFO - 'LANG': 'en_US.UTF-8', 20:15:04 INFO - 'LANGUAGE': 'en_US:en', 20:15:04 INFO - 'LOGNAME': 'cltbld', 20:15:04 INFO - 'MAIL': '/var/mail/cltbld', 20:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:04 INFO - 'MOZ_NO_REMOTE': '1', 20:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:04 INFO - 'NO_EM_RESTART': '1', 20:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:04 INFO - 'PWD': '/builds/slave/test', 20:15:04 INFO - 'SHELL': '/bin/bash', 20:15:04 INFO - 'SHLVL': '1', 20:15:04 INFO - 'TERM': 'linux', 20:15:04 INFO - 'TMOUT': '86400', 20:15:04 INFO - 'USER': 'cltbld', 20:15:04 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745', 20:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:04 INFO - '_': '/tools/buildbot/bin/python'} 20:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:15:05 INFO - Running setup.py (path:/tmp/pip-DwSjf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:15:05 INFO - Running setup.py (path:/tmp/pip-Ft9Aa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:15:05 INFO - Running setup.py (path:/tmp/pip-hWbxkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:15:05 INFO - Running setup.py (path:/tmp/pip-t1LGCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:15:05 INFO - Running setup.py (path:/tmp/pip-UTEQpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:15:05 INFO - Running setup.py (path:/tmp/pip-XPeFty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:15:05 INFO - Running setup.py (path:/tmp/pip-dpT8iB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:15:05 INFO - Running setup.py (path:/tmp/pip-ehg04E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:15:05 INFO - Running setup.py (path:/tmp/pip-oWWTyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:15:05 INFO - Running setup.py (path:/tmp/pip-BDlFQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:15:05 INFO - Running setup.py (path:/tmp/pip-mR0c_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:15:05 INFO - Running setup.py (path:/tmp/pip-nUXjEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:15:05 INFO - Running setup.py (path:/tmp/pip-pZOE_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:15:05 INFO - Running setup.py (path:/tmp/pip-N_dkk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:15:06 INFO - Running setup.py (path:/tmp/pip-5dDRPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:15:06 INFO - Running setup.py (path:/tmp/pip-tLXRHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:15:06 INFO - Running setup.py (path:/tmp/pip-RdEFWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:15:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:15:06 INFO - Running setup.py install for manifestparser 20:15:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:15:06 INFO - Running setup.py install for mozcrash 20:15:06 INFO - Running setup.py install for mozdebug 20:15:06 INFO - Running setup.py install for mozdevice 20:15:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:15:06 INFO - Running setup.py install for mozfile 20:15:06 INFO - Running setup.py install for mozhttpd 20:15:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:15:06 INFO - Running setup.py install for mozinfo 20:15:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:15:06 INFO - Running setup.py install for mozInstall 20:15:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:15:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:15:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:15:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:15:07 INFO - Running setup.py install for mozleak 20:15:07 INFO - Running setup.py install for mozlog 20:15:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:15:07 INFO - Running setup.py install for moznetwork 20:15:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:15:07 INFO - Running setup.py install for mozprocess 20:15:07 INFO - Running setup.py install for mozprofile 20:15:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:15:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:15:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:15:07 INFO - Running setup.py install for mozrunner 20:15:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:15:07 INFO - Running setup.py install for mozscreenshot 20:15:07 INFO - Running setup.py install for moztest 20:15:07 INFO - Running setup.py install for mozversion 20:15:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:15:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:15:07 INFO - Cleaning up... 20:15:07 INFO - Return code: 0 20:15:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:15:07 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:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:07 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:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:08 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 0xc171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf849c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81d60>, '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 0xf82a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf82ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745', '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:08 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:15:08 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:15:08 INFO - Using env: {'DISPLAY': ':0', 20:15:08 INFO - 'HOME': '/home/cltbld', 20:15:08 INFO - 'LANG': 'en_US.UTF-8', 20:15:08 INFO - 'LANGUAGE': 'en_US:en', 20:15:08 INFO - 'LOGNAME': 'cltbld', 20:15:08 INFO - 'MAIL': '/var/mail/cltbld', 20:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:08 INFO - 'MOZ_NO_REMOTE': '1', 20:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:08 INFO - 'NO_EM_RESTART': '1', 20:15:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:08 INFO - 'PWD': '/builds/slave/test', 20:15:08 INFO - 'SHELL': '/bin/bash', 20:15:08 INFO - 'SHLVL': '1', 20:15:08 INFO - 'TERM': 'linux', 20:15:08 INFO - 'TMOUT': '86400', 20:15:08 INFO - 'USER': 'cltbld', 20:15:08 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745', 20:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:08 INFO - '_': '/tools/buildbot/bin/python'} 20:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:15:08 INFO - Running setup.py (path:/tmp/pip-a1EGm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:15:08 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:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:15:08 INFO - Running setup.py (path:/tmp/pip-D4X57H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:15:08 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:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:15:08 INFO - Running setup.py (path:/tmp/pip-AuSQGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:15:08 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:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:15:08 INFO - Running setup.py (path:/tmp/pip-pak_0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:15:08 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:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:15:08 INFO - Running setup.py (path:/tmp/pip-QpYY7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:15:08 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:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:15:08 INFO - Running setup.py (path:/tmp/pip-pbd2Pn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:15:08 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:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:15:08 INFO - Running setup.py (path:/tmp/pip-bMX2tY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:15:08 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:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:15:08 INFO - Running setup.py (path:/tmp/pip-tq348X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:15:08 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:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:15:08 INFO - Running setup.py (path:/tmp/pip-_AerNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:15:08 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:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:15:08 INFO - Running setup.py (path:/tmp/pip-47UL5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:15:08 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:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:15:08 INFO - Running setup.py (path:/tmp/pip-opNCR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:15:09 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:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:15:09 INFO - Running setup.py (path:/tmp/pip-ze9c8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:15:09 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:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:15:09 INFO - Running setup.py (path:/tmp/pip-B7ONdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:15:09 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:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:15:09 INFO - Running setup.py (path:/tmp/pip-rbfNyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:15:09 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:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:15:09 INFO - Running setup.py (path:/tmp/pip-vS3UFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:15:09 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:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:15:09 INFO - Running setup.py (path:/tmp/pip-Fy7FQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:15:09 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:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:15:09 INFO - Running setup.py (path:/tmp/pip-LlLdPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:15:09 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:15:09 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:15:09 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:15:09 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:15:09 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:15:09 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:15:09 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:15:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:15:09 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:09 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:09 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:09 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:10 INFO - Downloading blessings-1.6.tar.gz 20:15:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:15:10 INFO - Installing collected packages: blessings 20:15:10 INFO - Running setup.py install for blessings 20:15:10 INFO - Successfully installed blessings 20:15:10 INFO - Cleaning up... 20:15:10 INFO - Return code: 0 20:15:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:15:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:15:11 INFO - Reading from file tmpfile_stdout 20:15:11 INFO - Current package versions: 20:15:11 INFO - argparse == 1.2.1 20:15:11 INFO - blessings == 1.6 20:15:11 INFO - blobuploader == 1.2.4 20:15:11 INFO - docopt == 0.6.1 20:15:11 INFO - functools32 == 3.2.3-2 20:15:11 INFO - jsonschema == 2.5.1 20:15:11 INFO - manifestparser == 1.1 20:15:11 INFO - mozInstall == 1.13 20:15:11 INFO - mozcrash == 1.0 20:15:11 INFO - mozdebug == 0.1 20:15:11 INFO - mozdevice == 0.51 20:15:11 INFO - mozfile == 1.2 20:15:11 INFO - mozhttpd == 0.7 20:15:11 INFO - mozinfo == 0.10 20:15:11 INFO - mozleak == 0.1 20:15:11 INFO - mozlog == 3.5 20:15:11 INFO - moznetwork == 0.27 20:15:11 INFO - mozprocess == 0.25 20:15:11 INFO - mozprofile == 0.28 20:15:11 INFO - mozrunner == 6.13 20:15:11 INFO - mozscreenshot == 0.1 20:15:11 INFO - mozsystemmonitor == 0.3 20:15:11 INFO - moztest == 0.8 20:15:11 INFO - mozversion == 1.4 20:15:11 INFO - psutil == 3.1.1 20:15:11 INFO - requests == 1.2.3 20:15:11 INFO - wsgiref == 0.1.2 20:15:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:15: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:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15: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:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:11 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 0xc171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf849c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81d60>, '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 0xf82a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf82ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745', '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:11 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:15:11 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:15:11 INFO - Using env: {'DISPLAY': ':0', 20:15:11 INFO - 'HOME': '/home/cltbld', 20:15:11 INFO - 'LANG': 'en_US.UTF-8', 20:15:11 INFO - 'LANGUAGE': 'en_US:en', 20:15:11 INFO - 'LOGNAME': 'cltbld', 20:15:11 INFO - 'MAIL': '/var/mail/cltbld', 20:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:11 INFO - 'MOZ_NO_REMOTE': '1', 20:15:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:11 INFO - 'NO_EM_RESTART': '1', 20:15:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:11 INFO - 'PWD': '/builds/slave/test', 20:15:11 INFO - 'SHELL': '/bin/bash', 20:15:11 INFO - 'SHLVL': '1', 20:15:11 INFO - 'TERM': 'linux', 20:15:11 INFO - 'TMOUT': '86400', 20:15:11 INFO - 'USER': 'cltbld', 20:15:11 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745', 20:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:11 INFO - '_': '/tools/buildbot/bin/python'} 20:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:11 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:15:11 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:15:11 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:15:11 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:15:11 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:15:11 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:15:11 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:15:11 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:15:11 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:15:11 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 20:15:11 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:11 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:11 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:11 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:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 20:15:12 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:15:12 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:15:12 INFO - Installing collected packages: simplejson 20:15:12 INFO - Running setup.py install for simplejson 20:15:12 INFO - building 'simplejson._speedups' extension 20:15:12 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:15:13 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:15:13 INFO - Successfully installed simplejson 20:15:13 INFO - Cleaning up... 20:15:13 INFO - Return code: 0 20:15:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:15:13 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:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:13 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:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:13 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 0xc171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf849c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81d60>, '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 0xf82a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf82ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745', '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:13 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:15:13 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:15:13 INFO - Using env: {'DISPLAY': ':0', 20:15:13 INFO - 'HOME': '/home/cltbld', 20:15:13 INFO - 'LANG': 'en_US.UTF-8', 20:15:13 INFO - 'LANGUAGE': 'en_US:en', 20:15:13 INFO - 'LOGNAME': 'cltbld', 20:15:13 INFO - 'MAIL': '/var/mail/cltbld', 20:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:13 INFO - 'MOZ_NO_REMOTE': '1', 20:15:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:13 INFO - 'NO_EM_RESTART': '1', 20:15:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:13 INFO - 'PWD': '/builds/slave/test', 20:15:13 INFO - 'SHELL': '/bin/bash', 20:15:13 INFO - 'SHLVL': '1', 20:15:13 INFO - 'TERM': 'linux', 20:15:13 INFO - 'TMOUT': '86400', 20:15:13 INFO - 'USER': 'cltbld', 20:15:13 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745', 20:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:13 INFO - '_': '/tools/buildbot/bin/python'} 20:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:15:13 INFO - Cleaning up... 20:15:13 INFO - Return code: 0 20:15:13 INFO - Running post-action listener: _resource_record_post_action 20:15:13 INFO - Running post-action listener: _start_resource_monitoring 20:15:13 INFO - Starting resource monitoring. 20:15:13 INFO - [mozharness: 2017-09-24 03:15:13.761447Z] Finished create-virtualenv step (success) 20:15:13 INFO - [mozharness: 2017-09-24 03:15:13.762455Z] Running install step. 20:15:13 INFO - Running pre-action listener: _resource_record_pre_action 20:15:13 INFO - Running main action method: install 20:15:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:15:13 INFO - Reading from file tmpfile_stdout 20:15:13 INFO - Detecting whether we're running mozinstall >=1.0... 20:15:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:15:14 INFO - Reading from file tmpfile_stdout 20:15:14 INFO - Output received: 20:15:14 INFO - Usage: mozinstall [options] installer 20:15:14 INFO - Options: 20:15:14 INFO - -h, --help show this help message and exit 20:15:14 INFO - -d DEST, --destination=DEST 20:15:14 INFO - Directory to install application into. [default: 20:15:14 INFO - "/builds/slave/test"] 20:15:14 INFO - --app=APP Application being installed. [default: firefox] 20:15:14 INFO - mkdir: /builds/slave/test/build/application 20:15:14 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:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 20:15:31 INFO - Reading from file tmpfile_stdout 20:15:31 INFO - Output received: 20:15:31 INFO - /builds/slave/test/build/application/firefox/firefox 20:15:31 INFO - Running post-action listener: _resource_record_post_action 20:15:31 INFO - [mozharness: 2017-09-24 03:15:31.934726Z] Finished install step (success) 20:15:31 INFO - [mozharness: 2017-09-24 03:15:31.935063Z] Running setup-mitmproxy step. 20:15:31 INFO - Running pre-action listener: _resource_record_pre_action 20:15:31 INFO - Running main action method: setup_mitmproxy 20:15:31 INFO - Skipping: mitmproxy is not required 20:15:31 INFO - Running post-action listener: _resource_record_post_action 20:15:31 INFO - [mozharness: 2017-09-24 03:15:31.936734Z] Finished setup-mitmproxy step (success) 20:15:31 INFO - [mozharness: 2017-09-24 03:15:31.937044Z] Running run-tests step. 20:15:31 INFO - Running pre-action listener: _resource_record_pre_action 20:15:31 INFO - Running pre-action listener: _set_gcov_prefix 20:15:31 INFO - Running main action method: run_tests 20:15:31 WARNING - Try message not found. 20:15:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:15:31 INFO - Python 2.7.3 20:15:31 INFO - Return code: 0 20:15:31 INFO - grabbing minidump binary from tooltool 20:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:31 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 0xf81d60>, '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 0xf82a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf82ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:15:31 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:15:31 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:15:31 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:15:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:15:32 INFO - Return code: 0 20:15:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:15:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:15:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:15:32 INFO - ENV: RUST_BACKTRACE is now full 20:15:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:15:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:15:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-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-083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:15:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-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-083 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:15:32 INFO - Using env: {'DISPLAY': ':0', 20:15:32 INFO - 'HOME': '/home/cltbld', 20:15:32 INFO - 'LANG': 'en_US.UTF-8', 20:15:32 INFO - 'LANGUAGE': 'en_US:en', 20:15:32 INFO - 'LOGNAME': 'cltbld', 20:15:32 INFO - 'MAIL': '/var/mail/cltbld', 20:15:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:15:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:15:32 INFO - 'MOZ_ACCELERATED': '1', 20:15:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:32 INFO - 'MOZ_NO_REMOTE': '1', 20:15:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:15:32 INFO - 'MOZ_WEBRENDER': '1', 20:15:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:32 INFO - 'NO_EM_RESTART': '1', 20:15:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:32 INFO - 'PWD': '/builds/slave/test', 20:15:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:15:32 INFO - 'RUST_BACKTRACE': 'full', 20:15:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 20:15:32 INFO - 'SHELL': '/bin/bash', 20:15:32 INFO - 'SHLVL': '1', 20:15:32 INFO - 'TERM': 'linux', 20:15:32 INFO - 'TMOUT': '86400', 20:15:32 INFO - 'USER': 'cltbld', 20:15:32 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745', 20:15:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:32 INFO - '_': '/tools/buildbot/bin/python'} 20:15:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-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-083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:15:32 INFO - mozversion application_buildid: 20170924022042 20:15:32 INFO - mozversion application_changeset: ff40c5dcaa41261b39a4e9795e02a9d51dd30ced 20:15:32 INFO - mozversion application_display_name: Nightly 20:15:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:15:32 INFO - mozversion application_name: Firefox 20:15:32 INFO - mozversion application_remotingname: firefox 20:15:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:15:32 INFO - mozversion application_vendor: Mozilla 20:15:32 INFO - mozversion application_version: 58.0a1 20:15:32 INFO - mozversion platform_buildid: 20170924022042 20:15:32 INFO - mozversion platform_changeset: ff40c5dcaa41261b39a4e9795e02a9d51dd30ced 20:15:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:15:32 INFO - mozversion platform_version: 58.0a1 20:15:32 INFO - using testdate: 1506222932 20:15:32 INFO - actual date: 1506222932 20:15:32 INFO - starting webserver on 'localhost:44693' 20:15:32 INFO - SUITE-START | Running 2 tests 20:15:32 INFO - TEST-START | dromaeo_css 20:15:32 INFO - Initialising browser for dromaeo_css test... 20:15:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44693/getInfo.html -profile /tmp/tmpCwS0TH/profile 20:15:32 INFO - TEST-INFO | started process 3526 (/builds/slave/test/build/application/firefox/firefox http://localhost:44693/getInfo.html) 20:15:43 INFO - TEST-INFO | 3526: exit 0 20:15:43 INFO - Browser initialized. 20:15:43 INFO - Running cycle 1/1 for dromaeo_css test... 20:15:43 INFO - Using env: {'DISPLAY': ':0', 20:15:43 INFO - 'HOME': '/home/cltbld', 20:15:43 INFO - 'JSGC_DISABLE_POISONING': '1', 20:15:43 INFO - 'LANG': 'en_US.UTF-8', 20:15:43 INFO - 'LANGUAGE': 'en_US:en', 20:15:43 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 20:15:43 INFO - 'LOGNAME': 'cltbld', 20:15:43 INFO - 'MAIL': '/var/mail/cltbld', 20:15:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:15:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:15:43 INFO - 'MOZ_ACCELERATED': '1', 20:15:43 INFO - 'MOZ_CRASHREPORTER': '1', 20:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:43 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 20:15:43 INFO - 'MOZ_NO_REMOTE': '1', 20:15:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:15:43 INFO - 'MOZ_WEBRENDER': '1', 20:15:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:43 INFO - 'NO_EM_RESTART': '1', 20:15:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:43 INFO - 'PWD': '/builds/slave/test', 20:15:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:15:43 INFO - 'RUST_BACKTRACE': 'full', 20:15:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 20:15:43 INFO - 'SHELL': '/bin/bash', 20:15:43 INFO - 'SHLVL': '1', 20:15:43 INFO - 'TERM': 'linux', 20:15:43 INFO - 'TMOUT': '86400', 20:15:43 INFO - 'USER': 'cltbld', 20:15:43 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745', 20:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:43 INFO - '_': '/tools/buildbot/bin/python'} 20:15:43 INFO - TEST-INFO | started process 3777 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCwS0TH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:15:44 INFO - PID 3777 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 20:15:44 INFO - PID 3777 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 20:15:45 INFO - PID 3777 | 20:15:45 INFO - PID 3777 | (/builds/slave/test/build/application/firefox/firefox:3837): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:15:45 INFO - PID 3777 | 20:15:55 INFO - PID 3777 | RSS: Main: 205574144 20:15:55 INFO - PID 3777 | 20:18:52 INFO - PID 3777 | Cycle 1(1): loaded http://localhost:44693/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44693/tests/dromaeo/cssquery-ext.html) 20:18:54 INFO - PID 3777 | RSS: Main: 207183872 20:18:54 INFO - PID 3777 | 20:21:56 INFO - PID 3777 | Cycle 1(1): loaded http://localhost:44693/tests/dromaeo/cssquery-ext.html (next: http://localhost:44693/tests/dromaeo/cssquery-jquery.html) 20:21:57 INFO - PID 3777 | RSS: Main: 211480576 20:21:57 INFO - PID 3777 | 20:24:59 INFO - PID 3777 | Cycle 1(1): loaded http://localhost:44693/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44693/tests/dromaeo/cssquery-mootools.html) 20:25:00 INFO - PID 3777 | RSS: Main: 210182144 20:25:00 INFO - PID 3777 | 20:28:02 INFO - PID 3777 | Cycle 1(1): loaded http://localhost:44693/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44693/tests/dromaeo/cssquery-prototype.html) 20:28:02 INFO - PID 3777 | RSS: Main: 209022976 20:28:02 INFO - PID 3777 | 20:31:06 INFO - PID 3777 | Cycle 1(1): loaded http://localhost:44693/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44693/tests/dromaeo/cssquery-yui.html) 20:31:07 INFO - PID 3777 | RSS: Main: 213319680 20:31:07 INFO - PID 3777 | 20:34:09 INFO - PID 3777 | Cycle 1(1): loaded http://localhost:44693/tests/dromaeo/cssquery-yui.html (next: http://localhost:44693/tests/dromaeo/cssquery-dojo.html) 20:34:09 INFO - PID 3777 | RSS: Main: 212484096 20:34:09 INFO - PID 3777 | 20:34:09 INFO - PID 3777 | __start_tp_report 20:34:09 INFO - PID 3777 | _x_x_mozilla_page_load 20:34:09 INFO - PID 3777 | _x_x_mozilla_page_load_details 20:34:09 INFO - PID 3777 | |i|pagename|runs| 20:34:09 INFO - PID 3777 | |0;dojo.html;3132.7807053506262;3145.2451411661195;3155.2742869140097;3157.305392813581;3159.210197450637;6191.133241346215;6215.440610345068;6329.525285603581;6330.936690633098;6378.521610879191;6213.502919766419;6280.717367718452;6357.427831495164;6455.870882582346;6483.254425741041;5820.82537523875;5869.295684517864;5880.029795083806;5918.319393269786;5940.584159108864;5731.856703582402;5802.709864506758;5820.330661973885;5847.532197424196;5898.439648233411;5787;5831.154482600021;5848.883022339572;5878.882422351529;5908.172855800149;5784.537237021028;5791.536677065867;5870.060790273578;5882.205902203191;5893.204417403681;5787.681677507735;5813.302403711539;5842.824715258549;5845.503132233765;5852.414758524156;6114.602550834182;6176.567640265183;6345.143405640226;6377.457916077139;6397.776077837299;6587.11074005008;6668.899966500507;6705.631190284533;6769.661516924183;6881.690323935435;6919.619420931846;6926.896096558556;6931.965340173318;6951.304869513008;6963.617001064939;6367.554271201017;6391.328910464427;6395.20059992501;6400.135981642512;6402.679866006681;6913.481488888354;6982.162140543167;7000.159980802337;7049.118860142482;7076.504644674823;6413.935860641333;6598.472122230306;6704.932950670431;6779.423748981392;6802.625855577891;6706.5640733352175;6721.428678562279;6739.494537909578;6746.359095885883;6753.425958793459;6613.537052406382;6638.601683898885;6646.53474256807;6728.798136055926;6773.254941956381;6766.898496522556;6818.249992500821;6856.417204537571;6874.9656251719425;6906.412954898789;5220.451852555503;5275.419703832576;5330.573554115739;5349.4650534946195;5355.410904800468;4623.42207224097;4653.581177694024;4663.533646635377;4688.929666055012;4702.412198475191;5680.886382272414;5825.970870145622;5829.76680932758;5834.416558344216;5834.620749651259;6876.140482439695;6925.099737034254;6945.062416573698;6950.374466297956;6959.338862808025;5803.419658034163;5883.264591926009;5917.5857689961285;5921.259842519685;5926.377730338339;5673.375928647845;5848.498217888478;5932.377100404482;5937.346891841894;5948.7323070461935;6530.314316996742;6542.476601871839;6549.508786840911;6562.343765623399;6572.934270657232;6671.33286671329;6704.6982885769285;6779.220389655253;6782.593044417351;6900.378965893094;6524.934750652433;6646.567973081735;6669.166354205724;6679.632620205935;6686.0973768540625;6661.700968311133;6725.663716814041;6727.226368967631;6798.660066996532;6799.048133261248;6629.502787290876;6709.865802684017;6790.8641827164165;6824.249332573314;6902.482313826383;6456.709448074942;6525.477961762953;6537.934620653923;6552.6723663815665;6554.820132376218;6482.546221764431;6492.675366231575;6525.608463492205;6549.4760419167305;6703.329667033453;6549.705263263069;6604.315899445611;6618.503612229199;6628.436582890316;6660.167479065117;6634.767783127568;6670.799876003728;6707.429868461236;6761.492888033516;6762.932370676231;6153.353897840662;6310.6213627182515;6328.778492752732;6331.873362532816;6345.90481142774 20:34:09 INFO - PID 3777 | |1;ext.html;816.644759529605;823.9999999999999;824.1181935329197;828.6643909216765;852.9701460448883;39307.99999999996;39578.60421395785;39824;39996.80001599995;40085.19829603406;36753.08117297069;36836.44745328822;36871;36941.44587831178;37103;7049.36555709986;7201.459890508233;7206.17129030163;7218.314260145278;7244.492885498017;7074.504784665076;7179.856402871939;7183.497155199138;7184.1019872515935;7184.928150718504;7163.355298023177;7166.355028047475;7185.568865868038;7200.675969581382;7429.2570742925545;7535.51019183754;7977.720779772709;8007.67969281228;8013.11855695873;8039.598020098972;7847.803804904866;7898.881516777253;7920.207979202091;7920.366370690331;7929.920700793034;37121.81439092787;37410.25179496422;37662.81168594167;37967.810160949295;38193.61806381928;3444.9483257751153;3451.7238620910516;3478.843452044664;3478.9478157827652;3481.617022127564;31356.21609459759;31468.527972080436;31492.37015259705;31555.36889262225;31583.684163158305;5117.232415137722;5122.001209764097;5126.897462050738;5127.897442051138;5158.845234642967;189436.0528197364;190036.04981975;190437;190844;191227;46633.30050049252;46704.532954670016;47077.058458831314;47153.52846471492;47537.286940695914;48302;48543.5145648546;48750;49047;49227.26159107616;15476;15758.054516729033;15898;16000.599985000235;16077.517674469784;13049.804252936214;13079.738405231841;13132.934335328453;13181.340932953313;13242.867571324356;13745.862541374658;13762.174269543859;13857.653558660912;13999.790003149961;14147.929260353632;5563.682294969047;5781.88436231273;5827.388124246978;5836.299644042742;5928.911066334009;984.5372674842812;994.1599348550463;1009.4397609326894;1015.441507171053;1023.672424824064;22540.887295563745;22597.548049038927;22698;23157.652635210485;23442.64836027461;1112.1825458288313;1116.7264020315074;1118.1948996722347;1125.0437128440924;1128.3737525673166;11734.589289374831;11749.4712737927;12028.635810716465;12052.156349055482;12168.14822962402;196251;197238;197530;212501;213860;39919.20161596752;40569.18861622751;50297.49702503001;50691.493085069415;50695.239571406455;1300.8894243989178;1324.9403776830065;1447.0594113825887;1453.883689304853;1468.5594321703447;27426.725732742416;27452.392022757806;27909.720902790712;28225.717742822308;28429.857850710614;37092.81453592715;37253.62746372502;37421.81289093537;37467;37473.437898431;205475;205606;206212;206233;206700;33888.83055584706;35071.824640877654;35151.29697406089;35291.29417411689;35885.820570896976;40981.79509102435;41763.37354939617;41816.581834182485;41885;42255.7887210562;29500;30120.24699382533;30716.846415767777;31093.222669433446;31182;30947.381052378376;31080.378392431572;31098.844505777328;31255.53116703297;31456.213594660316;34349.31301374009;34721.30557388889;34935.12662183466;34974.300513990085;34979.12552186216;30478.390432191674;30912.227194320323;30918;30975.380492390475;31278.06165815029;22766.31701048905;22778.43053923665;22872.199473018365;22936.197233096762;23076.769232308132 20:34:09 INFO - PID 3777 | |2;jquery.html;588.7233000489771;591.3022633292713;600.2616781358928;603.8912995660783;632.7089538812147;22628.54742905141;23264.534709305804;23419.76580234197;23453.29640110797;23491.647625285634;23413.531729365444;25639.35901602461;25987.22038338853;26260;26326.47347053058;6439.066335381367;6618.966905165467;6684.131062961808;6688.197416310025;6695.062691223233;6354.078658594501;6567.179102612174;6600.735970561196;6601.339866013408;6668.066470694107;6591;6600.372964568358;6653.401193892549;6653.733850645968;6675.132232809728;6605.768798092067;6652.434543063821;6656.301088385747;6656.467482601381;6657.900131498007;5970.313413957407;6137.723802428902;6178.752849885999;6197.969010154966;6198.783042593487;29314.85342573295;29710;29715.702842971725;29750.70249297501;29853.850730746206;2106.189117189893;2115.6826476028564;2139.775323591032;2151.268568686654;2155.611989841828;19149.329773458;19183;19570.119344629526;19591.216351345927;20149.79850201494;2427.397917374542;2435.8416702914255;2491.5016996600752;2501.762332578402;2503.5869081601513;113242;117674.41162794217;119621;137110.3144484281;138855;14974.326155323037;15160.620984475476;15183.696326073417;15230.543083707507;15485.29661737208;24056.39859003539;24146.154884578955;24150.275491735276;24152.75847241505;24165.275041748424;10102;10119.190464762802;10157.695269141937;10217.74455638615;10296.691099267035;9062.81874362509;9249.815003699889;9296.116868897443;9306.2089722373;9413.623455061721;8908;9114.954425227832;9195.356325057182;9338.066193380608;9522.714318570454;2560.9615855762177;2580.21370357987;2594.779443747265;2631.907883224116;2718.143784707811;957.7749228931195;962.592422823212;976.5995941663883;981.1513041219437;994.4431118573622;19942.20231190765;19988.20047198096;20014.88727138305;20213.292534761214;20913.477163071046;1043.4886905416442;1045.1168762395764;1053.5048527192207;1060.6287799270349;1062.6705721226444;10815.729606759736;11062.778744425066;11249.550017999352;11396.886031139748;11478.081753459703;433563;457433;458655.82688346715;461551;472573;111716.44141779402;112927.43536282267;114900.42549787364;114926;115933;1134.6879608107672;1172.6013155527162;1230.3318464781103;1243.4777393494935;1252.067209928609;21269.574608507435;21302.254421095186;21661;21790.673139902596;22002.009909553788;60417.395826041175;61647;61814.381856180866;62965.68517157385;63170.68414658081;77571.2242877564;78134.609326953;78442.6077869607;79415;81321;14672.413103475741;15119.924400378368;15185.16481593523;15235.542933712006;15351.769723454381;23166.652500212174;23268;23501.177458789545;23843.165489207793;24203.878980604983;18756.155972980974;18783.060846957324;18800.62398752045;18850.52873678169;18929;16498.25757840876;16973.236204370587;17283.913580432018;17770.822291776916;17795.19921603557;17036.829631703524;17941.282348706427;18178;18432.723509147643;18471.722924156416;15021.324040417989;15062.096274223582;15156.166410847509;15166;15185;18269.634607307515;18368.265269389074;18662.626747464703;18800.247990080243;19136.23455061782 20:34:09 INFO - PID 3777 | |3;mootools.html;1329.0829327763843;1364.2292104960698;1381.765099933011;1393.8397084335293;1395.2047333020182;15200.695986080273;15808.209589520535;15905.045697258158;15919.602009949756;15922.442714504994;15301.69396612067;15592.298346574404;15595.220238988033;15605.375784968588;15617.531474055768;2801.173653772137;2881.8991335303267;2894.594756734059;2912.635920509936;2915.2128925190186;2796.6504186976626;2840.957385639217;2841.9005334813287;2842.07632519431;2846.6014757933904;2745.8594183374266;2797.342624483245;2810.943781124376;2822.280318518785;2822.9717702822913;2619.5546757051347;2656.3757516983396;2659.175655546787;2670.9732902671017;2683.154806236049;2617.659704238437;2627.1724406811795;2648.642433271503;2649.5098406794805;2651.8541480218582;14664.193469359181;15011;15012.849871501254;15042.172680502568;15078.396864125421;8049.9195008049755;8271.875921861178;8327.250547450758;8344.8331033379;8348;5432.280994785222;5513.531349835269;5647.576431767634;5671.723862131029;5792.333881603585;1937.3509874192162;1997.9630960939437;1999.2302963359066;2045.734054572896;2051.753789545264;24488;24965.251042468753;27816.30459238515;28468.85765571159;28537.57193642097;7400.111986561647;7485.513441626277;7586.734464293833;7687.5387476751575;7702.691892324245;20795.896020520104;20880.47798805042;20900.37298881036;21096.472588185417;21116.683249751266;8450;8502.872456913028;8548.572571371407;8632.266257368068;8636.395452318277;7524.887126693104;7705.075390953121;7834.334081603128;7875.251851074138;7908.881366779503;5545.306836645419;5735.4551317624755;5826.067829147316;5869.647821130746;5899.351071382144;1729.9135043247786;1734.6530693861278;1754.877158598886;1775.6359946211255;1778.0573151434396;867.7613656244583;882.0870399136991;898.3711402018482;901.6032945503957;905.4612505559181;7638.968739220134;7936.365090792723;7997.120316765151;8026.719064832703;8072;725.7895210388928;735.3749313083836;739.3973911262304;748.1770052941721;754.0611938137055;4558.749268790249;4644.140833945731;4644.7213167210075;4655.162070827284;4700.459447163552;21689;22660.433489162573;22755.544889102126;22788.088476460754;22835.314940551478;21499.2475263365;21929.451763705714;22175.11299548;22253.332400027703;22402.775972240393;11678.24091434054;11782.88217117835;11841.171118021655;12049.939750301193;12060.276383417198;8333.499990000619;8337.95831020841;8363.498190108612;8413.95793021031;8481.363897707573;18336;18569.628607428047;18758.718619220996;18971.336003240373;19252.614947701248;18946.810531894505;19226.423207303244;20271.59456810885;20519;20685.482862928548;11755.177137600285;11833.467493962964;11848.940755296513;11884.10869184832;11909.166358354832;13612.455501779817;13658.317084145952;13689.178649281075;13750.86249137536;13772.793408099087;11140.275882067639;11675.76648467009;11787.941060294643;11821.172517924007;11886;11171.385573793194;11212.887871121511;11267.380294083903;11322.433878306216;11438.256513326607;10035.598576056876;10084.445355505517;10137.493125343852;10235;10246.6413675521;6857.27998560144;6906.758263460755;6907.20567134786;6914.8617027660175;7047.436205103477;6754.784138855053;6849.383555480031;6928;6950.20072691647;7063.434925206074 20:34:09 INFO - PID 3777 | |4;prototype.html;499.54042281101385;502.8441183233198;526.276369991262;531.7987895624566;550.7191332420464;6217.347178546255;6241.594296370744;6267.529935254851;6286.717097730601;6292.716827742751;6143.81568552943;6145.139680444741;6177.227846519174;6211.409916057979;6231.719572619231;5156.123459011977;5202.921956170641;5225.190095535198;5233.476652334774;5267.604929630274;5180.663256888309;5203.297554830087;5248.580113590903;5252.737363131828;5264.026155161288;4811.8075276988875;4983.700977941317;4991.176455884774;5006.799728010893;5125.718085505296;4934.40787105546;4980.6762560433635;4989.176785830316;5006.399232092136;5014.022265658198;4428;4438.9124664457095;4444.133393988173;4451.1097780443715;4483.618892394151;5869.505460179406;5993.910091348634;5994.8501287467725;6099.57302988791;6136.7545298188015;5689.260396148516;5699.458551437607;5701.743421546041;5717.285339332583;5728.97135514324;6537.150170477855;6547.214334279917;6578.309277525838;6584.604923704545;6620.735170593171;4715.221988371914;4866.172750632401;4883.609311255091;4911.7544122793715;4922.360093187863;6732.84548944338;6765.154355705537;6782.72869085236;6829.146356705412;6851.314868513208;4994.225894986283;5024.673396229234;5032.220005899091;5063.797448102035;5072.28987941681;5078.97460512695;5085.338905942203;5111.900941297639;5116.874287656709;5126.87182820425;5631.577631677641;5651.265335506358;5700.033488446479;5718.285214348207;5768.163616275617;6556.868862622816;6592.373724496165;6611.537192396486;6623.138991931114;6710.148187020594;1743.8779285449896;1763.1536862306166;1768.124778234782;1784.8750587459012;1787.7944036435977;1157.7626586549736;1226.270369130366;1234.962951111468;1237.4431505822415;1259.6724851538484;5631.183478395692;5634.915476267859;5671.347795003628;5675.744591493392;5682.914756278659;6545.869082618321;6616;6622.4039836413995;6651.201855777241;6697.196336439659;5581.525570326487;5624.156376543469;5644.491995720405;5649.20911072442;5680.233168522279;3474.8957531274104;3517.3317069757177;3534.8586056557965;3538.832185378819;3562.2697347043795;6334.714937827716;6399.744010239631;6415.294317625057;6478.805635830932;6503.349665033554;6550.181227346582;6852.828679283058;6861.451083913275;6918.515703900779;6966.825829354307;6197.845053873689;6351.396617321439;6382.266039405435;6486.35136486357;6486.610803351719;6488.740450381932;6641.568298060611;6658.267590564937;6736.66316684154;6736.831579210559;6506.544541882023;6651.102101216274;6691.698873550605;6735.349839289405;6762.222344430454;6443.420092191725;6465.903011454926;6469.611823290429;6501.902471462838;6516.73933042673;5013.373328333958;5024.623153263593;5024.623153263593;5041.924371134362;5053.873653158554;6519.837004074936;6625.304343043911;6685.933140668531;6698.933010669831;6781.593104413751;6338.746450141943;6428.678566071584;6444.297930152588;6538.790323790114;6597.637129957899;6367.395097465734;6499.6750162492635;6535.607863528204;6597.769078082244;6600.669966501559;6216.875662486816;6305.464035557029;6335.176427064452;6353.555251132561;6365.204349456318;6484.28672845996;6494.253160886558;6495.317991611002;6538.542302038812;6552.6068435894;6147.907781383194;6198.659073750987;6233.937660623335;6276;6278.340774218641 20:34:09 INFO - PID 3777 | |5;yui.html;908.5048648486575;918.4581097152679;921.3366376209127;927.9907200927988;935.3919952031179;19173.42479725607;19836.801631983675;19883.60232795343;19931.50171245718;19995.60008799823;18209.089545522704;18286;18324.725129123075;18340.449786506426;18571.721424178613;959.036168650507;977.8435450327949;980.127686359141;980.4950450517989;981.5533932060931;984.4634674102631;985.2364417576364;990.0891180114276;990.2573070197352;994.1500017485055;1000.9449480278582;1038.2835843268158;1044.9477526123662;1051.8264486359742;1053.2048303530862;1025.7128004158847;1029.5367084811828;1030.5671617920455;1032.7727899862018;1033.5090831854884;751.3050428353805;753.9472236943416;756.2286467802866;756.4100001998451;759.017072890608;19823.603527929507;20012.599748005105;20117.899410503;20207.69688454674;20324.79675203244;21734.565308693895;21740.782592174193;21934.780652193433;22184.445388865246;22247.777522224733;16075.839241607551;16776;16877.831221687873;16901.7464738029;16911.154442277835;3703.777773333609;3770.2836461072307;3772.302124107049;3778.074371778932;3779.6598306152578;98078;100171.49914250454;131736;138201;142211;16566.585835354213;17236.913815431093;17292.740608890625;17417.954922704677;17432.825671743372;30269.69730302669;31387.372252554822;31638.525422118688;31703.365932681216;31772.523412148836;9230.353875228804;9473.194778443909;9484.857727134098;9502.714918552454;9574.47340396271;4494.325851122292;4497.685162038626;4537.977310113428;4547.977260113678;4551.089782043605;5338.599605029638;5474.945250547444;5475.09660905946;5480.013597552399;5490.396056433789;864.3301441382979;888.6845169964698;906.8005038891565;912.32943786317;922.8800255966681;641.7112299465259;654.8231977366084;661.4509956735898;668.4351722794231;671.3554987212233;11935.224210426295;12018.519259229533;12613.30626815534;12650.683732906567;12662.240265584094;676.5636164673758;684.8904175331922;692.9722811087601;708.7696498637963;713.1976526407791;5348.786048558014;5416.997855396764;5469.480399362054;5512.91730624041;5551.500364967173;120929;122966;123062;123081.38459307826;124610.37694811467;110080.4495977515;112750.43624781823;113535.43232283786;114654.42672786582;115005;90788;91280.54359728159;93371;95164.52417737867;96504.51747741357;9997.700068997941;10379.481025948522;10422.426766527611;10441.321314114559;10683.94658026705;43304.56695433131;43518.34722479102;44294;45077.54922450733;45130;57480.71259643675;58322.4167758317;58381;58615.4138458627;59061.70469147627;14631.341589628279;14996.550103496913;15009.474668386554;15045.247737612857;15100.471483498024;17738.290468381638;17954.461366159037;17971.640567188846;17990.910045449687;18261.269549218414;15888.841111589198;15897.284622191797;15924.92037539805;16009;16120.596985075466;14948.103113813206;14956.102633842005;15020.173890435693;15228.238588070331;15423.61440963985;15649.765253521435;16182.919085404497;16339.428120015742;16451.177441128137;16618.66762664716;11436.656900293005;11503.482343294405;11577.826332605186;11740.530378784753;11802.645920622395;10996.835047474455;11051.226414150933;11075.169362298022;11102.389368584805;11138.443077846237 20:34:09 INFO - PID 3777 | __end_tp_report 20:34:09 INFO - PID 3777 | __start_cc_report 20:34:09 INFO - PID 3777 | _x_x_mozilla_cycle_collect,291 20:34:09 INFO - PID 3777 | __end_cc_report 20:34:09 INFO - PID 3777 | __startTimestamp1506224049325__endTimestamp 20:34:09 INFO - PID 3777 | 20:34:09 INFO - PID 3777 | ------- Summary: start ------- 20:34:09 INFO - PID 3777 | Number of tests: 6 20:34:09 INFO - PID 3777 | 20:34:09 INFO - PID 3777 | [#0] dojo.html Cycles:165 Average:6239.75 Median:6483.25 stddev:754.63 (11.6%) stddev-sans-first:716.50 20:34:09 INFO - PID 3777 | Values: 3132.8 3145.2 3155.3 3157.3 3159.2 6191.1 6215.4 6329.5 6330.9 6378.5 6213.5 6280.7 6357.4 6455.9 6483.3 5820.8 5869.3 5880.0 5918.3 5940.6 5731.9 5802.7 5820.3 5847.5 5898.4 5787.0 5831.2 5848.9 5878.9 5908.2 5784.5 5791.5 5870.1 5882.2 5893.2 5787.7 5813.3 5842.8 5845.5 5852.4 6114.6 6176.6 6345.1 6377.5 6397.8 6587.1 6668.9 6705.6 6769.7 6881.7 6919.6 6926.9 6932.0 6951.3 6963.6 6367.6 6391.3 6395.2 6400.1 6402.7 6913.5 6982.2 7000.2 7049.1 7076.5 6413.9 6598.5 6704.9 6779.4 6802.6 6706.6 6721.4 6739.5 6746.4 6753.4 6613.5 6638.6 6646.5 6728.8 6773.3 6766.9 6818.2 6856.4 6875.0 6906.4 5220.5 5275.4 5330.6 5349.5 5355.4 4623.4 4653.6 4663.5 4688.9 4702.4 5680.9 5826.0 5829.8 5834.4 5834.6 6876.1 6925.1 6945.1 6950.4 6959.3 5803.4 5883.3 5917.6 5921.3 5926.4 5673.4 5848.5 5932.4 5937.3 5948.7 6530.3 6542.5 6549.5 6562.3 6572.9 6671.3 6704.7 6779.2 6782.6 6900.4 6524.9 6646.6 6669.2 6679.6 6686.1 6661.7 6725.7 6727.2 6798.7 6799.0 6629.5 6709.9 6790.9 6824.2 6902.5 6456.7 6525.5 6537.9 6552.7 6554.8 6482.5 6492.7 6525.6 6549.5 6703.3 6549.7 6604.3 6618.5 6628.4 6660.2 6634.8 6670.8 6707.4 6761.5 6762.9 6153.4 6310.6 6328.8 6331.9 6345.9 20:34:09 INFO - PID 3777 | 20:34:09 INFO - PID 3777 | [#1] ext.html Cycles:180 Average:36503.50 Median:19208.37 stddev:51704.22 (269.2%) stddev-sans-first:51779.83 20:34:09 INFO - PID 3777 | Values: 816.6 824.0 824.1 828.7 853.0 39308.0 39578.6 39824.0 39996.8 40085.2 36753.1 36836.4 36871.0 36941.4 37103.0 7049.4 7201.5 7206.2 7218.3 7244.5 7074.5 7179.9 7183.5 7184.1 7184.9 7163.4 7166.4 7185.6 7200.7 7429.3 7535.5 7977.7 8007.7 8013.1 8039.6 7847.8 7898.9 7920.2 7920.4 7929.9 37121.8 37410.3 37662.8 37967.8 38193.6 3444.9 3451.7 3478.8 3478.9 3481.6 31356.2 31468.5 31492.4 31555.4 31583.7 5117.2 5122.0 5126.9 5127.9 5158.8 189436.1 190036.0 190437.0 190844.0 191227.0 46633.3 46704.5 47077.1 47153.5 47537.3 48302.0 48543.5 48750.0 49047.0 49227.3 15476.0 15758.1 15898.0 16000.6 16077.5 13049.8 13079.7 13132.9 13181.3 13242.9 13745.9 13762.2 13857.7 13999.8 14147.9 5563.7 5781.9 5827.4 5836.3 5928.9 984.5 994.2 1009.4 1015.4 1023.7 22540.9 22597.5 22698.0 23157.7 23442.6 1112.2 1116.7 1118.2 1125.0 1128.4 11734.6 11749.5 12028.6 12052.2 12168.1 196251.0 197238.0 197530.0 212501.0 213860.0 39919.2 40569.2 50297.5 50691.5 50695.2 1300.9 1324.9 1447.1 1453.9 1468.6 27426.7 27452.4 27909.7 28225.7 28429.9 37092.8 37253.6 37421.8 37467.0 37473.4 205475.0 205606.0 206212.0 206233.0 206700.0 33888.8 35071.8 35151.3 35291.3 35885.8 40981.8 41763.4 41816.6 41885.0 42255.8 29500.0 30120.2 30716.8 31093.2 31182.0 30947.4 31080.4 31098.8 31255.5 31456.2 34349.3 34721.3 34935.1 34974.3 34979.1 30478.4 30912.2 30918.0 30975.4 31278.1 22766.3 22778.4 22872.2 22936.2 23076.8 20:34:09 INFO - PID 3777 | 20:34:09 INFO - PID 3777 | [#2] jquery.html Cycles:180 Average:34065.24 Median:23436.53 stddev:77142.31 (329.2%) stddev-sans-first:77317.77 20:34:09 INFO - PID 3777 | Values: 588.7 591.3 600.3 603.9 632.7 22628.5 23264.5 23419.8 23453.3 23491.6 23413.5 25639.4 25987.2 26260.0 26326.5 6439.1 6619.0 6684.1 6688.2 6695.1 6354.1 6567.2 6600.7 6601.3 6668.1 6591.0 6600.4 6653.4 6653.7 6675.1 6605.8 6652.4 6656.3 6656.5 6657.9 5970.3 6137.7 6178.8 6198.0 6198.8 29314.9 29710.0 29715.7 29750.7 29853.9 2106.2 2115.7 2139.8 2151.3 2155.6 19149.3 19183.0 19570.1 19591.2 20149.8 2427.4 2435.8 2491.5 2501.8 2503.6 113242.0 117674.4 119621.0 137110.3 138855.0 14974.3 15160.6 15183.7 15230.5 15485.3 24056.4 24146.2 24150.3 24152.8 24165.3 10102.0 10119.2 10157.7 10217.7 10296.7 9062.8 9249.8 9296.1 9306.2 9413.6 8908.0 9115.0 9195.4 9338.1 9522.7 2561.0 2580.2 2594.8 2631.9 2718.1 957.8 962.6 976.6 981.2 994.4 19942.2 19988.2 20014.9 20213.3 20913.5 1043.5 1045.1 1053.5 1060.6 1062.7 10815.7 11062.8 11249.6 11396.9 11478.1 433563.0 457433.0 458655.8 461551.0 472573.0 111716.4 112927.4 114900.4 114926.0 115933.0 1134.7 1172.6 1230.3 1243.5 1252.1 21269.6 21302.3 21661.0 21790.7 22002.0 60417.4 61647.0 61814.4 62965.7 63170.7 77571.2 78134.6 78442.6 79415.0 81321.0 14672.4 15119.9 15185.2 15235.5 15351.8 23166.7 23268.0 23501.2 23843.2 24203.9 18756.2 18783.1 18800.6 18850.5 18929.0 16498.3 16973.2 17283.9 17770.8 17795.2 17036.8 17941.3 18178.0 18432.7 18471.7 15021.3 15062.1 15156.2 15166.0 15185.0 18269.6 18368.3 18662.6 18800.2 19136.2 20:34:09 INFO - PID 3777 | 20:34:09 INFO - PID 3777 | [#3] mootools.html Cycles:180 Average:9633.79 Median:2649.08 stddev:6971.86 (263.2%) stddev-sans-first:6963.50 20:34:09 INFO - PID 3777 | Values: 1329.1 1364.2 1381.8 1393.8 1395.2 15200.7 15808.2 15905.0 15919.6 15922.4 15301.7 15592.3 15595.2 15605.4 15617.5 2801.2 2881.9 2894.6 2912.6 2915.2 2796.7 2841.0 2841.9 2842.1 2846.6 2745.9 2797.3 2810.9 2822.3 2823.0 2619.6 2656.4 2659.2 2671.0 2683.2 2617.7 2627.2 2648.6 2649.5 2651.9 14664.2 15011.0 15012.8 15042.2 15078.4 8049.9 8271.9 8327.3 8344.8 8348.0 5432.3 5513.5 5647.6 5671.7 5792.3 1937.4 1998.0 1999.2 2045.7 2051.8 24488.0 24965.3 27816.3 28468.9 28537.6 7400.1 7485.5 7586.7 7687.5 7702.7 20795.9 20880.5 20900.4 21096.5 21116.7 8450.0 8502.9 8548.6 8632.3 8636.4 7524.9 7705.1 7834.3 7875.3 7908.9 5545.3 5735.5 5826.1 5869.6 5899.4 1729.9 1734.7 1754.9 1775.6 1778.1 867.8 882.1 898.4 901.6 905.5 7639.0 7936.4 7997.1 8026.7 8072.0 725.8 735.4 739.4 748.2 754.1 4558.7 4644.1 4644.7 4655.2 4700.5 21689.0 22660.4 22755.5 22788.1 22835.3 21499.2 21929.5 22175.1 22253.3 22402.8 11678.2 11782.9 11841.2 12049.9 12060.3 8333.5 8338.0 8363.5 8414.0 8481.4 18336.0 18569.6 18758.7 18971.3 19252.6 18946.8 19226.4 20271.6 20519.0 20685.5 11755.2 11833.5 11848.9 11884.1 11909.2 13612.5 13658.3 13689.2 13750.9 13772.8 11140.3 11675.8 11787.9 11821.2 11886.0 11171.4 11212.9 11267.4 11322.4 11438.3 10035.6 10084.4 10137.5 10235.0 10246.6 6857.3 6906.8 6907.2 6914.9 7047.4 6754.8 6849.4 6928.0 6950.2 7063.4 20:34:09 INFO - PID 3777 | 20:34:09 INFO - PID 3777 | [#4] prototype.html Cycles:180 Average:5495.94 Median:6144.48 stddev:1524.38 (24.8%) stddev-sans-first:1481.81 20:34:09 INFO - PID 3777 | Values: 499.5 502.8 526.3 531.8 550.7 6217.3 6241.6 6267.5 6286.7 6292.7 6143.8 6145.1 6177.2 6211.4 6231.7 5156.1 5202.9 5225.2 5233.5 5267.6 5180.7 5203.3 5248.6 5252.7 5264.0 4811.8 4983.7 4991.2 5006.8 5125.7 4934.4 4980.7 4989.2 5006.4 5014.0 4428.0 4438.9 4444.1 4451.1 4483.6 5869.5 5993.9 5994.9 6099.6 6136.8 5689.3 5699.5 5701.7 5717.3 5729.0 6537.2 6547.2 6578.3 6584.6 6620.7 4715.2 4866.2 4883.6 4911.8 4922.4 6732.8 6765.2 6782.7 6829.1 6851.3 4994.2 5024.7 5032.2 5063.8 5072.3 5079.0 5085.3 5111.9 5116.9 5126.9 5631.6 5651.3 5700.0 5718.3 5768.2 6556.9 6592.4 6611.5 6623.1 6710.1 1743.9 1763.2 1768.1 1784.9 1787.8 1157.8 1226.3 1235.0 1237.4 1259.7 5631.2 5634.9 5671.3 5675.7 5682.9 6545.9 6616.0 6622.4 6651.2 6697.2 5581.5 5624.2 5644.5 5649.2 5680.2 3474.9 3517.3 3534.9 3538.8 3562.3 6334.7 6399.7 6415.3 6478.8 6503.3 6550.2 6852.8 6861.5 6918.5 6966.8 6197.8 6351.4 6382.3 6486.4 6486.6 6488.7 6641.6 6658.3 6736.7 6736.8 6506.5 6651.1 6691.7 6735.3 6762.2 6443.4 6465.9 6469.6 6501.9 6516.7 5013.4 5024.6 5024.6 5041.9 5053.9 6519.8 6625.3 6685.9 6698.9 6781.6 6338.7 6428.7 6444.3 6538.8 6597.6 6367.4 6499.7 6535.6 6597.8 6600.7 6216.9 6305.5 6335.2 6353.6 6365.2 6484.3 6494.3 6495.3 6538.5 6552.6 6147.9 6198.7 6233.9 6276.0 6278.3 20:34:09 INFO - PID 3777 | 20:34:09 INFO - PID 3777 | [#5] yui.html Cycles:180 Average:23945.43 Median:20162.80 stddev:34183.36 (169.5%) stddev-sans-first:34235.49 20:34:09 INFO - PID 3777 | Values: 908.5 918.5 921.3 928.0 935.4 19173.4 19836.8 19883.6 19931.5 19995.6 18209.1 18286.0 18324.7 18340.4 18571.7 959.0 977.8 980.1 980.5 981.6 984.5 985.2 990.1 990.3 994.2 1000.9 1038.3 1044.9 1051.8 1053.2 1025.7 1029.5 1030.6 1032.8 1033.5 751.3 753.9 756.2 756.4 759.0 19823.6 20012.6 20117.9 20207.7 20324.8 21734.6 21740.8 21934.8 22184.4 22247.8 16075.8 16776.0 16877.8 16901.7 16911.2 3703.8 3770.3 3772.3 3778.1 3779.7 98078.0 100171.5 131736.0 138201.0 142211.0 16566.6 17236.9 17292.7 17418.0 17432.8 30269.7 31387.4 31638.5 31703.4 31772.5 9230.4 9473.2 9484.9 9502.7 9574.5 4494.3 4497.7 4538.0 4548.0 4551.1 5338.6 5474.9 5475.1 5480.0 5490.4 864.3 888.7 906.8 912.3 922.9 641.7 654.8 661.5 668.4 671.4 11935.2 12018.5 12613.3 12650.7 12662.2 676.6 684.9 693.0 708.8 713.2 5348.8 5417.0 5469.5 5512.9 5551.5 120929.0 122966.0 123062.0 123081.4 124610.4 110080.4 112750.4 113535.4 114654.4 115005.0 90788.0 91280.5 93371.0 95164.5 96504.5 9997.7 10379.5 10422.4 10441.3 10683.9 43304.6 43518.3 44294.0 45077.5 45130.0 57480.7 58322.4 58381.0 58615.4 59061.7 14631.3 14996.6 15009.5 15045.2 15100.5 17738.3 17954.5 17971.6 17990.9 18261.3 15888.8 15897.3 15924.9 16009.0 16120.6 14948.1 14956.1 15020.2 15228.2 15423.6 15649.8 16182.9 16339.4 16451.2 16618.7 11436.7 11503.5 11577.8 11740.5 11802.6 10996.8 11051.2 11075.2 11102.4 11138.4 20:34:09 INFO - PID 3777 | -------- Summary: end -------- 20:34:09 INFO - PID 3777 | 20:34:10 INFO - TEST-INFO | 3777: exit 0 20:34:10 INFO - TEST-OK | dromaeo_css | took 1117863ms 20:34:10 INFO - TEST-START | kraken 20:34:10 INFO - Initialising browser for kraken test... 20:34:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44693/getInfo.html -profile /tmp/tmp6SPbyl/profile 20:34:10 INFO - TEST-INFO | started process 4161 (/builds/slave/test/build/application/firefox/firefox http://localhost:44693/getInfo.html) 20:34:16 INFO - TEST-INFO | 4161: exit 0 20:34:16 INFO - Browser initialized. 20:34:16 INFO - Running cycle 1/1 for kraken test... 20:34:16 INFO - Using env: {'DISPLAY': ':0', 20:34:16 INFO - 'HOME': '/home/cltbld', 20:34:16 INFO - 'JSGC_DISABLE_POISONING': '1', 20:34:16 INFO - 'LANG': 'en_US.UTF-8', 20:34:16 INFO - 'LANGUAGE': 'en_US:en', 20:34:16 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 20:34:16 INFO - 'LOGNAME': 'cltbld', 20:34:16 INFO - 'MAIL': '/var/mail/cltbld', 20:34:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:34:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:34:16 INFO - 'MOZ_ACCELERATED': '1', 20:34:16 INFO - 'MOZ_CRASHREPORTER': '1', 20:34:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:16 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 20:34:16 INFO - 'MOZ_NO_REMOTE': '1', 20:34:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:34:16 INFO - 'MOZ_WEBRENDER': '1', 20:34:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:16 INFO - 'NO_EM_RESTART': '1', 20:34:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:16 INFO - 'PWD': '/builds/slave/test', 20:34:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:34:16 INFO - 'RUST_BACKTRACE': 'full', 20:34:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 20:34:16 INFO - 'SHELL': '/bin/bash', 20:34:16 INFO - 'SHLVL': '1', 20:34:16 INFO - 'TERM': 'linux', 20:34:16 INFO - 'TMOUT': '86400', 20:34:16 INFO - 'USER': 'cltbld', 20:34:16 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745', 20:34:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:16 INFO - '_': '/tools/buildbot/bin/python'} 20:34:16 INFO - TEST-INFO | started process 4404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6SPbyl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:34:17 INFO - PID 4404 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 20:34:17 INFO - PID 4404 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 20:34:17 INFO - PID 4404 | 20:34:17 INFO - PID 4404 | (/builds/slave/test/build/application/firefox/firefox:4465): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:34:17 INFO - PID 4404 | 20:34:28 INFO - PID 4404 | RSS: Main: 209870848 20:34:28 INFO - PID 4404 | 20:34:30 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44693/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44693/tests/kraken/driver.html?testName=audio-beat-detection) 20:34:31 INFO - PID 4404 | RSS: Main: 208973824 20:34:31 INFO - PID 4404 | 20:34:34 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44693/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44693/tests/kraken/driver.html?testName=audio-dft) 20:34:34 INFO - PID 4404 | RSS: Main: 209121280 20:34:34 INFO - PID 4404 | 20:34:37 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44693/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44693/tests/kraken/driver.html?testName=audio-fft) 20:34:38 INFO - PID 4404 | RSS: Main: 206430208 20:34:38 INFO - PID 4404 | 20:34:40 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44693/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44693/tests/kraken/driver.html?testName=audio-oscillator) 20:34:41 INFO - PID 4404 | RSS: Main: 206827520 20:34:41 INFO - PID 4404 | 20:34:43 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44693/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44693/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:34:44 INFO - PID 4404 | RSS: Main: 206561280 20:34:44 INFO - PID 4404 | 20:34:47 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44693/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44693/tests/kraken/driver.html?testName=imaging-darkroom) 20:34:48 INFO - PID 4404 | RSS: Main: 209199104 20:34:48 INFO - PID 4404 | 20:34:51 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44693/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44693/tests/kraken/driver.html?testName=imaging-desaturate) 20:34:52 INFO - PID 4404 | RSS: Main: 207036416 20:34:52 INFO - PID 4404 | 20:34:55 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44693/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44693/tests/kraken/driver.html?testName=json-parse-financial) 20:34:56 INFO - PID 4404 | RSS: Main: 208392192 20:34:56 INFO - PID 4404 | 20:34:57 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44693/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44693/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:34:58 INFO - PID 4404 | RSS: Main: 209096704 20:34:58 INFO - PID 4404 | 20:35:00 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44693/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44693/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:35:00 INFO - PID 4404 | RSS: Main: 204595200 20:35:00 INFO - PID 4404 | 20:35:02 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44693/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44693/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:35:03 INFO - PID 4404 | RSS: Main: 205955072 20:35:03 INFO - PID 4404 | 20:35:06 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44693/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44693/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:35:06 INFO - PID 4404 | RSS: Main: 206274560 20:35:06 INFO - PID 4404 | 20:35:09 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44693/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44693/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:35:10 INFO - PID 4404 | RSS: Main: 206831616 20:35:10 INFO - PID 4404 | 20:35:12 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:44693/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44693/tests/kraken/driver.html?testName=ai-astar) 20:35:12 INFO - PID 4404 | RSS: Main: 206655488 20:35:12 INFO - PID 4404 | 20:35:12 INFO - PID 4404 | __start_tp_report 20:35:12 INFO - PID 4404 | _x_x_mozilla_page_load 20:35:12 INFO - PID 4404 | _x_x_mozilla_page_load_details 20:35:12 INFO - PID 4404 | |i|pagename|runs| 20:35:12 INFO - PID 4404 | |0;ai-astar;116;107;114;113;109;111;115;109;114;107 20:35:12 INFO - PID 4404 | |1;audio-beat-detection;127;116;119;126;115;124;149;119;123;118 20:35:12 INFO - PID 4404 | |2;audio-dft;164;164;162;174;164;168;168;162;163;164 20:35:12 INFO - PID 4404 | |3;audio-fft;81;76;84;74;84;77;76;76;80;80 20:35:12 INFO - PID 4404 | |4;audio-oscillator;89;85;79;79;83;97;82;84;83;82 20:35:12 INFO - PID 4404 | |5;imaging-gaussian-blur;115;116;117;114;115;120;115;118;115;117 20:35:12 INFO - PID 4404 | |6;imaging-darkroom;152;151;149;154;151;148;157;152;148;153 20:35:12 INFO - PID 4404 | |7;imaging-desaturate;99;95;105;101;95;96;105;94;106;96 20:35:12 INFO - PID 4404 | |8;json-parse-financial;56;54;55;53;55;55;57;56;57;56 20:35:12 INFO - PID 4404 | |9;json-stringify-tinderbox;42;40;45;38;41;46;40;45;44;47 20:35:12 INFO - PID 4404 | |10;stanford-crypto-aes;77;77;81;72;77;73;80;76;83;76 20:35:12 INFO - PID 4404 | |11;stanford-crypto-ccm;126;116;118;118;113;121;119;116;113;118 20:35:12 INFO - PID 4404 | |12;stanford-crypto-pbkdf2;174;167;170;168;162;172;171;164;174;167 20:35:12 INFO - PID 4404 | |13;stanford-crypto-sha256-iterative;66;66;65;65;65;65;70;67;66;67 20:35:12 INFO - PID 4404 | __end_tp_report 20:35:12 INFO - PID 4404 | __start_cc_report 20:35:12 INFO - PID 4404 | _x_x_mozilla_cycle_collect,749 20:35:12 INFO - PID 4404 | __end_cc_report 20:35:12 INFO - PID 4404 | __startTimestamp1506224112398__endTimestamp 20:35:12 INFO - PID 4404 | 20:35:12 INFO - PID 4404 | ------- Summary: start ------- 20:35:12 INFO - PID 4404 | Number of tests: 14 20:35:12 INFO - PID 4404 | 20:35:12 INFO - PID 4404 | [#0] ai-astar Cycles:10 Average:111.50 Median:113.50 stddev:3.34 (2.9%) stddev-sans-first:3.12 20:35:12 INFO - PID 4404 | Values: 116.0 107.0 114.0 113.0 109.0 111.0 115.0 109.0 114.0 107.0 20:35:12 INFO - PID 4404 | 20:35:12 INFO - PID 4404 | [#1] audio-beat-detection Cycles:10 Average:123.60 Median:123.50 stddev:9.82 (8.0%) stddev-sans-first:10.34 20:35:12 INFO - PID 4404 | Values: 127.0 116.0 119.0 126.0 115.0 124.0 149.0 119.0 123.0 118.0 20:35:12 INFO - PID 4404 | 20:35:12 INFO - PID 4404 | [#2] audio-dft Cycles:10 Average:165.30 Median:164.00 stddev:3.71 (2.3%) stddev-sans-first:3.91 20:35:12 INFO - PID 4404 | Values: 164.0 164.0 162.0 174.0 164.0 168.0 168.0 162.0 163.0 164.0 20:35:12 INFO - PID 4404 | 20:35:12 INFO - PID 4404 | [#3] audio-fft Cycles:10 Average:78.80 Median:80.00 stddev:3.52 (4.4%) stddev-sans-first:3.64 20:35:12 INFO - PID 4404 | Values: 81.0 76.0 84.0 74.0 84.0 77.0 76.0 76.0 80.0 80.0 20:35:12 INFO - PID 4404 | 20:35:12 INFO - PID 4404 | [#4] audio-oscillator Cycles:10 Average:84.30 Median:83.50 stddev:5.31 (6.4%) stddev-sans-first:5.36 20:35:12 INFO - PID 4404 | Values: 89.0 85.0 79.0 79.0 83.0 97.0 82.0 84.0 83.0 82.0 20:35:12 INFO - PID 4404 | 20:35:12 INFO - PID 4404 | [#5] imaging-gaussian-blur Cycles:10 Average:116.20 Median:116.50 stddev:1.81 (1.6%) stddev-sans-first:1.87 20:35:12 INFO - PID 4404 | Values: 115.0 116.0 117.0 114.0 115.0 120.0 115.0 118.0 115.0 117.0 20:35:12 INFO - PID 4404 | 20:35:12 INFO - PID 4404 | [#6] imaging-darkroom Cycles:10 Average:151.50 Median:152.00 stddev:2.80 (1.8%) stddev-sans-first:2.96 20:35:12 INFO - PID 4404 | Values: 152.0 151.0 149.0 154.0 151.0 148.0 157.0 152.0 148.0 153.0 20:35:12 INFO - PID 4404 | 20:35:12 INFO - PID 4404 | [#7] imaging-desaturate Cycles:10 Average:99.20 Median:95.00 stddev:4.71 (5.0%) stddev-sans-first:4.99 20:35:12 INFO - PID 4404 | Values: 99.0 95.0 105.0 101.0 95.0 96.0 105.0 94.0 106.0 96.0 20:35:12 INFO - PID 4404 | 20:35:12 INFO - PID 4404 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:56.00 stddev:1.26 (2.3%) stddev-sans-first:1.32 20:35:12 INFO - PID 4404 | Values: 56.0 54.0 55.0 53.0 55.0 55.0 57.0 56.0 57.0 56.0 20:35:12 INFO - PID 4404 | 20:35:12 INFO - PID 4404 | [#9] json-stringify-tinderbox Cycles:10 Average:42.80 Median:44.50 stddev:3.01 (6.8%) stddev-sans-first:3.18 20:35:12 INFO - PID 4404 | Values: 42.0 40.0 45.0 38.0 41.0 46.0 40.0 45.0 44.0 47.0 20:35:12 INFO - PID 4404 | 20:35:12 INFO - PID 4404 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:77.00 stddev:3.39 (4.4%) stddev-sans-first:3.60 20:35:12 INFO - PID 4404 | Values: 77.0 77.0 81.0 72.0 77.0 73.0 80.0 76.0 83.0 76.0 20:35:12 INFO - PID 4404 | 20:35:12 INFO - PID 4404 | [#11] stanford-crypto-ccm Cycles:10 Average:117.80 Median:118.00 stddev:3.82 (3.2%) stddev-sans-first:2.67 20:35:12 INFO - PID 4404 | Values: 126.0 116.0 118.0 118.0 113.0 121.0 119.0 116.0 113.0 118.0 20:35:12 INFO - PID 4404 | 20:35:12 INFO - PID 4404 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.90 Median:170.50 stddev:4.04 (2.4%) stddev-sans-first:3.84 20:35:12 INFO - PID 4404 | Values: 174.0 167.0 170.0 168.0 162.0 172.0 171.0 164.0 174.0 167.0 20:35:12 INFO - PID 4404 | 20:35:12 INFO - PID 4404 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:1.55 (2.3%) stddev-sans-first:1.64 20:35:12 INFO - PID 4404 | Values: 66.0 66.0 65.0 65.0 65.0 65.0 70.0 67.0 66.0 67.0 20:35:12 INFO - PID 4404 | -------- Summary: end -------- 20:35:12 INFO - PID 4404 | 20:35:12 INFO - PID 4404 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 20:35:13 INFO - TEST-INFO | 4404: exit 0 20:35:13 INFO - TEST-OK | kraken | took 63043ms 20:35:13 INFO - SUITE-END | took 1180s 20:35:13 INFO - Completed test suite (00:19:41) 20:35:13 INFO - javascript benchmark 20:35:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8538.496311119825, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3132.7807053506262, 3145.2451411661195, 3155.2742869140097, 3157.305392813581, 3159.210197450637, 6191.133241346215, 6215.440610345068, 6329.525285603581, 6330.936690633098, 6378.521610879191, 6213.502919766419, 6280.717367718452, 6357.427831495164, 6455.870882582346, 6483.254425741041, 5820.82537523875, 5869.295684517864, 5880.029795083806, 5918.319393269786, 5940.584159108864, 5731.856703582402, 5802.709864506758, 5820.330661973885, 5847.532197424196, 5898.439648233411, 5787.0, 5831.154482600021, 5848.883022339572, 5878.882422351529, 5908.172855800149, 5784.537237021028, 5791.536677065867, 5870.060790273578, 5882.205902203191, 5893.204417403681, 5787.681677507735, 5813.302403711539, 5842.824715258549, 5845.503132233765, 5852.414758524156, 6114.602550834182, 6176.567640265183, 6345.143405640226, 6377.457916077139, 6397.776077837299, 6587.11074005008, 6668.899966500507, 6705.631190284533, 6769.661516924183, 6881.690323935435, 6919.619420931846, 6926.896096558556, 6931.965340173318, 6951.304869513008, 6963.617001064939, 6367.554271201017, 6391.328910464427, 6395.20059992501, 6400.135981642512, 6402.679866006681, 6913.481488888354, 6982.162140543167, 7000.159980802337, 7049.118860142482, 7076.504644674823, 6413.935860641333, 6598.472122230306, 6704.932950670431, 6779.423748981392, 6802.625855577891, 6706.5640733352175, 6721.428678562279, 6739.494537909578, 6746.359095885883, 6753.425958793459, 6613.537052406382, 6638.601683898885, 6646.53474256807, 6728.798136055926, 6773.254941956381, 6766.898496522556, 6818.249992500821, 6856.417204537571, 6874.9656251719425, 6906.412954898789, 5220.451852555503, 5275.419703832576, 5330.573554115739, 5349.4650534946195, 5355.410904800468, 4623.42207224097, 4653.581177694024, 4663.533646635377, 4688.929666055012, 4702.412198475191, 5680.886382272414, 5825.970870145622, 5829.76680932758, 5834.416558344216, 5834.620749651259, 6876.140482439695, 6925.099737034254, 6945.062416573698, 6950.374466297956, 6959.338862808025, 5803.419658034163, 5883.264591926009, 5917.5857689961285, 5921.259842519685, 5926.377730338339, 5673.375928647845, 5848.498217888478, 5932.377100404482, 5937.346891841894, 5948.7323070461935, 6530.314316996742, 6542.476601871839, 6549.508786840911, 6562.343765623399, 6572.934270657232, 6671.33286671329, 6704.6982885769285, 6779.220389655253, 6782.593044417351, 6900.378965893094, 6524.934750652433, 6646.567973081735, 6669.166354205724, 6679.632620205935, 6686.0973768540625, 6661.700968311133, 6725.663716814041, 6727.226368967631, 6798.660066996532, 6799.048133261248, 6629.502787290876, 6709.865802684017, 6790.8641827164165, 6824.249332573314, 6902.482313826383, 6456.709448074942, 6525.477961762953, 6537.934620653923, 6552.6723663815665, 6554.820132376218, 6482.546221764431, 6492.675366231575, 6525.608463492205, 6549.4760419167305, 6703.329667033453, 6549.705263263069, 6604.315899445611, 6618.503612229199, 6628.436582890316, 6660.167479065117, 6634.767783127568, 6670.799876003728, 6707.429868461236, 6761.492888033516, 6762.932370676231, 6153.353897840662, 6310.6213627182515, 6328.778492752732, 6331.873362532816, 6345.90481142774], "value": 6181.5545176973965, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.644759529605, 823.9999999999999, 824.1181935329197, 828.6643909216765, 852.9701460448883, 39307.99999999996, 39578.60421395785, 39824.0, 39996.80001599995, 40085.19829603406, 36753.08117297069, 36836.44745328822, 36871.0, 36941.44587831178, 37103.0, 7049.36555709986, 7201.459890508233, 7206.17129030163, 7218.314260145278, 7244.492885498017, 7074.504784665076, 7179.856402871939, 7183.497155199138, 7184.1019872515935, 7184.928150718504, 7163.355298023177, 7166.355028047475, 7185.568865868038, 7200.675969581382, 7429.2570742925545, 7535.51019183754, 7977.720779772709, 8007.67969281228, 8013.11855695873, 8039.598020098972, 7847.803804904866, 7898.881516777253, 7920.207979202091, 7920.366370690331, 7929.920700793034, 37121.81439092787, 37410.25179496422, 37662.81168594167, 37967.810160949295, 38193.61806381928, 3444.9483257751153, 3451.7238620910516, 3478.843452044664, 3478.9478157827652, 3481.617022127564, 31356.21609459759, 31468.527972080436, 31492.37015259705, 31555.36889262225, 31583.684163158305, 5117.232415137722, 5122.001209764097, 5126.897462050738, 5127.897442051138, 5158.845234642967, 189436.0528197364, 190036.04981975, 190437.0, 190844.0, 191227.0, 46633.30050049252, 46704.532954670016, 47077.058458831314, 47153.52846471492, 47537.286940695914, 48302.0, 48543.5145648546, 48750.0, 49047.0, 49227.26159107616, 15476.0, 15758.054516729033, 15898.0, 16000.599985000235, 16077.517674469784, 13049.804252936214, 13079.738405231841, 13132.934335328453, 13181.340932953313, 13242.867571324356, 13745.862541374658, 13762.174269543859, 13857.653558660912, 13999.790003149961, 14147.929260353632, 5563.682294969047, 5781.88436231273, 5827.388124246978, 5836.299644042742, 5928.911066334009, 984.5372674842812, 994.1599348550463, 1009.4397609326894, 1015.441507171053, 1023.672424824064, 22540.887295563745, 22597.548049038927, 22698.0, 23157.652635210485, 23442.64836027461, 1112.1825458288313, 1116.7264020315074, 1118.1948996722347, 1125.0437128440924, 1128.3737525673166, 11734.589289374831, 11749.4712737927, 12028.635810716465, 12052.156349055482, 12168.14822962402, 196251.0, 197238.0, 197530.0, 212501.0, 213860.0, 39919.20161596752, 40569.18861622751, 50297.49702503001, 50691.493085069415, 50695.239571406455, 1300.8894243989178, 1324.9403776830065, 1447.0594113825887, 1453.883689304853, 1468.5594321703447, 27426.725732742416, 27452.392022757806, 27909.720902790712, 28225.717742822308, 28429.857850710614, 37092.81453592715, 37253.62746372502, 37421.81289093537, 37467.0, 37473.437898431, 205475.0, 205606.0, 206212.0, 206233.0, 206700.0, 33888.83055584706, 35071.824640877654, 35151.29697406089, 35291.29417411689, 35885.820570896976, 40981.79509102435, 41763.37354939617, 41816.581834182485, 41885.0, 42255.7887210562, 29500.0, 30120.24699382533, 30716.846415767777, 31093.222669433446, 31182.0, 30947.381052378376, 31080.378392431572, 31098.844505777328, 31255.53116703297, 31456.213594660316, 34349.31301374009, 34721.30557388889, 34935.12662183466, 34974.300513990085, 34979.12552186216, 30478.390432191674, 30912.227194320323, 30918.0, 30975.380492390475, 31278.06165815029, 22766.31701048905, 22778.43053923665, 22872.199473018365, 22936.197233096762, 23076.769232308132], "value": 16807.38258475657, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.7233000489771, 591.3022633292713, 600.2616781358928, 603.8912995660783, 632.7089538812147, 22628.54742905141, 23264.534709305804, 23419.76580234197, 23453.29640110797, 23491.647625285634, 23413.531729365444, 25639.35901602461, 25987.22038338853, 26260.0, 26326.47347053058, 6439.066335381367, 6618.966905165467, 6684.131062961808, 6688.197416310025, 6695.062691223233, 6354.078658594501, 6567.179102612174, 6600.735970561196, 6601.339866013408, 6668.066470694107, 6591.0, 6600.372964568358, 6653.401193892549, 6653.733850645968, 6675.132232809728, 6605.768798092067, 6652.434543063821, 6656.301088385747, 6656.467482601381, 6657.900131498007, 5970.313413957407, 6137.723802428902, 6178.752849885999, 6197.969010154966, 6198.783042593487, 29314.85342573295, 29710.0, 29715.702842971725, 29750.70249297501, 29853.850730746206, 2106.189117189893, 2115.6826476028564, 2139.775323591032, 2151.268568686654, 2155.611989841828, 19149.329773458, 19183.0, 19570.119344629526, 19591.216351345927, 20149.79850201494, 2427.397917374542, 2435.8416702914255, 2491.5016996600752, 2501.762332578402, 2503.5869081601513, 113242.0, 117674.41162794217, 119621.0, 137110.3144484281, 138855.0, 14974.326155323037, 15160.620984475476, 15183.696326073417, 15230.543083707507, 15485.29661737208, 24056.39859003539, 24146.154884578955, 24150.275491735276, 24152.75847241505, 24165.275041748424, 10102.0, 10119.190464762802, 10157.695269141937, 10217.74455638615, 10296.691099267035, 9062.81874362509, 9249.815003699889, 9296.116868897443, 9306.2089722373, 9413.623455061721, 8908.0, 9114.954425227832, 9195.356325057182, 9338.066193380608, 9522.714318570454, 2560.9615855762177, 2580.21370357987, 2594.779443747265, 2631.907883224116, 2718.143784707811, 957.7749228931195, 962.592422823212, 976.5995941663883, 981.1513041219437, 994.4431118573622, 19942.20231190765, 19988.20047198096, 20014.88727138305, 20213.292534761214, 20913.477163071046, 1043.4886905416442, 1045.1168762395764, 1053.5048527192207, 1060.6287799270349, 1062.6705721226444, 10815.729606759736, 11062.778744425066, 11249.550017999352, 11396.886031139748, 11478.081753459703, 433563.0, 457433.0, 458655.82688346715, 461551.0, 472573.0, 111716.44141779402, 112927.43536282267, 114900.42549787364, 114926.0, 115933.0, 1134.6879608107672, 1172.6013155527162, 1230.3318464781103, 1243.4777393494935, 1252.067209928609, 21269.574608507435, 21302.254421095186, 21661.0, 21790.673139902596, 22002.009909553788, 60417.395826041175, 61647.0, 61814.381856180866, 62965.68517157385, 63170.68414658081, 77571.2242877564, 78134.609326953, 78442.6077869607, 79415.0, 81321.0, 14672.413103475741, 15119.924400378368, 15185.16481593523, 15235.542933712006, 15351.769723454381, 23166.652500212174, 23268.0, 23501.177458789545, 23843.165489207793, 24203.878980604983, 18756.155972980974, 18783.060846957324, 18800.62398752045, 18850.52873678169, 18929.0, 16498.25757840876, 16973.236204370587, 17283.913580432018, 17770.822291776916, 17795.19921603557, 17036.829631703524, 17941.282348706427, 18178.0, 18432.723509147643, 18471.722924156416, 15021.324040417989, 15062.096274223582, 15156.166410847509, 15166.0, 15185.0, 18269.634607307515, 18368.265269389074, 18662.626747464703, 18800.247990080243, 19136.23455061782], "value": 12185.153785713781, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1329.0829327763843, 1364.2292104960698, 1381.765099933011, 1393.8397084335293, 1395.2047333020182, 15200.695986080273, 15808.209589520535, 15905.045697258158, 15919.602009949756, 15922.442714504994, 15301.69396612067, 15592.298346574404, 15595.220238988033, 15605.375784968588, 15617.531474055768, 2801.173653772137, 2881.8991335303267, 2894.594756734059, 2912.635920509936, 2915.2128925190186, 2796.6504186976626, 2840.957385639217, 2841.9005334813287, 2842.07632519431, 2846.6014757933904, 2745.8594183374266, 2797.342624483245, 2810.943781124376, 2822.280318518785, 2822.9717702822913, 2619.5546757051347, 2656.3757516983396, 2659.175655546787, 2670.9732902671017, 2683.154806236049, 2617.659704238437, 2627.1724406811795, 2648.642433271503, 2649.5098406794805, 2651.8541480218582, 14664.193469359181, 15011.0, 15012.849871501254, 15042.172680502568, 15078.396864125421, 8049.9195008049755, 8271.875921861178, 8327.250547450758, 8344.8331033379, 8348.0, 5432.280994785222, 5513.531349835269, 5647.576431767634, 5671.723862131029, 5792.333881603585, 1937.3509874192162, 1997.9630960939437, 1999.2302963359066, 2045.734054572896, 2051.753789545264, 24488.0, 24965.251042468753, 27816.30459238515, 28468.85765571159, 28537.57193642097, 7400.111986561647, 7485.513441626277, 7586.734464293833, 7687.5387476751575, 7702.691892324245, 20795.896020520104, 20880.47798805042, 20900.37298881036, 21096.472588185417, 21116.683249751266, 8450.0, 8502.872456913028, 8548.572571371407, 8632.266257368068, 8636.395452318277, 7524.887126693104, 7705.075390953121, 7834.334081603128, 7875.251851074138, 7908.881366779503, 5545.306836645419, 5735.4551317624755, 5826.067829147316, 5869.647821130746, 5899.351071382144, 1729.9135043247786, 1734.6530693861278, 1754.877158598886, 1775.6359946211255, 1778.0573151434396, 867.7613656244583, 882.0870399136991, 898.3711402018482, 901.6032945503957, 905.4612505559181, 7638.968739220134, 7936.365090792723, 7997.120316765151, 8026.719064832703, 8072.0, 725.7895210388928, 735.3749313083836, 739.3973911262304, 748.1770052941721, 754.0611938137055, 4558.749268790249, 4644.140833945731, 4644.7213167210075, 4655.162070827284, 4700.459447163552, 21689.0, 22660.433489162573, 22755.544889102126, 22788.088476460754, 22835.314940551478, 21499.2475263365, 21929.451763705714, 22175.11299548, 22253.332400027703, 22402.775972240393, 11678.24091434054, 11782.88217117835, 11841.171118021655, 12049.939750301193, 12060.276383417198, 8333.499990000619, 8337.95831020841, 8363.498190108612, 8413.95793021031, 8481.363897707573, 18336.0, 18569.628607428047, 18758.718619220996, 18971.336003240373, 19252.614947701248, 18946.810531894505, 19226.423207303244, 20271.59456810885, 20519.0, 20685.482862928548, 11755.177137600285, 11833.467493962964, 11848.940755296513, 11884.10869184832, 11909.166358354832, 13612.455501779817, 13658.317084145952, 13689.178649281075, 13750.86249137536, 13772.793408099087, 11140.275882067639, 11675.76648467009, 11787.941060294643, 11821.172517924007, 11886.0, 11171.385573793194, 11212.887871121511, 11267.380294083903, 11322.433878306216, 11438.256513326607, 10035.598576056876, 10084.445355505517, 10137.493125343852, 10235.0, 10246.6413675521, 6857.27998560144, 6906.758263460755, 6907.20567134786, 6914.8617027660175, 7047.436205103477, 6754.784138855053, 6849.383555480031, 6928.0, 6950.20072691647, 7063.434925206074], "value": 6814.725461542303, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.54042281101385, 502.8441183233198, 526.276369991262, 531.7987895624566, 550.7191332420464, 6217.347178546255, 6241.594296370744, 6267.529935254851, 6286.717097730601, 6292.716827742751, 6143.81568552943, 6145.139680444741, 6177.227846519174, 6211.409916057979, 6231.719572619231, 5156.123459011977, 5202.921956170641, 5225.190095535198, 5233.476652334774, 5267.604929630274, 5180.663256888309, 5203.297554830087, 5248.580113590903, 5252.737363131828, 5264.026155161288, 4811.8075276988875, 4983.700977941317, 4991.176455884774, 5006.799728010893, 5125.718085505296, 4934.40787105546, 4980.6762560433635, 4989.176785830316, 5006.399232092136, 5014.022265658198, 4428.0, 4438.9124664457095, 4444.133393988173, 4451.1097780443715, 4483.618892394151, 5869.505460179406, 5993.910091348634, 5994.8501287467725, 6099.57302988791, 6136.7545298188015, 5689.260396148516, 5699.458551437607, 5701.743421546041, 5717.285339332583, 5728.97135514324, 6537.150170477855, 6547.214334279917, 6578.309277525838, 6584.604923704545, 6620.735170593171, 4715.221988371914, 4866.172750632401, 4883.609311255091, 4911.7544122793715, 4922.360093187863, 6732.84548944338, 6765.154355705537, 6782.72869085236, 6829.146356705412, 6851.314868513208, 4994.225894986283, 5024.673396229234, 5032.220005899091, 5063.797448102035, 5072.28987941681, 5078.97460512695, 5085.338905942203, 5111.900941297639, 5116.874287656709, 5126.87182820425, 5631.577631677641, 5651.265335506358, 5700.033488446479, 5718.285214348207, 5768.163616275617, 6556.868862622816, 6592.373724496165, 6611.537192396486, 6623.138991931114, 6710.148187020594, 1743.8779285449896, 1763.1536862306166, 1768.124778234782, 1784.8750587459012, 1787.7944036435977, 1157.7626586549736, 1226.270369130366, 1234.962951111468, 1237.4431505822415, 1259.6724851538484, 5631.183478395692, 5634.915476267859, 5671.347795003628, 5675.744591493392, 5682.914756278659, 6545.869082618321, 6616.0, 6622.4039836413995, 6651.201855777241, 6697.196336439659, 5581.525570326487, 5624.156376543469, 5644.491995720405, 5649.20911072442, 5680.233168522279, 3474.8957531274104, 3517.3317069757177, 3534.8586056557965, 3538.832185378819, 3562.2697347043795, 6334.714937827716, 6399.744010239631, 6415.294317625057, 6478.805635830932, 6503.349665033554, 6550.181227346582, 6852.828679283058, 6861.451083913275, 6918.515703900779, 6966.825829354307, 6197.845053873689, 6351.396617321439, 6382.266039405435, 6486.35136486357, 6486.610803351719, 6488.740450381932, 6641.568298060611, 6658.267590564937, 6736.66316684154, 6736.831579210559, 6506.544541882023, 6651.102101216274, 6691.698873550605, 6735.349839289405, 6762.222344430454, 6443.420092191725, 6465.903011454926, 6469.611823290429, 6501.902471462838, 6516.73933042673, 5013.373328333958, 5024.623153263593, 5024.623153263593, 5041.924371134362, 5053.873653158554, 6519.837004074936, 6625.304343043911, 6685.933140668531, 6698.933010669831, 6781.593104413751, 6338.746450141943, 6428.678566071584, 6444.297930152588, 6538.790323790114, 6597.637129957899, 6367.395097465734, 6499.6750162492635, 6535.607863528204, 6597.769078082244, 6600.669966501559, 6216.875662486816, 6305.464035557029, 6335.176427064452, 6353.555251132561, 6365.204349456318, 6484.28672845996, 6494.253160886558, 6495.317991611002, 6538.542302038812, 6552.6068435894, 6147.907781383194, 6198.659073750987, 6233.937660623335, 6276.0, 6278.340774218641], "value": 5049.519070980349, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [908.5048648486575, 918.4581097152679, 921.3366376209127, 927.9907200927988, 935.3919952031179, 19173.42479725607, 19836.801631983675, 19883.60232795343, 19931.50171245718, 19995.60008799823, 18209.089545522704, 18286.0, 18324.725129123075, 18340.449786506426, 18571.721424178613, 959.036168650507, 977.8435450327949, 980.127686359141, 980.4950450517989, 981.5533932060931, 984.4634674102631, 985.2364417576364, 990.0891180114276, 990.2573070197352, 994.1500017485055, 1000.9449480278582, 1038.2835843268158, 1044.9477526123662, 1051.8264486359742, 1053.2048303530862, 1025.7128004158847, 1029.5367084811828, 1030.5671617920455, 1032.7727899862018, 1033.5090831854884, 751.3050428353805, 753.9472236943416, 756.2286467802866, 756.4100001998451, 759.017072890608, 19823.603527929507, 20012.599748005105, 20117.899410503, 20207.69688454674, 20324.79675203244, 21734.565308693895, 21740.782592174193, 21934.780652193433, 22184.445388865246, 22247.777522224733, 16075.839241607551, 16776.0, 16877.831221687873, 16901.7464738029, 16911.154442277835, 3703.777773333609, 3770.2836461072307, 3772.302124107049, 3778.074371778932, 3779.6598306152578, 98078.0, 100171.49914250454, 131736.0, 138201.0, 142211.0, 16566.585835354213, 17236.913815431093, 17292.740608890625, 17417.954922704677, 17432.825671743372, 30269.69730302669, 31387.372252554822, 31638.525422118688, 31703.365932681216, 31772.523412148836, 9230.353875228804, 9473.194778443909, 9484.857727134098, 9502.714918552454, 9574.47340396271, 4494.325851122292, 4497.685162038626, 4537.977310113428, 4547.977260113678, 4551.089782043605, 5338.599605029638, 5474.945250547444, 5475.09660905946, 5480.013597552399, 5490.396056433789, 864.3301441382979, 888.6845169964698, 906.8005038891565, 912.32943786317, 922.8800255966681, 641.7112299465259, 654.8231977366084, 661.4509956735898, 668.4351722794231, 671.3554987212233, 11935.224210426295, 12018.519259229533, 12613.30626815534, 12650.683732906567, 12662.240265584094, 676.5636164673758, 684.8904175331922, 692.9722811087601, 708.7696498637963, 713.1976526407791, 5348.786048558014, 5416.997855396764, 5469.480399362054, 5512.91730624041, 5551.500364967173, 120929.0, 122966.0, 123062.0, 123081.38459307826, 124610.37694811467, 110080.4495977515, 112750.43624781823, 113535.43232283786, 114654.42672786582, 115005.0, 90788.0, 91280.54359728159, 93371.0, 95164.52417737867, 96504.51747741357, 9997.700068997941, 10379.481025948522, 10422.426766527611, 10441.321314114559, 10683.94658026705, 43304.56695433131, 43518.34722479102, 44294.0, 45077.54922450733, 45130.0, 57480.71259643675, 58322.4167758317, 58381.0, 58615.4138458627, 59061.70469147627, 14631.341589628279, 14996.550103496913, 15009.474668386554, 15045.247737612857, 15100.471483498024, 17738.290468381638, 17954.461366159037, 17971.640567188846, 17990.910045449687, 18261.269549218414, 15888.841111589198, 15897.284622191797, 15924.92037539805, 16009.0, 16120.596985075466, 14948.103113813206, 14956.102633842005, 15020.173890435693, 15228.238588070331, 15423.61440963985, 15649.765253521435, 16182.919085404497, 16339.428120015742, 16451.177441128137, 16618.66762664716, 11436.656900293005, 11503.482343294405, 11577.826332605186, 11740.530378784753, 11802.645920622395, 10996.835047474455, 11051.226414150933, 11075.169362298022, 11102.389368584805, 11138.443077846237], "value": 8894.797610794809, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1458.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 107.0, 114.0, 113.0, 109.0, 111.0, 115.0, 109.0, 114.0, 107.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 116.0, 119.0, 126.0, 115.0, 124.0, 149.0, 119.0, 123.0, 118.0], "value": 123.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 162.0, 174.0, 164.0, 168.0, 168.0, 162.0, 163.0, 164.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 76.0, 84.0, 74.0, 84.0, 77.0, 76.0, 76.0, 80.0, 80.0], "value": 78.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 79.0, 79.0, 83.0, 97.0, 82.0, 84.0, 83.0, 82.0], "value": 84.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 117.0, 114.0, 115.0, 120.0, 115.0, 118.0, 115.0, 117.0], "value": 116.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 149.0, 154.0, 151.0, 148.0, 157.0, 152.0, 148.0, 153.0], "value": 151.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 95.0, 105.0, 101.0, 95.0, 96.0, 105.0, 94.0, 106.0, 96.0], "value": 99.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 55.0, 53.0, 55.0, 55.0, 57.0, 56.0, 57.0, 56.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [42.0, 40.0, 45.0, 38.0, 41.0, 46.0, 40.0, 45.0, 44.0, 47.0], "value": 42.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 81.0, 72.0, 77.0, 73.0, 80.0, 76.0, 83.0, 76.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 116.0, 118.0, 118.0, 113.0, 121.0, 119.0, 116.0, 113.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 167.0, 170.0, 168.0, 162.0, 172.0, 171.0, 164.0, 174.0, 167.0], "value": 168.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 65.0, 65.0, 70.0, 67.0, 66.0, 67.0], "value": 66.2, "unit": "score"}]}]} 20:35:13 INFO - Return code: 0 20:35:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:35:13 INFO - # TBPL SUCCESS # 20:35:13 INFO - Running post-action listener: _package_coverage_data 20:35:13 INFO - Running post-action listener: _resource_record_post_action 20:35:13 INFO - [mozharness: 2017-09-24 03:35:13.668101Z] Finished run-tests step (success) 20:35:13 INFO - Running post-run listener: _resource_record_post_run 20:35:13 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 21598208; Write bytes: 405307392; Read time: 9148; Write time: 344436 20:35:13 INFO - TinderboxPrint: CPU usage
13.3% 20:35:13 INFO - TinderboxPrint: I/O read bytes / time
21,598,208 / 9,148 20:35:13 INFO - TinderboxPrint: I/O write bytes / time
405,307,392 / 344,436 20:35:13 INFO - TinderboxPrint: CPU idle
8,283.8 (86.7%) 20:35:13 INFO - TinderboxPrint: CPU user
1,202.4 (12.6%) 20:35:13 INFO - TinderboxPrint: Swap in / out
0 / 0 20:35:13 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 471040; Read time: 0; Write time: 32 20:35:13 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 20:35:13 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 19361792; Write bytes: 404836352; Read time: 8964; Write time: 344404 20:35:14 INFO - Running post-run listener: _upload_blobber_files 20:35:14 INFO - Blob upload gear active. 20:35:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:35:14 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:35:14 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:35:14 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:35:14 INFO - (blobuploader) - INFO - Open directory for files ... 20:35:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:35:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:35:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:35:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:35:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:35:15 INFO - (blobuploader) - INFO - Done attempting. 20:35:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:35:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:35:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:35:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:35:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:35:16 INFO - (blobuploader) - INFO - Done attempting. 20:35:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:35:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:35:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:35:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:35:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:35:17 INFO - (blobuploader) - INFO - Done attempting. 20:35:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:35:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:35:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:35:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:35:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:35:24 INFO - (blobuploader) - INFO - Done attempting. 20:35:24 INFO - (blobuploader) - INFO - Iteration through files over. 20:35:24 INFO - Return code: 0 20:35:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:35:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:35:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29f0606dfef2083cce54c7c70b7028b9e670468ac35fe69b1dae741bce6e81a572a5a1fec1a0b40e6ca842519b9bc4db61efcd88ee01f044226d3495311fad32", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f95da39233434115905485f234259b5000b7b0b3dbac7be4d8ba0371771237026591498113fa3589c6d7eaef029d33c4d795c48b180301293c85960f8f745854", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a4214020e4511b55e1cdf2b0910c1852c3c676f45c90e38ed6d38d0533255eaa0e71324d0f088175de2eb9aedf9cd38c58332688c631c15bcfee0ebe74247d5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7d34e7cb62b63b73f4d8f8443a8ddd47b3bd2c441418e48e119ddfc74a6fb2154e13304897a3fb1eaf8ae80c0c7a7e7529c56fad85b6ad9f92bb0213e201a00"} 20:35:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:35:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:35:24 INFO - Contents: 20:35:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29f0606dfef2083cce54c7c70b7028b9e670468ac35fe69b1dae741bce6e81a572a5a1fec1a0b40e6ca842519b9bc4db61efcd88ee01f044226d3495311fad32", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f95da39233434115905485f234259b5000b7b0b3dbac7be4d8ba0371771237026591498113fa3589c6d7eaef029d33c4d795c48b180301293c85960f8f745854", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a4214020e4511b55e1cdf2b0910c1852c3c676f45c90e38ed6d38d0533255eaa0e71324d0f088175de2eb9aedf9cd38c58332688c631c15bcfee0ebe74247d5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7d34e7cb62b63b73f4d8f8443a8ddd47b3bd2c441418e48e119ddfc74a6fb2154e13304897a3fb1eaf8ae80c0c7a7e7529c56fad85b6ad9f92bb0213e201a00"} 20:35:24 INFO - Running post-run listener: copy_logs_to_upload_dir 20:35:24 INFO - Copying logs to upload dir... 20:35:24 INFO - mkdir: /builds/slave/test/build/upload/logs 20:35:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.845471 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-09-23 20:35:24.665895) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 20:35:24.669074) ========= 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=3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29f0606dfef2083cce54c7c70b7028b9e670468ac35fe69b1dae741bce6e81a572a5a1fec1a0b40e6ca842519b9bc4db61efcd88ee01f044226d3495311fad32", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f95da39233434115905485f234259b5000b7b0b3dbac7be4d8ba0371771237026591498113fa3589c6d7eaef029d33c4d795c48b180301293c85960f8f745854", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a4214020e4511b55e1cdf2b0910c1852c3c676f45c90e38ed6d38d0533255eaa0e71324d0f088175de2eb9aedf9cd38c58332688c631c15bcfee0ebe74247d5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7d34e7cb62b63b73f4d8f8443a8ddd47b3bd2c441418e48e119ddfc74a6fb2154e13304897a3fb1eaf8ae80c0c7a7e7529c56fad85b6ad9f92bb0213e201a00"} build_url:https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011374 build_url: 'https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29f0606dfef2083cce54c7c70b7028b9e670468ac35fe69b1dae741bce6e81a572a5a1fec1a0b40e6ca842519b9bc4db61efcd88ee01f044226d3495311fad32", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f95da39233434115905485f234259b5000b7b0b3dbac7be4d8ba0371771237026591498113fa3589c6d7eaef029d33c4d795c48b180301293c85960f8f745854", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a4214020e4511b55e1cdf2b0910c1852c3c676f45c90e38ed6d38d0533255eaa0e71324d0f088175de2eb9aedf9cd38c58332688c631c15bcfee0ebe74247d5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7d34e7cb62b63b73f4d8f8443a8ddd47b3bd2c441418e48e119ddfc74a6fb2154e13304897a3fb1eaf8ae80c0c7a7e7529c56fad85b6ad9f92bb0213e201a00"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 20:35:24.697961) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:35:24.698329) ========= 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=3297cc2eebb5444a7688c33f000001b5-1506220340.896633-1944277745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:35:24.786095) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 20:35:24.786501) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 20:35:24.787200) ========= ========= Total master_lag: 0.24 =========