builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-014 starttime: 1504906760.46 results: success (0) revision: dd3736e98e4e7558af2f202803bce36278a26c66 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-08 14:39:20.459877) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-08 14:39:20.460380) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-08 14:39:20.460694) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-08 14:39:20.479320) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 14:39:20.479943) ========= 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=31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-08 14:39:20-- 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% 47.2M=0s 2017-09-08 14:39:20 (47.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.289366 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 14:39:20.804218) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 14:39:20.804563) ========= 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=31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014314 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 14:39:20.854221) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-08 14:39:20.854568) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dd3736e98e4e7558af2f202803bce36278a26c66 --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 dd3736e98e4e7558af2f202803bce36278a26c66 --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=31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-08 14:39:20,927 truncating revision to first 12 chars 2017-09-08 14:39:20,927 Setting DEBUG logging. 2017-09-08 14:39:20,927 attempt 1/10 2017-09-08 14:39:20,927 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dd3736e98e4e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-08 14:39:21,797 unpacking tar archive at: mozilla-central-dd3736e98e4e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.169435 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-08 14:39:22.039844) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-08 14:39:22.040195) ========= script_repo_revision: dd3736e98e4e7558af2f202803bce36278a26c66 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-08 14:39:22.040681) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-08 14:39:22.040959) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-08 14:39:22.054473) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-08 14:39:22.054815) ========= /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=31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:39:22 INFO - MultiFileLogger online at 20170908 14:39:22 in /builds/slave/test 14:39:22 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 14:39:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:39:22 INFO - {'append_to_log': False, 14:39:22 INFO - 'base_work_dir': '/builds/slave/test', 14:39:22 INFO - 'blob_upload_branch': 'Firefox', 14:39:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:39:22 INFO - 'branch': 'Firefox', 14:39:22 INFO - 'buildbot_json_path': 'buildprops.json', 14:39:22 INFO - 'code_coverage': False, 14:39:22 INFO - 'config_files': ('talos/linux_config.py',), 14:39:22 INFO - 'default_actions': ('clobber', 14:39:22 INFO - 'read-buildbot-config', 14:39:22 INFO - 'download-and-extract', 14:39:22 INFO - 'populate-webroot', 14:39:22 INFO - 'create-virtualenv', 14:39:22 INFO - 'install', 14:39:22 INFO - 'setup-mitmproxy', 14:39:22 INFO - 'run-tests'), 14:39:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:39:22 INFO - 'disable_ccov_upload': False, 14:39:22 INFO - 'disable_stylo': False, 14:39:22 INFO - 'download_minidump_stackwalk': True, 14:39:22 INFO - 'download_symbols': 'ondemand', 14:39:22 INFO - 'enable_stylo': False, 14:39:22 INFO - 'enable_webrender': False, 14:39:22 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 14:39:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:39:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:39:22 INFO - 'gecko_profile': False, 14:39:22 INFO - 'gecko_profile_interval': 0, 14:39:22 INFO - 'installer_path': 'installer.exe', 14:39:22 INFO - 'log_level': 'info', 14:39:22 INFO - 'log_name': 'talos', 14:39:22 INFO - 'log_to_console': True, 14:39:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:39:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:39:22 INFO - 'opt_config_files': (), 14:39:22 INFO - 'pip_index': False, 14:39:22 INFO - 'suite': 'dromaeojs-e10s', 14:39:22 INFO - 'system_bits': '32', 14:39:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:39:22 INFO - 'title': 'talos-linux64-ix-014', 14:39:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:39:22 INFO - 'use_talos_json': True, 14:39:22 INFO - 'verify': 'False', 14:39:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:39:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:39:22 INFO - 'work_dir': 'build'} 14:39:22 INFO - [mozharness: 2017-09-08 21:39:22.392707Z] Running clobber step. 14:39:22 INFO - Running pre-action listener: _resource_record_pre_action 14:39:22 INFO - Running main action method: clobber 14:39:22 INFO - rmtree: /builds/slave/test/build 14:39:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:39:23 INFO - Running post-action listener: _resource_record_post_action 14:39:23 INFO - [mozharness: 2017-09-08 21:39:23.366359Z] Finished clobber step (success) 14:39:23 INFO - [mozharness: 2017-09-08 21:39:23.366455Z] Running read-buildbot-config step. 14:39:23 INFO - Running pre-action listener: _resource_record_pre_action 14:39:23 INFO - Running main action method: read_buildbot_config 14:39:23 INFO - Using buildbot properties: 14:39:23 INFO - { 14:39:23 INFO - "project": "", 14:39:23 INFO - "product": "firefox", 14:39:23 INFO - "who": "kwierso@gmail.com", 14:39:23 INFO - "installer_path": "public/build/target.tar.bz2", 14:39:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 14:39:23 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 14:39:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 14:39:23 INFO - "stage_platform": "linux64-pgo", 14:39:23 INFO - "basedir": "/builds/slave/test", 14:39:23 INFO - "buildnumber": 169, 14:39:23 INFO - "platform": "ubuntu64_hw", 14:39:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:39:23 INFO - "slavebuilddir": "test", 14:39:23 INFO - "taskId": "Esg5rzgAQamwUiKRAgLxqQ", 14:39:23 INFO - "branch": "mozilla-central", 14:39:23 INFO - "script_repo_revision": "production", 14:39:23 INFO - "revision": "dd3736e98e4e7558af2f202803bce36278a26c66", 14:39:23 INFO - "slavename": "talos-linux64-ix-014", 14:39:23 INFO - "repo_path": "mozilla-central" 14:39:23 INFO - } 14:39:23 INFO - Finding installer, test and symbols from parent task. 14:39:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Esg5rzgAQamwUiKRAgLxqQ'}, attempt #1 14:39:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Esg5rzgAQamwUiKRAgLxqQ'}, attempt #1 14:39:24 INFO - Task dependencies: IMacF5BeTkyX-9dYE2IlAA 14:39:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IMacF5BeTkyX-9dYE2IlAA'}, attempt #1 14:39:24 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/IMacF5BeTkyX-9dYE2IlAA/artifacts/public/build/target.tar.bz2 14:39:24 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/IMacF5BeTkyX-9dYE2IlAA/artifacts/public/build/target.test_packages.json 14:39:24 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/IMacF5BeTkyX-9dYE2IlAA/artifacts/public/build/target.crashreporter-symbols.zip 14:39:24 INFO - Running post-action listener: _resource_record_post_action 14:39:24 INFO - [mozharness: 2017-09-08 21:39:24.773145Z] Finished read-buildbot-config step (success) 14:39:24 INFO - [mozharness: 2017-09-08 21:39:24.773405Z] Running download-and-extract step. 14:39:24 INFO - Running pre-action listener: _resource_record_pre_action 14:39:24 INFO - Running main action method: download_and_extract 14:39:24 INFO - mkdir: /builds/slave/test/build/tests 14:39:24 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')]} 14:39:24 INFO - trying https://queue.taskcluster.net/v1/task/IMacF5BeTkyX-9dYE2IlAA/artifacts/public/build/target.test_packages.json 14:39:24 INFO - Downloading https://queue.taskcluster.net/v1/task/IMacF5BeTkyX-9dYE2IlAA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:39:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IMacF5BeTkyX-9dYE2IlAA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:39:25 INFO - Downloaded 989 bytes. 14:39:25 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:39:25 INFO - Using the following test package requirements: 14:39:25 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:39:25 INFO - u'common': [u'target.common.tests.zip'], 14:39:25 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:39:25 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:39:25 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:39:25 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:39:25 INFO - u'mozbase': [u'target.common.tests.zip'], 14:39:25 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:39:25 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:39:25 INFO - u'web-platform': [u'target.common.tests.zip', 14:39:25 INFO - u'target.web-platform.tests.tar.gz'], 14:39:25 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:39:25 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 14:39:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IMacF5BeTkyX-9dYE2IlAA/artifacts/public/build/target.common.tests.zip 14:39:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IMacF5BeTkyX-9dYE2IlAA/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:39:25 INFO - Fetch https://queue.taskcluster.net/v1/task/IMacF5BeTkyX-9dYE2IlAA/artifacts/public/build/target.common.tests.zip into memory 14:39:26 INFO - Content-Length response header: 55691794 14:39:26 INFO - Bytes received: 55691794 14:39:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IMacF5BeTkyX-9dYE2IlAA/artifacts/public/build/target.talos.tests.zip 14:39:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IMacF5BeTkyX-9dYE2IlAA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:39:37 INFO - Fetch https://queue.taskcluster.net/v1/task/IMacF5BeTkyX-9dYE2IlAA/artifacts/public/build/target.talos.tests.zip into memory 14:39:38 INFO - Content-Length response header: 14497945 14:39:38 INFO - Bytes received: 14497945 14:39:38 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')]} 14:39:38 INFO - trying https://queue.taskcluster.net/v1/task/IMacF5BeTkyX-9dYE2IlAA/artifacts/public/build/target.tar.bz2 14:39:38 INFO - Downloading https://queue.taskcluster.net/v1/task/IMacF5BeTkyX-9dYE2IlAA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:39:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IMacF5BeTkyX-9dYE2IlAA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:39:40 INFO - Downloaded 63581036 bytes. 14:39:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IMacF5BeTkyX-9dYE2IlAA/artifacts/public/build/target.tar.bz2 14:39:40 INFO - mkdir: /builds/slave/test/properties 14:39:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:39:40 INFO - Writing to file /builds/slave/test/properties/build_url 14:39:40 INFO - Contents: 14:39:40 INFO - build_url:https://queue.taskcluster.net/v1/task/IMacF5BeTkyX-9dYE2IlAA/artifacts/public/build/target.tar.bz2 14:39:40 INFO - Running post-action listener: _resource_record_post_action 14:39:40 INFO - Running post-action listener: find_tests_for_verification 14:39:40 INFO - Running post-action listener: set_extra_try_arguments 14:39:40 INFO - [mozharness: 2017-09-08 21:39:40.026640Z] Finished download-and-extract step (success) 14:39:40 INFO - [mozharness: 2017-09-08 21:39:40.026743Z] Running populate-webroot step. 14:39:40 INFO - Running pre-action listener: _resource_record_pre_action 14:39:40 INFO - Running main action method: populate_webroot 14:39:40 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:39:40 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:39:40 INFO - 'tests': ['tresize', 14:39:40 INFO - 'tcanvasmark']}, 14:39:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:39:40 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:39:40 INFO - 'tests': ['dromaeo_css', 14:39:40 INFO - 'kraken']}, 14:39:40 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:39:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:39:40 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:39:40 INFO - 'talos_options': ['--disable-stylo'], 14:39:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:39:40 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:39:40 INFO - 'tests': ['damp', 'tps']}, 14:39:40 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:39:40 INFO - 'talos_options': ['--disable-stylo'], 14:39:40 INFO - 'tests': ['damp', 'tps']}, 14:39:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:39:40 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:39:40 INFO - 'tests': ['dromaeo_dom']}, 14:39:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:39:40 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:39:40 INFO - 'tests': ['basic_compositor_video', 14:39:40 INFO - 'glvideo']}, 14:39:40 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:39:40 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:39:40 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:39:40 INFO - 'talos_options': ['--disable-stylo'], 14:39:40 INFO - 'tests': ['ts_paint_webext', 14:39:40 INFO - 'tp5o_webext']}, 14:39:40 INFO - 'other-e10s': {'tests': ['a11yr', 14:39:40 INFO - 'ts_paint', 14:39:40 INFO - 'tpaint', 14:39:40 INFO - 'sessionrestore', 14:39:40 INFO - 'sessionrestore_many_windows', 14:39:40 INFO - 'sessionrestore_no_auto_restore', 14:39:40 INFO - 'tabpaint']}, 14:39:40 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:39:40 INFO - 'tests': ['a11yr', 14:39:40 INFO - 'ts_paint', 14:39:40 INFO - 'tpaint', 14:39:40 INFO - 'sessionrestore', 14:39:40 INFO - 'sessionrestore_many_windows', 14:39:40 INFO - 'sessionrestore_no_auto_restore', 14:39:40 INFO - 'tabpaint']}, 14:39:40 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 14:39:40 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 14:39:40 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:39:40 INFO - 'tests': ['bloom_basic_singleton']}, 14:39:40 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:39:40 INFO - 'tests': ['bloom_basic']}, 14:39:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:39:40 INFO - 'tsvgr_opacity', 14:39:40 INFO - 'tart', 14:39:40 INFO - 'tscrollx', 14:39:40 INFO - 'tsvg_static']}, 14:39:40 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:39:40 INFO - 'tests': ['tsvgx', 14:39:40 INFO - 'tsvgr_opacity', 14:39:40 INFO - 'tart', 14:39:40 INFO - 'tscrollx', 14:39:40 INFO - 'tsvg_static']}, 14:39:40 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:39:40 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:39:40 INFO - 'talos_options': ['--disable-stylo'], 14:39:40 INFO - 'tests': ['tp5o']}, 14:39:40 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:39:40 INFO - 'talos_options': ['--mitmproxy', 14:39:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:39:40 INFO - '--firstNonBlankPaint'], 14:39:40 INFO - 'tests': ['tp6_google', 14:39:40 INFO - 'tp6_youtube', 14:39:40 INFO - 'tp6_amazon', 14:39:40 INFO - 'tp6_facebook']}, 14:39:40 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:39:40 INFO - 'talos_options': ['--disable-stylo', 14:39:40 INFO - '--mitmproxy', 14:39:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:39:40 INFO - '--firstNonBlankPaint'], 14:39:40 INFO - 'tests': ['tp6_google', 14:39:40 INFO - 'tp6_youtube', 14:39:40 INFO - 'tp6_amazon', 14:39:40 INFO - 'tp6_facebook']}, 14:39:40 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:39:40 INFO - 'talos_options': ['--stylo-threads=1', 14:39:40 INFO - '--mitmproxy', 14:39:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:39:40 INFO - '--firstNonBlankPaint'], 14:39:40 INFO - 'tests': ['tp6_google', 14:39:40 INFO - 'tp6_youtube', 14:39:40 INFO - 'tp6_amazon', 14:39:40 INFO - 'tp6_facebook']}, 14:39:40 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:39:40 INFO - 'talos_options': ['--xperf_path', 14:39:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:39:40 INFO - 'tests': ['tp5n']}, 14:39:40 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:39:40 INFO - 'talos_options': ['--disable-stylo', 14:39:40 INFO - '--xperf_path', 14:39:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:39:40 INFO - 'tests': ['tp5n']}}} 14:39:40 INFO - Running post-action listener: _resource_record_post_action 14:39:40 INFO - [mozharness: 2017-09-08 21:39:40.041655Z] Finished populate-webroot step (success) 14:39:40 INFO - [mozharness: 2017-09-08 21:39:40.041744Z] Running create-virtualenv step. 14:39:40 INFO - Running pre-action listener: _resource_record_pre_action 14:39:40 INFO - Running main action method: create_virtualenv 14:39:40 INFO - Creating virtualenv /builds/slave/test/build/venv 14:39:40 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:39:40 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 14:39:40 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 14:39:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:39:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:39:40 INFO - Installing distribute.............................................................................................................................................................................................done. 14:39:41 INFO - Installing pip...............done. 14:39:41 INFO - Return code: 0 14:39:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:39:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:39:41 INFO - Reading from file tmpfile_stdout 14:39:41 INFO - Output received: 14:39:41 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 14:39:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:39:41 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')]} 14:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:41 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')]} 14:39:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:41 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 0x23491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b9090>, '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 0x26b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b3f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906', '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 14:39:41 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 14:39:41 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 14:39:41 INFO - Using env: {'DISPLAY': ':0', 14:39:41 INFO - 'HOME': '/home/cltbld', 14:39:41 INFO - 'LANG': 'en_US.UTF-8', 14:39:41 INFO - 'LANGUAGE': 'en_US:en', 14:39:41 INFO - 'LOGNAME': 'cltbld', 14:39:41 INFO - 'MAIL': '/var/mail/cltbld', 14:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:41 INFO - 'MOZ_NO_REMOTE': '1', 14:39:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:41 INFO - 'NO_EM_RESTART': '1', 14:39:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:41 INFO - 'PWD': '/builds/slave/test', 14:39:41 INFO - 'SHELL': '/bin/bash', 14:39:41 INFO - 'SHLVL': '1', 14:39:41 INFO - 'TERM': 'linux', 14:39:41 INFO - 'TMOUT': '86400', 14:39:41 INFO - 'USER': 'cltbld', 14:39:41 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906', 14:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:41 INFO - '_': '/tools/buildbot/bin/python'} 14:39:42 INFO - Ignoring indexes: http://pypi.python.org/simple/ 14:39:42 INFO - Downloading/unpacking pip>=1.5 14:39:42 INFO - Running setup.py egg_info for package pip 14:39:42 INFO - warning: no files found matching 'pip/cacert.pem' 14:39:42 INFO - warning: no files found matching '*.html' under directory 'docs' 14:39:42 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 14:39:42 INFO - no previously-included directories found matching 'docs/_build/_sources' 14:39:42 INFO - Installing collected packages: pip 14:39:42 INFO - Found existing installation: pip 1.1 14:39:42 INFO - Uninstalling pip: 14:39:42 INFO - Successfully uninstalled pip 14:39:42 INFO - Running setup.py install for pip 14:39:42 INFO - warning: no files found matching 'pip/cacert.pem' 14:39:42 INFO - warning: no files found matching '*.html' under directory 'docs' 14:39:42 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 14:39:42 INFO - no previously-included directories found matching 'docs/_build/_sources' 14:39:42 INFO - Installing pip script to /builds/slave/test/build/venv/bin 14:39:42 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 14:39:42 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 14:39:42 INFO - Successfully installed pip 14:39:42 INFO - Cleaning up... 14:39:42 INFO - Return code: 0 14:39:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:39:42 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')]} 14:39:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:42 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')]} 14:39:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:42 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 0x23491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b9090>, '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 0x26b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b3f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906', '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 14:39:42 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 14:39:42 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 14:39:42 INFO - Using env: {'DISPLAY': ':0', 14:39:42 INFO - 'HOME': '/home/cltbld', 14:39:42 INFO - 'LANG': 'en_US.UTF-8', 14:39:42 INFO - 'LANGUAGE': 'en_US:en', 14:39:42 INFO - 'LOGNAME': 'cltbld', 14:39:42 INFO - 'MAIL': '/var/mail/cltbld', 14:39:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:42 INFO - 'MOZ_NO_REMOTE': '1', 14:39:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:42 INFO - 'NO_EM_RESTART': '1', 14:39:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:42 INFO - 'PWD': '/builds/slave/test', 14:39:42 INFO - 'SHELL': '/bin/bash', 14:39:42 INFO - 'SHLVL': '1', 14:39:42 INFO - 'TERM': 'linux', 14:39:42 INFO - 'TMOUT': '86400', 14:39:42 INFO - 'USER': 'cltbld', 14:39:42 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906', 14:39:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:42 INFO - '_': '/tools/buildbot/bin/python'} 14:39:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:43 INFO - Downloading/unpacking psutil>=3.1.1 14:39:43 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 14:39:43 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 14:39:43 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 14:39:43 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 14:39:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:39:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:39:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:39:44 INFO - Installing collected packages: psutil 14:39:44 INFO - Running setup.py install for psutil 14:39:44 INFO - building 'psutil._psutil_linux' extension 14:39:44 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 14:39:47 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 14:39:47 INFO - building 'psutil._psutil_posix' extension 14:39:47 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 14:39:48 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 14:39:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:39:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:39:48 INFO - Successfully installed psutil 14:39:48 INFO - Cleaning up... 14:39:48 INFO - Return code: 0 14:39:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b9090>, '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 0x26b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b3f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906', '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 14:39:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:39:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:39:48 INFO - Using env: {'DISPLAY': ':0', 14:39:48 INFO - 'HOME': '/home/cltbld', 14:39:48 INFO - 'LANG': 'en_US.UTF-8', 14:39:48 INFO - 'LANGUAGE': 'en_US:en', 14:39:48 INFO - 'LOGNAME': 'cltbld', 14:39:48 INFO - 'MAIL': '/var/mail/cltbld', 14:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:48 INFO - 'MOZ_NO_REMOTE': '1', 14:39:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:48 INFO - 'NO_EM_RESTART': '1', 14:39:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:48 INFO - 'PWD': '/builds/slave/test', 14:39:48 INFO - 'SHELL': '/bin/bash', 14:39:48 INFO - 'SHLVL': '1', 14:39:48 INFO - 'TERM': 'linux', 14:39:48 INFO - 'TMOUT': '86400', 14:39:48 INFO - 'USER': 'cltbld', 14:39:48 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906', 14:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:48 INFO - '_': '/tools/buildbot/bin/python'} 14:39:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:39:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:39:49 INFO - Installing collected packages: mozsystemmonitor 14:39:49 INFO - Running setup.py install for mozsystemmonitor 14:39:49 INFO - Successfully installed mozsystemmonitor 14:39:49 INFO - Cleaning up... 14:39:49 INFO - Return code: 0 14:39:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:39:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b9090>, '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 0x26b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b3f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906', '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 14:39:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:39:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:39:49 INFO - Using env: {'DISPLAY': ':0', 14:39:49 INFO - 'HOME': '/home/cltbld', 14:39:49 INFO - 'LANG': 'en_US.UTF-8', 14:39:49 INFO - 'LANGUAGE': 'en_US:en', 14:39:49 INFO - 'LOGNAME': 'cltbld', 14:39:49 INFO - 'MAIL': '/var/mail/cltbld', 14:39:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:49 INFO - 'MOZ_NO_REMOTE': '1', 14:39:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:49 INFO - 'NO_EM_RESTART': '1', 14:39:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:49 INFO - 'PWD': '/builds/slave/test', 14:39:49 INFO - 'SHELL': '/bin/bash', 14:39:49 INFO - 'SHLVL': '1', 14:39:49 INFO - 'TERM': 'linux', 14:39:49 INFO - 'TMOUT': '86400', 14:39:49 INFO - 'USER': 'cltbld', 14:39:49 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906', 14:39:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:49 INFO - '_': '/tools/buildbot/bin/python'} 14:39:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:49 INFO - Downloading/unpacking jsonschema==2.5.1 14:39:49 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 14:39:49 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 14:39:49 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 14:39:49 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 14:39:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:39:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:39:51 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 14:39:51 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 14:39:51 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 14:39:51 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 14:39:51 INFO - Downloading functools32-3.2.3-2.tar.gz 14:39:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:39:51 INFO - warning: no files found matching '*.txt' 14:39:51 INFO - no previously-included directories found matching 'build' 14:39:51 INFO - no previously-included directories found matching 'dist' 14:39:51 INFO - no previously-included directories found matching '.git*' 14:39:51 INFO - Installing collected packages: jsonschema, functools32 14:39:51 INFO - Running setup.py install for functools32 14:39:51 INFO - warning: no files found matching '*.txt' 14:39:51 INFO - no previously-included directories found matching 'build' 14:39:51 INFO - no previously-included directories found matching 'dist' 14:39:51 INFO - no previously-included directories found matching '.git*' 14:39:51 INFO - Successfully installed jsonschema functools32 14:39:51 INFO - Cleaning up... 14:39:51 INFO - Return code: 0 14:39:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:51 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 0x23491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b9090>, '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 0x26b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b3f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906', '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 14:39:51 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 14:39:51 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 14:39:51 INFO - Using env: {'DISPLAY': ':0', 14:39:51 INFO - 'HOME': '/home/cltbld', 14:39:51 INFO - 'LANG': 'en_US.UTF-8', 14:39:51 INFO - 'LANGUAGE': 'en_US:en', 14:39:51 INFO - 'LOGNAME': 'cltbld', 14:39:51 INFO - 'MAIL': '/var/mail/cltbld', 14:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:51 INFO - 'MOZ_NO_REMOTE': '1', 14:39:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:51 INFO - 'NO_EM_RESTART': '1', 14:39:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:51 INFO - 'PWD': '/builds/slave/test', 14:39:51 INFO - 'SHELL': '/bin/bash', 14:39:51 INFO - 'SHLVL': '1', 14:39:51 INFO - 'TERM': 'linux', 14:39:51 INFO - 'TMOUT': '86400', 14:39:51 INFO - 'USER': 'cltbld', 14:39:51 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906', 14:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:51 INFO - '_': '/tools/buildbot/bin/python'} 14:39:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:39:51 INFO - Cleaning up... 14:39:51 INFO - Return code: 0 14:39:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:51 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 0x23491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b9090>, '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 0x26b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b3f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906', '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 14:39:51 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 14:39:51 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 14:39:51 INFO - Using env: {'DISPLAY': ':0', 14:39:51 INFO - 'HOME': '/home/cltbld', 14:39:51 INFO - 'LANG': 'en_US.UTF-8', 14:39:51 INFO - 'LANGUAGE': 'en_US:en', 14:39:51 INFO - 'LOGNAME': 'cltbld', 14:39:51 INFO - 'MAIL': '/var/mail/cltbld', 14:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:51 INFO - 'MOZ_NO_REMOTE': '1', 14:39:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:51 INFO - 'NO_EM_RESTART': '1', 14:39:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:51 INFO - 'PWD': '/builds/slave/test', 14:39:51 INFO - 'SHELL': '/bin/bash', 14:39:51 INFO - 'SHLVL': '1', 14:39:51 INFO - 'TERM': 'linux', 14:39:51 INFO - 'TMOUT': '86400', 14:39:51 INFO - 'USER': 'cltbld', 14:39:51 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906', 14:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:51 INFO - '_': '/tools/buildbot/bin/python'} 14:39:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:51 INFO - Downloading/unpacking blobuploader==1.2.4 14:39:51 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 14:39:51 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 14:39:51 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 14:39:51 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 14:39:52 INFO - Downloading blobuploader-1.2.4.tar.gz 14:39:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:39:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:39:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:53 INFO - Downloading docopt-0.6.1.tar.gz 14:39:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:39:53 INFO - Installing collected packages: blobuploader, requests, docopt 14:39:53 INFO - Running setup.py install for blobuploader 14:39:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:39:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:39:53 INFO - Running setup.py install for requests 14:39:54 INFO - Running setup.py install for docopt 14:39:54 INFO - Successfully installed blobuploader requests docopt 14:39:54 INFO - Cleaning up... 14:39:54 INFO - Return code: 0 14:39:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:54 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 0x23491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b9090>, '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 0x26b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b3f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906', '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 14:39:54 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 14:39:54 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 14:39:54 INFO - Using env: {'DISPLAY': ':0', 14:39:54 INFO - 'HOME': '/home/cltbld', 14:39:54 INFO - 'LANG': 'en_US.UTF-8', 14:39:54 INFO - 'LANGUAGE': 'en_US:en', 14:39:54 INFO - 'LOGNAME': 'cltbld', 14:39:54 INFO - 'MAIL': '/var/mail/cltbld', 14:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:54 INFO - 'MOZ_NO_REMOTE': '1', 14:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:54 INFO - 'NO_EM_RESTART': '1', 14:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:54 INFO - 'PWD': '/builds/slave/test', 14:39:54 INFO - 'SHELL': '/bin/bash', 14:39:54 INFO - 'SHLVL': '1', 14:39:54 INFO - 'TERM': 'linux', 14:39:54 INFO - 'TMOUT': '86400', 14:39:54 INFO - 'USER': 'cltbld', 14:39:54 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906', 14:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:54 INFO - '_': '/tools/buildbot/bin/python'} 14:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:39:54 INFO - Running setup.py (path:/tmp/pip-pxQefd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:39:54 INFO - Running setup.py (path:/tmp/pip-KcHeGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:39:54 INFO - Running setup.py (path:/tmp/pip-8R7aP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:39:54 INFO - Running setup.py (path:/tmp/pip-DnTg5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:39:54 INFO - Running setup.py (path:/tmp/pip-9QUNX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:39:54 INFO - Running setup.py (path:/tmp/pip-SD8vgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:39:54 INFO - Running setup.py (path:/tmp/pip-6b91hW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:39:54 INFO - Running setup.py (path:/tmp/pip-jzJ2Vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:39:54 INFO - Running setup.py (path:/tmp/pip-VznQbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:39:55 INFO - Running setup.py (path:/tmp/pip-0V1s83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:39:55 INFO - Running setup.py (path:/tmp/pip-HpSXY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:39:55 INFO - Running setup.py (path:/tmp/pip-ICEdl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:39:55 INFO - Running setup.py (path:/tmp/pip-0LyA2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:39:55 INFO - Running setup.py (path:/tmp/pip-b5_1MQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:55 INFO - Running setup.py (path:/tmp/pip-mWH2DM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:39:55 INFO - Running setup.py (path:/tmp/pip-ni2GN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:39:55 INFO - Running setup.py (path:/tmp/pip-ndU_64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:39:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:39:55 INFO - Running setup.py install for manifestparser 14:39:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:39:55 INFO - Running setup.py install for mozcrash 14:39:55 INFO - Running setup.py install for mozdebug 14:39:55 INFO - Running setup.py install for mozdevice 14:39:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:39:55 INFO - Running setup.py install for mozfile 14:39:56 INFO - Running setup.py install for mozhttpd 14:39:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:39:56 INFO - Running setup.py install for mozinfo 14:39:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:39:56 INFO - Running setup.py install for mozInstall 14:39:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:39:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:39:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:39:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:39:56 INFO - Running setup.py install for mozleak 14:39:56 INFO - Running setup.py install for mozlog 14:39:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:39:56 INFO - Running setup.py install for moznetwork 14:39:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:39:56 INFO - Running setup.py install for mozprocess 14:39:56 INFO - Running setup.py install for mozprofile 14:39:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:39:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:39:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:39:56 INFO - Running setup.py install for mozrunner 14:39:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:39:56 INFO - Running setup.py install for mozscreenshot 14:39:57 INFO - Running setup.py install for moztest 14:39:57 INFO - Running setup.py install for mozversion 14:39:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:39:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:39:57 INFO - Cleaning up... 14:39:57 INFO - Return code: 0 14:39:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:57 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 0x23491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b9090>, '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 0x26b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b3f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906', '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 14:39:57 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 14:39:57 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 14:39:57 INFO - Using env: {'DISPLAY': ':0', 14:39:57 INFO - 'HOME': '/home/cltbld', 14:39:57 INFO - 'LANG': 'en_US.UTF-8', 14:39:57 INFO - 'LANGUAGE': 'en_US:en', 14:39:57 INFO - 'LOGNAME': 'cltbld', 14:39:57 INFO - 'MAIL': '/var/mail/cltbld', 14:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:57 INFO - 'MOZ_NO_REMOTE': '1', 14:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:57 INFO - 'NO_EM_RESTART': '1', 14:39:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:57 INFO - 'PWD': '/builds/slave/test', 14:39:57 INFO - 'SHELL': '/bin/bash', 14:39:57 INFO - 'SHLVL': '1', 14:39:57 INFO - 'TERM': 'linux', 14:39:57 INFO - 'TMOUT': '86400', 14:39:57 INFO - 'USER': 'cltbld', 14:39:57 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906', 14:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:57 INFO - '_': '/tools/buildbot/bin/python'} 14:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:39:57 INFO - Running setup.py (path:/tmp/pip-w7bDXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:39:57 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)) 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:39:57 INFO - Running setup.py (path:/tmp/pip-4U2K2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:39:57 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)) 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:39:57 INFO - Running setup.py (path:/tmp/pip-SOWGN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:39:57 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)) 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:39:57 INFO - Running setup.py (path:/tmp/pip-Kzm8ZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:39:57 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)) 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:39:57 INFO - Running setup.py (path:/tmp/pip-tLkimV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:39:57 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)) 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:39:57 INFO - Running setup.py (path:/tmp/pip-YCET0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:39:57 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)) 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:39:57 INFO - Running setup.py (path:/tmp/pip-ERTXAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:39:58 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)) 14:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:39:58 INFO - Running setup.py (path:/tmp/pip-lWvurJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:39:58 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)) 14:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:39:58 INFO - Running setup.py (path:/tmp/pip-D8fenO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:39:58 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)) 14:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:39:58 INFO - Running setup.py (path:/tmp/pip-sWC3_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:39:58 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)) 14:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:39:58 INFO - Running setup.py (path:/tmp/pip-GjQufy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:39:58 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)) 14:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:39:58 INFO - Running setup.py (path:/tmp/pip-JasQOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:39:58 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)) 14:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:39:58 INFO - Running setup.py (path:/tmp/pip-bik2OC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:39:58 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)) 14:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:39:58 INFO - Running setup.py (path:/tmp/pip-Wx5cgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:39:58 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)) 14:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:58 INFO - Running setup.py (path:/tmp/pip-MysuR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:58 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)) 14:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:39:58 INFO - Running setup.py (path:/tmp/pip-pKp4Mr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:39:58 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)) 14:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:39:58 INFO - Running setup.py (path:/tmp/pip-5EyOcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:39:58 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)) 14:39:58 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)) 14:39:58 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)) 14:39:58 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)) 14:39:58 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)) 14:39:58 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)) 14:39:58 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)) 14:39:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:59 INFO - Downloading blessings-1.6.tar.gz 14:39:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:39:59 INFO - Installing collected packages: blessings 14:39:59 INFO - Running setup.py install for blessings 14:40:00 INFO - Successfully installed blessings 14:40:00 INFO - Cleaning up... 14:40:00 INFO - Return code: 0 14:40:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:40:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:40:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:40:00 INFO - Reading from file tmpfile_stdout 14:40:00 INFO - Current package versions: 14:40:00 INFO - argparse == 1.2.1 14:40:00 INFO - blessings == 1.6 14:40:00 INFO - blobuploader == 1.2.4 14:40:00 INFO - docopt == 0.6.1 14:40:00 INFO - functools32 == 3.2.3-2 14:40:00 INFO - jsonschema == 2.5.1 14:40:00 INFO - manifestparser == 1.1 14:40:00 INFO - mozInstall == 1.13 14:40:00 INFO - mozcrash == 1.0 14:40:00 INFO - mozdebug == 0.1 14:40:00 INFO - mozdevice == 0.51 14:40:00 INFO - mozfile == 1.2 14:40:00 INFO - mozhttpd == 0.7 14:40:00 INFO - mozinfo == 0.10 14:40:00 INFO - mozleak == 0.1 14:40:00 INFO - mozlog == 3.5 14:40:00 INFO - moznetwork == 0.27 14:40:00 INFO - mozprocess == 0.25 14:40:00 INFO - mozprofile == 0.28 14:40:00 INFO - mozrunner == 6.13 14:40:00 INFO - mozscreenshot == 0.1 14:40:00 INFO - mozsystemmonitor == 0.3 14:40:00 INFO - moztest == 0.8 14:40:00 INFO - mozversion == 1.4 14:40:00 INFO - psutil == 3.1.1 14:40:00 INFO - requests == 1.2.3 14:40:00 INFO - wsgiref == 0.1.2 14:40:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:40: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')]} 14:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40: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')]} 14:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:00 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 0x23491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b9090>, '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 0x26b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b3f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906', '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 14:40:00 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 14:40:00 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 14:40:00 INFO - Using env: {'DISPLAY': ':0', 14:40:00 INFO - 'HOME': '/home/cltbld', 14:40:00 INFO - 'LANG': 'en_US.UTF-8', 14:40:00 INFO - 'LANGUAGE': 'en_US:en', 14:40:00 INFO - 'LOGNAME': 'cltbld', 14:40:00 INFO - 'MAIL': '/var/mail/cltbld', 14:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:00 INFO - 'MOZ_NO_REMOTE': '1', 14:40:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:00 INFO - 'NO_EM_RESTART': '1', 14:40:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:00 INFO - 'PWD': '/builds/slave/test', 14:40:00 INFO - 'SHELL': '/bin/bash', 14:40:00 INFO - 'SHLVL': '1', 14:40:00 INFO - 'TERM': 'linux', 14:40:00 INFO - 'TMOUT': '86400', 14:40:00 INFO - 'USER': 'cltbld', 14:40:00 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906', 14:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:00 INFO - '_': '/tools/buildbot/bin/python'} 14:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:00 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)) 14:40:00 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)) 14:40:00 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)) 14:40:00 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)) 14:40:00 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)) 14:40:00 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)) 14:40:00 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)) 14:40:00 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)) 14:40:00 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)) 14:40:00 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 14:40:01 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)) 14:40:01 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)) 14:40:01 INFO - Installing collected packages: simplejson 14:40:01 INFO - Running setup.py install for simplejson 14:40:01 INFO - building 'simplejson._speedups' extension 14:40:01 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 14:40:02 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 14:40:02 INFO - Successfully installed simplejson 14:40:02 INFO - Cleaning up... 14:40:02 INFO - Return code: 0 14:40:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b9090>, '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 0x26b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b3f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906', '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 14:40:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:40:02 INFO - Using env: {'DISPLAY': ':0', 14:40:02 INFO - 'HOME': '/home/cltbld', 14:40:02 INFO - 'LANG': 'en_US.UTF-8', 14:40:02 INFO - 'LANGUAGE': 'en_US:en', 14:40:02 INFO - 'LOGNAME': 'cltbld', 14:40:02 INFO - 'MAIL': '/var/mail/cltbld', 14:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:02 INFO - 'MOZ_NO_REMOTE': '1', 14:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:02 INFO - 'NO_EM_RESTART': '1', 14:40:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:02 INFO - 'PWD': '/builds/slave/test', 14:40:02 INFO - 'SHELL': '/bin/bash', 14:40:02 INFO - 'SHLVL': '1', 14:40:02 INFO - 'TERM': 'linux', 14:40:02 INFO - 'TMOUT': '86400', 14:40:02 INFO - 'USER': 'cltbld', 14:40:02 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906', 14:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:02 INFO - '_': '/tools/buildbot/bin/python'} 14:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:40:03 INFO - Cleaning up... 14:40:03 INFO - Return code: 0 14:40:03 INFO - Running post-action listener: _resource_record_post_action 14:40:03 INFO - Running post-action listener: _start_resource_monitoring 14:40:03 INFO - Starting resource monitoring. 14:40:03 INFO - [mozharness: 2017-09-08 21:40:03.063102Z] Finished create-virtualenv step (success) 14:40:03 INFO - [mozharness: 2017-09-08 21:40:03.064107Z] Running install step. 14:40:03 INFO - Running pre-action listener: _resource_record_pre_action 14:40:03 INFO - Running main action method: install 14:40:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:40:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:40:03 INFO - Reading from file tmpfile_stdout 14:40:03 INFO - Detecting whether we're running mozinstall >=1.0... 14:40:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:40:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:40:03 INFO - Reading from file tmpfile_stdout 14:40:03 INFO - Output received: 14:40:03 INFO - Usage: mozinstall [options] installer 14:40:03 INFO - Options: 14:40:03 INFO - -h, --help show this help message and exit 14:40:03 INFO - -d DEST, --destination=DEST 14:40:03 INFO - Directory to install application into. [default: 14:40:03 INFO - "/builds/slave/test"] 14:40:03 INFO - --app=APP Application being installed. [default: firefox] 14:40:03 INFO - mkdir: /builds/slave/test/build/application 14:40:03 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'] 14:40:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:40:19 INFO - Reading from file tmpfile_stdout 14:40:19 INFO - Output received: 14:40:19 INFO - /builds/slave/test/build/application/firefox/firefox 14:40:19 INFO - Running post-action listener: _resource_record_post_action 14:40:19 INFO - [mozharness: 2017-09-08 21:40:19.798016Z] Finished install step (success) 14:40:19 INFO - [mozharness: 2017-09-08 21:40:19.798123Z] Running setup-mitmproxy step. 14:40:19 INFO - Running pre-action listener: _resource_record_pre_action 14:40:19 INFO - Running main action method: setup_mitmproxy 14:40:19 INFO - Skipping: mitmproxy is not required 14:40:19 INFO - Running post-action listener: _resource_record_post_action 14:40:19 INFO - [mozharness: 2017-09-08 21:40:19.798591Z] Finished setup-mitmproxy step (success) 14:40:19 INFO - [mozharness: 2017-09-08 21:40:19.798682Z] Running run-tests step. 14:40:19 INFO - Running pre-action listener: _resource_record_pre_action 14:40:19 INFO - Running pre-action listener: _set_gcov_prefix 14:40:19 INFO - Running main action method: run_tests 14:40:19 WARNING - Try message not found. 14:40:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:40:19 INFO - Python 2.7.3 14:40:19 INFO - Return code: 0 14:40:19 INFO - grabbing minidump binary from tooltool 14:40: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')]} 14:40:19 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 0x26b9090>, '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 0x26b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b3f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:40:19 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 14:40:19 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 14:40:19 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 14:40:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:40:20 INFO - Return code: 0 14:40:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:40:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:40:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:40:20 INFO - ENV: RUST_BACKTRACE is now full 14:40:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:40:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:40:20 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/IMacF5BeTkyX-9dYE2IlAA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 14:40:20 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/IMacF5BeTkyX-9dYE2IlAA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 14:40:20 INFO - Using env: {'DISPLAY': ':0', 14:40:20 INFO - 'HOME': '/home/cltbld', 14:40:20 INFO - 'LANG': 'en_US.UTF-8', 14:40:20 INFO - 'LANGUAGE': 'en_US:en', 14:40:20 INFO - 'LOGNAME': 'cltbld', 14:40:20 INFO - 'MAIL': '/var/mail/cltbld', 14:40:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:40:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:20 INFO - 'MOZ_NO_REMOTE': '1', 14:40:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:40:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:20 INFO - 'NO_EM_RESTART': '1', 14:40:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:20 INFO - 'PWD': '/builds/slave/test', 14:40:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:40:20 INFO - 'RUST_BACKTRACE': 'full', 14:40:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:40:20 INFO - 'SHELL': '/bin/bash', 14:40:20 INFO - 'SHLVL': '1', 14:40:20 INFO - 'TERM': 'linux', 14:40:20 INFO - 'TMOUT': '86400', 14:40:20 INFO - 'USER': 'cltbld', 14:40:20 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906', 14:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:20 INFO - '_': '/tools/buildbot/bin/python'} 14:40:20 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/IMacF5BeTkyX-9dYE2IlAA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 14:40:20 INFO - mozversion application_buildid: 20170908201532 14:40:20 INFO - mozversion application_changeset: dd3736e98e4e7558af2f202803bce36278a26c66 14:40:20 INFO - mozversion application_display_name: Nightly 14:40:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:40:20 INFO - mozversion application_name: Firefox 14:40:20 INFO - mozversion application_remotingname: firefox 14:40:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:40:20 INFO - mozversion application_vendor: Mozilla 14:40:20 INFO - mozversion application_version: 57.0a1 14:40:20 INFO - mozversion platform_buildid: 20170908201532 14:40:20 INFO - mozversion platform_changeset: dd3736e98e4e7558af2f202803bce36278a26c66 14:40:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:40:20 INFO - mozversion platform_version: 57.0a1 14:40:20 INFO - using testdate: 1504906820 14:40:20 INFO - actual date: 1504906820 14:40:20 INFO - starting webserver on 'localhost:51844' 14:40:20 INFO - SUITE-START | Running 2 tests 14:40:20 INFO - TEST-START | dromaeo_css 14:40:20 INFO - Initialising browser for dromaeo_css test... 14:40:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51844/getInfo.html -profile /tmp/tmp7Y7GWp/profile 14:40:20 INFO - TEST-INFO | started process 3553 (/builds/slave/test/build/application/firefox/firefox http://localhost:51844/getInfo.html) 14:40:27 INFO - TEST-INFO | 3553: exit 0 14:40:27 INFO - Browser initialized. 14:40:27 INFO - Running cycle 1/1 for dromaeo_css test... 14:40:27 INFO - Using env: {'DISPLAY': ':0', 14:40:27 INFO - 'HOME': '/home/cltbld', 14:40:27 INFO - 'JSGC_DISABLE_POISONING': '1', 14:40:27 INFO - 'LANG': 'en_US.UTF-8', 14:40:27 INFO - 'LANGUAGE': 'en_US:en', 14:40:27 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:40:27 INFO - 'LOGNAME': 'cltbld', 14:40:27 INFO - 'MAIL': '/var/mail/cltbld', 14:40:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:40:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:40:27 INFO - 'MOZ_CRASHREPORTER': '1', 14:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:27 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:40:27 INFO - 'MOZ_NO_REMOTE': '1', 14:40:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:40:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:27 INFO - 'NO_EM_RESTART': '1', 14:40:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:27 INFO - 'PWD': '/builds/slave/test', 14:40:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:40:27 INFO - 'RUST_BACKTRACE': 'full', 14:40:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:40:27 INFO - 'SHELL': '/bin/bash', 14:40:27 INFO - 'SHLVL': '1', 14:40:27 INFO - 'TERM': 'linux', 14:40:27 INFO - 'TMOUT': '86400', 14:40:27 INFO - 'USER': 'cltbld', 14:40:27 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906', 14:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:27 INFO - '_': '/tools/buildbot/bin/python'} 14:40:27 INFO - TEST-INFO | started process 3755 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7Y7GWp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:40:28 INFO - PID 3755 | 14:40:28 INFO - PID 3755 | (/builds/slave/test/build/application/firefox/firefox:3807): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:40:28 INFO - PID 3755 | 14:40:38 INFO - PID 3755 | RSS: Main: 165007360 14:40:38 INFO - PID 3755 | 14:43:35 INFO - PID 3755 | Cycle 1(1): loaded http://localhost:51844/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51844/tests/dromaeo/cssquery-ext.html) 14:43:37 INFO - PID 3755 | RSS: Main: 168390656 14:43:37 INFO - PID 3755 | 14:46:38 INFO - PID 3755 | Cycle 1(1): loaded http://localhost:51844/tests/dromaeo/cssquery-ext.html (next: http://localhost:51844/tests/dromaeo/cssquery-jquery.html) 14:46:39 INFO - PID 3755 | RSS: Main: 165138432 14:46:39 INFO - PID 3755 | 14:49:40 INFO - PID 3755 | Cycle 1(1): loaded http://localhost:51844/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51844/tests/dromaeo/cssquery-mootools.html) 14:49:41 INFO - PID 3755 | RSS: Main: 166723584 14:49:41 INFO - PID 3755 | 14:52:42 INFO - PID 3755 | Cycle 1(1): loaded http://localhost:51844/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51844/tests/dromaeo/cssquery-prototype.html) 14:52:43 INFO - PID 3755 | RSS: Main: 166064128 14:52:43 INFO - PID 3755 | 14:55:46 INFO - PID 3755 | Cycle 1(1): loaded http://localhost:51844/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51844/tests/dromaeo/cssquery-yui.html) 14:55:47 INFO - PID 3755 | RSS: Main: 166805504 14:55:47 INFO - PID 3755 | 14:58:49 INFO - PID 3755 | Cycle 1(1): loaded http://localhost:51844/tests/dromaeo/cssquery-yui.html (next: http://localhost:51844/tests/dromaeo/cssquery-dojo.html) 14:58:49 INFO - PID 3755 | RSS: Main: 169922560 14:58:49 INFO - PID 3755 | 14:58:49 INFO - PID 3755 | __start_tp_report 14:58:49 INFO - PID 3755 | _x_x_mozilla_page_load 14:58:49 INFO - PID 3755 | _x_x_mozilla_page_load_details 14:58:49 INFO - PID 3755 | |i|pagename|runs| 14:58:49 INFO - PID 3755 | |0;dojo.html;3817.274717803617;3830.846766129354;3844.288806570786;3883.495145631069;3889.863854765084;6268.937310626904;6352.68236588171;6421.325760795119;6429.485641148709;6458.386453286936;6393.392627700361;6422.036694495828;6478.773242936498;6503.349665033495;6524.510661700368;5691.345495268035;5802.651840889539;5807.983602869502;5818.621789583684;5844.795432159875;115.90085348670532;5471;5703.429657034305;5788.826335209929;5793.942060579382;5712.542996560286;5747.885042299152;5815.825525234229;5816.563757718188;5830.82507524775;5744.6840423776675;5748.109043098327;5821.09772985188;5826.446487583715;5827.88344233113;5717.742701578439;5724.685142317171;5801.680907550083;5811.82564523065;5812.099124635688;6269.592476489013;6388.201474815648;6400.839979000562;6452.451541618968;6497.382748638872;6870.862582748317;6887.345702158287;6917;6955.061066755974;6971.79084627462;6951.478639102037;7004.859902801966;7005.474589405764;7006.824829379307;7021.859562808766;6399.328070552571;6399.488040956712;6399.87200255997;6469.514786390992;6489.059086432488;7088.503804733619;7091.89362159568;7105.609191494517;7105.964470177616;7106.822329441702;6786.626735529495;6793.116894803743;6793.72825086991;6796.898046529306;6801.319868013159;6828.931710682829;6857.828554286183;6909.861802763917;6915.827104322331;6919.688614012382;6873.347032031949;6888.690008949609;6924.203716572558;6985.301469852974;6986.860262794716;6923.099997000459;6925.6190909500465;6980.232174460805;7021.89467157993;7026.859462810818;5010.148274793294;5015.623828212899;5056.620753443506;5069.44236134025;5093.286939828427;4433.911321773611;4536.047430039663;4557.430321209848;4615.699979501389;4668.393108895822;6325;6364.681765911686;6364.681765911686;6378.649174295366;6379.393957574023;6882.449404047664;6910.239873613898;6929.5842249465195;6963.09479767627;6968.268331825187;6266.216722909637;6303.873922521524;6329.68351582419;6364.936350636527;6393.9360606394275;5553.833384998376;5602.271704678447;5608.9719551402795;5609.1305847593685;5610.298712660918;7081.681324340417;7126.394256488153;7162.785116446515;7170.8207294817;7177.92822071783;6834.384905358542;6860.142482189726;6866.553674011173;6932.306769323028;6948.791536253921;7011.193712723102;7072.646367681698;7089.432845372461;7107.324804143598;7178.282171782989;6718.630475323708;6829.726810927507;6838.04267402574;6842.418394436529;6846.041554182319;6900.068490753684;6984.441244700513;7045.577265364094;7055.611941343275;7056.964715176391;6673.399394054364;6737.461003119836;6737.764178253738;6762.830929226809;6779.796606101825;6597.703103360264;6632.336766323329;6637.070810086495;6700.798976030727;6729.495287853529;6581.868362632625;6590.934090659032;6596.109525214035;6603.603783772989;6606.471482281502;6657.733690652513;6732.360425759545;6767.1879374475375;6785.2536221016635;6881.243063262937;6483.157189565326;6517.543771936109;6583.374579414948;6588.571742836892;6603.735850566116 14:58:49 INFO - PID 3755 | |1;ext.html;957.1098878043417;960.313375936206;970.1801977329156;1013.7820368620747;1013.8580598716177;43260.56739432605;43686.78156609216;43720;43771.56228437715;43782.56217437825;39646.20707585847;42670.57329426705;43360.3495947561;43365.34951975723;43392.78303608485;7900.723474678373;8014.118446970829;8015.7194498192575;8043.316318112968;8049.919500805005;7916;8040.798980025487;8044.919550804476;8048.758537243892;8064.516129032248;8020.959895200516;8038.236367545103;8043.638036288381;8095.878561821577;8101.756947291591;8016.238457346542;8030.5181689098845;8033.718819841307;8054.355651547862;8058.516489010678;7814.921850781477;7943.483673561258;7952.244536768998;7953.085395179571;7953.721619743281;40014;40283;40311.79844100761;40461;40539;3778;3813.809309534512;3814.275287695329;3814.8855534334016;3815.9618403815884;32621.51067733986;32691.83654081738;32729.181770455692;32851;32857.50713739296;5432.076546986982;5439.184122381635;5483.341998960111;5493.395726470085;5577.2191893135;224699;224817;226473;227248;227870;51702;52569.47430525722;52950;53004.204936925205;53058.73470632699;54663.18005229925;54965;55066;55082.44917550773;55136.17295740567;15848.286827092808;15965;15980.200989950456;15992.280347384396;15992.440264590683;12975.351232438341;12982.415791289415;12983.28591927453;12990.480380784662;13001.414936327888;13155.671108222372;13189.538366157138;13283.933580332037;13367.933160334136;13496;5292.25355632648;5319;5357.223202635596;5378.04713535551;5442.782288708408;1062.2829590026702;1093.6773651772746;1104.861892263467;1121.770037142384;1122.3041714137123;25603;25662.615060774104;25757.8712106442;25817.870910645703;25886.870565647052;1211.8061110222322;1218.5552273420137;1219.3598360860442;1220.8473940757406;1234.5247079874314;13320.733585328238;13388.19670819754;13518.391672374766;13572;13650.522231722041;295426;296120;296217;296279;297031;55730;56110.15834762482;56164.71917640386;59950;60108.39891601115;1492.1643879427556;1498.7826765119214;1503.2784263553556;1519.8708109810568;1530.4490383461946;28469.715302847533;28528.857355713088;28839.741001600014;29087.85456072706;29151.708482915747;39628.40557391699;39719.205615886945;39805;39806.800965996146;39811.20377592374;258790;258987;259523;260965;261153;31615.841920790248;32212.516812248305;34339.14152146116;34555.827220863735;35455.11362215965;46465.53534464612;46537;47039.529604703515;47477.28784068311;47858.28212576884;34501.48247776235;34760.13099672528;34809.77853322022;35440.29119417649;35462.64537354697;34426.655733443346;34571.654283456846;34647.82676086603;34891.82554087213;35176.648233517335;39303.41044884272;39796.40305395363;39956;40084;40397.59602404056;33403.665963340056;33413.49879751757;33546.329073418885;33743.4938475928;34184.316313674084;25430.49139017246;25478.23565293044;25570.744292556836;25900.61149082803;25953.22140335793 14:58:49 INFO - PID 3755 | |2;jquery.html;578.3782433883576;580.2196046317702;585.183668782049;593.1044123373705;604.9788257410991;23203.535929281403;24005.159819406323;24034.15880444185;24037;24121.75878241217;25066.498670026634;25461;25593.104241351557;25697;25716.485670286584;6560.606363618174;6691.933080669191;6703.497237707192;6716.690245402148;6732.798016059502;6464.418202361787;6697.129373181479;6855.554388964726;6948.930510694904;6969.825754356131;6645.169353830771;6702.564333318319;6723.193216813989;6726.461883049345;6728.4953628477815;6546.247181574085;6688.765893193739;6696.631685257309;6703.162104736908;6830.658467076676;6329.651869147195;6340.397662222128;6341.714622841983;6342.143810585604;6358.300586935434;28868.422631547463;29284.121476355744;29285;29331;29379.853100734574;2322.1175953137868;2344.7303560090636;2348;2350.25966820451;2352.6823878776318;19879.40361789134;20326.88202148881;20495.18019279227;20635.071421786055;20677.689834652494;2565.24325324028;2597.0910181436534;2639.7624213820654;2643.524165650182;2648.205538338491;131786;139814;140863;148415;148499.25750371287;14912.70174596502;15436.38254469831;15473.690526189414;15784.526464205863;15948.840511594735;24392.756072439402;24421;24534;24566.877165614056;24578.262652120466;9885.406875587487;10010.699679009642;10017.899821001842;10116.949415253024;10236.436995965294;8988.685396011108;8997.190252877272;9069.138431849096;9127.680531181377;9148.405353651991;9725.221982241404;9867.358621689567;9882.654107106217;9985.20118390527;9989.102070606561;2875.6980517045827;2886.7834912381654;2903.462859371023;2917.2852651100616;2997.7751668624505;1032.6437379104198;1037.822071948329;1042.7810159866513;1053.3206082077018;1055.8257887448638;19888.403347899588;20336.59326813485;20365.592688146153;20750.273740419012;20878.478038048866;1065.1159537583787;1078.2829418436809;1082.0748260237542;1084.902358787713;1096.3586302013412;11142.944285278683;11420.714482137846;11457.59898403552;11648.256205731373;11775.52897884075;590605;593916;596710;597148;613579;125822.3708881468;129604;129791.75520612061;131491;131855;1200.9279443233258;1203.284045992633;1209.6733881852026;1220.408102070495;1224.1247508031622;18109.637807244046;18328.266869325078;18511.629767404305;18593;18598.53503662419;60644;61209.69395152996;61498.385016151056;62259.6887015562;62979.37020629735;76920;77232.22767772475;77522;77615.61192194003;78477;15218.239088045775;15230.543083707507;15353.846461535688;15407;15422.845771542141;23878;24010.27969160928;24166.758332417154;24200.757992420557;24476.510469790148;19565;19630.803691962898;19726.605467890276;19821.30625428103;19827.900860495603;16660.16699165061;16905.32378704838;17476.213570389617;17501.56246093807;17554.297828087245;19900.70148947796;20196.394108176777;20237.898810505852;20306.59386812285;20370.28703995353;14988.175650339335;15030;15149;15162.469313573973;15182.924085379502;18473.16870740793;18560.979146147092;18830.905845470686;19250.518737031685;19303.131359088595 14:58:49 INFO - PID 3755 | |3;mootools.html;1442.1995792335254;1462.225020739008;1492.2986196487648;1492.9402823887044;1497.7977972973645;16537.586560335996;17124.743128853046;17187.570310742223;17192.82807171928;17194.570135746613;16568.337266509356;16616.66766664666;16746.916265418655;16771.161441927918;16844.74732879008;2829.1795379339965;2875.568664700291;2885.5671649252677;2889.537673972165;2891.9710802891914;2712.5795501697266;2817.197098826835;2835.6313679221776;2836.2342167614734;2837.900673476429;2618.738126187385;2789.9302517437022;2807.5507918733006;2809.3678922242534;2810.0445848411537;2795.958060629082;2835.6030155778103;2854.9857250713717;2855;2858.0139851751114;2732.53546897028;2765.9861700691567;2780.88876444942;2782.1514438096374;2794.9580756288674;16481.423150189687;16614.75077873833;16754.832451675447;16784.244708988124;16875.831241687672;8196.13940536241;8487;8496.447730897471;8512.78718032048;8514.063453020162;5375.65058271215;5506.64206826559;5552.944470555283;5683.658980461186;5712.771489140429;2116.386247988097;2119.109973811003;2140.8073273405466;2185.530111026121;2197.604431202383;29796.70203297961;29987;30112.69887301121;30117.69882301171;30168.396632067455;7123.89314160288;7141.642917854087;7184.1019872515935;7271.67277472515;7313.085864266966;18825.435236942914;18846.623067538574;18885.244590216236;18900.05499725008;18949.526261843563;8343.54110523927;8533.658653653909;8541.14588541141;8542.145785421408;8550.657973681107;7465.477416580896;7515.812104697427;7561.9243807562325;7645.044369453818;7646.311831935152;5443.945560544423;5663.263775709213;5670.092785154356;5709.143628455682;5709.857253568694;1567.7256480115934;1570.646604513998;1584.8525248288634;1606.7268564343856;1614.77393164957;981.4896253947907;1009.4548943570536;1012.6506355307407;1016.0804471952895;1036.8703912011;9347.859782103274;9464.763380915532;9605.135537801492;9613.230941524662;9626.759331016641;1059.660908509285;1065.8347956066823;1067.4662668665667;1069.8448724934997;1106.043272569222;5534.335879694382;6017.217761691039;6022.638641681426;6255.030470277115;6371.872562548723;24806.131785387424;25273.494530109296;25446;25689.614655780177;25705.614415783777;23715;24938.750612494005;25675.229743107735;25701.614475782877;25747.87126064395;11799.941000295115;12169.20900141488;12355.876441235472;12400.81398779001;12418.627441176779;10100.292979491365;10341.37951722899;10405.398650337416;10739.946300268448;10770.784584308427;21706;21793.038626523055;21879.45301367415;22104.778952210272;22565;22323.330300091024;22325.218617348313;22325.888370558045;22365.440863978532;22598.774012259666;13462.192268463923;13535.458581657018;13735.175889446666;13784.655383615489;13880.375383107583;15217.77173342423;15516.379344826531;15552.533423997298;15563;15578.922105389855;12359.3820308986;12419;12453.93773031129;12508.437120329789;12567.18313309632;11366.204365694322;11628.360440175871;11796.941015295211;11801;11867.109966752356;11311.264767790397;11392.886071139183;11458.083353331547;11498.425078746197;11521.654350369166;8497.660093596187;8562.357823163413;8620.13798620133;8620.353473489638;8754.168354006359;8583.742487725378;8606.483610983361;8668.0898505656;8691.391602587759;8750.781230469289 14:58:49 INFO - PID 3755 | |4;prototype.html;544.9019176548222;546.9288992430986;573.2118337286231;575.5510701652711;581.8370856160277;6004.519638428927;6181.381861813817;6189.690515474225;6253.312135665079;6295.716692748826;6115.510759139269;6184.350643182457;6274.780382686596;6281.937180628192;6290.433860952513;5154.845354639367;5184.922226166611;5187.610929180327;5198.246254293125;5217.426083130853;5044.688381020943;5057.620678449131;5144.974275128619;5165.509276618715;5216.7391630418515;5137.820176293831;5176.948230517703;5200.0759718904055;5208.687478751268;5231.319928409302;5076.111680455905;5148.407933087706;5201.5838732901275;5228.163493840967;5236.7119808410525;4769.594584460325;4788.569028787391;4844.546636009183;4867;4870.951290487121;6218.4714299284615;6264.655443950581;6280.434760871498;6290.119383286344;6318.557700960934;6120.449159575615;6120.785772497941;6163.352847950945;6174;6178.84552886177;6657.434118099967;6703.162104736908;6727.562708423937;6747.190337159573;6761.154855643044;5384.300040994684;5432.483914028161;5476;5494.203340515603;5498.697571633558;6970.79087627372;7003.404710599605;7020.894686579705;7052.61210633415;7095.467839911976;5568.16477528374;5584.664920104807;5603.915941260884;5637.8590535236945;5641.605087643826;5723.656580605094;5727.341355744059;5736.799212027559;5764.798232061858;5765.509931655773;6130.344806902201;6131.908021379683;6145;6166.167567378437;6242.313345531988;6600.699650174913;6662.600243985376;6684.395745021257;6687.7993660189295;6703.994400839913;1887.6979683250613;1892.4228110426452;1935.4097000414727;1963.7741659709316;1979.0104947526238;1447.7538818400687;1469.4644096918746;1475.8671719545293;1483.1546018769197;1506.7739839024234;6000.909986350208;6010.819675409744;6011.939880601226;6095.342794323459;6165.136880836686;6657.367550082734;6696.06255124283;6706.981858163846;6716.832079197961;6834.8633027340165;6151.876962460726;6152.630842149485;6174.475169610543;6194.4115309045565;6231.657258850807;3545.592256890439;3549.7870127792416;3573.2496175802853;3584;3629.528161339009;7057.788266352018;7060.188078371053;7071.752488662872;7112.293049668043;7139.928600713926;7012.158540975116;7029.472789540702;7082.662721301958;7092.326229008339;7124.715011399486;7067.187273463412;7081.398081163055;7101.2898710128575;7123.857522849514;7134.714611415693;6713.261541230363;6770.763023294161;6783.3555812197765;6835;6883.965580172067;6757.358050985148;6759.324067593201;6799.422049125879;6809.897851532132;6815.318468153145;7103.25415831351;7129.4652901031595;7131.928680713334;7145.9285407147345;7153.2131465537705;5217.4260831307765;5229.947700522946;5233.450487698889;5247.399543139379;5263.5525980292105;6599.106527149005;6613.206415230203;6712.993051042383;6867.725290988305;6877.277885822116;6528.183977002875;6569.540132190701;6584.078229048033;6617.536772425884;6618.768343107968;6492.929111280968;6519.4132528072705;6532.379423954717;6600.60396376219;6614.338566143347;6382.36176382358;6409.775657851953;6497.675116244074;6542.378474044958;6563.310852360433;6643.2360278568585;6644.966775166094;6652.035454859115;6656;6669.266380698023;6344.492440604833;6419.716056788754;6424.582402143846;6452.22573291208;6525.119108920425 14:58:49 INFO - PID 3755 | |5;yui.html;990.1089019882106;992.6228033347322;994.6618149829061;995.4624502768505;1017.6489111256616;18214;18301.35945241917;18453.630927381444;18464.446066618006;18489.445316640504;17568.121593920318;17758.82241177591;17780.288788448477;17785.82214177858;17828.55428614285;1058.8305871060631;1060.628779927025;1080.389579887365;1086.0551320351267;1086.3970496374548;1077.245927850504;1084.7396624810067;1086.8532748079026;1087.141158484796;1089.9073578745815;1184.0645889747088;1185.887340702632;1186.2170967161633;1188.9405529723522;1191.7556900835352;1176.4176732517374;1181.0256538355804;1181.3561608923158;1184.3782014442443;1186.1696812231473;863.063576020019;864.1790299215708;864.2006144316482;864.5633954852759;865.8657908024267;18955.71566426491;19272.614547708967;19365.225390984484;19407.708884366744;20257.898710506353;22662;23020.884895575415;23043.769562304497;23053.538929221322;23073.653895191586;17909.283628654837;17951.73072403902;18016.279348826163;18082.276708931626;18164.636707265912;3897.2984862724697;3962.0491082140366;4062.1469491406547;4063.3701776224734;4072.8574499892657;147973;148246;148411;151991;153438.23280883636;17548.29806807739;17550.29798808059;17613.207405666777;17780.91109544444;17869.553261168574;31970.520442193385;32093;32123.51814722781;32166.19584510406;32465.35069298648;8550.102239264788;8583.785405364792;8635.136486351315;8642.870356944652;8654.87017694735;4371.344298355209;4473.910521789611;4487.753173575485;4489.932651010237;4491.079328737601;5764.077747560454;5902.498287645512;5904.9704751475965;5920.052791553331;5941.940580594225;1108.9279196852178;1129.6272230164027;1147.6843867936218;1152.521703493041;1156.699258192876;703.2440126863539;722.1803253307429;738.7119023580808;752.8833030880222;760.6577040331873;12536.252502109024;12633.2420054797;12920.741585168244;12937.935310323388;13294.667633309246;690.520088538461;693.3551796828998;694.9861002779916;696.3245651717825;703.3353480960443;5640.125780504029;5667.489925906688;5684.289463817023;5701.230333904953;5769.653820770767;139005;139403;140353.2982335082;141381;145947;115574.4221278905;116842;118293;121541;124263;100103.49948250358;101031.4948425268;102147;103015.9999999985;104295;10680.359178449318;10720.19598530129;10849.67450976472;10868.891311086787;11167.329960202414;49600.50399495959;51093.74453127859;51094.74452627713;51805;52112.47887521228;66217;66407.66796165988;66737.33262667505;66954;67592;16618.584535386228;16663.50009499717;16889;17021.31914723397;17061.232244549272;17682.204300806752;17726;17952.730709039115;17975.101244937963;18121.36575219861;17401;17501.737473938156;17593.472195833634;17659.205335759663;17714.20286087155;17516.649667006335;17695.823041769418;17730.468085957444;17870.731939021185;17963.550911227325;16169.434069807501;16248.593785155466;16313.755293670842;16453.42413015539;16522.17389130563;11604;11815.822762658396;11820.645380638594;11863.76272474563;12056.276623402624;12043.277403355827;12354.814677780021;12386.451693538307;12606.55877044299;12770.808437873253 14:58:49 INFO - PID 3755 | __end_tp_report 14:58:49 INFO - PID 3755 | __start_cc_report 14:58:49 INFO - PID 3755 | _x_x_mozilla_cycle_collect,363 14:58:49 INFO - PID 3755 | __end_cc_report 14:58:49 INFO - PID 3755 | __startTimestamp1504907929279__endTimestamp 14:58:49 INFO - PID 3755 | 14:58:49 INFO - PID 3755 | ------- Summary: start ------- 14:58:49 INFO - PID 3755 | Number of tests: 6 14:58:49 INFO - PID 3755 | 14:58:49 INFO - PID 3755 | [#0] dojo.html Cycles:165 Average:6332.04 Median:6597.70 stddev:901.85 (13.7%) stddev-sans-first:882.78 14:58:49 INFO - PID 3755 | Values: 3817.3 3830.8 3844.3 3883.5 3889.9 6268.9 6352.7 6421.3 6429.5 6458.4 6393.4 6422.0 6478.8 6503.3 6524.5 5691.3 5802.7 5808.0 5818.6 5844.8 115.9 5471.0 5703.4 5788.8 5793.9 5712.5 5747.9 5815.8 5816.6 5830.8 5744.7 5748.1 5821.1 5826.4 5827.9 5717.7 5724.7 5801.7 5811.8 5812.1 6269.6 6388.2 6400.8 6452.5 6497.4 6870.9 6887.3 6917.0 6955.1 6971.8 6951.5 7004.9 7005.5 7006.8 7021.9 6399.3 6399.5 6399.9 6469.5 6489.1 7088.5 7091.9 7105.6 7106.0 7106.8 6786.6 6793.1 6793.7 6796.9 6801.3 6828.9 6857.8 6909.9 6915.8 6919.7 6873.3 6888.7 6924.2 6985.3 6986.9 6923.1 6925.6 6980.2 7021.9 7026.9 5010.1 5015.6 5056.6 5069.4 5093.3 4433.9 4536.0 4557.4 4615.7 4668.4 6325.0 6364.7 6364.7 6378.6 6379.4 6882.4 6910.2 6929.6 6963.1 6968.3 6266.2 6303.9 6329.7 6364.9 6393.9 5553.8 5602.3 5609.0 5609.1 5610.3 7081.7 7126.4 7162.8 7170.8 7177.9 6834.4 6860.1 6866.6 6932.3 6948.8 7011.2 7072.6 7089.4 7107.3 7178.3 6718.6 6829.7 6838.0 6842.4 6846.0 6900.1 6984.4 7045.6 7055.6 7057.0 6673.4 6737.5 6737.8 6762.8 6779.8 6597.7 6632.3 6637.1 6700.8 6729.5 6581.9 6590.9 6596.1 6603.6 6606.5 6657.7 6732.4 6767.2 6785.3 6881.2 6483.2 6517.5 6583.4 6588.6 6603.7 14:58:49 INFO - PID 3755 | 14:58:49 INFO - PID 3755 | [#1] ext.html Cycles:180 Average:43500.47 Median:35458.88 stddev:68358.87 (192.8%) stddev-sans-first:68476.00 14:58:49 INFO - PID 3755 | Values: 957.1 960.3 970.2 1013.8 1013.9 43260.6 43686.8 43720.0 43771.6 43782.6 39646.2 42670.6 43360.3 43365.3 43392.8 7900.7 8014.1 8015.7 8043.3 8049.9 7916.0 8040.8 8044.9 8048.8 8064.5 8021.0 8038.2 8043.6 8095.9 8101.8 8016.2 8030.5 8033.7 8054.4 8058.5 7814.9 7943.5 7952.2 7953.1 7953.7 40014.0 40283.0 40311.8 40461.0 40539.0 3778.0 3813.8 3814.3 3814.9 3816.0 32621.5 32691.8 32729.2 32851.0 32857.5 5432.1 5439.2 5483.3 5493.4 5577.2 224699.0 224817.0 226473.0 227248.0 227870.0 51702.0 52569.5 52950.0 53004.2 53058.7 54663.2 54965.0 55066.0 55082.4 55136.2 15848.3 15965.0 15980.2 15992.3 15992.4 12975.4 12982.4 12983.3 12990.5 13001.4 13155.7 13189.5 13283.9 13367.9 13496.0 5292.3 5319.0 5357.2 5378.0 5442.8 1062.3 1093.7 1104.9 1121.8 1122.3 25603.0 25662.6 25757.9 25817.9 25886.9 1211.8 1218.6 1219.4 1220.8 1234.5 13320.7 13388.2 13518.4 13572.0 13650.5 295426.0 296120.0 296217.0 296279.0 297031.0 55730.0 56110.2 56164.7 59950.0 60108.4 1492.2 1498.8 1503.3 1519.9 1530.4 28469.7 28528.9 28839.7 29087.9 29151.7 39628.4 39719.2 39805.0 39806.8 39811.2 258790.0 258987.0 259523.0 260965.0 261153.0 31615.8 32212.5 34339.1 34555.8 35455.1 46465.5 46537.0 47039.5 47477.3 47858.3 34501.5 34760.1 34809.8 35440.3 35462.6 34426.7 34571.7 34647.8 34891.8 35176.6 39303.4 39796.4 39956.0 40084.0 40397.6 33403.7 33413.5 33546.3 33743.5 34184.3 25430.5 25478.2 25570.7 25900.6 25953.2 14:58:49 INFO - PID 3755 | 14:58:49 INFO - PID 3755 | [#2] jquery.html Cycles:180 Average:38979.46 Median:23941.58 stddev:99930.82 (417.4%) stddev-sans-first:100169.55 14:58:49 INFO - PID 3755 | Values: 578.4 580.2 585.2 593.1 605.0 23203.5 24005.2 24034.2 24037.0 24121.8 25066.5 25461.0 25593.1 25697.0 25716.5 6560.6 6691.9 6703.5 6716.7 6732.8 6464.4 6697.1 6855.6 6948.9 6969.8 6645.2 6702.6 6723.2 6726.5 6728.5 6546.2 6688.8 6696.6 6703.2 6830.7 6329.7 6340.4 6341.7 6342.1 6358.3 28868.4 29284.1 29285.0 29331.0 29379.9 2322.1 2344.7 2348.0 2350.3 2352.7 19879.4 20326.9 20495.2 20635.1 20677.7 2565.2 2597.1 2639.8 2643.5 2648.2 131786.0 139814.0 140863.0 148415.0 148499.3 14912.7 15436.4 15473.7 15784.5 15948.8 24392.8 24421.0 24534.0 24566.9 24578.3 9885.4 10010.7 10017.9 10116.9 10236.4 8988.7 8997.2 9069.1 9127.7 9148.4 9725.2 9867.4 9882.7 9985.2 9989.1 2875.7 2886.8 2903.5 2917.3 2997.8 1032.6 1037.8 1042.8 1053.3 1055.8 19888.4 20336.6 20365.6 20750.3 20878.5 1065.1 1078.3 1082.1 1084.9 1096.4 11142.9 11420.7 11457.6 11648.3 11775.5 590605.0 593916.0 596710.0 597148.0 613579.0 125822.4 129604.0 129791.8 131491.0 131855.0 1200.9 1203.3 1209.7 1220.4 1224.1 18109.6 18328.3 18511.6 18593.0 18598.5 60644.0 61209.7 61498.4 62259.7 62979.4 76920.0 77232.2 77522.0 77615.6 78477.0 15218.2 15230.5 15353.8 15407.0 15422.8 23878.0 24010.3 24166.8 24200.8 24476.5 19565.0 19630.8 19726.6 19821.3 19827.9 16660.2 16905.3 17476.2 17501.6 17554.3 19900.7 20196.4 20237.9 20306.6 20370.3 14988.2 15030.0 15149.0 15162.5 15182.9 18473.2 18561.0 18830.9 19250.5 19303.1 14:58:49 INFO - PID 3755 | 14:58:49 INFO - PID 3755 | [#3] mootools.html Cycles:180 Average:10524.99 Median:24872.44 stddev:7723.72 (31.1%) stddev-sans-first:7715.24 14:58:49 INFO - PID 3755 | Values: 1442.2 1462.2 1492.3 1492.9 1497.8 16537.6 17124.7 17187.6 17192.8 17194.6 16568.3 16616.7 16746.9 16771.2 16844.7 2829.2 2875.6 2885.6 2889.5 2892.0 2712.6 2817.2 2835.6 2836.2 2837.9 2618.7 2789.9 2807.6 2809.4 2810.0 2796.0 2835.6 2855.0 2855.0 2858.0 2732.5 2766.0 2780.9 2782.2 2795.0 16481.4 16614.8 16754.8 16784.2 16875.8 8196.1 8487.0 8496.4 8512.8 8514.1 5375.7 5506.6 5552.9 5683.7 5712.8 2116.4 2119.1 2140.8 2185.5 2197.6 29796.7 29987.0 30112.7 30117.7 30168.4 7123.9 7141.6 7184.1 7271.7 7313.1 18825.4 18846.6 18885.2 18900.1 18949.5 8343.5 8533.7 8541.1 8542.1 8550.7 7465.5 7515.8 7561.9 7645.0 7646.3 5443.9 5663.3 5670.1 5709.1 5709.9 1567.7 1570.6 1584.9 1606.7 1614.8 981.5 1009.5 1012.7 1016.1 1036.9 9347.9 9464.8 9605.1 9613.2 9626.8 1059.7 1065.8 1067.5 1069.8 1106.0 5534.3 6017.2 6022.6 6255.0 6371.9 24806.1 25273.5 25446.0 25689.6 25705.6 23715.0 24938.8 25675.2 25701.6 25747.9 11799.9 12169.2 12355.9 12400.8 12418.6 10100.3 10341.4 10405.4 10739.9 10770.8 21706.0 21793.0 21879.5 22104.8 22565.0 22323.3 22325.2 22325.9 22365.4 22598.8 13462.2 13535.5 13735.2 13784.7 13880.4 15217.8 15516.4 15552.5 15563.0 15578.9 12359.4 12419.0 12453.9 12508.4 12567.2 11366.2 11628.4 11796.9 11801.0 11867.1 11311.3 11392.9 11458.1 11498.4 11521.7 8497.7 8562.4 8620.1 8620.4 8754.2 8583.7 8606.5 8668.1 8691.4 8750.8 14:58:49 INFO - PID 3755 | 14:58:49 INFO - PID 3755 | [#4] prototype.html Cycles:180 Average:5747.18 Median:6247.81 stddev:1552.90 (24.9%) stddev-sans-first:1507.36 14:58:49 INFO - PID 3755 | Values: 544.9 546.9 573.2 575.6 581.8 6004.5 6181.4 6189.7 6253.3 6295.7 6115.5 6184.4 6274.8 6281.9 6290.4 5154.8 5184.9 5187.6 5198.2 5217.4 5044.7 5057.6 5145.0 5165.5 5216.7 5137.8 5176.9 5200.1 5208.7 5231.3 5076.1 5148.4 5201.6 5228.2 5236.7 4769.6 4788.6 4844.5 4867.0 4871.0 6218.5 6264.7 6280.4 6290.1 6318.6 6120.4 6120.8 6163.4 6174.0 6178.8 6657.4 6703.2 6727.6 6747.2 6761.2 5384.3 5432.5 5476.0 5494.2 5498.7 6970.8 7003.4 7020.9 7052.6 7095.5 5568.2 5584.7 5603.9 5637.9 5641.6 5723.7 5727.3 5736.8 5764.8 5765.5 6130.3 6131.9 6145.0 6166.2 6242.3 6600.7 6662.6 6684.4 6687.8 6704.0 1887.7 1892.4 1935.4 1963.8 1979.0 1447.8 1469.5 1475.9 1483.2 1506.8 6000.9 6010.8 6011.9 6095.3 6165.1 6657.4 6696.1 6707.0 6716.8 6834.9 6151.9 6152.6 6174.5 6194.4 6231.7 3545.6 3549.8 3573.2 3584.0 3629.5 7057.8 7060.2 7071.8 7112.3 7139.9 7012.2 7029.5 7082.7 7092.3 7124.7 7067.2 7081.4 7101.3 7123.9 7134.7 6713.3 6770.8 6783.4 6835.0 6884.0 6757.4 6759.3 6799.4 6809.9 6815.3 7103.3 7129.5 7131.9 7145.9 7153.2 5217.4 5229.9 5233.5 5247.4 5263.6 6599.1 6613.2 6713.0 6867.7 6877.3 6528.2 6569.5 6584.1 6617.5 6618.8 6492.9 6519.4 6532.4 6600.6 6614.3 6382.4 6409.8 6497.7 6542.4 6563.3 6643.2 6645.0 6652.0 6656.0 6669.3 6344.5 6419.7 6424.6 6452.2 6525.1 14:58:49 INFO - PID 3755 | 14:58:49 INFO - PID 3755 | [#5] yui.html Cycles:180 Average:26361.51 Median:17769.56 stddev:39081.83 (219.9%) stddev-sans-first:39145.04 14:58:49 INFO - PID 3755 | Values: 990.1 992.6 994.7 995.5 1017.6 18214.0 18301.4 18453.6 18464.4 18489.4 17568.1 17758.8 17780.3 17785.8 17828.6 1058.8 1060.6 1080.4 1086.1 1086.4 1077.2 1084.7 1086.9 1087.1 1089.9 1184.1 1185.9 1186.2 1188.9 1191.8 1176.4 1181.0 1181.4 1184.4 1186.2 863.1 864.2 864.2 864.6 865.9 18955.7 19272.6 19365.2 19407.7 20257.9 22662.0 23020.9 23043.8 23053.5 23073.7 17909.3 17951.7 18016.3 18082.3 18164.6 3897.3 3962.0 4062.1 4063.4 4072.9 147973.0 148246.0 148411.0 151991.0 153438.2 17548.3 17550.3 17613.2 17780.9 17869.6 31970.5 32093.0 32123.5 32166.2 32465.4 8550.1 8583.8 8635.1 8642.9 8654.9 4371.3 4473.9 4487.8 4489.9 4491.1 5764.1 5902.5 5905.0 5920.1 5941.9 1108.9 1129.6 1147.7 1152.5 1156.7 703.2 722.2 738.7 752.9 760.7 12536.3 12633.2 12920.7 12937.9 13294.7 690.5 693.4 695.0 696.3 703.3 5640.1 5667.5 5684.3 5701.2 5769.7 139005.0 139403.0 140353.3 141381.0 145947.0 115574.4 116842.0 118293.0 121541.0 124263.0 100103.5 101031.5 102147.0 103016.0 104295.0 10680.4 10720.2 10849.7 10868.9 11167.3 49600.5 51093.7 51094.7 51805.0 52112.5 66217.0 66407.7 66737.3 66954.0 67592.0 16618.6 16663.5 16889.0 17021.3 17061.2 17682.2 17726.0 17952.7 17975.1 18121.4 17401.0 17501.7 17593.5 17659.2 17714.2 17516.6 17695.8 17730.5 17870.7 17963.6 16169.4 16248.6 16313.8 16453.4 16522.2 11604.0 11815.8 11820.6 11863.8 12056.3 12043.3 12354.8 12386.5 12606.6 12770.8 14:58:49 INFO - PID 3755 | -------- Summary: end -------- 14:58:49 INFO - PID 3755 | 14:58:49 INFO - TEST-INFO | 3755: exit 0 14:58:50 INFO - TEST-OK | dromaeo_css | took 1109515ms 14:58:50 INFO - TEST-START | kraken 14:58:50 INFO - Initialising browser for kraken test... 14:58:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51844/getInfo.html -profile /tmp/tmp4CP7hr/profile 14:58:50 INFO - TEST-INFO | started process 4130 (/builds/slave/test/build/application/firefox/firefox http://localhost:51844/getInfo.html) 14:58:55 INFO - TEST-INFO | 4130: exit 0 14:58:55 INFO - Browser initialized. 14:58:55 INFO - Running cycle 1/1 for kraken test... 14:58:55 INFO - Using env: {'DISPLAY': ':0', 14:58:55 INFO - 'HOME': '/home/cltbld', 14:58:55 INFO - 'JSGC_DISABLE_POISONING': '1', 14:58:55 INFO - 'LANG': 'en_US.UTF-8', 14:58:55 INFO - 'LANGUAGE': 'en_US:en', 14:58:55 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:58:55 INFO - 'LOGNAME': 'cltbld', 14:58:55 INFO - 'MAIL': '/var/mail/cltbld', 14:58:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:58:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:58:55 INFO - 'MOZ_CRASHREPORTER': '1', 14:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:55 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:58:55 INFO - 'MOZ_NO_REMOTE': '1', 14:58:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:58:55 INFO - 'NO_EM_RESTART': '1', 14:58:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:55 INFO - 'PWD': '/builds/slave/test', 14:58:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:58:55 INFO - 'RUST_BACKTRACE': 'full', 14:58:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:58:55 INFO - 'SHELL': '/bin/bash', 14:58:55 INFO - 'SHLVL': '1', 14:58:55 INFO - 'TERM': 'linux', 14:58:55 INFO - 'TMOUT': '86400', 14:58:55 INFO - 'USER': 'cltbld', 14:58:55 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906', 14:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:55 INFO - '_': '/tools/buildbot/bin/python'} 14:58:55 INFO - TEST-INFO | started process 4327 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4CP7hr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:58:56 INFO - PID 4327 | 14:58:56 INFO - PID 4327 | (/builds/slave/test/build/application/firefox/firefox:4378): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:58:56 INFO - PID 4327 | 14:59:06 INFO - PID 4327 | RSS: Main: 165789696 14:59:06 INFO - PID 4327 | 14:59:09 INFO - PID 4327 | Cycle 1(1): loaded http://localhost:51844/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51844/tests/kraken/driver.html?testName=audio-beat-detection) 14:59:10 INFO - PID 4327 | RSS: Main: 172228608 14:59:10 INFO - PID 4327 | 14:59:12 INFO - PID 4327 | Cycle 1(1): loaded http://localhost:51844/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51844/tests/kraken/driver.html?testName=audio-dft) 14:59:13 INFO - PID 4327 | RSS: Main: 172740608 14:59:13 INFO - PID 4327 | 14:59:16 INFO - PID 4327 | Cycle 1(1): loaded http://localhost:51844/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51844/tests/kraken/driver.html?testName=audio-fft) 14:59:16 INFO - PID 4327 | RSS: Main: 166502400 14:59:16 INFO - PID 4327 | 14:59:18 INFO - PID 4327 | Cycle 1(1): loaded http://localhost:51844/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51844/tests/kraken/driver.html?testName=audio-oscillator) 14:59:19 INFO - PID 4327 | RSS: Main: 167800832 14:59:19 INFO - PID 4327 | 14:59:21 INFO - PID 4327 | Cycle 1(1): loaded http://localhost:51844/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51844/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:59:22 INFO - PID 4327 | RSS: Main: 167698432 14:59:22 INFO - PID 4327 | 14:59:25 INFO - PID 4327 | Cycle 1(1): loaded http://localhost:51844/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51844/tests/kraken/driver.html?testName=imaging-darkroom) 14:59:25 INFO - PID 4327 | RSS: Main: 167804928 14:59:25 INFO - PID 4327 | 14:59:29 INFO - PID 4327 | Cycle 1(1): loaded http://localhost:51844/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51844/tests/kraken/driver.html?testName=imaging-desaturate) 14:59:29 INFO - PID 4327 | RSS: Main: 170516480 14:59:29 INFO - PID 4327 | 14:59:32 INFO - PID 4327 | Cycle 1(1): loaded http://localhost:51844/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51844/tests/kraken/driver.html?testName=json-parse-financial) 14:59:33 INFO - PID 4327 | RSS: Main: 170565632 14:59:33 INFO - PID 4327 | 14:59:34 INFO - PID 4327 | Cycle 1(1): loaded http://localhost:51844/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51844/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:59:35 INFO - PID 4327 | RSS: Main: 170635264 14:59:35 INFO - PID 4327 | 14:59:36 INFO - PID 4327 | Cycle 1(1): loaded http://localhost:51844/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51844/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:59:37 INFO - PID 4327 | RSS: Main: 170684416 14:59:37 INFO - PID 4327 | 14:59:39 INFO - PID 4327 | Cycle 1(1): loaded http://localhost:51844/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51844/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:59:40 INFO - PID 4327 | RSS: Main: 167645184 14:59:40 INFO - PID 4327 | 14:59:42 INFO - PID 4327 | Cycle 1(1): loaded http://localhost:51844/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51844/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:59:43 INFO - PID 4327 | RSS: Main: 167768064 14:59:43 INFO - PID 4327 | 14:59:46 INFO - PID 4327 | Cycle 1(1): loaded http://localhost:51844/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51844/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:59:46 INFO - PID 4327 | RSS: Main: 167960576 14:59:46 INFO - PID 4327 | 14:59:48 INFO - PID 4327 | Cycle 1(1): loaded http://localhost:51844/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51844/tests/kraken/driver.html?testName=ai-astar) 14:59:48 INFO - PID 4327 | RSS: Main: 169742336 14:59:48 INFO - PID 4327 | 14:59:48 INFO - PID 4327 | __start_tp_report 14:59:48 INFO - PID 4327 | _x_x_mozilla_page_load 14:59:48 INFO - PID 4327 | _x_x_mozilla_page_load_details 14:59:48 INFO - PID 4327 | |i|pagename|runs| 14:59:48 INFO - PID 4327 | |0;ai-astar;107;105;105;107;105;108;105;106;106;106 14:59:48 INFO - PID 4327 | |1;audio-beat-detection;117;112;116;116;112;140;113;115;112;113 14:59:48 INFO - PID 4327 | |2;audio-dft;162;161;163;160;162;161;161;161;169;167 14:59:48 INFO - PID 4327 | |3;audio-fft;73;72;72;73;73;73;72;73;72;73 14:59:48 INFO - PID 4327 | |4;audio-oscillator;81;79;81;79;80;81;78;78;79;78 14:59:48 INFO - PID 4327 | |5;imaging-gaussian-blur;113;113;114;114;114;114;115;115;111;118 14:59:48 INFO - PID 4327 | |6;imaging-darkroom;150;151;159;149;149;148;150;149;149;149 14:59:48 INFO - PID 4327 | |7;imaging-desaturate;94;94;95;95;94;94;94;94;94;94 14:59:48 INFO - PID 4327 | |8;json-parse-financial;44;43;46;46;42;44;45;42;43;54 14:59:48 INFO - PID 4327 | |9;json-stringify-tinderbox;37;38;38;37;37;37;37;37;38;37 14:59:48 INFO - PID 4327 | |10;stanford-crypto-aes;75;74;72;75;73;73;72;73;82;75 14:59:48 INFO - PID 4327 | |11;stanford-crypto-ccm;116;118;113;119;123;115;115;113;106;107 14:59:48 INFO - PID 4327 | |12;stanford-crypto-pbkdf2;162;156;154;158;165;168;161;157;158;164 14:59:48 INFO - PID 4327 | |13;stanford-crypto-sha256-iterative;63;61;56;58;63;57;59;59;62;59 14:59:48 INFO - PID 4327 | __end_tp_report 14:59:48 INFO - PID 4327 | __start_cc_report 14:59:48 INFO - PID 4327 | _x_x_mozilla_cycle_collect,893 14:59:48 INFO - PID 4327 | __end_cc_report 14:59:48 INFO - PID 4327 | __startTimestamp1504907988843__endTimestamp 14:59:48 INFO - PID 4327 | 14:59:48 INFO - PID 4327 | ------- Summary: start ------- 14:59:48 INFO - PID 4327 | Number of tests: 14 14:59:48 INFO - PID 4327 | 14:59:48 INFO - PID 4327 | [#0] ai-astar Cycles:10 Average:106.00 Median:106.00 stddev:1.05 (1.0%) stddev-sans-first:1.05 14:59:48 INFO - PID 4327 | Values: 107.0 105.0 105.0 107.0 105.0 108.0 105.0 106.0 106.0 106.0 14:59:48 INFO - PID 4327 | 14:59:48 INFO - PID 4327 | [#1] audio-beat-detection Cycles:10 Average:116.60 Median:115.50 stddev:8.44 (7.3%) stddev-sans-first:8.95 14:59:48 INFO - PID 4327 | Values: 117.0 112.0 116.0 116.0 112.0 140.0 113.0 115.0 112.0 113.0 14:59:48 INFO - PID 4327 | 14:59:48 INFO - PID 4327 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.00 stddev:2.95 (1.8%) stddev-sans-first:3.11 14:59:48 INFO - PID 4327 | Values: 162.0 161.0 163.0 160.0 162.0 161.0 161.0 161.0 169.0 167.0 14:59:48 INFO - PID 4327 | 14:59:48 INFO - PID 4327 | [#3] audio-fft Cycles:10 Average:72.60 Median:73.00 stddev:0.52 (0.7%) stddev-sans-first:0.53 14:59:48 INFO - PID 4327 | Values: 73.0 72.0 72.0 73.0 73.0 73.0 72.0 73.0 72.0 73.0 14:59:48 INFO - PID 4327 | 14:59:48 INFO - PID 4327 | [#4] audio-oscillator Cycles:10 Average:79.40 Median:79.50 stddev:1.26 (1.6%) stddev-sans-first:1.20 14:59:48 INFO - PID 4327 | Values: 81.0 79.0 81.0 79.0 80.0 81.0 78.0 78.0 79.0 78.0 14:59:48 INFO - PID 4327 | 14:59:48 INFO - PID 4327 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:1.79 (1.6%) stddev-sans-first:1.86 14:59:48 INFO - PID 4327 | Values: 113.0 113.0 114.0 114.0 114.0 114.0 115.0 115.0 111.0 118.0 14:59:48 INFO - PID 4327 | 14:59:48 INFO - PID 4327 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:149.50 stddev:3.16 (2.1%) stddev-sans-first:3.35 14:59:48 INFO - PID 4327 | Values: 150.0 151.0 159.0 149.0 149.0 148.0 150.0 149.0 149.0 149.0 14:59:48 INFO - PID 4327 | 14:59:48 INFO - PID 4327 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:59:48 INFO - PID 4327 | Values: 94.0 94.0 95.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 14:59:48 INFO - PID 4327 | 14:59:48 INFO - PID 4327 | [#8] json-parse-financial Cycles:10 Average:44.90 Median:44.50 stddev:3.51 (7.9%) stddev-sans-first:3.71 14:59:48 INFO - PID 4327 | Values: 44.0 43.0 46.0 46.0 42.0 44.0 45.0 42.0 43.0 54.0 14:59:48 INFO - PID 4327 | 14:59:48 INFO - PID 4327 | [#9] json-stringify-tinderbox Cycles:10 Average:37.30 Median:37.00 stddev:0.48 (1.3%) stddev-sans-first:0.50 14:59:48 INFO - PID 4327 | Values: 37.0 38.0 38.0 37.0 37.0 37.0 37.0 37.0 38.0 37.0 14:59:48 INFO - PID 4327 | 14:59:48 INFO - PID 4327 | [#10] stanford-crypto-aes Cycles:10 Average:74.40 Median:74.50 stddev:2.91 (3.9%) stddev-sans-first:3.08 14:59:48 INFO - PID 4327 | Values: 75.0 74.0 72.0 75.0 73.0 73.0 72.0 73.0 82.0 75.0 14:59:48 INFO - PID 4327 | 14:59:48 INFO - PID 4327 | [#11] stanford-crypto-ccm Cycles:10 Average:114.50 Median:115.50 stddev:5.17 (4.5%) stddev-sans-first:5.45 14:59:48 INFO - PID 4327 | Values: 116.0 118.0 113.0 119.0 123.0 115.0 115.0 113.0 106.0 107.0 14:59:48 INFO - PID 4327 | 14:59:48 INFO - PID 4327 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:161.50 stddev:4.45 (2.8%) stddev-sans-first:4.68 14:59:48 INFO - PID 4327 | Values: 162.0 156.0 154.0 158.0 165.0 168.0 161.0 157.0 158.0 164.0 14:59:48 INFO - PID 4327 | 14:59:48 INFO - PID 4327 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.70 Median:60.00 stddev:2.45 (4.1%) stddev-sans-first:2.29 14:59:48 INFO - PID 4327 | Values: 63.0 61.0 56.0 58.0 63.0 57.0 59.0 59.0 62.0 59.0 14:59:48 INFO - PID 4327 | -------- Summary: end -------- 14:59:48 INFO - PID 4327 | 14:59:49 INFO - PID 4327 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 14:59:49 INFO - TEST-INFO | 4327: exit 0 14:59:49 INFO - TEST-OK | kraken | took 59536ms 14:59:49 INFO - SUITE-END | took 1169s 14:59:50 INFO - Completed test suite (00:19:29) 14:59:50 INFO - javascript benchmark 14:59:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9038.254718474283, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3817.274717803617, 3830.846766129354, 3844.288806570786, 3883.495145631069, 3889.863854765084, 6268.937310626904, 6352.68236588171, 6421.325760795119, 6429.485641148709, 6458.386453286936, 6393.392627700361, 6422.036694495828, 6478.773242936498, 6503.349665033495, 6524.510661700368, 5691.345495268035, 5802.651840889539, 5807.983602869502, 5818.621789583684, 5844.795432159875, 115.90085348670532, 5471.0, 5703.429657034305, 5788.826335209929, 5793.942060579382, 5712.542996560286, 5747.885042299152, 5815.825525234229, 5816.563757718188, 5830.82507524775, 5744.6840423776675, 5748.109043098327, 5821.09772985188, 5826.446487583715, 5827.88344233113, 5717.742701578439, 5724.685142317171, 5801.680907550083, 5811.82564523065, 5812.099124635688, 6269.592476489013, 6388.201474815648, 6400.839979000562, 6452.451541618968, 6497.382748638872, 6870.862582748317, 6887.345702158287, 6917.0, 6955.061066755974, 6971.79084627462, 6951.478639102037, 7004.859902801966, 7005.474589405764, 7006.824829379307, 7021.859562808766, 6399.328070552571, 6399.488040956712, 6399.87200255997, 6469.514786390992, 6489.059086432488, 7088.503804733619, 7091.89362159568, 7105.609191494517, 7105.964470177616, 7106.822329441702, 6786.626735529495, 6793.116894803743, 6793.72825086991, 6796.898046529306, 6801.319868013159, 6828.931710682829, 6857.828554286183, 6909.861802763917, 6915.827104322331, 6919.688614012382, 6873.347032031949, 6888.690008949609, 6924.203716572558, 6985.301469852974, 6986.860262794716, 6923.099997000459, 6925.6190909500465, 6980.232174460805, 7021.89467157993, 7026.859462810818, 5010.148274793294, 5015.623828212899, 5056.620753443506, 5069.44236134025, 5093.286939828427, 4433.911321773611, 4536.047430039663, 4557.430321209848, 4615.699979501389, 4668.393108895822, 6325.0, 6364.681765911686, 6364.681765911686, 6378.649174295366, 6379.393957574023, 6882.449404047664, 6910.239873613898, 6929.5842249465195, 6963.09479767627, 6968.268331825187, 6266.216722909637, 6303.873922521524, 6329.68351582419, 6364.936350636527, 6393.9360606394275, 5553.833384998376, 5602.271704678447, 5608.9719551402795, 5609.1305847593685, 5610.298712660918, 7081.681324340417, 7126.394256488153, 7162.785116446515, 7170.8207294817, 7177.92822071783, 6834.384905358542, 6860.142482189726, 6866.553674011173, 6932.306769323028, 6948.791536253921, 7011.193712723102, 7072.646367681698, 7089.432845372461, 7107.324804143598, 7178.282171782989, 6718.630475323708, 6829.726810927507, 6838.04267402574, 6842.418394436529, 6846.041554182319, 6900.068490753684, 6984.441244700513, 7045.577265364094, 7055.611941343275, 7056.964715176391, 6673.399394054364, 6737.461003119836, 6737.764178253738, 6762.830929226809, 6779.796606101825, 6597.703103360264, 6632.336766323329, 6637.070810086495, 6700.798976030727, 6729.495287853529, 6581.868362632625, 6590.934090659032, 6596.109525214035, 6603.603783772989, 6606.471482281502, 6657.733690652513, 6732.360425759545, 6767.1879374475375, 6785.2536221016635, 6881.243063262937, 6483.157189565326, 6517.543771936109, 6583.374579414948, 6588.571742836892, 6603.735850566116], "value": 6271.537619132031, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [957.1098878043417, 960.313375936206, 970.1801977329156, 1013.7820368620747, 1013.8580598716177, 43260.56739432605, 43686.78156609216, 43720.0, 43771.56228437715, 43782.56217437825, 39646.20707585847, 42670.57329426705, 43360.3495947561, 43365.34951975723, 43392.78303608485, 7900.723474678373, 8014.118446970829, 8015.7194498192575, 8043.316318112968, 8049.919500805005, 7916.0, 8040.798980025487, 8044.919550804476, 8048.758537243892, 8064.516129032248, 8020.959895200516, 8038.236367545103, 8043.638036288381, 8095.878561821577, 8101.756947291591, 8016.238457346542, 8030.5181689098845, 8033.718819841307, 8054.355651547862, 8058.516489010678, 7814.921850781477, 7943.483673561258, 7952.244536768998, 7953.085395179571, 7953.721619743281, 40014.0, 40283.0, 40311.79844100761, 40461.0, 40539.0, 3778.0, 3813.809309534512, 3814.275287695329, 3814.8855534334016, 3815.9618403815884, 32621.51067733986, 32691.83654081738, 32729.181770455692, 32851.0, 32857.50713739296, 5432.076546986982, 5439.184122381635, 5483.341998960111, 5493.395726470085, 5577.2191893135, 224699.0, 224817.0, 226473.0, 227248.0, 227870.0, 51702.0, 52569.47430525722, 52950.0, 53004.204936925205, 53058.73470632699, 54663.18005229925, 54965.0, 55066.0, 55082.44917550773, 55136.17295740567, 15848.286827092808, 15965.0, 15980.200989950456, 15992.280347384396, 15992.440264590683, 12975.351232438341, 12982.415791289415, 12983.28591927453, 12990.480380784662, 13001.414936327888, 13155.671108222372, 13189.538366157138, 13283.933580332037, 13367.933160334136, 13496.0, 5292.25355632648, 5319.0, 5357.223202635596, 5378.04713535551, 5442.782288708408, 1062.2829590026702, 1093.6773651772746, 1104.861892263467, 1121.770037142384, 1122.3041714137123, 25603.0, 25662.615060774104, 25757.8712106442, 25817.870910645703, 25886.870565647052, 1211.8061110222322, 1218.5552273420137, 1219.3598360860442, 1220.8473940757406, 1234.5247079874314, 13320.733585328238, 13388.19670819754, 13518.391672374766, 13572.0, 13650.522231722041, 295426.0, 296120.0, 296217.0, 296279.0, 297031.0, 55730.0, 56110.15834762482, 56164.71917640386, 59950.0, 60108.39891601115, 1492.1643879427556, 1498.7826765119214, 1503.2784263553556, 1519.8708109810568, 1530.4490383461946, 28469.715302847533, 28528.857355713088, 28839.741001600014, 29087.85456072706, 29151.708482915747, 39628.40557391699, 39719.205615886945, 39805.0, 39806.800965996146, 39811.20377592374, 258790.0, 258987.0, 259523.0, 260965.0, 261153.0, 31615.841920790248, 32212.516812248305, 34339.14152146116, 34555.827220863735, 35455.11362215965, 46465.53534464612, 46537.0, 47039.529604703515, 47477.28784068311, 47858.28212576884, 34501.48247776235, 34760.13099672528, 34809.77853322022, 35440.29119417649, 35462.64537354697, 34426.655733443346, 34571.654283456846, 34647.82676086603, 34891.82554087213, 35176.648233517335, 39303.41044884272, 39796.40305395363, 39956.0, 40084.0, 40397.59602404056, 33403.665963340056, 33413.49879751757, 33546.329073418885, 33743.4938475928, 34184.316313674084, 25430.49139017246, 25478.23565293044, 25570.744292556836, 25900.61149082803, 25953.22140335793], "value": 18457.409143178385, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.3782433883576, 580.2196046317702, 585.183668782049, 593.1044123373705, 604.9788257410991, 23203.535929281403, 24005.159819406323, 24034.15880444185, 24037.0, 24121.75878241217, 25066.498670026634, 25461.0, 25593.104241351557, 25697.0, 25716.485670286584, 6560.606363618174, 6691.933080669191, 6703.497237707192, 6716.690245402148, 6732.798016059502, 6464.418202361787, 6697.129373181479, 6855.554388964726, 6948.930510694904, 6969.825754356131, 6645.169353830771, 6702.564333318319, 6723.193216813989, 6726.461883049345, 6728.4953628477815, 6546.247181574085, 6688.765893193739, 6696.631685257309, 6703.162104736908, 6830.658467076676, 6329.651869147195, 6340.397662222128, 6341.714622841983, 6342.143810585604, 6358.300586935434, 28868.422631547463, 29284.121476355744, 29285.0, 29331.0, 29379.853100734574, 2322.1175953137868, 2344.7303560090636, 2348.0, 2350.25966820451, 2352.6823878776318, 19879.40361789134, 20326.88202148881, 20495.18019279227, 20635.071421786055, 20677.689834652494, 2565.24325324028, 2597.0910181436534, 2639.7624213820654, 2643.524165650182, 2648.205538338491, 131786.0, 139814.0, 140863.0, 148415.0, 148499.25750371287, 14912.70174596502, 15436.38254469831, 15473.690526189414, 15784.526464205863, 15948.840511594735, 24392.756072439402, 24421.0, 24534.0, 24566.877165614056, 24578.262652120466, 9885.406875587487, 10010.699679009642, 10017.899821001842, 10116.949415253024, 10236.436995965294, 8988.685396011108, 8997.190252877272, 9069.138431849096, 9127.680531181377, 9148.405353651991, 9725.221982241404, 9867.358621689567, 9882.654107106217, 9985.20118390527, 9989.102070606561, 2875.6980517045827, 2886.7834912381654, 2903.462859371023, 2917.2852651100616, 2997.7751668624505, 1032.6437379104198, 1037.822071948329, 1042.7810159866513, 1053.3206082077018, 1055.8257887448638, 19888.403347899588, 20336.59326813485, 20365.592688146153, 20750.273740419012, 20878.478038048866, 1065.1159537583787, 1078.2829418436809, 1082.0748260237542, 1084.902358787713, 1096.3586302013412, 11142.944285278683, 11420.714482137846, 11457.59898403552, 11648.256205731373, 11775.52897884075, 590605.0, 593916.0, 596710.0, 597148.0, 613579.0, 125822.3708881468, 129604.0, 129791.75520612061, 131491.0, 131855.0, 1200.9279443233258, 1203.284045992633, 1209.6733881852026, 1220.408102070495, 1224.1247508031622, 18109.637807244046, 18328.266869325078, 18511.629767404305, 18593.0, 18598.53503662419, 60644.0, 61209.69395152996, 61498.385016151056, 62259.6887015562, 62979.37020629735, 76920.0, 77232.22767772475, 77522.0, 77615.61192194003, 78477.0, 15218.239088045775, 15230.543083707507, 15353.846461535688, 15407.0, 15422.845771542141, 23878.0, 24010.27969160928, 24166.758332417154, 24200.757992420557, 24476.510469790148, 19565.0, 19630.803691962898, 19726.605467890276, 19821.30625428103, 19827.900860495603, 16660.16699165061, 16905.32378704838, 17476.213570389617, 17501.56246093807, 17554.297828087245, 19900.70148947796, 20196.394108176777, 20237.898810505852, 20306.59386812285, 20370.28703995353, 14988.175650339335, 15030.0, 15149.0, 15162.469313573973, 15182.924085379502, 18473.16870740793, 18560.979146147092, 18830.905845470686, 19250.518737031685, 19303.131359088595], "value": 12576.647270913694, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1442.1995792335254, 1462.225020739008, 1492.2986196487648, 1492.9402823887044, 1497.7977972973645, 16537.586560335996, 17124.743128853046, 17187.570310742223, 17192.82807171928, 17194.570135746613, 16568.337266509356, 16616.66766664666, 16746.916265418655, 16771.161441927918, 16844.74732879008, 2829.1795379339965, 2875.568664700291, 2885.5671649252677, 2889.537673972165, 2891.9710802891914, 2712.5795501697266, 2817.197098826835, 2835.6313679221776, 2836.2342167614734, 2837.900673476429, 2618.738126187385, 2789.9302517437022, 2807.5507918733006, 2809.3678922242534, 2810.0445848411537, 2795.958060629082, 2835.6030155778103, 2854.9857250713717, 2855.0, 2858.0139851751114, 2732.53546897028, 2765.9861700691567, 2780.88876444942, 2782.1514438096374, 2794.9580756288674, 16481.423150189687, 16614.75077873833, 16754.832451675447, 16784.244708988124, 16875.831241687672, 8196.13940536241, 8487.0, 8496.447730897471, 8512.78718032048, 8514.063453020162, 5375.65058271215, 5506.64206826559, 5552.944470555283, 5683.658980461186, 5712.771489140429, 2116.386247988097, 2119.109973811003, 2140.8073273405466, 2185.530111026121, 2197.604431202383, 29796.70203297961, 29987.0, 30112.69887301121, 30117.69882301171, 30168.396632067455, 7123.89314160288, 7141.642917854087, 7184.1019872515935, 7271.67277472515, 7313.085864266966, 18825.435236942914, 18846.623067538574, 18885.244590216236, 18900.05499725008, 18949.526261843563, 8343.54110523927, 8533.658653653909, 8541.14588541141, 8542.145785421408, 8550.657973681107, 7465.477416580896, 7515.812104697427, 7561.9243807562325, 7645.044369453818, 7646.311831935152, 5443.945560544423, 5663.263775709213, 5670.092785154356, 5709.143628455682, 5709.857253568694, 1567.7256480115934, 1570.646604513998, 1584.8525248288634, 1606.7268564343856, 1614.77393164957, 981.4896253947907, 1009.4548943570536, 1012.6506355307407, 1016.0804471952895, 1036.8703912011, 9347.859782103274, 9464.763380915532, 9605.135537801492, 9613.230941524662, 9626.759331016641, 1059.660908509285, 1065.8347956066823, 1067.4662668665667, 1069.8448724934997, 1106.043272569222, 5534.335879694382, 6017.217761691039, 6022.638641681426, 6255.030470277115, 6371.872562548723, 24806.131785387424, 25273.494530109296, 25446.0, 25689.614655780177, 25705.614415783777, 23715.0, 24938.750612494005, 25675.229743107735, 25701.614475782877, 25747.87126064395, 11799.941000295115, 12169.20900141488, 12355.876441235472, 12400.81398779001, 12418.627441176779, 10100.292979491365, 10341.37951722899, 10405.398650337416, 10739.946300268448, 10770.784584308427, 21706.0, 21793.038626523055, 21879.45301367415, 22104.778952210272, 22565.0, 22323.330300091024, 22325.218617348313, 22325.888370558045, 22365.440863978532, 22598.774012259666, 13462.192268463923, 13535.458581657018, 13735.175889446666, 13784.655383615489, 13880.375383107583, 15217.77173342423, 15516.379344826531, 15552.533423997298, 15563.0, 15578.922105389855, 12359.3820308986, 12419.0, 12453.93773031129, 12508.437120329789, 12567.18313309632, 11366.204365694322, 11628.360440175871, 11796.941015295211, 11801.0, 11867.109966752356, 11311.264767790397, 11392.886071139183, 11458.083353331547, 11498.425078746197, 11521.654350369166, 8497.660093596187, 8562.357823163413, 8620.13798620133, 8620.353473489638, 8754.168354006359, 8583.742487725378, 8606.483610983361, 8668.0898505656, 8691.391602587759, 8750.781230469289], "value": 7399.709641056591, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.9019176548222, 546.9288992430986, 573.2118337286231, 575.5510701652711, 581.8370856160277, 6004.519638428927, 6181.381861813817, 6189.690515474225, 6253.312135665079, 6295.716692748826, 6115.510759139269, 6184.350643182457, 6274.780382686596, 6281.937180628192, 6290.433860952513, 5154.845354639367, 5184.922226166611, 5187.610929180327, 5198.246254293125, 5217.426083130853, 5044.688381020943, 5057.620678449131, 5144.974275128619, 5165.509276618715, 5216.7391630418515, 5137.820176293831, 5176.948230517703, 5200.0759718904055, 5208.687478751268, 5231.319928409302, 5076.111680455905, 5148.407933087706, 5201.5838732901275, 5228.163493840967, 5236.7119808410525, 4769.594584460325, 4788.569028787391, 4844.546636009183, 4867.0, 4870.951290487121, 6218.4714299284615, 6264.655443950581, 6280.434760871498, 6290.119383286344, 6318.557700960934, 6120.449159575615, 6120.785772497941, 6163.352847950945, 6174.0, 6178.84552886177, 6657.434118099967, 6703.162104736908, 6727.562708423937, 6747.190337159573, 6761.154855643044, 5384.300040994684, 5432.483914028161, 5476.0, 5494.203340515603, 5498.697571633558, 6970.79087627372, 7003.404710599605, 7020.894686579705, 7052.61210633415, 7095.467839911976, 5568.16477528374, 5584.664920104807, 5603.915941260884, 5637.8590535236945, 5641.605087643826, 5723.656580605094, 5727.341355744059, 5736.799212027559, 5764.798232061858, 5765.509931655773, 6130.344806902201, 6131.908021379683, 6145.0, 6166.167567378437, 6242.313345531988, 6600.699650174913, 6662.600243985376, 6684.395745021257, 6687.7993660189295, 6703.994400839913, 1887.6979683250613, 1892.4228110426452, 1935.4097000414727, 1963.7741659709316, 1979.0104947526238, 1447.7538818400687, 1469.4644096918746, 1475.8671719545293, 1483.1546018769197, 1506.7739839024234, 6000.909986350208, 6010.819675409744, 6011.939880601226, 6095.342794323459, 6165.136880836686, 6657.367550082734, 6696.06255124283, 6706.981858163846, 6716.832079197961, 6834.8633027340165, 6151.876962460726, 6152.630842149485, 6174.475169610543, 6194.4115309045565, 6231.657258850807, 3545.592256890439, 3549.7870127792416, 3573.2496175802853, 3584.0, 3629.528161339009, 7057.788266352018, 7060.188078371053, 7071.752488662872, 7112.293049668043, 7139.928600713926, 7012.158540975116, 7029.472789540702, 7082.662721301958, 7092.326229008339, 7124.715011399486, 7067.187273463412, 7081.398081163055, 7101.2898710128575, 7123.857522849514, 7134.714611415693, 6713.261541230363, 6770.763023294161, 6783.3555812197765, 6835.0, 6883.965580172067, 6757.358050985148, 6759.324067593201, 6799.422049125879, 6809.897851532132, 6815.318468153145, 7103.25415831351, 7129.4652901031595, 7131.928680713334, 7145.9285407147345, 7153.2131465537705, 5217.4260831307765, 5229.947700522946, 5233.450487698889, 5247.399543139379, 5263.5525980292105, 6599.106527149005, 6613.206415230203, 6712.993051042383, 6867.725290988305, 6877.277885822116, 6528.183977002875, 6569.540132190701, 6584.078229048033, 6617.536772425884, 6618.768343107968, 6492.929111280968, 6519.4132528072705, 6532.379423954717, 6600.60396376219, 6614.338566143347, 6382.36176382358, 6409.775657851953, 6497.675116244074, 6542.378474044958, 6563.310852360433, 6643.2360278568585, 6644.966775166094, 6652.035454859115, 6656.0, 6669.266380698023, 6344.492440604833, 6419.716056788754, 6424.582402143846, 6452.22573291208, 6525.119108920425], "value": 5308.487655893269, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [990.1089019882106, 992.6228033347322, 994.6618149829061, 995.4624502768505, 1017.6489111256616, 18214.0, 18301.35945241917, 18453.630927381444, 18464.446066618006, 18489.445316640504, 17568.121593920318, 17758.82241177591, 17780.288788448477, 17785.82214177858, 17828.55428614285, 1058.8305871060631, 1060.628779927025, 1080.389579887365, 1086.0551320351267, 1086.3970496374548, 1077.245927850504, 1084.7396624810067, 1086.8532748079026, 1087.141158484796, 1089.9073578745815, 1184.0645889747088, 1185.887340702632, 1186.2170967161633, 1188.9405529723522, 1191.7556900835352, 1176.4176732517374, 1181.0256538355804, 1181.3561608923158, 1184.3782014442443, 1186.1696812231473, 863.063576020019, 864.1790299215708, 864.2006144316482, 864.5633954852759, 865.8657908024267, 18955.71566426491, 19272.614547708967, 19365.225390984484, 19407.708884366744, 20257.898710506353, 22662.0, 23020.884895575415, 23043.769562304497, 23053.538929221322, 23073.653895191586, 17909.283628654837, 17951.73072403902, 18016.279348826163, 18082.276708931626, 18164.636707265912, 3897.2984862724697, 3962.0491082140366, 4062.1469491406547, 4063.3701776224734, 4072.8574499892657, 147973.0, 148246.0, 148411.0, 151991.0, 153438.23280883636, 17548.29806807739, 17550.29798808059, 17613.207405666777, 17780.91109544444, 17869.553261168574, 31970.520442193385, 32093.0, 32123.51814722781, 32166.19584510406, 32465.35069298648, 8550.102239264788, 8583.785405364792, 8635.136486351315, 8642.870356944652, 8654.87017694735, 4371.344298355209, 4473.910521789611, 4487.753173575485, 4489.932651010237, 4491.079328737601, 5764.077747560454, 5902.498287645512, 5904.9704751475965, 5920.052791553331, 5941.940580594225, 1108.9279196852178, 1129.6272230164027, 1147.6843867936218, 1152.521703493041, 1156.699258192876, 703.2440126863539, 722.1803253307429, 738.7119023580808, 752.8833030880222, 760.6577040331873, 12536.252502109024, 12633.2420054797, 12920.741585168244, 12937.935310323388, 13294.667633309246, 690.520088538461, 693.3551796828998, 694.9861002779916, 696.3245651717825, 703.3353480960443, 5640.125780504029, 5667.489925906688, 5684.289463817023, 5701.230333904953, 5769.653820770767, 139005.0, 139403.0, 140353.2982335082, 141381.0, 145947.0, 115574.4221278905, 116842.0, 118293.0, 121541.0, 124263.0, 100103.49948250358, 101031.4948425268, 102147.0, 103015.9999999985, 104295.0, 10680.359178449318, 10720.19598530129, 10849.67450976472, 10868.891311086787, 11167.329960202414, 49600.50399495959, 51093.74453127859, 51094.74452627713, 51805.0, 52112.47887521228, 66217.0, 66407.66796165988, 66737.33262667505, 66954.0, 67592.0, 16618.584535386228, 16663.50009499717, 16889.0, 17021.31914723397, 17061.232244549272, 17682.204300806752, 17726.0, 17952.730709039115, 17975.101244937963, 18121.36575219861, 17401.0, 17501.737473938156, 17593.472195833634, 17659.205335759663, 17714.20286087155, 17516.649667006335, 17695.823041769418, 17730.468085957444, 17870.731939021185, 17963.550911227325, 16169.434069807501, 16248.593785155466, 16313.755293670842, 16453.42413015539, 16522.17389130563, 11604.0, 11815.822762658396, 11820.645380638594, 11863.76272474563, 12056.276623402624, 12043.277403355827, 12354.814677780021, 12386.451693538307, 12606.55877044299, 12770.808437873253], "value": 9532.07067572231, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1387.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 105.0, 105.0, 107.0, 105.0, 108.0, 105.0, 106.0, 106.0, 106.0], "value": 106.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 112.0, 116.0, 116.0, 112.0, 140.0, 113.0, 115.0, 112.0, 113.0], "value": 116.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 160.0, 162.0, 161.0, 161.0, 161.0, 169.0, 167.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 72.0, 73.0, 73.0, 73.0, 72.0, 73.0, 72.0, 73.0], "value": 72.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 81.0, 79.0, 80.0, 81.0, 78.0, 78.0, 79.0, 78.0], "value": 79.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 114.0, 114.0, 114.0, 115.0, 115.0, 111.0, 118.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 159.0, 149.0, 149.0, 148.0, 150.0, 149.0, 149.0, 149.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 43.0, 46.0, 46.0, 42.0, 44.0, 45.0, 42.0, 43.0, 54.0], "value": 44.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 38.0, 37.0, 37.0, 37.0, 37.0, 37.0, 38.0, 37.0], "value": 37.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 72.0, 75.0, 73.0, 73.0, 72.0, 73.0, 82.0, 75.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 113.0, 119.0, 123.0, 115.0, 115.0, 113.0, 106.0, 107.0], "value": 114.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 156.0, 154.0, 158.0, 165.0, 168.0, 161.0, 157.0, 158.0, 164.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 56.0, 58.0, 63.0, 57.0, 59.0, 59.0, 62.0, 59.0], "value": 59.7, "unit": "score"}]}]} 14:59:50 INFO - Return code: 0 14:59:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:59:50 INFO - # TBPL SUCCESS # 14:59:50 INFO - Running post-action listener: _package_coverage_data 14:59:50 INFO - Running post-action listener: _resource_record_post_action 14:59:50 INFO - [mozharness: 2017-09-08 21:59:50.129735Z] Finished run-tests step (success) 14:59:50 INFO - Running post-run listener: _resource_record_post_run 14:59:50 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 6041600; Write bytes: 406093824; Read time: 3668; Write time: 331360 14:59:50 INFO - TinderboxPrint: CPU usage
13.1% 14:59:50 INFO - TinderboxPrint: I/O read bytes / time
6,041,600 / 3,668 14:59:50 INFO - TinderboxPrint: I/O write bytes / time
406,093,824 / 331,360 14:59:50 INFO - TinderboxPrint: CPU idle
8,223.8 (86.9%) 14:59:50 INFO - TinderboxPrint: CPU user
1,186.3 (12.5%) 14:59:50 INFO - TinderboxPrint: Swap in / out
0 / 0 14:59:50 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 380928; Read time: 0; Write time: 64 14:59:50 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:59:50 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4296704; Write bytes: 348221440; Read time: 3472; Write time: 306120 14:59:50 INFO - Running post-run listener: _upload_blobber_files 14:59:50 INFO - Blob upload gear active. 14:59:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:59:50 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 14:59:50 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'] 14:59:50 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 14:59:51 INFO - (blobuploader) - INFO - Open directory for files ... 14:59:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:59:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:59:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:59:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:59:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:59:55 INFO - (blobuploader) - INFO - Done attempting. 14:59:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:59:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:59:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:59:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:59:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:59:56 INFO - (blobuploader) - INFO - Done attempting. 14:59:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:59:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:59:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:59:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:59:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:59:57 INFO - (blobuploader) - INFO - Done attempting. 14:59:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:59:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:59:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:59:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:59:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:59:58 INFO - (blobuploader) - INFO - Done attempting. 14:59:58 INFO - (blobuploader) - INFO - Iteration through files over. 14:59:58 INFO - Return code: 0 14:59:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:59:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:59:58 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d863d3d589e39119ea123c707da551edec670c2d8a1c43457d44cb20da134d257894a249ea13730c2215d7abe3ebd02ee7cd11de2fec2aaf8183551dbf925376", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0edbe669069273de153bd9b25c45ae8c42f56171ae98d3b80c0e3ce7ce776230d70f0d13754a07061aeb9d94e3c8d74bf4d8019c23618d1414433afc057105e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7660a90a57860ae85610c22b9cd0298e07bc702a7db49268fb26e7748b9b7e14175c8b256ca3b4d29066a11d0a0eddb3ca997851da112d8ca14f8201226f73c2", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f36983a29c8f4c2ad410dbb64da502a112707c197124a568d05d4f27a168c79bb19554b65bc175151447df029c85e3ba0de0053bf9f2f16f84acc7268e0411af"} 14:59:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:59:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:59:58 INFO - Contents: 14:59:58 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d863d3d589e39119ea123c707da551edec670c2d8a1c43457d44cb20da134d257894a249ea13730c2215d7abe3ebd02ee7cd11de2fec2aaf8183551dbf925376", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0edbe669069273de153bd9b25c45ae8c42f56171ae98d3b80c0e3ce7ce776230d70f0d13754a07061aeb9d94e3c8d74bf4d8019c23618d1414433afc057105e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7660a90a57860ae85610c22b9cd0298e07bc702a7db49268fb26e7748b9b7e14175c8b256ca3b4d29066a11d0a0eddb3ca997851da112d8ca14f8201226f73c2", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f36983a29c8f4c2ad410dbb64da502a112707c197124a568d05d4f27a168c79bb19554b65bc175151447df029c85e3ba0de0053bf9f2f16f84acc7268e0411af"} 14:59:58 INFO - Running post-run listener: copy_logs_to_upload_dir 14:59:58 INFO - Copying logs to upload dir... 14:59:58 INFO - mkdir: /builds/slave/test/build/upload/logs 14:59:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.228956 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-08 14:59:58.420094) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-08 14:59:58.423579) ========= 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=31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d863d3d589e39119ea123c707da551edec670c2d8a1c43457d44cb20da134d257894a249ea13730c2215d7abe3ebd02ee7cd11de2fec2aaf8183551dbf925376", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0edbe669069273de153bd9b25c45ae8c42f56171ae98d3b80c0e3ce7ce776230d70f0d13754a07061aeb9d94e3c8d74bf4d8019c23618d1414433afc057105e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7660a90a57860ae85610c22b9cd0298e07bc702a7db49268fb26e7748b9b7e14175c8b256ca3b4d29066a11d0a0eddb3ca997851da112d8ca14f8201226f73c2", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f36983a29c8f4c2ad410dbb64da502a112707c197124a568d05d4f27a168c79bb19554b65bc175151447df029c85e3ba0de0053bf9f2f16f84acc7268e0411af"} build_url:https://queue.taskcluster.net/v1/task/IMacF5BeTkyX-9dYE2IlAA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011161 build_url: 'https://queue.taskcluster.net/v1/task/IMacF5BeTkyX-9dYE2IlAA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d863d3d589e39119ea123c707da551edec670c2d8a1c43457d44cb20da134d257894a249ea13730c2215d7abe3ebd02ee7cd11de2fec2aaf8183551dbf925376", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0edbe669069273de153bd9b25c45ae8c42f56171ae98d3b80c0e3ce7ce776230d70f0d13754a07061aeb9d94e3c8d74bf4d8019c23618d1414433afc057105e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7660a90a57860ae85610c22b9cd0298e07bc702a7db49268fb26e7748b9b7e14175c8b256ca3b4d29066a11d0a0eddb3ca997851da112d8ca14f8201226f73c2", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f36983a29c8f4c2ad410dbb64da502a112707c197124a568d05d4f27a168c79bb19554b65bc175151447df029c85e3ba0de0053bf9f2f16f84acc7268e0411af"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-08 14:59:58.452470) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 14:59:58.452815) ========= 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=31acecf42b6a79ec49471d4a000001bb-1504906759.253181-1498129906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004386 ========= master_lag: 0.11 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 14:59:58.565884) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-08 14:59:58.566290) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-08 14:59:58.566755) ========= ========= Total master_lag: 0.35 =========