builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-010 starttime: 1506988525.1 results: success (0) revision: 8c6b4fd1d76927cf8b07eb045c5aadd47b77d910 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 16:55:25.097216) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 16:55:25.097691) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 16:55:25.097959) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 16:55:25.180260) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 16:55:25.180532) ========= 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=eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-02 16:55:25-- 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% 115M=0s 2017-10-02 16:55:25 (115 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.101502 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 16:55:25.321531) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 16:55:25.322047) ========= 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=eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020358 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 16:55:25.391531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-02 16:55:25.391901) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8c6b4fd1d76927cf8b07eb045c5aadd47b77d910 --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 8c6b4fd1d76927cf8b07eb045c5aadd47b77d910 --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=eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-02 16:55:25,451 truncating revision to first 12 chars 2017-10-02 16:55:25,451 Setting DEBUG logging. 2017-10-02 16:55:25,451 attempt 1/10 2017-10-02 16:55:25,451 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8c6b4fd1d769?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-02 16:55:26,312 unpacking tar archive at: mozilla-central-8c6b4fd1d769/testing/mozharness/ program finished with exit code 0 elapsedTime=1.232530 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-02 16:55:26.651382) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 16:55:26.654719) ========= script_repo_revision: 8c6b4fd1d76927cf8b07eb045c5aadd47b77d910 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 16:55:26.655117) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 16:55:26.655383) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 16:55:26.678011) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-10-02 16:55:26.678335) ========= /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=eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:55:26 INFO - MultiFileLogger online at 20171002 16:55:26 in /builds/slave/test 16:55:26 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 16:55:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:55:26 INFO - {'append_to_log': False, 16:55:26 INFO - 'base_work_dir': '/builds/slave/test', 16:55:26 INFO - 'blob_upload_branch': 'Firefox', 16:55:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:55:26 INFO - 'branch': 'Firefox', 16:55:26 INFO - 'buildbot_json_path': 'buildprops.json', 16:55:26 INFO - 'code_coverage': False, 16:55:26 INFO - 'config_files': ('talos/linux_config.py',), 16:55:26 INFO - 'default_actions': ('clobber', 16:55:26 INFO - 'read-buildbot-config', 16:55:26 INFO - 'download-and-extract', 16:55:26 INFO - 'populate-webroot', 16:55:26 INFO - 'create-virtualenv', 16:55:26 INFO - 'install', 16:55:26 INFO - 'setup-mitmproxy', 16:55:26 INFO - 'run-tests'), 16:55:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:55:26 INFO - 'disable_ccov_upload': False, 16:55:26 INFO - 'disable_stylo': False, 16:55:26 INFO - 'download_minidump_stackwalk': True, 16:55:26 INFO - 'download_symbols': 'ondemand', 16:55:26 INFO - 'enable_stylo': False, 16:55:26 INFO - 'enable_webrender': False, 16:55:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 16:55:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:55:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:55:26 INFO - 'gecko_profile': False, 16:55:26 INFO - 'gecko_profile_interval': 0, 16:55:26 INFO - 'installer_path': 'installer.exe', 16:55:26 INFO - 'log_level': 'info', 16:55:26 INFO - 'log_name': 'talos', 16:55:26 INFO - 'log_to_console': True, 16:55:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:55:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:55:26 INFO - 'opt_config_files': (), 16:55:26 INFO - 'pip_index': False, 16:55:26 INFO - 'suite': 'dromaeojs-e10s', 16:55:26 INFO - 'system_bits': '32', 16:55:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:55:26 INFO - 'title': 'talos-linux64-ix-010', 16:55:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:55:26 INFO - 'use_talos_json': True, 16:55:26 INFO - 'verify': 'False', 16:55:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:55:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:55:26 INFO - 'work_dir': 'build'} 16:55:26 INFO - [mozharness: 2017-10-02 23:55:26.867176Z] Running clobber step. 16:55:26 INFO - Running pre-action listener: _resource_record_pre_action 16:55:26 INFO - Running main action method: clobber 16:55:26 INFO - rmtree: /builds/slave/test/build 16:55:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:55:27 INFO - Running post-action listener: _resource_record_post_action 16:55:27 INFO - [mozharness: 2017-10-02 23:55:27.875107Z] Finished clobber step (success) 16:55:27 INFO - [mozharness: 2017-10-02 23:55:27.875206Z] Running read-buildbot-config step. 16:55:27 INFO - Running pre-action listener: _resource_record_pre_action 16:55:27 INFO - Running main action method: read_buildbot_config 16:55:27 INFO - Using buildbot properties: 16:55:27 INFO - { 16:55:27 INFO - "project": "", 16:55:27 INFO - "product": "firefox", 16:55:27 INFO - "who": "kwierso@gmail.com", 16:55:27 INFO - "installer_path": "public/build/target.tar.bz2", 16:55:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 16:55:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:55:27 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 16:55:27 INFO - "stage_platform": "linux64-qr", 16:55:27 INFO - "basedir": "/builds/slave/test", 16:55:27 INFO - "buildnumber": 116, 16:55:27 INFO - "platform": "ubuntu64_hw_qr", 16:55:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:55:27 INFO - "slavebuilddir": "test", 16:55:27 INFO - "taskId": "I-ER512jQbGYY4Nv-o8Riw", 16:55:27 INFO - "branch": "mozilla-central", 16:55:27 INFO - "script_repo_revision": "production", 16:55:27 INFO - "revision": "8c6b4fd1d76927cf8b07eb045c5aadd47b77d910", 16:55:27 INFO - "slavename": "talos-linux64-ix-010", 16:55:27 INFO - "repo_path": "mozilla-central" 16:55:27 INFO - } 16:55:27 INFO - Finding installer, test and symbols from parent task. 16:55:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I-ER512jQbGYY4Nv-o8Riw'}, attempt #1 16:55:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I-ER512jQbGYY4Nv-o8Riw'}, attempt #1 16:55:28 INFO - Task dependencies: YAgzs5MDS5qLhHYHYdDeDQ 16:55:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ'}, attempt #1 16:55:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.tar.bz2 16:55:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.test_packages.json 16:55:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.crashreporter-symbols.zip 16:55:29 INFO - Running post-action listener: _resource_record_post_action 16:55:29 INFO - [mozharness: 2017-10-02 23:55:29.519793Z] Finished read-buildbot-config step (success) 16:55:29 INFO - [mozharness: 2017-10-02 23:55:29.520010Z] Running download-and-extract step. 16:55:29 INFO - Running pre-action listener: _resource_record_pre_action 16:55:29 INFO - Running main action method: download_and_extract 16:55:29 INFO - mkdir: /builds/slave/test/build/tests 16:55:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:29 INFO - trying https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.test_packages.json 16:55:29 INFO - Downloading https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:55:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:55:30 INFO - Downloaded 989 bytes. 16:55:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:55:30 INFO - Using the following test package requirements: 16:55:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:55:30 INFO - u'common': [u'target.common.tests.zip'], 16:55:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:55:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:55:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:55:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:55:30 INFO - u'mozbase': [u'target.common.tests.zip'], 16:55:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:55:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:55:30 INFO - u'web-platform': [u'target.common.tests.zip', 16:55:30 INFO - u'target.web-platform.tests.tar.gz'], 16:55:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:55:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 16:55:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.common.tests.zip 16:55:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:55:30 INFO - Fetch https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.common.tests.zip into memory 16:55:31 INFO - Content-Length response header: 55366782 16:55:31 INFO - Bytes received: 55366782 16:55:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.talos.tests.zip 16:55:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:55:42 INFO - Fetch https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.talos.tests.zip into memory 16:55:43 INFO - Content-Length response header: 14522427 16:55:43 INFO - Bytes received: 14522427 16:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:43 INFO - trying https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.tar.bz2 16:55:43 INFO - Downloading https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:55:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:55:45 INFO - Downloaded 61637993 bytes. 16:55:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.tar.bz2 16:55:45 INFO - mkdir: /builds/slave/test/properties 16:55:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:55:45 INFO - Writing to file /builds/slave/test/properties/build_url 16:55:45 INFO - Contents: 16:55:45 INFO - build_url:https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.tar.bz2 16:55:45 INFO - Running post-action listener: _resource_record_post_action 16:55:45 INFO - Running post-action listener: find_tests_for_verification 16:55:45 INFO - Running post-action listener: set_extra_try_arguments 16:55:45 INFO - [mozharness: 2017-10-02 23:55:45.406009Z] Finished download-and-extract step (success) 16:55:45 INFO - [mozharness: 2017-10-02 23:55:45.406239Z] Running populate-webroot step. 16:55:45 INFO - Running pre-action listener: _resource_record_pre_action 16:55:45 INFO - Running main action method: populate_webroot 16:55:45 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:55:45 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:55:45 INFO - 'tests': ['tresize', 16:55:45 INFO - 'tcanvasmark']}, 16:55:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:55:45 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:55:45 INFO - 'tests': ['dromaeo_css', 16:55:45 INFO - 'kraken']}, 16:55:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:55:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:55:45 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:55:45 INFO - 'talos_options': ['--disable-stylo'], 16:55:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:55:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:55:45 INFO - 'tests': ['damp', 'tps']}, 16:55:45 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:55:45 INFO - 'talos_options': ['--disable-stylo'], 16:55:45 INFO - 'tests': ['damp', 'tps']}, 16:55:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:55:45 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:55:45 INFO - 'tests': ['dromaeo_dom']}, 16:55:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:55:45 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:55:45 INFO - 'tests': ['basic_compositor_video', 16:55:45 INFO - 'glvideo']}, 16:55:45 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:55:45 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:55:45 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:55:45 INFO - 'talos_options': ['--disable-stylo'], 16:55:45 INFO - 'tests': ['ts_paint_webext', 16:55:45 INFO - 'tp5o_webext']}, 16:55:45 INFO - 'other-e10s': {'tests': ['a11yr', 16:55:45 INFO - 'ts_paint', 16:55:45 INFO - 'tpaint', 16:55:45 INFO - 'sessionrestore', 16:55:45 INFO - 'sessionrestore_many_windows', 16:55:45 INFO - 'sessionrestore_no_auto_restore', 16:55:45 INFO - 'tabpaint', 16:55:45 INFO - 'cpstartup']}, 16:55:45 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:55:45 INFO - 'tests': ['a11yr', 16:55:45 INFO - 'ts_paint', 16:55:45 INFO - 'tpaint', 16:55:45 INFO - 'sessionrestore', 16:55:45 INFO - 'sessionrestore_many_windows', 16:55:45 INFO - 'sessionrestore_no_auto_restore', 16:55:45 INFO - 'tabpaint', 16:55:45 INFO - 'cpstartup']}, 16:55:45 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 16:55:45 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 16:55:45 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:55:45 INFO - 'tests': ['perf_reftest_singletons']}, 16:55:45 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:55:45 INFO - 'tests': ['perf_reftest']}, 16:55:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:55:45 INFO - 'tsvgr_opacity', 16:55:45 INFO - 'tart', 16:55:45 INFO - 'tscrollx', 16:55:45 INFO - 'tsvg_static']}, 16:55:45 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:55:45 INFO - 'tests': ['tsvgx', 16:55:45 INFO - 'tsvgr_opacity', 16:55:45 INFO - 'tart', 16:55:45 INFO - 'tscrollx', 16:55:45 INFO - 'tsvg_static']}, 16:55:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:55:45 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:55:45 INFO - 'talos_options': ['--disable-stylo'], 16:55:45 INFO - 'tests': ['tp5o']}, 16:55:45 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:55:45 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:55:45 INFO - 'talos_options': ['--mitmproxy', 16:55:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:55:45 INFO - '--firstNonBlankPaint'], 16:55:45 INFO - 'tests': ['tp6_google', 16:55:45 INFO - 'tp6_youtube', 16:55:45 INFO - 'tp6_amazon', 16:55:45 INFO - 'tp6_facebook']}, 16:55:45 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:55:45 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:55:45 INFO - 'talos_options': ['--disable-stylo', 16:55:45 INFO - '--mitmproxy', 16:55:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:55:45 INFO - '--firstNonBlankPaint'], 16:55:45 INFO - 'tests': ['tp6_google', 16:55:45 INFO - 'tp6_youtube', 16:55:45 INFO - 'tp6_amazon', 16:55:45 INFO - 'tp6_facebook']}, 16:55:45 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:55:45 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:55:45 INFO - 'talos_options': ['--stylo-threads=1', 16:55:45 INFO - '--mitmproxy', 16:55:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:55:45 INFO - '--firstNonBlankPaint'], 16:55:45 INFO - 'tests': ['tp6_google', 16:55:45 INFO - 'tp6_youtube', 16:55:45 INFO - 'tp6_amazon', 16:55:45 INFO - 'tp6_facebook']}, 16:55:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:55:45 INFO - 'talos_options': ['--xperf_path', 16:55:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:55:45 INFO - 'tests': ['tp5n']}, 16:55:45 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:55:45 INFO - 'talos_options': ['--disable-stylo', 16:55:45 INFO - '--xperf_path', 16:55:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:55:45 INFO - 'tests': ['tp5n']}}} 16:55:45 INFO - Running post-action listener: _resource_record_post_action 16:55:45 INFO - [mozharness: 2017-10-02 23:55:45.424539Z] Finished populate-webroot step (success) 16:55:45 INFO - [mozharness: 2017-10-02 23:55:45.424683Z] Running create-virtualenv step. 16:55:45 INFO - Running pre-action listener: _resource_record_pre_action 16:55:45 INFO - Running main action method: create_virtualenv 16:55:45 INFO - Creating virtualenv /builds/slave/test/build/venv 16:55:45 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:55:45 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 16:55:45 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:55:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:55:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:55:46 INFO - Installing distribute.............................................................................................................................................................................................done. 16:55:46 INFO - Installing pip...............done. 16:55:46 INFO - Return code: 0 16:55:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:55:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:55:46 INFO - Reading from file tmpfile_stdout 16:55:46 INFO - Output received: 16:55:46 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 16:55:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1599d60>, '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 0x159aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159aef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995', '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 16:55:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:55:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:55:46 INFO - Using env: {'DISPLAY': ':0', 16:55:46 INFO - 'HOME': '/home/cltbld', 16:55:46 INFO - 'LANG': 'en_US.UTF-8', 16:55:46 INFO - 'LANGUAGE': 'en_US:en', 16:55:46 INFO - 'LOGNAME': 'cltbld', 16:55:46 INFO - 'MAIL': '/var/mail/cltbld', 16:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:46 INFO - 'MOZ_NO_REMOTE': '1', 16:55:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:46 INFO - 'NO_EM_RESTART': '1', 16:55:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:46 INFO - 'PWD': '/builds/slave/test', 16:55:46 INFO - 'SHELL': '/bin/bash', 16:55:46 INFO - 'SHLVL': '1', 16:55:46 INFO - 'TERM': 'linux', 16:55:46 INFO - 'TMOUT': '86400', 16:55:46 INFO - 'USER': 'cltbld', 16:55:46 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995', 16:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:46 INFO - '_': '/tools/buildbot/bin/python'} 16:55:48 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:55:48 INFO - Downloading/unpacking pip>=1.5 16:55:48 INFO - Running setup.py egg_info for package pip 16:55:48 INFO - warning: no files found matching 'pip/cacert.pem' 16:55:48 INFO - warning: no files found matching '*.html' under directory 'docs' 16:55:48 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:55:48 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:55:48 INFO - Installing collected packages: pip 16:55:48 INFO - Found existing installation: pip 1.1 16:55:48 INFO - Uninstalling pip: 16:55:48 INFO - Successfully uninstalled pip 16:55:48 INFO - Running setup.py install for pip 16:55:48 INFO - warning: no files found matching 'pip/cacert.pem' 16:55:48 INFO - warning: no files found matching '*.html' under directory 'docs' 16:55:48 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:55:48 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:55:48 INFO - Installing pip script to /builds/slave/test/build/venv/bin 16:55:48 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 16:55:48 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 16:55:48 INFO - Successfully installed pip 16:55:48 INFO - Cleaning up... 16:55:48 INFO - Return code: 0 16:55:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:48 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 0x122f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1599d60>, '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 0x159aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159aef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995', '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 16:55:48 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 16:55:48 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 16:55:48 INFO - Using env: {'DISPLAY': ':0', 16:55:48 INFO - 'HOME': '/home/cltbld', 16:55:48 INFO - 'LANG': 'en_US.UTF-8', 16:55:48 INFO - 'LANGUAGE': 'en_US:en', 16:55:48 INFO - 'LOGNAME': 'cltbld', 16:55:48 INFO - 'MAIL': '/var/mail/cltbld', 16:55:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:48 INFO - 'MOZ_NO_REMOTE': '1', 16:55:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:48 INFO - 'NO_EM_RESTART': '1', 16:55:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:48 INFO - 'PWD': '/builds/slave/test', 16:55:48 INFO - 'SHELL': '/bin/bash', 16:55:48 INFO - 'SHLVL': '1', 16:55:48 INFO - 'TERM': 'linux', 16:55:48 INFO - 'TMOUT': '86400', 16:55:48 INFO - 'USER': 'cltbld', 16:55:48 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995', 16:55:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:48 INFO - '_': '/tools/buildbot/bin/python'} 16:55:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:48 INFO - Downloading/unpacking psutil>=3.1.1 16:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:55:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:55:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:55:49 INFO - Installing collected packages: psutil 16:55:49 INFO - Running setup.py install for psutil 16:55:49 INFO - building 'psutil._psutil_linux' extension 16:55:49 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 16:55:49 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 16:55:49 INFO - building 'psutil._psutil_posix' extension 16:55:49 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 16:55:49 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 16:55:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:55:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:55:49 INFO - Successfully installed psutil 16:55:49 INFO - Cleaning up... 16:55:49 INFO - Return code: 0 16:55:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:55:49 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')]} 16:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:49 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')]} 16:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:49 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 0x122f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1599d60>, '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 0x159aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159aef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995', '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 16:55:49 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 16:55:49 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 16:55:49 INFO - Using env: {'DISPLAY': ':0', 16:55:49 INFO - 'HOME': '/home/cltbld', 16:55:49 INFO - 'LANG': 'en_US.UTF-8', 16:55:49 INFO - 'LANGUAGE': 'en_US:en', 16:55:49 INFO - 'LOGNAME': 'cltbld', 16:55:49 INFO - 'MAIL': '/var/mail/cltbld', 16:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:49 INFO - 'MOZ_NO_REMOTE': '1', 16:55:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:49 INFO - 'NO_EM_RESTART': '1', 16:55:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:49 INFO - 'PWD': '/builds/slave/test', 16:55:49 INFO - 'SHELL': '/bin/bash', 16:55:49 INFO - 'SHLVL': '1', 16:55:49 INFO - 'TERM': 'linux', 16:55:49 INFO - 'TMOUT': '86400', 16:55:49 INFO - 'USER': 'cltbld', 16:55:49 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995', 16:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:49 INFO - '_': '/tools/buildbot/bin/python'} 16:55:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:55:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:55:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:55:51 INFO - Installing collected packages: mozsystemmonitor 16:55:51 INFO - Running setup.py install for mozsystemmonitor 16:55:51 INFO - Successfully installed mozsystemmonitor 16:55:51 INFO - Cleaning up... 16:55:53 INFO - Return code: 0 16:55:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:55: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')]} 16:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55: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')]} 16:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55: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', '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 0x122f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1599d60>, '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 0x159aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159aef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995', '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 16:55: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:55: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 jsonschema==2.5.1 16:55:53 INFO - Using env: {'DISPLAY': ':0', 16:55:53 INFO - 'HOME': '/home/cltbld', 16:55:53 INFO - 'LANG': 'en_US.UTF-8', 16:55:53 INFO - 'LANGUAGE': 'en_US:en', 16:55:53 INFO - 'LOGNAME': 'cltbld', 16:55:53 INFO - 'MAIL': '/var/mail/cltbld', 16:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:53 INFO - 'MOZ_NO_REMOTE': '1', 16:55:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:53 INFO - 'NO_EM_RESTART': '1', 16:55:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:53 INFO - 'PWD': '/builds/slave/test', 16:55:53 INFO - 'SHELL': '/bin/bash', 16:55:53 INFO - 'SHLVL': '1', 16:55:53 INFO - 'TERM': 'linux', 16:55:53 INFO - 'TMOUT': '86400', 16:55:53 INFO - 'USER': 'cltbld', 16:55:53 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995', 16:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:53 INFO - '_': '/tools/buildbot/bin/python'} 16:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:53 INFO - Downloading/unpacking jsonschema==2.5.1 16:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:55:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:55:54 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 16:55:54 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 16:55:54 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 16:55:54 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 16:55:55 INFO - Downloading functools32-3.2.3-2.tar.gz 16:55:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:55:55 INFO - warning: no files found matching '*.txt' 16:55:55 INFO - no previously-included directories found matching 'build' 16:55:55 INFO - no previously-included directories found matching 'dist' 16:55:55 INFO - no previously-included directories found matching '.git*' 16:55:55 INFO - Installing collected packages: jsonschema, functools32 16:55:55 INFO - Running setup.py install for functools32 16:55:55 INFO - warning: no files found matching '*.txt' 16:55:55 INFO - no previously-included directories found matching 'build' 16:55:55 INFO - no previously-included directories found matching 'dist' 16:55:55 INFO - no previously-included directories found matching '.git*' 16:55:55 INFO - Successfully installed jsonschema functools32 16:55:55 INFO - Cleaning up... 16:55:55 INFO - Return code: 0 16:55:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:55: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')]} 16:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55: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')]} 16:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55: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', '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 0x122f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1599d60>, '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 0x159aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159aef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995', '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 16:55: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:55: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 functools32==3.2.3-2 16:55:55 INFO - Using env: {'DISPLAY': ':0', 16:55:55 INFO - 'HOME': '/home/cltbld', 16:55:55 INFO - 'LANG': 'en_US.UTF-8', 16:55:55 INFO - 'LANGUAGE': 'en_US:en', 16:55:55 INFO - 'LOGNAME': 'cltbld', 16:55:55 INFO - 'MAIL': '/var/mail/cltbld', 16:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:55 INFO - 'MOZ_NO_REMOTE': '1', 16:55:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:55 INFO - 'NO_EM_RESTART': '1', 16:55:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:55 INFO - 'PWD': '/builds/slave/test', 16:55:55 INFO - 'SHELL': '/bin/bash', 16:55:55 INFO - 'SHLVL': '1', 16:55:55 INFO - 'TERM': 'linux', 16:55:55 INFO - 'TMOUT': '86400', 16:55:55 INFO - 'USER': 'cltbld', 16:55:55 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995', 16:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:55 INFO - '_': '/tools/buildbot/bin/python'} 16:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:55:56 INFO - Cleaning up... 16:55:56 INFO - Return code: 0 16:55:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:55:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x122f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1599d60>, '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 0x159aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159aef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995', '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 16:55:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:55:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:55:56 INFO - Using env: {'DISPLAY': ':0', 16:55:56 INFO - 'HOME': '/home/cltbld', 16:55:56 INFO - 'LANG': 'en_US.UTF-8', 16:55:56 INFO - 'LANGUAGE': 'en_US:en', 16:55:56 INFO - 'LOGNAME': 'cltbld', 16:55:56 INFO - 'MAIL': '/var/mail/cltbld', 16:55:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:56 INFO - 'MOZ_NO_REMOTE': '1', 16:55:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:56 INFO - 'NO_EM_RESTART': '1', 16:55:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:56 INFO - 'PWD': '/builds/slave/test', 16:55:56 INFO - 'SHELL': '/bin/bash', 16:55:56 INFO - 'SHLVL': '1', 16:55:56 INFO - 'TERM': 'linux', 16:55:56 INFO - 'TMOUT': '86400', 16:55:56 INFO - 'USER': 'cltbld', 16:55:56 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995', 16:55:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:56 INFO - '_': '/tools/buildbot/bin/python'} 16:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:56 INFO - Downloading/unpacking blobuploader==1.2.4 16:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:57 INFO - Downloading blobuploader-1.2.4.tar.gz 16:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:55:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:55:57 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 16:55:57 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 16:55:57 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 16:55:57 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 16:55:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:55:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:58 INFO - Downloading docopt-0.6.1.tar.gz 16:55:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:55:58 INFO - Installing collected packages: blobuploader, requests, docopt 16:55:58 INFO - Running setup.py install for blobuploader 16:55:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:55:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:55:58 INFO - Running setup.py install for requests 16:55:58 INFO - Running setup.py install for docopt 16:55:59 INFO - Successfully installed blobuploader requests docopt 16:55:59 INFO - Cleaning up... 16:55:59 INFO - Return code: 0 16:55:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:59 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 0x122f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1599d60>, '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 0x159aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159aef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995', '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 16:55:59 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 16:55:59 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 16:55:59 INFO - Using env: {'DISPLAY': ':0', 16:55:59 INFO - 'HOME': '/home/cltbld', 16:55:59 INFO - 'LANG': 'en_US.UTF-8', 16:55:59 INFO - 'LANGUAGE': 'en_US:en', 16:55:59 INFO - 'LOGNAME': 'cltbld', 16:55:59 INFO - 'MAIL': '/var/mail/cltbld', 16:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:59 INFO - 'MOZ_NO_REMOTE': '1', 16:55:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:59 INFO - 'NO_EM_RESTART': '1', 16:55:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:59 INFO - 'PWD': '/builds/slave/test', 16:55:59 INFO - 'SHELL': '/bin/bash', 16:55:59 INFO - 'SHLVL': '1', 16:55:59 INFO - 'TERM': 'linux', 16:55:59 INFO - 'TMOUT': '86400', 16:55:59 INFO - 'USER': 'cltbld', 16:55:59 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995', 16:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:59 INFO - '_': '/tools/buildbot/bin/python'} 16:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:55:59 INFO - Running setup.py (path:/tmp/pip-mXUfNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:55:59 INFO - Running setup.py (path:/tmp/pip-9FcgL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:55:59 INFO - Running setup.py (path:/tmp/pip-V9Xtry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:55:59 INFO - Running setup.py (path:/tmp/pip-qyvk_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:55:59 INFO - Running setup.py (path:/tmp/pip-FvVxJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:55:59 INFO - Running setup.py (path:/tmp/pip-GIarK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:55:59 INFO - Running setup.py (path:/tmp/pip-chgRHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:55:59 INFO - Running setup.py (path:/tmp/pip-xJuqWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:55:59 INFO - Running setup.py (path:/tmp/pip-8VhA7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:55:59 INFO - Running setup.py (path:/tmp/pip-BR1piD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:56:00 INFO - Running setup.py (path:/tmp/pip-q78v2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:56:00 INFO - Running setup.py (path:/tmp/pip-oPI4qX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:56:00 INFO - Running setup.py (path:/tmp/pip-c9bJhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:56:00 INFO - Running setup.py (path:/tmp/pip-yOcRlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:00 INFO - Running setup.py (path:/tmp/pip-v6EGDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:56:00 INFO - Running setup.py (path:/tmp/pip-Om7syY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:56:00 INFO - Running setup.py (path:/tmp/pip-YkCeP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:56:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:56:00 INFO - Running setup.py install for manifestparser 16:56:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:56:00 INFO - Running setup.py install for mozcrash 16:56:00 INFO - Running setup.py install for mozdebug 16:56:00 INFO - Running setup.py install for mozdevice 16:56:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:56:00 INFO - Running setup.py install for mozfile 16:56:01 INFO - Running setup.py install for mozhttpd 16:56:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:56:01 INFO - Running setup.py install for mozinfo 16:56:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:56:01 INFO - Running setup.py install for mozInstall 16:56:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:56:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:56:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:56:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:56:01 INFO - Running setup.py install for mozleak 16:56:01 INFO - Running setup.py install for mozlog 16:56:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:56:01 INFO - Running setup.py install for moznetwork 16:56:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:56:01 INFO - Running setup.py install for mozprocess 16:56:01 INFO - Running setup.py install for mozprofile 16:56:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:56:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:56:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:56:01 INFO - Running setup.py install for mozrunner 16:56:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:56:01 INFO - Running setup.py install for mozscreenshot 16:56:02 INFO - Running setup.py install for moztest 16:56:02 INFO - Running setup.py install for mozversion 16:56:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:56:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:56:02 INFO - Cleaning up... 16:56:02 INFO - Return code: 0 16:56:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:56: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')]} 16:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56: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')]} 16:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:02 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 0x122f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1599d60>, '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 0x159aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159aef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995', '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 16:56:02 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 16:56:02 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 16:56:02 INFO - Using env: {'DISPLAY': ':0', 16:56:02 INFO - 'HOME': '/home/cltbld', 16:56:02 INFO - 'LANG': 'en_US.UTF-8', 16:56:02 INFO - 'LANGUAGE': 'en_US:en', 16:56:02 INFO - 'LOGNAME': 'cltbld', 16:56:02 INFO - 'MAIL': '/var/mail/cltbld', 16:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:02 INFO - 'MOZ_NO_REMOTE': '1', 16:56:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:02 INFO - 'NO_EM_RESTART': '1', 16:56:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:02 INFO - 'PWD': '/builds/slave/test', 16:56:02 INFO - 'SHELL': '/bin/bash', 16:56:02 INFO - 'SHLVL': '1', 16:56:02 INFO - 'TERM': 'linux', 16:56:02 INFO - 'TMOUT': '86400', 16:56:02 INFO - 'USER': 'cltbld', 16:56:02 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995', 16:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:02 INFO - '_': '/tools/buildbot/bin/python'} 16:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:56:02 INFO - Running setup.py (path:/tmp/pip-ax1UJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:56:02 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)) 16:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:56:02 INFO - Running setup.py (path:/tmp/pip-GWWiEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:56:02 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)) 16:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:56:02 INFO - Running setup.py (path:/tmp/pip-B6Gakg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:56:02 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)) 16:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:56:02 INFO - Running setup.py (path:/tmp/pip-9DNONN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:56:02 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)) 16:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:56:02 INFO - Running setup.py (path:/tmp/pip-QIzh7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:56:02 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)) 16:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:56:02 INFO - Running setup.py (path:/tmp/pip-T0Kdpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:56:02 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)) 16:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:56:02 INFO - Running setup.py (path:/tmp/pip-wks28y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:56:03 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)) 16:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:56:03 INFO - Running setup.py (path:/tmp/pip-LPzbLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:56:03 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)) 16:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:56:03 INFO - Running setup.py (path:/tmp/pip-ECcyyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:56:03 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)) 16:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:56:03 INFO - Running setup.py (path:/tmp/pip-9VBBR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:56:03 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)) 16:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:56:03 INFO - Running setup.py (path:/tmp/pip-tsEPxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:56:03 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)) 16:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:56:03 INFO - Running setup.py (path:/tmp/pip-HrGqTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:56:03 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)) 16:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:56:03 INFO - Running setup.py (path:/tmp/pip-x6a3DD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:56:03 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)) 16:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:56:03 INFO - Running setup.py (path:/tmp/pip-lNh1_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:56:03 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)) 16:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:03 INFO - Running setup.py (path:/tmp/pip-vFCEFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:03 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)) 16:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:56:03 INFO - Running setup.py (path:/tmp/pip-LmkWHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:56:03 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)) 16:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:56:03 INFO - Running setup.py (path:/tmp/pip-v2qupH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:56:03 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)) 16:56:03 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)) 16:56:03 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)) 16:56:03 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)) 16:56:03 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)) 16:56:03 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)) 16:56:03 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)) 16:56:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:56: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 16:56: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 16:56: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 16:56: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 16:56:04 INFO - Downloading blessings-1.6.tar.gz 16:56:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:56:04 INFO - Installing collected packages: blessings 16:56:04 INFO - Running setup.py install for blessings 16:56:05 INFO - Successfully installed blessings 16:56:05 INFO - Cleaning up... 16:56:05 INFO - Return code: 0 16:56:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:56:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:56:05 INFO - Reading from file tmpfile_stdout 16:56:05 INFO - Current package versions: 16:56:05 INFO - argparse == 1.2.1 16:56:05 INFO - blessings == 1.6 16:56:05 INFO - blobuploader == 1.2.4 16:56:05 INFO - docopt == 0.6.1 16:56:05 INFO - functools32 == 3.2.3-2 16:56:05 INFO - jsonschema == 2.5.1 16:56:05 INFO - manifestparser == 1.1 16:56:05 INFO - mozInstall == 1.13 16:56:05 INFO - mozcrash == 1.0 16:56:05 INFO - mozdebug == 0.1 16:56:05 INFO - mozdevice == 0.51 16:56:05 INFO - mozfile == 1.2 16:56:05 INFO - mozhttpd == 0.7 16:56:05 INFO - mozinfo == 0.10 16:56:05 INFO - mozleak == 0.1 16:56:05 INFO - mozlog == 3.5 16:56:05 INFO - moznetwork == 0.27 16:56:05 INFO - mozprocess == 0.25 16:56:05 INFO - mozprofile == 0.28 16:56:05 INFO - mozrunner == 6.13 16:56:05 INFO - mozscreenshot == 0.1 16:56:05 INFO - mozsystemmonitor == 0.3 16:56:05 INFO - moztest == 0.8 16:56:05 INFO - mozversion == 1.4 16:56:05 INFO - psutil == 3.1.1 16:56:05 INFO - requests == 1.2.3 16:56:05 INFO - wsgiref == 0.1.2 16:56:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:05 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 0x122f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1599d60>, '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 0x159aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159aef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995', '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 16:56:05 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 16:56:05 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 16:56:05 INFO - Using env: {'DISPLAY': ':0', 16:56:05 INFO - 'HOME': '/home/cltbld', 16:56:05 INFO - 'LANG': 'en_US.UTF-8', 16:56:05 INFO - 'LANGUAGE': 'en_US:en', 16:56:05 INFO - 'LOGNAME': 'cltbld', 16:56:05 INFO - 'MAIL': '/var/mail/cltbld', 16:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:05 INFO - 'MOZ_NO_REMOTE': '1', 16:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:05 INFO - 'NO_EM_RESTART': '1', 16:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:05 INFO - 'PWD': '/builds/slave/test', 16:56:05 INFO - 'SHELL': '/bin/bash', 16:56:05 INFO - 'SHLVL': '1', 16:56:05 INFO - 'TERM': 'linux', 16:56:05 INFO - 'TMOUT': '86400', 16:56:05 INFO - 'USER': 'cltbld', 16:56:05 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995', 16:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:05 INFO - '_': '/tools/buildbot/bin/python'} 16:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:05 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)) 16:56:05 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)) 16:56:05 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)) 16:56:05 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)) 16:56:05 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)) 16:56:05 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)) 16:56:05 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)) 16:56:05 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)) 16:56:05 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)) 16:56:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:56:05 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 16:56:05 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 16:56:05 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 16:56:05 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 16:56:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:56:06 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)) 16:56:06 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)) 16:56:06 INFO - Installing collected packages: simplejson 16:56:06 INFO - Running setup.py install for simplejson 16:56:06 INFO - building 'simplejson._speedups' extension 16:56:06 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 16:56:07 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 16:56:07 INFO - Successfully installed simplejson 16:56:07 INFO - Cleaning up... 16:56:07 INFO - Return code: 0 16:56:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:56: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')]} 16:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56: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')]} 16:56:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:07 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 0x122f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1599d60>, '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 0x159aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159aef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995', '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 16:56:07 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 16:56:07 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 16:56:07 INFO - Using env: {'DISPLAY': ':0', 16:56:07 INFO - 'HOME': '/home/cltbld', 16:56:07 INFO - 'LANG': 'en_US.UTF-8', 16:56:07 INFO - 'LANGUAGE': 'en_US:en', 16:56:07 INFO - 'LOGNAME': 'cltbld', 16:56:07 INFO - 'MAIL': '/var/mail/cltbld', 16:56:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:07 INFO - 'MOZ_NO_REMOTE': '1', 16:56:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:07 INFO - 'NO_EM_RESTART': '1', 16:56:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:07 INFO - 'PWD': '/builds/slave/test', 16:56:07 INFO - 'SHELL': '/bin/bash', 16:56:07 INFO - 'SHLVL': '1', 16:56:07 INFO - 'TERM': 'linux', 16:56:07 INFO - 'TMOUT': '86400', 16:56:07 INFO - 'USER': 'cltbld', 16:56:07 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995', 16:56:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:07 INFO - '_': '/tools/buildbot/bin/python'} 16:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:56:07 INFO - Cleaning up... 16:56:07 INFO - Return code: 0 16:56:07 INFO - Running post-action listener: _resource_record_post_action 16:56:07 INFO - Running post-action listener: _start_resource_monitoring 16:56:07 INFO - Starting resource monitoring. 16:56:07 INFO - [mozharness: 2017-10-02 23:56:07.985092Z] Finished create-virtualenv step (success) 16:56:07 INFO - [mozharness: 2017-10-02 23:56:07.985555Z] Running install step. 16:56:07 INFO - Running pre-action listener: _resource_record_pre_action 16:56:07 INFO - Running main action method: install 16:56:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:56:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:56:08 INFO - Reading from file tmpfile_stdout 16:56:08 INFO - Detecting whether we're running mozinstall >=1.0... 16:56:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:56:08 INFO - Reading from file tmpfile_stdout 16:56:08 INFO - Output received: 16:56:08 INFO - Usage: mozinstall [options] installer 16:56:08 INFO - Options: 16:56:08 INFO - -h, --help show this help message and exit 16:56:08 INFO - -d DEST, --destination=DEST 16:56:08 INFO - Directory to install application into. [default: 16:56:08 INFO - "/builds/slave/test"] 16:56:08 INFO - --app=APP Application being installed. [default: firefox] 16:56:08 INFO - mkdir: /builds/slave/test/build/application 16:56:08 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'] 16:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:56:26 INFO - Reading from file tmpfile_stdout 16:56:26 INFO - Output received: 16:56:26 INFO - /builds/slave/test/build/application/firefox/firefox 16:56:26 INFO - Running post-action listener: _resource_record_post_action 16:56:26 INFO - [mozharness: 2017-10-02 23:56:26.136885Z] Finished install step (success) 16:56:26 INFO - [mozharness: 2017-10-02 23:56:26.137137Z] Running setup-mitmproxy step. 16:56:26 INFO - Running pre-action listener: _resource_record_pre_action 16:56:26 INFO - Running main action method: setup_mitmproxy 16:56:26 INFO - Skipping: mitmproxy is not required 16:56:26 INFO - Running post-action listener: _resource_record_post_action 16:56:26 INFO - [mozharness: 2017-10-02 23:56:26.138273Z] Finished setup-mitmproxy step (success) 16:56:26 INFO - [mozharness: 2017-10-02 23:56:26.138508Z] Running run-tests step. 16:56:26 INFO - Running pre-action listener: _resource_record_pre_action 16:56:26 INFO - Running pre-action listener: _set_gcov_prefix 16:56:26 INFO - Running main action method: run_tests 16:56:26 WARNING - Try message not found. 16:56:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:56:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:56:26 INFO - Python 2.7.3 16:56:26 INFO - Return code: 0 16:56:26 INFO - grabbing minidump binary from tooltool 16:56:26 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')]} 16:56:26 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 0x1599d60>, '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 0x159aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159aef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:56:26 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 16:56:26 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 16:56:26 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 16:56:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:56:26 INFO - Return code: 0 16:56:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:56:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:56:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:56:26 INFO - ENV: RUST_BACKTRACE is now full 16:56:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:56:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:56:26 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/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 16:56:26 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/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 16:56:26 INFO - Using env: {'DISPLAY': ':0', 16:56:26 INFO - 'HOME': '/home/cltbld', 16:56:26 INFO - 'LANG': 'en_US.UTF-8', 16:56:26 INFO - 'LANGUAGE': 'en_US:en', 16:56:26 INFO - 'LOGNAME': 'cltbld', 16:56:26 INFO - 'MAIL': '/var/mail/cltbld', 16:56:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:56:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:56:26 INFO - 'MOZ_ACCELERATED': '1', 16:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:26 INFO - 'MOZ_NO_REMOTE': '1', 16:56:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:56:26 INFO - 'MOZ_WEBRENDER': '1', 16:56:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:26 INFO - 'NO_EM_RESTART': '1', 16:56:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:26 INFO - 'PWD': '/builds/slave/test', 16:56:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:56:26 INFO - 'RUST_BACKTRACE': 'full', 16:56:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:56:26 INFO - 'SHELL': '/bin/bash', 16:56:26 INFO - 'SHLVL': '1', 16:56:26 INFO - 'TERM': 'linux', 16:56:26 INFO - 'TMOUT': '86400', 16:56:26 INFO - 'USER': 'cltbld', 16:56:26 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995', 16:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:26 INFO - '_': '/tools/buildbot/bin/python'} 16:56:26 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/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 16:56:26 INFO - mozversion application_buildid: 20171002230255 16:56:26 INFO - mozversion application_changeset: 8c6b4fd1d76927cf8b07eb045c5aadd47b77d910 16:56:26 INFO - mozversion application_display_name: Nightly 16:56:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:56:26 INFO - mozversion application_name: Firefox 16:56:26 INFO - mozversion application_remotingname: firefox 16:56:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:56:26 INFO - mozversion application_vendor: Mozilla 16:56:26 INFO - mozversion application_version: 58.0a1 16:56:26 INFO - mozversion platform_buildid: 20171002230255 16:56:26 INFO - mozversion platform_changeset: 8c6b4fd1d76927cf8b07eb045c5aadd47b77d910 16:56:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:56:26 INFO - mozversion platform_version: 58.0a1 16:56:26 INFO - using testdate: 1506988586 16:56:26 INFO - actual date: 1506988586 16:56:26 INFO - starting webserver on 'localhost:42571' 16:56:26 INFO - SUITE-START | Running 2 tests 16:56:26 INFO - TEST-START | dromaeo_css 16:56:26 INFO - Initialising browser for dromaeo_css test... 16:56:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42571/getInfo.html -profile /tmp/tmpI1co_l/profile 16:56:26 INFO - TEST-INFO | started process 12211 (/builds/slave/test/build/application/firefox/firefox http://localhost:42571/getInfo.html) 16:56:33 INFO - TEST-INFO | 12211: exit 0 16:56:33 INFO - Browser initialized. 16:56:33 INFO - Running cycle 1/1 for dromaeo_css test... 16:56:33 INFO - Using env: {'DISPLAY': ':0', 16:56:33 INFO - 'HOME': '/home/cltbld', 16:56:33 INFO - 'JSGC_DISABLE_POISONING': '1', 16:56:33 INFO - 'LANG': 'en_US.UTF-8', 16:56:33 INFO - 'LANGUAGE': 'en_US:en', 16:56:33 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:56:33 INFO - 'LOGNAME': 'cltbld', 16:56:33 INFO - 'MAIL': '/var/mail/cltbld', 16:56:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:56:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:56:33 INFO - 'MOZ_ACCELERATED': '1', 16:56:33 INFO - 'MOZ_CRASHREPORTER': '1', 16:56:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:33 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:56:33 INFO - 'MOZ_NO_REMOTE': '1', 16:56:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:56:33 INFO - 'MOZ_WEBRENDER': '1', 16:56:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:33 INFO - 'NO_EM_RESTART': '1', 16:56:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:33 INFO - 'PWD': '/builds/slave/test', 16:56:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:56:33 INFO - 'RUST_BACKTRACE': 'full', 16:56:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:56:33 INFO - 'SHELL': '/bin/bash', 16:56:33 INFO - 'SHLVL': '1', 16:56:33 INFO - 'TERM': 'linux', 16:56:33 INFO - 'TMOUT': '86400', 16:56:33 INFO - 'USER': 'cltbld', 16:56:33 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995', 16:56:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:33 INFO - '_': '/tools/buildbot/bin/python'} 16:56:33 INFO - TEST-INFO | started process 12453 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI1co_l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:56:34 INFO - PID 12453 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:56:35 INFO - PID 12453 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:56:35 INFO - PID 12453 | 16:56:35 INFO - PID 12453 | (/builds/slave/test/build/application/firefox/firefox:12512): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:56:35 INFO - PID 12453 | 16:56:45 INFO - PID 12453 | RSS: Main: 204509184 16:56:45 INFO - PID 12453 | 16:59:43 INFO - PID 12453 | Cycle 1(1): loaded http://localhost:42571/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42571/tests/dromaeo/cssquery-ext.html) 16:59:44 INFO - PID 12453 | RSS: Main: 203436032 16:59:44 INFO - PID 12453 | 17:02:47 INFO - PID 12453 | Cycle 1(1): loaded http://localhost:42571/tests/dromaeo/cssquery-ext.html (next: http://localhost:42571/tests/dromaeo/cssquery-jquery.html) 17:02:47 INFO - PID 12453 | RSS: Main: 203251712 17:02:47 INFO - PID 12453 | 17:05:49 INFO - PID 12453 | Cycle 1(1): loaded http://localhost:42571/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42571/tests/dromaeo/cssquery-mootools.html) 17:05:50 INFO - PID 12453 | RSS: Main: 204464128 17:05:50 INFO - PID 12453 | 17:08:52 INFO - PID 12453 | Cycle 1(1): loaded http://localhost:42571/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42571/tests/dromaeo/cssquery-prototype.html) 17:08:53 INFO - PID 12453 | RSS: Main: 204046336 17:08:53 INFO - PID 12453 | 17:11:56 INFO - PID 12453 | Cycle 1(1): loaded http://localhost:42571/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42571/tests/dromaeo/cssquery-yui.html) 17:11:57 INFO - PID 12453 | RSS: Main: 206422016 17:11:57 INFO - PID 12453 | 17:14:59 INFO - PID 12453 | Cycle 1(1): loaded http://localhost:42571/tests/dromaeo/cssquery-yui.html (next: http://localhost:42571/tests/dromaeo/cssquery-dojo.html) 17:14:59 INFO - PID 12453 | RSS: Main: 208019456 17:14:59 INFO - PID 12453 | 17:14:59 INFO - PID 12453 | __start_tp_report 17:14:59 INFO - PID 12453 | _x_x_mozilla_page_load 17:14:59 INFO - PID 12453 | _x_x_mozilla_page_load_details 17:14:59 INFO - PID 12453 | |i|pagename|runs| 17:14:59 INFO - PID 12453 | |0;dojo.html;3210.2295449092226;3210.9518357224647;3214.2285851395663;3227.193201699575;3228.9838550807235;6087.756489740405;6284.183056202699;6333.8099857004245;6356.269029061659;6441.903371449432;6220.84447888803;6286.779962701306;6321.051842223669;6325.620462772237;6329.841753956153;5776.537876969833;5790.305163380401;5799.21710569072;5823.864346452444;5893.440123188312;5808.477237048664;5829.242198514187;5852.853678658025;5875.441833025877;5885.823425297226;5841.5326773858205;5886.852828679274;5907.350191478934;5917.319508256563;5954.434328738785;5497.45025497451;5676.914846277309;5744.253247077895;5826.135537745782;5920.97039514804;5386.245925570423;5785.421457854223;5852.15143804146;5858.238429004202;5859.882802343929;6159.84600384994;6229.501639868799;6237.345078766755;6348.333424990402;6387.968060159716;6738.494612904052;6746.865062698718;6765.052892594991;6794.932050679479;6810.829729256759;6781.966090169518;6839.384455399038;6844.623545704984;6862.828429289308;6884.931150688529;6240.656763877985;6297.6536290504;6319.6208227506495;6333.113364129025;6344.460720838688;6706.161729783777;6812.182538095361;6865.5537390069485;6984.895226571605;7003.194632617212;6575.408213260829;6582.078509008743;6599.60402375859;6600.306967768315;6645.966770166215;6542.934570654328;6601.240857301375;6616.27221005689;6687.230968438595;6689.2307384651385;6622.2715501294815;6648.734050638017;6691.832704182337;6719.630420326831;6731.798046058626;6763.425108865703;6790.253072162058;6806.76176333826;6867.622280774605;6879.58722476653;5290.867728306823;5292.9735351323;5365.409804921455;5366.275552800322;5375.75809088592;4516.480604730498;4554.612857907049;4557.931631025537;4574.771261436915;4575.3823233863;5561.332640083216;5602.859928501739;5625.099984002622;5737.598368114275;5811.389804070512;6817.897731534031;6837.589744615339;6849.1438570178725;6858.794236172923;6877.552959057645;5729;5785.652860828363;5805.419458054161;5819.650820950672;5896.498797602166;5645.096784514458;5712.6286791358425;5779.3642699303045;5839.9124013139835;5858.882822343615;6446.548741588043;6447.6453795041725;6461.321561236096;6476.514261430318;6517.348265173539;6674.098996635392;6684.398404143456;6703.664816759143;6807.863842723217;6877.449804015767;6488.578242414228;6522.249941256816;6612.70242839083;6630.701618427086;6656.30108838565;6628.53600247978;6630.23752268476;6641.435477984425;6642.3025582315095;6710.932890671031;6607.141071660653;6637.601743895381;6735.528513004238;6894.069300644549;6898.034275201376;6430.3891130342545;6502.967485162544;6507.0564768107415;6516;6518.511111666549;6499.155109835691;6499.2200935887995;6515.73937042532;6518.022296655539;6518.543701940818;6536.640484773383;6578.04618330349;6585.143931289093;6586;6606.942889137715;6594.90107648376;6612.867742645024;6642.535022548375;6675;6735.932640673531;6199.597026193283;6251.249850018027;6265.060240963892;6269.937300626935;6271.122042913905 17:14:59 INFO - PID 12453 | |1;ext.html;873.2533683700436;891.9732408027758;895.3374502867878;899.1188635137569;900.3022657440483;39211.80394098029;42593.574064259345;42915.78542107293;42996.57003429965;43185.7840710796;38510.80744596273;38513.614863851355;38770.61229387705;39075.41386879199;39095.60904390955;7203.927960720378;7274.781756547286;7313.634318284091;7333.853322933538;7358.117025956893;7208.207097219301;7248.2389349118375;7287.453440991921;7290.489665723375;7302.81742956425;7234.27657234275;7252.202257751643;7263.782086537412;7270.745523906664;7272.236415176383;7121.928780712205;7817.491863028885;7938.126806051329;7960.243776841191;8024.638891249908;7921.128675845653;8011.0386753589355;8017.438779285452;8017.839643207161;8033.839323213561;38337;38787.41818872719;38798;38809.805950970345;38878.61121388806;3507.5264839246884;3562.340966921128;3580.0512864090774;3585.229175727231;3606.6753992140834;32449.35101297961;32476.67523324784;32644.6735532644;32710.182245443815;32846.17884552881;5223.2165175223645;5228.686278823283;5228.79084836606;5268.868278293035;5269.947300527022;189289;189719;190523.04738476357;190779;191307;42974.57025429768;43938.56061439345;44233.778831105636;48264.27603585949;48479;51296.74351628293;51867;52097.7395113022;52187.21719174215;52511;14352.708256256987;14434.350454229585;14445.133292002514;14514;14541.491047813275;11536.884631153582;11590.768184636428;11594.94202528982;11640.534378624929;11683.883161168449;14116.788248176286;14239.928800355932;14362.856371436152;14409.279536023158;14416.711665766627;5670.5747068969995;5719.571032172604;5767.538596912237;5886.82111659699;5919.733611987471;1019.6940917724653;1029.8352263637782;1033.7415646088477;1036.6630844975261;1047.9633212837666;23164.420889477897;23605.29184124479;23746.287611371685;23795.04819807223;24022.15922442706;1111.1222134513644;1122.8280108692975;1127.836463712757;1134.8354488599107;1135.812590922505;12558.241846141547;12564.623061308175;12590.874091259153;12691.873081269254;12728.23630582168;233499;233707;234479;234742;235104;53898.46101539013;54221;54228.18657720138;54234.18648720272;54381.45618543843;1427.6508699279289;1461.7953486511897;1468.4566710317251;1472.4183947340741;1479.5635287590187;22613;23379.88310058439;23542.46973946688;23711.52576948486;23777.405564861016;38158.236835262585;38711.6128838708;38764.80617596894;38896.02759930911;38955.2208955825;195655;196251;197115;198024;198781;33072.17319566934;34380.31239375249;34799.30401392009;34989.650103498636;35220.119497012776;44267.33598995953;44302.77848610736;44740;44847;44883.102337953715;32550;32681.836590817846;32770.34459310848;32792.67207327896;32962;31704.841475792473;31726.682733173297;32187.839060804545;32515.512267315535;32711.836440818595;34854.651453486156;36268;36418.27163456769;36459.81770091239;36705;31405.371892561565;31653.84173079212;31711.682883170874;31734.52398214075;32063.519047214777;23485;24079.398015049763;24127.758722413255;24167.637485437383;24595.631065534388 17:14:59 INFO - PID 12453 | |2;jquery.html;580.6806256558891;588.2382314902201;591.5120025978566;599.2419589219636;602.5450784657583;21877;22681.319560413194;22720.204792832254;22729.77270227297;22801.885990570023;23856;24076;24251.75748242517;24380.198336532318;24475.26574202777;6490.513211509144;6705.865882682343;6715.899261511081;6718;6727.360900714424;6586.407223349922;6589.736410543573;6635.540181160137;6663.267040625527;6668.899966500482;6410.455111315544;6681.933180668204;6715.093462382589;6721.563098398613;6727.798166055001;6631.204255489348;6651.60090394573;6690.899636505456;6711.731530738764;6713.966430167867;5818.650880947157;6045.637261764308;6046.637201767908;6173.567850250484;6207.689615519206;27823.58264626032;28184.859075704695;28257;28266;28476.430471390457;1945.5330720626948;1972.2012584903136;1989.691597802343;1998.3005947918257;2000.1299434745931;18850.71723924142;19036.80963190378;19341.323053693195;19452.319168829024;19500.9274489903;2384.332386931662;2447.6940382452194;2455.042533411971;2455.508898220345;2458.21337172105;112552;117828.41085794516;119616;119735;123013;14193.922411710751;14368.497102601359;14529.626063391544;14745.23057233139;14867.628309292139;22313.55372892533;22322.55354892893;22673.093076276764;22720.886395567915;22830.31509054731;9314.254859611216;9393.483358415353;9553.665621703207;9618.567164477616;9704.748909115526;8490.915090849136;8568.143185681382;8637.956810216034;8672.176143266379;8677.39258251929;8738.95630521856;8838.160374764388;8854.911450885409;8861.424007439497;9006.504642244608;2593.9663822755797;2630.197789674168;2667.5731882898644;2748.477789220042;2792.7067657895627;929.2055292724758;939.2861425316672;953.5565961827783;959.5681943125621;960;18537.721934170997;18906.386483316168;19008.23967041303;19267.614647707247;19548;983.498415807943;999.9250056245811;1002.2583288366557;1016.7407311135761;1017.7506510904876;10512.842307365396;10560.788784224273;10566.260361774603;10580.518727378174;10672.893271067345;452185;463306;471299;471599;475805;105893;108360;108744.45627771968;109166.45416772865;109383.45308273408;1113.6659002299277;1132.63279745331;1140.7832511822562;1144.6566030191077;1152.423788105947;17124.743128852828;17257.137143142543;17267.222974965905;17748.3788067417;17756.822431775516;50810.23784643159;52144.73927630338;52549.7372513135;53117.7344113277;53795.19307210473;66953.66523167353;67369.3263067363;67410.32589674236;67435;68231.31768682448;13877.791833122714;14012.509562165274;14120.717585648435;14141.292935352985;14196.36116374745;21100.47248818792;21759.673604895623;21796.45508862291;21957;22178.889105554368;16166.272517736965;16336.101514416347;16377.93543419674;16447.671046579242;16533.008019518868;15793.052416855026;16344.67310653804;16346.346146154021;16486;16512.83487165113;16381.590460238589;16509.422170223985;18121.27514899442;18148.455546333633;18428.447146585622;13718.17690938547;13851.584452466443;13872.4451021958;13948.232847193502;13950.302484875918;16614.750778738086;16669.49991500257;16820.243089060776;16848.57878553046;17380.913095434444 17:14:59 INFO - PID 12453 | |3;mootools.html;1298.0913360647546;1363.8636136386363;1389.138733984929;1403.9017268791188;1406.1000959385995;13960.930195349021;14504.347304371302;14554.490592829254;14569.417223311055;14588;14359.138451692907;14478.493252736156;14500.41998320066;14503.854961450383;14510.709785804303;2604.882780274892;2630.302969713023;2657.2426858345375;2675.8528280944543;2683.6511253537014;2479.789217916479;2512.334231428673;2523.8990440382363;2524.406764410362;2535.949281014379;2477.603583426652;2480.082369523279;2651.058874099696;2769.2107749291454;2771.0855417712105;2653.4693061387798;2657.6677915260593;2672.4521473097966;2685.8388496690163;2686.932826679339;2646;2653.9601905971426;2666.080202330193;2670.5326567850548;2685;13485.865141348559;13906.860931390658;13918.791218131737;14077.084989475652;14205.431782728678;7475.7383491578075;7762.340201082915;7768.65041073153;7819.3744500439825;7875.921240787633;5113.795448182068;5323.148296272578;5420.512153906128;5445.9727701361635;5520.613557051008;1916.7987361327;1978.5251539630528;1978.8317992970615;1979.4853338132045;2032.7459067616549;24775.25674229776;24781;24809.25572232836;24896.626550601755;24907.252782416555;6573.1783527059115;6705.042732532519;6838.555493892881;6977.162740471074;6989.93010069903;16475.58811029734;16479.423220187236;16586.419475318547;16669.583260418345;16693.332266709196;7613.238676132342;7775.57234352116;7854.332381747501;7864;7870.881936770953;6799.5920244785475;6974.930250697529;7091.078159839291;7093.219745827955;7106.111736032996;5086.16078347076;5092.388913330424;5093.217373919173;5099.4390617032095;5100.413452453015;1548.5896237497072;1558.8363221861769;1564.3586129687;1575.708493928604;1580.2414840876213;902.7652810269377;905.185333200112;915.7481692534607;930.1024511346583;930.283681565191;7312.707491700273;7317.37802286801;7349.77950661481;7419.59192244421;7424.96287518559;730.9122905251297;737.5390381011867;738.5679377564185;747.9925200748032;748.3265061444635;4516.977415112903;4555.06621142665;4755.881102972453;5159.974200128975;5425.159100339453;19492.805071949384;19555.31556395519;20361.79638203599;20385.08267127983;20485.487862803548;19686.507837303896;20015.199392024446;20023.399298021082;20440.591188176153;20671.4832129195;9969.601215951427;10131.898681013095;10354.326968747007;10395.32430392022;10426.791464170674;7741.496802707806;7753.612319384121;7831.138574756658;7912.129665736879;7943.841123177389;16783.664326713155;17023.91488042552;17201;17619.647607048042;17957.191926363084;17949.282028718706;18050.638987219918;18370.89774613474;18490.63018739591;18594.907025464785;10786.838197426889;10807.189460790314;11017.889821101686;11028.062614677843;11094.22340436194;13171.275579842817;13305.66735831612;13426.395812188279;13429.798553021908;13439.328033598085;10449.634262800766;10645.8935410648;10707.143428525855;10837.67486975392;10953.780924381626;10600.628977985734;10682.412467314372;10695.893041069801;10788.568457261621;10852.782944341227;9456.669016584661;9565.808683826424;9684.95157524208;9699.78752655918;9712.5143742814;6683.532152749261;6865.622390768555;6882.208546017272;6908.1019467468905;6948.687309071003;7124.038254835531;7266.455015873725;7321.084864391951;7349;7366.521176123535 17:14:59 INFO - PID 12453 | |4;prototype.html;468.9437267527899;493.59278595159003;509.2971699055303;516.8268630008947;518.2666526864487;6242.219722534684;6256.7497300108;6259.906101408471;6326.272478664955;6353.428191462774;6137.785177518787;6147.649531005602;6149.415805498482;6154.599951003182;6160.691965401723;5114.207297868837;5148.253503242027;5152.273988213953;5187.688738675692;5195.246689230078;5142.768575414097;5145.408278048035;5147.948520514784;5180.119379705459;5193.766280517386;4712.552307530779;4942.209246520558;4948.925766113512;4952.628552858532;4974.676646017997;4873.366462359906;4913.213885778258;4946.159152944008;4976.701397916118;4986.675866068694;4383.9342409863875;4415.646748260164;4420.20436321462;4432.84485043022;4442.711223770445;6040.48655864252;6047.637141771464;6084.330723620398;6098.878022439526;6103;5642.802501912454;5657.660540367591;5668.43315668434;5676.574256930706;5742.368339482654;6498.967505162491;6504.568994821132;6511.837204069889;6544.836379090513;6576.441002514792;4592;4730.668853180278;4787.16224660683;4791.377120974286;4839.491853355382;6533.869322613568;6616.801495955129;6699.799006029827;6749.291324410964;6845.520813543004;4867.1969125093965;4916.926246106311;4917.311576379309;4962.6774259673;4976.751162441863;4956.826511072095;4965.155923493015;5003.149464591028;5031.4213865405945;5036.395632524121;5441.755121019563;5585.888282234332;5646.209530665628;5658.801941932013;5669.886602267931;6546.803595892131;6573.704183311763;6600.834979125464;6603.438707709803;6616.305287944792;1714.7342161964916;1716.9399071032703;1718.243972652029;1735.3752649046332;1745.8079611242754;1171.988280117205;1177.2929252583788;1186.7033241689578;1193.7552801675636;1202.8255902894032;5573.27547418833;5585.972070139624;5645.943540564542;5667.319921609351;5744.339400968858;6706;6712.160979877515;6720.22717387497;6762.526623136333;6777.271795692067;5653.462921022497;5659.462351076641;5689.402612725687;5729.541636669056;5755.740991655385;3499.267862408124;3501.2472318451655;3510.771230069455;3521.9823900880842;3554.87557935471;6319.936800631935;6349;6393.6163830170335;6415.294317625057;6520.641364724986;6728.259891411941;6825.35159159879;6864.622445765431;6880.314322990899;6911.17065952089;6332.905006424908;6368.235811702532;6395.392437718409;6414.775482858077;6487.610743355413;6599;6665.800025999228;6668.799936001928;6672.633005184762;6677.3656502632175;6529.216494020748;6604.438622717123;6614.966925165343;6639.634820084942;6707;6011.188489553854;6129.387061294014;6418.743250269937;6441.67791610427;6489.383508566679;4857.319975203545;4886.780094895809;4940.283658869515;4953.950460495493;4955.2567114933045;6622.801315960529;6669.566478178903;6687.598744075371;6693.230278517838;6734.966325168343;6163.660998645118;6359.427651511386;6361.968190159019;6418.6469744164515;6466;6280.246370435577;6398.392152745481;6450.48396128318;6499.415052645285;6519.445847103049;6280.52407684203;6368.363163683594;6392.264889537762;6418.358164183731;6439.649527922368;6332.556721029668;6539.934600653933;6588.143541339595;6596.70314835824;6620.966895165493;6226.782062627786;6233.885635480561;6241.469475094668;6244.1570387997035;6247.468965137832 17:14:59 INFO - PID 12453 | |5;yui.html;879.5426378283292;901.7925877048275;902.4810733828047;905.036136514612;908.4004556992386;18260.269589216416;18625.7206141908;18779;18811.153498092586;18858.528536786554;18481.353152639662;18518.90740546299;18577.814221857778;18715.90642046788;18800;949.264320151881;961.2550273538029;965.2181732796457;967.7483854197924;971.159946646153;984.9212063034976;993.4436715439341;997.7356000659831;998.3460833154296;999.170688328689;990.420603946692;1031.0565832263508;1045.513836066229;1051.6529545250087;1054.5781687325093;1028.7942411517688;1044.4255659387306;1044.6813721814844;1046.1839764983324;1046.9947650261777;717.6124892558013;759.7530802489213;760.2511526146797;760.4714723267332;762.0702742653954;20125.194992200293;20346.389608311776;20485.692714609293;20630.277940272168;20670.689939650918;21226.681599776017;21668.34994950154;21825;22015.669764953538;22169.113235470562;17039.914800426042;17070.317187312492;17146.828531714647;17614.471565853044;17677.38129165486;3664.8534058637624;3712.888613341604;3718.925621487555;3719.5350581177354;3720.7023438125157;100444.91546606121;136939.999999999;138858;141284;142038;17116.229769660396;17340.826591734174;17664.11679416024;17820.19809108593;17826.46520604384;30290.09129726112;30645.540316895265;30903.227419314248;30916.845415772776;30962.22594435112;8320.292775114183;8507.106753790888;8526.829463410697;8569.914300857037;8652.3510736695;4078;4087.734297270668;4115.444415003996;4137.8758637240935;4144.254034273859;5465.688234823614;5514.779408823602;5566.916496252559;5574.136008918624;5593.692346920959;1077.4397313397146;1089.128697042363;1117.5306371324064;1117.921745477825;1122.5958654884234;649.1560970738021;658.479800957248;674.8177991942148;678.1523096129838;683.9008343790123;12193.695157620952;12393.256404615571;12415.875841241652;12579.308138052495;12732.872671273353;672.9596224226563;680.7617333933084;684.3156843156843;695.6869408766075;703.0192880931072;5389.703566303812;5437.782488700408;5464.316960379952;5543.972280138654;5564.02629539837;126531;127828.36085819511;129909.35045324902;130933.03600446001;132616.3369183148;112544;112822.43588782003;113944.43027784974;115768;116828.41585792186;92504.53747731219;94542;96619;96684;96822;10248.333858299486;10252.692419227435;10273.589056437659;10292.073713365833;10642.627508037182;44187.33718994282;44656.33015504705;45369.694910511644;45608;45916.54083459123;58852.70573647276;59127.70436147792;60267;60747.69626151841;60990.39009609847;15833.416658334536;15966.441174558835;16057.91971040184;16064.67870642604;16369.09969951664;17291.91354043272;17453.30186792514;17479.213435395694;17608.29566817313;17757;16133.596660083593;16266.593335166715;16332.918335408247;16498.092604906844;16642.75035874487;16293.837061629707;16327.59181020484;16414.917925410296;16423.343066277215;16468.01191928488;16482.25829837684;16545.83454165491;16619.66760664804;16730.58173545671;16760.58098547546;10701.143908487458;10757.085647720032;11079.16906232052;11149;11277.436128193393;12303.507859685513;12335;12434.191777534432;12624.495020199089;12699.809502857279 17:14:59 INFO - PID 12453 | __end_tp_report 17:14:59 INFO - PID 12453 | __start_cc_report 17:14:59 INFO - PID 12453 | _x_x_mozilla_cycle_collect,292 17:14:59 INFO - PID 12453 | __end_cc_report 17:14:59 INFO - PID 12453 | __startTimestamp1506989699537__endTimestamp 17:14:59 INFO - PID 12453 | 17:14:59 INFO - PID 12453 | ------- Summary: start ------- 17:14:59 INFO - PID 12453 | Number of tests: 6 17:14:59 INFO - PID 12453 | 17:14:59 INFO - PID 12453 | [#0] dojo.html Cycles:165 Average:6192.27 Median:6447.65 stddev:742.32 (11.5%) stddev-sans-first:706.77 17:14:59 INFO - PID 12453 | Values: 3210.2 3211.0 3214.2 3227.2 3229.0 6087.8 6284.2 6333.8 6356.3 6441.9 6220.8 6286.8 6321.1 6325.6 6329.8 5776.5 5790.3 5799.2 5823.9 5893.4 5808.5 5829.2 5852.9 5875.4 5885.8 5841.5 5886.9 5907.4 5917.3 5954.4 5497.5 5676.9 5744.3 5826.1 5921.0 5386.2 5785.4 5852.2 5858.2 5859.9 6159.8 6229.5 6237.3 6348.3 6388.0 6738.5 6746.9 6765.1 6794.9 6810.8 6782.0 6839.4 6844.6 6862.8 6884.9 6240.7 6297.7 6319.6 6333.1 6344.5 6706.2 6812.2 6865.6 6984.9 7003.2 6575.4 6582.1 6599.6 6600.3 6646.0 6542.9 6601.2 6616.3 6687.2 6689.2 6622.3 6648.7 6691.8 6719.6 6731.8 6763.4 6790.3 6806.8 6867.6 6879.6 5290.9 5293.0 5365.4 5366.3 5375.8 4516.5 4554.6 4557.9 4574.8 4575.4 5561.3 5602.9 5625.1 5737.6 5811.4 6817.9 6837.6 6849.1 6858.8 6877.6 5729.0 5785.7 5805.4 5819.7 5896.5 5645.1 5712.6 5779.4 5839.9 5858.9 6446.5 6447.6 6461.3 6476.5 6517.3 6674.1 6684.4 6703.7 6807.9 6877.4 6488.6 6522.2 6612.7 6630.7 6656.3 6628.5 6630.2 6641.4 6642.3 6710.9 6607.1 6637.6 6735.5 6894.1 6898.0 6430.4 6503.0 6507.1 6516.0 6518.5 6499.2 6499.2 6515.7 6518.0 6518.5 6536.6 6578.0 6585.1 6586.0 6606.9 6594.9 6612.9 6642.5 6675.0 6735.9 6199.6 6251.2 6265.1 6269.9 6271.1 17:14:59 INFO - PID 12453 | 17:14:59 INFO - PID 12453 | [#1] ext.html Cycles:180 Average:37703.68 Median:19363.82 stddev:53963.70 (278.7%) stddev-sans-first:54044.22 17:14:59 INFO - PID 12453 | Values: 873.3 892.0 895.3 899.1 900.3 39211.8 42593.6 42915.8 42996.6 43185.8 38510.8 38513.6 38770.6 39075.4 39095.6 7203.9 7274.8 7313.6 7333.9 7358.1 7208.2 7248.2 7287.5 7290.5 7302.8 7234.3 7252.2 7263.8 7270.7 7272.2 7121.9 7817.5 7938.1 7960.2 8024.6 7921.1 8011.0 8017.4 8017.8 8033.8 38337.0 38787.4 38798.0 38809.8 38878.6 3507.5 3562.3 3580.1 3585.2 3606.7 32449.4 32476.7 32644.7 32710.2 32846.2 5223.2 5228.7 5228.8 5268.9 5269.9 189289.0 189719.0 190523.0 190779.0 191307.0 42974.6 43938.6 44233.8 48264.3 48479.0 51296.7 51867.0 52097.7 52187.2 52511.0 14352.7 14434.4 14445.1 14514.0 14541.5 11536.9 11590.8 11594.9 11640.5 11683.9 14116.8 14239.9 14362.9 14409.3 14416.7 5670.6 5719.6 5767.5 5886.8 5919.7 1019.7 1029.8 1033.7 1036.7 1048.0 23164.4 23605.3 23746.3 23795.0 24022.2 1111.1 1122.8 1127.8 1134.8 1135.8 12558.2 12564.6 12590.9 12691.9 12728.2 233499.0 233707.0 234479.0 234742.0 235104.0 53898.5 54221.0 54228.2 54234.2 54381.5 1427.7 1461.8 1468.5 1472.4 1479.6 22613.0 23379.9 23542.5 23711.5 23777.4 38158.2 38711.6 38764.8 38896.0 38955.2 195655.0 196251.0 197115.0 198024.0 198781.0 33072.2 34380.3 34799.3 34989.7 35220.1 44267.3 44302.8 44740.0 44847.0 44883.1 32550.0 32681.8 32770.3 32792.7 32962.0 31704.8 31726.7 32187.8 32515.5 32711.8 34854.7 36268.0 36418.3 36459.8 36705.0 31405.4 31653.8 31711.7 31734.5 32063.5 23485.0 24079.4 24127.8 24167.6 24595.6 17:14:59 INFO - PID 12453 | 17:14:59 INFO - PID 12453 | [#2] jquery.html Cycles:180 Average:32757.23 Median:22765.83 stddev:78162.39 (343.3%) stddev-sans-first:78344.32 17:14:59 INFO - PID 12453 | Values: 580.7 588.2 591.5 599.2 602.5 21877.0 22681.3 22720.2 22729.8 22801.9 23856.0 24076.0 24251.8 24380.2 24475.3 6490.5 6705.9 6715.9 6718.0 6727.4 6586.4 6589.7 6635.5 6663.3 6668.9 6410.5 6681.9 6715.1 6721.6 6727.8 6631.2 6651.6 6690.9 6711.7 6714.0 5818.7 6045.6 6046.6 6173.6 6207.7 27823.6 28184.9 28257.0 28266.0 28476.4 1945.5 1972.2 1989.7 1998.3 2000.1 18850.7 19036.8 19341.3 19452.3 19500.9 2384.3 2447.7 2455.0 2455.5 2458.2 112552.0 117828.4 119616.0 119735.0 123013.0 14193.9 14368.5 14529.6 14745.2 14867.6 22313.6 22322.6 22673.1 22720.9 22830.3 9314.3 9393.5 9553.7 9618.6 9704.7 8490.9 8568.1 8638.0 8672.2 8677.4 8739.0 8838.2 8854.9 8861.4 9006.5 2594.0 2630.2 2667.6 2748.5 2792.7 929.2 939.3 953.6 959.6 960.0 18537.7 18906.4 19008.2 19267.6 19548.0 983.5 999.9 1002.3 1016.7 1017.8 10512.8 10560.8 10566.3 10580.5 10672.9 452185.0 463306.0 471299.0 471599.0 475805.0 105893.0 108360.0 108744.5 109166.5 109383.5 1113.7 1132.6 1140.8 1144.7 1152.4 17124.7 17257.1 17267.2 17748.4 17756.8 50810.2 52144.7 52549.7 53117.7 53795.2 66953.7 67369.3 67410.3 67435.0 68231.3 13877.8 14012.5 14120.7 14141.3 14196.4 21100.5 21759.7 21796.5 21957.0 22178.9 16166.3 16336.1 16377.9 16447.7 16533.0 15793.1 16344.7 16346.3 16486.0 16512.8 16381.6 16509.4 18121.3 18148.5 18428.4 13718.2 13851.6 13872.4 13948.2 13950.3 16614.8 16669.5 16820.2 16848.6 17380.9 17:14:59 INFO - PID 12453 | 17:14:59 INFO - PID 12453 | [#3] mootools.html Cycles:180 Average:8873.63 Median:2570.42 stddev:6239.21 (242.7%) stddev-sans-first:6230.75 17:14:59 INFO - PID 12453 | Values: 1298.1 1363.9 1389.1 1403.9 1406.1 13960.9 14504.3 14554.5 14569.4 14588.0 14359.1 14478.5 14500.4 14503.9 14510.7 2604.9 2630.3 2657.2 2675.9 2683.7 2479.8 2512.3 2523.9 2524.4 2535.9 2477.6 2480.1 2651.1 2769.2 2771.1 2653.5 2657.7 2672.5 2685.8 2686.9 2646.0 2654.0 2666.1 2670.5 2685.0 13485.9 13906.9 13918.8 14077.1 14205.4 7475.7 7762.3 7768.7 7819.4 7875.9 5113.8 5323.1 5420.5 5446.0 5520.6 1916.8 1978.5 1978.8 1979.5 2032.7 24775.3 24781.0 24809.3 24896.6 24907.3 6573.2 6705.0 6838.6 6977.2 6989.9 16475.6 16479.4 16586.4 16669.6 16693.3 7613.2 7775.6 7854.3 7864.0 7870.9 6799.6 6974.9 7091.1 7093.2 7106.1 5086.2 5092.4 5093.2 5099.4 5100.4 1548.6 1558.8 1564.4 1575.7 1580.2 902.8 905.2 915.7 930.1 930.3 7312.7 7317.4 7349.8 7419.6 7425.0 730.9 737.5 738.6 748.0 748.3 4517.0 4555.1 4755.9 5160.0 5425.2 19492.8 19555.3 20361.8 20385.1 20485.5 19686.5 20015.2 20023.4 20440.6 20671.5 9969.6 10131.9 10354.3 10395.3 10426.8 7741.5 7753.6 7831.1 7912.1 7943.8 16783.7 17023.9 17201.0 17619.6 17957.2 17949.3 18050.6 18370.9 18490.6 18594.9 10786.8 10807.2 11017.9 11028.1 11094.2 13171.3 13305.7 13426.4 13429.8 13439.3 10449.6 10645.9 10707.1 10837.7 10953.8 10600.6 10682.4 10695.9 10788.6 10852.8 9456.7 9565.8 9685.0 9699.8 9712.5 6683.5 6865.6 6882.2 6908.1 6948.7 7124.0 7266.5 7321.1 7349.0 7366.5 17:14:59 INFO - PID 12453 | 17:14:59 INFO - PID 12453 | [#4] prototype.html Cycles:180 Average:5461.61 Median:6116.19 stddev:1532.54 (25.1%) stddev-sans-first:1490.32 17:14:59 INFO - PID 12453 | Values: 468.9 493.6 509.3 516.8 518.3 6242.2 6256.7 6259.9 6326.3 6353.4 6137.8 6147.6 6149.4 6154.6 6160.7 5114.2 5148.3 5152.3 5187.7 5195.2 5142.8 5145.4 5147.9 5180.1 5193.8 4712.6 4942.2 4948.9 4952.6 4974.7 4873.4 4913.2 4946.2 4976.7 4986.7 4383.9 4415.6 4420.2 4432.8 4442.7 6040.5 6047.6 6084.3 6098.9 6103.0 5642.8 5657.7 5668.4 5676.6 5742.4 6499.0 6504.6 6511.8 6544.8 6576.4 4592.0 4730.7 4787.2 4791.4 4839.5 6533.9 6616.8 6699.8 6749.3 6845.5 4867.2 4916.9 4917.3 4962.7 4976.8 4956.8 4965.2 5003.1 5031.4 5036.4 5441.8 5585.9 5646.2 5658.8 5669.9 6546.8 6573.7 6600.8 6603.4 6616.3 1714.7 1716.9 1718.2 1735.4 1745.8 1172.0 1177.3 1186.7 1193.8 1202.8 5573.3 5586.0 5645.9 5667.3 5744.3 6706.0 6712.2 6720.2 6762.5 6777.3 5653.5 5659.5 5689.4 5729.5 5755.7 3499.3 3501.2 3510.8 3522.0 3554.9 6319.9 6349.0 6393.6 6415.3 6520.6 6728.3 6825.4 6864.6 6880.3 6911.2 6332.9 6368.2 6395.4 6414.8 6487.6 6599.0 6665.8 6668.8 6672.6 6677.4 6529.2 6604.4 6615.0 6639.6 6707.0 6011.2 6129.4 6418.7 6441.7 6489.4 4857.3 4886.8 4940.3 4954.0 4955.3 6622.8 6669.6 6687.6 6693.2 6735.0 6163.7 6359.4 6362.0 6418.6 6466.0 6280.2 6398.4 6450.5 6499.4 6519.4 6280.5 6368.4 6392.3 6418.4 6439.6 6332.6 6539.9 6588.1 6596.7 6621.0 6226.8 6233.9 6241.5 6244.2 6247.5 17:14:59 INFO - PID 12453 | 17:14:59 INFO - PID 12453 | [#5] yui.html Cycles:180 Average:24619.70 Median:18789.50 stddev:35723.88 (190.1%) stddev-sans-first:35779.62 17:14:59 INFO - PID 12453 | Values: 879.5 901.8 902.5 905.0 908.4 18260.3 18625.7 18779.0 18811.2 18858.5 18481.4 18518.9 18577.8 18715.9 18800.0 949.3 961.3 965.2 967.7 971.2 984.9 993.4 997.7 998.3 999.2 990.4 1031.1 1045.5 1051.7 1054.6 1028.8 1044.4 1044.7 1046.2 1047.0 717.6 759.8 760.3 760.5 762.1 20125.2 20346.4 20485.7 20630.3 20670.7 21226.7 21668.3 21825.0 22015.7 22169.1 17039.9 17070.3 17146.8 17614.5 17677.4 3664.9 3712.9 3718.9 3719.5 3720.7 100444.9 136940.0 138858.0 141284.0 142038.0 17116.2 17340.8 17664.1 17820.2 17826.5 30290.1 30645.5 30903.2 30916.8 30962.2 8320.3 8507.1 8526.8 8569.9 8652.4 4078.0 4087.7 4115.4 4137.9 4144.3 5465.7 5514.8 5566.9 5574.1 5593.7 1077.4 1089.1 1117.5 1117.9 1122.6 649.2 658.5 674.8 678.2 683.9 12193.7 12393.3 12415.9 12579.3 12732.9 673.0 680.8 684.3 695.7 703.0 5389.7 5437.8 5464.3 5544.0 5564.0 126531.0 127828.4 129909.4 130933.0 132616.3 112544.0 112822.4 113944.4 115768.0 116828.4 92504.5 94542.0 96619.0 96684.0 96822.0 10248.3 10252.7 10273.6 10292.1 10642.6 44187.3 44656.3 45369.7 45608.0 45916.5 58852.7 59127.7 60267.0 60747.7 60990.4 15833.4 15966.4 16057.9 16064.7 16369.1 17291.9 17453.3 17479.2 17608.3 17757.0 16133.6 16266.6 16332.9 16498.1 16642.8 16293.8 16327.6 16414.9 16423.3 16468.0 16482.3 16545.8 16619.7 16730.6 16760.6 10701.1 10757.1 11079.2 11149.0 11277.4 12303.5 12335.0 12434.2 12624.5 12699.8 17:14:59 INFO - PID 12453 | -------- Summary: end -------- 17:14:59 INFO - PID 12453 | 17:15:00 INFO - TEST-INFO | 12453: exit 0 17:15:00 INFO - TEST-OK | dromaeo_css | took 1113816ms 17:15:00 INFO - TEST-START | kraken 17:15:00 INFO - Initialising browser for kraken test... 17:15:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42571/getInfo.html -profile /tmp/tmpnB07JH/profile 17:15:00 INFO - TEST-INFO | started process 12821 (/builds/slave/test/build/application/firefox/firefox http://localhost:42571/getInfo.html) 17:15:07 INFO - TEST-INFO | 12821: exit 0 17:15:07 INFO - Browser initialized. 17:15:07 INFO - Running cycle 1/1 for kraken test... 17:15:07 INFO - Using env: {'DISPLAY': ':0', 17:15:07 INFO - 'HOME': '/home/cltbld', 17:15:07 INFO - 'JSGC_DISABLE_POISONING': '1', 17:15:07 INFO - 'LANG': 'en_US.UTF-8', 17:15:07 INFO - 'LANGUAGE': 'en_US:en', 17:15:07 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:15:07 INFO - 'LOGNAME': 'cltbld', 17:15:07 INFO - 'MAIL': '/var/mail/cltbld', 17:15:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:15:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:15:07 INFO - 'MOZ_ACCELERATED': '1', 17:15:07 INFO - 'MOZ_CRASHREPORTER': '1', 17:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:07 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:15:07 INFO - 'MOZ_NO_REMOTE': '1', 17:15:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:15:07 INFO - 'MOZ_WEBRENDER': '1', 17:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:07 INFO - 'NO_EM_RESTART': '1', 17:15:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:07 INFO - 'PWD': '/builds/slave/test', 17:15:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:15:07 INFO - 'RUST_BACKTRACE': 'full', 17:15:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:15:07 INFO - 'SHELL': '/bin/bash', 17:15:07 INFO - 'SHLVL': '1', 17:15:07 INFO - 'TERM': 'linux', 17:15:07 INFO - 'TMOUT': '86400', 17:15:07 INFO - 'USER': 'cltbld', 17:15:07 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995', 17:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:07 INFO - '_': '/tools/buildbot/bin/python'} 17:15:07 INFO - TEST-INFO | started process 13065 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnB07JH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:15:08 INFO - PID 13065 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 17:15:08 INFO - PID 13065 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 17:15:08 INFO - PID 13065 | 17:15:08 INFO - PID 13065 | (/builds/slave/test/build/application/firefox/firefox:13125): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:15:08 INFO - PID 13065 | 17:15:19 INFO - PID 13065 | RSS: Main: 208850944 17:15:19 INFO - PID 13065 | 17:15:21 INFO - PID 13065 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42571/tests/kraken/driver.html?testName=audio-beat-detection) 17:15:22 INFO - PID 13065 | RSS: Main: 206237696 17:15:22 INFO - PID 13065 | 17:15:25 INFO - PID 13065 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42571/tests/kraken/driver.html?testName=audio-dft) 17:15:25 INFO - PID 13065 | RSS: Main: 206372864 17:15:25 INFO - PID 13065 | 17:15:28 INFO - PID 13065 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42571/tests/kraken/driver.html?testName=audio-fft) 17:15:29 INFO - PID 13065 | RSS: Main: 202551296 17:15:29 INFO - PID 13065 | 17:15:31 INFO - PID 13065 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42571/tests/kraken/driver.html?testName=audio-oscillator) 17:15:32 INFO - PID 13065 | RSS: Main: 202940416 17:15:32 INFO - PID 13065 | 17:15:34 INFO - PID 13065 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42571/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:15:35 INFO - PID 13065 | RSS: Main: 203427840 17:15:35 INFO - PID 13065 | 17:15:38 INFO - PID 13065 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42571/tests/kraken/driver.html?testName=imaging-darkroom) 17:15:39 INFO - PID 13065 | RSS: Main: 205615104 17:15:39 INFO - PID 13065 | 17:15:42 INFO - PID 13065 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42571/tests/kraken/driver.html?testName=imaging-desaturate) 17:15:43 INFO - PID 13065 | RSS: Main: 205606912 17:15:43 INFO - PID 13065 | 17:15:46 INFO - PID 13065 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42571/tests/kraken/driver.html?testName=json-parse-financial) 17:15:47 INFO - PID 13065 | RSS: Main: 205991936 17:15:47 INFO - PID 13065 | 17:15:48 INFO - PID 13065 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42571/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:15:49 INFO - PID 13065 | RSS: Main: 206012416 17:15:49 INFO - PID 13065 | 17:15:50 INFO - PID 13065 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42571/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:15:51 INFO - PID 13065 | RSS: Main: 205873152 17:15:51 INFO - PID 13065 | 17:15:53 INFO - PID 13065 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42571/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:15:54 INFO - PID 13065 | RSS: Main: 206045184 17:15:54 INFO - PID 13065 | 17:15:57 INFO - PID 13065 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42571/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:15:57 INFO - PID 13065 | RSS: Main: 206778368 17:15:57 INFO - PID 13065 | 17:16:00 INFO - PID 13065 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42571/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:16:01 INFO - PID 13065 | RSS: Main: 206426112 17:16:01 INFO - PID 13065 | 17:16:03 INFO - PID 13065 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42571/tests/kraken/driver.html?testName=ai-astar) 17:16:03 INFO - PID 13065 | RSS: Main: 207728640 17:16:03 INFO - PID 13065 | 17:16:03 INFO - PID 13065 | __start_tp_report 17:16:03 INFO - PID 13065 | _x_x_mozilla_page_load 17:16:03 INFO - PID 13065 | _x_x_mozilla_page_load_details 17:16:03 INFO - PID 13065 | |i|pagename|runs| 17:16:03 INFO - PID 13065 | |0;ai-astar;109;113;107;109;114;114;107;112;108;108 17:16:03 INFO - PID 13065 | |1;audio-beat-detection;117;133;123;121;120;141;127;125;119;116 17:16:03 INFO - PID 13065 | |2;audio-dft;163;165;166;170;164;182;166;164;168;164 17:16:03 INFO - PID 13065 | |3;audio-fft;86;83;81;77;83;77;86;77;74;73 17:16:03 INFO - PID 13065 | |4;audio-oscillator;83;86;89;97;82;86;83;79;80;80 17:16:03 INFO - PID 13065 | |5;imaging-gaussian-blur;114;115;119;114;114;114;123;117;115;116 17:16:03 INFO - PID 13065 | |6;imaging-darkroom;149;153;149;150;151;149;148;150;156;149 17:16:03 INFO - PID 13065 | |7;imaging-desaturate;101;94;95;94;95;94;96;100;95;99 17:16:03 INFO - PID 13065 | |8;json-parse-financial;55;53;52;61;51;52;56;50;52;50 17:16:03 INFO - PID 13065 | |9;json-stringify-tinderbox;39;45;38;41;38;48;45;46;42;43 17:16:03 INFO - PID 13065 | |10;stanford-crypto-aes;73;78;74;72;78;77;72;72;77;71 17:16:03 INFO - PID 13065 | |11;stanford-crypto-ccm;106;116;119;115;113;111;109;110;113;116 17:16:03 INFO - PID 13065 | |12;stanford-crypto-pbkdf2;172;183;161;176;163;171;160;170;166;158 17:16:03 INFO - PID 13065 | |13;stanford-crypto-sha256-iterative;66;61;69;63;70;66;66;63;63;65 17:16:03 INFO - PID 13065 | __end_tp_report 17:16:03 INFO - PID 13065 | __start_cc_report 17:16:03 INFO - PID 13065 | _x_x_mozilla_cycle_collect,728 17:16:03 INFO - PID 13065 | __end_cc_report 17:16:03 INFO - PID 13065 | __startTimestamp1506989763288__endTimestamp 17:16:03 INFO - PID 13065 | 17:16:03 INFO - PID 13065 | ------- Summary: start ------- 17:16:03 INFO - PID 13065 | Number of tests: 14 17:16:03 INFO - PID 13065 | 17:16:03 INFO - PID 13065 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.50 stddev:2.85 (2.6%) stddev-sans-first:2.99 17:16:03 INFO - PID 13065 | Values: 109.0 113.0 107.0 109.0 114.0 114.0 107.0 112.0 108.0 108.0 17:16:03 INFO - PID 13065 | 17:16:03 INFO - PID 13065 | [#1] audio-beat-detection Cycles:10 Average:124.20 Median:124.00 stddev:7.77 (6.3%) stddev-sans-first:7.79 17:16:03 INFO - PID 13065 | Values: 117.0 133.0 123.0 121.0 120.0 141.0 127.0 125.0 119.0 116.0 17:16:03 INFO - PID 13065 | 17:16:03 INFO - PID 13065 | [#2] audio-dft Cycles:10 Average:167.20 Median:166.00 stddev:5.61 (3.4%) stddev-sans-first:5.74 17:16:03 INFO - PID 13065 | Values: 163.0 165.0 166.0 170.0 164.0 182.0 166.0 164.0 168.0 164.0 17:16:03 INFO - PID 13065 | 17:16:03 INFO - PID 13065 | [#3] audio-fft Cycles:10 Average:79.70 Median:82.00 stddev:4.74 (5.8%) stddev-sans-first:4.44 17:16:03 INFO - PID 13065 | Values: 86.0 83.0 81.0 77.0 83.0 77.0 86.0 77.0 74.0 73.0 17:16:03 INFO - PID 13065 | 17:16:03 INFO - PID 13065 | [#4] audio-oscillator Cycles:10 Average:84.50 Median:84.50 stddev:5.40 (6.4%) stddev-sans-first:5.70 17:16:03 INFO - PID 13065 | Values: 83.0 86.0 89.0 97.0 82.0 86.0 83.0 79.0 80.0 80.0 17:16:03 INFO - PID 13065 | 17:16:03 INFO - PID 13065 | [#5] imaging-gaussian-blur Cycles:10 Average:116.10 Median:115.50 stddev:2.92 (2.5%) stddev-sans-first:3.00 17:16:03 INFO - PID 13065 | Values: 114.0 115.0 119.0 114.0 114.0 114.0 123.0 117.0 115.0 116.0 17:16:03 INFO - PID 13065 | 17:16:03 INFO - PID 13065 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.00 stddev:2.41 (1.6%) stddev-sans-first:2.51 17:16:03 INFO - PID 13065 | Values: 149.0 153.0 149.0 150.0 151.0 149.0 148.0 150.0 156.0 149.0 17:16:03 INFO - PID 13065 | 17:16:03 INFO - PID 13065 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:95.00 stddev:2.67 (2.8%) stddev-sans-first:2.22 17:16:03 INFO - PID 13065 | Values: 101.0 94.0 95.0 94.0 95.0 94.0 96.0 100.0 95.0 99.0 17:16:03 INFO - PID 13065 | 17:16:03 INFO - PID 13065 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:52.50 stddev:3.36 (6.4%) stddev-sans-first:3.50 17:16:03 INFO - PID 13065 | Values: 55.0 53.0 52.0 61.0 51.0 52.0 56.0 50.0 52.0 50.0 17:16:03 INFO - PID 13065 | 17:16:03 INFO - PID 13065 | [#9] json-stringify-tinderbox Cycles:10 Average:42.50 Median:44.00 stddev:3.50 (8.0%) stddev-sans-first:3.48 17:16:03 INFO - PID 13065 | Values: 39.0 45.0 38.0 41.0 38.0 48.0 45.0 46.0 42.0 43.0 17:16:03 INFO - PID 13065 | 17:16:03 INFO - PID 13065 | [#10] stanford-crypto-aes Cycles:10 Average:74.40 Median:75.50 stddev:2.80 (3.7%) stddev-sans-first:2.92 17:16:03 INFO - PID 13065 | Values: 73.0 78.0 74.0 72.0 78.0 77.0 72.0 72.0 77.0 71.0 17:16:03 INFO - PID 13065 | 17:16:03 INFO - PID 13065 | [#11] stanford-crypto-ccm Cycles:10 Average:112.80 Median:114.00 stddev:3.88 (3.4%) stddev-sans-first:3.24 17:16:03 INFO - PID 13065 | Values: 106.0 116.0 119.0 115.0 113.0 111.0 109.0 110.0 113.0 116.0 17:16:03 INFO - PID 13065 | 17:16:03 INFO - PID 13065 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:170.50 stddev:7.89 (4.6%) stddev-sans-first:8.23 17:16:03 INFO - PID 13065 | Values: 172.0 183.0 161.0 176.0 163.0 171.0 160.0 170.0 166.0 158.0 17:16:03 INFO - PID 13065 | 17:16:03 INFO - PID 13065 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:66.00 stddev:2.82 (4.3%) stddev-sans-first:2.98 17:16:03 INFO - PID 13065 | Values: 66.0 61.0 69.0 63.0 70.0 66.0 66.0 63.0 63.0 65.0 17:16:03 INFO - PID 13065 | -------- Summary: end -------- 17:16:03 INFO - PID 13065 | 17:16:03 INFO - PID 13065 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:16:04 INFO - TEST-INFO | 13065: exit 0 17:16:04 INFO - TEST-OK | kraken | took 63908ms 17:16:04 INFO - SUITE-END | took 1177s 17:16:04 INFO - Completed test suite (00:19:37) 17:16:04 INFO - javascript benchmark 17:16:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8395.237126022574, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3210.2295449092226, 3210.9518357224647, 3214.2285851395663, 3227.193201699575, 3228.9838550807235, 6087.756489740405, 6284.183056202699, 6333.8099857004245, 6356.269029061659, 6441.903371449432, 6220.84447888803, 6286.779962701306, 6321.051842223669, 6325.620462772237, 6329.841753956153, 5776.537876969833, 5790.305163380401, 5799.21710569072, 5823.864346452444, 5893.440123188312, 5808.477237048664, 5829.242198514187, 5852.853678658025, 5875.441833025877, 5885.823425297226, 5841.5326773858205, 5886.852828679274, 5907.350191478934, 5917.319508256563, 5954.434328738785, 5497.45025497451, 5676.914846277309, 5744.253247077895, 5826.135537745782, 5920.97039514804, 5386.245925570423, 5785.421457854223, 5852.15143804146, 5858.238429004202, 5859.882802343929, 6159.84600384994, 6229.501639868799, 6237.345078766755, 6348.333424990402, 6387.968060159716, 6738.494612904052, 6746.865062698718, 6765.052892594991, 6794.932050679479, 6810.829729256759, 6781.966090169518, 6839.384455399038, 6844.623545704984, 6862.828429289308, 6884.931150688529, 6240.656763877985, 6297.6536290504, 6319.6208227506495, 6333.113364129025, 6344.460720838688, 6706.161729783777, 6812.182538095361, 6865.5537390069485, 6984.895226571605, 7003.194632617212, 6575.408213260829, 6582.078509008743, 6599.60402375859, 6600.306967768315, 6645.966770166215, 6542.934570654328, 6601.240857301375, 6616.27221005689, 6687.230968438595, 6689.2307384651385, 6622.2715501294815, 6648.734050638017, 6691.832704182337, 6719.630420326831, 6731.798046058626, 6763.425108865703, 6790.253072162058, 6806.76176333826, 6867.622280774605, 6879.58722476653, 5290.867728306823, 5292.9735351323, 5365.409804921455, 5366.275552800322, 5375.75809088592, 4516.480604730498, 4554.612857907049, 4557.931631025537, 4574.771261436915, 4575.3823233863, 5561.332640083216, 5602.859928501739, 5625.099984002622, 5737.598368114275, 5811.389804070512, 6817.897731534031, 6837.589744615339, 6849.1438570178725, 6858.794236172923, 6877.552959057645, 5729.0, 5785.652860828363, 5805.419458054161, 5819.650820950672, 5896.498797602166, 5645.096784514458, 5712.6286791358425, 5779.3642699303045, 5839.9124013139835, 5858.882822343615, 6446.548741588043, 6447.6453795041725, 6461.321561236096, 6476.514261430318, 6517.348265173539, 6674.098996635392, 6684.398404143456, 6703.664816759143, 6807.863842723217, 6877.449804015767, 6488.578242414228, 6522.249941256816, 6612.70242839083, 6630.701618427086, 6656.30108838565, 6628.53600247978, 6630.23752268476, 6641.435477984425, 6642.3025582315095, 6710.932890671031, 6607.141071660653, 6637.601743895381, 6735.528513004238, 6894.069300644549, 6898.034275201376, 6430.3891130342545, 6502.967485162544, 6507.0564768107415, 6516.0, 6518.511111666549, 6499.155109835691, 6499.2200935887995, 6515.73937042532, 6518.022296655539, 6518.543701940818, 6536.640484773383, 6578.04618330349, 6585.143931289093, 6586.0, 6606.942889137715, 6594.90107648376, 6612.867742645024, 6642.535022548375, 6675.0, 6735.932640673531, 6199.597026193283, 6251.249850018027, 6265.060240963892, 6269.937300626935, 6271.122042913905], "value": 6136.434586163239, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [873.2533683700436, 891.9732408027758, 895.3374502867878, 899.1188635137569, 900.3022657440483, 39211.80394098029, 42593.574064259345, 42915.78542107293, 42996.57003429965, 43185.7840710796, 38510.80744596273, 38513.614863851355, 38770.61229387705, 39075.41386879199, 39095.60904390955, 7203.927960720378, 7274.781756547286, 7313.634318284091, 7333.853322933538, 7358.117025956893, 7208.207097219301, 7248.2389349118375, 7287.453440991921, 7290.489665723375, 7302.81742956425, 7234.27657234275, 7252.202257751643, 7263.782086537412, 7270.745523906664, 7272.236415176383, 7121.928780712205, 7817.491863028885, 7938.126806051329, 7960.243776841191, 8024.638891249908, 7921.128675845653, 8011.0386753589355, 8017.438779285452, 8017.839643207161, 8033.839323213561, 38337.0, 38787.41818872719, 38798.0, 38809.805950970345, 38878.61121388806, 3507.5264839246884, 3562.340966921128, 3580.0512864090774, 3585.229175727231, 3606.6753992140834, 32449.35101297961, 32476.67523324784, 32644.6735532644, 32710.182245443815, 32846.17884552881, 5223.2165175223645, 5228.686278823283, 5228.79084836606, 5268.868278293035, 5269.947300527022, 189289.0, 189719.0, 190523.04738476357, 190779.0, 191307.0, 42974.57025429768, 43938.56061439345, 44233.778831105636, 48264.27603585949, 48479.0, 51296.74351628293, 51867.0, 52097.7395113022, 52187.21719174215, 52511.0, 14352.708256256987, 14434.350454229585, 14445.133292002514, 14514.0, 14541.491047813275, 11536.884631153582, 11590.768184636428, 11594.94202528982, 11640.534378624929, 11683.883161168449, 14116.788248176286, 14239.928800355932, 14362.856371436152, 14409.279536023158, 14416.711665766627, 5670.5747068969995, 5719.571032172604, 5767.538596912237, 5886.82111659699, 5919.733611987471, 1019.6940917724653, 1029.8352263637782, 1033.7415646088477, 1036.6630844975261, 1047.9633212837666, 23164.420889477897, 23605.29184124479, 23746.287611371685, 23795.04819807223, 24022.15922442706, 1111.1222134513644, 1122.8280108692975, 1127.836463712757, 1134.8354488599107, 1135.812590922505, 12558.241846141547, 12564.623061308175, 12590.874091259153, 12691.873081269254, 12728.23630582168, 233499.0, 233707.0, 234479.0, 234742.0, 235104.0, 53898.46101539013, 54221.0, 54228.18657720138, 54234.18648720272, 54381.45618543843, 1427.6508699279289, 1461.7953486511897, 1468.4566710317251, 1472.4183947340741, 1479.5635287590187, 22613.0, 23379.88310058439, 23542.46973946688, 23711.52576948486, 23777.405564861016, 38158.236835262585, 38711.6128838708, 38764.80617596894, 38896.02759930911, 38955.2208955825, 195655.0, 196251.0, 197115.0, 198024.0, 198781.0, 33072.17319566934, 34380.31239375249, 34799.30401392009, 34989.650103498636, 35220.119497012776, 44267.33598995953, 44302.77848610736, 44740.0, 44847.0, 44883.102337953715, 32550.0, 32681.836590817846, 32770.34459310848, 32792.67207327896, 32962.0, 31704.841475792473, 31726.682733173297, 32187.839060804545, 32515.512267315535, 32711.836440818595, 34854.651453486156, 36268.0, 36418.27163456769, 36459.81770091239, 36705.0, 31405.371892561565, 31653.84173079212, 31711.682883170874, 31734.52398214075, 32063.519047214777, 23485.0, 24079.398015049763, 24127.758722413255, 24167.637485437383, 24595.631065534388], "value": 17145.04713903816, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.6806256558891, 588.2382314902201, 591.5120025978566, 599.2419589219636, 602.5450784657583, 21877.0, 22681.319560413194, 22720.204792832254, 22729.77270227297, 22801.885990570023, 23856.0, 24076.0, 24251.75748242517, 24380.198336532318, 24475.26574202777, 6490.513211509144, 6705.865882682343, 6715.899261511081, 6718.0, 6727.360900714424, 6586.407223349922, 6589.736410543573, 6635.540181160137, 6663.267040625527, 6668.899966500482, 6410.455111315544, 6681.933180668204, 6715.093462382589, 6721.563098398613, 6727.798166055001, 6631.204255489348, 6651.60090394573, 6690.899636505456, 6711.731530738764, 6713.966430167867, 5818.650880947157, 6045.637261764308, 6046.637201767908, 6173.567850250484, 6207.689615519206, 27823.58264626032, 28184.859075704695, 28257.0, 28266.0, 28476.430471390457, 1945.5330720626948, 1972.2012584903136, 1989.691597802343, 1998.3005947918257, 2000.1299434745931, 18850.71723924142, 19036.80963190378, 19341.323053693195, 19452.319168829024, 19500.9274489903, 2384.332386931662, 2447.6940382452194, 2455.042533411971, 2455.508898220345, 2458.21337172105, 112552.0, 117828.41085794516, 119616.0, 119735.0, 123013.0, 14193.922411710751, 14368.497102601359, 14529.626063391544, 14745.23057233139, 14867.628309292139, 22313.55372892533, 22322.55354892893, 22673.093076276764, 22720.886395567915, 22830.31509054731, 9314.254859611216, 9393.483358415353, 9553.665621703207, 9618.567164477616, 9704.748909115526, 8490.915090849136, 8568.143185681382, 8637.956810216034, 8672.176143266379, 8677.39258251929, 8738.95630521856, 8838.160374764388, 8854.911450885409, 8861.424007439497, 9006.504642244608, 2593.9663822755797, 2630.197789674168, 2667.5731882898644, 2748.477789220042, 2792.7067657895627, 929.2055292724758, 939.2861425316672, 953.5565961827783, 959.5681943125621, 960.0, 18537.721934170997, 18906.386483316168, 19008.23967041303, 19267.614647707247, 19548.0, 983.498415807943, 999.9250056245811, 1002.2583288366557, 1016.7407311135761, 1017.7506510904876, 10512.842307365396, 10560.788784224273, 10566.260361774603, 10580.518727378174, 10672.893271067345, 452185.0, 463306.0, 471299.0, 471599.0, 475805.0, 105893.0, 108360.0, 108744.45627771968, 109166.45416772865, 109383.45308273408, 1113.6659002299277, 1132.63279745331, 1140.7832511822562, 1144.6566030191077, 1152.423788105947, 17124.743128852828, 17257.137143142543, 17267.222974965905, 17748.3788067417, 17756.822431775516, 50810.23784643159, 52144.73927630338, 52549.7372513135, 53117.7344113277, 53795.19307210473, 66953.66523167353, 67369.3263067363, 67410.32589674236, 67435.0, 68231.31768682448, 13877.791833122714, 14012.509562165274, 14120.717585648435, 14141.292935352985, 14196.36116374745, 21100.47248818792, 21759.673604895623, 21796.45508862291, 21957.0, 22178.889105554368, 16166.272517736965, 16336.101514416347, 16377.93543419674, 16447.671046579242, 16533.008019518868, 15793.052416855026, 16344.67310653804, 16346.346146154021, 16486.0, 16512.83487165113, 16381.590460238589, 16509.422170223985, 18121.27514899442, 18148.455546333633, 18428.447146585622, 13718.17690938547, 13851.584452466443, 13872.4451021958, 13948.232847193502, 13950.302484875918, 16614.750778738086, 16669.49991500257, 16820.243089060776, 16848.57878553046, 17380.913095434444], "value": 11543.756616047023, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1298.0913360647546, 1363.8636136386363, 1389.138733984929, 1403.9017268791188, 1406.1000959385995, 13960.930195349021, 14504.347304371302, 14554.490592829254, 14569.417223311055, 14588.0, 14359.138451692907, 14478.493252736156, 14500.41998320066, 14503.854961450383, 14510.709785804303, 2604.882780274892, 2630.302969713023, 2657.2426858345375, 2675.8528280944543, 2683.6511253537014, 2479.789217916479, 2512.334231428673, 2523.8990440382363, 2524.406764410362, 2535.949281014379, 2477.603583426652, 2480.082369523279, 2651.058874099696, 2769.2107749291454, 2771.0855417712105, 2653.4693061387798, 2657.6677915260593, 2672.4521473097966, 2685.8388496690163, 2686.932826679339, 2646.0, 2653.9601905971426, 2666.080202330193, 2670.5326567850548, 2685.0, 13485.865141348559, 13906.860931390658, 13918.791218131737, 14077.084989475652, 14205.431782728678, 7475.7383491578075, 7762.340201082915, 7768.65041073153, 7819.3744500439825, 7875.921240787633, 5113.795448182068, 5323.148296272578, 5420.512153906128, 5445.9727701361635, 5520.613557051008, 1916.7987361327, 1978.5251539630528, 1978.8317992970615, 1979.4853338132045, 2032.7459067616549, 24775.25674229776, 24781.0, 24809.25572232836, 24896.626550601755, 24907.252782416555, 6573.1783527059115, 6705.042732532519, 6838.555493892881, 6977.162740471074, 6989.93010069903, 16475.58811029734, 16479.423220187236, 16586.419475318547, 16669.583260418345, 16693.332266709196, 7613.238676132342, 7775.57234352116, 7854.332381747501, 7864.0, 7870.881936770953, 6799.5920244785475, 6974.930250697529, 7091.078159839291, 7093.219745827955, 7106.111736032996, 5086.16078347076, 5092.388913330424, 5093.217373919173, 5099.4390617032095, 5100.413452453015, 1548.5896237497072, 1558.8363221861769, 1564.3586129687, 1575.708493928604, 1580.2414840876213, 902.7652810269377, 905.185333200112, 915.7481692534607, 930.1024511346583, 930.283681565191, 7312.707491700273, 7317.37802286801, 7349.77950661481, 7419.59192244421, 7424.96287518559, 730.9122905251297, 737.5390381011867, 738.5679377564185, 747.9925200748032, 748.3265061444635, 4516.977415112903, 4555.06621142665, 4755.881102972453, 5159.974200128975, 5425.159100339453, 19492.805071949384, 19555.31556395519, 20361.79638203599, 20385.08267127983, 20485.487862803548, 19686.507837303896, 20015.199392024446, 20023.399298021082, 20440.591188176153, 20671.4832129195, 9969.601215951427, 10131.898681013095, 10354.326968747007, 10395.32430392022, 10426.791464170674, 7741.496802707806, 7753.612319384121, 7831.138574756658, 7912.129665736879, 7943.841123177389, 16783.664326713155, 17023.91488042552, 17201.0, 17619.647607048042, 17957.191926363084, 17949.282028718706, 18050.638987219918, 18370.89774613474, 18490.63018739591, 18594.907025464785, 10786.838197426889, 10807.189460790314, 11017.889821101686, 11028.062614677843, 11094.22340436194, 13171.275579842817, 13305.66735831612, 13426.395812188279, 13429.798553021908, 13439.328033598085, 10449.634262800766, 10645.8935410648, 10707.143428525855, 10837.67486975392, 10953.780924381626, 10600.628977985734, 10682.412467314372, 10695.893041069801, 10788.568457261621, 10852.782944341227, 9456.669016584661, 9565.808683826424, 9684.95157524208, 9699.78752655918, 9712.5143742814, 6683.532152749261, 6865.622390768555, 6882.208546017272, 6908.1019467468905, 6948.687309071003, 7124.038254835531, 7266.455015873725, 7321.084864391951, 7349.0, 7366.521176123535], "value": 6394.263947260783, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.9437267527899, 493.59278595159003, 509.2971699055303, 516.8268630008947, 518.2666526864487, 6242.219722534684, 6256.7497300108, 6259.906101408471, 6326.272478664955, 6353.428191462774, 6137.785177518787, 6147.649531005602, 6149.415805498482, 6154.599951003182, 6160.691965401723, 5114.207297868837, 5148.253503242027, 5152.273988213953, 5187.688738675692, 5195.246689230078, 5142.768575414097, 5145.408278048035, 5147.948520514784, 5180.119379705459, 5193.766280517386, 4712.552307530779, 4942.209246520558, 4948.925766113512, 4952.628552858532, 4974.676646017997, 4873.366462359906, 4913.213885778258, 4946.159152944008, 4976.701397916118, 4986.675866068694, 4383.9342409863875, 4415.646748260164, 4420.20436321462, 4432.84485043022, 4442.711223770445, 6040.48655864252, 6047.637141771464, 6084.330723620398, 6098.878022439526, 6103.0, 5642.802501912454, 5657.660540367591, 5668.43315668434, 5676.574256930706, 5742.368339482654, 6498.967505162491, 6504.568994821132, 6511.837204069889, 6544.836379090513, 6576.441002514792, 4592.0, 4730.668853180278, 4787.16224660683, 4791.377120974286, 4839.491853355382, 6533.869322613568, 6616.801495955129, 6699.799006029827, 6749.291324410964, 6845.520813543004, 4867.1969125093965, 4916.926246106311, 4917.311576379309, 4962.6774259673, 4976.751162441863, 4956.826511072095, 4965.155923493015, 5003.149464591028, 5031.4213865405945, 5036.395632524121, 5441.755121019563, 5585.888282234332, 5646.209530665628, 5658.801941932013, 5669.886602267931, 6546.803595892131, 6573.704183311763, 6600.834979125464, 6603.438707709803, 6616.305287944792, 1714.7342161964916, 1716.9399071032703, 1718.243972652029, 1735.3752649046332, 1745.8079611242754, 1171.988280117205, 1177.2929252583788, 1186.7033241689578, 1193.7552801675636, 1202.8255902894032, 5573.27547418833, 5585.972070139624, 5645.943540564542, 5667.319921609351, 5744.339400968858, 6706.0, 6712.160979877515, 6720.22717387497, 6762.526623136333, 6777.271795692067, 5653.462921022497, 5659.462351076641, 5689.402612725687, 5729.541636669056, 5755.740991655385, 3499.267862408124, 3501.2472318451655, 3510.771230069455, 3521.9823900880842, 3554.87557935471, 6319.936800631935, 6349.0, 6393.6163830170335, 6415.294317625057, 6520.641364724986, 6728.259891411941, 6825.35159159879, 6864.622445765431, 6880.314322990899, 6911.17065952089, 6332.905006424908, 6368.235811702532, 6395.392437718409, 6414.775482858077, 6487.610743355413, 6599.0, 6665.800025999228, 6668.799936001928, 6672.633005184762, 6677.3656502632175, 6529.216494020748, 6604.438622717123, 6614.966925165343, 6639.634820084942, 6707.0, 6011.188489553854, 6129.387061294014, 6418.743250269937, 6441.67791610427, 6489.383508566679, 4857.319975203545, 4886.780094895809, 4940.283658869515, 4953.950460495493, 4955.2567114933045, 6622.801315960529, 6669.566478178903, 6687.598744075371, 6693.230278517838, 6734.966325168343, 6163.660998645118, 6359.427651511386, 6361.968190159019, 6418.6469744164515, 6466.0, 6280.246370435577, 6398.392152745481, 6450.48396128318, 6499.415052645285, 6519.445847103049, 6280.52407684203, 6368.363163683594, 6392.264889537762, 6418.358164183731, 6439.649527922368, 6332.556721029668, 6539.934600653933, 6588.143541339595, 6596.70314835824, 6620.966895165493, 6226.782062627786, 6233.885635480561, 6241.469475094668, 6244.1570387997035, 6247.468965137832], "value": 5006.608377299484, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [879.5426378283292, 901.7925877048275, 902.4810733828047, 905.036136514612, 908.4004556992386, 18260.269589216416, 18625.7206141908, 18779.0, 18811.153498092586, 18858.528536786554, 18481.353152639662, 18518.90740546299, 18577.814221857778, 18715.90642046788, 18800.0, 949.264320151881, 961.2550273538029, 965.2181732796457, 967.7483854197924, 971.159946646153, 984.9212063034976, 993.4436715439341, 997.7356000659831, 998.3460833154296, 999.170688328689, 990.420603946692, 1031.0565832263508, 1045.513836066229, 1051.6529545250087, 1054.5781687325093, 1028.7942411517688, 1044.4255659387306, 1044.6813721814844, 1046.1839764983324, 1046.9947650261777, 717.6124892558013, 759.7530802489213, 760.2511526146797, 760.4714723267332, 762.0702742653954, 20125.194992200293, 20346.389608311776, 20485.692714609293, 20630.277940272168, 20670.689939650918, 21226.681599776017, 21668.34994950154, 21825.0, 22015.669764953538, 22169.113235470562, 17039.914800426042, 17070.317187312492, 17146.828531714647, 17614.471565853044, 17677.38129165486, 3664.8534058637624, 3712.888613341604, 3718.925621487555, 3719.5350581177354, 3720.7023438125157, 100444.91546606121, 136939.999999999, 138858.0, 141284.0, 142038.0, 17116.229769660396, 17340.826591734174, 17664.11679416024, 17820.19809108593, 17826.46520604384, 30290.09129726112, 30645.540316895265, 30903.227419314248, 30916.845415772776, 30962.22594435112, 8320.292775114183, 8507.106753790888, 8526.829463410697, 8569.914300857037, 8652.3510736695, 4078.0, 4087.734297270668, 4115.444415003996, 4137.8758637240935, 4144.254034273859, 5465.688234823614, 5514.779408823602, 5566.916496252559, 5574.136008918624, 5593.692346920959, 1077.4397313397146, 1089.128697042363, 1117.5306371324064, 1117.921745477825, 1122.5958654884234, 649.1560970738021, 658.479800957248, 674.8177991942148, 678.1523096129838, 683.9008343790123, 12193.695157620952, 12393.256404615571, 12415.875841241652, 12579.308138052495, 12732.872671273353, 672.9596224226563, 680.7617333933084, 684.3156843156843, 695.6869408766075, 703.0192880931072, 5389.703566303812, 5437.782488700408, 5464.316960379952, 5543.972280138654, 5564.02629539837, 126531.0, 127828.36085819511, 129909.35045324902, 130933.03600446001, 132616.3369183148, 112544.0, 112822.43588782003, 113944.43027784974, 115768.0, 116828.41585792186, 92504.53747731219, 94542.0, 96619.0, 96684.0, 96822.0, 10248.333858299486, 10252.692419227435, 10273.589056437659, 10292.073713365833, 10642.627508037182, 44187.33718994282, 44656.33015504705, 45369.694910511644, 45608.0, 45916.54083459123, 58852.70573647276, 59127.70436147792, 60267.0, 60747.69626151841, 60990.39009609847, 15833.416658334536, 15966.441174558835, 16057.91971040184, 16064.67870642604, 16369.09969951664, 17291.91354043272, 17453.30186792514, 17479.213435395694, 17608.29566817313, 17757.0, 16133.596660083593, 16266.593335166715, 16332.918335408247, 16498.092604906844, 16642.75035874487, 16293.837061629707, 16327.59181020484, 16414.917925410296, 16423.343066277215, 16468.01191928488, 16482.25829837684, 16545.83454165491, 16619.66760664804, 16730.58173545671, 16760.58098547546, 10701.143908487458, 10757.085647720032, 11079.16906232052, 11149.0, 11277.436128193393, 12303.507859685513, 12335.0, 12434.191777534432, 12624.495020199089, 12699.809502857279], "value": 9003.999026246549, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1444.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 113.0, 107.0, 109.0, 114.0, 114.0, 107.0, 112.0, 108.0, 108.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 133.0, 123.0, 121.0, 120.0, 141.0, 127.0, 125.0, 119.0, 116.0], "value": 124.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 166.0, 170.0, 164.0, 182.0, 166.0, 164.0, 168.0, 164.0], "value": 167.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 81.0, 77.0, 83.0, 77.0, 86.0, 77.0, 74.0, 73.0], "value": 79.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 89.0, 97.0, 82.0, 86.0, 83.0, 79.0, 80.0, 80.0], "value": 84.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 119.0, 114.0, 114.0, 114.0, 123.0, 117.0, 115.0, 116.0], "value": 116.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 153.0, 149.0, 150.0, 151.0, 149.0, 148.0, 150.0, 156.0, 149.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 94.0, 95.0, 94.0, 95.0, 94.0, 96.0, 100.0, 95.0, 99.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 52.0, 61.0, 51.0, 52.0, 56.0, 50.0, 52.0, 50.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 45.0, 38.0, 41.0, 38.0, 48.0, 45.0, 46.0, 42.0, 43.0], "value": 42.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 78.0, 74.0, 72.0, 78.0, 77.0, 72.0, 72.0, 77.0, 71.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 119.0, 115.0, 113.0, 111.0, 109.0, 110.0, 113.0, 116.0], "value": 112.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 183.0, 161.0, 176.0, 163.0, 171.0, 160.0, 170.0, 166.0, 158.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 61.0, 69.0, 63.0, 70.0, 66.0, 66.0, 63.0, 63.0, 65.0], "value": 65.2, "unit": "score"}]}]} 17:16:04 INFO - Return code: 0 17:16:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:16:04 INFO - # TBPL SUCCESS # 17:16:04 INFO - Running post-action listener: _package_coverage_data 17:16:04 INFO - Running post-action listener: _resource_record_post_action 17:16:04 INFO - [mozharness: 2017-10-03 00:16:04.574697Z] Finished run-tests step (success) 17:16:04 INFO - Running post-run listener: _resource_record_post_run 17:16:04 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 135168; Write bytes: 342487040; Read time: 44; Write time: 312088 17:16:04 INFO - TinderboxPrint: CPU usage
13.3% 17:16:04 INFO - TinderboxPrint: I/O read bytes / time
135,168 / 44 17:16:04 INFO - TinderboxPrint: I/O write bytes / time
342,487,040 / 312,088 17:16:04 INFO - TinderboxPrint: CPU idle
8,265.6 (86.7%) 17:16:04 INFO - TinderboxPrint: CPU user
1,199.4 (12.6%) 17:16:04 INFO - TinderboxPrint: Swap in / out
0 / 0 17:16:04 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13279232; Read time: 0; Write time: 5656 17:16:04 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:16:04 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 131072; Write bytes: 329207808; Read time: 28; Write time: 306432 17:16:05 INFO - Running post-run listener: _upload_blobber_files 17:16:05 INFO - Blob upload gear active. 17:16:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:16:05 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 17:16:05 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'] 17:16:05 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 17:16:05 INFO - (blobuploader) - INFO - Open directory for files ... 17:16:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:16:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:16:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:12 INFO - (blobuploader) - INFO - Done attempting. 17:16:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:16:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:16:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:13 INFO - (blobuploader) - INFO - Done attempting. 17:16:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:16:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:16:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:14 INFO - (blobuploader) - INFO - Done attempting. 17:16:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:16:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:16:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:15 INFO - (blobuploader) - INFO - Done attempting. 17:16:15 INFO - (blobuploader) - INFO - Iteration through files over. 17:16:15 INFO - Return code: 0 17:16:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:16:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:16:15 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d26da0776a1875b89479bdae7906180cec2cd78131ab9b28e73d07c3c493fce4e9a6726cd732e677644e57b02f5e2d5453adfd284a02d0db412850c3228edb93", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad4a31978efd0bb77017a9d035699ed5de2f9b5ab7f6426875c511de188b0e8a71655820bf6f4bf4cb0d297c2fe6af41744ef3812dce6c8b893e1a5f6577e578", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4569aee006f0398abb1169d2be56dfe24b7bdd042a9a37704f73f0e9336c3c0167e99a71ebf6bce79d88a607d52ef242c95a3071e662f1cfe51db1f6a9a207b5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4cac30fdcacb19f7d818c686e9bc5ec8875c82e11575129c2eda1052bdc7620135999c73d33ebaf4ab2db67b26cba41463d9b487f4319763d5aa838695100a2"} 17:16:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:16:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:16:15 INFO - Contents: 17:16:15 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d26da0776a1875b89479bdae7906180cec2cd78131ab9b28e73d07c3c493fce4e9a6726cd732e677644e57b02f5e2d5453adfd284a02d0db412850c3228edb93", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad4a31978efd0bb77017a9d035699ed5de2f9b5ab7f6426875c511de188b0e8a71655820bf6f4bf4cb0d297c2fe6af41744ef3812dce6c8b893e1a5f6577e578", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4569aee006f0398abb1169d2be56dfe24b7bdd042a9a37704f73f0e9336c3c0167e99a71ebf6bce79d88a607d52ef242c95a3071e662f1cfe51db1f6a9a207b5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4cac30fdcacb19f7d818c686e9bc5ec8875c82e11575129c2eda1052bdc7620135999c73d33ebaf4ab2db67b26cba41463d9b487f4319763d5aa838695100a2"} 17:16:15 INFO - Running post-run listener: copy_logs_to_upload_dir 17:16:15 INFO - Copying logs to upload dir... 17:16:15 INFO - mkdir: /builds/slave/test/build/upload/logs 17:16:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.278707 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-10-02 17:16:16.011753) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 17:16:16.016030) ========= 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=eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d26da0776a1875b89479bdae7906180cec2cd78131ab9b28e73d07c3c493fce4e9a6726cd732e677644e57b02f5e2d5453adfd284a02d0db412850c3228edb93", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad4a31978efd0bb77017a9d035699ed5de2f9b5ab7f6426875c511de188b0e8a71655820bf6f4bf4cb0d297c2fe6af41744ef3812dce6c8b893e1a5f6577e578", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4569aee006f0398abb1169d2be56dfe24b7bdd042a9a37704f73f0e9336c3c0167e99a71ebf6bce79d88a607d52ef242c95a3071e662f1cfe51db1f6a9a207b5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4cac30fdcacb19f7d818c686e9bc5ec8875c82e11575129c2eda1052bdc7620135999c73d33ebaf4ab2db67b26cba41463d9b487f4319763d5aa838695100a2"} build_url:https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011149 build_url: 'https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d26da0776a1875b89479bdae7906180cec2cd78131ab9b28e73d07c3c493fce4e9a6726cd732e677644e57b02f5e2d5453adfd284a02d0db412850c3228edb93", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad4a31978efd0bb77017a9d035699ed5de2f9b5ab7f6426875c511de188b0e8a71655820bf6f4bf4cb0d297c2fe6af41744ef3812dce6c8b893e1a5f6577e578", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4569aee006f0398abb1169d2be56dfe24b7bdd042a9a37704f73f0e9336c3c0167e99a71ebf6bce79d88a607d52ef242c95a3071e662f1cfe51db1f6a9a207b5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4cac30fdcacb19f7d818c686e9bc5ec8875c82e11575129c2eda1052bdc7620135999c73d33ebaf4ab2db67b26cba41463d9b487f4319763d5aa838695100a2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 17:16:16.047408) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 17:16:16.047745) ========= 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=eca2ab57546de7b41f256b19000001ef-1506987403.344296-1402987995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004679 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 17:16:16.128514) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 17:16:16.131851) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 17:16:16.132138) ========= ========= Total master_lag: 0.27 =========