builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1505622822.41 results: success (0) revision: 015f852e93fe8887e666ee5a1ff246d3d4e8063b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 21:33:42.415012) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 21:33:42.415442) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 21:33:42.415710) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 21:33:42.458729) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 21:33:42.459004) ========= 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=ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-16 21:33:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2017-09-16 21:33:42 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.195162 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 21:33:42.716234) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 21:33:42.716545) ========= 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=ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016659 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 21:33:42.825773) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-16 21:33:42.826083) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 015f852e93fe8887e666ee5a1ff246d3d4e8063b --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 015f852e93fe8887e666ee5a1ff246d3d4e8063b --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=ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-16 21:33:42,927 truncating revision to first 12 chars 2017-09-16 21:33:42,927 Setting DEBUG logging. 2017-09-16 21:33:42,927 attempt 1/10 2017-09-16 21:33:42,927 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/015f852e93fe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-16 21:33:43,761 unpacking tar archive at: mozilla-central-015f852e93fe/testing/mozharness/ program finished with exit code 0 elapsedTime=1.190318 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-16 21:33:44.057244) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 21:33:44.060602) ========= script_repo_revision: 015f852e93fe8887e666ee5a1ff246d3d4e8063b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 21:33:44.060985) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 21:33:44.061240) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 21:33:44.074811) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-09-16 21:33:44.075163) ========= /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=ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:33:44 INFO - MultiFileLogger online at 20170916 21:33:44 in /builds/slave/test 21:33:44 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 21:33:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:33:44 INFO - {'append_to_log': False, 21:33:44 INFO - 'base_work_dir': '/builds/slave/test', 21:33:44 INFO - 'blob_upload_branch': 'Firefox', 21:33:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:33:44 INFO - 'branch': 'Firefox', 21:33:44 INFO - 'buildbot_json_path': 'buildprops.json', 21:33:44 INFO - 'code_coverage': False, 21:33:44 INFO - 'config_files': ('talos/linux_config.py',), 21:33:44 INFO - 'default_actions': ('clobber', 21:33:44 INFO - 'read-buildbot-config', 21:33:44 INFO - 'download-and-extract', 21:33:44 INFO - 'populate-webroot', 21:33:44 INFO - 'create-virtualenv', 21:33:44 INFO - 'install', 21:33:44 INFO - 'setup-mitmproxy', 21:33:44 INFO - 'run-tests'), 21:33:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:33:44 INFO - 'disable_ccov_upload': False, 21:33:44 INFO - 'disable_stylo': False, 21:33:44 INFO - 'download_minidump_stackwalk': True, 21:33:44 INFO - 'download_symbols': 'ondemand', 21:33:44 INFO - 'enable_stylo': False, 21:33:44 INFO - 'enable_webrender': False, 21:33:44 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 21:33:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:33:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:33:44 INFO - 'gecko_profile': False, 21:33:44 INFO - 'gecko_profile_interval': 0, 21:33:44 INFO - 'installer_path': 'installer.exe', 21:33:44 INFO - 'log_level': 'info', 21:33:44 INFO - 'log_name': 'talos', 21:33:44 INFO - 'log_to_console': True, 21:33:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:33:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:33:44 INFO - 'opt_config_files': (), 21:33:44 INFO - 'pip_index': False, 21:33:44 INFO - 'suite': 'dromaeojs-e10s', 21:33:44 INFO - 'system_bits': '32', 21:33:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:33:44 INFO - 'title': 'talos-linux64-ix-050', 21:33:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:33:44 INFO - 'use_talos_json': True, 21:33:44 INFO - 'verify': 'False', 21:33:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:33:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:33:44 INFO - 'work_dir': 'build'} 21:33:44 INFO - [mozharness: 2017-09-17 04:33:44.291859Z] Running clobber step. 21:33:44 INFO - Running pre-action listener: _resource_record_pre_action 21:33:44 INFO - Running main action method: clobber 21:33:44 INFO - rmtree: /builds/slave/test/build 21:33:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:33:45 INFO - Running post-action listener: _resource_record_post_action 21:33:45 INFO - [mozharness: 2017-09-17 04:33:45.800296Z] Finished clobber step (success) 21:33:45 INFO - [mozharness: 2017-09-17 04:33:45.800393Z] Running read-buildbot-config step. 21:33:45 INFO - Running pre-action listener: _resource_record_pre_action 21:33:45 INFO - Running main action method: read_buildbot_config 21:33:45 INFO - Using buildbot properties: 21:33:45 INFO - { 21:33:45 INFO - "project": "", 21:33:45 INFO - "product": "firefox", 21:33:45 INFO - "who": "ryanvm@gmail.com", 21:33:45 INFO - "installer_path": "public/build/target.tar.bz2", 21:33:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 21:33:45 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 21:33:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 21:33:45 INFO - "stage_platform": "linux64-pgo", 21:33:45 INFO - "basedir": "/builds/slave/test", 21:33:45 INFO - "buildnumber": 170, 21:33:45 INFO - "platform": "ubuntu64_hw", 21:33:45 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:33:45 INFO - "slavebuilddir": "test", 21:33:45 INFO - "taskId": "eEQYR2zeQjmdKPQj0joA1Q", 21:33:45 INFO - "branch": "mozilla-central", 21:33:45 INFO - "script_repo_revision": "production", 21:33:45 INFO - "revision": "015f852e93fe8887e666ee5a1ff246d3d4e8063b", 21:33:45 INFO - "slavename": "talos-linux64-ix-050", 21:33:45 INFO - "repo_path": "mozilla-central" 21:33:45 INFO - } 21:33:45 INFO - Finding installer, test and symbols from parent task. 21:33:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eEQYR2zeQjmdKPQj0joA1Q'}, attempt #1 21:33:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eEQYR2zeQjmdKPQj0joA1Q'}, attempt #1 21:33:46 INFO - Task dependencies: cFWRlOVRSYCqONchm7xKJw 21:33:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cFWRlOVRSYCqONchm7xKJw'}, attempt #1 21:33:47 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/cFWRlOVRSYCqONchm7xKJw/artifacts/public/build/target.tar.bz2 21:33:47 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/cFWRlOVRSYCqONchm7xKJw/artifacts/public/build/target.test_packages.json 21:33:47 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/cFWRlOVRSYCqONchm7xKJw/artifacts/public/build/target.crashreporter-symbols.zip 21:33:47 INFO - Running post-action listener: _resource_record_post_action 21:33:47 INFO - [mozharness: 2017-09-17 04:33:47.206157Z] Finished read-buildbot-config step (success) 21:33:47 INFO - [mozharness: 2017-09-17 04:33:47.206374Z] Running download-and-extract step. 21:33:47 INFO - Running pre-action listener: _resource_record_pre_action 21:33:47 INFO - Running main action method: download_and_extract 21:33:47 INFO - mkdir: /builds/slave/test/build/tests 21:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:47 INFO - trying https://queue.taskcluster.net/v1/task/cFWRlOVRSYCqONchm7xKJw/artifacts/public/build/target.test_packages.json 21:33:47 INFO - Downloading https://queue.taskcluster.net/v1/task/cFWRlOVRSYCqONchm7xKJw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:33:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cFWRlOVRSYCqONchm7xKJw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:33:47 INFO - Downloaded 989 bytes. 21:33:47 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:33:47 INFO - Using the following test package requirements: 21:33:47 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 21:33:47 INFO - u'common': [u'target.common.tests.zip'], 21:33:47 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:33:47 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:33:47 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:33:47 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:33:47 INFO - u'mozbase': [u'target.common.tests.zip'], 21:33:47 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:33:47 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:33:47 INFO - u'web-platform': [u'target.common.tests.zip', 21:33:47 INFO - u'target.web-platform.tests.tar.gz'], 21:33:47 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:33:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 21:33:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cFWRlOVRSYCqONchm7xKJw/artifacts/public/build/target.common.tests.zip 21:33:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cFWRlOVRSYCqONchm7xKJw/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:33:47 INFO - Fetch https://queue.taskcluster.net/v1/task/cFWRlOVRSYCqONchm7xKJw/artifacts/public/build/target.common.tests.zip into memory 21:33:48 INFO - Content-Length response header: 55326082 21:33:48 INFO - Bytes received: 55326082 21:33:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cFWRlOVRSYCqONchm7xKJw/artifacts/public/build/target.talos.tests.zip 21:33:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cFWRlOVRSYCqONchm7xKJw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:33:59 INFO - Fetch https://queue.taskcluster.net/v1/task/cFWRlOVRSYCqONchm7xKJw/artifacts/public/build/target.talos.tests.zip into memory 21:34:00 INFO - Content-Length response header: 14508748 21:34:00 INFO - Bytes received: 14508748 21:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:00 INFO - trying https://queue.taskcluster.net/v1/task/cFWRlOVRSYCqONchm7xKJw/artifacts/public/build/target.tar.bz2 21:34:00 INFO - Downloading https://queue.taskcluster.net/v1/task/cFWRlOVRSYCqONchm7xKJw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:34:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cFWRlOVRSYCqONchm7xKJw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:34:01 INFO - Downloaded 62046936 bytes. 21:34:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cFWRlOVRSYCqONchm7xKJw/artifacts/public/build/target.tar.bz2 21:34:01 INFO - mkdir: /builds/slave/test/properties 21:34:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:34:01 INFO - Writing to file /builds/slave/test/properties/build_url 21:34:01 INFO - Contents: 21:34:01 INFO - build_url:https://queue.taskcluster.net/v1/task/cFWRlOVRSYCqONchm7xKJw/artifacts/public/build/target.tar.bz2 21:34:01 INFO - Running post-action listener: _resource_record_post_action 21:34:01 INFO - Running post-action listener: find_tests_for_verification 21:34:01 INFO - Running post-action listener: set_extra_try_arguments 21:34:01 INFO - [mozharness: 2017-09-17 04:34:01.630412Z] Finished download-and-extract step (success) 21:34:01 INFO - [mozharness: 2017-09-17 04:34:01.630565Z] Running populate-webroot step. 21:34:01 INFO - Running pre-action listener: _resource_record_pre_action 21:34:01 INFO - Running main action method: populate_webroot 21:34:01 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:34:01 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:34:01 INFO - 'tests': ['tresize', 21:34:01 INFO - 'tcanvasmark']}, 21:34:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:34:01 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:34:01 INFO - 'tests': ['dromaeo_css', 21:34:01 INFO - 'kraken']}, 21:34:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:34:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:34:01 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:34:01 INFO - 'talos_options': ['--disable-stylo'], 21:34:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:34:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:34:01 INFO - 'tests': ['damp', 'tps']}, 21:34:01 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:34:01 INFO - 'talos_options': ['--disable-stylo'], 21:34:01 INFO - 'tests': ['damp', 'tps']}, 21:34:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:34:01 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:34:01 INFO - 'tests': ['dromaeo_dom']}, 21:34:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 21:34:01 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:34:01 INFO - 'tests': ['basic_compositor_video', 21:34:01 INFO - 'glvideo']}, 21:34:01 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 21:34:01 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 21:34:01 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:34:01 INFO - 'talos_options': ['--disable-stylo'], 21:34:01 INFO - 'tests': ['ts_paint_webext', 21:34:01 INFO - 'tp5o_webext']}, 21:34:01 INFO - 'other-e10s': {'tests': ['a11yr', 21:34:01 INFO - 'ts_paint', 21:34:01 INFO - 'tpaint', 21:34:01 INFO - 'sessionrestore', 21:34:01 INFO - 'sessionrestore_many_windows', 21:34:01 INFO - 'sessionrestore_no_auto_restore', 21:34:01 INFO - 'tabpaint']}, 21:34:01 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:34:01 INFO - 'tests': ['a11yr', 21:34:01 INFO - 'ts_paint', 21:34:01 INFO - 'tpaint', 21:34:01 INFO - 'sessionrestore', 21:34:01 INFO - 'sessionrestore_many_windows', 21:34:01 INFO - 'sessionrestore_no_auto_restore', 21:34:01 INFO - 'tabpaint']}, 21:34:01 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 21:34:01 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 21:34:01 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:34:01 INFO - 'tests': ['perf_reftest_singletons']}, 21:34:01 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:34:01 INFO - 'tests': ['bloom_basic']}, 21:34:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:34:01 INFO - 'tsvgr_opacity', 21:34:01 INFO - 'tart', 21:34:01 INFO - 'tscrollx', 21:34:01 INFO - 'tsvg_static']}, 21:34:01 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:34:01 INFO - 'tests': ['tsvgx', 21:34:01 INFO - 'tsvgr_opacity', 21:34:01 INFO - 'tart', 21:34:01 INFO - 'tscrollx', 21:34:01 INFO - 'tsvg_static']}, 21:34:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:34:01 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:34:01 INFO - 'talos_options': ['--disable-stylo'], 21:34:01 INFO - 'tests': ['tp5o']}, 21:34:01 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:34:01 INFO - 'talos_options': ['--mitmproxy', 21:34:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:34:01 INFO - '--firstNonBlankPaint'], 21:34:01 INFO - 'tests': ['tp6_google', 21:34:01 INFO - 'tp6_youtube', 21:34:01 INFO - 'tp6_amazon', 21:34:01 INFO - 'tp6_facebook']}, 21:34:01 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:34:01 INFO - 'talos_options': ['--disable-stylo', 21:34:01 INFO - '--mitmproxy', 21:34:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:34:01 INFO - '--firstNonBlankPaint'], 21:34:01 INFO - 'tests': ['tp6_google', 21:34:01 INFO - 'tp6_youtube', 21:34:01 INFO - 'tp6_amazon', 21:34:01 INFO - 'tp6_facebook']}, 21:34:01 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:34:01 INFO - 'talos_options': ['--stylo-threads=1', 21:34:01 INFO - '--mitmproxy', 21:34:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:34:01 INFO - '--firstNonBlankPaint'], 21:34:01 INFO - 'tests': ['tp6_google', 21:34:01 INFO - 'tp6_youtube', 21:34:01 INFO - 'tp6_amazon', 21:34:01 INFO - 'tp6_facebook']}, 21:34:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:34:01 INFO - 'talos_options': ['--xperf_path', 21:34:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:34:01 INFO - 'tests': ['tp5n']}, 21:34:01 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:34:01 INFO - 'talos_options': ['--disable-stylo', 21:34:01 INFO - '--xperf_path', 21:34:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:34:01 INFO - 'tests': ['tp5n']}}} 21:34:01 INFO - Running post-action listener: _resource_record_post_action 21:34:01 INFO - [mozharness: 2017-09-17 04:34:01.651138Z] Finished populate-webroot step (success) 21:34:01 INFO - [mozharness: 2017-09-17 04:34:01.651244Z] Running create-virtualenv step. 21:34:01 INFO - Running pre-action listener: _resource_record_pre_action 21:34:01 INFO - Running main action method: create_virtualenv 21:34:01 INFO - Creating virtualenv /builds/slave/test/build/venv 21:34:01 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:34:01 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 21:34:01 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 21:34:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:34:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:34:02 INFO - Installing distribute.............................................................................................................................................................................................done. 21:34:02 INFO - Installing pip...............done. 21:34:02 INFO - Return code: 0 21:34:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:34:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:34:03 INFO - Reading from file tmpfile_stdout 21:34:03 INFO - Output received: 21:34:03 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 21:34:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:34:03 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')]} 21:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:03 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')]} 21:34:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:03 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 0x1b451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb5090>, '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 0x1eb5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eaff90>, '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': 'ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545', '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 21:34:03 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 21:34:03 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 21:34:03 INFO - Using env: {'DISPLAY': ':0', 21:34:03 INFO - 'HOME': '/home/cltbld', 21:34:03 INFO - 'LANG': 'en_US.UTF-8', 21:34:03 INFO - 'LANGUAGE': 'en_US:en', 21:34:03 INFO - 'LOGNAME': 'cltbld', 21:34:03 INFO - 'MAIL': '/var/mail/cltbld', 21:34:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:03 INFO - 'MOZ_NO_REMOTE': '1', 21:34:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:03 INFO - 'NO_EM_RESTART': '1', 21:34:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:03 INFO - 'PWD': '/builds/slave/test', 21:34:03 INFO - 'SHELL': '/bin/bash', 21:34:03 INFO - 'SHLVL': '1', 21:34:03 INFO - 'TERM': 'linux', 21:34:03 INFO - 'TMOUT': '86400', 21:34:03 INFO - 'USER': 'cltbld', 21:34:03 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545', 21:34:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:03 INFO - '_': '/tools/buildbot/bin/python'} 21:34:04 INFO - Ignoring indexes: http://pypi.python.org/simple/ 21:34:04 INFO - Downloading/unpacking pip>=1.5 21:34:04 INFO - Running setup.py egg_info for package pip 21:34:04 INFO - warning: no files found matching 'pip/cacert.pem' 21:34:04 INFO - warning: no files found matching '*.html' under directory 'docs' 21:34:04 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 21:34:04 INFO - no previously-included directories found matching 'docs/_build/_sources' 21:34:04 INFO - Installing collected packages: pip 21:34:04 INFO - Found existing installation: pip 1.1 21:34:04 INFO - Uninstalling pip: 21:34:04 INFO - Successfully uninstalled pip 21:34:04 INFO - Running setup.py install for pip 21:34:04 INFO - warning: no files found matching 'pip/cacert.pem' 21:34:04 INFO - warning: no files found matching '*.html' under directory 'docs' 21:34:04 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 21:34:04 INFO - no previously-included directories found matching 'docs/_build/_sources' 21:34:04 INFO - Installing pip script to /builds/slave/test/build/venv/bin 21:34:04 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 21:34:04 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 21:34:04 INFO - Successfully installed pip 21:34:04 INFO - Cleaning up... 21:34:04 INFO - Return code: 0 21:34:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:34:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:04 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 0x1b451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb5090>, '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 0x1eb5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eaff90>, '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': 'ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545', '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 21:34:04 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 21:34:04 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 21:34:04 INFO - Using env: {'DISPLAY': ':0', 21:34:04 INFO - 'HOME': '/home/cltbld', 21:34:04 INFO - 'LANG': 'en_US.UTF-8', 21:34:04 INFO - 'LANGUAGE': 'en_US:en', 21:34:04 INFO - 'LOGNAME': 'cltbld', 21:34:04 INFO - 'MAIL': '/var/mail/cltbld', 21:34:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:04 INFO - 'MOZ_NO_REMOTE': '1', 21:34:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:04 INFO - 'NO_EM_RESTART': '1', 21:34:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:04 INFO - 'PWD': '/builds/slave/test', 21:34:04 INFO - 'SHELL': '/bin/bash', 21:34:04 INFO - 'SHLVL': '1', 21:34:04 INFO - 'TERM': 'linux', 21:34:04 INFO - 'TMOUT': '86400', 21:34:04 INFO - 'USER': 'cltbld', 21:34:04 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545', 21:34:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:04 INFO - '_': '/tools/buildbot/bin/python'} 21:34:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:04 INFO - Downloading/unpacking psutil>=3.1.1 21:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:34:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:34:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:34:05 INFO - Installing collected packages: psutil 21:34:05 INFO - Running setup.py install for psutil 21:34:05 INFO - building 'psutil._psutil_linux' extension 21:34:05 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 21:34:05 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 21:34:05 INFO - building 'psutil._psutil_posix' extension 21:34:05 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 21:34:06 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 21:34:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:34:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:34:06 INFO - Successfully installed psutil 21:34:06 INFO - Cleaning up... 21:34:06 INFO - Return code: 0 21:34:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:34:06 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')]} 21:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:06 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')]} 21:34:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:06 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 0x1b451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb5090>, '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 0x1eb5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eaff90>, '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': 'ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545', '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 21:34:06 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 21:34:06 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 21:34:06 INFO - Using env: {'DISPLAY': ':0', 21:34:06 INFO - 'HOME': '/home/cltbld', 21:34:06 INFO - 'LANG': 'en_US.UTF-8', 21:34:06 INFO - 'LANGUAGE': 'en_US:en', 21:34:06 INFO - 'LOGNAME': 'cltbld', 21:34:06 INFO - 'MAIL': '/var/mail/cltbld', 21:34:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:06 INFO - 'MOZ_NO_REMOTE': '1', 21:34:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:06 INFO - 'NO_EM_RESTART': '1', 21:34:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:06 INFO - 'PWD': '/builds/slave/test', 21:34:06 INFO - 'SHELL': '/bin/bash', 21:34:06 INFO - 'SHLVL': '1', 21:34:06 INFO - 'TERM': 'linux', 21:34:06 INFO - 'TMOUT': '86400', 21:34:06 INFO - 'USER': 'cltbld', 21:34:06 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545', 21:34:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:06 INFO - '_': '/tools/buildbot/bin/python'} 21:34:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:34:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:34:07 INFO - Installing collected packages: mozsystemmonitor 21:34:07 INFO - Running setup.py install for mozsystemmonitor 21:34:08 INFO - Successfully installed mozsystemmonitor 21:34:08 INFO - Cleaning up... 21:34:08 INFO - Return code: 0 21:34:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:34:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:08 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 0x1b451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb5090>, '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 0x1eb5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eaff90>, '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': 'ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545', '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 21:34:08 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 21:34:08 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 21:34:08 INFO - Using env: {'DISPLAY': ':0', 21:34:08 INFO - 'HOME': '/home/cltbld', 21:34:08 INFO - 'LANG': 'en_US.UTF-8', 21:34:08 INFO - 'LANGUAGE': 'en_US:en', 21:34:08 INFO - 'LOGNAME': 'cltbld', 21:34:08 INFO - 'MAIL': '/var/mail/cltbld', 21:34:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:08 INFO - 'MOZ_NO_REMOTE': '1', 21:34:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:08 INFO - 'NO_EM_RESTART': '1', 21:34:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:08 INFO - 'PWD': '/builds/slave/test', 21:34:08 INFO - 'SHELL': '/bin/bash', 21:34:08 INFO - 'SHLVL': '1', 21:34:08 INFO - 'TERM': 'linux', 21:34:08 INFO - 'TMOUT': '86400', 21:34:08 INFO - 'USER': 'cltbld', 21:34:08 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545', 21:34:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:08 INFO - '_': '/tools/buildbot/bin/python'} 21:34:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:08 INFO - Downloading/unpacking jsonschema==2.5.1 21:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:34:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:34:10 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 21:34:10 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 21:34:10 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 21:34:10 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 21:34:10 INFO - Downloading functools32-3.2.3-2.tar.gz 21:34:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:34:10 INFO - warning: no files found matching '*.txt' 21:34:10 INFO - no previously-included directories found matching 'build' 21:34:10 INFO - no previously-included directories found matching 'dist' 21:34:10 INFO - no previously-included directories found matching '.git*' 21:34:10 INFO - Installing collected packages: jsonschema, functools32 21:34:10 INFO - Running setup.py install for functools32 21:34:10 INFO - warning: no files found matching '*.txt' 21:34:10 INFO - no previously-included directories found matching 'build' 21:34:10 INFO - no previously-included directories found matching 'dist' 21:34:10 INFO - no previously-included directories found matching '.git*' 21:34:10 INFO - Successfully installed jsonschema functools32 21:34:10 INFO - Cleaning up... 21:34:10 INFO - Return code: 0 21:34:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:34:10 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')]} 21:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:10 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')]} 21:34:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:10 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 0x1b451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb5090>, '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 0x1eb5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eaff90>, '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': 'ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545', '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 21:34:10 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 21:34:10 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 21:34:10 INFO - Using env: {'DISPLAY': ':0', 21:34:10 INFO - 'HOME': '/home/cltbld', 21:34:10 INFO - 'LANG': 'en_US.UTF-8', 21:34:10 INFO - 'LANGUAGE': 'en_US:en', 21:34:10 INFO - 'LOGNAME': 'cltbld', 21:34:10 INFO - 'MAIL': '/var/mail/cltbld', 21:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:10 INFO - 'MOZ_NO_REMOTE': '1', 21:34:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:10 INFO - 'NO_EM_RESTART': '1', 21:34:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:10 INFO - 'PWD': '/builds/slave/test', 21:34:10 INFO - 'SHELL': '/bin/bash', 21:34:10 INFO - 'SHLVL': '1', 21:34:10 INFO - 'TERM': 'linux', 21:34:10 INFO - 'TMOUT': '86400', 21:34:10 INFO - 'USER': 'cltbld', 21:34:10 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545', 21:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:10 INFO - '_': '/tools/buildbot/bin/python'} 21:34:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:34:10 INFO - Cleaning up... 21:34:10 INFO - Return code: 0 21:34:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:34:10 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')]} 21:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:10 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')]} 21:34:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:10 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 0x1b451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb5090>, '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 0x1eb5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eaff90>, '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': 'ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545', '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 21:34:10 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 21:34:10 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 21:34:10 INFO - Using env: {'DISPLAY': ':0', 21:34:10 INFO - 'HOME': '/home/cltbld', 21:34:10 INFO - 'LANG': 'en_US.UTF-8', 21:34:10 INFO - 'LANGUAGE': 'en_US:en', 21:34:10 INFO - 'LOGNAME': 'cltbld', 21:34:10 INFO - 'MAIL': '/var/mail/cltbld', 21:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:10 INFO - 'MOZ_NO_REMOTE': '1', 21:34:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:10 INFO - 'NO_EM_RESTART': '1', 21:34:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:10 INFO - 'PWD': '/builds/slave/test', 21:34:10 INFO - 'SHELL': '/bin/bash', 21:34:10 INFO - 'SHLVL': '1', 21:34:10 INFO - 'TERM': 'linux', 21:34:10 INFO - 'TMOUT': '86400', 21:34:10 INFO - 'USER': 'cltbld', 21:34:10 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545', 21:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:10 INFO - '_': '/tools/buildbot/bin/python'} 21:34:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:10 INFO - Downloading/unpacking blobuploader==1.2.4 21:34:10 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 21:34:10 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 21:34:10 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 21:34:10 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 21:34:11 INFO - Downloading blobuploader-1.2.4.tar.gz 21:34:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:34:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:34:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:34:12 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 21:34:12 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 21:34:12 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 21:34:12 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 21:34:12 INFO - Downloading docopt-0.6.1.tar.gz 21:34:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:34:12 INFO - Installing collected packages: blobuploader, requests, docopt 21:34:12 INFO - Running setup.py install for blobuploader 21:34:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:34:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:34:12 INFO - Running setup.py install for requests 21:34:12 INFO - Running setup.py install for docopt 21:34:13 INFO - Successfully installed blobuploader requests docopt 21:34:13 INFO - Cleaning up... 21:34:13 INFO - Return code: 0 21:34:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:13 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 0x1b451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb5090>, '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 0x1eb5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eaff90>, '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': 'ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545', '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 21:34:13 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 21:34:13 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 21:34:13 INFO - Using env: {'DISPLAY': ':0', 21:34:13 INFO - 'HOME': '/home/cltbld', 21:34:13 INFO - 'LANG': 'en_US.UTF-8', 21:34:13 INFO - 'LANGUAGE': 'en_US:en', 21:34:13 INFO - 'LOGNAME': 'cltbld', 21:34:13 INFO - 'MAIL': '/var/mail/cltbld', 21:34:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:13 INFO - 'MOZ_NO_REMOTE': '1', 21:34:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:13 INFO - 'NO_EM_RESTART': '1', 21:34:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:13 INFO - 'PWD': '/builds/slave/test', 21:34:13 INFO - 'SHELL': '/bin/bash', 21:34:13 INFO - 'SHLVL': '1', 21:34:13 INFO - 'TERM': 'linux', 21:34:13 INFO - 'TMOUT': '86400', 21:34:13 INFO - 'USER': 'cltbld', 21:34:13 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545', 21:34:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:13 INFO - '_': '/tools/buildbot/bin/python'} 21:34:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:34:13 INFO - Running setup.py (path:/tmp/pip-oZbi3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:34:13 INFO - Running setup.py (path:/tmp/pip-prLjbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:34:13 INFO - Running setup.py (path:/tmp/pip-HUaTT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:34:13 INFO - Running setup.py (path:/tmp/pip-JNCO_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:34:13 INFO - Running setup.py (path:/tmp/pip-v_bfTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:34:13 INFO - Running setup.py (path:/tmp/pip-mW3tUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:34:13 INFO - Running setup.py (path:/tmp/pip-VKn8bZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:34:13 INFO - Running setup.py (path:/tmp/pip-DqYuKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:34:13 INFO - Running setup.py (path:/tmp/pip-626Cp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:34:13 INFO - Running setup.py (path:/tmp/pip-lfbQ1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:34:14 INFO - Running setup.py (path:/tmp/pip-Qrrw3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:34:14 INFO - Running setup.py (path:/tmp/pip-8nY_VV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:34:14 INFO - Running setup.py (path:/tmp/pip-1kdpGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:34:14 INFO - Running setup.py (path:/tmp/pip-yq03Wt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:34:14 INFO - Running setup.py (path:/tmp/pip-jhf2BK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:34:14 INFO - Running setup.py (path:/tmp/pip-6VNj4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:34:14 INFO - Running setup.py (path:/tmp/pip-rC0ejR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:34:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:34:14 INFO - Running setup.py install for manifestparser 21:34:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:34:14 INFO - Running setup.py install for mozcrash 21:34:14 INFO - Running setup.py install for mozdebug 21:34:14 INFO - Running setup.py install for mozdevice 21:34:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:34:14 INFO - Running setup.py install for mozfile 21:34:15 INFO - Running setup.py install for mozhttpd 21:34:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:34:15 INFO - Running setup.py install for mozinfo 21:34:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:34:15 INFO - Running setup.py install for mozInstall 21:34:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:34:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:34:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:34:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:34:15 INFO - Running setup.py install for mozleak 21:34:15 INFO - Running setup.py install for mozlog 21:34:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:34:15 INFO - Running setup.py install for moznetwork 21:34:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:34:15 INFO - Running setup.py install for mozprocess 21:34:15 INFO - Running setup.py install for mozprofile 21:34:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:34:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:34:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:34:15 INFO - Running setup.py install for mozrunner 21:34:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:34:15 INFO - Running setup.py install for mozscreenshot 21:34:16 INFO - Running setup.py install for moztest 21:34:16 INFO - Running setup.py install for mozversion 21:34:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:34:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:34:16 INFO - Cleaning up... 21:34:16 INFO - Return code: 0 21:34:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:34:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:16 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 0x1b451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb5090>, '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 0x1eb5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eaff90>, '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': 'ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545', '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 21:34:16 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 21:34:16 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 21:34:16 INFO - Using env: {'DISPLAY': ':0', 21:34:16 INFO - 'HOME': '/home/cltbld', 21:34:16 INFO - 'LANG': 'en_US.UTF-8', 21:34:16 INFO - 'LANGUAGE': 'en_US:en', 21:34:16 INFO - 'LOGNAME': 'cltbld', 21:34:16 INFO - 'MAIL': '/var/mail/cltbld', 21:34:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:16 INFO - 'MOZ_NO_REMOTE': '1', 21:34:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:16 INFO - 'NO_EM_RESTART': '1', 21:34:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:16 INFO - 'PWD': '/builds/slave/test', 21:34:16 INFO - 'SHELL': '/bin/bash', 21:34:16 INFO - 'SHLVL': '1', 21:34:16 INFO - 'TERM': 'linux', 21:34:16 INFO - 'TMOUT': '86400', 21:34:16 INFO - 'USER': 'cltbld', 21:34:16 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545', 21:34:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:16 INFO - '_': '/tools/buildbot/bin/python'} 21:34:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:34:16 INFO - Running setup.py (path:/tmp/pip-95GJ6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:34:16 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)) 21:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:34:16 INFO - Running setup.py (path:/tmp/pip-gd4s6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:34:16 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)) 21:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:34:16 INFO - Running setup.py (path:/tmp/pip-E1OzpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:34:16 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)) 21:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:34:16 INFO - Running setup.py (path:/tmp/pip-1pxHOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:34:16 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)) 21:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:34:16 INFO - Running setup.py (path:/tmp/pip-wHDwDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:34:16 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)) 21:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:34:16 INFO - Running setup.py (path:/tmp/pip-U9mrd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:34:16 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)) 21:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:34:16 INFO - Running setup.py (path:/tmp/pip-VEFXXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:34:16 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)) 21:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:34:16 INFO - Running setup.py (path:/tmp/pip-l4_x8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:34:17 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)) 21:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:34:17 INFO - Running setup.py (path:/tmp/pip-WIJZO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:34:17 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)) 21:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:34:17 INFO - Running setup.py (path:/tmp/pip-Fz8nFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:34:17 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)) 21:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:34:17 INFO - Running setup.py (path:/tmp/pip-mZI5iG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:34:17 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)) 21:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:34:17 INFO - Running setup.py (path:/tmp/pip-iAf6Pn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:34:17 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)) 21:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:34:17 INFO - Running setup.py (path:/tmp/pip-NMgbMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:34:17 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)) 21:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:34:17 INFO - Running setup.py (path:/tmp/pip-nxeoja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:34:17 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)) 21:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:34:17 INFO - Running setup.py (path:/tmp/pip-5nlZi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:34:17 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)) 21:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:34:17 INFO - Running setup.py (path:/tmp/pip-SVrTwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:34:17 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)) 21:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:34:17 INFO - Running setup.py (path:/tmp/pip-RscAf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:34:17 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)) 21:34:17 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)) 21:34:17 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)) 21:34:17 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)) 21:34:17 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)) 21:34:17 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)) 21:34:17 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)) 21:34:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:34:17 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 21:34:17 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 21:34:17 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 21:34:17 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 21:34:18 INFO - Downloading blessings-1.6.tar.gz 21:34:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:34:18 INFO - Installing collected packages: blessings 21:34:18 INFO - Running setup.py install for blessings 21:34:18 INFO - Successfully installed blessings 21:34:18 INFO - Cleaning up... 21:34:19 INFO - Return code: 0 21:34:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:34:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:34:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:34:19 INFO - Reading from file tmpfile_stdout 21:34:19 INFO - Current package versions: 21:34:19 INFO - argparse == 1.2.1 21:34:19 INFO - blessings == 1.6 21:34:19 INFO - blobuploader == 1.2.4 21:34:19 INFO - docopt == 0.6.1 21:34:19 INFO - functools32 == 3.2.3-2 21:34:19 INFO - jsonschema == 2.5.1 21:34:19 INFO - manifestparser == 1.1 21:34:19 INFO - mozInstall == 1.13 21:34:19 INFO - mozcrash == 1.0 21:34:19 INFO - mozdebug == 0.1 21:34:19 INFO - mozdevice == 0.51 21:34:19 INFO - mozfile == 1.2 21:34:19 INFO - mozhttpd == 0.7 21:34:19 INFO - mozinfo == 0.10 21:34:19 INFO - mozleak == 0.1 21:34:19 INFO - mozlog == 3.5 21:34:19 INFO - moznetwork == 0.27 21:34:19 INFO - mozprocess == 0.25 21:34:19 INFO - mozprofile == 0.28 21:34:19 INFO - mozrunner == 6.13 21:34:19 INFO - mozscreenshot == 0.1 21:34:19 INFO - mozsystemmonitor == 0.3 21:34:19 INFO - moztest == 0.8 21:34:19 INFO - mozversion == 1.4 21:34:19 INFO - psutil == 3.1.1 21:34:19 INFO - requests == 1.2.3 21:34:19 INFO - wsgiref == 0.1.2 21:34:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:34:19 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')]} 21:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:19 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')]} 21:34:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:19 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 0x1b451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb5090>, '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 0x1eb5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eaff90>, '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': 'ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545', '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 21:34:19 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 21:34:19 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 21:34:19 INFO - Using env: {'DISPLAY': ':0', 21:34:19 INFO - 'HOME': '/home/cltbld', 21:34:19 INFO - 'LANG': 'en_US.UTF-8', 21:34:19 INFO - 'LANGUAGE': 'en_US:en', 21:34:19 INFO - 'LOGNAME': 'cltbld', 21:34:19 INFO - 'MAIL': '/var/mail/cltbld', 21:34:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:19 INFO - 'MOZ_NO_REMOTE': '1', 21:34:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:19 INFO - 'NO_EM_RESTART': '1', 21:34:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:19 INFO - 'PWD': '/builds/slave/test', 21:34:19 INFO - 'SHELL': '/bin/bash', 21:34:19 INFO - 'SHLVL': '1', 21:34:19 INFO - 'TERM': 'linux', 21:34:19 INFO - 'TMOUT': '86400', 21:34:19 INFO - 'USER': 'cltbld', 21:34:19 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545', 21:34:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:19 INFO - '_': '/tools/buildbot/bin/python'} 21:34:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:19 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)) 21:34:19 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)) 21:34:19 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)) 21:34:19 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)) 21:34:19 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)) 21:34:19 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)) 21:34:19 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)) 21:34:19 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)) 21:34:19 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)) 21:34:19 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 21:34:19 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 21:34:19 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 21:34:19 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 21:34:19 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 21:34:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 21:34:20 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)) 21:34:20 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)) 21:34:20 INFO - Installing collected packages: simplejson 21:34:20 INFO - Running setup.py install for simplejson 21:34:20 INFO - building 'simplejson._speedups' extension 21:34:20 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 21:34:21 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 21:34:21 INFO - Successfully installed simplejson 21:34:21 INFO - Cleaning up... 21:34:21 INFO - Return code: 0 21:34:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:34:21 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')]} 21:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:21 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')]} 21:34:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:21 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 0x1b451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb5090>, '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 0x1eb5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eaff90>, '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': 'ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545', '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 21:34:21 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 21:34:21 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 21:34:21 INFO - Using env: {'DISPLAY': ':0', 21:34:21 INFO - 'HOME': '/home/cltbld', 21:34:21 INFO - 'LANG': 'en_US.UTF-8', 21:34:21 INFO - 'LANGUAGE': 'en_US:en', 21:34:21 INFO - 'LOGNAME': 'cltbld', 21:34:21 INFO - 'MAIL': '/var/mail/cltbld', 21:34:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:21 INFO - 'MOZ_NO_REMOTE': '1', 21:34:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:21 INFO - 'NO_EM_RESTART': '1', 21:34:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:21 INFO - 'PWD': '/builds/slave/test', 21:34:21 INFO - 'SHELL': '/bin/bash', 21:34:21 INFO - 'SHLVL': '1', 21:34:21 INFO - 'TERM': 'linux', 21:34:21 INFO - 'TMOUT': '86400', 21:34:21 INFO - 'USER': 'cltbld', 21:34:21 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545', 21:34:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:21 INFO - '_': '/tools/buildbot/bin/python'} 21:34:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:34:21 INFO - Cleaning up... 21:34:21 INFO - Return code: 0 21:34:21 INFO - Running post-action listener: _resource_record_post_action 21:34:21 INFO - Running post-action listener: _start_resource_monitoring 21:34:21 INFO - Starting resource monitoring. 21:34:21 INFO - [mozharness: 2017-09-17 04:34:21.994599Z] Finished create-virtualenv step (success) 21:34:21 INFO - [mozharness: 2017-09-17 04:34:21.995066Z] Running install step. 21:34:21 INFO - Running pre-action listener: _resource_record_pre_action 21:34:21 INFO - Running main action method: install 21:34:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:34:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:34:22 INFO - Reading from file tmpfile_stdout 21:34:22 INFO - Detecting whether we're running mozinstall >=1.0... 21:34:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:34:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:34:22 INFO - Reading from file tmpfile_stdout 21:34:22 INFO - Output received: 21:34:22 INFO - Usage: mozinstall [options] installer 21:34:22 INFO - Options: 21:34:22 INFO - -h, --help show this help message and exit 21:34:22 INFO - -d DEST, --destination=DEST 21:34:22 INFO - Directory to install application into. [default: 21:34:22 INFO - "/builds/slave/test"] 21:34:22 INFO - --app=APP Application being installed. [default: firefox] 21:34:22 INFO - mkdir: /builds/slave/test/build/application 21:34:22 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'] 21:34:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:34:39 INFO - Reading from file tmpfile_stdout 21:34:39 INFO - Output received: 21:34:39 INFO - /builds/slave/test/build/application/firefox/firefox 21:34:39 INFO - Running post-action listener: _resource_record_post_action 21:34:39 INFO - [mozharness: 2017-09-17 04:34:39.864809Z] Finished install step (success) 21:34:39 INFO - [mozharness: 2017-09-17 04:34:39.865060Z] Running setup-mitmproxy step. 21:34:39 INFO - Running pre-action listener: _resource_record_pre_action 21:34:39 INFO - Running main action method: setup_mitmproxy 21:34:39 INFO - Skipping: mitmproxy is not required 21:34:39 INFO - Running post-action listener: _resource_record_post_action 21:34:39 INFO - [mozharness: 2017-09-17 04:34:39.866259Z] Finished setup-mitmproxy step (success) 21:34:39 INFO - [mozharness: 2017-09-17 04:34:39.866478Z] Running run-tests step. 21:34:39 INFO - Running pre-action listener: _resource_record_pre_action 21:34:39 INFO - Running pre-action listener: _set_gcov_prefix 21:34:39 INFO - Running main action method: run_tests 21:34:39 WARNING - Try message not found. 21:34:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:34:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:34:39 INFO - Python 2.7.3 21:34:39 INFO - Return code: 0 21:34:39 INFO - grabbing minidump binary from tooltool 21:34:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:39 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 0x1eb5090>, '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 0x1eb5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eaff90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:34:39 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 21:34:39 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 21:34:39 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 21:34:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:34:39 INFO - Return code: 0 21:34:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:34:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:34:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:34:39 INFO - ENV: RUST_BACKTRACE is now full 21:34:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:34:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:34:39 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/cFWRlOVRSYCqONchm7xKJw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 21:34:39 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/cFWRlOVRSYCqONchm7xKJw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 21:34:39 INFO - Using env: {'DISPLAY': ':0', 21:34:39 INFO - 'HOME': '/home/cltbld', 21:34:39 INFO - 'LANG': 'en_US.UTF-8', 21:34:39 INFO - 'LANGUAGE': 'en_US:en', 21:34:39 INFO - 'LOGNAME': 'cltbld', 21:34:39 INFO - 'MAIL': '/var/mail/cltbld', 21:34:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:34:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:40 INFO - 'MOZ_NO_REMOTE': '1', 21:34:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:34:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:40 INFO - 'NO_EM_RESTART': '1', 21:34:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:40 INFO - 'PWD': '/builds/slave/test', 21:34:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:34:40 INFO - 'RUST_BACKTRACE': 'full', 21:34:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 21:34:40 INFO - 'SHELL': '/bin/bash', 21:34:40 INFO - 'SHLVL': '1', 21:34:40 INFO - 'TERM': 'linux', 21:34:40 INFO - 'TMOUT': '86400', 21:34:40 INFO - 'USER': 'cltbld', 21:34:40 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545', 21:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:40 INFO - '_': '/tools/buildbot/bin/python'} 21:34:40 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/cFWRlOVRSYCqONchm7xKJw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 21:34:40 INFO - mozversion application_buildid: 20170917031052 21:34:40 INFO - mozversion application_changeset: 015f852e93fe8887e666ee5a1ff246d3d4e8063b 21:34:40 INFO - mozversion application_display_name: Nightly 21:34:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:34:40 INFO - mozversion application_name: Firefox 21:34:40 INFO - mozversion application_remotingname: firefox 21:34:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:34:40 INFO - mozversion application_vendor: Mozilla 21:34:40 INFO - mozversion application_version: 57.0a1 21:34:40 INFO - mozversion platform_buildid: 20170917031052 21:34:40 INFO - mozversion platform_changeset: 015f852e93fe8887e666ee5a1ff246d3d4e8063b 21:34:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:34:40 INFO - mozversion platform_version: 57.0a1 21:34:40 INFO - using testdate: 1505622880 21:34:40 INFO - actual date: 1505622880 21:34:40 INFO - starting webserver on 'localhost:42104' 21:34:40 INFO - SUITE-START | Running 2 tests 21:34:40 INFO - TEST-START | dromaeo_css 21:34:40 INFO - Initialising browser for dromaeo_css test... 21:34:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42104/getInfo.html -profile /tmp/tmpFKZ6Z0/profile 21:34:40 INFO - TEST-INFO | started process 15904 (/builds/slave/test/build/application/firefox/firefox http://localhost:42104/getInfo.html) 21:34:46 INFO - TEST-INFO | 15904: exit 0 21:34:46 INFO - Browser initialized. 21:34:46 INFO - Running cycle 1/1 for dromaeo_css test... 21:34:46 INFO - Using env: {'DISPLAY': ':0', 21:34:46 INFO - 'HOME': '/home/cltbld', 21:34:46 INFO - 'JSGC_DISABLE_POISONING': '1', 21:34:46 INFO - 'LANG': 'en_US.UTF-8', 21:34:46 INFO - 'LANGUAGE': 'en_US:en', 21:34:46 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 21:34:46 INFO - 'LOGNAME': 'cltbld', 21:34:46 INFO - 'MAIL': '/var/mail/cltbld', 21:34:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:34:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:34:46 INFO - 'MOZ_CRASHREPORTER': '1', 21:34:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:46 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 21:34:46 INFO - 'MOZ_NO_REMOTE': '1', 21:34:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:34:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:46 INFO - 'NO_EM_RESTART': '1', 21:34:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:46 INFO - 'PWD': '/builds/slave/test', 21:34:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:34:46 INFO - 'RUST_BACKTRACE': 'full', 21:34:46 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 21:34:46 INFO - 'SHELL': '/bin/bash', 21:34:46 INFO - 'SHLVL': '1', 21:34:46 INFO - 'TERM': 'linux', 21:34:46 INFO - 'TMOUT': '86400', 21:34:46 INFO - 'USER': 'cltbld', 21:34:46 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545', 21:34:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:46 INFO - '_': '/tools/buildbot/bin/python'} 21:34:46 INFO - TEST-INFO | started process 16145 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFKZ6Z0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 21:34:47 INFO - PID 16145 | 21:34:47 INFO - PID 16145 | (/builds/slave/test/build/application/firefox/firefox:16194): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 21:34:47 INFO - PID 16145 | 21:34:57 INFO - PID 16145 | RSS: Main: 148275200 21:34:57 INFO - PID 16145 | 21:37:55 INFO - PID 16145 | Cycle 1(1): loaded http://localhost:42104/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42104/tests/dromaeo/cssquery-ext.html) 21:37:56 INFO - PID 16145 | RSS: Main: 148934656 21:37:56 INFO - PID 16145 | 21:40:58 INFO - PID 16145 | Cycle 1(1): loaded http://localhost:42104/tests/dromaeo/cssquery-ext.html (next: http://localhost:42104/tests/dromaeo/cssquery-jquery.html) 21:40:58 INFO - PID 16145 | RSS: Main: 148418560 21:40:58 INFO - PID 16145 | 21:44:00 INFO - PID 16145 | Cycle 1(1): loaded http://localhost:42104/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42104/tests/dromaeo/cssquery-mootools.html) 21:44:01 INFO - PID 16145 | RSS: Main: 151048192 21:44:01 INFO - PID 16145 | 21:47:02 INFO - PID 16145 | Cycle 1(1): loaded http://localhost:42104/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42104/tests/dromaeo/cssquery-prototype.html) 21:47:03 INFO - PID 16145 | RSS: Main: 149377024 21:47:03 INFO - PID 16145 | 21:50:06 INFO - PID 16145 | Cycle 1(1): loaded http://localhost:42104/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42104/tests/dromaeo/cssquery-yui.html) 21:50:06 INFO - PID 16145 | RSS: Main: 150298624 21:50:06 INFO - PID 16145 | 21:53:08 INFO - PID 16145 | Cycle 1(1): loaded http://localhost:42104/tests/dromaeo/cssquery-yui.html (next: http://localhost:42104/tests/dromaeo/cssquery-dojo.html) 21:53:08 INFO - PID 16145 | RSS: Main: 152985600 21:53:08 INFO - PID 16145 | 21:53:08 INFO - PID 16145 | __start_tp_report 21:53:08 INFO - PID 16145 | _x_x_mozilla_page_load 21:53:08 INFO - PID 16145 | _x_x_mozilla_page_load_details 21:53:08 INFO - PID 16145 | |i|pagename|runs| 21:53:08 INFO - PID 16145 | |0;dojo.html;3881.825317860696;3892.5718171001186;3894.844206231751;3895.0846551060476;3916.999999999998;6076.878462430749;6079;6174.722137503812;6196.318404975449;6276.05859121132;6190.938090619093;6233.625982441056;6324.525660575452;6328.873422531547;6340.0489926511045;5512.200730894018;5525.060739674245;5628.183913332565;5636.633618814764;5672.943270567303;5339.946600534003;5603.551715862721;5629.9866024115645;5666.376698563155;5692.402297758717;5469.808556700536;5522.641028333145;5548.361938377098;5597.720113994284;5609.439056094398;5542.224088627595;5560.944390556124;5575.832725018256;5582.944170558324;5583.302087239095;5489.725513724337;5566.944330556683;5603.831885043455;5643.661380317194;5647.43525647436;6112.266528016667;6147.631142131441;6228.159198508234;6238.844028899269;6267.4672652824565;6593.20881494219;6694.364035416627;6714.932850671479;6768.492363072789;6782.321767823228;6765.898511522331;6777.186737591472;6846.383825455683;6859.2454829969165;6887.896681549781;6227.96886015567;6239.532035097386;6291.1192433059405;6321.905171422432;6328.303886572473;6982.0923279974295;6986.231514533397;7000.124984376953;7011.754588589375;7011.89482157768;6680.799576012728;6692.86614267712;6745.696443660047;6774.45804335652;6788.898166527506;6685.832854178587;6769.796906092825;6792.117024786845;6802.591844489347;6880.552764070319;6682.966585167043;6683.565568238147;6686.1642294713165;6715.93284067153;6759;6705.228898676617;6711.899321510181;6793.490488213404;6797.014432907201;6805.489588280899;4864.36763220779;4866.9513304867205;4923.040007198562;4929.531694489017;4946.727929963887;4419.602235798729;4441.244988351988;4460.330950357407;4539.251023581138;4568.840090596813;6204.875902482016;6231.501479881598;6234.906476402857;6235.064740288903;6273.278572964167;6663.167104111986;6667.33326667339;6735.326467353226;6748.561343512656;6767.255601883789;6116.847078822976;6174.135621013062;6202.193714817045;6252.187215661935;6268;5381.246625472437;5474.09677403224;5480.972595136999;5493.340799104053;5510.504054635102;7033.542819716702;7047.788566343018;7094.858102838018;7123.25205853378;7133.750318738819;6730.192376914802;6734.595924244561;6813.4208592270215;6817.522773405814;6822.522423430312;6873.0377747116445;6996.230414654282;7008.7546935857;7011.579305241702;7013.754518591825;6624.701888414937;6672.666366681744;6698.196216454056;6711.865762684816;6713.932860671526;6753.763618273337;6792;6891.483138764713;6901.275366086488;6905.1713794342995;6456.128422663069;6516.120323756232;6531.248906375828;6640.767573134917;6648.601083934979;6506.804795856132;6587.769428069994;6590.90113648286;6596.472282217507;6604.471642268511;6433.485321174388;6437.839054023687;6507.902381464187;6525.934740652533;6539.444147247537;6502.707378167899;6512.73949042033;6535.640539770358;6574.046763219402;6576.079348891255;6347.143135676624;6379.585326953733;6380.234371875405;6399.360063993563;6402.487800976004 21:53:08 INFO - PID 16145 | |1;ext.html;887.2635712358743;955.0544960489116;982.891881892992;983.292029738588;985.1380042462845;44186.33720494191;44617.77691111548;44809;44838.99999999992;44870.55129448704;42024.15951680965;42064.158716825725;42507.78746106265;42560.361594576105;42603.57396426035;7384.483086183969;7482.588457634828;7535.2464753524755;7554.055743032121;7558.773236802905;7333.9266607333775;7433;7441.218672039412;7444.069491313586;7444.664990075433;7990.800229994267;8139.226773456512;8139.715109971152;8141.959290203541;8158.714444994426;8052.355811535063;8109.391795615353;8123.187681231889;8155.225253600928;8212.671493140268;7753.263439973193;7917.485363451415;8093.595320234023;8099.595020248964;8106;40610;40731;40779.38830917539;40845.59154408448;40879.591204087876;3666.17511060012;3706.814659267026;3715.6841668458214;3717.739758216926;3732.64539868712;32869.50695739566;32967.3406531868;33067;33149.17127071819;33193;5506.394296627368;5526.447355264441;5553.278073850414;5572.86067848307;5583.6928968906695;220461;220628;221283;221702.89148554316;221838;47942;49449.25826112611;57212;57659.711701442066;57910.4208957905;60954.39045609576;60990.69504652448;61222.38777612167;61331;61380.38619613836;15149.091054536762;15388.153651549048;15411.768823467657;15443;15468.690626187414;12033.699157520958;12083.939580302042;12131.878681213075;12213.816792748115;12214.57248996281;16203.351865925231;16257.349706011864;16386;16387.34450621962;16414.343426262814;6164.065426395306;6177.054227918192;6261.9373806262265;6349.968250158812;6353.490371303309;1087.7117563845586;1091.6179337231906;1094.7810437912449;1096.0628662493452;1098.8846171152074;25491.23526294214;25723.356916076875;25774.87112564425;25827.35431614187;25967;1161.1407558406886;1200.4897918384652;1200.9399530023638;1203.0916657923387;1210.7941649919535;13427;13637.113587616774;13674;13827.654308642163;13922.86077139236;270260;271151;272244;272385;272704;59180.40819591835;59213.407865921654;59538;59754.40245597489;59896.401035989955;1465.4724299252262;1521.8249901261274;1526.3131590784192;1530.6249968757725;1541.7379045562282;24656.470693628355;24669.866751648548;24830.751692482845;24833.255002349957;24873.253802385232;38637.42043869288;39956.60043399645;42428;42437.363439547815;42461.78769106135;234936;235651;236064;236315;236414;34875;36093.819530902176;36196.276074477835;37825.05437364088;38648.42027369535;45660.77169614131;46520.7673961628;46639.06721865611;47036.7648161757;47622.76188619035;33716;33767.83116084404;34247.82876085703;34265.143371415914;34334.313313734085;34030.82984585061;34148.31703365968;34177.82911085428;34476.13809654779;35061.29877402489;38921.41617875677;39855.60144398635;39874;40134.397984030846;40212.3968140484;32494.512582311756;33014.83492582522;33276.66723332833;33533.32933341368;33988.32023359469;25056.37359066038;25249.242522724348;25345;26015.609765853147;26072.478550428506 21:53:08 INFO - PID 16145 | |2;jquery.html;579.898517759392;587.1833084947839;591.3436085944601;594.860207851155;610.6183635227981;23572.410689732744;24372.634410483835;24410.023599056018;24414.38964025898;24438;25384.11155609554;26414.20757377282;26735.33161670959;27000.729992700068;27040.72959270407;6835.14560679915;6839.931600683992;6847.794566163023;6852.074969879077;6865.4850886183485;6259.186305780242;6451.83870403239;6510.9023364649565;6827.249002609709;6920.411764999981;6434.0027295769;6442.806715798533;6455.096286519891;6458.838529036765;6467.644279564622;6422.454091402236;6430;6440.4525615322755;6444.484441244736;6445.1943507061615;6036.245469316335;6162.137300777895;6165.5992360496875;6168.44483996438;6177.62934223948;30767.538486922713;31312.21719457009;31360.37279254402;31403.84298078518;31496.37007259865;2276.1236923784295;2293.633018717014;2297.4600968772324;2302.3898666853297;2306.6770652108717;20001.1999520019;20639;21472.677909831364;21550.461238469008;21569.892150539305;2470.2218801077784;2485.614729716897;2534.6704928359195;2581.70310414301;2589.2102908612865;141398.2930085343;142771.2861435686;147817;149603.25198374048;150913.24543377323;15847.762283565755;15873.682526349408;16129.274182661808;16475.752863707054;16520;25168.49663006766;25361.112361067273;25425.491490170094;25448.491030179663;25525;9968.102870741523;10056.59773609062;10129.493525323704;10270.845937310947;10318.587256509656;9136.08639136081;9153.22197613197;9165.81668366629;9198;9204.40171388871;9706.466144362128;9723.41659500418;9745.171660408803;9775.266854985905;9868.555914983843;2694.9730502695115;2754.7520723135012;2809.881032054418;2851.7148285171315;2916.2709322669334;1015.2334987084704;1020.739711373595;1039.5270152080784;1041.2242879055002;1049.6536143072767;21674.783252167592;22059.007344669528;22089.116435342406;22131.889340553193;22543.887280563493;1108.6563165418745;1111.1000089927186;1124.5108377855659;1125.6679279612533;1128.3342827731515;11829.171957963032;12078.27530348182;12137.393130343447;12140;12158.392080395945;586212;590995;595744;595796;601201;117670.41164794122;120703;121931;122131.38934305271;122502.38748806198;1208.1663652080038;1250.3748125937032;1288.3815768431205;1315.5132600937523;1328.5615746803533;23260;23359.065637374315;23481.06075757019;23573.057077716698;23632.763672363057;63033.369666304585;63415.682921585096;63460.68269658622;66089;66102;81538;81700.18299817163;82327.5883620602;83777;83880;15491.84508154949;15790.684186315979;15805.209739513208;15857.920710396374;15925.8407415929;24641.137560185307;24814.37964050913;24920.875395622905;25038.37404064913;25310.620340695274;19616.313429029917;20090.39728808138;20418.69371959392;20523.384298471068;20653.69019464679;16931.899426537235;17003.574910627332;18234.179461924512;18298;18398.08009599488;20381.286654967003;20808.89595552073;20831.270905518235;20934.685979710623;20948.1620735175;15491.91556591073;15526.456574019856;15636.530904072895;15659.451919182773;15659.92170039188;19817.702734458708;20040.298589549297;20080.096395662524;20109.29617463382;20277.188912443336 21:53:08 INFO - PID 16145 | |3;mootools.html;1387.2508845223579;1453.280626090085;1456.235476374903;1458.139697578429;1465.201465201465;16485.670286594275;17215.13924303783;17330;17342.739858902125;17360.30558777649;16872.578185545368;16992.660146797087;17023.319067237328;17051.232694528746;17079.060651664153;2736.343277613373;2865.0258911969927;2865.4555634429494;2866.4553734790325;2866.7993240473174;2809.0730059080456;2887.537993920973;2887.768978481727;2891.8120322178993;2892.175729916974;2749.4501099780023;2797.342624483245;2808.199663096018;2809.12916995732;2810.339570201001;2708.079253053961;2734.8359098454157;2746.3134216445887;2747.587861820723;2748.395353022332;2595.065776320523;2645.3386653336665;2651.4166883285648;2656.375751698349;2662.480816240834;16219.91890040554;16281.674366512721;16446.424375146933;16452.588685282844;16457.588560285967;8168.264856162974;8482.83034339316;8483.618237179342;8518.829623407497;8533.530655813927;5339.11904535755;5455.890882182373;5642;5677.290338707661;5781.075027995501;2039.4187656517822;2064.3290930447515;2078.896055197249;2135.209972310255;2149.602323570129;27629.30926726828;28345.291367715767;29887.402251954838;30530.84734576335;30793.692063079307;7759.379249660014;7885.44801863864;7913.287804097658;8071.4753541019645;8072.354211663052;23061;23063;23091.653625195635;23120.53758924812;23121.53756924852;8479.364047696448;8577.356698247657;9016.459012459274;9032.954835225913;9037.68368107113;7438.479306448497;7801.726939557088;7830.177831327743;7846.097698764601;7855.489393189425;6035.728392222272;6125.479334256549;6132.816015519542;6215.502759779297;6228.750849966042;1859.9256029758658;1873.175802646831;1884.9528761781064;1899.1833511590148;1911.6367890100837;948.0708905272871;969.3602222533094;970.8932017478072;974.0600320690568;985.103555764251;9050.683226087056;9222.907770922206;9286.164245217962;9296.72109836706;9490.572924218426;772.3705180278056;773.1418125880268;792.2354927494995;794.3605397654828;796.5459687977797;5089.796408143633;5130.4100028497205;5152.278680984665;5197.766100525486;5254.579633629301;24165.275041748777;24822;25427.11005114812;25470;25791.871040644677;24230.394240144138;24890.875545622155;24951;25102.874485627453;25506.107286244893;9935.80128397428;10350.585976560853;10626.14990800734;11818.172727908965;12099.818502722466;9899.950500247453;9917.702468925943;9945.005499450286;10029.899701003189;10079.395236285847;21097.89451052735;21567;21701.782982169978;21722.456938576663;22056.88971555132;22509.77490225142;22591.43521411912;22777.31668049961;22893.313200604007;22983.770162298162;12704.618861434172;13042.739145217232;13166.210027398387;13171.67070823237;13178.538751143664;15552.144632045347;15559.844401556293;15570.844291557392;15688.764668529753;15700.842991569938;12444.253344799341;12495.437705303102;12788.232706037668;12800.359982000677;12927.806082908575;11703.648890533297;11895.583654572049;12151;12226.755464890475;12285.75428491443;11035.889641103486;11202.327860328407;11204.383758893338;11218.214724969173;11242.718932026764;7601;7647.992651537255;7673.577953212627;7741.535507869546;7747.767566973;7570.3943684504;7575.772726818204;7623.542587444771;7743.574103424366;7762.650680719494 21:53:08 INFO - PID 16145 | |4;prototype.html;537.6209772110661;540.308405241291;567.4552429667519;569.4334137533156;582.8717682109934;6135.637779454909;6168.4140006699345;6168.470926919964;6176.413240742134;6226.533010024244;6052.788152414666;6074.817755467343;6095.603785753923;6097.57316987811;6117.2965109012475;5009.724465154433;5013.248012798092;5022.347094877661;5074.264231686403;5074.619403544731;5005.524475174852;5020.322256495381;5026.246063090547;5027.245913113025;5041.1682072458;4913.852584422473;4934.753262336887;5067.695938243699;5096.362954630671;5112;5046.9747651261505;5061.544460998528;5069.0115427491655;5108.438071812097;5136.563392111675;4691.413573303337;4735.644826638016;4788.090262850083;4794.496577859344;4805.639577031737;6031.125486804389;6040.395960403968;6052.4552790248645;6055;6069.726862291208;6000.8499787505225;6001.789937352215;6009.308929473123;6066.181065556138;6077.6353418795015;6570.901436478457;6608.339166083401;6627.867442651168;6634.938409854401;6657.76697815579;5319.441458646825;5382.273393091921;5384.67691938481;5395.757190926418;5412.323459567554;6615.503837212228;6644.700988455531;6772.932270677329;6835.931640683629;6835.965820170867;5486.807961721321;5525.254090697785;5534.972325138348;5577.609567330248;5596.608237423423;5572.944270557324;5573.526250268692;5574.9442505574425;5611.719414029282;5657.547396208293;5955.838611470808;6006.639601623917;6007.579469437097;6047.0627052806;6051.546134039877;6533.575317604341;6563.538672997626;6606.207255129415;6623.205215374186;6639.3692599203;1930.903454827253;1940.8156225158586;1950.2740075033414;1977.5451646121473;1981.5838673878648;1413.6465883529117;1463.6194589406618;1488.9255537223096;1493.3802471974009;1508.954731358039;5972.492338151219;5974.790882319098;5982.461578457873;6022.976094063932;6047.455728984412;6496.913965866176;6518.217813862367;6536.640484773383;6555.311692272243;6567.1462709848365;5958.344582096052;6024.849378765566;6053.636781793107;6059.878802423927;6062.120992456069;3434.883662809597;3468.6531346865113;3480.89557313281;3485.5294535237927;3506.2111025019676;6862.4853136015;6886.276940921131;6911.343422374866;6933.2026816915695;6953.756618518328;6792.150981127359;6816.693248803816;6850.554713943578;6852.931470685229;6860.416864566568;6849.589024658537;6857.245702972768;6902.309769023058;6912.758053468205;6923.6192009439965;6401.071844582416;6482.254540727688;6508.8047358579315;6541.738330466728;6578.506612004215;6286.622802631857;6403.167588213502;6509.381608747161;6542.34576542342;6613.900791488035;6790.558613690095;6854.5201835873;6854.725810967506;6914.239433662394;6934.791956241321;5547.861303467284;5575.275214222287;5593.685483911197;5601.579881508822;5615.719214039364;6401.935980640134;6436.324185960594;6512.772052978313;6603.669816509059;6692.631905245258;6252.656103914328;6337.65142917144;6339.683015849281;6383.616982981036;6385.87228255423;6282.277538083179;6315.842103947438;6349.746010159727;6409.9359006411205;6417.93582064192;6246.625202487865;6325.177726895658;6343.3339499351905;6379.87240255183;6380.617162970237;6446.678430921556;6475.870482590228;6486.2216534016225;6499.3175716549085;6501.349865013461;6219.315875253809;6228.5951413158;6230.906536402048;6238.845813524513;6259.618267212878 21:53:08 INFO - PID 16145 | |5;yui.html;979.6081567373054;983.7835676151246;1008.1229330482477;1011.307254530647;1015.786684796193;20745.792542074592;21135.682964755502;21324.57350852982;21366.252181173662;21369.893150534244;18874.33939812107;19149.234030638756;19945;19951.501212469695;20076.196952121896;1068.7595291059508;1106.5241945963232;1108.2685427617773;1110.944452777362;1111.9610813621525;1101.9063379612703;1103.7075175078571;1103.7406209540752;1104.13877175803;1104.4864138175747;1133.6315697398338;1172.8533933258343;1175.1304035014114;1176.9882301176965;1178.5403692559908;1169.0355456748175;1170.1165619956962;1170.6253998720413;1170.6488053583976;1171.2796630072487;826.5247482697473;834.0991728932738;835.1481488881307;836.3434703757582;837.2883049407955;18414.815851841446;18573.257069717194;18604.069796510255;18606.069696515122;19614.215431382727;23182.76817231823;23355.88322058379;23771.762282377127;23784.643230351558;23859.403514912094;19367.903160484108;19467.318643847397;19593.118309676098;19676.311329103413;19711.11299991504;3597.8380972856285;3888.786116763577;3933.1347103637154;3943.3296339622048;3947.032976920644;133928;158181.2090939538;158783.23650290509;159686;160341;18730;18977.905110474636;19209.423717288504;19249.61500769977;19338;29342.413151736844;29660.851695741814;29682.406351873273;29896.55155172674;30014.84992575023;9078.182963533181;9089.31830112731;9102.180803727697;9118.133777291147;9128.58921348541;4164.895877603023;4173.853915113017;4177.122804211089;4213.4522512073845;4216.7680777557525;6037.305709843336;6149.938500615026;6165.445109940038;6170.56806023583;6187.071939209065;1254.7866862633375;1293.043148070421;1302.9153105048142;1304.928228947398;1305.11252348404;734.1117248129716;739.4860571902584;747.4170147285126;758.1016495452795;762.5500954436798;12928;13010.284434356012;13671.248081355621;13911.364563739775;13956.162630242217;738.811603041221;743.6913680822506;749.4903465643415;754.6792613139394;756.4137793210306;6308.211473565804;6416.679166041679;6507.9023814642815;6512.381323774234;6516.804495865132;141276.2936185333;141991;143152;145651;146697;128521.42957140805;129712;132257;132457.33771331082;134236;110717;110797.44601276942;110938;113210;113921;12178.695532611755;12465.688357791129;12528.812067818808;12579.937100314806;12636.747265054464;53682.463175367746;53707.194392083366;53819.46180538301;53897.730511347196;55570.444295556525;67445;68477;68507.65746171237;69665;71280;16021.118838463997;16340.754888676916;16459.34162633481;16466.09436480957;16577.17114144264;19243.51891202731;19266.422007339803;19311.130999105357;19415.611687765882;19450.124744386252;17318.82681173172;17586.56033599119;17611;17684.46946591604;17708.734368984216;16280.837191627932;16312.51062468128;16404.835951640332;16456.177191140636;16595.585110371856;17798.37705680295;18087.18607662632;18126.818731812513;18242.45272641823;18278.908605456887;12932.353382330657;13127.737445251232;13264.33678316061;13373.598792036255;13439.46242150303;13728.862711372758;13764.449422023408;13902.791458127935;13942.163470191821;13989.580312590639 21:53:08 INFO - PID 16145 | __end_tp_report 21:53:08 INFO - PID 16145 | __start_cc_report 21:53:08 INFO - PID 16145 | _x_x_mozilla_cycle_collect,262 21:53:08 INFO - PID 16145 | __end_cc_report 21:53:08 INFO - PID 16145 | __startTimestamp1505623988498__endTimestamp 21:53:08 INFO - PID 16145 | 21:53:08 INFO - PID 16145 | ------- Summary: start ------- 21:53:08 INFO - PID 16145 | Number of tests: 6 21:53:08 INFO - PID 16145 | 21:53:08 INFO - PID 16145 | [#0] dojo.html Cycles:165 Average:6217.71 Median:6456.13 stddev:743.75 (11.5%) stddev-sans-first:723.10 21:53:08 INFO - PID 16145 | Values: 3881.8 3892.6 3894.8 3895.1 3917.0 6076.9 6079.0 6174.7 6196.3 6276.1 6190.9 6233.6 6324.5 6328.9 6340.0 5512.2 5525.1 5628.2 5636.6 5672.9 5339.9 5603.6 5630.0 5666.4 5692.4 5469.8 5522.6 5548.4 5597.7 5609.4 5542.2 5560.9 5575.8 5582.9 5583.3 5489.7 5566.9 5603.8 5643.7 5647.4 6112.3 6147.6 6228.2 6238.8 6267.5 6593.2 6694.4 6714.9 6768.5 6782.3 6765.9 6777.2 6846.4 6859.2 6887.9 6228.0 6239.5 6291.1 6321.9 6328.3 6982.1 6986.2 7000.1 7011.8 7011.9 6680.8 6692.9 6745.7 6774.5 6788.9 6685.8 6769.8 6792.1 6802.6 6880.6 6683.0 6683.6 6686.2 6715.9 6759.0 6705.2 6711.9 6793.5 6797.0 6805.5 4864.4 4867.0 4923.0 4929.5 4946.7 4419.6 4441.2 4460.3 4539.3 4568.8 6204.9 6231.5 6234.9 6235.1 6273.3 6663.2 6667.3 6735.3 6748.6 6767.3 6116.8 6174.1 6202.2 6252.2 6268.0 5381.2 5474.1 5481.0 5493.3 5510.5 7033.5 7047.8 7094.9 7123.3 7133.8 6730.2 6734.6 6813.4 6817.5 6822.5 6873.0 6996.2 7008.8 7011.6 7013.8 6624.7 6672.7 6698.2 6711.9 6713.9 6753.8 6792.0 6891.5 6901.3 6905.2 6456.1 6516.1 6531.2 6640.8 6648.6 6506.8 6587.8 6590.9 6596.5 6604.5 6433.5 6437.8 6507.9 6525.9 6539.4 6502.7 6512.7 6535.6 6574.0 6576.1 6347.1 6379.6 6380.2 6399.4 6402.5 21:53:08 INFO - PID 16145 | 21:53:08 INFO - PID 16145 | [#1] ext.html Cycles:180 Average:42320.54 Median:3716.71 stddev:63449.82 (1707.1%) stddev-sans-first:63551.55 21:53:08 INFO - PID 16145 | Values: 887.3 955.1 982.9 983.3 985.1 44186.3 44617.8 44809.0 44839.0 44870.6 42024.2 42064.2 42507.8 42560.4 42603.6 7384.5 7482.6 7535.2 7554.1 7558.8 7333.9 7433.0 7441.2 7444.1 7444.7 7990.8 8139.2 8139.7 8142.0 8158.7 8052.4 8109.4 8123.2 8155.2 8212.7 7753.3 7917.5 8093.6 8099.6 8106.0 40610.0 40731.0 40779.4 40845.6 40879.6 3666.2 3706.8 3715.7 3717.7 3732.6 32869.5 32967.3 33067.0 33149.2 33193.0 5506.4 5526.4 5553.3 5572.9 5583.7 220461.0 220628.0 221283.0 221702.9 221838.0 47942.0 49449.3 57212.0 57659.7 57910.4 60954.4 60990.7 61222.4 61331.0 61380.4 15149.1 15388.2 15411.8 15443.0 15468.7 12033.7 12083.9 12131.9 12213.8 12214.6 16203.4 16257.3 16386.0 16387.3 16414.3 6164.1 6177.1 6261.9 6350.0 6353.5 1087.7 1091.6 1094.8 1096.1 1098.9 25491.2 25723.4 25774.9 25827.4 25967.0 1161.1 1200.5 1200.9 1203.1 1210.8 13427.0 13637.1 13674.0 13827.7 13922.9 270260.0 271151.0 272244.0 272385.0 272704.0 59180.4 59213.4 59538.0 59754.4 59896.4 1465.5 1521.8 1526.3 1530.6 1541.7 24656.5 24669.9 24830.8 24833.3 24873.3 38637.4 39956.6 42428.0 42437.4 42461.8 234936.0 235651.0 236064.0 236315.0 236414.0 34875.0 36093.8 36196.3 37825.1 38648.4 45660.8 46520.8 46639.1 47036.8 47622.8 33716.0 33767.8 34247.8 34265.1 34334.3 34030.8 34148.3 34177.8 34476.1 35061.3 38921.4 39855.6 39874.0 40134.4 40212.4 32494.5 33014.8 33276.7 33533.3 33988.3 25056.4 25249.2 25345.0 26015.6 26072.5 21:53:08 INFO - PID 16145 | 21:53:08 INFO - PID 16145 | [#2] jquery.html Cycles:180 Average:39422.37 Median:24391.33 stddev:99158.14 (406.5%) stddev-sans-first:99393.42 21:53:08 INFO - PID 16145 | Values: 579.9 587.2 591.3 594.9 610.6 23572.4 24372.6 24410.0 24414.4 24438.0 25384.1 26414.2 26735.3 27000.7 27040.7 6835.1 6839.9 6847.8 6852.1 6865.5 6259.2 6451.8 6510.9 6827.2 6920.4 6434.0 6442.8 6455.1 6458.8 6467.6 6422.5 6430.0 6440.5 6444.5 6445.2 6036.2 6162.1 6165.6 6168.4 6177.6 30767.5 31312.2 31360.4 31403.8 31496.4 2276.1 2293.6 2297.5 2302.4 2306.7 20001.2 20639.0 21472.7 21550.5 21569.9 2470.2 2485.6 2534.7 2581.7 2589.2 141398.3 142771.3 147817.0 149603.3 150913.2 15847.8 15873.7 16129.3 16475.8 16520.0 25168.5 25361.1 25425.5 25448.5 25525.0 9968.1 10056.6 10129.5 10270.8 10318.6 9136.1 9153.2 9165.8 9198.0 9204.4 9706.5 9723.4 9745.2 9775.3 9868.6 2695.0 2754.8 2809.9 2851.7 2916.3 1015.2 1020.7 1039.5 1041.2 1049.7 21674.8 22059.0 22089.1 22131.9 22543.9 1108.7 1111.1 1124.5 1125.7 1128.3 11829.2 12078.3 12137.4 12140.0 12158.4 586212.0 590995.0 595744.0 595796.0 601201.0 117670.4 120703.0 121931.0 122131.4 122502.4 1208.2 1250.4 1288.4 1315.5 1328.6 23260.0 23359.1 23481.1 23573.1 23632.8 63033.4 63415.7 63460.7 66089.0 66102.0 81538.0 81700.2 82327.6 83777.0 83880.0 15491.8 15790.7 15805.2 15857.9 15925.8 24641.1 24814.4 24920.9 25038.4 25310.6 19616.3 20090.4 20418.7 20523.4 20653.7 16931.9 17003.6 18234.2 18298.0 18398.1 20381.3 20808.9 20831.3 20934.7 20948.2 15491.9 15526.5 15636.5 15659.5 15659.9 19817.7 20040.3 20080.1 20109.3 20277.2 21:53:08 INFO - PID 16145 | 21:53:08 INFO - PID 16145 | [#3] mootools.html Cycles:180 Average:10515.58 Median:2685.28 stddev:7838.17 (291.9%) stddev-sans-first:7830.15 21:53:08 INFO - PID 16145 | Values: 1387.3 1453.3 1456.2 1458.1 1465.2 16485.7 17215.1 17330.0 17342.7 17360.3 16872.6 16992.7 17023.3 17051.2 17079.1 2736.3 2865.0 2865.5 2866.5 2866.8 2809.1 2887.5 2887.8 2891.8 2892.2 2749.5 2797.3 2808.2 2809.1 2810.3 2708.1 2734.8 2746.3 2747.6 2748.4 2595.1 2645.3 2651.4 2656.4 2662.5 16219.9 16281.7 16446.4 16452.6 16457.6 8168.3 8482.8 8483.6 8518.8 8533.5 5339.1 5455.9 5642.0 5677.3 5781.1 2039.4 2064.3 2078.9 2135.2 2149.6 27629.3 28345.3 29887.4 30530.8 30793.7 7759.4 7885.4 7913.3 8071.5 8072.4 23061.0 23063.0 23091.7 23120.5 23121.5 8479.4 8577.4 9016.5 9033.0 9037.7 7438.5 7801.7 7830.2 7846.1 7855.5 6035.7 6125.5 6132.8 6215.5 6228.8 1859.9 1873.2 1885.0 1899.2 1911.6 948.1 969.4 970.9 974.1 985.1 9050.7 9222.9 9286.2 9296.7 9490.6 772.4 773.1 792.2 794.4 796.5 5089.8 5130.4 5152.3 5197.8 5254.6 24165.3 24822.0 25427.1 25470.0 25791.9 24230.4 24890.9 24951.0 25102.9 25506.1 9935.8 10350.6 10626.1 11818.2 12099.8 9900.0 9917.7 9945.0 10029.9 10079.4 21097.9 21567.0 21701.8 21722.5 22056.9 22509.8 22591.4 22777.3 22893.3 22983.8 12704.6 13042.7 13166.2 13171.7 13178.5 15552.1 15559.8 15570.8 15688.8 15700.8 12444.3 12495.4 12788.2 12800.4 12927.8 11703.6 11895.6 12151.0 12226.8 12285.8 11035.9 11202.3 11204.4 11218.2 11242.7 7601.0 7648.0 7673.6 7741.5 7747.8 7570.4 7575.8 7623.5 7743.6 7762.7 21:53:08 INFO - PID 16145 | 21:53:08 INFO - PID 16145 | [#4] prototype.html Cycles:180 Average:5614.99 Median:6076.23 stddev:1492.58 (24.6%) stddev-sans-first:1447.30 21:53:08 INFO - PID 16145 | Values: 537.6 540.3 567.5 569.4 582.9 6135.6 6168.4 6168.5 6176.4 6226.5 6052.8 6074.8 6095.6 6097.6 6117.3 5009.7 5013.2 5022.3 5074.3 5074.6 5005.5 5020.3 5026.2 5027.2 5041.2 4913.9 4934.8 5067.7 5096.4 5112.0 5047.0 5061.5 5069.0 5108.4 5136.6 4691.4 4735.6 4788.1 4794.5 4805.6 6031.1 6040.4 6052.5 6055.0 6069.7 6000.8 6001.8 6009.3 6066.2 6077.6 6570.9 6608.3 6627.9 6634.9 6657.8 5319.4 5382.3 5384.7 5395.8 5412.3 6615.5 6644.7 6772.9 6835.9 6836.0 5486.8 5525.3 5535.0 5577.6 5596.6 5572.9 5573.5 5574.9 5611.7 5657.5 5955.8 6006.6 6007.6 6047.1 6051.5 6533.6 6563.5 6606.2 6623.2 6639.4 1930.9 1940.8 1950.3 1977.5 1981.6 1413.6 1463.6 1488.9 1493.4 1509.0 5972.5 5974.8 5982.5 6023.0 6047.5 6496.9 6518.2 6536.6 6555.3 6567.1 5958.3 6024.8 6053.6 6059.9 6062.1 3434.9 3468.7 3480.9 3485.5 3506.2 6862.5 6886.3 6911.3 6933.2 6953.8 6792.2 6816.7 6850.6 6852.9 6860.4 6849.6 6857.2 6902.3 6912.8 6923.6 6401.1 6482.3 6508.8 6541.7 6578.5 6286.6 6403.2 6509.4 6542.3 6613.9 6790.6 6854.5 6854.7 6914.2 6934.8 5547.9 5575.3 5593.7 5601.6 5615.7 6401.9 6436.3 6512.8 6603.7 6692.6 6252.7 6337.7 6339.7 6383.6 6385.9 6282.3 6315.8 6349.7 6409.9 6417.9 6246.6 6325.2 6343.3 6379.9 6380.6 6446.7 6475.9 6486.2 6499.3 6501.3 6219.3 6228.6 6230.9 6238.8 6259.6 21:53:08 INFO - PID 16145 | 21:53:08 INFO - PID 16145 | [#5] yui.html Cycles:180 Average:27661.54 Median:18605.07 stddev:41055.17 (220.7%) stddev-sans-first:41121.46 21:53:08 INFO - PID 16145 | Values: 979.6 983.8 1008.1 1011.3 1015.8 20745.8 21135.7 21324.6 21366.3 21369.9 18874.3 19149.2 19945.0 19951.5 20076.2 1068.8 1106.5 1108.3 1110.9 1112.0 1101.9 1103.7 1103.7 1104.1 1104.5 1133.6 1172.9 1175.1 1177.0 1178.5 1169.0 1170.1 1170.6 1170.6 1171.3 826.5 834.1 835.1 836.3 837.3 18414.8 18573.3 18604.1 18606.1 19614.2 23182.8 23355.9 23771.8 23784.6 23859.4 19367.9 19467.3 19593.1 19676.3 19711.1 3597.8 3888.8 3933.1 3943.3 3947.0 133928.0 158181.2 158783.2 159686.0 160341.0 18730.0 18977.9 19209.4 19249.6 19338.0 29342.4 29660.9 29682.4 29896.6 30014.8 9078.2 9089.3 9102.2 9118.1 9128.6 4164.9 4173.9 4177.1 4213.5 4216.8 6037.3 6149.9 6165.4 6170.6 6187.1 1254.8 1293.0 1302.9 1304.9 1305.1 734.1 739.5 747.4 758.1 762.6 12928.0 13010.3 13671.2 13911.4 13956.2 738.8 743.7 749.5 754.7 756.4 6308.2 6416.7 6507.9 6512.4 6516.8 141276.3 141991.0 143152.0 145651.0 146697.0 128521.4 129712.0 132257.0 132457.3 134236.0 110717.0 110797.4 110938.0 113210.0 113921.0 12178.7 12465.7 12528.8 12579.9 12636.7 53682.5 53707.2 53819.5 53897.7 55570.4 67445.0 68477.0 68507.7 69665.0 71280.0 16021.1 16340.8 16459.3 16466.1 16577.2 19243.5 19266.4 19311.1 19415.6 19450.1 17318.8 17586.6 17611.0 17684.5 17708.7 16280.8 16312.5 16404.8 16456.2 16595.6 17798.4 18087.2 18126.8 18242.5 18278.9 12932.4 13127.7 13264.3 13373.6 13439.5 13728.9 13764.4 13902.8 13942.2 13989.6 21:53:08 INFO - PID 16145 | -------- Summary: end -------- 21:53:08 INFO - PID 16145 | 21:53:09 INFO - TEST-INFO | 16145: exit 0 21:53:09 INFO - TEST-OK | dromaeo_css | took 1108947ms 21:53:09 INFO - TEST-START | kraken 21:53:09 INFO - Initialising browser for kraken test... 21:53:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42104/getInfo.html -profile /tmp/tmpBsYsP6/profile 21:53:09 INFO - TEST-INFO | started process 16527 (/builds/slave/test/build/application/firefox/firefox http://localhost:42104/getInfo.html) 21:53:15 INFO - TEST-INFO | 16527: exit 0 21:53:15 INFO - Browser initialized. 21:53:15 INFO - Running cycle 1/1 for kraken test... 21:53:15 INFO - Using env: {'DISPLAY': ':0', 21:53:15 INFO - 'HOME': '/home/cltbld', 21:53:15 INFO - 'JSGC_DISABLE_POISONING': '1', 21:53:15 INFO - 'LANG': 'en_US.UTF-8', 21:53:15 INFO - 'LANGUAGE': 'en_US:en', 21:53:15 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 21:53:15 INFO - 'LOGNAME': 'cltbld', 21:53:15 INFO - 'MAIL': '/var/mail/cltbld', 21:53:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:53:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:53:15 INFO - 'MOZ_CRASHREPORTER': '1', 21:53:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:53:15 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 21:53:15 INFO - 'MOZ_NO_REMOTE': '1', 21:53:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:53:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:53:15 INFO - 'NO_EM_RESTART': '1', 21:53:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:53:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:53:15 INFO - 'PWD': '/builds/slave/test', 21:53:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:53:15 INFO - 'RUST_BACKTRACE': 'full', 21:53:15 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 21:53:15 INFO - 'SHELL': '/bin/bash', 21:53:15 INFO - 'SHLVL': '1', 21:53:15 INFO - 'TERM': 'linux', 21:53:15 INFO - 'TMOUT': '86400', 21:53:15 INFO - 'USER': 'cltbld', 21:53:15 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545', 21:53:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:53:15 INFO - '_': '/tools/buildbot/bin/python'} 21:53:15 INFO - TEST-INFO | started process 16765 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBsYsP6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 21:53:15 INFO - PID 16765 | 21:53:15 INFO - PID 16765 | (/builds/slave/test/build/application/firefox/firefox:16814): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 21:53:15 INFO - PID 16765 | 21:53:26 INFO - PID 16765 | RSS: Main: 144760832 21:53:26 INFO - PID 16765 | 21:53:28 INFO - PID 16765 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42104/tests/kraken/driver.html?testName=audio-beat-detection) 21:53:29 INFO - PID 16765 | RSS: Main: 151027712 21:53:29 INFO - PID 16765 | 21:53:32 INFO - PID 16765 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42104/tests/kraken/driver.html?testName=audio-dft) 21:53:32 INFO - PID 16765 | RSS: Main: 151171072 21:53:32 INFO - PID 16765 | 21:53:35 INFO - PID 16765 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42104/tests/kraken/driver.html?testName=audio-fft) 21:53:36 INFO - PID 16765 | RSS: Main: 146161664 21:53:36 INFO - PID 16765 | 21:53:38 INFO - PID 16765 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42104/tests/kraken/driver.html?testName=audio-oscillator) 21:53:39 INFO - PID 16765 | RSS: Main: 147566592 21:53:39 INFO - PID 16765 | 21:53:41 INFO - PID 16765 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42104/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:53:41 INFO - PID 16765 | RSS: Main: 147263488 21:53:41 INFO - PID 16765 | 21:53:44 INFO - PID 16765 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42104/tests/kraken/driver.html?testName=imaging-darkroom) 21:53:45 INFO - PID 16765 | RSS: Main: 147447808 21:53:45 INFO - PID 16765 | 21:53:48 INFO - PID 16765 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42104/tests/kraken/driver.html?testName=imaging-desaturate) 21:53:49 INFO - PID 16765 | RSS: Main: 148168704 21:53:49 INFO - PID 16765 | 21:53:52 INFO - PID 16765 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42104/tests/kraken/driver.html?testName=json-parse-financial) 21:53:53 INFO - PID 16765 | RSS: Main: 149864448 21:53:53 INFO - PID 16765 | 21:53:54 INFO - PID 16765 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42104/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:53:55 INFO - PID 16765 | RSS: Main: 149553152 21:53:55 INFO - PID 16765 | 21:53:56 INFO - PID 16765 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42104/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:53:57 INFO - PID 16765 | RSS: Main: 149909504 21:53:57 INFO - PID 16765 | 21:53:59 INFO - PID 16765 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42104/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:54:00 INFO - PID 16765 | RSS: Main: 149848064 21:54:00 INFO - PID 16765 | 21:54:02 INFO - PID 16765 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42104/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:54:03 INFO - PID 16765 | RSS: Main: 149925888 21:54:03 INFO - PID 16765 | 21:54:05 INFO - PID 16765 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42104/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:54:06 INFO - PID 16765 | RSS: Main: 150274048 21:54:06 INFO - PID 16765 | 21:54:08 INFO - PID 16765 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42104/tests/kraken/driver.html?testName=ai-astar) 21:54:08 INFO - PID 16765 | RSS: Main: 152018944 21:54:08 INFO - PID 16765 | 21:54:08 INFO - PID 16765 | __start_tp_report 21:54:08 INFO - PID 16765 | _x_x_mozilla_page_load 21:54:08 INFO - PID 16765 | _x_x_mozilla_page_load_details 21:54:08 INFO - PID 16765 | |i|pagename|runs| 21:54:08 INFO - PID 16765 | |0;ai-astar;105;105;104;106;105;110;107;105;106;106 21:54:08 INFO - PID 16765 | |1;audio-beat-detection;115;116;111;114;114;113;142;112;115;113 21:54:08 INFO - PID 16765 | |2;audio-dft;160;163;163;165;161;161;161;162;162;162 21:54:08 INFO - PID 16765 | |3;audio-fft;75;76;74;73;73;73;73;73;73;76 21:54:08 INFO - PID 16765 | |4;audio-oscillator;79;78;78;77;78;77;77;78;77;78 21:54:08 INFO - PID 16765 | |5;imaging-gaussian-blur;113;114;113;114;113;115;116;118;113;113 21:54:08 INFO - PID 16765 | |6;imaging-darkroom;149;150;153;150;150;150;150;152;151;149 21:54:08 INFO - PID 16765 | |7;imaging-desaturate;94;95;94;93;93;94;94;99;98;97 21:54:08 INFO - PID 16765 | |8;json-parse-financial;45;45;45;50;45;45;46;43;46;43 21:54:08 INFO - PID 16765 | |9;json-stringify-tinderbox;38;39;38;38;39;37;37;38;38;44 21:54:08 INFO - PID 16765 | |10;stanford-crypto-aes;71;77;71;75;72;73;71;71;71;74 21:54:08 INFO - PID 16765 | |11;stanford-crypto-ccm;109;104;102;105;112;106;110;105;116;107 21:54:08 INFO - PID 16765 | |12;stanford-crypto-pbkdf2;157;155;153;158;153;153;159;168;156;160 21:54:08 INFO - PID 16765 | |13;stanford-crypto-sha256-iterative;62;59;58;58;66;62;61;60;60;60 21:54:08 INFO - PID 16765 | __end_tp_report 21:54:08 INFO - PID 16765 | __start_cc_report 21:54:08 INFO - PID 16765 | _x_x_mozilla_cycle_collect,712 21:54:08 INFO - PID 16765 | __end_cc_report 21:54:08 INFO - PID 16765 | __startTimestamp1505624048458__endTimestamp 21:54:08 INFO - PID 16765 | 21:54:08 INFO - PID 16765 | ------- Summary: start ------- 21:54:08 INFO - PID 16765 | Number of tests: 14 21:54:08 INFO - PID 16765 | 21:54:08 INFO - PID 16765 | [#0] ai-astar Cycles:10 Average:105.90 Median:106.00 stddev:1.66 (1.6%) stddev-sans-first:1.73 21:54:08 INFO - PID 16765 | Values: 105.0 105.0 104.0 106.0 105.0 110.0 107.0 105.0 106.0 106.0 21:54:08 INFO - PID 16765 | 21:54:08 INFO - PID 16765 | [#1] audio-beat-detection Cycles:10 Average:116.50 Median:114.50 stddev:9.08 (7.9%) stddev-sans-first:9.62 21:54:08 INFO - PID 16765 | Values: 115.0 116.0 111.0 114.0 114.0 113.0 142.0 112.0 115.0 113.0 21:54:08 INFO - PID 16765 | 21:54:08 INFO - PID 16765 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.41 (0.9%) stddev-sans-first:1.30 21:54:08 INFO - PID 16765 | Values: 160.0 163.0 163.0 165.0 161.0 161.0 161.0 162.0 162.0 162.0 21:54:08 INFO - PID 16765 | 21:54:08 INFO - PID 16765 | [#3] audio-fft Cycles:10 Average:73.90 Median:73.50 stddev:1.29 (1.8%) stddev-sans-first:1.30 21:54:08 INFO - PID 16765 | Values: 75.0 76.0 74.0 73.0 73.0 73.0 73.0 73.0 73.0 76.0 21:54:08 INFO - PID 16765 | 21:54:08 INFO - PID 16765 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:78.00 stddev:0.67 (0.9%) stddev-sans-first:0.53 21:54:08 INFO - PID 16765 | Values: 79.0 78.0 78.0 77.0 78.0 77.0 77.0 78.0 77.0 78.0 21:54:08 INFO - PID 16765 | 21:54:08 INFO - PID 16765 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:1.69 (1.5%) stddev-sans-first:1.73 21:54:08 INFO - PID 16765 | Values: 113.0 114.0 113.0 114.0 113.0 115.0 116.0 118.0 113.0 113.0 21:54:08 INFO - PID 16765 | 21:54:08 INFO - PID 16765 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.00 stddev:1.26 (0.8%) stddev-sans-first:1.24 21:54:08 INFO - PID 16765 | Values: 149.0 150.0 153.0 150.0 150.0 150.0 150.0 152.0 151.0 149.0 21:54:08 INFO - PID 16765 | 21:54:08 INFO - PID 16765 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:94.50 stddev:2.13 (2.3%) stddev-sans-first:2.22 21:54:08 INFO - PID 16765 | Values: 94.0 95.0 94.0 93.0 93.0 94.0 94.0 99.0 98.0 97.0 21:54:08 INFO - PID 16765 | 21:54:08 INFO - PID 16765 | [#8] json-parse-financial Cycles:10 Average:45.30 Median:45.00 stddev:1.95 (4.3%) stddev-sans-first:2.06 21:54:08 INFO - PID 16765 | Values: 45.0 45.0 45.0 50.0 45.0 45.0 46.0 43.0 46.0 43.0 21:54:08 INFO - PID 16765 | 21:54:08 INFO - PID 16765 | [#9] json-stringify-tinderbox Cycles:10 Average:38.60 Median:38.00 stddev:2.01 (5.3%) stddev-sans-first:2.12 21:54:08 INFO - PID 16765 | Values: 38.0 39.0 38.0 38.0 39.0 37.0 37.0 38.0 38.0 44.0 21:54:08 INFO - PID 16765 | 21:54:08 INFO - PID 16765 | [#10] stanford-crypto-aes Cycles:10 Average:72.60 Median:72.50 stddev:2.12 (2.9%) stddev-sans-first:2.17 21:54:08 INFO - PID 16765 | Values: 71.0 77.0 71.0 75.0 72.0 73.0 71.0 71.0 71.0 74.0 21:54:08 INFO - PID 16765 | 21:54:08 INFO - PID 16765 | [#11] stanford-crypto-ccm Cycles:10 Average:107.60 Median:108.00 stddev:4.20 (3.9%) stddev-sans-first:4.42 21:54:08 INFO - PID 16765 | Values: 109.0 104.0 102.0 105.0 112.0 106.0 110.0 105.0 116.0 107.0 21:54:08 INFO - PID 16765 | 21:54:08 INFO - PID 16765 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.20 Median:157.50 stddev:4.57 (2.9%) stddev-sans-first:4.84 21:54:08 INFO - PID 16765 | Values: 157.0 155.0 153.0 158.0 153.0 153.0 159.0 168.0 156.0 160.0 21:54:08 INFO - PID 16765 | 21:54:08 INFO - PID 16765 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.60 Median:60.50 stddev:2.37 (3.9%) stddev-sans-first:2.46 21:54:08 INFO - PID 16765 | Values: 62.0 59.0 58.0 58.0 66.0 62.0 61.0 60.0 60.0 60.0 21:54:08 INFO - PID 16765 | -------- Summary: end -------- 21:54:08 INFO - PID 16765 | 21:54:08 INFO - PID 16765 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 21:54:08 INFO - TEST-INFO | 16765: exit 0 21:54:09 INFO - TEST-OK | kraken | took 59866ms 21:54:09 INFO - SUITE-END | took 1168s 21:54:09 INFO - Completed test suite (00:19:28) 21:54:09 INFO - javascript benchmark 21:54:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9054.225993256152, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3881.825317860696, 3892.5718171001186, 3894.844206231751, 3895.0846551060476, 3916.999999999998, 6076.878462430749, 6079.0, 6174.722137503812, 6196.318404975449, 6276.05859121132, 6190.938090619093, 6233.625982441056, 6324.525660575452, 6328.873422531547, 6340.0489926511045, 5512.200730894018, 5525.060739674245, 5628.183913332565, 5636.633618814764, 5672.943270567303, 5339.946600534003, 5603.551715862721, 5629.9866024115645, 5666.376698563155, 5692.402297758717, 5469.808556700536, 5522.641028333145, 5548.361938377098, 5597.720113994284, 5609.439056094398, 5542.224088627595, 5560.944390556124, 5575.832725018256, 5582.944170558324, 5583.302087239095, 5489.725513724337, 5566.944330556683, 5603.831885043455, 5643.661380317194, 5647.43525647436, 6112.266528016667, 6147.631142131441, 6228.159198508234, 6238.844028899269, 6267.4672652824565, 6593.20881494219, 6694.364035416627, 6714.932850671479, 6768.492363072789, 6782.321767823228, 6765.898511522331, 6777.186737591472, 6846.383825455683, 6859.2454829969165, 6887.896681549781, 6227.96886015567, 6239.532035097386, 6291.1192433059405, 6321.905171422432, 6328.303886572473, 6982.0923279974295, 6986.231514533397, 7000.124984376953, 7011.754588589375, 7011.89482157768, 6680.799576012728, 6692.86614267712, 6745.696443660047, 6774.45804335652, 6788.898166527506, 6685.832854178587, 6769.796906092825, 6792.117024786845, 6802.591844489347, 6880.552764070319, 6682.966585167043, 6683.565568238147, 6686.1642294713165, 6715.93284067153, 6759.0, 6705.228898676617, 6711.899321510181, 6793.490488213404, 6797.014432907201, 6805.489588280899, 4864.36763220779, 4866.9513304867205, 4923.040007198562, 4929.531694489017, 4946.727929963887, 4419.602235798729, 4441.244988351988, 4460.330950357407, 4539.251023581138, 4568.840090596813, 6204.875902482016, 6231.501479881598, 6234.906476402857, 6235.064740288903, 6273.278572964167, 6663.167104111986, 6667.33326667339, 6735.326467353226, 6748.561343512656, 6767.255601883789, 6116.847078822976, 6174.135621013062, 6202.193714817045, 6252.187215661935, 6268.0, 5381.246625472437, 5474.09677403224, 5480.972595136999, 5493.340799104053, 5510.504054635102, 7033.542819716702, 7047.788566343018, 7094.858102838018, 7123.25205853378, 7133.750318738819, 6730.192376914802, 6734.595924244561, 6813.4208592270215, 6817.522773405814, 6822.522423430312, 6873.0377747116445, 6996.230414654282, 7008.7546935857, 7011.579305241702, 7013.754518591825, 6624.701888414937, 6672.666366681744, 6698.196216454056, 6711.865762684816, 6713.932860671526, 6753.763618273337, 6792.0, 6891.483138764713, 6901.275366086488, 6905.1713794342995, 6456.128422663069, 6516.120323756232, 6531.248906375828, 6640.767573134917, 6648.601083934979, 6506.804795856132, 6587.769428069994, 6590.90113648286, 6596.472282217507, 6604.471642268511, 6433.485321174388, 6437.839054023687, 6507.902381464187, 6525.934740652533, 6539.444147247537, 6502.707378167899, 6512.73949042033, 6535.640539770358, 6574.046763219402, 6576.079348891255, 6347.143135676624, 6379.585326953733, 6380.234371875405, 6399.360063993563, 6402.487800976004], "value": 6167.238062583769, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [887.2635712358743, 955.0544960489116, 982.891881892992, 983.292029738588, 985.1380042462845, 44186.33720494191, 44617.77691111548, 44809.0, 44838.99999999992, 44870.55129448704, 42024.15951680965, 42064.158716825725, 42507.78746106265, 42560.361594576105, 42603.57396426035, 7384.483086183969, 7482.588457634828, 7535.2464753524755, 7554.055743032121, 7558.773236802905, 7333.9266607333775, 7433.0, 7441.218672039412, 7444.069491313586, 7444.664990075433, 7990.800229994267, 8139.226773456512, 8139.715109971152, 8141.959290203541, 8158.714444994426, 8052.355811535063, 8109.391795615353, 8123.187681231889, 8155.225253600928, 8212.671493140268, 7753.263439973193, 7917.485363451415, 8093.595320234023, 8099.595020248964, 8106.0, 40610.0, 40731.0, 40779.38830917539, 40845.59154408448, 40879.591204087876, 3666.17511060012, 3706.814659267026, 3715.6841668458214, 3717.739758216926, 3732.64539868712, 32869.50695739566, 32967.3406531868, 33067.0, 33149.17127071819, 33193.0, 5506.394296627368, 5526.447355264441, 5553.278073850414, 5572.86067848307, 5583.6928968906695, 220461.0, 220628.0, 221283.0, 221702.89148554316, 221838.0, 47942.0, 49449.25826112611, 57212.0, 57659.711701442066, 57910.4208957905, 60954.39045609576, 60990.69504652448, 61222.38777612167, 61331.0, 61380.38619613836, 15149.091054536762, 15388.153651549048, 15411.768823467657, 15443.0, 15468.690626187414, 12033.699157520958, 12083.939580302042, 12131.878681213075, 12213.816792748115, 12214.57248996281, 16203.351865925231, 16257.349706011864, 16386.0, 16387.34450621962, 16414.343426262814, 6164.065426395306, 6177.054227918192, 6261.9373806262265, 6349.968250158812, 6353.490371303309, 1087.7117563845586, 1091.6179337231906, 1094.7810437912449, 1096.0628662493452, 1098.8846171152074, 25491.23526294214, 25723.356916076875, 25774.87112564425, 25827.35431614187, 25967.0, 1161.1407558406886, 1200.4897918384652, 1200.9399530023638, 1203.0916657923387, 1210.7941649919535, 13427.0, 13637.113587616774, 13674.0, 13827.654308642163, 13922.86077139236, 270260.0, 271151.0, 272244.0, 272385.0, 272704.0, 59180.40819591835, 59213.407865921654, 59538.0, 59754.40245597489, 59896.401035989955, 1465.4724299252262, 1521.8249901261274, 1526.3131590784192, 1530.6249968757725, 1541.7379045562282, 24656.470693628355, 24669.866751648548, 24830.751692482845, 24833.255002349957, 24873.253802385232, 38637.42043869288, 39956.60043399645, 42428.0, 42437.363439547815, 42461.78769106135, 234936.0, 235651.0, 236064.0, 236315.0, 236414.0, 34875.0, 36093.819530902176, 36196.276074477835, 37825.05437364088, 38648.42027369535, 45660.77169614131, 46520.7673961628, 46639.06721865611, 47036.7648161757, 47622.76188619035, 33716.0, 33767.83116084404, 34247.82876085703, 34265.143371415914, 34334.313313734085, 34030.82984585061, 34148.31703365968, 34177.82911085428, 34476.13809654779, 35061.29877402489, 38921.41617875677, 39855.60144398635, 39874.0, 40134.397984030846, 40212.3968140484, 32494.512582311756, 33014.83492582522, 33276.66723332833, 33533.32933341368, 33988.32023359469, 25056.37359066038, 25249.242522724348, 25345.0, 26015.609765853147, 26072.478550428506], "value": 18457.546285461816, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.898517759392, 587.1833084947839, 591.3436085944601, 594.860207851155, 610.6183635227981, 23572.410689732744, 24372.634410483835, 24410.023599056018, 24414.38964025898, 24438.0, 25384.11155609554, 26414.20757377282, 26735.33161670959, 27000.729992700068, 27040.72959270407, 6835.14560679915, 6839.931600683992, 6847.794566163023, 6852.074969879077, 6865.4850886183485, 6259.186305780242, 6451.83870403239, 6510.9023364649565, 6827.249002609709, 6920.411764999981, 6434.0027295769, 6442.806715798533, 6455.096286519891, 6458.838529036765, 6467.644279564622, 6422.454091402236, 6430.0, 6440.4525615322755, 6444.484441244736, 6445.1943507061615, 6036.245469316335, 6162.137300777895, 6165.5992360496875, 6168.44483996438, 6177.62934223948, 30767.538486922713, 31312.21719457009, 31360.37279254402, 31403.84298078518, 31496.37007259865, 2276.1236923784295, 2293.633018717014, 2297.4600968772324, 2302.3898666853297, 2306.6770652108717, 20001.1999520019, 20639.0, 21472.677909831364, 21550.461238469008, 21569.892150539305, 2470.2218801077784, 2485.614729716897, 2534.6704928359195, 2581.70310414301, 2589.2102908612865, 141398.2930085343, 142771.2861435686, 147817.0, 149603.25198374048, 150913.24543377323, 15847.762283565755, 15873.682526349408, 16129.274182661808, 16475.752863707054, 16520.0, 25168.49663006766, 25361.112361067273, 25425.491490170094, 25448.491030179663, 25525.0, 9968.102870741523, 10056.59773609062, 10129.493525323704, 10270.845937310947, 10318.587256509656, 9136.08639136081, 9153.22197613197, 9165.81668366629, 9198.0, 9204.40171388871, 9706.466144362128, 9723.41659500418, 9745.171660408803, 9775.266854985905, 9868.555914983843, 2694.9730502695115, 2754.7520723135012, 2809.881032054418, 2851.7148285171315, 2916.2709322669334, 1015.2334987084704, 1020.739711373595, 1039.5270152080784, 1041.2242879055002, 1049.6536143072767, 21674.783252167592, 22059.007344669528, 22089.116435342406, 22131.889340553193, 22543.887280563493, 1108.6563165418745, 1111.1000089927186, 1124.5108377855659, 1125.6679279612533, 1128.3342827731515, 11829.171957963032, 12078.27530348182, 12137.393130343447, 12140.0, 12158.392080395945, 586212.0, 590995.0, 595744.0, 595796.0, 601201.0, 117670.41164794122, 120703.0, 121931.0, 122131.38934305271, 122502.38748806198, 1208.1663652080038, 1250.3748125937032, 1288.3815768431205, 1315.5132600937523, 1328.5615746803533, 23260.0, 23359.065637374315, 23481.06075757019, 23573.057077716698, 23632.763672363057, 63033.369666304585, 63415.682921585096, 63460.68269658622, 66089.0, 66102.0, 81538.0, 81700.18299817163, 82327.5883620602, 83777.0, 83880.0, 15491.84508154949, 15790.684186315979, 15805.209739513208, 15857.920710396374, 15925.8407415929, 24641.137560185307, 24814.37964050913, 24920.875395622905, 25038.37404064913, 25310.620340695274, 19616.313429029917, 20090.39728808138, 20418.69371959392, 20523.384298471068, 20653.69019464679, 16931.899426537235, 17003.574910627332, 18234.179461924512, 18298.0, 18398.08009599488, 20381.286654967003, 20808.89595552073, 20831.270905518235, 20934.685979710623, 20948.1620735175, 15491.91556591073, 15526.456574019856, 15636.530904072895, 15659.451919182773, 15659.92170039188, 19817.702734458708, 20040.298589549297, 20080.096395662524, 20109.29617463382, 20277.188912443336], "value": 12854.527467172058, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1387.2508845223579, 1453.280626090085, 1456.235476374903, 1458.139697578429, 1465.201465201465, 16485.670286594275, 17215.13924303783, 17330.0, 17342.739858902125, 17360.30558777649, 16872.578185545368, 16992.660146797087, 17023.319067237328, 17051.232694528746, 17079.060651664153, 2736.343277613373, 2865.0258911969927, 2865.4555634429494, 2866.4553734790325, 2866.7993240473174, 2809.0730059080456, 2887.537993920973, 2887.768978481727, 2891.8120322178993, 2892.175729916974, 2749.4501099780023, 2797.342624483245, 2808.199663096018, 2809.12916995732, 2810.339570201001, 2708.079253053961, 2734.8359098454157, 2746.3134216445887, 2747.587861820723, 2748.395353022332, 2595.065776320523, 2645.3386653336665, 2651.4166883285648, 2656.375751698349, 2662.480816240834, 16219.91890040554, 16281.674366512721, 16446.424375146933, 16452.588685282844, 16457.588560285967, 8168.264856162974, 8482.83034339316, 8483.618237179342, 8518.829623407497, 8533.530655813927, 5339.11904535755, 5455.890882182373, 5642.0, 5677.290338707661, 5781.075027995501, 2039.4187656517822, 2064.3290930447515, 2078.896055197249, 2135.209972310255, 2149.602323570129, 27629.30926726828, 28345.291367715767, 29887.402251954838, 30530.84734576335, 30793.692063079307, 7759.379249660014, 7885.44801863864, 7913.287804097658, 8071.4753541019645, 8072.354211663052, 23061.0, 23063.0, 23091.653625195635, 23120.53758924812, 23121.53756924852, 8479.364047696448, 8577.356698247657, 9016.459012459274, 9032.954835225913, 9037.68368107113, 7438.479306448497, 7801.726939557088, 7830.177831327743, 7846.097698764601, 7855.489393189425, 6035.728392222272, 6125.479334256549, 6132.816015519542, 6215.502759779297, 6228.750849966042, 1859.9256029758658, 1873.175802646831, 1884.9528761781064, 1899.1833511590148, 1911.6367890100837, 948.0708905272871, 969.3602222533094, 970.8932017478072, 974.0600320690568, 985.103555764251, 9050.683226087056, 9222.907770922206, 9286.164245217962, 9296.72109836706, 9490.572924218426, 772.3705180278056, 773.1418125880268, 792.2354927494995, 794.3605397654828, 796.5459687977797, 5089.796408143633, 5130.4100028497205, 5152.278680984665, 5197.766100525486, 5254.579633629301, 24165.275041748777, 24822.0, 25427.11005114812, 25470.0, 25791.871040644677, 24230.394240144138, 24890.875545622155, 24951.0, 25102.874485627453, 25506.107286244893, 9935.80128397428, 10350.585976560853, 10626.14990800734, 11818.172727908965, 12099.818502722466, 9899.950500247453, 9917.702468925943, 9945.005499450286, 10029.899701003189, 10079.395236285847, 21097.89451052735, 21567.0, 21701.782982169978, 21722.456938576663, 22056.88971555132, 22509.77490225142, 22591.43521411912, 22777.31668049961, 22893.313200604007, 22983.770162298162, 12704.618861434172, 13042.739145217232, 13166.210027398387, 13171.67070823237, 13178.538751143664, 15552.144632045347, 15559.844401556293, 15570.844291557392, 15688.764668529753, 15700.842991569938, 12444.253344799341, 12495.437705303102, 12788.232706037668, 12800.359982000677, 12927.806082908575, 11703.648890533297, 11895.583654572049, 12151.0, 12226.755464890475, 12285.75428491443, 11035.889641103486, 11202.327860328407, 11204.383758893338, 11218.214724969173, 11242.718932026764, 7601.0, 7647.992651537255, 7673.577953212627, 7741.535507869546, 7747.767566973, 7570.3943684504, 7575.772726818204, 7623.542587444771, 7743.574103424366, 7762.650680719494], "value": 7302.243591960987, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.6209772110661, 540.308405241291, 567.4552429667519, 569.4334137533156, 582.8717682109934, 6135.637779454909, 6168.4140006699345, 6168.470926919964, 6176.413240742134, 6226.533010024244, 6052.788152414666, 6074.817755467343, 6095.603785753923, 6097.57316987811, 6117.2965109012475, 5009.724465154433, 5013.248012798092, 5022.347094877661, 5074.264231686403, 5074.619403544731, 5005.524475174852, 5020.322256495381, 5026.246063090547, 5027.245913113025, 5041.1682072458, 4913.852584422473, 4934.753262336887, 5067.695938243699, 5096.362954630671, 5112.0, 5046.9747651261505, 5061.544460998528, 5069.0115427491655, 5108.438071812097, 5136.563392111675, 4691.413573303337, 4735.644826638016, 4788.090262850083, 4794.496577859344, 4805.639577031737, 6031.125486804389, 6040.395960403968, 6052.4552790248645, 6055.0, 6069.726862291208, 6000.8499787505225, 6001.789937352215, 6009.308929473123, 6066.181065556138, 6077.6353418795015, 6570.901436478457, 6608.339166083401, 6627.867442651168, 6634.938409854401, 6657.76697815579, 5319.441458646825, 5382.273393091921, 5384.67691938481, 5395.757190926418, 5412.323459567554, 6615.503837212228, 6644.700988455531, 6772.932270677329, 6835.931640683629, 6835.965820170867, 5486.807961721321, 5525.254090697785, 5534.972325138348, 5577.609567330248, 5596.608237423423, 5572.944270557324, 5573.526250268692, 5574.9442505574425, 5611.719414029282, 5657.547396208293, 5955.838611470808, 6006.639601623917, 6007.579469437097, 6047.0627052806, 6051.546134039877, 6533.575317604341, 6563.538672997626, 6606.207255129415, 6623.205215374186, 6639.3692599203, 1930.903454827253, 1940.8156225158586, 1950.2740075033414, 1977.5451646121473, 1981.5838673878648, 1413.6465883529117, 1463.6194589406618, 1488.9255537223096, 1493.3802471974009, 1508.954731358039, 5972.492338151219, 5974.790882319098, 5982.461578457873, 6022.976094063932, 6047.455728984412, 6496.913965866176, 6518.217813862367, 6536.640484773383, 6555.311692272243, 6567.1462709848365, 5958.344582096052, 6024.849378765566, 6053.636781793107, 6059.878802423927, 6062.120992456069, 3434.883662809597, 3468.6531346865113, 3480.89557313281, 3485.5294535237927, 3506.2111025019676, 6862.4853136015, 6886.276940921131, 6911.343422374866, 6933.2026816915695, 6953.756618518328, 6792.150981127359, 6816.693248803816, 6850.554713943578, 6852.931470685229, 6860.416864566568, 6849.589024658537, 6857.245702972768, 6902.309769023058, 6912.758053468205, 6923.6192009439965, 6401.071844582416, 6482.254540727688, 6508.8047358579315, 6541.738330466728, 6578.506612004215, 6286.622802631857, 6403.167588213502, 6509.381608747161, 6542.34576542342, 6613.900791488035, 6790.558613690095, 6854.5201835873, 6854.725810967506, 6914.239433662394, 6934.791956241321, 5547.861303467284, 5575.275214222287, 5593.685483911197, 5601.579881508822, 5615.719214039364, 6401.935980640134, 6436.324185960594, 6512.772052978313, 6603.669816509059, 6692.631905245258, 6252.656103914328, 6337.65142917144, 6339.683015849281, 6383.616982981036, 6385.87228255423, 6282.277538083179, 6315.842103947438, 6349.746010159727, 6409.9359006411205, 6417.93582064192, 6246.625202487865, 6325.177726895658, 6343.3339499351905, 6379.87240255183, 6380.617162970237, 6446.678430921556, 6475.870482590228, 6486.2216534016225, 6499.3175716549085, 6501.349865013461, 6219.315875253809, 6228.5951413158, 6230.906536402048, 6238.845813524513, 6259.618267212878], "value": 5197.420446065091, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [979.6081567373054, 983.7835676151246, 1008.1229330482477, 1011.307254530647, 1015.786684796193, 20745.792542074592, 21135.682964755502, 21324.57350852982, 21366.252181173662, 21369.893150534244, 18874.33939812107, 19149.234030638756, 19945.0, 19951.501212469695, 20076.196952121896, 1068.7595291059508, 1106.5241945963232, 1108.2685427617773, 1110.944452777362, 1111.9610813621525, 1101.9063379612703, 1103.7075175078571, 1103.7406209540752, 1104.13877175803, 1104.4864138175747, 1133.6315697398338, 1172.8533933258343, 1175.1304035014114, 1176.9882301176965, 1178.5403692559908, 1169.0355456748175, 1170.1165619956962, 1170.6253998720413, 1170.6488053583976, 1171.2796630072487, 826.5247482697473, 834.0991728932738, 835.1481488881307, 836.3434703757582, 837.2883049407955, 18414.815851841446, 18573.257069717194, 18604.069796510255, 18606.069696515122, 19614.215431382727, 23182.76817231823, 23355.88322058379, 23771.762282377127, 23784.643230351558, 23859.403514912094, 19367.903160484108, 19467.318643847397, 19593.118309676098, 19676.311329103413, 19711.11299991504, 3597.8380972856285, 3888.786116763577, 3933.1347103637154, 3943.3296339622048, 3947.032976920644, 133928.0, 158181.2090939538, 158783.23650290509, 159686.0, 160341.0, 18730.0, 18977.905110474636, 19209.423717288504, 19249.61500769977, 19338.0, 29342.413151736844, 29660.851695741814, 29682.406351873273, 29896.55155172674, 30014.84992575023, 9078.182963533181, 9089.31830112731, 9102.180803727697, 9118.133777291147, 9128.58921348541, 4164.895877603023, 4173.853915113017, 4177.122804211089, 4213.4522512073845, 4216.7680777557525, 6037.305709843336, 6149.938500615026, 6165.445109940038, 6170.56806023583, 6187.071939209065, 1254.7866862633375, 1293.043148070421, 1302.9153105048142, 1304.928228947398, 1305.11252348404, 734.1117248129716, 739.4860571902584, 747.4170147285126, 758.1016495452795, 762.5500954436798, 12928.0, 13010.284434356012, 13671.248081355621, 13911.364563739775, 13956.162630242217, 738.811603041221, 743.6913680822506, 749.4903465643415, 754.6792613139394, 756.4137793210306, 6308.211473565804, 6416.679166041679, 6507.9023814642815, 6512.381323774234, 6516.804495865132, 141276.2936185333, 141991.0, 143152.0, 145651.0, 146697.0, 128521.42957140805, 129712.0, 132257.0, 132457.33771331082, 134236.0, 110717.0, 110797.44601276942, 110938.0, 113210.0, 113921.0, 12178.695532611755, 12465.688357791129, 12528.812067818808, 12579.937100314806, 12636.747265054464, 53682.463175367746, 53707.194392083366, 53819.46180538301, 53897.730511347196, 55570.444295556525, 67445.0, 68477.0, 68507.65746171237, 69665.0, 71280.0, 16021.118838463997, 16340.754888676916, 16459.34162633481, 16466.09436480957, 16577.17114144264, 19243.51891202731, 19266.422007339803, 19311.130999105357, 19415.611687765882, 19450.124744386252, 17318.82681173172, 17586.56033599119, 17611.0, 17684.46946591604, 17708.734368984216, 16280.837191627932, 16312.51062468128, 16404.835951640332, 16456.177191140636, 16595.585110371856, 17798.37705680295, 18087.18607662632, 18126.818731812513, 18242.45272641823, 18278.908605456887, 12932.353382330657, 13127.737445251232, 13264.33678316061, 13373.598792036255, 13439.46242150303, 13728.862711372758, 13764.449422023408, 13902.791458127935, 13942.163470191821, 13989.580312590639], "value": 9920.105102886137, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1377.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 104.0, 106.0, 105.0, 110.0, 107.0, 105.0, 106.0, 106.0], "value": 105.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 111.0, 114.0, 114.0, 113.0, 142.0, 112.0, 115.0, 113.0], "value": 116.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 163.0, 165.0, 161.0, 161.0, 161.0, 162.0, 162.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 73.0, 73.0, 73.0, 73.0, 73.0, 73.0, 76.0], "value": 73.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 77.0, 78.0, 77.0, 77.0, 78.0, 77.0, 78.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 114.0, 113.0, 115.0, 116.0, 118.0, 113.0, 113.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 153.0, 150.0, 150.0, 150.0, 150.0, 152.0, 151.0, 149.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 93.0, 93.0, 94.0, 94.0, 99.0, 98.0, 97.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 45.0, 45.0, 50.0, 45.0, 45.0, 46.0, 43.0, 46.0, 43.0], "value": 45.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 38.0, 38.0, 39.0, 37.0, 37.0, 38.0, 38.0, 44.0], "value": 38.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 77.0, 71.0, 75.0, 72.0, 73.0, 71.0, 71.0, 71.0, 74.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 104.0, 102.0, 105.0, 112.0, 106.0, 110.0, 105.0, 116.0, 107.0], "value": 107.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 155.0, 153.0, 158.0, 153.0, 153.0, 159.0, 168.0, 156.0, 160.0], "value": 157.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 59.0, 58.0, 58.0, 66.0, 62.0, 61.0, 60.0, 60.0, 60.0], "value": 60.6, "unit": "score"}]}]} 21:54:09 INFO - Return code: 0 21:54:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:54:09 INFO - # TBPL SUCCESS # 21:54:09 INFO - Running post-action listener: _package_coverage_data 21:54:09 INFO - Running post-action listener: _resource_record_post_action 21:54:09 INFO - [mozharness: 2017-09-17 04:54:09.239187Z] Finished run-tests step (success) 21:54:09 INFO - Running post-run listener: _resource_record_post_run 21:54:09 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 8192; Write bytes: 326877184; Read time: 136; Write time: 198804 21:54:09 INFO - TinderboxPrint: CPU usage
13.1% 21:54:09 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 136 21:54:09 INFO - TinderboxPrint: I/O write bytes / time
326,877,184 / 198,804 21:54:09 INFO - TinderboxPrint: CPU idle
8,227.6 (86.9%) 21:54:09 INFO - TinderboxPrint: CPU user
1,186.6 (12.5%) 21:54:09 INFO - TinderboxPrint: Swap in / out
0 / 0 21:54:09 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12779520; Read time: 0; Write time: 2500 21:54:09 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 21:54:09 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 8192; Write bytes: 313483264; Read time: 136; Write time: 196304 21:54:09 INFO - Running post-run listener: _upload_blobber_files 21:54:09 INFO - Blob upload gear active. 21:54:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:54:09 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 21:54:09 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'] 21:54:09 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 21:54:10 INFO - (blobuploader) - INFO - Open directory for files ... 21:54:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:54:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:54:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:54:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:54:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:54:11 INFO - (blobuploader) - INFO - Done attempting. 21:54:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:54:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:54:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:54:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:54:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:54:17 INFO - (blobuploader) - INFO - Done attempting. 21:54:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:54:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:54:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:54:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:54:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:54:18 INFO - (blobuploader) - INFO - Done attempting. 21:54:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:54:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:54:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:54:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:54:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:54:19 INFO - (blobuploader) - INFO - Done attempting. 21:54:19 INFO - (blobuploader) - INFO - Iteration through files over. 21:54:19 INFO - Return code: 0 21:54:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:54:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:54:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9965387eac5cd5d8b43accf9f2985402a47eeb2d2612ba6d6d56a83e6b48cce351e095b6a2f7d92450e5c12728da15999c04062dfae1385d1c9afc1982ceddac", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdde0c4e0ee54a83d51f886eba85953c293dbb96dd1fd8c9515e2a9a61526f8b3d45ad2bb0f5a540ae43144ac4ca2ff94252674cd7a9aca19c37e26ef62c9886", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1949deb741d0d1ef1c2f0d7b2c683ab9b469045a3ba666dd1c06d18eb0a0c07d150ace880d8395e5dfb63a2c7304dd509223e7b8ebd218ed47afdf1685c51deb", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/acf2f59b4e489e74f164115461384e2aae4cbc777cc57095f323a3823b16b2820438b9fc0f64f01f58449c6c830c7df1d94d30047de3d7bc826f75f550fcd2a4"} 21:54:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:54:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:54:19 INFO - Contents: 21:54:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9965387eac5cd5d8b43accf9f2985402a47eeb2d2612ba6d6d56a83e6b48cce351e095b6a2f7d92450e5c12728da15999c04062dfae1385d1c9afc1982ceddac", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdde0c4e0ee54a83d51f886eba85953c293dbb96dd1fd8c9515e2a9a61526f8b3d45ad2bb0f5a540ae43144ac4ca2ff94252674cd7a9aca19c37e26ef62c9886", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1949deb741d0d1ef1c2f0d7b2c683ab9b469045a3ba666dd1c06d18eb0a0c07d150ace880d8395e5dfb63a2c7304dd509223e7b8ebd218ed47afdf1685c51deb", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/acf2f59b4e489e74f164115461384e2aae4cbc777cc57095f323a3823b16b2820438b9fc0f64f01f58449c6c830c7df1d94d30047de3d7bc826f75f550fcd2a4"} 21:54:19 INFO - Running post-run listener: copy_logs_to_upload_dir 21:54:19 INFO - Copying logs to upload dir... 21:54:19 INFO - mkdir: /builds/slave/test/build/upload/logs 21:54:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.835559 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-09-16 21:54:19.983110) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 21:54:19.989755) ========= 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=ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9965387eac5cd5d8b43accf9f2985402a47eeb2d2612ba6d6d56a83e6b48cce351e095b6a2f7d92450e5c12728da15999c04062dfae1385d1c9afc1982ceddac", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdde0c4e0ee54a83d51f886eba85953c293dbb96dd1fd8c9515e2a9a61526f8b3d45ad2bb0f5a540ae43144ac4ca2ff94252674cd7a9aca19c37e26ef62c9886", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1949deb741d0d1ef1c2f0d7b2c683ab9b469045a3ba666dd1c06d18eb0a0c07d150ace880d8395e5dfb63a2c7304dd509223e7b8ebd218ed47afdf1685c51deb", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/acf2f59b4e489e74f164115461384e2aae4cbc777cc57095f323a3823b16b2820438b9fc0f64f01f58449c6c830c7df1d94d30047de3d7bc826f75f550fcd2a4"} build_url:https://queue.taskcluster.net/v1/task/cFWRlOVRSYCqONchm7xKJw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011847 build_url: 'https://queue.taskcluster.net/v1/task/cFWRlOVRSYCqONchm7xKJw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9965387eac5cd5d8b43accf9f2985402a47eeb2d2612ba6d6d56a83e6b48cce351e095b6a2f7d92450e5c12728da15999c04062dfae1385d1c9afc1982ceddac", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdde0c4e0ee54a83d51f886eba85953c293dbb96dd1fd8c9515e2a9a61526f8b3d45ad2bb0f5a540ae43144ac4ca2ff94252674cd7a9aca19c37e26ef62c9886", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1949deb741d0d1ef1c2f0d7b2c683ab9b469045a3ba666dd1c06d18eb0a0c07d150ace880d8395e5dfb63a2c7304dd509223e7b8ebd218ed47afdf1685c51deb", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/acf2f59b4e489e74f164115461384e2aae4cbc777cc57095f323a3823b16b2820438b9fc0f64f01f58449c6c830c7df1d94d30047de3d7bc826f75f550fcd2a4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 21:54:20.020426) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 21:54:20.020753) ========= 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=ca6c2627acea03e666270f68000001e0-1505622257.348003-552652545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004399 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 21:54:20.101428) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 21:54:20.101759) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 21:54:20.102085) ========= ========= Total master_lag: 0.36 =========