builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-015 starttime: 1506471745.55 results: success (0) revision: b7d8ae4a03c62e549b9d82595b1d1964f0af70cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:25.554491) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:25.554898) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:25.555176) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:25.761855) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:25.762112) ========= 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=20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-26 17:22: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.4M=0s 2017-09-26 17:22:25 (50.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.176266 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:25.998955) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:25.999543) ========= 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=20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021103 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:26.092725) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:26.093065) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b7d8ae4a03c62e549b9d82595b1d1964f0af70cd --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 b7d8ae4a03c62e549b9d82595b1d1964f0af70cd --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=20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-26 17:22:26,151 truncating revision to first 12 chars 2017-09-26 17:22:26,151 Setting DEBUG logging. 2017-09-26 17:22:26,151 attempt 1/10 2017-09-26 17:22:26,151 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b7d8ae4a03c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-26 17:22:26,543 unpacking tar archive at: mozilla-central-b7d8ae4a03c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.660214 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:26.794825) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:26.795109) ========= script_repo_revision: b7d8ae4a03c62e549b9d82595b1d1964f0af70cd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:26.795464) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:26.795721) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:26.900651) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-26 17:22:26.900912) ========= /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=20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:22:27 INFO - MultiFileLogger online at 20170926 17:22:27 in /builds/slave/test 17:22:27 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 17:22:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:22:27 INFO - {'append_to_log': False, 17:22:27 INFO - 'base_work_dir': '/builds/slave/test', 17:22:27 INFO - 'blob_upload_branch': 'Firefox', 17:22:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:22:27 INFO - 'branch': 'Firefox', 17:22:27 INFO - 'buildbot_json_path': 'buildprops.json', 17:22:27 INFO - 'code_coverage': False, 17:22:27 INFO - 'config_files': ('talos/linux_config.py',), 17:22:27 INFO - 'default_actions': ('clobber', 17:22:27 INFO - 'read-buildbot-config', 17:22:27 INFO - 'download-and-extract', 17:22:27 INFO - 'populate-webroot', 17:22:27 INFO - 'create-virtualenv', 17:22:27 INFO - 'install', 17:22:27 INFO - 'setup-mitmproxy', 17:22:27 INFO - 'run-tests'), 17:22:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:22:27 INFO - 'disable_ccov_upload': False, 17:22:27 INFO - 'disable_stylo': False, 17:22:27 INFO - 'download_minidump_stackwalk': True, 17:22:27 INFO - 'download_symbols': 'ondemand', 17:22:27 INFO - 'enable_stylo': False, 17:22:27 INFO - 'enable_webrender': False, 17:22:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:22:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:22:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:22:27 INFO - 'gecko_profile': False, 17:22:27 INFO - 'gecko_profile_interval': 0, 17:22:27 INFO - 'installer_path': 'installer.exe', 17:22:27 INFO - 'log_level': 'info', 17:22:27 INFO - 'log_name': 'talos', 17:22:27 INFO - 'log_to_console': True, 17:22:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:22:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:22:27 INFO - 'opt_config_files': (), 17:22:27 INFO - 'pip_index': False, 17:22:27 INFO - 'suite': 'dromaeojs-e10s', 17:22:27 INFO - 'system_bits': '32', 17:22:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:22:27 INFO - 'title': 'talos-linux64-ix-015', 17:22:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:22:27 INFO - 'use_talos_json': True, 17:22:27 INFO - 'verify': 'False', 17:22:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:22:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:22:27 INFO - 'work_dir': 'build'} 17:22:27 INFO - [mozharness: 2017-09-27 00:22:27.100634Z] Running clobber step. 17:22:27 INFO - Running pre-action listener: _resource_record_pre_action 17:22:27 INFO - Running main action method: clobber 17:22:27 INFO - rmtree: /builds/slave/test/build 17:22:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:22:28 INFO - Running post-action listener: _resource_record_post_action 17:22:28 INFO - [mozharness: 2017-09-27 00:22:28.099577Z] Finished clobber step (success) 17:22:28 INFO - [mozharness: 2017-09-27 00:22:28.099675Z] Running read-buildbot-config step. 17:22:28 INFO - Running pre-action listener: _resource_record_pre_action 17:22:28 INFO - Running main action method: read_buildbot_config 17:22:28 INFO - Using buildbot properties: 17:22:28 INFO - { 17:22:28 INFO - "project": "", 17:22:28 INFO - "product": "firefox", 17:22:28 INFO - "who": "kwierso@gmail.com", 17:22:28 INFO - "installer_path": "public/build/target.tar.bz2", 17:22:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:22:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:22:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 17:22:28 INFO - "stage_platform": "linux64-pgo", 17:22:28 INFO - "basedir": "/builds/slave/test", 17:22:28 INFO - "buildnumber": 210, 17:22:28 INFO - "platform": "ubuntu64_hw", 17:22:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:22:28 INFO - "slavebuilddir": "test", 17:22:28 INFO - "taskId": "cp3Q0GUaTte_QiOaD9dDUg", 17:22:28 INFO - "branch": "mozilla-central", 17:22:28 INFO - "script_repo_revision": "production", 17:22:28 INFO - "revision": "b7d8ae4a03c62e549b9d82595b1d1964f0af70cd", 17:22:28 INFO - "slavename": "talos-linux64-ix-015", 17:22:28 INFO - "repo_path": "mozilla-central" 17:22:28 INFO - } 17:22:28 INFO - Finding installer, test and symbols from parent task. 17:22:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cp3Q0GUaTte_QiOaD9dDUg'}, attempt #1 17:22:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cp3Q0GUaTte_QiOaD9dDUg'}, attempt #1 17:22:29 INFO - Task dependencies: A6SBlonfSxyxXhl1ngSEGA 17:22:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA'}, attempt #1 17:22:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.tar.bz2 17:22:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.test_packages.json 17:22:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.crashreporter-symbols.zip 17:22:29 INFO - Running post-action listener: _resource_record_post_action 17:22:29 INFO - [mozharness: 2017-09-27 00:22:29.448557Z] Finished read-buildbot-config step (success) 17:22:29 INFO - [mozharness: 2017-09-27 00:22:29.448779Z] Running download-and-extract step. 17:22:29 INFO - Running pre-action listener: _resource_record_pre_action 17:22:29 INFO - Running main action method: download_and_extract 17:22:29 INFO - mkdir: /builds/slave/test/build/tests 17:22: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')]} 17:22:29 INFO - trying https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.test_packages.json 17:22:29 INFO - Downloading https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:22:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:22:30 INFO - Downloaded 989 bytes. 17:22:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:22:30 INFO - Using the following test package requirements: 17:22:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:22:30 INFO - u'common': [u'target.common.tests.zip'], 17:22:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:22:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:22:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:22:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:22:30 INFO - u'mozbase': [u'target.common.tests.zip'], 17:22:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:22:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:22:30 INFO - u'web-platform': [u'target.common.tests.zip', 17:22:30 INFO - u'target.web-platform.tests.tar.gz'], 17:22:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:22:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 17:22:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.common.tests.zip 17:22:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:22:30 INFO - Fetch https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.common.tests.zip into memory 17:22:32 INFO - Content-Length response header: 55349519 17:22:32 INFO - Bytes received: 55349519 17:22:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.talos.tests.zip 17:22:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:22:43 INFO - Fetch https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.talos.tests.zip into memory 17:22:44 INFO - Content-Length response header: 14513823 17:22:44 INFO - Bytes received: 14513823 17:22:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:44 INFO - trying https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.tar.bz2 17:22:44 INFO - Downloading https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:22:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:22:47 INFO - Downloaded 62414004 bytes. 17:22:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.tar.bz2 17:22:47 INFO - mkdir: /builds/slave/test/properties 17:22:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:22:47 INFO - Writing to file /builds/slave/test/properties/build_url 17:22:47 INFO - Contents: 17:22:47 INFO - build_url:https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.tar.bz2 17:22:47 INFO - Running post-action listener: _resource_record_post_action 17:22:47 INFO - Running post-action listener: find_tests_for_verification 17:22:47 INFO - Running post-action listener: set_extra_try_arguments 17:22:47 INFO - [mozharness: 2017-09-27 00:22:47.941645Z] Finished download-and-extract step (success) 17:22:47 INFO - [mozharness: 2017-09-27 00:22:47.941774Z] Running populate-webroot step. 17:22:47 INFO - Running pre-action listener: _resource_record_pre_action 17:22:47 INFO - Running main action method: populate_webroot 17:22:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:22:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['tresize', 17:22:48 INFO - 'tcanvasmark']}, 17:22:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:22:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['dromaeo_css', 17:22:48 INFO - 'kraken']}, 17:22:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:22:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:22:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:22:48 INFO - 'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:22:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:22:48 INFO - 'tests': ['damp', 'tps']}, 17:22:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:22:48 INFO - 'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['damp', 'tps']}, 17:22:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:22:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['dromaeo_dom']}, 17:22:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:22:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['basic_compositor_video', 17:22:48 INFO - 'glvideo']}, 17:22:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:22:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:22:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:22:48 INFO - 'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['ts_paint_webext', 17:22:48 INFO - 'tp5o_webext']}, 17:22:48 INFO - 'other-e10s': {'tests': ['a11yr', 17:22:48 INFO - 'ts_paint', 17:22:48 INFO - 'tpaint', 17:22:48 INFO - 'sessionrestore', 17:22:48 INFO - 'sessionrestore_many_windows', 17:22:48 INFO - 'sessionrestore_no_auto_restore', 17:22:48 INFO - 'tabpaint']}, 17:22:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['a11yr', 17:22:48 INFO - 'ts_paint', 17:22:48 INFO - 'tpaint', 17:22:48 INFO - 'sessionrestore', 17:22:48 INFO - 'sessionrestore_many_windows', 17:22:48 INFO - 'sessionrestore_no_auto_restore', 17:22:48 INFO - 'tabpaint']}, 17:22:48 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 17:22:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 17:22:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['perf_reftest_singletons']}, 17:22:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['perf_reftest']}, 17:22:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:22:48 INFO - 'tsvgr_opacity', 17:22:48 INFO - 'tart', 17:22:48 INFO - 'tscrollx', 17:22:48 INFO - 'tsvg_static']}, 17:22:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['tsvgx', 17:22:48 INFO - 'tsvgr_opacity', 17:22:48 INFO - 'tart', 17:22:48 INFO - 'tscrollx', 17:22:48 INFO - 'tsvg_static']}, 17:22:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:22:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:22:48 INFO - 'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['tp5o']}, 17:22:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:22:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:22:48 INFO - 'talos_options': ['--mitmproxy', 17:22:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:22:48 INFO - '--firstNonBlankPaint'], 17:22:48 INFO - 'tests': ['tp6_google', 17:22:48 INFO - 'tp6_youtube', 17:22:48 INFO - 'tp6_amazon', 17:22:48 INFO - 'tp6_facebook']}, 17:22:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:22:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:22:48 INFO - 'talos_options': ['--disable-stylo', 17:22:48 INFO - '--mitmproxy', 17:22:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:22:48 INFO - '--firstNonBlankPaint'], 17:22:48 INFO - 'tests': ['tp6_google', 17:22:48 INFO - 'tp6_youtube', 17:22:48 INFO - 'tp6_amazon', 17:22:48 INFO - 'tp6_facebook']}, 17:22:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:22:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:22:48 INFO - 'talos_options': ['--stylo-threads=1', 17:22:48 INFO - '--mitmproxy', 17:22:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:22:48 INFO - '--firstNonBlankPaint'], 17:22:48 INFO - 'tests': ['tp6_google', 17:22:48 INFO - 'tp6_youtube', 17:22:48 INFO - 'tp6_amazon', 17:22:48 INFO - 'tp6_facebook']}, 17:22:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:22:48 INFO - 'talos_options': ['--xperf_path', 17:22:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:22:48 INFO - 'tests': ['tp5n']}, 17:22:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:22:48 INFO - 'talos_options': ['--disable-stylo', 17:22:48 INFO - '--xperf_path', 17:22:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:22:48 INFO - 'tests': ['tp5n']}}} 17:22:48 INFO - Running post-action listener: _resource_record_post_action 17:22:48 INFO - [mozharness: 2017-09-27 00:22:48.429321Z] Finished populate-webroot step (success) 17:22:48 INFO - [mozharness: 2017-09-27 00:22:48.429547Z] Running create-virtualenv step. 17:22:48 INFO - Running pre-action listener: _resource_record_pre_action 17:22:48 INFO - Running main action method: create_virtualenv 17:22:48 INFO - Creating virtualenv /builds/slave/test/build/venv 17:22:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:22:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:22:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:22:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:22:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:22:49 INFO - Installing distribute.............................................................................................................................................................................................done. 17:22:49 INFO - Installing pip...............done. 17:22:49 INFO - Return code: 0 17:22:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:22:49 INFO - Reading from file tmpfile_stdout 17:22:49 INFO - Output received: 17:22:49 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:22:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:22: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')]} 17:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22: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')]} 17:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1159d60>, '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 0x115aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115aef0>, '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': '20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326', '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 17:22: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', 'pip>=1.5'] in /builds/slave/test/build 17:22: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 pip>=1.5 17:22:49 INFO - Using env: {'DISPLAY': ':0', 17:22:49 INFO - 'HOME': '/home/cltbld', 17:22:49 INFO - 'LANG': 'en_US.UTF-8', 17:22:49 INFO - 'LANGUAGE': 'en_US:en', 17:22:49 INFO - 'LOGNAME': 'cltbld', 17:22:49 INFO - 'MAIL': '/var/mail/cltbld', 17:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:49 INFO - 'MOZ_NO_REMOTE': '1', 17:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:49 INFO - 'NO_EM_RESTART': '1', 17:22:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:49 INFO - 'PWD': '/builds/slave/test', 17:22:49 INFO - 'SHELL': '/bin/bash', 17:22:49 INFO - 'SHLVL': '1', 17:22:49 INFO - 'TERM': 'linux', 17:22:49 INFO - 'TMOUT': '86400', 17:22:49 INFO - 'USER': 'cltbld', 17:22:49 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326', 17:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:49 INFO - '_': '/tools/buildbot/bin/python'} 17:22:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:22:50 INFO - Downloading/unpacking pip>=1.5 17:22:50 INFO - Running setup.py egg_info for package pip 17:22:50 INFO - warning: no files found matching 'pip/cacert.pem' 17:22:50 INFO - warning: no files found matching '*.html' under directory 'docs' 17:22:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:22:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:22:50 INFO - Installing collected packages: pip 17:22:50 INFO - Found existing installation: pip 1.1 17:22:50 INFO - Uninstalling pip: 17:22:50 INFO - Successfully uninstalled pip 17:22:50 INFO - Running setup.py install for pip 17:22:50 INFO - warning: no files found matching 'pip/cacert.pem' 17:22:50 INFO - warning: no files found matching '*.html' under directory 'docs' 17:22:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:22:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:22:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:22:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:22:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:22:50 INFO - Successfully installed pip 17:22:50 INFO - Cleaning up... 17:22:50 INFO - Return code: 0 17:22:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xdef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1159d60>, '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 0x115aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115aef0>, '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': '20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326', '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 17:22:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:22:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:22:50 INFO - Using env: {'DISPLAY': ':0', 17:22:50 INFO - 'HOME': '/home/cltbld', 17:22:50 INFO - 'LANG': 'en_US.UTF-8', 17:22:50 INFO - 'LANGUAGE': 'en_US:en', 17:22:50 INFO - 'LOGNAME': 'cltbld', 17:22:50 INFO - 'MAIL': '/var/mail/cltbld', 17:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:50 INFO - 'MOZ_NO_REMOTE': '1', 17:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:50 INFO - 'NO_EM_RESTART': '1', 17:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:50 INFO - 'PWD': '/builds/slave/test', 17:22:50 INFO - 'SHELL': '/bin/bash', 17:22:50 INFO - 'SHLVL': '1', 17:22:50 INFO - 'TERM': 'linux', 17:22:50 INFO - 'TMOUT': '86400', 17:22:50 INFO - 'USER': 'cltbld', 17:22:50 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326', 17:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:50 INFO - '_': '/tools/buildbot/bin/python'} 17:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:50 INFO - Downloading/unpacking psutil>=3.1.1 17:22: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 17:22: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 17:22: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 17:22: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 17:22:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:22:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:22:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:22:52 INFO - Installing collected packages: psutil 17:22:52 INFO - Running setup.py install for psutil 17:22:52 INFO - building 'psutil._psutil_linux' extension 17:22:52 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 17:22:52 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 17:22:52 INFO - building 'psutil._psutil_posix' extension 17:22:52 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 17:22:52 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 17:22:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:22:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:22:52 INFO - Successfully installed psutil 17:22:52 INFO - Cleaning up... 17:22:52 INFO - Return code: 0 17:22:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1159d60>, '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 0x115aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115aef0>, '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': '20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326', '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 17:22:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:22:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:22:52 INFO - Using env: {'DISPLAY': ':0', 17:22:52 INFO - 'HOME': '/home/cltbld', 17:22:52 INFO - 'LANG': 'en_US.UTF-8', 17:22:52 INFO - 'LANGUAGE': 'en_US:en', 17:22:52 INFO - 'LOGNAME': 'cltbld', 17:22:52 INFO - 'MAIL': '/var/mail/cltbld', 17:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:52 INFO - 'MOZ_NO_REMOTE': '1', 17:22:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:52 INFO - 'NO_EM_RESTART': '1', 17:22:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:52 INFO - 'PWD': '/builds/slave/test', 17:22:52 INFO - 'SHELL': '/bin/bash', 17:22:52 INFO - 'SHLVL': '1', 17:22:52 INFO - 'TERM': 'linux', 17:22:52 INFO - 'TMOUT': '86400', 17:22:52 INFO - 'USER': 'cltbld', 17:22:52 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326', 17:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:52 INFO - '_': '/tools/buildbot/bin/python'} 17:22:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:22:52 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 17:22:52 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 17:22:52 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 17:22:52 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 17:22:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:22:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:22:54 INFO - Installing collected packages: mozsystemmonitor 17:22:54 INFO - Running setup.py install for mozsystemmonitor 17:22:54 INFO - Successfully installed mozsystemmonitor 17:22:54 INFO - Cleaning up... 17:22:54 INFO - Return code: 0 17:22:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:22:54 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')]} 17:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:54 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')]} 17:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:54 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 0xdef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1159d60>, '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 0x115aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115aef0>, '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': '20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326', '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 17:22:54 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 17:22:54 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 17:22:54 INFO - Using env: {'DISPLAY': ':0', 17:22:54 INFO - 'HOME': '/home/cltbld', 17:22:54 INFO - 'LANG': 'en_US.UTF-8', 17:22:54 INFO - 'LANGUAGE': 'en_US:en', 17:22:54 INFO - 'LOGNAME': 'cltbld', 17:22:54 INFO - 'MAIL': '/var/mail/cltbld', 17:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:54 INFO - 'MOZ_NO_REMOTE': '1', 17:22:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:54 INFO - 'NO_EM_RESTART': '1', 17:22:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:54 INFO - 'PWD': '/builds/slave/test', 17:22:54 INFO - 'SHELL': '/bin/bash', 17:22:54 INFO - 'SHLVL': '1', 17:22:54 INFO - 'TERM': 'linux', 17:22:54 INFO - 'TMOUT': '86400', 17:22:54 INFO - 'USER': 'cltbld', 17:22:54 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326', 17:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:54 INFO - '_': '/tools/buildbot/bin/python'} 17:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:54 INFO - Downloading/unpacking jsonschema==2.5.1 17:22: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 17:22: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 17:22: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 17:22: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 17:22:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:22:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:56 INFO - Downloading functools32-3.2.3-2.tar.gz 17:22:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:22:56 INFO - warning: no files found matching '*.txt' 17:22:56 INFO - no previously-included directories found matching 'build' 17:22:56 INFO - no previously-included directories found matching 'dist' 17:22:56 INFO - no previously-included directories found matching '.git*' 17:22:56 INFO - Installing collected packages: jsonschema, functools32 17:22:56 INFO - Running setup.py install for functools32 17:22:56 INFO - warning: no files found matching '*.txt' 17:22:56 INFO - no previously-included directories found matching 'build' 17:22:56 INFO - no previously-included directories found matching 'dist' 17:22:56 INFO - no previously-included directories found matching '.git*' 17:22:56 INFO - Successfully installed jsonschema functools32 17:22:56 INFO - Cleaning up... 17:22:56 INFO - Return code: 0 17:22:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:22: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')]} 17:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22: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')]} 17:22:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22: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', '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 0xdef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1159d60>, '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 0x115aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115aef0>, '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': '20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326', '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 17:22: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:22: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 functools32==3.2.3-2 17:22:56 INFO - Using env: {'DISPLAY': ':0', 17:22:56 INFO - 'HOME': '/home/cltbld', 17:22:56 INFO - 'LANG': 'en_US.UTF-8', 17:22:56 INFO - 'LANGUAGE': 'en_US:en', 17:22:56 INFO - 'LOGNAME': 'cltbld', 17:22:56 INFO - 'MAIL': '/var/mail/cltbld', 17:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:56 INFO - 'MOZ_NO_REMOTE': '1', 17:22:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:56 INFO - 'NO_EM_RESTART': '1', 17:22:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:56 INFO - 'PWD': '/builds/slave/test', 17:22:56 INFO - 'SHELL': '/bin/bash', 17:22:56 INFO - 'SHLVL': '1', 17:22:56 INFO - 'TERM': 'linux', 17:22:56 INFO - 'TMOUT': '86400', 17:22:56 INFO - 'USER': 'cltbld', 17:22:56 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326', 17:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:56 INFO - '_': '/tools/buildbot/bin/python'} 17:22:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:22:56 INFO - Cleaning up... 17:22:56 INFO - Return code: 0 17:22:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:22: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')]} 17:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22: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')]} 17:22:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22: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 0xdef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1159d60>, '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 0x115aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115aef0>, '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': '20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326', '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 17:22: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 17:22: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 17:22:56 INFO - Using env: {'DISPLAY': ':0', 17:22:56 INFO - 'HOME': '/home/cltbld', 17:22:56 INFO - 'LANG': 'en_US.UTF-8', 17:22:56 INFO - 'LANGUAGE': 'en_US:en', 17:22:56 INFO - 'LOGNAME': 'cltbld', 17:22:56 INFO - 'MAIL': '/var/mail/cltbld', 17:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:56 INFO - 'MOZ_NO_REMOTE': '1', 17:22:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:56 INFO - 'NO_EM_RESTART': '1', 17:22:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:56 INFO - 'PWD': '/builds/slave/test', 17:22:56 INFO - 'SHELL': '/bin/bash', 17:22:56 INFO - 'SHLVL': '1', 17:22:56 INFO - 'TERM': 'linux', 17:22:56 INFO - 'TMOUT': '86400', 17:22:56 INFO - 'USER': 'cltbld', 17:22:56 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326', 17:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:56 INFO - '_': '/tools/buildbot/bin/python'} 17:22:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:56 INFO - Downloading/unpacking blobuploader==1.2.4 17:22: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 17:22: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 17:22: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 17:22: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 17:22:57 INFO - Downloading blobuploader-1.2.4.tar.gz 17:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:22:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:22: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 17:22: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 17:22: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 17:22: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 17:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:22:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:22: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 17:22: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 17:22: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 17:22: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 17:22:58 INFO - Downloading docopt-0.6.1.tar.gz 17:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:22:58 INFO - Installing collected packages: blobuploader, requests, docopt 17:22:58 INFO - Running setup.py install for blobuploader 17:22:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:22:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:22:58 INFO - Running setup.py install for requests 17:22:59 INFO - Running setup.py install for docopt 17:22:59 INFO - Successfully installed blobuploader requests docopt 17:22:59 INFO - Cleaning up... 17:22:59 INFO - Return code: 0 17:22:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:22: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')]} 17:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22: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')]} 17:22:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22: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 0xdef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1159d60>, '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 0x115aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115aef0>, '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': '20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326', '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 17:22: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 17:22: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 17:22:59 INFO - Using env: {'DISPLAY': ':0', 17:22:59 INFO - 'HOME': '/home/cltbld', 17:22:59 INFO - 'LANG': 'en_US.UTF-8', 17:22:59 INFO - 'LANGUAGE': 'en_US:en', 17:22:59 INFO - 'LOGNAME': 'cltbld', 17:22:59 INFO - 'MAIL': '/var/mail/cltbld', 17:22:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:59 INFO - 'MOZ_NO_REMOTE': '1', 17:22:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:59 INFO - 'NO_EM_RESTART': '1', 17:22:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:59 INFO - 'PWD': '/builds/slave/test', 17:22:59 INFO - 'SHELL': '/bin/bash', 17:22:59 INFO - 'SHLVL': '1', 17:22:59 INFO - 'TERM': 'linux', 17:22:59 INFO - 'TMOUT': '86400', 17:22:59 INFO - 'USER': 'cltbld', 17:22:59 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326', 17:22:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:59 INFO - '_': '/tools/buildbot/bin/python'} 17:22:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:22:59 INFO - Running setup.py (path:/tmp/pip-oH68_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:22:59 INFO - Running setup.py (path:/tmp/pip-UbyXeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:22:59 INFO - Running setup.py (path:/tmp/pip-GWgigu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:22:59 INFO - Running setup.py (path:/tmp/pip-nH3wJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:22:59 INFO - Running setup.py (path:/tmp/pip-Ja3d1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:22:59 INFO - Running setup.py (path:/tmp/pip-_pY0Zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:22:59 INFO - Running setup.py (path:/tmp/pip-mKUS5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:22:59 INFO - Running setup.py (path:/tmp/pip-u8oNN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:22:59 INFO - Running setup.py (path:/tmp/pip-nHJ2Iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:22:59 INFO - Running setup.py (path:/tmp/pip-OhRyyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:23:00 INFO - Running setup.py (path:/tmp/pip-n_VqKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:23:00 INFO - Running setup.py (path:/tmp/pip-stZuVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:23:00 INFO - Running setup.py (path:/tmp/pip-xQBbPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:23:00 INFO - Running setup.py (path:/tmp/pip-_Ilk6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:23:00 INFO - Running setup.py (path:/tmp/pip-eUwHTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:23:00 INFO - Running setup.py (path:/tmp/pip-89AwSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:23:00 INFO - Running setup.py (path:/tmp/pip-T0IrIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:23:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:23:00 INFO - Running setup.py install for manifestparser 17:23:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:23:00 INFO - Running setup.py install for mozcrash 17:23:00 INFO - Running setup.py install for mozdebug 17:23:00 INFO - Running setup.py install for mozdevice 17:23:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:23:00 INFO - Running setup.py install for mozfile 17:23:01 INFO - Running setup.py install for mozhttpd 17:23:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:23:01 INFO - Running setup.py install for mozinfo 17:23:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:23:01 INFO - Running setup.py install for mozInstall 17:23:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:23:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:23:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:23:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:23:01 INFO - Running setup.py install for mozleak 17:23:01 INFO - Running setup.py install for mozlog 17:23:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:23:01 INFO - Running setup.py install for moznetwork 17:23:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:23:01 INFO - Running setup.py install for mozprocess 17:23:01 INFO - Running setup.py install for mozprofile 17:23:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:23:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:23:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:23:01 INFO - Running setup.py install for mozrunner 17:23:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:23:02 INFO - Running setup.py install for mozscreenshot 17:23:02 INFO - Running setup.py install for moztest 17:23:02 INFO - Running setup.py install for mozversion 17:23:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:23:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:23:02 INFO - Cleaning up... 17:23:02 INFO - Return code: 0 17:23:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:23: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')]} 17:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23: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')]} 17:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23: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 0xdef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1159d60>, '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 0x115aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115aef0>, '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': '20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326', '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 17:23: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 17:23: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 17:23:02 INFO - Using env: {'DISPLAY': ':0', 17:23:02 INFO - 'HOME': '/home/cltbld', 17:23:02 INFO - 'LANG': 'en_US.UTF-8', 17:23:02 INFO - 'LANGUAGE': 'en_US:en', 17:23:02 INFO - 'LOGNAME': 'cltbld', 17:23:02 INFO - 'MAIL': '/var/mail/cltbld', 17:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:02 INFO - 'MOZ_NO_REMOTE': '1', 17:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:02 INFO - 'NO_EM_RESTART': '1', 17:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:02 INFO - 'PWD': '/builds/slave/test', 17:23:02 INFO - 'SHELL': '/bin/bash', 17:23:02 INFO - 'SHLVL': '1', 17:23:02 INFO - 'TERM': 'linux', 17:23:02 INFO - 'TMOUT': '86400', 17:23:02 INFO - 'USER': 'cltbld', 17:23:02 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326', 17:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:02 INFO - '_': '/tools/buildbot/bin/python'} 17:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:23:02 INFO - Running setup.py (path:/tmp/pip-43NLaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:23: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)) 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:23:02 INFO - Running setup.py (path:/tmp/pip-HxQWOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:23: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)) 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:23:02 INFO - Running setup.py (path:/tmp/pip-NFFdkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:23: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)) 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:23:02 INFO - Running setup.py (path:/tmp/pip-CFftCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:23: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)) 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:23:02 INFO - Running setup.py (path:/tmp/pip-X_1Kc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:23: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)) 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:23:02 INFO - Running setup.py (path:/tmp/pip-ycFnzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:23: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)) 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:23:02 INFO - Running setup.py (path:/tmp/pip-06qVD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:23: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)) 17:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:23:03 INFO - Running setup.py (path:/tmp/pip-Qvs3FA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:23: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)) 17:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:23:03 INFO - Running setup.py (path:/tmp/pip-QgVlre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:23: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)) 17:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:23:03 INFO - Running setup.py (path:/tmp/pip-kHcbbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:23: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)) 17:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:23:03 INFO - Running setup.py (path:/tmp/pip-9n5fqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:23: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)) 17:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:23:03 INFO - Running setup.py (path:/tmp/pip-byP0Q_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:23: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)) 17:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:23:03 INFO - Running setup.py (path:/tmp/pip-IRcaF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:23: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)) 17:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:23:03 INFO - Running setup.py (path:/tmp/pip-w7yCtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:23: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)) 17:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:23:03 INFO - Running setup.py (path:/tmp/pip-N80PT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:23: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)) 17:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:23:03 INFO - Running setup.py (path:/tmp/pip-aIfgrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:23: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)) 17:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:23:03 INFO - Running setup.py (path:/tmp/pip-jCRtj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:23: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)) 17:23: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)) 17:23: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)) 17:23: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)) 17:23: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)) 17:23: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)) 17:23: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)) 17:23:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:23: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 17:23: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 17:23: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 17:23: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 17:23:04 INFO - Downloading blessings-1.6.tar.gz 17:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:23:04 INFO - Installing collected packages: blessings 17:23:04 INFO - Running setup.py install for blessings 17:23:05 INFO - Successfully installed blessings 17:23:05 INFO - Cleaning up... 17:23:05 INFO - Return code: 0 17:23:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:23:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:23:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:23:05 INFO - Reading from file tmpfile_stdout 17:23:05 INFO - Current package versions: 17:23:05 INFO - argparse == 1.2.1 17:23:05 INFO - blessings == 1.6 17:23:05 INFO - blobuploader == 1.2.4 17:23:05 INFO - docopt == 0.6.1 17:23:05 INFO - functools32 == 3.2.3-2 17:23:05 INFO - jsonschema == 2.5.1 17:23:05 INFO - manifestparser == 1.1 17:23:05 INFO - mozInstall == 1.13 17:23:05 INFO - mozcrash == 1.0 17:23:05 INFO - mozdebug == 0.1 17:23:05 INFO - mozdevice == 0.51 17:23:05 INFO - mozfile == 1.2 17:23:05 INFO - mozhttpd == 0.7 17:23:05 INFO - mozinfo == 0.10 17:23:05 INFO - mozleak == 0.1 17:23:05 INFO - mozlog == 3.5 17:23:05 INFO - moznetwork == 0.27 17:23:05 INFO - mozprocess == 0.25 17:23:05 INFO - mozprofile == 0.28 17:23:05 INFO - mozrunner == 6.13 17:23:05 INFO - mozscreenshot == 0.1 17:23:05 INFO - mozsystemmonitor == 0.3 17:23:05 INFO - moztest == 0.8 17:23:05 INFO - mozversion == 1.4 17:23:05 INFO - psutil == 3.1.1 17:23:05 INFO - requests == 1.2.3 17:23:05 INFO - wsgiref == 0.1.2 17:23:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:23: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')]} 17:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23: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')]} 17:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23: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 0xdef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1159d60>, '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 0x115aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115aef0>, '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': '20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326', '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 17:23: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 17:23: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 17:23:05 INFO - Using env: {'DISPLAY': ':0', 17:23:05 INFO - 'HOME': '/home/cltbld', 17:23:05 INFO - 'LANG': 'en_US.UTF-8', 17:23:05 INFO - 'LANGUAGE': 'en_US:en', 17:23:05 INFO - 'LOGNAME': 'cltbld', 17:23:05 INFO - 'MAIL': '/var/mail/cltbld', 17:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:05 INFO - 'MOZ_NO_REMOTE': '1', 17:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:05 INFO - 'NO_EM_RESTART': '1', 17:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:05 INFO - 'PWD': '/builds/slave/test', 17:23:05 INFO - 'SHELL': '/bin/bash', 17:23:05 INFO - 'SHLVL': '1', 17:23:05 INFO - 'TERM': 'linux', 17:23:05 INFO - 'TMOUT': '86400', 17:23:05 INFO - 'USER': 'cltbld', 17:23:05 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326', 17:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:05 INFO - '_': '/tools/buildbot/bin/python'} 17:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23: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)) 17:23: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)) 17:23: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)) 17:23: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)) 17:23: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)) 17:23: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)) 17:23: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)) 17:23: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)) 17:23: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)) 17:23:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:23: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 17:23: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 17:23: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 17:23: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 17:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:23: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)) 17:23: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)) 17:23:06 INFO - Installing collected packages: simplejson 17:23:06 INFO - Running setup.py install for simplejson 17:23:06 INFO - building 'simplejson._speedups' extension 17:23: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 17:23: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 17:23:07 INFO - Successfully installed simplejson 17:23:07 INFO - Cleaning up... 17:23:07 INFO - Return code: 0 17:23:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:23: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')]} 17:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23: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')]} 17:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23: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 0xdef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1159d60>, '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 0x115aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115aef0>, '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': '20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326', '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 17:23: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 17:23: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 17:23:07 INFO - Using env: {'DISPLAY': ':0', 17:23:07 INFO - 'HOME': '/home/cltbld', 17:23:07 INFO - 'LANG': 'en_US.UTF-8', 17:23:07 INFO - 'LANGUAGE': 'en_US:en', 17:23:07 INFO - 'LOGNAME': 'cltbld', 17:23:07 INFO - 'MAIL': '/var/mail/cltbld', 17:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:07 INFO - 'MOZ_NO_REMOTE': '1', 17:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:07 INFO - 'NO_EM_RESTART': '1', 17:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:07 INFO - 'PWD': '/builds/slave/test', 17:23:07 INFO - 'SHELL': '/bin/bash', 17:23:07 INFO - 'SHLVL': '1', 17:23:07 INFO - 'TERM': 'linux', 17:23:07 INFO - 'TMOUT': '86400', 17:23:07 INFO - 'USER': 'cltbld', 17:23:07 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326', 17:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:07 INFO - '_': '/tools/buildbot/bin/python'} 17:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:23:07 INFO - Cleaning up... 17:23:08 INFO - Return code: 0 17:23:08 INFO - Running post-action listener: _resource_record_post_action 17:23:08 INFO - Running post-action listener: _start_resource_monitoring 17:23:08 INFO - Starting resource monitoring. 17:23:08 INFO - [mozharness: 2017-09-27 00:23:08.035116Z] Finished create-virtualenv step (success) 17:23:08 INFO - [mozharness: 2017-09-27 00:23:08.035637Z] Running install step. 17:23:08 INFO - Running pre-action listener: _resource_record_pre_action 17:23:08 INFO - Running main action method: install 17:23:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:23:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:23:08 INFO - Reading from file tmpfile_stdout 17:23:08 INFO - Detecting whether we're running mozinstall >=1.0... 17:23:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:23:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:23:08 INFO - Reading from file tmpfile_stdout 17:23:08 INFO - Output received: 17:23:08 INFO - Usage: mozinstall [options] installer 17:23:08 INFO - Options: 17:23:08 INFO - -h, --help show this help message and exit 17:23:08 INFO - -d DEST, --destination=DEST 17:23:08 INFO - Directory to install application into. [default: 17:23:08 INFO - "/builds/slave/test"] 17:23:08 INFO - --app=APP Application being installed. [default: firefox] 17:23:08 INFO - mkdir: /builds/slave/test/build/application 17:23: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'] 17:23:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:23:26 INFO - Reading from file tmpfile_stdout 17:23:26 INFO - Output received: 17:23:26 INFO - /builds/slave/test/build/application/firefox/firefox 17:23:26 INFO - Running post-action listener: _resource_record_post_action 17:23:26 INFO - [mozharness: 2017-09-27 00:23:26.046063Z] Finished install step (success) 17:23:26 INFO - [mozharness: 2017-09-27 00:23:26.046318Z] Running setup-mitmproxy step. 17:23:26 INFO - Running pre-action listener: _resource_record_pre_action 17:23:26 INFO - Running main action method: setup_mitmproxy 17:23:26 INFO - Skipping: mitmproxy is not required 17:23:26 INFO - Running post-action listener: _resource_record_post_action 17:23:26 INFO - [mozharness: 2017-09-27 00:23:26.047457Z] Finished setup-mitmproxy step (success) 17:23:26 INFO - [mozharness: 2017-09-27 00:23:26.047680Z] Running run-tests step. 17:23:26 INFO - Running pre-action listener: _resource_record_pre_action 17:23:26 INFO - Running pre-action listener: _set_gcov_prefix 17:23:26 INFO - Running main action method: run_tests 17:23:26 WARNING - Try message not found. 17:23:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:23:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:23:26 INFO - Python 2.7.3 17:23:26 INFO - Return code: 0 17:23:26 INFO - grabbing minidump binary from tooltool 17:23: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')]} 17:23: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 0x1159d60>, '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 0x115aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115aef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:23: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 17:23: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 17:23: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 17:23:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:23:26 INFO - Return code: 0 17:23:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:23:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:23:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:23:26 INFO - ENV: RUST_BACKTRACE is now full 17:23:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:23:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:23: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/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 17:23: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/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 17:23:26 INFO - Using env: {'DISPLAY': ':0', 17:23:26 INFO - 'HOME': '/home/cltbld', 17:23:26 INFO - 'LANG': 'en_US.UTF-8', 17:23:26 INFO - 'LANGUAGE': 'en_US:en', 17:23:26 INFO - 'LOGNAME': 'cltbld', 17:23:26 INFO - 'MAIL': '/var/mail/cltbld', 17:23:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:23:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:26 INFO - 'MOZ_NO_REMOTE': '1', 17:23:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:23:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:26 INFO - 'NO_EM_RESTART': '1', 17:23:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:26 INFO - 'PWD': '/builds/slave/test', 17:23:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:23:26 INFO - 'RUST_BACKTRACE': 'full', 17:23:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:23:26 INFO - 'SHELL': '/bin/bash', 17:23:26 INFO - 'SHLVL': '1', 17:23:26 INFO - 'TERM': 'linux', 17:23:26 INFO - 'TMOUT': '86400', 17:23:26 INFO - 'USER': 'cltbld', 17:23:26 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326', 17:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:26 INFO - '_': '/tools/buildbot/bin/python'} 17:23: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/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 17:23:26 INFO - mozversion application_buildid: 20170926225505 17:23:26 INFO - mozversion application_changeset: b7d8ae4a03c62e549b9d82595b1d1964f0af70cd 17:23:26 INFO - mozversion application_display_name: Nightly 17:23:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:23:26 INFO - mozversion application_name: Firefox 17:23:26 INFO - mozversion application_remotingname: firefox 17:23:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:23:26 INFO - mozversion application_vendor: Mozilla 17:23:26 INFO - mozversion application_version: 58.0a1 17:23:26 INFO - mozversion platform_buildid: 20170926225505 17:23:26 INFO - mozversion platform_changeset: b7d8ae4a03c62e549b9d82595b1d1964f0af70cd 17:23:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:23:26 INFO - mozversion platform_version: 58.0a1 17:23:26 INFO - using testdate: 1506471806 17:23:26 INFO - actual date: 1506471806 17:23:26 INFO - starting webserver on 'localhost:47665' 17:23:26 INFO - SUITE-START | Running 2 tests 17:23:26 INFO - TEST-START | dromaeo_css 17:23:26 INFO - Initialising browser for dromaeo_css test... 17:23:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47665/getInfo.html -profile /tmp/tmpwoaaCS/profile 17:23:26 INFO - TEST-INFO | started process 13256 (/builds/slave/test/build/application/firefox/firefox http://localhost:47665/getInfo.html) 17:23:31 INFO - TEST-INFO | 13256: exit 0 17:23:31 INFO - Browser initialized. 17:23:31 INFO - Running cycle 1/1 for dromaeo_css test... 17:23:31 INFO - Using env: {'DISPLAY': ':0', 17:23:31 INFO - 'HOME': '/home/cltbld', 17:23:31 INFO - 'JSGC_DISABLE_POISONING': '1', 17:23:31 INFO - 'LANG': 'en_US.UTF-8', 17:23:31 INFO - 'LANGUAGE': 'en_US:en', 17:23:31 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:23:31 INFO - 'LOGNAME': 'cltbld', 17:23:31 INFO - 'MAIL': '/var/mail/cltbld', 17:23:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:23:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:23:31 INFO - 'MOZ_CRASHREPORTER': '1', 17:23:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:31 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:23:31 INFO - 'MOZ_NO_REMOTE': '1', 17:23:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:23:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:31 INFO - 'NO_EM_RESTART': '1', 17:23:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:31 INFO - 'PWD': '/builds/slave/test', 17:23:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:23:31 INFO - 'RUST_BACKTRACE': 'full', 17:23:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:23:31 INFO - 'SHELL': '/bin/bash', 17:23:31 INFO - 'SHLVL': '1', 17:23:31 INFO - 'TERM': 'linux', 17:23:31 INFO - 'TMOUT': '86400', 17:23:31 INFO - 'USER': 'cltbld', 17:23:31 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326', 17:23:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:31 INFO - '_': '/tools/buildbot/bin/python'} 17:23:31 INFO - TEST-INFO | started process 13494 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwoaaCS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:23:32 INFO - PID 13494 | 17:23:32 INFO - PID 13494 | (/builds/slave/test/build/application/firefox/firefox:13543): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:23:32 INFO - PID 13494 | 17:23:42 INFO - PID 13494 | RSS: Main: 145096704 17:23:42 INFO - PID 13494 | 17:26:41 INFO - PID 13494 | Cycle 1(1): loaded http://localhost:47665/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47665/tests/dromaeo/cssquery-ext.html) 17:26:42 INFO - PID 13494 | RSS: Main: 146874368 17:26:42 INFO - PID 13494 | 17:29:44 INFO - PID 13494 | Cycle 1(1): loaded http://localhost:47665/tests/dromaeo/cssquery-ext.html (next: http://localhost:47665/tests/dromaeo/cssquery-jquery.html) 17:29:44 INFO - PID 13494 | RSS: Main: 146800640 17:29:44 INFO - PID 13494 | 17:32:46 INFO - PID 13494 | Cycle 1(1): loaded http://localhost:47665/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47665/tests/dromaeo/cssquery-mootools.html) 17:32:47 INFO - PID 13494 | RSS: Main: 149663744 17:32:47 INFO - PID 13494 | 17:35:48 INFO - PID 13494 | Cycle 1(1): loaded http://localhost:47665/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47665/tests/dromaeo/cssquery-prototype.html) 17:35:49 INFO - PID 13494 | RSS: Main: 147828736 17:35:49 INFO - PID 13494 | 17:38:52 INFO - PID 13494 | Cycle 1(1): loaded http://localhost:47665/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47665/tests/dromaeo/cssquery-yui.html) 17:38:52 INFO - PID 13494 | RSS: Main: 148217856 17:38:52 INFO - PID 13494 | 17:41:54 INFO - PID 13494 | Cycle 1(1): loaded http://localhost:47665/tests/dromaeo/cssquery-yui.html (next: http://localhost:47665/tests/dromaeo/cssquery-dojo.html) 17:41:54 INFO - PID 13494 | RSS: Main: 151212032 17:41:54 INFO - PID 13494 | 17:41:54 INFO - PID 13494 | __start_tp_report 17:41:54 INFO - PID 13494 | _x_x_mozilla_page_load 17:41:54 INFO - PID 13494 | _x_x_mozilla_page_load_details 17:41:54 INFO - PID 13494 | |i|pagename|runs| 17:41:54 INFO - PID 13494 | |0;dojo.html;3894.5910679378662;3906.140649057207;3918.0596656802377;3936.724429289951;3937.4684417603635;6296.464800491964;6319.6524191169465;6369;6458.321876203002;6464.09502669626;6344.587601805891;6357.65032923189;6361.936380636193;6400.551961362707;6415.390537898892;5637.971810140964;5672.205891175218;5677.602567820254;5720.141978703186;5722.227499287585;5745.253117094772;5769.105788602773;5769.682667453289;5774.7401366938375;5793.13103034544;5758.222639943596;5798.7100644967795;5821.09772985188;5829.09649004405;5879.176915231871;5748.913766293488;5764.077747560412;5779.422057794229;5840.153177789197;5852.707364631773;5571.777128914839;5607.663540187602;5632.324121105453;5677.347105082927;5729.828105156852;6170.167027451282;6334.398232167937;6351.301356850743;6407;6426.485881129498;6888.173419189679;6905.37851593354;6978.651067446658;6985.755498557526;6985.79042628722;6886.380225779654;6916.23921368649;6970.686319115652;7045.788626341218;7047.013418121467;6469.126667899774;6502.252240992252;6550.967245163792;6552.377524135247;6557.442617377528;7130.643467826588;7139.785806425815;7207.0270513481055;7215.134183897966;7221.31397517235;6835.58986460814;6847.589144651337;6876.828079298058;6884.483663725241;6905.378515933489;6923.307669233036;6944.583325000516;7008.369246767714;7018.508704390746;7024.824379390556;6861.039454476378;6862.176538815374;6869.484788640872;6948.687309071104;6967.442604591621;6760.391564759196;6860.485463590251;6886.48351373649;6898.172219333712;6903.344182302673;5050.040492306523;5081.923771143436;5117.8464646060675;5126.077306084866;5137.280780690707;4494.213512635276;4591.311303304531;4626.282926146453;4628.83799067031;4632.420947381577;6235.594686345464;6247.750449910036;6248.718807653667;6321.525885558602;6322.810315690536;6842.897356539655;6851.109355783816;6852.383285504328;6859.211190713132;6860.5197636165985;6307.432331090224;6371.872562548723;6415.26224484181;6416.069669897839;6417.294097649255;5527.281453411031;5658.603897727119;5670.234518340054;5685.033544297479;5688.11834165705;7104.502684812013;7186.532875363085;7199.3520583147765;7213.819654508679;7216.0258365120035;6865.759698410531;6878.69045892946;6881.277465866212;6882.724691012303;6888.41448476865;7104.928950710427;7156.212816590067;7162.462815288978;7192.42460603161;7198.640067996684;6903.309669033258;6917.654117294014;6920.688569014507;6931.029655848084;6954.826129346807;6880.827979300558;6900.654967251517;6917.7232910685025;6997.510174287954;7018.824529386806;6583.210014798255;6711.328867113445;6712.228093769084;6715.160604924385;6794.592324460548;6762.120924279812;6787.66061696923;6787.966060169668;6790.7623233186605;6801.0138529913875;6588.04473351371;6607.141071660653;6694.995750637443;6697.665116744241;6703.966480167568;6722.294159113419;6770.627615481196;6816.829579260559;6843.213030501556;6873.828154296182;6491.902621460587;6544.345565443417;6568.620589676221;6615.569987950767;6623.933760662524 17:41:54 INFO - PID 13494 | |1;ext.html;958.7603099225194;988.0317289056724;988.9604415823368;990.4651488196374;992.9106380425765;43465.13069738607;44255.114897702064;44368.77815610921;44370.55629443705;44477.555224447744;40563.797181014124;40707.18585628286;40755.18489630205;40813;40825.387619185734;7500.399968002574;7603.859421086853;7609.0869095708595;7625.389968802482;7625.542467451943;7519.473636845423;7582.052243469567;7592.164861865191;7593.696252149907;7612.505187162817;7579.583122928237;7616.543007419545;8489.23596876281;8660.393772435931;8695.21743043126;8570;8648.43785153963;8649.870251946226;8652.22130008299;8654.09132041133;8181.918180818175;8386.916130838674;8395.244428001448;8506.106858779802;8588.527630980294;41469.1706165878;41814.58185418137;41819.58180418187;41861;41901;3678.2091850252323;3708.647678470541;3728.7949162796035;3731.8320675569394;3739.8504059837846;33442.49836252458;33457.16357091068;33534.6646533534;33547.83226083878;33634.1591460213;5489;5499.065158922993;5524.502794748451;5526.47498487643;5533.557315414757;219220;220303;220944;220971;222155.99999999837;46080.769596151804;46340.768296158305;46849.76575117103;52407.73796130995;53137.468625314024;55591.722041389534;55791.44208557944;55792;55866.72066639641;55961.72019139878;16153.757693634605;16229.513114606581;16276.593085172728;16284.267207975432;16292.51122466328;12434.502619895104;12442.253464792142;12476.875231247754;12613.243205407705;12615.432305546272;14707.338169782386;14757;14758;14857.554273371816;15027.09837409759;5696.8860622787315;5762.2509073820975;5780.32370612526;5839.503642190376;6014.48876845473;1072.1904961753983;1087.9401632910267;1096.4408151842617;1103.6523495099018;1111.5553778488509;25602;25650.35874103125;25782.226533204033;25818.22545323643;26071.348216294744;1174.8413964114907;1178.5698220149584;1189.4469071881617;1191.5889018288676;1195.9043276537857;13470;13545.187288762509;13600.795988060187;13787.931060344834;13818.37817298224;283582;284449;284669;284734;284809;60429.697851510464;60564.39435605588;60657.69671151616;60839.39160608426;61265.387346125965;1483.2064845307925;1497.7229212595923;1520.7414739494313;1537.1622465755966;1541.306412114553;25208.361456505267;25417.74582254154;25448.745512545378;25488.617670735326;25640;42691;42707.786461067495;42711.3593296107;42733;42762.14475710531;247575;248024;248116;248142;248431;33015.17462063468;33408.83295583507;36329.091772704836;36498.45252321164;36905.44641830321;47948;48399.75800121118;48481.27278090902;48491.75754121207;49142.508574913794;35517;35519.934401967985;35701.64298357087;35750.28499430049;36131.81934090313;35128.82435587806;35289.64710352864;35896.64103359037;36012.45981310335;36072.45891311685;41269;41341.793291033355;41709.37435938524;41742.95642608959;41854;33494.83252583721;33893.49159762655;34123.488147678305;34293.65706342905;34375.656243437246;26274.029447791876;26393.604095938193;26495.735042650096;26964.191074267805;27390 17:41:54 INFO - PID 13494 | |2;jquery.html;579.8289504596144;608.5283904973642;618.2025187508118;633.2717375018727;642.431448168371;23460.64809027866;23784.28647140584;24299.392515187108;24359.878200609015;24363.39091522713;22420.215292464767;22971.310860674206;23098.076076956942;23143.421414464647;23167;6602.537822352438;6687.899681504781;6708.496862735315;6719.092922455479;6727.058211850321;6540.836479088013;6544.083828264047;6859.451243900501;6901.309869013109;6903.896441553381;6849.657517124148;6851.554648947827;6853.417459515922;6853.862922741542;6854.0404343391965;6549.869002619945;6780.08468856703;6792.150981127359;6802.4898132639755;6845.075914751519;6276.309605943343;6281.59169653971;6338.556301058928;6342.207224096988;6348.746050157988;30649;30900.53649195264;31001.689983100106;31012.844935775178;31367.529487057713;2120.5546835164632;2142.9464263393384;2144.1101942693763;2145.785421457842;2151.698762173297;19580.314688985818;20919.5816083679;20966.16135354599;20970;21022.894885525475;2553.3616595851036;2563.154159127502;2596.4287856671504;2629.1323863125313;2629.500394924958;126405.36797315955;131738.3413082938;150605;154806;161641;15615.60960975962;16171.595710107342;16228.51314460568;16396.672066558604;16883.915580422265;25636.05185403665;25656.61515077275;25710.10014649516;25743.871280643853;25798.226053218434;10137.746556336004;10303.124234440007;10334.948325258476;10359.482025898675;10449.425281609432;9259.166674999282;9288.7677808054;9319.627214911463;9390.577424015935;9482.525873706287;9590.184834289164;9686.515674216262;9902.356346837432;9931.453770042717;10033.448160351105;2751.6422865027816;2795.5107856125096;2925.546540286259;2950.1002194330504;3012.774041946863;1028.881678606955;1036.388530766851;1041.2398948767443;1056.7410984308895;1062.5909025025421;20972.056257468146;21309.25417610376;21343;21429.571408572054;21825.890870545863;1076.983845242322;1094.4746521669642;1110.1673744691482;1111.5053801058614;1113.4599719136213;11596.362200079077;11710.765784684429;11713.648590542298;11849.348285844362;11864.347460889734;513977;553343;554997;566110;577978;130974;133414;133490;134785;134884;1193.7254431480808;1213.9605462822367;1230.7415442757122;1232.6548566401423;1236.1779416687802;18484.907575462035;18891.149898254338;19047.238110475424;19155.71266430977;19309;59523.40476595179;59991.40008599858;60058;60256.39743602508;61840.38159618346;75485;75738;76365;76959;77121;15577.84422155764;15603.375864965728;15739.527814165593;15763.97534160276;15812.60468488251;23741.64387534154;23849.046038158278;23912.56524608529;24453.144139955017;24525.877370613034;19418.90290548538;19455.221791128195;19579.118939647466;19662.21351145938;19725.40823775289;17516.299348026445;17553;17626.823731762517;18137.546561336072;18249.543761406072;19628.411147665593;20196.394108176777;20279.59440811146;20466.69299960472;20513.89743051335;15331.386744530093;15422.537323880302;15439.305231264396;15502.922485387951;15541.378344866078;19280.807191927903;19284;19316;19456.319028833925;19663.8033619662 17:41:54 INFO - PID 13494 | |3;mootools.html;1429.5782744090493;1473.9778903316453;1493.0220705437941;1496.887733419993;1504.9247537623123;16693.74959375609;17367.218475168615;17375.913120434398;17381.044042577654;17383.999999999985;16844.57888552787;16856.494305170865;16873.493795186132;16965.406210782625;16967.57581060474;2816.155153453961;2853.7574306183897;2854.9714502855018;2856.2002639260936;2862.384587313727;2779.986100069497;2862.484752744505;2863.584780206869;2864.4987127252753;2865.4698880707138;2734.1387462949206;2760.558310670293;2769.4322663853864;2773.5839624056453;2774.389634280455;2650.60240963856;2688.6908005579216;2700.203439985209;2708.9322766930786;2711.7830573554165;2641.2076377086796;2651.3106592286144;2660.068975858434;2666.640003599528;2669.7597216250438;15779.28993195309;15932.920335398365;15935.760963585555;15944.521664350088;15993.680126397523;8113.959430202811;8396.160383961555;8458.66165353385;8467.32261419085;8471.364647651451;4956.207006878918;5217.2695822584865;5385.730713464351;5395.136778115522;5527.668339899619;1974.1511150205406;2012.9396118116333;2026.6656001759693;2085.0304608357187;2104.7263855698816;27395;27533.449331013268;27890.35041671038;30437.695623043706;31330.373392532023;7248.963755181296;7497.775066748006;7561.09266887977;7641.3886889048745;7708.38332933364;22981.88509057444;23091.19180828663;23116;23117.768822311897;23153.189638362575;8428.915710842935;8453.323734101381;8456.196661317164;8456.915430845613;8469.703560375357;7487.251274872469;7600.543967361976;7617.390608751287;7621.3902887768845;7625;5994.790182343597;6215.122767857208;6246.219222597176;6291.716872740646;6377.17096777416;1818.7453756474104;1835.8072402397822;1839.2802729448008;1850.5743678953647;1871.6350311689089;994.572333896417;1004.7940172264668;1006.1699098243978;1022.9795404092025;1026.58423338548;9724.367916085432;9794.167495762798;9989.001099889952;10020.799584008279;10029.097381235724;792.3542313014874;797.8165022044847;800.8198155415101;803.0804728585737;812.1269635142246;4827.396575428072;4882.926756098661;4946.258061290835;4962.454130045692;4984.775685094107;24274.75725242725;25067.87466062658;25181.62227566588;25332.74667253341;25338.873305633355;23618.64572031421;24697.382565436008;24714.629280560806;24753.752462475506;24770.380740481272;11366.715832104099;11691.415429228504;11982.52069917211;12690.175138615961;13060.08579399452;10023.69928902134;10112;10219.13137383301;10343.793124137324;10459.68620941373;20739.8963005184;21796.564068718853;21849.563008740053;21860.781392185876;21943.890280548494;21620.67568986498;21928;22156.446088847908;22203.22288719887;22291.331260062223;12948.223106613634;13000.479980800663;13254.734905302033;13259.535916242885;13336.333183340988;14993.100413975197;15300.846991530387;15306.387744490095;15318.080915145127;15319.387224510894;12130.33283169434;12151;12215.511379544718;12262.570810021964;12442.253464792142;12038.75922481563;12126.48651802327;12201.08491863096;12249.755004900031;12371.628851134481;10455.58177672915;10483.52824122901;10598.364098153826;10600;10616;8315.501069935823;8334.333253339597;8361.163883611833;8406.621702023302;8409.117042710428;8070.636821342936;8085.514869107872;8176.67293308261;8179.591020448835;8239.794005149919 17:41:54 INFO - PID 13494 | |4;prototype.html;540.4865377891002;563.2621266141358;569.208799768322;582.5688990147291;585.2771826793909;6163.691815409228;6181.474574661148;6201.751929922803;6231.252249730039;6254.4371006609335;6108.755649774015;6169.5989760665525;6196.752129914798;6204.813855584329;6247.437730604244;5023.974880125595;5052.26742122392;5062.898742025157;5064.544191022807;5076.111680455924;4804;4909;4972.552470277675;4978.352814134158;5073.7463126843695;4909.68087074339;4945.455999840033;4949.579285760715;4958.950410495903;4972.985940694025;4884.169691152512;4906.460289368167;4925;4934.40787105546;4951.331570238008;4311.1808756336195;4408.206522825923;4429.756363400012;4447.844325448594;4478.305862591304;5937.465628093492;5994.912620000703;6020.488258498033;6121;6121.143039974407;5794.377574279209;5797.188393624896;5818.5345172386105;5836.854078648025;5851.473367396955;6544;6581.835454113638;6625.271220165826;6669.466442684574;6683.421856028636;4815.5906747926465;5000.3249561309485;5024.974875125601;5055.266986286968;5073.868975030496;6821.1814582250445;6828.385445309897;6957.538916827421;6964.512484126113;6970.2681218471835;5159.606906135397;5193.37679478465;5214.0447332250405;5224.294720212799;5225.947740522623;5222.694326418396;5247.790088396498;5254.264402983586;5263.526282634504;5276.234945932818;5814.825555233349;5820.650760954271;5854.302252346772;5868.501177399969;5887.322957859816;6559.212894452697;6669.666516674244;6684.197896252481;6705.2624211336715;6733.787918174776;1769.4780039888265;1804.124999375302;1806.151108978778;1812.5196822841958;1826.9451916442529;1211.5577814097792;1270.142653708743;1278.1947373154853;1286.852012018611;1305.7323248733987;6120.540959428061;6136.693165341715;6151.231096112986;6171.814845554551;6208.2373343862455;6492.383223593751;6548.607083575001;6589.967050164719;6662.233843108104;6683.298253683391;5758.481736643722;5911.231539899785;6026.668533230714;6082.209312789398;6086.60437071589;3420.81185534793;3456.637053109387;3473.4616134498688;3485.7385696072897;3543.2204914918675;6815.863682726318;6846.884667476286;6848.246692863781;6859.519833611599;6922.273161317989;6826.283240259701;6843.22076260166;6864.828379290558;6924.79225623222;6932.584044957319;6878.55289406187;6929.618870962045;6937.167539895245;7056.6118863463;7068.893966590403;6676.732930682719;6708.865822683617;6709.36261055199;6720.899186512304;6756.69594868242;6593.868122637617;6620.742059008773;6674.8998765017595;6729.394354508117;6784.728610855708;6905.792826215222;6935.6475487279495;7008.404285635778;7039.753608623673;7058.929410705828;5073.923891141562;5118.641695081308;5119.283300337881;5147.742612869267;5192.844214673566;6570.901436478361;6748;6752.535324606385;6813.058278390635;6823.078884350748;6393.87212255743;6531.052997315268;6540.444062254572;6557.9344206557325;6614.140161778938;6426.903596445964;6434.485241180788;6514.3811337922825;6540.345965403421;6628.668566571749;6358.523110766619;6371.299157092809;6402.7194561087035;6414.775482858265;6431.807045788634;6529.151210342625;6602.854072426577;6639.867202656016;6640.335966403514;6675.198976122896;6359.904601431075;6375.840603984752;6444.871102577828;6451.290358060516;6505.316941721051 17:41:54 INFO - PID 13494 | |5;yui.html;975.3952549419357;982.3860087445347;994.1698681600863;1007.043308856586;1010.9292349535526;17499.562510937216;18937;19055.14251858666;19059.142338594746;19062.2375104996;19430.417087487396;19599.412017639457;19713.408597742055;19733.210671573157;19737.11182996765;1038.2732087538716;1043.838205078214;1047.8323468245082;1048.5229220704562;1048.847917052027;1063.3672964586096;1063.415121683075;1063.5320458998056;1063.7766069125494;1081.8918108189198;1080.1304949515636;1111.6720567432626;1126.1947707389256;1126.4818183635537;1134.7446824464512;1112.9944350278238;1115.5259014918627;1115.6206889657556;1115.7266469714891;1116.3748300951452;788.9132195458495;816.0248503038871;821.9342452603777;822.8724547695117;823.9876401853977;18494;18510.722339164924;18516.90741546297;18523.166457509444;18574.349897753513;23150.53698926029;23466;24122.39694007646;24301.27096187117;24312.39219019521;18558.072096395128;18700.438986830417;18740.0629968501;18769.436916892515;18807.435776926715;3922.0587059105897;3948.4077388391684;3966.226585815767;3967.3255546557157;3967.861124860616;130472.34763826214;158075;161724;162323;162472;17853.910730446525;17899;18167.45497635073;18188.454346369632;18347.724784127982;31797.04608861738;31810.681893180772;32044.519332210035;32380.514292285636;32512.02463926086;10016.79966400668;10113.494325283853;10114.190864730805;10117.241206909512;10154.543045562967;4533.002739397393;4559.566841150086;4635.675502714845;4650;4662.95337046632;6323.399277068671;6413.134226879405;6424.903626445607;6433.774817881352;6464.6121232725245;1237.7276999060193;1246.5886257534992;1251.7934540800848;1255.554278231233;1261.3251910227984;694.3473135252846;751.305042835375;758.1849511774864;771.8957940677936;777.1645481107719;13456.932715336361;13781.310934453237;13915.30423478822;13950.162990220619;13976;736.1571001203592;737.7307282841831;744.2037020388241;748.6855520681327;757.8105473631592;6528.445082167974;6590.308017658077;6617.2059352877;6644.8671026579195;6661.800145995628;151265.24367378312;151621.24189379203;154433;155809.22095389676;160578;130491;130921;131261;131794;139246.30376848252;108504;115322.42338788252;115684;115816;118526;13696.452141914611;14080.78878816798;14232.573022809333;14369.712605748036;14485.710285794436;56115;56499;56933.43066569281;58358.416415837;59159;73531;74351;75068.62465687636;75406.24593753992;76555;19720.309789157884;20375.286864959657;20539.486512836702;20728.792712072685;20869.895650521652;21115.155393784076;21619.35141945744;21951.560968780854;22445.43886402853;22537.5492490146;21122.894385527972;21258.25596104191;21388.251411200534;21452;21477;19799.40601781949;19868.60262794707;20088;20120.19519219215;20414.693779593614;19422.320218792276;19640.116194770984;19647.60704785925;19942.50143746418;20256.493587660425;15025;15132.394704211709;15228.543143705707;15312.693746125238;15371.61570960735;14599.343029563483;15096.16971066602;15335.539933802003;15358.001729887968;15372.769408459106 17:41:54 INFO - PID 13494 | __end_tp_report 17:41:54 INFO - PID 13494 | __start_cc_report 17:41:54 INFO - PID 13494 | _x_x_mozilla_cycle_collect,271 17:41:54 INFO - PID 13494 | __end_cc_report 17:41:54 INFO - PID 13494 | __startTimestamp1506472914659__endTimestamp 17:41:54 INFO - PID 13494 | 17:41:54 INFO - PID 13494 | ------- Summary: start ------- 17:41:54 INFO - PID 13494 | Number of tests: 6 17:41:54 INFO - PID 13494 | 17:41:54 INFO - PID 13494 | [#0] dojo.html Cycles:165 Average:6377.31 Median:6623.93 stddev:759.28 (11.5%) stddev-sans-first:736.21 17:41:54 INFO - PID 13494 | Values: 3894.6 3906.1 3918.1 3936.7 3937.5 6296.5 6319.7 6369.0 6458.3 6464.1 6344.6 6357.7 6361.9 6400.6 6415.4 5638.0 5672.2 5677.6 5720.1 5722.2 5745.3 5769.1 5769.7 5774.7 5793.1 5758.2 5798.7 5821.1 5829.1 5879.2 5748.9 5764.1 5779.4 5840.2 5852.7 5571.8 5607.7 5632.3 5677.3 5729.8 6170.2 6334.4 6351.3 6407.0 6426.5 6888.2 6905.4 6978.7 6985.8 6985.8 6886.4 6916.2 6970.7 7045.8 7047.0 6469.1 6502.3 6551.0 6552.4 6557.4 7130.6 7139.8 7207.0 7215.1 7221.3 6835.6 6847.6 6876.8 6884.5 6905.4 6923.3 6944.6 7008.4 7018.5 7024.8 6861.0 6862.2 6869.5 6948.7 6967.4 6760.4 6860.5 6886.5 6898.2 6903.3 5050.0 5081.9 5117.8 5126.1 5137.3 4494.2 4591.3 4626.3 4628.8 4632.4 6235.6 6247.8 6248.7 6321.5 6322.8 6842.9 6851.1 6852.4 6859.2 6860.5 6307.4 6371.9 6415.3 6416.1 6417.3 5527.3 5658.6 5670.2 5685.0 5688.1 7104.5 7186.5 7199.4 7213.8 7216.0 6865.8 6878.7 6881.3 6882.7 6888.4 7104.9 7156.2 7162.5 7192.4 7198.6 6903.3 6917.7 6920.7 6931.0 6954.8 6880.8 6900.7 6917.7 6997.5 7018.8 6583.2 6711.3 6712.2 6715.2 6794.6 6762.1 6787.7 6788.0 6790.8 6801.0 6588.0 6607.1 6695.0 6697.7 6704.0 6722.3 6770.6 6816.8 6843.2 6873.8 6491.9 6544.3 6568.6 6615.6 6623.9 17:41:54 INFO - PID 13494 | 17:41:54 INFO - PID 13494 | [#1] ext.html Cycles:180 Average:42995.65 Median:20307.05 stddev:65677.70 (323.4%) stddev-sans-first:65786.10 17:41:54 INFO - PID 13494 | Values: 958.8 988.0 989.0 990.5 992.9 43465.1 44255.1 44368.8 44370.6 44477.6 40563.8 40707.2 40755.2 40813.0 40825.4 7500.4 7603.9 7609.1 7625.4 7625.5 7519.5 7582.1 7592.2 7593.7 7612.5 7579.6 7616.5 8489.2 8660.4 8695.2 8570.0 8648.4 8649.9 8652.2 8654.1 8181.9 8386.9 8395.2 8506.1 8588.5 41469.2 41814.6 41819.6 41861.0 41901.0 3678.2 3708.6 3728.8 3731.8 3739.9 33442.5 33457.2 33534.7 33547.8 33634.2 5489.0 5499.1 5524.5 5526.5 5533.6 219220.0 220303.0 220944.0 220971.0 222156.0 46080.8 46340.8 46849.8 52407.7 53137.5 55591.7 55791.4 55792.0 55866.7 55961.7 16153.8 16229.5 16276.6 16284.3 16292.5 12434.5 12442.3 12476.9 12613.2 12615.4 14707.3 14757.0 14758.0 14857.6 15027.1 5696.9 5762.3 5780.3 5839.5 6014.5 1072.2 1087.9 1096.4 1103.7 1111.6 25602.0 25650.4 25782.2 25818.2 26071.3 1174.8 1178.6 1189.4 1191.6 1195.9 13470.0 13545.2 13600.8 13787.9 13818.4 283582.0 284449.0 284669.0 284734.0 284809.0 60429.7 60564.4 60657.7 60839.4 61265.4 1483.2 1497.7 1520.7 1537.2 1541.3 25208.4 25417.7 25448.7 25488.6 25640.0 42691.0 42707.8 42711.4 42733.0 42762.1 247575.0 248024.0 248116.0 248142.0 248431.0 33015.2 33408.8 36329.1 36498.5 36905.4 47948.0 48399.8 48481.3 48491.8 49142.5 35517.0 35519.9 35701.6 35750.3 36131.8 35128.8 35289.6 35896.6 36012.5 36072.5 41269.0 41341.8 41709.4 41743.0 41854.0 33494.8 33893.5 34123.5 34293.7 34375.7 26274.0 26393.6 26495.7 26964.2 27390.0 17:41:54 INFO - PID 13494 | 17:41:54 INFO - PID 13494 | [#2] jquery.html Cycles:180 Average:37999.07 Median:22123.05 stddev:93142.42 (421.0%) stddev-sans-first:93361.33 17:41:54 INFO - PID 13494 | Values: 579.8 608.5 618.2 633.3 642.4 23460.6 23784.3 24299.4 24359.9 24363.4 22420.2 22971.3 23098.1 23143.4 23167.0 6602.5 6687.9 6708.5 6719.1 6727.1 6540.8 6544.1 6859.5 6901.3 6903.9 6849.7 6851.6 6853.4 6853.9 6854.0 6549.9 6780.1 6792.2 6802.5 6845.1 6276.3 6281.6 6338.6 6342.2 6348.7 30649.0 30900.5 31001.7 31012.8 31367.5 2120.6 2142.9 2144.1 2145.8 2151.7 19580.3 20919.6 20966.2 20970.0 21022.9 2553.4 2563.2 2596.4 2629.1 2629.5 126405.4 131738.3 150605.0 154806.0 161641.0 15615.6 16171.6 16228.5 16396.7 16883.9 25636.1 25656.6 25710.1 25743.9 25798.2 10137.7 10303.1 10334.9 10359.5 10449.4 9259.2 9288.8 9319.6 9390.6 9482.5 9590.2 9686.5 9902.4 9931.5 10033.4 2751.6 2795.5 2925.5 2950.1 3012.8 1028.9 1036.4 1041.2 1056.7 1062.6 20972.1 21309.3 21343.0 21429.6 21825.9 1077.0 1094.5 1110.2 1111.5 1113.5 11596.4 11710.8 11713.6 11849.3 11864.3 513977.0 553343.0 554997.0 566110.0 577978.0 130974.0 133414.0 133490.0 134785.0 134884.0 1193.7 1214.0 1230.7 1232.7 1236.2 18484.9 18891.1 19047.2 19155.7 19309.0 59523.4 59991.4 60058.0 60256.4 61840.4 75485.0 75738.0 76365.0 76959.0 77121.0 15577.8 15603.4 15739.5 15764.0 15812.6 23741.6 23849.0 23912.6 24453.1 24525.9 19418.9 19455.2 19579.1 19662.2 19725.4 17516.3 17553.0 17626.8 18137.5 18249.5 19628.4 20196.4 20279.6 20466.7 20513.9 15331.4 15422.5 15439.3 15502.9 15541.4 19280.8 19284.0 19316.0 19456.3 19663.8 17:41:54 INFO - PID 13494 | 17:41:54 INFO - PID 13494 | [#3] mootools.html Cycles:180 Average:10469.23 Median:24762.07 stddev:7740.63 (31.3%) stddev-sans-first:7732.55 17:41:54 INFO - PID 13494 | Values: 1429.6 1474.0 1493.0 1496.9 1504.9 16693.7 17367.2 17375.9 17381.0 17384.0 16844.6 16856.5 16873.5 16965.4 16967.6 2816.2 2853.8 2855.0 2856.2 2862.4 2780.0 2862.5 2863.6 2864.5 2865.5 2734.1 2760.6 2769.4 2773.6 2774.4 2650.6 2688.7 2700.2 2708.9 2711.8 2641.2 2651.3 2660.1 2666.6 2669.8 15779.3 15932.9 15935.8 15944.5 15993.7 8114.0 8396.2 8458.7 8467.3 8471.4 4956.2 5217.3 5385.7 5395.1 5527.7 1974.2 2012.9 2026.7 2085.0 2104.7 27395.0 27533.4 27890.4 30437.7 31330.4 7249.0 7497.8 7561.1 7641.4 7708.4 22981.9 23091.2 23116.0 23117.8 23153.2 8428.9 8453.3 8456.2 8456.9 8469.7 7487.3 7600.5 7617.4 7621.4 7625.0 5994.8 6215.1 6246.2 6291.7 6377.2 1818.7 1835.8 1839.3 1850.6 1871.6 994.6 1004.8 1006.2 1023.0 1026.6 9724.4 9794.2 9989.0 10020.8 10029.1 792.4 797.8 800.8 803.1 812.1 4827.4 4882.9 4946.3 4962.5 4984.8 24274.8 25067.9 25181.6 25332.7 25338.9 23618.6 24697.4 24714.6 24753.8 24770.4 11366.7 11691.4 11982.5 12690.2 13060.1 10023.7 10112.0 10219.1 10343.8 10459.7 20739.9 21796.6 21849.6 21860.8 21943.9 21620.7 21928.0 22156.4 22203.2 22291.3 12948.2 13000.5 13254.7 13259.5 13336.3 14993.1 15300.8 15306.4 15318.1 15319.4 12130.3 12151.0 12215.5 12262.6 12442.3 12038.8 12126.5 12201.1 12249.8 12371.6 10455.6 10483.5 10598.4 10600.0 10616.0 8315.5 8334.3 8361.2 8406.6 8409.1 8070.6 8085.5 8176.7 8179.6 8239.8 17:41:54 INFO - PID 13494 | 17:41:54 INFO - PID 13494 | [#4] prototype.html Cycles:180 Average:5592.38 Median:6170.71 stddev:1568.90 (25.4%) stddev-sans-first:1526.79 17:41:54 INFO - PID 13494 | Values: 540.5 563.3 569.2 582.6 585.3 6163.7 6181.5 6201.8 6231.3 6254.4 6108.8 6169.6 6196.8 6204.8 6247.4 5024.0 5052.3 5062.9 5064.5 5076.1 4804.0 4909.0 4972.6 4978.4 5073.7 4909.7 4945.5 4949.6 4959.0 4973.0 4884.2 4906.5 4925.0 4934.4 4951.3 4311.2 4408.2 4429.8 4447.8 4478.3 5937.5 5994.9 6020.5 6121.0 6121.1 5794.4 5797.2 5818.5 5836.9 5851.5 6544.0 6581.8 6625.3 6669.5 6683.4 4815.6 5000.3 5025.0 5055.3 5073.9 6821.2 6828.4 6957.5 6964.5 6970.3 5159.6 5193.4 5214.0 5224.3 5225.9 5222.7 5247.8 5254.3 5263.5 5276.2 5814.8 5820.7 5854.3 5868.5 5887.3 6559.2 6669.7 6684.2 6705.3 6733.8 1769.5 1804.1 1806.2 1812.5 1826.9 1211.6 1270.1 1278.2 1286.9 1305.7 6120.5 6136.7 6151.2 6171.8 6208.2 6492.4 6548.6 6590.0 6662.2 6683.3 5758.5 5911.2 6026.7 6082.2 6086.6 3420.8 3456.6 3473.5 3485.7 3543.2 6815.9 6846.9 6848.2 6859.5 6922.3 6826.3 6843.2 6864.8 6924.8 6932.6 6878.6 6929.6 6937.2 7056.6 7068.9 6676.7 6708.9 6709.4 6720.9 6756.7 6593.9 6620.7 6674.9 6729.4 6784.7 6905.8 6935.6 7008.4 7039.8 7058.9 5073.9 5118.6 5119.3 5147.7 5192.8 6570.9 6748.0 6752.5 6813.1 6823.1 6393.9 6531.1 6540.4 6557.9 6614.1 6426.9 6434.5 6514.4 6540.3 6628.7 6358.5 6371.3 6402.7 6414.8 6431.8 6529.2 6602.9 6639.9 6640.3 6675.2 6359.9 6375.8 6444.9 6451.3 6505.3 17:41:54 INFO - PID 13494 | 17:41:54 INFO - PID 13494 | [#5] yui.html Cycles:180 Average:28939.96 Median:19060.69 stddev:42385.81 (222.4%) stddev-sans-first:42452.70 17:41:54 INFO - PID 13494 | Values: 975.4 982.4 994.2 1007.0 1010.9 17499.6 18937.0 19055.1 19059.1 19062.2 19430.4 19599.4 19713.4 19733.2 19737.1 1038.3 1043.8 1047.8 1048.5 1048.8 1063.4 1063.4 1063.5 1063.8 1081.9 1080.1 1111.7 1126.2 1126.5 1134.7 1113.0 1115.5 1115.6 1115.7 1116.4 788.9 816.0 821.9 822.9 824.0 18494.0 18510.7 18516.9 18523.2 18574.3 23150.5 23466.0 24122.4 24301.3 24312.4 18558.1 18700.4 18740.1 18769.4 18807.4 3922.1 3948.4 3966.2 3967.3 3967.9 130472.3 158075.0 161724.0 162323.0 162472.0 17853.9 17899.0 18167.5 18188.5 18347.7 31797.0 31810.7 32044.5 32380.5 32512.0 10016.8 10113.5 10114.2 10117.2 10154.5 4533.0 4559.6 4635.7 4650.0 4663.0 6323.4 6413.1 6424.9 6433.8 6464.6 1237.7 1246.6 1251.8 1255.6 1261.3 694.3 751.3 758.2 771.9 777.2 13456.9 13781.3 13915.3 13950.2 13976.0 736.2 737.7 744.2 748.7 757.8 6528.4 6590.3 6617.2 6644.9 6661.8 151265.2 151621.2 154433.0 155809.2 160578.0 130491.0 130921.0 131261.0 131794.0 139246.3 108504.0 115322.4 115684.0 115816.0 118526.0 13696.5 14080.8 14232.6 14369.7 14485.7 56115.0 56499.0 56933.4 58358.4 59159.0 73531.0 74351.0 75068.6 75406.2 76555.0 19720.3 20375.3 20539.5 20728.8 20869.9 21115.2 21619.4 21951.6 22445.4 22537.5 21122.9 21258.3 21388.3 21452.0 21477.0 19799.4 19868.6 20088.0 20120.2 20414.7 19422.3 19640.1 19647.6 19942.5 20256.5 15025.0 15132.4 15228.5 15312.7 15371.6 14599.3 15096.2 15335.5 15358.0 15372.8 17:41:54 INFO - PID 13494 | -------- Summary: end -------- 17:41:54 INFO - PID 13494 | 17:41:55 INFO - TEST-INFO | 13494: exit 0 17:41:55 INFO - TEST-OK | dromaeo_css | took 1108864ms 17:41:55 INFO - TEST-START | kraken 17:41:55 INFO - Initialising browser for kraken test... 17:41:55 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47665/getInfo.html -profile /tmp/tmphU722o/profile 17:41:55 INFO - TEST-INFO | started process 13864 (/builds/slave/test/build/application/firefox/firefox http://localhost:47665/getInfo.html) 17:42:00 INFO - TEST-INFO | 13864: exit 0 17:42:00 INFO - Browser initialized. 17:42:00 INFO - Running cycle 1/1 for kraken test... 17:42:00 INFO - Using env: {'DISPLAY': ':0', 17:42:00 INFO - 'HOME': '/home/cltbld', 17:42:00 INFO - 'JSGC_DISABLE_POISONING': '1', 17:42:00 INFO - 'LANG': 'en_US.UTF-8', 17:42:00 INFO - 'LANGUAGE': 'en_US:en', 17:42:00 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:42:00 INFO - 'LOGNAME': 'cltbld', 17:42:00 INFO - 'MAIL': '/var/mail/cltbld', 17:42:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:42:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:42:00 INFO - 'MOZ_CRASHREPORTER': '1', 17:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:00 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:42:00 INFO - 'MOZ_NO_REMOTE': '1', 17:42:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:42:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:00 INFO - 'NO_EM_RESTART': '1', 17:42:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:00 INFO - 'PWD': '/builds/slave/test', 17:42:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:42:00 INFO - 'RUST_BACKTRACE': 'full', 17:42:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:42:00 INFO - 'SHELL': '/bin/bash', 17:42:00 INFO - 'SHLVL': '1', 17:42:00 INFO - 'TERM': 'linux', 17:42:00 INFO - 'TMOUT': '86400', 17:42:00 INFO - 'USER': 'cltbld', 17:42:00 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326', 17:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:00 INFO - '_': '/tools/buildbot/bin/python'} 17:42:00 INFO - TEST-INFO | started process 14102 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphU722o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:42:00 INFO - PID 14102 | 17:42:00 INFO - PID 14102 | (/builds/slave/test/build/application/firefox/firefox:14152): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:42:00 INFO - PID 14102 | 17:42:11 INFO - PID 14102 | RSS: Main: 144789504 17:42:11 INFO - PID 14102 | 17:42:13 INFO - PID 14102 | Cycle 1(1): loaded http://localhost:47665/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47665/tests/kraken/driver.html?testName=audio-beat-detection) 17:42:14 INFO - PID 14102 | RSS: Main: 150671360 17:42:14 INFO - PID 14102 | 17:42:17 INFO - PID 14102 | Cycle 1(1): loaded http://localhost:47665/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47665/tests/kraken/driver.html?testName=audio-dft) 17:42:17 INFO - PID 14102 | RSS: Main: 151281664 17:42:17 INFO - PID 14102 | 17:42:20 INFO - PID 14102 | Cycle 1(1): loaded http://localhost:47665/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47665/tests/kraken/driver.html?testName=audio-fft) 17:42:21 INFO - PID 14102 | RSS: Main: 147197952 17:42:21 INFO - PID 14102 | 17:42:23 INFO - PID 14102 | Cycle 1(1): loaded http://localhost:47665/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47665/tests/kraken/driver.html?testName=audio-oscillator) 17:42:24 INFO - PID 14102 | RSS: Main: 148287488 17:42:24 INFO - PID 14102 | 17:42:26 INFO - PID 14102 | Cycle 1(1): loaded http://localhost:47665/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47665/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:42:26 INFO - PID 14102 | RSS: Main: 148557824 17:42:26 INFO - PID 14102 | 17:42:29 INFO - PID 14102 | Cycle 1(1): loaded http://localhost:47665/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47665/tests/kraken/driver.html?testName=imaging-darkroom) 17:42:30 INFO - PID 14102 | RSS: Main: 148942848 17:42:30 INFO - PID 14102 | 17:42:33 INFO - PID 14102 | Cycle 1(1): loaded http://localhost:47665/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47665/tests/kraken/driver.html?testName=imaging-desaturate) 17:42:34 INFO - PID 14102 | RSS: Main: 149839872 17:42:34 INFO - PID 14102 | 17:42:37 INFO - PID 14102 | Cycle 1(1): loaded http://localhost:47665/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47665/tests/kraken/driver.html?testName=json-parse-financial) 17:42:38 INFO - PID 14102 | RSS: Main: 151347200 17:42:38 INFO - PID 14102 | 17:42:39 INFO - PID 14102 | Cycle 1(1): loaded http://localhost:47665/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47665/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:42:40 INFO - PID 14102 | RSS: Main: 150753280 17:42:40 INFO - PID 14102 | 17:42:41 INFO - PID 14102 | Cycle 1(1): loaded http://localhost:47665/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47665/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:42:42 INFO - PID 14102 | RSS: Main: 150966272 17:42:42 INFO - PID 14102 | 17:42:44 INFO - PID 14102 | Cycle 1(1): loaded http://localhost:47665/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47665/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:42:45 INFO - PID 14102 | RSS: Main: 148062208 17:42:45 INFO - PID 14102 | 17:42:47 INFO - PID 14102 | Cycle 1(1): loaded http://localhost:47665/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47665/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:42:48 INFO - PID 14102 | RSS: Main: 148127744 17:42:48 INFO - PID 14102 | 17:42:50 INFO - PID 14102 | Cycle 1(1): loaded http://localhost:47665/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47665/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:42:51 INFO - PID 14102 | RSS: Main: 148742144 17:42:51 INFO - PID 14102 | 17:42:53 INFO - PID 14102 | Cycle 1(1): loaded http://localhost:47665/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47665/tests/kraken/driver.html?testName=ai-astar) 17:42:53 INFO - PID 14102 | RSS: Main: 150331392 17:42:53 INFO - PID 14102 | 17:42:53 INFO - PID 14102 | __start_tp_report 17:42:53 INFO - PID 14102 | _x_x_mozilla_page_load 17:42:53 INFO - PID 14102 | _x_x_mozilla_page_load_details 17:42:53 INFO - PID 14102 | |i|pagename|runs| 17:42:53 INFO - PID 14102 | |0;ai-astar;106;105;106;107;106;105;107;105;107;105 17:42:53 INFO - PID 14102 | |1;audio-beat-detection;114;115;114;116;118;113;114;111;142;118 17:42:53 INFO - PID 14102 | |2;audio-dft;163;164;163;162;162;161;162;161;165;168 17:42:53 INFO - PID 14102 | |3;audio-fft;74;75;73;73;72;73;74;73;74;74 17:42:53 INFO - PID 14102 | |4;audio-oscillator;79;79;79;77;80;78;78;79;77;78 17:42:53 INFO - PID 14102 | |5;imaging-gaussian-blur;115;114;111;114;113;113;115;114;113;115 17:42:53 INFO - PID 14102 | |6;imaging-darkroom;149;151;150;149;150;148;150;150;151;150 17:42:53 INFO - PID 14102 | |7;imaging-desaturate;94;94;99;94;94;94;96;94;95;99 17:42:53 INFO - PID 14102 | |8;json-parse-financial;44;44;45;43;45;46;48;46;45;46 17:42:53 INFO - PID 14102 | |9;json-stringify-tinderbox;35;36;37;36;36;36;36;37;37;36 17:42:53 INFO - PID 14102 | |10;stanford-crypto-aes;76;72;72;76;75;72;71;70;71;73 17:42:53 INFO - PID 14102 | |11;stanford-crypto-ccm;108;103;106;111;105;107;109;106;109;103 17:42:53 INFO - PID 14102 | |12;stanford-crypto-pbkdf2;162;155;152;158;155;157;162;155;154;153 17:42:53 INFO - PID 14102 | |13;stanford-crypto-sha256-iterative;61;61;60;58;58;61;60;63;62;62 17:42:53 INFO - PID 14102 | __end_tp_report 17:42:53 INFO - PID 14102 | __start_cc_report 17:42:53 INFO - PID 14102 | _x_x_mozilla_cycle_collect,696 17:42:53 INFO - PID 14102 | __end_cc_report 17:42:53 INFO - PID 14102 | __startTimestamp1506472973354__endTimestamp 17:42:53 INFO - PID 14102 | 17:42:53 INFO - PID 14102 | ------- Summary: start ------- 17:42:53 INFO - PID 14102 | Number of tests: 14 17:42:53 INFO - PID 14102 | 17:42:53 INFO - PID 14102 | [#0] ai-astar Cycles:10 Average:105.90 Median:106.00 stddev:0.88 (0.8%) stddev-sans-first:0.93 17:42:53 INFO - PID 14102 | Values: 106.0 105.0 106.0 107.0 106.0 105.0 107.0 105.0 107.0 105.0 17:42:53 INFO - PID 14102 | 17:42:53 INFO - PID 14102 | [#1] audio-beat-detection Cycles:10 Average:117.50 Median:115.50 stddev:8.87 (7.7%) stddev-sans-first:9.32 17:42:53 INFO - PID 14102 | Values: 114.0 115.0 114.0 116.0 118.0 113.0 114.0 111.0 142.0 118.0 17:42:53 INFO - PID 14102 | 17:42:53 INFO - PID 14102 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:2.13 (1.3%) stddev-sans-first:2.26 17:42:53 INFO - PID 14102 | Values: 163.0 164.0 163.0 162.0 162.0 161.0 162.0 161.0 165.0 168.0 17:42:53 INFO - PID 14102 | 17:42:53 INFO - PID 14102 | [#3] audio-fft Cycles:10 Average:73.50 Median:74.00 stddev:0.85 (1.1%) stddev-sans-first:0.88 17:42:53 INFO - PID 14102 | Values: 74.0 75.0 73.0 73.0 72.0 73.0 74.0 73.0 74.0 74.0 17:42:53 INFO - PID 14102 | 17:42:53 INFO - PID 14102 | [#4] audio-oscillator Cycles:10 Average:78.40 Median:79.00 stddev:0.97 (1.2%) stddev-sans-first:1.00 17:42:53 INFO - PID 14102 | Values: 79.0 79.0 79.0 77.0 80.0 78.0 78.0 79.0 77.0 78.0 17:42:53 INFO - PID 14102 | 17:42:53 INFO - PID 14102 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:1.25 (1.1%) stddev-sans-first:1.24 17:42:53 INFO - PID 14102 | Values: 115.0 114.0 111.0 114.0 113.0 113.0 115.0 114.0 113.0 115.0 17:42:53 INFO - PID 14102 | 17:42:53 INFO - PID 14102 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:150.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 17:42:53 INFO - PID 14102 | Values: 149.0 151.0 150.0 149.0 150.0 148.0 150.0 150.0 151.0 150.0 17:42:53 INFO - PID 14102 | 17:42:53 INFO - PID 14102 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:94.50 stddev:2.06 (2.2%) stddev-sans-first:2.13 17:42:53 INFO - PID 14102 | Values: 94.0 94.0 99.0 94.0 94.0 94.0 96.0 94.0 95.0 99.0 17:42:53 INFO - PID 14102 | 17:42:53 INFO - PID 14102 | [#8] json-parse-financial Cycles:10 Average:45.20 Median:45.50 stddev:1.40 (3.1%) stddev-sans-first:1.41 17:42:53 INFO - PID 14102 | Values: 44.0 44.0 45.0 43.0 45.0 46.0 48.0 46.0 45.0 46.0 17:42:53 INFO - PID 14102 | 17:42:53 INFO - PID 14102 | [#9] json-stringify-tinderbox Cycles:10 Average:36.20 Median:36.00 stddev:0.63 (1.8%) stddev-sans-first:0.50 17:42:53 INFO - PID 14102 | Values: 35.0 36.0 37.0 36.0 36.0 36.0 36.0 37.0 37.0 36.0 17:42:53 INFO - PID 14102 | 17:42:53 INFO - PID 14102 | [#10] stanford-crypto-aes Cycles:10 Average:72.80 Median:72.50 stddev:2.15 (3.0%) stddev-sans-first:1.94 17:42:53 INFO - PID 14102 | Values: 76.0 72.0 72.0 76.0 75.0 72.0 71.0 70.0 71.0 73.0 17:42:53 INFO - PID 14102 | 17:42:53 INFO - PID 14102 | [#11] stanford-crypto-ccm Cycles:10 Average:106.70 Median:107.50 stddev:2.63 (2.4%) stddev-sans-first:2.74 17:42:53 INFO - PID 14102 | Values: 108.0 103.0 106.0 111.0 105.0 107.0 109.0 106.0 109.0 103.0 17:42:53 INFO - PID 14102 | 17:42:53 INFO - PID 14102 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.30 Median:156.00 stddev:3.47 (2.2%) stddev-sans-first:3.00 17:42:53 INFO - PID 14102 | Values: 162.0 155.0 152.0 158.0 155.0 157.0 162.0 155.0 154.0 153.0 17:42:53 INFO - PID 14102 | 17:42:53 INFO - PID 14102 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.60 Median:61.00 stddev:1.65 (2.7%) stddev-sans-first:1.74 17:42:53 INFO - PID 14102 | Values: 61.0 61.0 60.0 58.0 58.0 61.0 60.0 63.0 62.0 62.0 17:42:53 INFO - PID 14102 | -------- Summary: end -------- 17:42:53 INFO - PID 14102 | 17:42:53 INFO - PID 14102 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:42:53 INFO - TEST-INFO | 14102: exit 0 17:42:53 INFO - TEST-OK | kraken | took 58710ms 17:42:53 INFO - SUITE-END | took 1167s 17:42:54 INFO - Completed test suite (00:19:27) 17:42:54 INFO - javascript benchmark 17:42:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9119.163639820503, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3894.5910679378662, 3906.140649057207, 3918.0596656802377, 3936.724429289951, 3937.4684417603635, 6296.464800491964, 6319.6524191169465, 6369.0, 6458.321876203002, 6464.09502669626, 6344.587601805891, 6357.65032923189, 6361.936380636193, 6400.551961362707, 6415.390537898892, 5637.971810140964, 5672.205891175218, 5677.602567820254, 5720.141978703186, 5722.227499287585, 5745.253117094772, 5769.105788602773, 5769.682667453289, 5774.7401366938375, 5793.13103034544, 5758.222639943596, 5798.7100644967795, 5821.09772985188, 5829.09649004405, 5879.176915231871, 5748.913766293488, 5764.077747560412, 5779.422057794229, 5840.153177789197, 5852.707364631773, 5571.777128914839, 5607.663540187602, 5632.324121105453, 5677.347105082927, 5729.828105156852, 6170.167027451282, 6334.398232167937, 6351.301356850743, 6407.0, 6426.485881129498, 6888.173419189679, 6905.37851593354, 6978.651067446658, 6985.755498557526, 6985.79042628722, 6886.380225779654, 6916.23921368649, 6970.686319115652, 7045.788626341218, 7047.013418121467, 6469.126667899774, 6502.252240992252, 6550.967245163792, 6552.377524135247, 6557.442617377528, 7130.643467826588, 7139.785806425815, 7207.0270513481055, 7215.134183897966, 7221.31397517235, 6835.58986460814, 6847.589144651337, 6876.828079298058, 6884.483663725241, 6905.378515933489, 6923.307669233036, 6944.583325000516, 7008.369246767714, 7018.508704390746, 7024.824379390556, 6861.039454476378, 6862.176538815374, 6869.484788640872, 6948.687309071104, 6967.442604591621, 6760.391564759196, 6860.485463590251, 6886.48351373649, 6898.172219333712, 6903.344182302673, 5050.040492306523, 5081.923771143436, 5117.8464646060675, 5126.077306084866, 5137.280780690707, 4494.213512635276, 4591.311303304531, 4626.282926146453, 4628.83799067031, 4632.420947381577, 6235.594686345464, 6247.750449910036, 6248.718807653667, 6321.525885558602, 6322.810315690536, 6842.897356539655, 6851.109355783816, 6852.383285504328, 6859.211190713132, 6860.5197636165985, 6307.432331090224, 6371.872562548723, 6415.26224484181, 6416.069669897839, 6417.294097649255, 5527.281453411031, 5658.603897727119, 5670.234518340054, 5685.033544297479, 5688.11834165705, 7104.502684812013, 7186.532875363085, 7199.3520583147765, 7213.819654508679, 7216.0258365120035, 6865.759698410531, 6878.69045892946, 6881.277465866212, 6882.724691012303, 6888.41448476865, 7104.928950710427, 7156.212816590067, 7162.462815288978, 7192.42460603161, 7198.640067996684, 6903.309669033258, 6917.654117294014, 6920.688569014507, 6931.029655848084, 6954.826129346807, 6880.827979300558, 6900.654967251517, 6917.7232910685025, 6997.510174287954, 7018.824529386806, 6583.210014798255, 6711.328867113445, 6712.228093769084, 6715.160604924385, 6794.592324460548, 6762.120924279812, 6787.66061696923, 6787.966060169668, 6790.7623233186605, 6801.0138529913875, 6588.04473351371, 6607.141071660653, 6694.995750637443, 6697.665116744241, 6703.966480167568, 6722.294159113419, 6770.627615481196, 6816.829579260559, 6843.213030501556, 6873.828154296182, 6491.902621460587, 6544.345565443417, 6568.620589676221, 6615.569987950767, 6623.933760662524], "value": 6325.425291488583, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [958.7603099225194, 988.0317289056724, 988.9604415823368, 990.4651488196374, 992.9106380425765, 43465.13069738607, 44255.114897702064, 44368.77815610921, 44370.55629443705, 44477.555224447744, 40563.797181014124, 40707.18585628286, 40755.18489630205, 40813.0, 40825.387619185734, 7500.399968002574, 7603.859421086853, 7609.0869095708595, 7625.389968802482, 7625.542467451943, 7519.473636845423, 7582.052243469567, 7592.164861865191, 7593.696252149907, 7612.505187162817, 7579.583122928237, 7616.543007419545, 8489.23596876281, 8660.393772435931, 8695.21743043126, 8570.0, 8648.43785153963, 8649.870251946226, 8652.22130008299, 8654.09132041133, 8181.918180818175, 8386.916130838674, 8395.244428001448, 8506.106858779802, 8588.527630980294, 41469.1706165878, 41814.58185418137, 41819.58180418187, 41861.0, 41901.0, 3678.2091850252323, 3708.647678470541, 3728.7949162796035, 3731.8320675569394, 3739.8504059837846, 33442.49836252458, 33457.16357091068, 33534.6646533534, 33547.83226083878, 33634.1591460213, 5489.0, 5499.065158922993, 5524.502794748451, 5526.47498487643, 5533.557315414757, 219220.0, 220303.0, 220944.0, 220971.0, 222155.99999999837, 46080.769596151804, 46340.768296158305, 46849.76575117103, 52407.73796130995, 53137.468625314024, 55591.722041389534, 55791.44208557944, 55792.0, 55866.72066639641, 55961.72019139878, 16153.757693634605, 16229.513114606581, 16276.593085172728, 16284.267207975432, 16292.51122466328, 12434.502619895104, 12442.253464792142, 12476.875231247754, 12613.243205407705, 12615.432305546272, 14707.338169782386, 14757.0, 14758.0, 14857.554273371816, 15027.09837409759, 5696.8860622787315, 5762.2509073820975, 5780.32370612526, 5839.503642190376, 6014.48876845473, 1072.1904961753983, 1087.9401632910267, 1096.4408151842617, 1103.6523495099018, 1111.5553778488509, 25602.0, 25650.35874103125, 25782.226533204033, 25818.22545323643, 26071.348216294744, 1174.8413964114907, 1178.5698220149584, 1189.4469071881617, 1191.5889018288676, 1195.9043276537857, 13470.0, 13545.187288762509, 13600.795988060187, 13787.931060344834, 13818.37817298224, 283582.0, 284449.0, 284669.0, 284734.0, 284809.0, 60429.697851510464, 60564.39435605588, 60657.69671151616, 60839.39160608426, 61265.387346125965, 1483.2064845307925, 1497.7229212595923, 1520.7414739494313, 1537.1622465755966, 1541.306412114553, 25208.361456505267, 25417.74582254154, 25448.745512545378, 25488.617670735326, 25640.0, 42691.0, 42707.786461067495, 42711.3593296107, 42733.0, 42762.14475710531, 247575.0, 248024.0, 248116.0, 248142.0, 248431.0, 33015.17462063468, 33408.83295583507, 36329.091772704836, 36498.45252321164, 36905.44641830321, 47948.0, 48399.75800121118, 48481.27278090902, 48491.75754121207, 49142.508574913794, 35517.0, 35519.934401967985, 35701.64298357087, 35750.28499430049, 36131.81934090313, 35128.82435587806, 35289.64710352864, 35896.64103359037, 36012.45981310335, 36072.45891311685, 41269.0, 41341.793291033355, 41709.37435938524, 41742.95642608959, 41854.0, 33494.83252583721, 33893.49159762655, 34123.488147678305, 34293.65706342905, 34375.656243437246, 26274.029447791876, 26393.604095938193, 26495.735042650096, 26964.191074267805, 27390.0], "value": 18586.92111734352, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.8289504596144, 608.5283904973642, 618.2025187508118, 633.2717375018727, 642.431448168371, 23460.64809027866, 23784.28647140584, 24299.392515187108, 24359.878200609015, 24363.39091522713, 22420.215292464767, 22971.310860674206, 23098.076076956942, 23143.421414464647, 23167.0, 6602.537822352438, 6687.899681504781, 6708.496862735315, 6719.092922455479, 6727.058211850321, 6540.836479088013, 6544.083828264047, 6859.451243900501, 6901.309869013109, 6903.896441553381, 6849.657517124148, 6851.554648947827, 6853.417459515922, 6853.862922741542, 6854.0404343391965, 6549.869002619945, 6780.08468856703, 6792.150981127359, 6802.4898132639755, 6845.075914751519, 6276.309605943343, 6281.59169653971, 6338.556301058928, 6342.207224096988, 6348.746050157988, 30649.0, 30900.53649195264, 31001.689983100106, 31012.844935775178, 31367.529487057713, 2120.5546835164632, 2142.9464263393384, 2144.1101942693763, 2145.785421457842, 2151.698762173297, 19580.314688985818, 20919.5816083679, 20966.16135354599, 20970.0, 21022.894885525475, 2553.3616595851036, 2563.154159127502, 2596.4287856671504, 2629.1323863125313, 2629.500394924958, 126405.36797315955, 131738.3413082938, 150605.0, 154806.0, 161641.0, 15615.60960975962, 16171.595710107342, 16228.51314460568, 16396.672066558604, 16883.915580422265, 25636.05185403665, 25656.61515077275, 25710.10014649516, 25743.871280643853, 25798.226053218434, 10137.746556336004, 10303.124234440007, 10334.948325258476, 10359.482025898675, 10449.425281609432, 9259.166674999282, 9288.7677808054, 9319.627214911463, 9390.577424015935, 9482.525873706287, 9590.184834289164, 9686.515674216262, 9902.356346837432, 9931.453770042717, 10033.448160351105, 2751.6422865027816, 2795.5107856125096, 2925.546540286259, 2950.1002194330504, 3012.774041946863, 1028.881678606955, 1036.388530766851, 1041.2398948767443, 1056.7410984308895, 1062.5909025025421, 20972.056257468146, 21309.25417610376, 21343.0, 21429.571408572054, 21825.890870545863, 1076.983845242322, 1094.4746521669642, 1110.1673744691482, 1111.5053801058614, 1113.4599719136213, 11596.362200079077, 11710.765784684429, 11713.648590542298, 11849.348285844362, 11864.347460889734, 513977.0, 553343.0, 554997.0, 566110.0, 577978.0, 130974.0, 133414.0, 133490.0, 134785.0, 134884.0, 1193.7254431480808, 1213.9605462822367, 1230.7415442757122, 1232.6548566401423, 1236.1779416687802, 18484.907575462035, 18891.149898254338, 19047.238110475424, 19155.71266430977, 19309.0, 59523.40476595179, 59991.40008599858, 60058.0, 60256.39743602508, 61840.38159618346, 75485.0, 75738.0, 76365.0, 76959.0, 77121.0, 15577.84422155764, 15603.375864965728, 15739.527814165593, 15763.97534160276, 15812.60468488251, 23741.64387534154, 23849.046038158278, 23912.56524608529, 24453.144139955017, 24525.877370613034, 19418.90290548538, 19455.221791128195, 19579.118939647466, 19662.21351145938, 19725.40823775289, 17516.299348026445, 17553.0, 17626.823731762517, 18137.546561336072, 18249.543761406072, 19628.411147665593, 20196.394108176777, 20279.59440811146, 20466.69299960472, 20513.89743051335, 15331.386744530093, 15422.537323880302, 15439.305231264396, 15502.922485387951, 15541.378344866078, 19280.807191927903, 19284.0, 19316.0, 19456.319028833925, 19663.8033619662], "value": 12659.156546912156, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1429.5782744090493, 1473.9778903316453, 1493.0220705437941, 1496.887733419993, 1504.9247537623123, 16693.74959375609, 17367.218475168615, 17375.913120434398, 17381.044042577654, 17383.999999999985, 16844.57888552787, 16856.494305170865, 16873.493795186132, 16965.406210782625, 16967.57581060474, 2816.155153453961, 2853.7574306183897, 2854.9714502855018, 2856.2002639260936, 2862.384587313727, 2779.986100069497, 2862.484752744505, 2863.584780206869, 2864.4987127252753, 2865.4698880707138, 2734.1387462949206, 2760.558310670293, 2769.4322663853864, 2773.5839624056453, 2774.389634280455, 2650.60240963856, 2688.6908005579216, 2700.203439985209, 2708.9322766930786, 2711.7830573554165, 2641.2076377086796, 2651.3106592286144, 2660.068975858434, 2666.640003599528, 2669.7597216250438, 15779.28993195309, 15932.920335398365, 15935.760963585555, 15944.521664350088, 15993.680126397523, 8113.959430202811, 8396.160383961555, 8458.66165353385, 8467.32261419085, 8471.364647651451, 4956.207006878918, 5217.2695822584865, 5385.730713464351, 5395.136778115522, 5527.668339899619, 1974.1511150205406, 2012.9396118116333, 2026.6656001759693, 2085.0304608357187, 2104.7263855698816, 27395.0, 27533.449331013268, 27890.35041671038, 30437.695623043706, 31330.373392532023, 7248.963755181296, 7497.775066748006, 7561.09266887977, 7641.3886889048745, 7708.38332933364, 22981.88509057444, 23091.19180828663, 23116.0, 23117.768822311897, 23153.189638362575, 8428.915710842935, 8453.323734101381, 8456.196661317164, 8456.915430845613, 8469.703560375357, 7487.251274872469, 7600.543967361976, 7617.390608751287, 7621.3902887768845, 7625.0, 5994.790182343597, 6215.122767857208, 6246.219222597176, 6291.716872740646, 6377.17096777416, 1818.7453756474104, 1835.8072402397822, 1839.2802729448008, 1850.5743678953647, 1871.6350311689089, 994.572333896417, 1004.7940172264668, 1006.1699098243978, 1022.9795404092025, 1026.58423338548, 9724.367916085432, 9794.167495762798, 9989.001099889952, 10020.799584008279, 10029.097381235724, 792.3542313014874, 797.8165022044847, 800.8198155415101, 803.0804728585737, 812.1269635142246, 4827.396575428072, 4882.926756098661, 4946.258061290835, 4962.454130045692, 4984.775685094107, 24274.75725242725, 25067.87466062658, 25181.62227566588, 25332.74667253341, 25338.873305633355, 23618.64572031421, 24697.382565436008, 24714.629280560806, 24753.752462475506, 24770.380740481272, 11366.715832104099, 11691.415429228504, 11982.52069917211, 12690.175138615961, 13060.08579399452, 10023.69928902134, 10112.0, 10219.13137383301, 10343.793124137324, 10459.68620941373, 20739.8963005184, 21796.564068718853, 21849.563008740053, 21860.781392185876, 21943.890280548494, 21620.67568986498, 21928.0, 22156.446088847908, 22203.22288719887, 22291.331260062223, 12948.223106613634, 13000.479980800663, 13254.734905302033, 13259.535916242885, 13336.333183340988, 14993.100413975197, 15300.846991530387, 15306.387744490095, 15318.080915145127, 15319.387224510894, 12130.33283169434, 12151.0, 12215.511379544718, 12262.570810021964, 12442.253464792142, 12038.75922481563, 12126.48651802327, 12201.08491863096, 12249.755004900031, 12371.628851134481, 10455.58177672915, 10483.52824122901, 10598.364098153826, 10600.0, 10616.0, 8315.501069935823, 8334.333253339597, 8361.163883611833, 8406.621702023302, 8409.117042710428, 8070.636821342936, 8085.514869107872, 8176.67293308261, 8179.591020448835, 8239.794005149919], "value": 7290.759268776947, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.4865377891002, 563.2621266141358, 569.208799768322, 582.5688990147291, 585.2771826793909, 6163.691815409228, 6181.474574661148, 6201.751929922803, 6231.252249730039, 6254.4371006609335, 6108.755649774015, 6169.5989760665525, 6196.752129914798, 6204.813855584329, 6247.437730604244, 5023.974880125595, 5052.26742122392, 5062.898742025157, 5064.544191022807, 5076.111680455924, 4804.0, 4909.0, 4972.552470277675, 4978.352814134158, 5073.7463126843695, 4909.68087074339, 4945.455999840033, 4949.579285760715, 4958.950410495903, 4972.985940694025, 4884.169691152512, 4906.460289368167, 4925.0, 4934.40787105546, 4951.331570238008, 4311.1808756336195, 4408.206522825923, 4429.756363400012, 4447.844325448594, 4478.305862591304, 5937.465628093492, 5994.912620000703, 6020.488258498033, 6121.0, 6121.143039974407, 5794.377574279209, 5797.188393624896, 5818.5345172386105, 5836.854078648025, 5851.473367396955, 6544.0, 6581.835454113638, 6625.271220165826, 6669.466442684574, 6683.421856028636, 4815.5906747926465, 5000.3249561309485, 5024.974875125601, 5055.266986286968, 5073.868975030496, 6821.1814582250445, 6828.385445309897, 6957.538916827421, 6964.512484126113, 6970.2681218471835, 5159.606906135397, 5193.37679478465, 5214.0447332250405, 5224.294720212799, 5225.947740522623, 5222.694326418396, 5247.790088396498, 5254.264402983586, 5263.526282634504, 5276.234945932818, 5814.825555233349, 5820.650760954271, 5854.302252346772, 5868.501177399969, 5887.322957859816, 6559.212894452697, 6669.666516674244, 6684.197896252481, 6705.2624211336715, 6733.787918174776, 1769.4780039888265, 1804.124999375302, 1806.151108978778, 1812.5196822841958, 1826.9451916442529, 1211.5577814097792, 1270.142653708743, 1278.1947373154853, 1286.852012018611, 1305.7323248733987, 6120.540959428061, 6136.693165341715, 6151.231096112986, 6171.814845554551, 6208.2373343862455, 6492.383223593751, 6548.607083575001, 6589.967050164719, 6662.233843108104, 6683.298253683391, 5758.481736643722, 5911.231539899785, 6026.668533230714, 6082.209312789398, 6086.60437071589, 3420.81185534793, 3456.637053109387, 3473.4616134498688, 3485.7385696072897, 3543.2204914918675, 6815.863682726318, 6846.884667476286, 6848.246692863781, 6859.519833611599, 6922.273161317989, 6826.283240259701, 6843.22076260166, 6864.828379290558, 6924.79225623222, 6932.584044957319, 6878.55289406187, 6929.618870962045, 6937.167539895245, 7056.6118863463, 7068.893966590403, 6676.732930682719, 6708.865822683617, 6709.36261055199, 6720.899186512304, 6756.69594868242, 6593.868122637617, 6620.742059008773, 6674.8998765017595, 6729.394354508117, 6784.728610855708, 6905.792826215222, 6935.6475487279495, 7008.404285635778, 7039.753608623673, 7058.929410705828, 5073.923891141562, 5118.641695081308, 5119.283300337881, 5147.742612869267, 5192.844214673566, 6570.901436478361, 6748.0, 6752.535324606385, 6813.058278390635, 6823.078884350748, 6393.87212255743, 6531.052997315268, 6540.444062254572, 6557.9344206557325, 6614.140161778938, 6426.903596445964, 6434.485241180788, 6514.3811337922825, 6540.345965403421, 6628.668566571749, 6358.523110766619, 6371.299157092809, 6402.7194561087035, 6414.775482858265, 6431.807045788634, 6529.151210342625, 6602.854072426577, 6639.867202656016, 6640.335966403514, 6675.198976122896, 6359.904601431075, 6375.840603984752, 6444.871102577828, 6451.290358060516, 6505.316941721051], "value": 5142.699257558977, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [975.3952549419357, 982.3860087445347, 994.1698681600863, 1007.043308856586, 1010.9292349535526, 17499.562510937216, 18937.0, 19055.14251858666, 19059.142338594746, 19062.2375104996, 19430.417087487396, 19599.412017639457, 19713.408597742055, 19733.210671573157, 19737.11182996765, 1038.2732087538716, 1043.838205078214, 1047.8323468245082, 1048.5229220704562, 1048.847917052027, 1063.3672964586096, 1063.415121683075, 1063.5320458998056, 1063.7766069125494, 1081.8918108189198, 1080.1304949515636, 1111.6720567432626, 1126.1947707389256, 1126.4818183635537, 1134.7446824464512, 1112.9944350278238, 1115.5259014918627, 1115.6206889657556, 1115.7266469714891, 1116.3748300951452, 788.9132195458495, 816.0248503038871, 821.9342452603777, 822.8724547695117, 823.9876401853977, 18494.0, 18510.722339164924, 18516.90741546297, 18523.166457509444, 18574.349897753513, 23150.53698926029, 23466.0, 24122.39694007646, 24301.27096187117, 24312.39219019521, 18558.072096395128, 18700.438986830417, 18740.0629968501, 18769.436916892515, 18807.435776926715, 3922.0587059105897, 3948.4077388391684, 3966.226585815767, 3967.3255546557157, 3967.861124860616, 130472.34763826214, 158075.0, 161724.0, 162323.0, 162472.0, 17853.910730446525, 17899.0, 18167.45497635073, 18188.454346369632, 18347.724784127982, 31797.04608861738, 31810.681893180772, 32044.519332210035, 32380.514292285636, 32512.02463926086, 10016.79966400668, 10113.494325283853, 10114.190864730805, 10117.241206909512, 10154.543045562967, 4533.002739397393, 4559.566841150086, 4635.675502714845, 4650.0, 4662.95337046632, 6323.399277068671, 6413.134226879405, 6424.903626445607, 6433.774817881352, 6464.6121232725245, 1237.7276999060193, 1246.5886257534992, 1251.7934540800848, 1255.554278231233, 1261.3251910227984, 694.3473135252846, 751.305042835375, 758.1849511774864, 771.8957940677936, 777.1645481107719, 13456.932715336361, 13781.310934453237, 13915.30423478822, 13950.162990220619, 13976.0, 736.1571001203592, 737.7307282841831, 744.2037020388241, 748.6855520681327, 757.8105473631592, 6528.445082167974, 6590.308017658077, 6617.2059352877, 6644.8671026579195, 6661.800145995628, 151265.24367378312, 151621.24189379203, 154433.0, 155809.22095389676, 160578.0, 130491.0, 130921.0, 131261.0, 131794.0, 139246.30376848252, 108504.0, 115322.42338788252, 115684.0, 115816.0, 118526.0, 13696.452141914611, 14080.78878816798, 14232.573022809333, 14369.712605748036, 14485.710285794436, 56115.0, 56499.0, 56933.43066569281, 58358.416415837, 59159.0, 73531.0, 74351.0, 75068.62465687636, 75406.24593753992, 76555.0, 19720.309789157884, 20375.286864959657, 20539.486512836702, 20728.792712072685, 20869.895650521652, 21115.155393784076, 21619.35141945744, 21951.560968780854, 22445.43886402853, 22537.5492490146, 21122.894385527972, 21258.25596104191, 21388.251411200534, 21452.0, 21477.0, 19799.40601781949, 19868.60262794707, 20088.0, 20120.19519219215, 20414.693779593614, 19422.320218792276, 19640.116194770984, 19647.60704785925, 19942.50143746418, 20256.493587660425, 15025.0, 15132.394704211709, 15228.543143705707, 15312.693746125238, 15371.61570960735, 14599.343029563483, 15096.16971066602, 15335.539933802003, 15358.001729887968, 15372.769408459106], "value": 10304.750250977246, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1375.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 106.0, 107.0, 106.0, 105.0, 107.0, 105.0, 107.0, 105.0], "value": 105.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 116.0, 118.0, 113.0, 114.0, 111.0, 142.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 162.0, 162.0, 161.0, 162.0, 161.0, 165.0, 168.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 73.0, 73.0, 72.0, 73.0, 74.0, 73.0, 74.0, 74.0], "value": 73.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 77.0, 80.0, 78.0, 78.0, 79.0, 77.0, 78.0], "value": 78.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 111.0, 114.0, 113.0, 113.0, 115.0, 114.0, 113.0, 115.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 150.0, 149.0, 150.0, 148.0, 150.0, 150.0, 151.0, 150.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 99.0, 94.0, 94.0, 94.0, 96.0, 94.0, 95.0, 99.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 44.0, 45.0, 43.0, 45.0, 46.0, 48.0, 46.0, 45.0, 46.0], "value": 45.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [35.0, 36.0, 37.0, 36.0, 36.0, 36.0, 36.0, 37.0, 37.0, 36.0], "value": 36.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 72.0, 72.0, 76.0, 75.0, 72.0, 71.0, 70.0, 71.0, 73.0], "value": 72.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 103.0, 106.0, 111.0, 105.0, 107.0, 109.0, 106.0, 109.0, 103.0], "value": 106.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 155.0, 152.0, 158.0, 155.0, 157.0, 162.0, 155.0, 154.0, 153.0], "value": 156.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 58.0, 58.0, 61.0, 60.0, 63.0, 62.0, 62.0], "value": 60.6, "unit": "score"}]}]} 17:42:54 INFO - Return code: 0 17:42:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:42:54 INFO - # TBPL SUCCESS # 17:42:54 INFO - Running post-action listener: _package_coverage_data 17:42:54 INFO - Running post-action listener: _resource_record_post_action 17:42:54 INFO - [mozharness: 2017-09-27 00:42:54.127893Z] Finished run-tests step (success) 17:42:54 INFO - Running post-run listener: _resource_record_post_run 17:42:54 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 336510976; Read time: 0; Write time: 237816 17:42:54 INFO - TinderboxPrint: CPU usage
13.1% 17:42:54 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:42:54 INFO - TinderboxPrint: I/O write bytes / time
336,510,976 / 237,816 17:42:54 INFO - TinderboxPrint: CPU idle
8,219.3 (86.9%) 17:42:54 INFO - TinderboxPrint: CPU user
1,188.4 (12.6%) 17:42:54 INFO - TinderboxPrint: Swap in / out
0 / 0 17:42:54 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12070912; Read time: 0; Write time: 2580 17:42:54 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:42:54 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 0; Write bytes: 323403776; Read time: 0; Write time: 235196 17:42:54 INFO - Running post-run listener: _upload_blobber_files 17:42:54 INFO - Blob upload gear active. 17:42:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:42:54 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:42:54 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:42:54 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:42:55 INFO - (blobuploader) - INFO - Open directory for files ... 17:42:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:42:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:42:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:42:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:42:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:42:56 INFO - (blobuploader) - INFO - Done attempting. 17:42:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:42:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:42:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:43:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:43:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:43:03 INFO - (blobuploader) - INFO - Done attempting. 17:43:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:43:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:43:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:43:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:43:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:43:04 INFO - (blobuploader) - INFO - Done attempting. 17:43:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:43:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:43:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:43:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:43:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:43:05 INFO - (blobuploader) - INFO - Done attempting. 17:43:05 INFO - (blobuploader) - INFO - Iteration through files over. 17:43:05 INFO - Return code: 0 17:43:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:43:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:43:05 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6d9faf10c021ee1c52ef87f6efa3cbc06be1cf593c0c3992cb697499a7e4cd0577186e2fa2a2bbcd821c5ba43cde9225db237e6a56636a2e4a58ef10edfffb6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/840af7084718c33f2d233e68fac72cd1f5c060e2dcdd2e0ab987bd8f99bf1a2596ade0b09dd70af62c7112089b8a2c87665ec422873a0b39d3cd0158da03607d", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18c36f3ebc0bdd9c88192f2b1d6fd110f24a15a4333845d41a8a1f2cbb8181a5369e096ac597bca41ff513304ce07c6ed722293a4150a4a6c44793ce64586758", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/126bf0c978656e35a3a7b440bde8acb0dfa5580f9a4625649285db949342f775478a560c61472576d508b92ee9b346368fc09bff6fc41f63be4f17fa0ccbc559"} 17:43:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:43:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:43:05 INFO - Contents: 17:43:05 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6d9faf10c021ee1c52ef87f6efa3cbc06be1cf593c0c3992cb697499a7e4cd0577186e2fa2a2bbcd821c5ba43cde9225db237e6a56636a2e4a58ef10edfffb6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/840af7084718c33f2d233e68fac72cd1f5c060e2dcdd2e0ab987bd8f99bf1a2596ade0b09dd70af62c7112089b8a2c87665ec422873a0b39d3cd0158da03607d", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18c36f3ebc0bdd9c88192f2b1d6fd110f24a15a4333845d41a8a1f2cbb8181a5369e096ac597bca41ff513304ce07c6ed722293a4150a4a6c44793ce64586758", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/126bf0c978656e35a3a7b440bde8acb0dfa5580f9a4625649285db949342f775478a560c61472576d508b92ee9b346368fc09bff6fc41f63be4f17fa0ccbc559"} 17:43:05 INFO - Running post-run listener: copy_logs_to_upload_dir 17:43:05 INFO - Copying logs to upload dir... 17:43:05 INFO - mkdir: /builds/slave/test/build/upload/logs 17:43:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.739478 ========= master_lag: -0.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-26 17:43:05.432395) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 17:43:05.439451) ========= 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=20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326 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/c6d9faf10c021ee1c52ef87f6efa3cbc06be1cf593c0c3992cb697499a7e4cd0577186e2fa2a2bbcd821c5ba43cde9225db237e6a56636a2e4a58ef10edfffb6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/840af7084718c33f2d233e68fac72cd1f5c060e2dcdd2e0ab987bd8f99bf1a2596ade0b09dd70af62c7112089b8a2c87665ec422873a0b39d3cd0158da03607d", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18c36f3ebc0bdd9c88192f2b1d6fd110f24a15a4333845d41a8a1f2cbb8181a5369e096ac597bca41ff513304ce07c6ed722293a4150a4a6c44793ce64586758", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/126bf0c978656e35a3a7b440bde8acb0dfa5580f9a4625649285db949342f775478a560c61472576d508b92ee9b346368fc09bff6fc41f63be4f17fa0ccbc559"} build_url:https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011245 build_url: 'https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6d9faf10c021ee1c52ef87f6efa3cbc06be1cf593c0c3992cb697499a7e4cd0577186e2fa2a2bbcd821c5ba43cde9225db237e6a56636a2e4a58ef10edfffb6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/840af7084718c33f2d233e68fac72cd1f5c060e2dcdd2e0ab987bd8f99bf1a2596ade0b09dd70af62c7112089b8a2c87665ec422873a0b39d3cd0158da03607d", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18c36f3ebc0bdd9c88192f2b1d6fd110f24a15a4333845d41a8a1f2cbb8181a5369e096ac597bca41ff513304ce07c6ed722293a4150a4a6c44793ce64586758", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/126bf0c978656e35a3a7b440bde8acb0dfa5580f9a4625649285db949342f775478a560c61472576d508b92ee9b346368fc09bff6fc41f63be4f17fa0ccbc559"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 17:43:05.470122) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 17:43:05.470429) ========= 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=20e666a3d4cfbb71505a330e000001b4-1506471291.107266-1661513326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004594 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 17:43:05.550626) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 17:43:05.550928) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 17:43:05.554234) ========= ========= Total master_lag: 0.06 =========