builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-069 starttime: 1505777066.02 results: success (0) revision: 948dc86aabc97e16d51ad19ea90debab6f93a628 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:26.018343) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:26.018733) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:26.018995) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:26.349703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:26.349944) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-18 16:24:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.7M=0s 2017-09-18 16:24:26 (23.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.078909 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:26.513222) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:26.517533) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018643 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:26.609906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:26.610197) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 948dc86aabc97e16d51ad19ea90debab6f93a628 --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 948dc86aabc97e16d51ad19ea90debab6f93a628 --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=05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-18 16:24:26,583 truncating revision to first 12 chars 2017-09-18 16:24:26,583 Setting DEBUG logging. 2017-09-18 16:24:26,583 attempt 1/10 2017-09-18 16:24:26,583 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/948dc86aabc9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-18 16:24:27,049 unpacking tar archive at: mozilla-central-948dc86aabc9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.835630 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:27.478455) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:27.478734) ========= script_repo_revision: 948dc86aabc97e16d51ad19ea90debab6f93a628 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:27.479158) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:27.479428) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:27.506365) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-18 16:24:27.506633) ========= /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=05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:24:27 INFO - MultiFileLogger online at 20170918 16:24:27 in /builds/slave/test 16:24:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:24:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:24:27 INFO - {'append_to_log': False, 16:24:27 INFO - 'base_work_dir': '/builds/slave/test', 16:24:27 INFO - 'blob_upload_branch': 'Firefox', 16:24:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:24:27 INFO - 'branch': 'Firefox', 16:24:27 INFO - 'buildbot_json_path': 'buildprops.json', 16:24:27 INFO - 'code_coverage': False, 16:24:27 INFO - 'config_files': ('talos/linux_config.py',), 16:24:27 INFO - 'default_actions': ('clobber', 16:24:27 INFO - 'read-buildbot-config', 16:24:27 INFO - 'download-and-extract', 16:24:27 INFO - 'populate-webroot', 16:24:27 INFO - 'create-virtualenv', 16:24:27 INFO - 'install', 16:24:27 INFO - 'setup-mitmproxy', 16:24:27 INFO - 'run-tests'), 16:24:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:24:27 INFO - 'disable_ccov_upload': False, 16:24:27 INFO - 'disable_stylo': False, 16:24:27 INFO - 'download_minidump_stackwalk': True, 16:24:27 INFO - 'download_symbols': 'ondemand', 16:24:27 INFO - 'enable_stylo': False, 16:24:27 INFO - 'enable_webrender': False, 16:24:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 16:24:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:24:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:24:27 INFO - 'gecko_profile': False, 16:24:27 INFO - 'gecko_profile_interval': 0, 16:24:27 INFO - 'installer_path': 'installer.exe', 16:24:27 INFO - 'log_level': 'info', 16:24:27 INFO - 'log_name': 'talos', 16:24:27 INFO - 'log_to_console': True, 16:24:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:24:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:24:27 INFO - 'opt_config_files': (), 16:24:27 INFO - 'pip_index': False, 16:24:27 INFO - 'suite': 'dromaeojs-e10s', 16:24:27 INFO - 'system_bits': '32', 16:24:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:24:27 INFO - 'title': 'talos-linux64-ix-069', 16:24:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:24:27 INFO - 'use_talos_json': True, 16:24:27 INFO - 'verify': 'False', 16:24:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:24:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:24:27 INFO - 'work_dir': 'build'} 16:24:27 INFO - [mozharness: 2017-09-18 23:24:27.609131Z] Running clobber step. 16:24:27 INFO - Running pre-action listener: _resource_record_pre_action 16:24:27 INFO - Running main action method: clobber 16:24:27 INFO - rmtree: /builds/slave/test/build 16:24:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:24:28 INFO - Running post-action listener: _resource_record_post_action 16:24:28 INFO - [mozharness: 2017-09-18 23:24:28.607507Z] Finished clobber step (success) 16:24:28 INFO - [mozharness: 2017-09-18 23:24:28.607604Z] Running read-buildbot-config step. 16:24:28 INFO - Running pre-action listener: _resource_record_pre_action 16:24:28 INFO - Running main action method: read_buildbot_config 16:24:28 INFO - Using buildbot properties: 16:24:28 INFO - { 16:24:28 INFO - "project": "", 16:24:28 INFO - "product": "firefox", 16:24:28 INFO - "who": "kwierso@gmail.com", 16:24:28 INFO - "installer_path": "public/build/target.tar.bz2", 16:24:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:24:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:24:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 16:24:28 INFO - "stage_platform": "linux64-pgo", 16:24:28 INFO - "basedir": "/builds/slave/test", 16:24:28 INFO - "buildnumber": 179, 16:24:28 INFO - "platform": "ubuntu64_hw", 16:24:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:24:28 INFO - "slavebuilddir": "test", 16:24:28 INFO - "taskId": "OdoG27geRaS3ymt2qnOvlA", 16:24:28 INFO - "branch": "mozilla-central", 16:24:28 INFO - "script_repo_revision": "production", 16:24:28 INFO - "revision": "948dc86aabc97e16d51ad19ea90debab6f93a628", 16:24:28 INFO - "slavename": "talos-linux64-ix-069", 16:24:28 INFO - "repo_path": "mozilla-central" 16:24:28 INFO - } 16:24:28 INFO - Finding installer, test and symbols from parent task. 16:24:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OdoG27geRaS3ymt2qnOvlA'}, attempt #1 16:24:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OdoG27geRaS3ymt2qnOvlA'}, attempt #1 16:24:29 INFO - Task dependencies: UqTWGDHrQViBxHcj81BZMg 16:24:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg'}, attempt #1 16:24:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.tar.bz2 16:24:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.test_packages.json 16:24:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.crashreporter-symbols.zip 16:24:29 INFO - Running post-action listener: _resource_record_post_action 16:24:29 INFO - [mozharness: 2017-09-18 23:24:29.961313Z] Finished read-buildbot-config step (success) 16:24:29 INFO - [mozharness: 2017-09-18 23:24:29.961527Z] Running download-and-extract step. 16:24:29 INFO - Running pre-action listener: _resource_record_pre_action 16:24:29 INFO - Running main action method: download_and_extract 16:24:29 INFO - mkdir: /builds/slave/test/build/tests 16:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:29 INFO - trying https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.test_packages.json 16:24:29 INFO - Downloading https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:24:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:24:30 INFO - Downloaded 989 bytes. 16:24:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:24:30 INFO - Using the following test package requirements: 16:24:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:24:30 INFO - u'common': [u'target.common.tests.zip'], 16:24:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:24:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:24:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:24:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:24:30 INFO - u'mozbase': [u'target.common.tests.zip'], 16:24:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:24:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:24:30 INFO - u'web-platform': [u'target.common.tests.zip', 16:24:30 INFO - u'target.web-platform.tests.tar.gz'], 16:24:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:24:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 16:24:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.common.tests.zip 16:24:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:24:30 INFO - Fetch https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.common.tests.zip into memory 16:24:32 INFO - Content-Length response header: 55322739 16:24:32 INFO - Bytes received: 55322739 16:24:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.talos.tests.zip 16:24:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:24:43 INFO - Fetch https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.talos.tests.zip into memory 16:24:45 INFO - Content-Length response header: 14508748 16:24:45 INFO - Bytes received: 14508748 16:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:45 INFO - trying https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.tar.bz2 16:24:45 INFO - Downloading https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:24:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:24:49 INFO - Downloaded 62224112 bytes. 16:24:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.tar.bz2 16:24:49 INFO - mkdir: /builds/slave/test/properties 16:24:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:24:49 INFO - Writing to file /builds/slave/test/properties/build_url 16:24:49 INFO - Contents: 16:24:49 INFO - build_url:https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.tar.bz2 16:24:49 INFO - Running post-action listener: _resource_record_post_action 16:24:49 INFO - Running post-action listener: find_tests_for_verification 16:24:49 INFO - Running post-action listener: set_extra_try_arguments 16:24:49 INFO - [mozharness: 2017-09-18 23:24:49.726162Z] Finished download-and-extract step (success) 16:24:49 INFO - [mozharness: 2017-09-18 23:24:49.726496Z] Running populate-webroot step. 16:24:49 INFO - Running pre-action listener: _resource_record_pre_action 16:24:49 INFO - Running main action method: populate_webroot 16:24:49 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:24:50 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:24:50 INFO - 'tests': ['tresize', 16:24:50 INFO - 'tcanvasmark']}, 16:24:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:24:50 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:24:50 INFO - 'tests': ['dromaeo_css', 16:24:50 INFO - 'kraken']}, 16:24:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:24:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:24:50 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:24:50 INFO - 'talos_options': ['--disable-stylo'], 16:24:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:24:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:24:50 INFO - 'tests': ['damp', 'tps']}, 16:24:50 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:24:50 INFO - 'talos_options': ['--disable-stylo'], 16:24:50 INFO - 'tests': ['damp', 'tps']}, 16:24:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:24:50 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:24:50 INFO - 'tests': ['dromaeo_dom']}, 16:24:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:24:50 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:24:50 INFO - 'tests': ['basic_compositor_video', 16:24:50 INFO - 'glvideo']}, 16:24:50 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:24:50 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:24:50 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:24:50 INFO - 'talos_options': ['--disable-stylo'], 16:24:50 INFO - 'tests': ['ts_paint_webext', 16:24:50 INFO - 'tp5o_webext']}, 16:24:50 INFO - 'other-e10s': {'tests': ['a11yr', 16:24:50 INFO - 'ts_paint', 16:24:50 INFO - 'tpaint', 16:24:50 INFO - 'sessionrestore', 16:24:50 INFO - 'sessionrestore_many_windows', 16:24:50 INFO - 'sessionrestore_no_auto_restore', 16:24:50 INFO - 'tabpaint']}, 16:24:50 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:24:50 INFO - 'tests': ['a11yr', 16:24:50 INFO - 'ts_paint', 16:24:50 INFO - 'tpaint', 16:24:50 INFO - 'sessionrestore', 16:24:50 INFO - 'sessionrestore_many_windows', 16:24:50 INFO - 'sessionrestore_no_auto_restore', 16:24:50 INFO - 'tabpaint']}, 16:24:50 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:24:50 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 16:24:50 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:24:50 INFO - 'tests': ['perf_reftest_singletons']}, 16:24:50 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:24:50 INFO - 'tests': ['bloom_basic']}, 16:24:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:24:50 INFO - 'tsvgr_opacity', 16:24:50 INFO - 'tart', 16:24:50 INFO - 'tscrollx', 16:24:50 INFO - 'tsvg_static']}, 16:24:50 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:24:50 INFO - 'tests': ['tsvgx', 16:24:50 INFO - 'tsvgr_opacity', 16:24:50 INFO - 'tart', 16:24:50 INFO - 'tscrollx', 16:24:50 INFO - 'tsvg_static']}, 16:24:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:24:50 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:24:50 INFO - 'talos_options': ['--disable-stylo'], 16:24:50 INFO - 'tests': ['tp5o']}, 16:24:50 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:24:50 INFO - 'talos_options': ['--mitmproxy', 16:24:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:24:50 INFO - '--firstNonBlankPaint'], 16:24:50 INFO - 'tests': ['tp6_google', 16:24:50 INFO - 'tp6_youtube', 16:24:50 INFO - 'tp6_amazon', 16:24:50 INFO - 'tp6_facebook']}, 16:24:50 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:24:50 INFO - 'talos_options': ['--disable-stylo', 16:24:50 INFO - '--mitmproxy', 16:24:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:24:50 INFO - '--firstNonBlankPaint'], 16:24:50 INFO - 'tests': ['tp6_google', 16:24:50 INFO - 'tp6_youtube', 16:24:50 INFO - 'tp6_amazon', 16:24:50 INFO - 'tp6_facebook']}, 16:24:50 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:24:50 INFO - 'talos_options': ['--stylo-threads=1', 16:24:50 INFO - '--mitmproxy', 16:24:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:24:50 INFO - '--firstNonBlankPaint'], 16:24:50 INFO - 'tests': ['tp6_google', 16:24:50 INFO - 'tp6_youtube', 16:24:50 INFO - 'tp6_amazon', 16:24:50 INFO - 'tp6_facebook']}, 16:24:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:24:50 INFO - 'talos_options': ['--xperf_path', 16:24:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:24:50 INFO - 'tests': ['tp5n']}, 16:24:50 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:24:50 INFO - 'talos_options': ['--disable-stylo', 16:24:50 INFO - '--xperf_path', 16:24:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:24:50 INFO - 'tests': ['tp5n']}}} 16:24:50 INFO - Running post-action listener: _resource_record_post_action 16:24:50 INFO - [mozharness: 2017-09-18 23:24:50.199714Z] Finished populate-webroot step (success) 16:24:50 INFO - [mozharness: 2017-09-18 23:24:50.199957Z] Running create-virtualenv step. 16:24:50 INFO - Running pre-action listener: _resource_record_pre_action 16:24:50 INFO - Running main action method: create_virtualenv 16:24:50 INFO - Creating virtualenv /builds/slave/test/build/venv 16:24:50 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:24:50 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 16:24:50 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:24:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:24:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:24:50 INFO - Installing distribute.............................................................................................................................................................................................done. 16:24:51 INFO - Installing pip...............done. 16:24:51 INFO - Return code: 0 16:24:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:24:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:24:51 INFO - Reading from file tmpfile_stdout 16:24:51 INFO - Output received: 16:24:51 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 16:24:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:24: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')]} 16:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24: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')]} 16:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2552090>, '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 0x2552d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:24: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', 'pip>=1.5'] in /builds/slave/test/build 16:24: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 pip>=1.5 16:24:51 INFO - Using env: {'DISPLAY': ':0', 16:24:51 INFO - 'HOME': '/home/cltbld', 16:24:51 INFO - 'LANG': 'en_US.UTF-8', 16:24:51 INFO - 'LANGUAGE': 'en_US:en', 16:24:51 INFO - 'LOGNAME': 'cltbld', 16:24:51 INFO - 'MAIL': '/var/mail/cltbld', 16:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:51 INFO - 'MOZ_NO_REMOTE': '1', 16:24:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:51 INFO - 'NO_EM_RESTART': '1', 16:24:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:51 INFO - 'PWD': '/builds/slave/test', 16:24:51 INFO - 'SHELL': '/bin/bash', 16:24:51 INFO - 'SHLVL': '1', 16:24:51 INFO - 'TERM': 'linux', 16:24:51 INFO - 'TMOUT': '86400', 16:24:51 INFO - 'USER': 'cltbld', 16:24:51 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190', 16:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:51 INFO - '_': '/tools/buildbot/bin/python'} 16:24:52 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:24:52 INFO - Downloading/unpacking pip>=1.5 16:24:52 INFO - Running setup.py egg_info for package pip 16:24:52 INFO - warning: no files found matching 'pip/cacert.pem' 16:24:52 INFO - warning: no files found matching '*.html' under directory 'docs' 16:24:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:24:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:24:52 INFO - Installing collected packages: pip 16:24:52 INFO - Found existing installation: pip 1.1 16:24:52 INFO - Uninstalling pip: 16:24:52 INFO - Successfully uninstalled pip 16:24:52 INFO - Running setup.py install for pip 16:24:52 INFO - warning: no files found matching 'pip/cacert.pem' 16:24:52 INFO - warning: no files found matching '*.html' under directory 'docs' 16:24:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:24:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:24:52 INFO - Installing pip script to /builds/slave/test/build/venv/bin 16:24:52 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 16:24:52 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 16:24:52 INFO - Successfully installed pip 16:24:52 INFO - Cleaning up... 16:24:52 INFO - Return code: 0 16:24:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2552090>, '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 0x2552d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:24:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:24:52 INFO - Using env: {'DISPLAY': ':0', 16:24:52 INFO - 'HOME': '/home/cltbld', 16:24:52 INFO - 'LANG': 'en_US.UTF-8', 16:24:52 INFO - 'LANGUAGE': 'en_US:en', 16:24:52 INFO - 'LOGNAME': 'cltbld', 16:24:52 INFO - 'MAIL': '/var/mail/cltbld', 16:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:52 INFO - 'MOZ_NO_REMOTE': '1', 16:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:52 INFO - 'NO_EM_RESTART': '1', 16:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:52 INFO - 'PWD': '/builds/slave/test', 16:24:52 INFO - 'SHELL': '/bin/bash', 16:24:52 INFO - 'SHLVL': '1', 16:24:52 INFO - 'TERM': 'linux', 16:24:52 INFO - 'TMOUT': '86400', 16:24:52 INFO - 'USER': 'cltbld', 16:24:52 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190', 16:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:52 INFO - '_': '/tools/buildbot/bin/python'} 16:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:52 INFO - Downloading/unpacking psutil>=3.1.1 16:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:24:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:24:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:24:53 INFO - Installing collected packages: psutil 16:24:53 INFO - Running setup.py install for psutil 16:24:53 INFO - building 'psutil._psutil_linux' extension 16:24:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:24:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:24:54 INFO - building 'psutil._psutil_posix' extension 16:24:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:24:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:24:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:24:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:24:54 INFO - Successfully installed psutil 16:24:54 INFO - Cleaning up... 16:24:54 INFO - Return code: 0 16:24:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:24: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')]} 16:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24: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')]} 16:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2552090>, '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 0x2552d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:24:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:24:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:24:54 INFO - Using env: {'DISPLAY': ':0', 16:24:54 INFO - 'HOME': '/home/cltbld', 16:24:54 INFO - 'LANG': 'en_US.UTF-8', 16:24:54 INFO - 'LANGUAGE': 'en_US:en', 16:24:54 INFO - 'LOGNAME': 'cltbld', 16:24:54 INFO - 'MAIL': '/var/mail/cltbld', 16:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:54 INFO - 'MOZ_NO_REMOTE': '1', 16:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:54 INFO - 'NO_EM_RESTART': '1', 16:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:54 INFO - 'PWD': '/builds/slave/test', 16:24:54 INFO - 'SHELL': '/bin/bash', 16:24:54 INFO - 'SHLVL': '1', 16:24:54 INFO - 'TERM': 'linux', 16:24:54 INFO - 'TMOUT': '86400', 16:24:54 INFO - 'USER': 'cltbld', 16:24:54 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190', 16:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:54 INFO - '_': '/tools/buildbot/bin/python'} 16:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:24:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:24:55 INFO - Installing collected packages: mozsystemmonitor 16:24:55 INFO - Running setup.py install for mozsystemmonitor 16:24:55 INFO - Successfully installed mozsystemmonitor 16:24:55 INFO - Cleaning up... 16:24:57 INFO - Return code: 0 16:24:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:24: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')]} 16:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24: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')]} 16:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:57 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 0x21e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2552090>, '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 0x2552d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:24:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:24:57 INFO - Using env: {'DISPLAY': ':0', 16:24:57 INFO - 'HOME': '/home/cltbld', 16:24:57 INFO - 'LANG': 'en_US.UTF-8', 16:24:57 INFO - 'LANGUAGE': 'en_US:en', 16:24:57 INFO - 'LOGNAME': 'cltbld', 16:24:57 INFO - 'MAIL': '/var/mail/cltbld', 16:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:57 INFO - 'MOZ_NO_REMOTE': '1', 16:24:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:57 INFO - 'NO_EM_RESTART': '1', 16:24:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:57 INFO - 'PWD': '/builds/slave/test', 16:24:57 INFO - 'SHELL': '/bin/bash', 16:24:57 INFO - 'SHLVL': '1', 16:24:57 INFO - 'TERM': 'linux', 16:24:57 INFO - 'TMOUT': '86400', 16:24:57 INFO - 'USER': 'cltbld', 16:24:57 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190', 16:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:57 INFO - '_': '/tools/buildbot/bin/python'} 16:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:57 INFO - Downloading/unpacking jsonschema==2.5.1 16:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:24:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:58 INFO - Downloading functools32-3.2.3-2.tar.gz 16:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:24:58 INFO - warning: no files found matching '*.txt' 16:24:58 INFO - no previously-included directories found matching 'build' 16:24:58 INFO - no previously-included directories found matching 'dist' 16:24:58 INFO - no previously-included directories found matching '.git*' 16:24:58 INFO - Installing collected packages: jsonschema, functools32 16:24:59 INFO - Running setup.py install for functools32 16:25:00 INFO - warning: no files found matching '*.txt' 16:25:00 INFO - no previously-included directories found matching 'build' 16:25:00 INFO - no previously-included directories found matching 'dist' 16:25:00 INFO - no previously-included directories found matching '.git*' 16:25:00 INFO - Successfully installed jsonschema functools32 16:25:00 INFO - Cleaning up... 16:25:00 INFO - Return code: 0 16:25:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:25: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')]} 16:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25: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')]} 16:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2552090>, '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 0x2552d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:25:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:25:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:25:00 INFO - Using env: {'DISPLAY': ':0', 16:25:00 INFO - 'HOME': '/home/cltbld', 16:25:00 INFO - 'LANG': 'en_US.UTF-8', 16:25:00 INFO - 'LANGUAGE': 'en_US:en', 16:25:00 INFO - 'LOGNAME': 'cltbld', 16:25:00 INFO - 'MAIL': '/var/mail/cltbld', 16:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:00 INFO - 'MOZ_NO_REMOTE': '1', 16:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:00 INFO - 'NO_EM_RESTART': '1', 16:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:00 INFO - 'PWD': '/builds/slave/test', 16:25:00 INFO - 'SHELL': '/bin/bash', 16:25:00 INFO - 'SHLVL': '1', 16:25:00 INFO - 'TERM': 'linux', 16:25:00 INFO - 'TMOUT': '86400', 16:25:00 INFO - 'USER': 'cltbld', 16:25:00 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190', 16:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:00 INFO - '_': '/tools/buildbot/bin/python'} 16:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:25:00 INFO - Cleaning up... 16:25:00 INFO - Return code: 0 16:25:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:25: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')]} 16:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25: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')]} 16:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2552090>, '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 0x2552d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:25:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:25:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:25:00 INFO - Using env: {'DISPLAY': ':0', 16:25:00 INFO - 'HOME': '/home/cltbld', 16:25:00 INFO - 'LANG': 'en_US.UTF-8', 16:25:00 INFO - 'LANGUAGE': 'en_US:en', 16:25:00 INFO - 'LOGNAME': 'cltbld', 16:25:00 INFO - 'MAIL': '/var/mail/cltbld', 16:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:00 INFO - 'MOZ_NO_REMOTE': '1', 16:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:00 INFO - 'NO_EM_RESTART': '1', 16:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:00 INFO - 'PWD': '/builds/slave/test', 16:25:00 INFO - 'SHELL': '/bin/bash', 16:25:00 INFO - 'SHLVL': '1', 16:25:00 INFO - 'TERM': 'linux', 16:25:00 INFO - 'TMOUT': '86400', 16:25:00 INFO - 'USER': 'cltbld', 16:25:00 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190', 16:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:00 INFO - '_': '/tools/buildbot/bin/python'} 16:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:00 INFO - Downloading/unpacking blobuploader==1.2.4 16:25: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 16:25: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 16:25: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 16:25: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 16:25:01 INFO - Downloading blobuploader-1.2.4.tar.gz 16:25:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:25:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:25:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:02 INFO - Downloading docopt-0.6.1.tar.gz 16:25:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:25:02 INFO - Installing collected packages: blobuploader, requests, docopt 16:25:02 INFO - Running setup.py install for blobuploader 16:25:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:25:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:25:02 INFO - Running setup.py install for requests 16:25:02 INFO - Running setup.py install for docopt 16:25:02 INFO - Successfully installed blobuploader requests docopt 16:25:02 INFO - Cleaning up... 16:25:02 INFO - Return code: 0 16:25:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:02 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 0x21e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2552090>, '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 0x2552d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:25:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:25:02 INFO - Using env: {'DISPLAY': ':0', 16:25:02 INFO - 'HOME': '/home/cltbld', 16:25:02 INFO - 'LANG': 'en_US.UTF-8', 16:25:02 INFO - 'LANGUAGE': 'en_US:en', 16:25:02 INFO - 'LOGNAME': 'cltbld', 16:25:02 INFO - 'MAIL': '/var/mail/cltbld', 16:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:02 INFO - 'MOZ_NO_REMOTE': '1', 16:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:02 INFO - 'NO_EM_RESTART': '1', 16:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:02 INFO - 'PWD': '/builds/slave/test', 16:25:02 INFO - 'SHELL': '/bin/bash', 16:25:02 INFO - 'SHLVL': '1', 16:25:02 INFO - 'TERM': 'linux', 16:25:02 INFO - 'TMOUT': '86400', 16:25:02 INFO - 'USER': 'cltbld', 16:25:02 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190', 16:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:02 INFO - '_': '/tools/buildbot/bin/python'} 16:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:25:03 INFO - Running setup.py (path:/tmp/pip-9CUUam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:25:03 INFO - Running setup.py (path:/tmp/pip-IVVBeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:25:03 INFO - Running setup.py (path:/tmp/pip-PTqFYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:25:03 INFO - Running setup.py (path:/tmp/pip-dJrfNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:25:03 INFO - Running setup.py (path:/tmp/pip-y5mvyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:25:03 INFO - Running setup.py (path:/tmp/pip-TSjbmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:25:03 INFO - Running setup.py (path:/tmp/pip-nFiaHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:25:03 INFO - Running setup.py (path:/tmp/pip-FuoEph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:25:03 INFO - Running setup.py (path:/tmp/pip-Qkx9HU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:25:03 INFO - Running setup.py (path:/tmp/pip-k9B2kx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:25:03 INFO - Running setup.py (path:/tmp/pip-uhPwR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:25:03 INFO - Running setup.py (path:/tmp/pip-i7PlQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:25:03 INFO - Running setup.py (path:/tmp/pip-qDLyao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:25:04 INFO - Running setup.py (path:/tmp/pip-dny3DK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:25:04 INFO - Running setup.py (path:/tmp/pip-AK7I6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:25:04 INFO - Running setup.py (path:/tmp/pip-Sya4AT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:25:04 INFO - Running setup.py (path:/tmp/pip-7fohfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:25:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:25:04 INFO - Running setup.py install for manifestparser 16:25:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:25:04 INFO - Running setup.py install for mozcrash 16:25:04 INFO - Running setup.py install for mozdebug 16:25:04 INFO - Running setup.py install for mozdevice 16:25:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:25:04 INFO - Running setup.py install for mozfile 16:25:04 INFO - Running setup.py install for mozhttpd 16:25:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:25:04 INFO - Running setup.py install for mozinfo 16:25:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:25:04 INFO - Running setup.py install for mozInstall 16:25:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:25:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:25:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:25:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:25:05 INFO - Running setup.py install for mozleak 16:25:05 INFO - Running setup.py install for mozlog 16:25:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:25:05 INFO - Running setup.py install for moznetwork 16:25:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:25:05 INFO - Running setup.py install for mozprocess 16:25:05 INFO - Running setup.py install for mozprofile 16:25:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:25:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:25:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:25:05 INFO - Running setup.py install for mozrunner 16:25:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:25:05 INFO - Running setup.py install for mozscreenshot 16:25:05 INFO - Running setup.py install for moztest 16:25:05 INFO - Running setup.py install for mozversion 16:25:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:25:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:25:06 INFO - Cleaning up... 16:25:06 INFO - Return code: 0 16:25:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:06 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 0x21e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2552090>, '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 0x2552d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:25:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:25:06 INFO - Using env: {'DISPLAY': ':0', 16:25:06 INFO - 'HOME': '/home/cltbld', 16:25:06 INFO - 'LANG': 'en_US.UTF-8', 16:25:06 INFO - 'LANGUAGE': 'en_US:en', 16:25:06 INFO - 'LOGNAME': 'cltbld', 16:25:06 INFO - 'MAIL': '/var/mail/cltbld', 16:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:06 INFO - 'MOZ_NO_REMOTE': '1', 16:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:06 INFO - 'NO_EM_RESTART': '1', 16:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:06 INFO - 'PWD': '/builds/slave/test', 16:25:06 INFO - 'SHELL': '/bin/bash', 16:25:06 INFO - 'SHLVL': '1', 16:25:06 INFO - 'TERM': 'linux', 16:25:06 INFO - 'TMOUT': '86400', 16:25:06 INFO - 'USER': 'cltbld', 16:25:06 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190', 16:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:06 INFO - '_': '/tools/buildbot/bin/python'} 16:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:25:06 INFO - Running setup.py (path:/tmp/pip-qB998z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:25:06 INFO - Running setup.py (path:/tmp/pip-1wN35p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:25:06 INFO - Running setup.py (path:/tmp/pip-ziMme2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:25:06 INFO - Running setup.py (path:/tmp/pip-udbyel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:25:06 INFO - Running setup.py (path:/tmp/pip-zDOAha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:25:06 INFO - Running setup.py (path:/tmp/pip-kbAm8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:25:06 INFO - Running setup.py (path:/tmp/pip-2AIEU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:25:06 INFO - Running setup.py (path:/tmp/pip-22kNWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:25:06 INFO - Running setup.py (path:/tmp/pip-nSnqPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:25:06 INFO - Running setup.py (path:/tmp/pip-wcpFB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:25:06 INFO - Running setup.py (path:/tmp/pip-CqQOSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:25:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:25:07 INFO - Running setup.py (path:/tmp/pip-_AJnA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:25:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:25:07 INFO - Running setup.py (path:/tmp/pip-a1O3OD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:25:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:25:07 INFO - Running setup.py (path:/tmp/pip-lkoDLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:25:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:25:07 INFO - Running setup.py (path:/tmp/pip-su5CJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:25:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:25:07 INFO - Running setup.py (path:/tmp/pip-FWlliw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:25:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:25:07 INFO - Running setup.py (path:/tmp/pip-y0vTdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:25:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:25:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:25:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:25:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:25:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:25:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:25:07 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:25:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:08 INFO - Downloading blessings-1.6.tar.gz 16:25:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:25:08 INFO - Installing collected packages: blessings 16:25:08 INFO - Running setup.py install for blessings 16:25:08 INFO - Successfully installed blessings 16:25:08 INFO - Cleaning up... 16:25:08 INFO - Return code: 0 16:25:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:25:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:25:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:25:08 INFO - Reading from file tmpfile_stdout 16:25:08 INFO - Current package versions: 16:25:08 INFO - argparse == 1.2.1 16:25:08 INFO - blessings == 1.6 16:25:08 INFO - blobuploader == 1.2.4 16:25:08 INFO - docopt == 0.6.1 16:25:08 INFO - functools32 == 3.2.3-2 16:25:08 INFO - jsonschema == 2.5.1 16:25:08 INFO - manifestparser == 1.1 16:25:08 INFO - mozInstall == 1.13 16:25:08 INFO - mozcrash == 1.0 16:25:08 INFO - mozdebug == 0.1 16:25:08 INFO - mozdevice == 0.51 16:25:08 INFO - mozfile == 1.2 16:25:08 INFO - mozhttpd == 0.7 16:25:08 INFO - mozinfo == 0.10 16:25:08 INFO - mozleak == 0.1 16:25:08 INFO - mozlog == 3.5 16:25:08 INFO - moznetwork == 0.27 16:25:08 INFO - mozprocess == 0.25 16:25:08 INFO - mozprofile == 0.28 16:25:08 INFO - mozrunner == 6.13 16:25:08 INFO - mozscreenshot == 0.1 16:25:08 INFO - mozsystemmonitor == 0.3 16:25:09 INFO - moztest == 0.8 16:25:09 INFO - mozversion == 1.4 16:25:09 INFO - psutil == 3.1.1 16:25:09 INFO - requests == 1.2.3 16:25:09 INFO - wsgiref == 0.1.2 16:25:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:09 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 0x21e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2552090>, '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 0x2552d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:25:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:25:09 INFO - Using env: {'DISPLAY': ':0', 16:25:09 INFO - 'HOME': '/home/cltbld', 16:25:09 INFO - 'LANG': 'en_US.UTF-8', 16:25:09 INFO - 'LANGUAGE': 'en_US:en', 16:25:09 INFO - 'LOGNAME': 'cltbld', 16:25:09 INFO - 'MAIL': '/var/mail/cltbld', 16:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:09 INFO - 'MOZ_NO_REMOTE': '1', 16:25:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:09 INFO - 'NO_EM_RESTART': '1', 16:25:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:09 INFO - 'PWD': '/builds/slave/test', 16:25:09 INFO - 'SHELL': '/bin/bash', 16:25:09 INFO - 'SHLVL': '1', 16:25:09 INFO - 'TERM': 'linux', 16:25:09 INFO - 'TMOUT': '86400', 16:25:09 INFO - 'USER': 'cltbld', 16:25:09 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190', 16:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:09 INFO - '_': '/tools/buildbot/bin/python'} 16:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:25:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:25:10 INFO - Installing collected packages: simplejson 16:25:10 INFO - Running setup.py install for simplejson 16:25:10 INFO - building 'simplejson._speedups' extension 16:25:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 16:25:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 16:25:11 INFO - Successfully installed simplejson 16:25:11 INFO - Cleaning up... 16:25:11 INFO - Return code: 0 16:25:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:11 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 0x21e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2552090>, '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 0x2552d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:25:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:25:11 INFO - Using env: {'DISPLAY': ':0', 16:25:11 INFO - 'HOME': '/home/cltbld', 16:25:11 INFO - 'LANG': 'en_US.UTF-8', 16:25:11 INFO - 'LANGUAGE': 'en_US:en', 16:25:11 INFO - 'LOGNAME': 'cltbld', 16:25:11 INFO - 'MAIL': '/var/mail/cltbld', 16:25:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:11 INFO - 'MOZ_NO_REMOTE': '1', 16:25:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:11 INFO - 'NO_EM_RESTART': '1', 16:25:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:11 INFO - 'PWD': '/builds/slave/test', 16:25:11 INFO - 'SHELL': '/bin/bash', 16:25:11 INFO - 'SHLVL': '1', 16:25:11 INFO - 'TERM': 'linux', 16:25:11 INFO - 'TMOUT': '86400', 16:25:11 INFO - 'USER': 'cltbld', 16:25:11 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190', 16:25:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:11 INFO - '_': '/tools/buildbot/bin/python'} 16:25:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:25:11 INFO - Cleaning up... 16:25:11 INFO - Return code: 0 16:25:11 INFO - Running post-action listener: _resource_record_post_action 16:25:11 INFO - Running post-action listener: _start_resource_monitoring 16:25:11 INFO - Starting resource monitoring. 16:25:11 INFO - [mozharness: 2017-09-18 23:25:11.733448Z] Finished create-virtualenv step (success) 16:25:11 INFO - [mozharness: 2017-09-18 23:25:11.733911Z] Running install step. 16:25:11 INFO - Running pre-action listener: _resource_record_pre_action 16:25:11 INFO - Running main action method: install 16:25:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:25:11 INFO - Reading from file tmpfile_stdout 16:25:11 INFO - Detecting whether we're running mozinstall >=1.0... 16:25:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:25:12 INFO - Reading from file tmpfile_stdout 16:25:12 INFO - Output received: 16:25:12 INFO - Usage: mozinstall [options] installer 16:25:12 INFO - Options: 16:25:12 INFO - -h, --help show this help message and exit 16:25:12 INFO - -d DEST, --destination=DEST 16:25:12 INFO - Directory to install application into. [default: 16:25:12 INFO - "/builds/slave/test"] 16:25:12 INFO - --app=APP Application being installed. [default: firefox] 16:25:12 INFO - mkdir: /builds/slave/test/build/application 16:25:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:25:29 INFO - Reading from file tmpfile_stdout 16:25:29 INFO - Output received: 16:25:29 INFO - /builds/slave/test/build/application/firefox/firefox 16:25:29 INFO - Running post-action listener: _resource_record_post_action 16:25:29 INFO - [mozharness: 2017-09-18 23:25:29.677267Z] Finished install step (success) 16:25:29 INFO - [mozharness: 2017-09-18 23:25:29.677520Z] Running setup-mitmproxy step. 16:25:29 INFO - Running pre-action listener: _resource_record_pre_action 16:25:29 INFO - Running main action method: setup_mitmproxy 16:25:29 INFO - Skipping: mitmproxy is not required 16:25:29 INFO - Running post-action listener: _resource_record_post_action 16:25:29 INFO - [mozharness: 2017-09-18 23:25:29.678643Z] Finished setup-mitmproxy step (success) 16:25:29 INFO - [mozharness: 2017-09-18 23:25:29.678864Z] Running run-tests step. 16:25:29 INFO - Running pre-action listener: _resource_record_pre_action 16:25:29 INFO - Running pre-action listener: _set_gcov_prefix 16:25:29 INFO - Running main action method: run_tests 16:25:29 WARNING - Try message not found. 16:25:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:25:29 INFO - Python 2.7.3 16:25:29 INFO - Return code: 0 16:25:29 INFO - grabbing minidump binary from tooltool 16:25:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:29 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 0x2552090>, '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 0x2552d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254cf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:25:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:25:29 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:25:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:25:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:25:29 INFO - Return code: 0 16:25:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:25:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:25:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:25:29 INFO - ENV: RUST_BACKTRACE is now full 16:25:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:25:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:25:29 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/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:25:29 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/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:25:29 INFO - Using env: {'DISPLAY': ':0', 16:25:29 INFO - 'HOME': '/home/cltbld', 16:25:29 INFO - 'LANG': 'en_US.UTF-8', 16:25:29 INFO - 'LANGUAGE': 'en_US:en', 16:25:29 INFO - 'LOGNAME': 'cltbld', 16:25:29 INFO - 'MAIL': '/var/mail/cltbld', 16:25:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:25:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:29 INFO - 'MOZ_NO_REMOTE': '1', 16:25:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:25:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:29 INFO - 'NO_EM_RESTART': '1', 16:25:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:29 INFO - 'PWD': '/builds/slave/test', 16:25:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:25:29 INFO - 'RUST_BACKTRACE': 'full', 16:25:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:25:29 INFO - 'SHELL': '/bin/bash', 16:25:29 INFO - 'SHLVL': '1', 16:25:29 INFO - 'TERM': 'linux', 16:25:29 INFO - 'TMOUT': '86400', 16:25:29 INFO - 'USER': 'cltbld', 16:25:29 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190', 16:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:29 INFO - '_': '/tools/buildbot/bin/python'} 16:25:29 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/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:25:30 INFO - mozversion application_buildid: 20170918220821 16:25:30 INFO - mozversion application_changeset: 948dc86aabc97e16d51ad19ea90debab6f93a628 16:25:30 INFO - mozversion application_display_name: Nightly 16:25:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:25:30 INFO - mozversion application_name: Firefox 16:25:30 INFO - mozversion application_remotingname: firefox 16:25:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:25:30 INFO - mozversion application_vendor: Mozilla 16:25:30 INFO - mozversion application_version: 57.0a1 16:25:30 INFO - mozversion platform_buildid: 20170918220821 16:25:30 INFO - mozversion platform_changeset: 948dc86aabc97e16d51ad19ea90debab6f93a628 16:25:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:25:30 INFO - mozversion platform_version: 57.0a1 16:25:30 INFO - using testdate: 1505777130 16:25:30 INFO - actual date: 1505777130 16:25:30 INFO - starting webserver on 'localhost:43120' 16:25:30 INFO - SUITE-START | Running 2 tests 16:25:30 INFO - TEST-START | dromaeo_css 16:25:30 INFO - Initialising browser for dromaeo_css test... 16:25:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43120/getInfo.html -profile /tmp/tmpp2ohey/profile 16:25:30 INFO - TEST-INFO | started process 12144 (/builds/slave/test/build/application/firefox/firefox http://localhost:43120/getInfo.html) 16:25:35 INFO - TEST-INFO | 12144: exit 0 16:25:35 INFO - Browser initialized. 16:25:35 INFO - Running cycle 1/1 for dromaeo_css test... 16:25:35 INFO - Using env: {'DISPLAY': ':0', 16:25:35 INFO - 'HOME': '/home/cltbld', 16:25:35 INFO - 'JSGC_DISABLE_POISONING': '1', 16:25:35 INFO - 'LANG': 'en_US.UTF-8', 16:25:35 INFO - 'LANGUAGE': 'en_US:en', 16:25:35 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:25:35 INFO - 'LOGNAME': 'cltbld', 16:25:35 INFO - 'MAIL': '/var/mail/cltbld', 16:25:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:25:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:25:35 INFO - 'MOZ_CRASHREPORTER': '1', 16:25:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:35 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:25:35 INFO - 'MOZ_NO_REMOTE': '1', 16:25:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:25:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:35 INFO - 'NO_EM_RESTART': '1', 16:25:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:35 INFO - 'PWD': '/builds/slave/test', 16:25:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:25:35 INFO - 'RUST_BACKTRACE': 'full', 16:25:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:25:35 INFO - 'SHELL': '/bin/bash', 16:25:35 INFO - 'SHLVL': '1', 16:25:35 INFO - 'TERM': 'linux', 16:25:35 INFO - 'TMOUT': '86400', 16:25:35 INFO - 'USER': 'cltbld', 16:25:35 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190', 16:25:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:35 INFO - '_': '/tools/buildbot/bin/python'} 16:25:35 INFO - TEST-INFO | started process 12380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp2ohey/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:25:36 INFO - PID 12380 | 16:25:36 INFO - PID 12380 | (/builds/slave/test/build/application/firefox/firefox:12430): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:25:36 INFO - PID 12380 | 16:25:47 INFO - PID 12380 | RSS: Main: 148135936 16:25:47 INFO - PID 12380 | 16:28:44 INFO - PID 12380 | Cycle 1(1): loaded http://localhost:43120/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43120/tests/dromaeo/cssquery-ext.html) 16:28:45 INFO - PID 12380 | RSS: Main: 148410368 16:28:45 INFO - PID 12380 | 16:31:46 INFO - PID 12380 | Cycle 1(1): loaded http://localhost:43120/tests/dromaeo/cssquery-ext.html (next: http://localhost:43120/tests/dromaeo/cssquery-jquery.html) 16:31:47 INFO - PID 12380 | RSS: Main: 148164608 16:31:47 INFO - PID 12380 | 16:34:49 INFO - PID 12380 | Cycle 1(1): loaded http://localhost:43120/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43120/tests/dromaeo/cssquery-mootools.html) 16:34:49 INFO - PID 12380 | RSS: Main: 150396928 16:34:49 INFO - PID 12380 | 16:37:51 INFO - PID 12380 | Cycle 1(1): loaded http://localhost:43120/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43120/tests/dromaeo/cssquery-prototype.html) 16:37:51 INFO - PID 12380 | RSS: Main: 149012480 16:37:51 INFO - PID 12380 | 16:40:54 INFO - PID 12380 | Cycle 1(1): loaded http://localhost:43120/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43120/tests/dromaeo/cssquery-yui.html) 16:40:55 INFO - PID 12380 | RSS: Main: 150687744 16:40:55 INFO - PID 12380 | 16:43:56 INFO - PID 12380 | Cycle 1(1): loaded http://localhost:43120/tests/dromaeo/cssquery-yui.html (next: http://localhost:43120/tests/dromaeo/cssquery-dojo.html) 16:43:57 INFO - PID 12380 | RSS: Main: 152965120 16:43:57 INFO - PID 12380 | 16:43:57 INFO - PID 12380 | __start_tp_report 16:43:57 INFO - PID 12380 | _x_x_mozilla_page_load 16:43:57 INFO - PID 12380 | _x_x_mozilla_page_load_details 16:43:57 INFO - PID 12380 | |i|pagename|runs| 16:43:57 INFO - PID 12380 | |0;dojo.html;3894.045958740109;3898.43472696459;3905.140869008817;3915.6671682906967;3930.5676375598696;6161.507079433646;6264.498840092793;6301.684915754211;6327.272363678178;6393.584417012891;6293.874122517547;6304.180456540644;6308.211473565804;6341.048842673601;6359.427651511363;5628.493435590785;5674.801381951633;5686.573506986972;5705.885882282352;5749.396313387097;5631.155326701007;5694.715264236792;5696.686682232496;5722.971385143069;5742.253507044078;212.06259199689174;5547.639403438763;5592.552595792326;5656.91514627281;5747.827565173052;5620.072688006474;5620.522255608278;5689.857753556153;5699.00267453194;5701.458361455655;5588.972055139739;5591.329040515124;5669;5672.971635141839;5689.7439615217;6239.126522286883;6249.78125765596;6251.156093927307;6301.369863013708;6323.399277068671;6599.505037122235;6713.93286067138;6766.28953959837;6796.898046529306;6860.5197636165485;6821;6826.146731658543;6829.897551536731;6840.384365407088;6852.6916288767125;6322.683865806691;6333.68331583419;6384.106225128486;6411.1024456576115;6424.839379015562;7104.467164962649;7121.074260346122;7125.144982602017;7129.643517824088;7131.286871312827;6727.831804204836;6733.42765864907;6752.493562982796;6830.931690683129;6851.862962740717;6748.662566871637;6859.108315918898;6868.107146070979;6949.652517374212;6972.51192416526;6747.426468750211;6757.594544327356;6769.898451523231;6783.728650854009;6795.150606174228;6797.116374871334;6821.283765204582;6829.931700683029;6863.450923926074;6868.862622747517;4861.124997500484;4905.435874874363;4909.263610458388;4939.3084968104495;4982.9252561211615;4499.977500112544;4525.479569849444;4552.203364411214;4555.06621142665;4560.384348113029;6272.498200143978;6279.309275979638;6338.080978258126;6350.618962862243;6355.0785136155;6690.799276021629;6761.695723692445;6791.932080679228;6818.693158807866;6891.552049116792;6296;6314.905276420857;6319;6321.589096708699;6323.988161894074;5519.116941289374;5560.916586251209;5561.499465048084;5567.749451274622;5571.637843540157;6999.895001574981;7073.893891591631;7094.006839042539;7171.856562868714;7183.353498185188;6708.960111182774;6793.048973143863;6797.762078327235;6887.621180835102;6905.930940690529;7008.264132266243;7017.05269788572;7082.893756593759;7121.14546254432;7123.893141602776;6725.5628384156835;6746.730130794909;6794.8641027180165;6817.454603631797;6825.8634827302185;6795.89806152918;6810.8637827244165;6826.761063362758;6899.17209934811;6920.688569014507;6454.935450645621;6553.082568440327;6554.573952693059;6554.885669436112;6632.933670663231;6518.2178138621775;6522.967385163044;6533.575317604341;6535.117759102651;6550.082988381535;6458.580192287486;6462.773802916875;6474.902876456763;6509.511786615928;6578.8355291118105;6522.119513865568;6697.330266973264;6711.9328806713265;6715.26132125456;6732.831679208059;6458.031295305742;6471.835069687501;6480.092787009728;6566.179227596551;6570.704318305783 16:43:57 INFO - PID 12380 | |1;ext.html;927.9396839205451;935.6538080910065;945.9148676619105;975.1370037516798;979.0209790209794;45949;46709.532904670945;46752.2987155193;46814.76592617037;46832.53167468324;43110;43523.347149792775;43573.7821310893;43641.34537981933;43833;7471.7011319547155;7577.393808495334;7606.885896711554;7611.2769286917655;7616.466847320689;7463.962680186592;7540;7547.13207981081;7550.3959683225485;7552.395808335347;7536.623168841536;8085.676572937075;8265.297449716782;8269.710560130397;8276.420650554464;8173.427860049799;8178.83642327156;8216.83566328676;8253.298469630088;8253.83492330153;7928.80177995549;8197.918020819834;8202.917970820336;8203.794905127359;8213.137620549876;41738.58261417377;42264.15471690549;42324;42362.15275694469;42457.150856983;3757.1922036762226;3797.3924172132324;3799.2211596622624;3804.6766024887643;3814.313423583754;34160.65839341599;34283.314333713184;34289.14277143066;34345;34388.82805585981;5479.75341109651;5506.339239291271;5508.228847961289;5536.114221724505;5601.775928962837;212441;213342.93328533412;214460;214778;215106;52398.73800630972;52408.47591524112;52423.47576524262;52464.16375426842;52511.47488525066;55692.16461753077;64548;65886.34113658802;65896;66249.33750662432;17068;17132.657346852993;17263.309467621406;17272.65454690899;17280.827191728175;13567.86432135666;13827.723445531034;14100.929495352457;14101.083429577046;14154.787678184835;15836.683266334609;15851.603709907344;15852.286647100907;15898.841011589737;15975.760363594323;6125.326214116443;6141.969290153521;6269.843253918689;6288.27684816252;6352.4918006559365;1063.431438628033;1067.2475904487474;1081.2809481694585;1081.2863510083307;1091.9071878890225;23627;23655.408614784425;23846.52306953886;23870.522589548113;24039;1170.8185231289165;1176.8411264479357;1177.1348059176498;1180.5690922813283;1187.4181650990952;12993.805092923614;13235.536756213487;13247.403866826016;13295.3352332383;13308.866911330762;266186;267671;269539;269679;269959;61271.38728612746;61610;61642.691786541676;63866.36133638697;65209.673951629935;1498.6702925356403;1523.9122402308908;1530.2425299476831;1538.7845701601784;1544.5675210940954;27767.583486248128;27862.58206126869;28181.859090705235;28662;29006.56490152607;42527.574724252365;42901.78549107235;43056;43078;43121.3531797017;247521;249876;250553;250836;250881;37002.62997369992;37979;38226.55960963527;38285.808570956964;38286.42570361502;48070.75964620154;48089;48521.5147848517;48562.5143748558;48786.26820597765;33980.50029643101;34398.82800585981;35127.29745405026;35522.644773552965;35613;34804.303913922085;34879.47680784739;35061.649383505835;35432.46851297181;35611.28777424489;36553.81723091367;36601.26797464089;36621;36680.266394671424;36737.632623673424;34262.31475370529;34523.48214776831;34626.82686586652;34828.477572836935;35064.246787661024;23002.53994920126;23694.05223791029;23721.52556948886;24009.879950600134;24131.63802542928 16:43:57 INFO - PID 12380 | |2;jquery.html;585.5549782165558;587.5182350472611;592.881423715257;604.4227762486825;608.8660494691168;23142.537149257005;23755.881220593896;23812.76187238127;23839.880800595973;23846.28461146164;23897.880510597424;24861.75138248617;25174;25288.114915977945;25313.74686253137;6473.935260647392;6497.155369801919;6498.870022599545;6499.642519661416;6517.478601711863;6403.423691867731;6407.519436042316;6499.870002599945;6661.233958094833;6707.664616769166;6671.432928201109;6672.76645317414;6674;6676.833079173011;6678.899816502732;6604.141461609984;6645.6344901030425;6656.93343066568;6661.63361015144;6665.566738162052;6199.380061993809;6213.844653883644;6215.502759779252;6239.968800156015;6247.156633854463;28631.14106576806;28689.713102868915;29241.122766317043;29709.851450742823;29869.55195672067;2265.2524666859895;2293.9885300573555;2294.0823670531922;2296.024189719379;2297.184499502686;20057.598848022957;20463.18147274107;20501.692474612893;20577.279795207247;20578.27976020832;2497.77520023197;2531.0761572026263;2556.412025234188;2576.0854896511655;2588.4564241509306;141535;148406.25796871053;156932;163517;164156;15007.421252267535;15816.36734530629;15916.16964049126;16175.919120404322;16509.58726031835;25246.495070098495;25520.23439296824;25546.23361299127;25565.3608659785;25581.488370232863;10391.584336626602;10464.162866970624;10469.633562825416;10500.947495262628;10679.626213082505;9352.812943741086;9440.24478041755;9540.95229523848;9629;9663.806723865484;9323.300752443594;9493.66772162971;9530.52347382628;9628.32601717887;9976.251781116445;2783.5546312590295;2811.668173214747;2841.659000919903;2868.1969048665987;2973.68776278492;991.3506653142204;1010.2221289606962;1011.9848202276971;1019.3272440189587;1021;18711.438656840317;18981.43055708331;19010.61978760417;19085.80914190868;19094.14076366567;1059.8622179116664;1066.632011955874;1076.56399158341;1076.8761592416815;1078.0085263394144;9644.75888102789;10484.580616775243;10850.457477126112;10874.510647020903;10911.508982095826;605605;622757;623912;624593;634262;121219;123581;127862;129322;131945;1087.3095584304024;1135.5401062569508;1172.4196522721309;1216.7688139253692;1217.8903898648987;20668.276610318568;20684.896575517025;20790.272340468615;20817.58364832725;20956.161753530298;62845.68577157085;62867.37132628615;64008.67995659992;64142.35857641551;65294.67352663206;77459.61270193613;78293.60853195697;78829;78885;80205.5989720071;14820.851791481948;14861.182634955181;15073.170975596448;15168.31742571609;15235.3905843765;23014.539709206056;23314.184003559792;23402;23445.648315274942;23504.882475588198;18361.816381836546;18399.908000459913;18457.90771046136;18629.627407452048;18761.061946902326;16365.754513682066;17159;17178.828211717722;17280.13599320054;17400.303987840343;18404.907975460035;18442.907785460986;18471.630567388307;18625.348112815987;18800.811991880455;14183.21992290434;14891.925540372662;14925.477608283658;15024.09855408679;15081.245937702852;17895.910520447316;17973;18068.096595169925;18109.909450452662;18318.63362732711 16:43:57 INFO - PID 12380 | |3;mootools.html;1404.3189053309143;1445.7903603977425;1449.3550370085316;1460.3939365163458;1465.3918623771133;16669;17488.38790642328;17492.125393730326;17508.999999999985;17509.912450437747;17227.310907563682;17364.39224627138;17382.739258911126;17393.913030434862;17415.91292043538;2607.282997175778;2750.35366688829;2752.779777617796;2756;2759.1308737747645;2700.2844246274653;2767.6402067731165;2787.4703806276843;2797.930051748702;2800.229936767385;2679.6382488364115;2769.9030533931214;2772.8613569321556;2773;2774.4035032468014;2787.484315401647;2788.1774876411305;2807.7753779697573;2810.142906413543;2812.114184032044;2575.060103062369;2762.088510791434;2767.1975127213086;2770.224337185591;2777.819441736301;16623.91688041564;16793.748093778602;16999.915000425044;17020.744688829553;17026.148692565446;8054.677812887478;8254.257116859511;8262.091169971298;8326.50040997542;8330.958345208295;5366.221897824833;5413.891722165574;5532.30846144232;5576.414476479952;5604.971975140139;2087.311187308185;2088.634488964425;2113.6829475578634;2133.9786602133936;2162.91348346066;30576.789437109004;30700.38599228025;30846;30857.691423085707;30920;6520.608763474207;6591.868162636816;6749.5612785168805;6763.932360676428;6766.729330826712;19681;19778;19837.40487785369;19866.801331986786;19872.10575524105;7854.960725196452;7964.840703185904;8021.117677055519;8024.839503209903;8031.1567285434185;7251.274872512707;7340.192578816326;7391.6673749681395;7424.628768561551;7504.62476876165;5463.180522921593;5504.669719816824;5516.696581688046;5540.2243685884005;5807.738651760681;1503.225838693074;1504.1576717038274;1510.909345439277;1517.6433538118533;1536.5620798072719;880.6873559886276;887.7381172553983;903.7785742493131;909.9308312732513;917.2891009467716;7664;7721.7683469496005;7765.223477652303;7771.145174030852;7807.531548107132;765.7166848266177;772.0966469231013;776.0687175389443;781.8514482248355;787.7479206653816;5626.493615574618;5652.293463317085;5745.712714364348;6041.912455758005;6060.696965151725;23492.060317587104;25229.87385063063;25326.746732532807;25519.362015949377;25709.10018149356;24312;24388.87805560961;25161.874190629296;25213.24360269195;25277.494450111262;12274.754504909852;12321.753564928651;12333.69165770845;12530.122891397516;12533.498660053496;8979.775505612412;8980.910190898006;9003.504807235666;9066.50134242623;9201.953990230006;20876.1649534023;21269.78730212678;21405.036773344924;21624.89187554115;21943.451413714785;21852.344429667137;21929.561408772053;22036.88981555082;22080.2271920482;22368.440788980406;12341.876581234073;12396.566120185751;12410.069244806857;12542.937285313516;12601.306928119042;15393.461228856937;15622.609434764221;15664.295106720452;15664.608384790472;15666.060036397852;12447.875521244672;12518.561850335194;12654.114212005072;12819.615411537668;12984.805227921777;12559.246445213317;12611.747765044463;12666.240025598494;12741.745165096832;12772.361381930681;10085.445300508543;10351.792964140826;10432.739181520523;10434.634787782392;10478.266521343432;7932.144193588624;8030.83938321242;8041.236082572146;8077.919220807717;8126.674933002614;8430.114837941928;8458.238758511763;8471.872921906053;8506.574671266535;8512.191341822518 16:43:57 INFO - PID 12380 | |4;prototype.html;548.9890202195957;554.8557375082478;557.6793343827301;575.680497323985;585.1281590430259;6188.226471691039;6249.3438188990185;6263.590692094276;6279.277883043452;6302.842428939279;6174.722137503812;6178.8829059231375;6187.29849291445;6227.377262273771;6252.6561039142825;4793.304970779235;4953.23224900141;5067.645264831473;5082.567981721558;5134.922976155361;4978.153713868651;4983.626228032894;5000.32495613093;5000.724815172144;5024.045431368028;4921.729304888229;4946.802127914897;4948.233023881304;4981.875453113683;4999.4250661174065;4873.48828373021;4910.238912968495;4951.678140920829;4976.950230497685;5010.048090862761;4532.365468834366;4569.651952673969;4578.862634120982;4579.862604121881;4589.977050114728;6161.428835646926;6181.783637572664;6198.969005154991;6269.96865015672;6277.748890044393;5846.532277417797;5847.333509949686;5883.764649414018;5901.734421951022;5930.940690593082;6677.76627818024;6722.4285935695525;6728.360805723449;6759.256481787;6766.56017358875;5042.621803364726;5067.366579177603;5072.6195535335;5080.212567052113;5082.771275292621;6908.9309106909295;6944.72221111155;7002.544834585787;7013.82465438363;7030.824229394255;5155.716435596003;5190.844274671766;5224.791008359699;5238.790448382022;5263.421023687391;5255.605829562798;5287.656302340336;5289.3652761668845;5310.92033619496;5339.46605339463;5801.390853960358;5815.912761308584;5842.824715258549;5894.528437724972;5896.351401345849;6467.644279564669;6530.314316996742;6627.933720662828;6663.13379260693;6752.696128674222;1782.5632719983428;1801.7297405389297;1803.9537068500501;1818.97271540927;1820.544863784054;1131.6122980511116;1279.6417003239108;1285.807128930668;1293.1659079893416;1302.101549930545;6164.630122192682;6180.6291622502795;6182.1345011698395;6272.905906411407;6318.052292156121;6836.589804611739;6861.828454288583;6883.8967415488805;6884.449244060464;6886.55672163918;6221.564490485713;6280.497560195174;6281.685915704196;6292.042739912234;6323.873522529524;3557.6086630470627;3642.581103173116;3649.635036496329;3656.305301992613;3658.506101676293;7078.186008608973;7144.928550714426;7165.319294666998;7172.21105678375;7189.173245076779;7099.006139140524;7151.499395042297;7163.498555101197;7170.784876453715;7177.78466645991;7109.253528379446;7148.714051437884;7170.2471240520035;7196.244394338623;7203.063601731847;6798.422134118655;6841.589504629738;6843.247242803387;6857.897131543131;6872.244053154049;6516.771912983023;6855.715178013741;6872.3884923728665;6907.481938854506;6910.06714093611;6997.860042799217;7007.6145811978795;7035.683394247373;7041.866369465743;7048.202708309348;5168.870778230575;5170;5175.327207463156;5218.243354713622;5222.033923724123;6879.862402751817;6881.931180688129;6901.827454313682;6950.165980082423;6968.895466568107;6573.671316434064;6575.947848344242;6616.338366163345;6706.731730730716;6722.327767223239;6521.7065232065615;6561.442277406474;6632.303608121078;6673.432758215412;6699.660067986325;6458.418742313214;6472.320406357265;6537.5096867734155;6552.705128269144;6604.636744979072;6100.542459315658;6642.535022548375;6650.600963942179;6695.531312808057;6731.596104233761;6312.495000400048;6398.200224971879;6410.134631824831;6489.578177418642;6551.574147680385 16:43:57 INFO - PID 12380 | |5;yui.html;956.8612551180079;962.9518524073794;971.3928794503436;973.816812572724;983.81941669996;20947.266845660404;22529.549409011808;22681.77318226817;22729.545409091807;22749.31752047437;22035.889820550914;22259.666105008397;23781.286561403143;23871;24031.75968240317;1073.9731506712335;1085.3270971997372;1085.375908852409;1086.7065892209098;1096.9122470202406;1070.0743856564093;1096.1121491591837;1103.0954617213888;1103.5034234594425;1104.0174244921986;1152.6196355202806;1155.57821395191;1158.4613154882977;1160.2748282323548;1160.3618010094456;1154.2958795134962;1154.867190273121;1155.260633194756;1155.6533040087982;1155.843961065258;845.1506236232547;845.6701886264361;846.3525403066659;846.6232526525698;846.6697987784769;19739.309124180585;20260.189592416285;20352.18591256348;20376.79623203764;21235.68146477804;20025.79974200254;20678.896605517028;21110;21114.683279750818;21145.5770884583;16777.74833377488;17135.48593542196;17196.398126065527;17199.398021069203;17206.913965430216;3698.7041036716996;3810.9809450952566;3818.9392278407913;3842.51968503937;3850.3261929162286;157419.99999999886;159354;159660.20169899194;161075;162418;17598.208080636403;17748.645027099643;17880.55298617519;18092.638147236983;18177.09114544294;32293.35413291721;32682.67317326844;32992.67007329944;33258.168545786066;33668;9262.490563018964;9391.34260601765;9439.056094390506;9441.669541566012;9461.621535138655;4222.9577704223175;4244.8514301999285;4279.636230920407;4286.314189729628;4324.481062272547;5942.286925568959;6068.271807383142;6076.696165191723;6077.696115194222;6094.268687757498;1042.145440738587;1062.5324857062867;1075.2580719303655;1091.328832767842;1092.0499165725869;669.8124525132971;673.1047706550277;680.880845851974;683.2518392360357;696.4358869315769;13040.673983150307;13615.931920340336;13795.724085518234;14357.64105897361;14551.85448145505;717.6447658409121;719.4711886763225;724.7427163356932;726.12501935168;738.0958326050652;6395.360463953567;6483.935160648428;6489.805305840832;6504.414602685781;6522.445592124723;141791.29104354413;143940.5605943948;145911;148069.25965370104;148814;130431;132732.3363383177;133497;134927;136504.31747841396;113494;113582.456701731;113647;114535.42732286286;115050;12271.141020128505;12286.815697764361;12383.938080309541;12474.688132796753;12512.874871251171;52846;53503.19745203747;53526.73236633792;53627.46372536381;54427.72786136044;66724;68523.31476685169;70000.6499967497;70315;72104;16072.678546428771;16511.33954641801;16595.336186552886;16721.832781672027;16728.247228874487;17059.147042648066;17083.91458042702;17156.313747450462;17398.304067837144;17407.91296043512;16995.7450638243;17191.65616687684;17409.82590174082;17463.38878139259;17473.912630436767;15111.54665360041;15363.23183840826;15473.84526154724;15631.140287283853;15742.685146297239;16439.83560164383;16504.66990660156;16579.585510361856;16623.418180363627;16725.080120592997;12628.684282893002;12734.108612397044;12822.743545128858;12902.612921611992;12932.93533532364;11559.479823407799;11659.358735269641;11701.941490292495;11710.94144529272;11873.109516786448 16:43:57 INFO - PID 12380 | __end_tp_report 16:43:57 INFO - PID 12380 | __start_cc_report 16:43:57 INFO - PID 12380 | _x_x_mozilla_cycle_collect,265 16:43:57 INFO - PID 12380 | __end_cc_report 16:43:57 INFO - PID 12380 | __startTimestamp1505778237165__endTimestamp 16:43:57 INFO - PID 12380 | 16:43:57 INFO - PID 12380 | ------- Summary: start ------- 16:43:57 INFO - PID 12380 | Number of tests: 6 16:43:57 INFO - PID 12380 | 16:43:57 INFO - PID 12380 | [#0] dojo.html Cycles:165 Average:6248.93 Median:6509.51 stddev:881.31 (13.5%) stddev-sans-first:864.43 16:43:57 INFO - PID 12380 | Values: 3894.0 3898.4 3905.1 3915.7 3930.6 6161.5 6264.5 6301.7 6327.3 6393.6 6293.9 6304.2 6308.2 6341.0 6359.4 5628.5 5674.8 5686.6 5705.9 5749.4 5631.2 5694.7 5696.7 5723.0 5742.3 212.1 5547.6 5592.6 5656.9 5747.8 5620.1 5620.5 5689.9 5699.0 5701.5 5589.0 5591.3 5669.0 5673.0 5689.7 6239.1 6249.8 6251.2 6301.4 6323.4 6599.5 6713.9 6766.3 6796.9 6860.5 6821.0 6826.1 6829.9 6840.4 6852.7 6322.7 6333.7 6384.1 6411.1 6424.8 7104.5 7121.1 7125.1 7129.6 7131.3 6727.8 6733.4 6752.5 6830.9 6851.9 6748.7 6859.1 6868.1 6949.7 6972.5 6747.4 6757.6 6769.9 6783.7 6795.2 6797.1 6821.3 6829.9 6863.5 6868.9 4861.1 4905.4 4909.3 4939.3 4982.9 4500.0 4525.5 4552.2 4555.1 4560.4 6272.5 6279.3 6338.1 6350.6 6355.1 6690.8 6761.7 6791.9 6818.7 6891.6 6296.0 6314.9 6319.0 6321.6 6324.0 5519.1 5560.9 5561.5 5567.7 5571.6 6999.9 7073.9 7094.0 7171.9 7183.4 6709.0 6793.0 6797.8 6887.6 6905.9 7008.3 7017.1 7082.9 7121.1 7123.9 6725.6 6746.7 6794.9 6817.5 6825.9 6795.9 6810.9 6826.8 6899.2 6920.7 6454.9 6553.1 6554.6 6554.9 6632.9 6518.2 6523.0 6533.6 6535.1 6550.1 6458.6 6462.8 6474.9 6509.5 6578.8 6522.1 6697.3 6711.9 6715.3 6732.8 6458.0 6471.8 6480.1 6566.2 6570.7 16:43:57 INFO - PID 12380 | 16:43:57 INFO - PID 12380 | [#1] ext.html Cycles:180 Average:42907.14 Median:20379.91 stddev:63819.79 (313.2%) stddev-sans-first:63920.98 16:43:57 INFO - PID 12380 | Values: 927.9 935.7 945.9 975.1 979.0 45949.0 46709.5 46752.3 46814.8 46832.5 43110.0 43523.3 43573.8 43641.3 43833.0 7471.7 7577.4 7606.9 7611.3 7616.5 7464.0 7540.0 7547.1 7550.4 7552.4 7536.6 8085.7 8265.3 8269.7 8276.4 8173.4 8178.8 8216.8 8253.3 8253.8 7928.8 8197.9 8202.9 8203.8 8213.1 41738.6 42264.2 42324.0 42362.2 42457.2 3757.2 3797.4 3799.2 3804.7 3814.3 34160.7 34283.3 34289.1 34345.0 34388.8 5479.8 5506.3 5508.2 5536.1 5601.8 212441.0 213342.9 214460.0 214778.0 215106.0 52398.7 52408.5 52423.5 52464.2 52511.5 55692.2 64548.0 65886.3 65896.0 66249.3 17068.0 17132.7 17263.3 17272.7 17280.8 13567.9 13827.7 14100.9 14101.1 14154.8 15836.7 15851.6 15852.3 15898.8 15975.8 6125.3 6142.0 6269.8 6288.3 6352.5 1063.4 1067.2 1081.3 1081.3 1091.9 23627.0 23655.4 23846.5 23870.5 24039.0 1170.8 1176.8 1177.1 1180.6 1187.4 12993.8 13235.5 13247.4 13295.3 13308.9 266186.0 267671.0 269539.0 269679.0 269959.0 61271.4 61610.0 61642.7 63866.4 65209.7 1498.7 1523.9 1530.2 1538.8 1544.6 27767.6 27862.6 28181.9 28662.0 29006.6 42527.6 42901.8 43056.0 43078.0 43121.4 247521.0 249876.0 250553.0 250836.0 250881.0 37002.6 37979.0 38226.6 38285.8 38286.4 48070.8 48089.0 48521.5 48562.5 48786.3 33980.5 34398.8 35127.3 35522.6 35613.0 34804.3 34879.5 35061.6 35432.5 35611.3 36553.8 36601.3 36621.0 36680.3 36737.6 34262.3 34523.5 34626.8 34828.5 35064.2 23002.5 23694.1 23721.5 24009.9 24131.6 16:43:57 INFO - PID 12380 | 16:43:57 INFO - PID 12380 | [#2] jquery.html Cycles:180 Average:39877.02 Median:23358.09 stddev:104042.37 (445.4%) stddev-sans-first:104292.41 16:43:57 INFO - PID 12380 | Values: 585.6 587.5 592.9 604.4 608.9 23142.5 23755.9 23812.8 23839.9 23846.3 23897.9 24861.8 25174.0 25288.1 25313.7 6473.9 6497.2 6498.9 6499.6 6517.5 6403.4 6407.5 6499.9 6661.2 6707.7 6671.4 6672.8 6674.0 6676.8 6678.9 6604.1 6645.6 6656.9 6661.6 6665.6 6199.4 6213.8 6215.5 6240.0 6247.2 28631.1 28689.7 29241.1 29709.9 29869.6 2265.3 2294.0 2294.1 2296.0 2297.2 20057.6 20463.2 20501.7 20577.3 20578.3 2497.8 2531.1 2556.4 2576.1 2588.5 141535.0 148406.3 156932.0 163517.0 164156.0 15007.4 15816.4 15916.2 16175.9 16509.6 25246.5 25520.2 25546.2 25565.4 25581.5 10391.6 10464.2 10469.6 10500.9 10679.6 9352.8 9440.2 9541.0 9629.0 9663.8 9323.3 9493.7 9530.5 9628.3 9976.3 2783.6 2811.7 2841.7 2868.2 2973.7 991.4 1010.2 1012.0 1019.3 1021.0 18711.4 18981.4 19010.6 19085.8 19094.1 1059.9 1066.6 1076.6 1076.9 1078.0 9644.8 10484.6 10850.5 10874.5 10911.5 605605.0 622757.0 623912.0 624593.0 634262.0 121219.0 123581.0 127862.0 129322.0 131945.0 1087.3 1135.5 1172.4 1216.8 1217.9 20668.3 20684.9 20790.3 20817.6 20956.2 62845.7 62867.4 64008.7 64142.4 65294.7 77459.6 78293.6 78829.0 78885.0 80205.6 14820.9 14861.2 15073.2 15168.3 15235.4 23014.5 23314.2 23402.0 23445.6 23504.9 18361.8 18399.9 18457.9 18629.6 18761.1 16365.8 17159.0 17178.8 17280.1 17400.3 18404.9 18442.9 18471.6 18625.3 18800.8 14183.2 14891.9 14925.5 15024.1 15081.2 17895.9 17973.0 18068.1 18109.9 18318.6 16:43:57 INFO - PID 12380 | 16:43:57 INFO - PID 12380 | [#3] mootools.html Cycles:180 Average:10354.64 Median:2754.39 stddev:7827.74 (284.2%) stddev-sans-first:7820.82 16:43:57 INFO - PID 12380 | Values: 1404.3 1445.8 1449.4 1460.4 1465.4 16669.0 17488.4 17492.1 17509.0 17509.9 17227.3 17364.4 17382.7 17393.9 17415.9 2607.3 2750.4 2752.8 2756.0 2759.1 2700.3 2767.6 2787.5 2797.9 2800.2 2679.6 2769.9 2772.9 2773.0 2774.4 2787.5 2788.2 2807.8 2810.1 2812.1 2575.1 2762.1 2767.2 2770.2 2777.8 16623.9 16793.7 16999.9 17020.7 17026.1 8054.7 8254.3 8262.1 8326.5 8331.0 5366.2 5413.9 5532.3 5576.4 5605.0 2087.3 2088.6 2113.7 2134.0 2162.9 30576.8 30700.4 30846.0 30857.7 30920.0 6520.6 6591.9 6749.6 6763.9 6766.7 19681.0 19778.0 19837.4 19866.8 19872.1 7855.0 7964.8 8021.1 8024.8 8031.2 7251.3 7340.2 7391.7 7424.6 7504.6 5463.2 5504.7 5516.7 5540.2 5807.7 1503.2 1504.2 1510.9 1517.6 1536.6 880.7 887.7 903.8 909.9 917.3 7664.0 7721.8 7765.2 7771.1 7807.5 765.7 772.1 776.1 781.9 787.7 5626.5 5652.3 5745.7 6041.9 6060.7 23492.1 25229.9 25326.7 25519.4 25709.1 24312.0 24388.9 25161.9 25213.2 25277.5 12274.8 12321.8 12333.7 12530.1 12533.5 8979.8 8980.9 9003.5 9066.5 9202.0 20876.2 21269.8 21405.0 21624.9 21943.5 21852.3 21929.6 22036.9 22080.2 22368.4 12341.9 12396.6 12410.1 12542.9 12601.3 15393.5 15622.6 15664.3 15664.6 15666.1 12447.9 12518.6 12654.1 12819.6 12984.8 12559.2 12611.7 12666.2 12741.7 12772.4 10085.4 10351.8 10432.7 10434.6 10478.3 7932.1 8030.8 8041.2 8077.9 8126.7 8430.1 8458.2 8471.9 8506.6 8512.2 16:43:57 INFO - PID 12380 | 16:43:57 INFO - PID 12380 | [#4] prototype.html Cycles:180 Average:5679.44 Median:6266.78 stddev:1605.95 (25.6%) stddev-sans-first:1563.61 16:43:57 INFO - PID 12380 | Values: 549.0 554.9 557.7 575.7 585.1 6188.2 6249.3 6263.6 6279.3 6302.8 6174.7 6178.9 6187.3 6227.4 6252.7 4793.3 4953.2 5067.6 5082.6 5134.9 4978.2 4983.6 5000.3 5000.7 5024.0 4921.7 4946.8 4948.2 4981.9 4999.4 4873.5 4910.2 4951.7 4977.0 5010.0 4532.4 4569.7 4578.9 4579.9 4590.0 6161.4 6181.8 6199.0 6270.0 6277.7 5846.5 5847.3 5883.8 5901.7 5930.9 6677.8 6722.4 6728.4 6759.3 6766.6 5042.6 5067.4 5072.6 5080.2 5082.8 6908.9 6944.7 7002.5 7013.8 7030.8 5155.7 5190.8 5224.8 5238.8 5263.4 5255.6 5287.7 5289.4 5310.9 5339.5 5801.4 5815.9 5842.8 5894.5 5896.4 6467.6 6530.3 6627.9 6663.1 6752.7 1782.6 1801.7 1804.0 1819.0 1820.5 1131.6 1279.6 1285.8 1293.2 1302.1 6164.6 6180.6 6182.1 6272.9 6318.1 6836.6 6861.8 6883.9 6884.4 6886.6 6221.6 6280.5 6281.7 6292.0 6323.9 3557.6 3642.6 3649.6 3656.3 3658.5 7078.2 7144.9 7165.3 7172.2 7189.2 7099.0 7151.5 7163.5 7170.8 7177.8 7109.3 7148.7 7170.2 7196.2 7203.1 6798.4 6841.6 6843.2 6857.9 6872.2 6516.8 6855.7 6872.4 6907.5 6910.1 6997.9 7007.6 7035.7 7041.9 7048.2 5168.9 5170.0 5175.3 5218.2 5222.0 6879.9 6881.9 6901.8 6950.2 6968.9 6573.7 6575.9 6616.3 6706.7 6722.3 6521.7 6561.4 6632.3 6673.4 6699.7 6458.4 6472.3 6537.5 6552.7 6604.6 6100.5 6642.5 6650.6 6695.5 6731.6 6312.5 6398.2 6410.1 6489.6 6551.6 16:43:57 INFO - PID 12380 | 16:43:57 INFO - PID 12380 | [#5] yui.html Cycles:180 Average:27884.83 Median:17403.11 stddev:42032.19 (241.5%) stddev-sans-first:42101.47 16:43:57 INFO - PID 12380 | Values: 956.9 963.0 971.4 973.8 983.8 20947.3 22529.5 22681.8 22729.5 22749.3 22035.9 22259.7 23781.3 23871.0 24031.8 1074.0 1085.3 1085.4 1086.7 1096.9 1070.1 1096.1 1103.1 1103.5 1104.0 1152.6 1155.6 1158.5 1160.3 1160.4 1154.3 1154.9 1155.3 1155.7 1155.8 845.2 845.7 846.4 846.6 846.7 19739.3 20260.2 20352.2 20376.8 21235.7 20025.8 20678.9 21110.0 21114.7 21145.6 16777.7 17135.5 17196.4 17199.4 17206.9 3698.7 3811.0 3818.9 3842.5 3850.3 157420.0 159354.0 159660.2 161075.0 162418.0 17598.2 17748.6 17880.6 18092.6 18177.1 32293.4 32682.7 32992.7 33258.2 33668.0 9262.5 9391.3 9439.1 9441.7 9461.6 4223.0 4244.9 4279.6 4286.3 4324.5 5942.3 6068.3 6076.7 6077.7 6094.3 1042.1 1062.5 1075.3 1091.3 1092.0 669.8 673.1 680.9 683.3 696.4 13040.7 13615.9 13795.7 14357.6 14551.9 717.6 719.5 724.7 726.1 738.1 6395.4 6483.9 6489.8 6504.4 6522.4 141791.3 143940.6 145911.0 148069.3 148814.0 130431.0 132732.3 133497.0 134927.0 136504.3 113494.0 113582.5 113647.0 114535.4 115050.0 12271.1 12286.8 12383.9 12474.7 12512.9 52846.0 53503.2 53526.7 53627.5 54427.7 66724.0 68523.3 70000.6 70315.0 72104.0 16072.7 16511.3 16595.3 16721.8 16728.2 17059.1 17083.9 17156.3 17398.3 17407.9 16995.7 17191.7 17409.8 17463.4 17473.9 15111.5 15363.2 15473.8 15631.1 15742.7 16439.8 16504.7 16579.6 16623.4 16725.1 12628.7 12734.1 12822.7 12902.6 12932.9 11559.5 11659.4 11701.9 11710.9 11873.1 16:43:57 INFO - PID 12380 | -------- Summary: end -------- 16:43:57 INFO - PID 12380 | 16:43:57 INFO - TEST-INFO | 12380: exit 0 16:43:57 INFO - TEST-OK | dromaeo_css | took 1107805ms 16:43:57 INFO - TEST-START | kraken 16:43:57 INFO - Initialising browser for kraken test... 16:43:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43120/getInfo.html -profile /tmp/tmpSpjWHl/profile 16:43:57 INFO - TEST-INFO | started process 12754 (/builds/slave/test/build/application/firefox/firefox http://localhost:43120/getInfo.html) 16:44:03 INFO - TEST-INFO | 12754: exit 0 16:44:03 INFO - Browser initialized. 16:44:03 INFO - Running cycle 1/1 for kraken test... 16:44:03 INFO - Using env: {'DISPLAY': ':0', 16:44:03 INFO - 'HOME': '/home/cltbld', 16:44:03 INFO - 'JSGC_DISABLE_POISONING': '1', 16:44:03 INFO - 'LANG': 'en_US.UTF-8', 16:44:03 INFO - 'LANGUAGE': 'en_US:en', 16:44:03 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:44:03 INFO - 'LOGNAME': 'cltbld', 16:44:03 INFO - 'MAIL': '/var/mail/cltbld', 16:44:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:44:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:44:03 INFO - 'MOZ_CRASHREPORTER': '1', 16:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:03 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:44:03 INFO - 'MOZ_NO_REMOTE': '1', 16:44:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:44:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:03 INFO - 'NO_EM_RESTART': '1', 16:44:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:03 INFO - 'PWD': '/builds/slave/test', 16:44:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:44:03 INFO - 'RUST_BACKTRACE': 'full', 16:44:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:44:03 INFO - 'SHELL': '/bin/bash', 16:44:03 INFO - 'SHLVL': '1', 16:44:03 INFO - 'TERM': 'linux', 16:44:03 INFO - 'TMOUT': '86400', 16:44:03 INFO - 'USER': 'cltbld', 16:44:03 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190', 16:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:03 INFO - '_': '/tools/buildbot/bin/python'} 16:44:03 INFO - TEST-INFO | started process 12997 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSpjWHl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:44:03 INFO - PID 12997 | 16:44:03 INFO - PID 12997 | (/builds/slave/test/build/application/firefox/firefox:13047): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:44:03 INFO - PID 12997 | 16:44:14 INFO - PID 12997 | RSS: Main: 148058112 16:44:14 INFO - PID 12997 | 16:44:16 INFO - PID 12997 | Cycle 1(1): loaded http://localhost:43120/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43120/tests/kraken/driver.html?testName=audio-beat-detection) 16:44:17 INFO - PID 12997 | RSS: Main: 152875008 16:44:17 INFO - PID 12997 | 16:44:20 INFO - PID 12997 | Cycle 1(1): loaded http://localhost:43120/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43120/tests/kraken/driver.html?testName=audio-dft) 16:44:20 INFO - PID 12997 | RSS: Main: 153202688 16:44:20 INFO - PID 12997 | 16:44:23 INFO - PID 12997 | Cycle 1(1): loaded http://localhost:43120/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43120/tests/kraken/driver.html?testName=audio-fft) 16:44:24 INFO - PID 12997 | RSS: Main: 149569536 16:44:24 INFO - PID 12997 | 16:44:26 INFO - PID 12997 | Cycle 1(1): loaded http://localhost:43120/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43120/tests/kraken/driver.html?testName=audio-oscillator) 16:44:27 INFO - PID 12997 | RSS: Main: 150806528 16:44:27 INFO - PID 12997 | 16:44:29 INFO - PID 12997 | Cycle 1(1): loaded http://localhost:43120/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43120/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:44:29 INFO - PID 12997 | RSS: Main: 150568960 16:44:29 INFO - PID 12997 | 16:44:32 INFO - PID 12997 | Cycle 1(1): loaded http://localhost:43120/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43120/tests/kraken/driver.html?testName=imaging-darkroom) 16:44:33 INFO - PID 12997 | RSS: Main: 150753280 16:44:33 INFO - PID 12997 | 16:44:37 INFO - PID 12997 | Cycle 1(1): loaded http://localhost:43120/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43120/tests/kraken/driver.html?testName=imaging-desaturate) 16:44:37 INFO - PID 12997 | RSS: Main: 152166400 16:44:37 INFO - PID 12997 | 16:44:40 INFO - PID 12997 | Cycle 1(1): loaded http://localhost:43120/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43120/tests/kraken/driver.html?testName=json-parse-financial) 16:44:41 INFO - PID 12997 | RSS: Main: 153636864 16:44:41 INFO - PID 12997 | 16:44:42 INFO - PID 12997 | Cycle 1(1): loaded http://localhost:43120/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43120/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:44:43 INFO - PID 12997 | RSS: Main: 153878528 16:44:43 INFO - PID 12997 | 16:44:44 INFO - PID 12997 | Cycle 1(1): loaded http://localhost:43120/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43120/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:44:45 INFO - PID 12997 | RSS: Main: 153706496 16:44:45 INFO - PID 12997 | 16:44:47 INFO - PID 12997 | Cycle 1(1): loaded http://localhost:43120/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43120/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:44:48 INFO - PID 12997 | RSS: Main: 150757376 16:44:48 INFO - PID 12997 | 16:44:50 INFO - PID 12997 | Cycle 1(1): loaded http://localhost:43120/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43120/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:44:51 INFO - PID 12997 | RSS: Main: 150732800 16:44:51 INFO - PID 12997 | 16:44:53 INFO - PID 12997 | Cycle 1(1): loaded http://localhost:43120/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43120/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:44:54 INFO - PID 12997 | RSS: Main: 151232512 16:44:54 INFO - PID 12997 | 16:44:56 INFO - PID 12997 | Cycle 1(1): loaded http://localhost:43120/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43120/tests/kraken/driver.html?testName=ai-astar) 16:44:56 INFO - PID 12997 | RSS: Main: 152580096 16:44:56 INFO - PID 12997 | 16:44:56 INFO - PID 12997 | __start_tp_report 16:44:56 INFO - PID 12997 | _x_x_mozilla_page_load 16:44:56 INFO - PID 12997 | _x_x_mozilla_page_load_details 16:44:56 INFO - PID 12997 | |i|pagename|runs| 16:44:56 INFO - PID 12997 | |0;ai-astar;106;105;108;106;105;115;107;106;106;106 16:44:56 INFO - PID 12997 | |1;audio-beat-detection;112;112;113;117;114;139;113;113;116;111 16:44:56 INFO - PID 12997 | |2;audio-dft;162;163;164;163;161;162;161;164;166;166 16:44:56 INFO - PID 12997 | |3;audio-fft;73;73;74;72;73;74;74;73;74;75 16:44:56 INFO - PID 12997 | |4;audio-oscillator;83;78;78;78;79;83;78;77;78;77 16:44:56 INFO - PID 12997 | |5;imaging-gaussian-blur;113;114;110;114;113;115;114;113;114;114 16:44:56 INFO - PID 12997 | |6;imaging-darkroom;149;150;150;150;150;150;152;149;151;152 16:44:56 INFO - PID 12997 | |7;imaging-desaturate;94;94;94;95;94;94;95;94;95;95 16:44:56 INFO - PID 12997 | |8;json-parse-financial;48;51;45;46;45;44;45;46;45;47 16:44:56 INFO - PID 12997 | |9;json-stringify-tinderbox;38;38;39;38;39;38;39;38;38;38 16:44:56 INFO - PID 12997 | |10;stanford-crypto-aes;74;74;72;69;69;71;72;70;71;72 16:44:56 INFO - PID 12997 | |11;stanford-crypto-ccm;106;110;106;114;108;104;108;111;107;105 16:44:56 INFO - PID 12997 | |12;stanford-crypto-pbkdf2;162;158;153;150;149;152;157;161;152;158 16:44:56 INFO - PID 12997 | |13;stanford-crypto-sha256-iterative;65;60;60;61;61;62;67;59;59;60 16:44:56 INFO - PID 12997 | __end_tp_report 16:44:56 INFO - PID 12997 | __start_cc_report 16:44:56 INFO - PID 12997 | _x_x_mozilla_cycle_collect,708 16:44:56 INFO - PID 12997 | __end_cc_report 16:44:56 INFO - PID 12997 | __startTimestamp1505778296395__endTimestamp 16:44:56 INFO - PID 12997 | 16:44:56 INFO - PID 12997 | ------- Summary: start ------- 16:44:56 INFO - PID 12997 | Number of tests: 14 16:44:56 INFO - PID 12997 | 16:44:56 INFO - PID 12997 | [#0] ai-astar Cycles:10 Average:107.00 Median:106.00 stddev:2.94 (2.8%) stddev-sans-first:3.10 16:44:56 INFO - PID 12997 | Values: 106.0 105.0 108.0 106.0 105.0 115.0 107.0 106.0 106.0 106.0 16:44:56 INFO - PID 12997 | 16:44:56 INFO - PID 12997 | [#1] audio-beat-detection Cycles:10 Average:116.00 Median:113.50 stddev:8.29 (7.3%) stddev-sans-first:8.66 16:44:56 INFO - PID 12997 | Values: 112.0 112.0 113.0 117.0 114.0 139.0 113.0 113.0 116.0 111.0 16:44:56 INFO - PID 12997 | 16:44:56 INFO - PID 12997 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:1.81 (1.1%) stddev-sans-first:1.87 16:44:56 INFO - PID 12997 | Values: 162.0 163.0 164.0 163.0 161.0 162.0 161.0 164.0 166.0 166.0 16:44:56 INFO - PID 12997 | 16:44:56 INFO - PID 12997 | [#3] audio-fft Cycles:10 Average:73.50 Median:74.00 stddev:0.85 (1.1%) stddev-sans-first:0.88 16:44:56 INFO - PID 12997 | Values: 73.0 73.0 74.0 72.0 73.0 74.0 74.0 73.0 74.0 75.0 16:44:56 INFO - PID 12997 | 16:44:56 INFO - PID 12997 | [#4] audio-oscillator Cycles:10 Average:78.90 Median:78.00 stddev:2.23 (2.9%) stddev-sans-first:1.81 16:44:56 INFO - PID 12997 | Values: 83.0 78.0 78.0 78.0 79.0 83.0 78.0 77.0 78.0 77.0 16:44:56 INFO - PID 12997 | 16:44:56 INFO - PID 12997 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:114.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 16:44:56 INFO - PID 12997 | Values: 113.0 114.0 110.0 114.0 113.0 115.0 114.0 113.0 114.0 114.0 16:44:56 INFO - PID 12997 | 16:44:56 INFO - PID 12997 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.00 stddev:1.06 (0.7%) stddev-sans-first:1.01 16:44:56 INFO - PID 12997 | Values: 149.0 150.0 150.0 150.0 150.0 150.0 152.0 149.0 151.0 152.0 16:44:56 INFO - PID 12997 | 16:44:56 INFO - PID 12997 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:44:56 INFO - PID 12997 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 95.0 94.0 95.0 95.0 16:44:56 INFO - PID 12997 | 16:44:56 INFO - PID 12997 | [#8] json-parse-financial Cycles:10 Average:46.20 Median:46.00 stddev:2.04 (4.4%) stddev-sans-first:2.06 16:44:56 INFO - PID 12997 | Values: 48.0 51.0 45.0 46.0 45.0 44.0 45.0 46.0 45.0 47.0 16:44:56 INFO - PID 12997 | 16:44:56 INFO - PID 12997 | [#9] json-stringify-tinderbox Cycles:10 Average:38.30 Median:38.00 stddev:0.48 (1.3%) stddev-sans-first:0.50 16:44:56 INFO - PID 12997 | Values: 38.0 38.0 39.0 38.0 39.0 38.0 39.0 38.0 38.0 38.0 16:44:56 INFO - PID 12997 | 16:44:56 INFO - PID 12997 | [#10] stanford-crypto-aes Cycles:10 Average:71.40 Median:72.00 stddev:1.78 (2.5%) stddev-sans-first:1.62 16:44:56 INFO - PID 12997 | Values: 74.0 74.0 72.0 69.0 69.0 71.0 72.0 70.0 71.0 72.0 16:44:56 INFO - PID 12997 | 16:44:56 INFO - PID 12997 | [#11] stanford-crypto-ccm Cycles:10 Average:107.90 Median:108.00 stddev:3.03 (2.8%) stddev-sans-first:3.14 16:44:56 INFO - PID 12997 | Values: 106.0 110.0 106.0 114.0 108.0 104.0 108.0 111.0 107.0 105.0 16:44:56 INFO - PID 12997 | 16:44:56 INFO - PID 12997 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:157.50 stddev:4.59 (2.9%) stddev-sans-first:4.16 16:44:56 INFO - PID 12997 | Values: 162.0 158.0 153.0 150.0 149.0 152.0 157.0 161.0 152.0 158.0 16:44:56 INFO - PID 12997 | 16:44:56 INFO - PID 12997 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.40 Median:61.00 stddev:2.63 (4.3%) stddev-sans-first:2.45 16:44:56 INFO - PID 12997 | Values: 65.0 60.0 60.0 61.0 61.0 62.0 67.0 59.0 59.0 60.0 16:44:56 INFO - PID 12997 | -------- Summary: end -------- 16:44:56 INFO - PID 12997 | 16:44:56 INFO - PID 12997 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:44:56 INFO - TEST-INFO | 12997: exit 0 16:44:57 INFO - TEST-OK | kraken | took 59311ms 16:44:57 INFO - SUITE-END | took 1167s 16:44:57 INFO - Completed test suite (00:19:27) 16:44:57 INFO - javascript benchmark 16:44:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8980.678151829654, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3894.045958740109, 3898.43472696459, 3905.140869008817, 3915.6671682906967, 3930.5676375598696, 6161.507079433646, 6264.498840092793, 6301.684915754211, 6327.272363678178, 6393.584417012891, 6293.874122517547, 6304.180456540644, 6308.211473565804, 6341.048842673601, 6359.427651511363, 5628.493435590785, 5674.801381951633, 5686.573506986972, 5705.885882282352, 5749.396313387097, 5631.155326701007, 5694.715264236792, 5696.686682232496, 5722.971385143069, 5742.253507044078, 212.06259199689174, 5547.639403438763, 5592.552595792326, 5656.91514627281, 5747.827565173052, 5620.072688006474, 5620.522255608278, 5689.857753556153, 5699.00267453194, 5701.458361455655, 5588.972055139739, 5591.329040515124, 5669.0, 5672.971635141839, 5689.7439615217, 6239.126522286883, 6249.78125765596, 6251.156093927307, 6301.369863013708, 6323.399277068671, 6599.505037122235, 6713.93286067138, 6766.28953959837, 6796.898046529306, 6860.5197636165485, 6821.0, 6826.146731658543, 6829.897551536731, 6840.384365407088, 6852.6916288767125, 6322.683865806691, 6333.68331583419, 6384.106225128486, 6411.1024456576115, 6424.839379015562, 7104.467164962649, 7121.074260346122, 7125.144982602017, 7129.643517824088, 7131.286871312827, 6727.831804204836, 6733.42765864907, 6752.493562982796, 6830.931690683129, 6851.862962740717, 6748.662566871637, 6859.108315918898, 6868.107146070979, 6949.652517374212, 6972.51192416526, 6747.426468750211, 6757.594544327356, 6769.898451523231, 6783.728650854009, 6795.150606174228, 6797.116374871334, 6821.283765204582, 6829.931700683029, 6863.450923926074, 6868.862622747517, 4861.124997500484, 4905.435874874363, 4909.263610458388, 4939.3084968104495, 4982.9252561211615, 4499.977500112544, 4525.479569849444, 4552.203364411214, 4555.06621142665, 4560.384348113029, 6272.498200143978, 6279.309275979638, 6338.080978258126, 6350.618962862243, 6355.0785136155, 6690.799276021629, 6761.695723692445, 6791.932080679228, 6818.693158807866, 6891.552049116792, 6296.0, 6314.905276420857, 6319.0, 6321.589096708699, 6323.988161894074, 5519.116941289374, 5560.916586251209, 5561.499465048084, 5567.749451274622, 5571.637843540157, 6999.895001574981, 7073.893891591631, 7094.006839042539, 7171.856562868714, 7183.353498185188, 6708.960111182774, 6793.048973143863, 6797.762078327235, 6887.621180835102, 6905.930940690529, 7008.264132266243, 7017.05269788572, 7082.893756593759, 7121.14546254432, 7123.893141602776, 6725.5628384156835, 6746.730130794909, 6794.8641027180165, 6817.454603631797, 6825.8634827302185, 6795.89806152918, 6810.8637827244165, 6826.761063362758, 6899.17209934811, 6920.688569014507, 6454.935450645621, 6553.082568440327, 6554.573952693059, 6554.885669436112, 6632.933670663231, 6518.2178138621775, 6522.967385163044, 6533.575317604341, 6535.117759102651, 6550.082988381535, 6458.580192287486, 6462.773802916875, 6474.902876456763, 6509.511786615928, 6578.8355291118105, 6522.119513865568, 6697.330266973264, 6711.9328806713265, 6715.26132125456, 6732.831679208059, 6458.031295305742, 6471.835069687501, 6480.092787009728, 6566.179227596551, 6570.704318305783], "value": 6191.031608429295, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [927.9396839205451, 935.6538080910065, 945.9148676619105, 975.1370037516798, 979.0209790209794, 45949.0, 46709.532904670945, 46752.2987155193, 46814.76592617037, 46832.53167468324, 43110.0, 43523.347149792775, 43573.7821310893, 43641.34537981933, 43833.0, 7471.7011319547155, 7577.393808495334, 7606.885896711554, 7611.2769286917655, 7616.466847320689, 7463.962680186592, 7540.0, 7547.13207981081, 7550.3959683225485, 7552.395808335347, 7536.623168841536, 8085.676572937075, 8265.297449716782, 8269.710560130397, 8276.420650554464, 8173.427860049799, 8178.83642327156, 8216.83566328676, 8253.298469630088, 8253.83492330153, 7928.80177995549, 8197.918020819834, 8202.917970820336, 8203.794905127359, 8213.137620549876, 41738.58261417377, 42264.15471690549, 42324.0, 42362.15275694469, 42457.150856983, 3757.1922036762226, 3797.3924172132324, 3799.2211596622624, 3804.6766024887643, 3814.313423583754, 34160.65839341599, 34283.314333713184, 34289.14277143066, 34345.0, 34388.82805585981, 5479.75341109651, 5506.339239291271, 5508.228847961289, 5536.114221724505, 5601.775928962837, 212441.0, 213342.93328533412, 214460.0, 214778.0, 215106.0, 52398.73800630972, 52408.47591524112, 52423.47576524262, 52464.16375426842, 52511.47488525066, 55692.16461753077, 64548.0, 65886.34113658802, 65896.0, 66249.33750662432, 17068.0, 17132.657346852993, 17263.309467621406, 17272.65454690899, 17280.827191728175, 13567.86432135666, 13827.723445531034, 14100.929495352457, 14101.083429577046, 14154.787678184835, 15836.683266334609, 15851.603709907344, 15852.286647100907, 15898.841011589737, 15975.760363594323, 6125.326214116443, 6141.969290153521, 6269.843253918689, 6288.27684816252, 6352.4918006559365, 1063.431438628033, 1067.2475904487474, 1081.2809481694585, 1081.2863510083307, 1091.9071878890225, 23627.0, 23655.408614784425, 23846.52306953886, 23870.522589548113, 24039.0, 1170.8185231289165, 1176.8411264479357, 1177.1348059176498, 1180.5690922813283, 1187.4181650990952, 12993.805092923614, 13235.536756213487, 13247.403866826016, 13295.3352332383, 13308.866911330762, 266186.0, 267671.0, 269539.0, 269679.0, 269959.0, 61271.38728612746, 61610.0, 61642.691786541676, 63866.36133638697, 65209.673951629935, 1498.6702925356403, 1523.9122402308908, 1530.2425299476831, 1538.7845701601784, 1544.5675210940954, 27767.583486248128, 27862.58206126869, 28181.859090705235, 28662.0, 29006.56490152607, 42527.574724252365, 42901.78549107235, 43056.0, 43078.0, 43121.3531797017, 247521.0, 249876.0, 250553.0, 250836.0, 250881.0, 37002.62997369992, 37979.0, 38226.55960963527, 38285.808570956964, 38286.42570361502, 48070.75964620154, 48089.0, 48521.5147848517, 48562.5143748558, 48786.26820597765, 33980.50029643101, 34398.82800585981, 35127.29745405026, 35522.644773552965, 35613.0, 34804.303913922085, 34879.47680784739, 35061.649383505835, 35432.46851297181, 35611.28777424489, 36553.81723091367, 36601.26797464089, 36621.0, 36680.266394671424, 36737.632623673424, 34262.31475370529, 34523.48214776831, 34626.82686586652, 34828.477572836935, 35064.246787661024, 23002.53994920126, 23694.05223791029, 23721.52556948886, 24009.879950600134, 24131.63802542928], "value": 18736.094262148992, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.5549782165558, 587.5182350472611, 592.881423715257, 604.4227762486825, 608.8660494691168, 23142.537149257005, 23755.881220593896, 23812.76187238127, 23839.880800595973, 23846.28461146164, 23897.880510597424, 24861.75138248617, 25174.0, 25288.114915977945, 25313.74686253137, 6473.935260647392, 6497.155369801919, 6498.870022599545, 6499.642519661416, 6517.478601711863, 6403.423691867731, 6407.519436042316, 6499.870002599945, 6661.233958094833, 6707.664616769166, 6671.432928201109, 6672.76645317414, 6674.0, 6676.833079173011, 6678.899816502732, 6604.141461609984, 6645.6344901030425, 6656.93343066568, 6661.63361015144, 6665.566738162052, 6199.380061993809, 6213.844653883644, 6215.502759779252, 6239.968800156015, 6247.156633854463, 28631.14106576806, 28689.713102868915, 29241.122766317043, 29709.851450742823, 29869.55195672067, 2265.2524666859895, 2293.9885300573555, 2294.0823670531922, 2296.024189719379, 2297.184499502686, 20057.598848022957, 20463.18147274107, 20501.692474612893, 20577.279795207247, 20578.27976020832, 2497.77520023197, 2531.0761572026263, 2556.412025234188, 2576.0854896511655, 2588.4564241509306, 141535.0, 148406.25796871053, 156932.0, 163517.0, 164156.0, 15007.421252267535, 15816.36734530629, 15916.16964049126, 16175.919120404322, 16509.58726031835, 25246.495070098495, 25520.23439296824, 25546.23361299127, 25565.3608659785, 25581.488370232863, 10391.584336626602, 10464.162866970624, 10469.633562825416, 10500.947495262628, 10679.626213082505, 9352.812943741086, 9440.24478041755, 9540.95229523848, 9629.0, 9663.806723865484, 9323.300752443594, 9493.66772162971, 9530.52347382628, 9628.32601717887, 9976.251781116445, 2783.5546312590295, 2811.668173214747, 2841.659000919903, 2868.1969048665987, 2973.68776278492, 991.3506653142204, 1010.2221289606962, 1011.9848202276971, 1019.3272440189587, 1021.0, 18711.438656840317, 18981.43055708331, 19010.61978760417, 19085.80914190868, 19094.14076366567, 1059.8622179116664, 1066.632011955874, 1076.56399158341, 1076.8761592416815, 1078.0085263394144, 9644.75888102789, 10484.580616775243, 10850.457477126112, 10874.510647020903, 10911.508982095826, 605605.0, 622757.0, 623912.0, 624593.0, 634262.0, 121219.0, 123581.0, 127862.0, 129322.0, 131945.0, 1087.3095584304024, 1135.5401062569508, 1172.4196522721309, 1216.7688139253692, 1217.8903898648987, 20668.276610318568, 20684.896575517025, 20790.272340468615, 20817.58364832725, 20956.161753530298, 62845.68577157085, 62867.37132628615, 64008.67995659992, 64142.35857641551, 65294.67352663206, 77459.61270193613, 78293.60853195697, 78829.0, 78885.0, 80205.5989720071, 14820.851791481948, 14861.182634955181, 15073.170975596448, 15168.31742571609, 15235.3905843765, 23014.539709206056, 23314.184003559792, 23402.0, 23445.648315274942, 23504.882475588198, 18361.816381836546, 18399.908000459913, 18457.90771046136, 18629.627407452048, 18761.061946902326, 16365.754513682066, 17159.0, 17178.828211717722, 17280.13599320054, 17400.303987840343, 18404.907975460035, 18442.907785460986, 18471.630567388307, 18625.348112815987, 18800.811991880455, 14183.21992290434, 14891.925540372662, 14925.477608283658, 15024.09855408679, 15081.245937702852, 17895.910520447316, 17973.0, 18068.096595169925, 18109.909450452662, 18318.63362732711], "value": 12472.92970296063, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1404.3189053309143, 1445.7903603977425, 1449.3550370085316, 1460.3939365163458, 1465.3918623771133, 16669.0, 17488.38790642328, 17492.125393730326, 17508.999999999985, 17509.912450437747, 17227.310907563682, 17364.39224627138, 17382.739258911126, 17393.913030434862, 17415.91292043538, 2607.282997175778, 2750.35366688829, 2752.779777617796, 2756.0, 2759.1308737747645, 2700.2844246274653, 2767.6402067731165, 2787.4703806276843, 2797.930051748702, 2800.229936767385, 2679.6382488364115, 2769.9030533931214, 2772.8613569321556, 2773.0, 2774.4035032468014, 2787.484315401647, 2788.1774876411305, 2807.7753779697573, 2810.142906413543, 2812.114184032044, 2575.060103062369, 2762.088510791434, 2767.1975127213086, 2770.224337185591, 2777.819441736301, 16623.91688041564, 16793.748093778602, 16999.915000425044, 17020.744688829553, 17026.148692565446, 8054.677812887478, 8254.257116859511, 8262.091169971298, 8326.50040997542, 8330.958345208295, 5366.221897824833, 5413.891722165574, 5532.30846144232, 5576.414476479952, 5604.971975140139, 2087.311187308185, 2088.634488964425, 2113.6829475578634, 2133.9786602133936, 2162.91348346066, 30576.789437109004, 30700.38599228025, 30846.0, 30857.691423085707, 30920.0, 6520.608763474207, 6591.868162636816, 6749.5612785168805, 6763.932360676428, 6766.729330826712, 19681.0, 19778.0, 19837.40487785369, 19866.801331986786, 19872.10575524105, 7854.960725196452, 7964.840703185904, 8021.117677055519, 8024.839503209903, 8031.1567285434185, 7251.274872512707, 7340.192578816326, 7391.6673749681395, 7424.628768561551, 7504.62476876165, 5463.180522921593, 5504.669719816824, 5516.696581688046, 5540.2243685884005, 5807.738651760681, 1503.225838693074, 1504.1576717038274, 1510.909345439277, 1517.6433538118533, 1536.5620798072719, 880.6873559886276, 887.7381172553983, 903.7785742493131, 909.9308312732513, 917.2891009467716, 7664.0, 7721.7683469496005, 7765.223477652303, 7771.145174030852, 7807.531548107132, 765.7166848266177, 772.0966469231013, 776.0687175389443, 781.8514482248355, 787.7479206653816, 5626.493615574618, 5652.293463317085, 5745.712714364348, 6041.912455758005, 6060.696965151725, 23492.060317587104, 25229.87385063063, 25326.746732532807, 25519.362015949377, 25709.10018149356, 24312.0, 24388.87805560961, 25161.874190629296, 25213.24360269195, 25277.494450111262, 12274.754504909852, 12321.753564928651, 12333.69165770845, 12530.122891397516, 12533.498660053496, 8979.775505612412, 8980.910190898006, 9003.504807235666, 9066.50134242623, 9201.953990230006, 20876.1649534023, 21269.78730212678, 21405.036773344924, 21624.89187554115, 21943.451413714785, 21852.344429667137, 21929.561408772053, 22036.88981555082, 22080.2271920482, 22368.440788980406, 12341.876581234073, 12396.566120185751, 12410.069244806857, 12542.937285313516, 12601.306928119042, 15393.461228856937, 15622.609434764221, 15664.295106720452, 15664.608384790472, 15666.060036397852, 12447.875521244672, 12518.561850335194, 12654.114212005072, 12819.615411537668, 12984.805227921777, 12559.246445213317, 12611.747765044463, 12666.240025598494, 12741.745165096832, 12772.361381930681, 10085.445300508543, 10351.792964140826, 10432.739181520523, 10434.634787782392, 10478.266521343432, 7932.144193588624, 8030.83938321242, 8041.236082572146, 8077.919220807717, 8126.674933002614, 8430.114837941928, 8458.238758511763, 8471.872921906053, 8506.574671266535, 8512.191341822518], "value": 7133.166379405451, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.9890202195957, 554.8557375082478, 557.6793343827301, 575.680497323985, 585.1281590430259, 6188.226471691039, 6249.3438188990185, 6263.590692094276, 6279.277883043452, 6302.842428939279, 6174.722137503812, 6178.8829059231375, 6187.29849291445, 6227.377262273771, 6252.6561039142825, 4793.304970779235, 4953.23224900141, 5067.645264831473, 5082.567981721558, 5134.922976155361, 4978.153713868651, 4983.626228032894, 5000.32495613093, 5000.724815172144, 5024.045431368028, 4921.729304888229, 4946.802127914897, 4948.233023881304, 4981.875453113683, 4999.4250661174065, 4873.48828373021, 4910.238912968495, 4951.678140920829, 4976.950230497685, 5010.048090862761, 4532.365468834366, 4569.651952673969, 4578.862634120982, 4579.862604121881, 4589.977050114728, 6161.428835646926, 6181.783637572664, 6198.969005154991, 6269.96865015672, 6277.748890044393, 5846.532277417797, 5847.333509949686, 5883.764649414018, 5901.734421951022, 5930.940690593082, 6677.76627818024, 6722.4285935695525, 6728.360805723449, 6759.256481787, 6766.56017358875, 5042.621803364726, 5067.366579177603, 5072.6195535335, 5080.212567052113, 5082.771275292621, 6908.9309106909295, 6944.72221111155, 7002.544834585787, 7013.82465438363, 7030.824229394255, 5155.716435596003, 5190.844274671766, 5224.791008359699, 5238.790448382022, 5263.421023687391, 5255.605829562798, 5287.656302340336, 5289.3652761668845, 5310.92033619496, 5339.46605339463, 5801.390853960358, 5815.912761308584, 5842.824715258549, 5894.528437724972, 5896.351401345849, 6467.644279564669, 6530.314316996742, 6627.933720662828, 6663.13379260693, 6752.696128674222, 1782.5632719983428, 1801.7297405389297, 1803.9537068500501, 1818.97271540927, 1820.544863784054, 1131.6122980511116, 1279.6417003239108, 1285.807128930668, 1293.1659079893416, 1302.101549930545, 6164.630122192682, 6180.6291622502795, 6182.1345011698395, 6272.905906411407, 6318.052292156121, 6836.589804611739, 6861.828454288583, 6883.8967415488805, 6884.449244060464, 6886.55672163918, 6221.564490485713, 6280.497560195174, 6281.685915704196, 6292.042739912234, 6323.873522529524, 3557.6086630470627, 3642.581103173116, 3649.635036496329, 3656.305301992613, 3658.506101676293, 7078.186008608973, 7144.928550714426, 7165.319294666998, 7172.21105678375, 7189.173245076779, 7099.006139140524, 7151.499395042297, 7163.498555101197, 7170.784876453715, 7177.78466645991, 7109.253528379446, 7148.714051437884, 7170.2471240520035, 7196.244394338623, 7203.063601731847, 6798.422134118655, 6841.589504629738, 6843.247242803387, 6857.897131543131, 6872.244053154049, 6516.771912983023, 6855.715178013741, 6872.3884923728665, 6907.481938854506, 6910.06714093611, 6997.860042799217, 7007.6145811978795, 7035.683394247373, 7041.866369465743, 7048.202708309348, 5168.870778230575, 5170.0, 5175.327207463156, 5218.243354713622, 5222.033923724123, 6879.862402751817, 6881.931180688129, 6901.827454313682, 6950.165980082423, 6968.895466568107, 6573.671316434064, 6575.947848344242, 6616.338366163345, 6706.731730730716, 6722.327767223239, 6521.7065232065615, 6561.442277406474, 6632.303608121078, 6673.432758215412, 6699.660067986325, 6458.418742313214, 6472.320406357265, 6537.5096867734155, 6552.705128269144, 6604.636744979072, 6100.542459315658, 6642.535022548375, 6650.600963942179, 6695.531312808057, 6731.596104233761, 6312.495000400048, 6398.200224971879, 6410.134631824831, 6489.578177418642, 6551.574147680385], "value": 5214.878854188003, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [956.8612551180079, 962.9518524073794, 971.3928794503436, 973.816812572724, 983.81941669996, 20947.266845660404, 22529.549409011808, 22681.77318226817, 22729.545409091807, 22749.31752047437, 22035.889820550914, 22259.666105008397, 23781.286561403143, 23871.0, 24031.75968240317, 1073.9731506712335, 1085.3270971997372, 1085.375908852409, 1086.7065892209098, 1096.9122470202406, 1070.0743856564093, 1096.1121491591837, 1103.0954617213888, 1103.5034234594425, 1104.0174244921986, 1152.6196355202806, 1155.57821395191, 1158.4613154882977, 1160.2748282323548, 1160.3618010094456, 1154.2958795134962, 1154.867190273121, 1155.260633194756, 1155.6533040087982, 1155.843961065258, 845.1506236232547, 845.6701886264361, 846.3525403066659, 846.6232526525698, 846.6697987784769, 19739.309124180585, 20260.189592416285, 20352.18591256348, 20376.79623203764, 21235.68146477804, 20025.79974200254, 20678.896605517028, 21110.0, 21114.683279750818, 21145.5770884583, 16777.74833377488, 17135.48593542196, 17196.398126065527, 17199.398021069203, 17206.913965430216, 3698.7041036716996, 3810.9809450952566, 3818.9392278407913, 3842.51968503937, 3850.3261929162286, 157419.99999999886, 159354.0, 159660.20169899194, 161075.0, 162418.0, 17598.208080636403, 17748.645027099643, 17880.55298617519, 18092.638147236983, 18177.09114544294, 32293.35413291721, 32682.67317326844, 32992.67007329944, 33258.168545786066, 33668.0, 9262.490563018964, 9391.34260601765, 9439.056094390506, 9441.669541566012, 9461.621535138655, 4222.9577704223175, 4244.8514301999285, 4279.636230920407, 4286.314189729628, 4324.481062272547, 5942.286925568959, 6068.271807383142, 6076.696165191723, 6077.696115194222, 6094.268687757498, 1042.145440738587, 1062.5324857062867, 1075.2580719303655, 1091.328832767842, 1092.0499165725869, 669.8124525132971, 673.1047706550277, 680.880845851974, 683.2518392360357, 696.4358869315769, 13040.673983150307, 13615.931920340336, 13795.724085518234, 14357.64105897361, 14551.85448145505, 717.6447658409121, 719.4711886763225, 724.7427163356932, 726.12501935168, 738.0958326050652, 6395.360463953567, 6483.935160648428, 6489.805305840832, 6504.414602685781, 6522.445592124723, 141791.29104354413, 143940.5605943948, 145911.0, 148069.25965370104, 148814.0, 130431.0, 132732.3363383177, 133497.0, 134927.0, 136504.31747841396, 113494.0, 113582.456701731, 113647.0, 114535.42732286286, 115050.0, 12271.141020128505, 12286.815697764361, 12383.938080309541, 12474.688132796753, 12512.874871251171, 52846.0, 53503.19745203747, 53526.73236633792, 53627.46372536381, 54427.72786136044, 66724.0, 68523.31476685169, 70000.6499967497, 70315.0, 72104.0, 16072.678546428771, 16511.33954641801, 16595.336186552886, 16721.832781672027, 16728.247228874487, 17059.147042648066, 17083.91458042702, 17156.313747450462, 17398.304067837144, 17407.91296043512, 16995.7450638243, 17191.65616687684, 17409.82590174082, 17463.38878139259, 17473.912630436767, 15111.54665360041, 15363.23183840826, 15473.84526154724, 15631.140287283853, 15742.685146297239, 16439.83560164383, 16504.66990660156, 16579.585510361856, 16623.418180363627, 16725.080120592997, 12628.684282893002, 12734.108612397044, 12822.743545128858, 12902.612921611992, 12932.93533532364, 11559.479823407799, 11659.358735269641, 11701.941490292495, 11710.94144529272, 11873.109516786448], "value": 9747.448542004317, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1377.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 108.0, 106.0, 105.0, 115.0, 107.0, 106.0, 106.0, 106.0], "value": 107.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 113.0, 117.0, 114.0, 139.0, 113.0, 113.0, 116.0, 111.0], "value": 116.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 163.0, 161.0, 162.0, 161.0, 164.0, 166.0, 166.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 72.0, 73.0, 74.0, 74.0, 73.0, 74.0, 75.0], "value": 73.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 78.0, 78.0, 78.0, 79.0, 83.0, 78.0, 77.0, 78.0, 77.0], "value": 78.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 110.0, 114.0, 113.0, 115.0, 114.0, 113.0, 114.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 150.0, 150.0, 150.0, 150.0, 152.0, 149.0, 151.0, 152.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 51.0, 45.0, 46.0, 45.0, 44.0, 45.0, 46.0, 45.0, 47.0], "value": 46.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 39.0, 38.0, 39.0, 38.0, 39.0, 38.0, 38.0, 38.0], "value": 38.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 72.0, 69.0, 69.0, 71.0, 72.0, 70.0, 71.0, 72.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 110.0, 106.0, 114.0, 108.0, 104.0, 108.0, 111.0, 107.0, 105.0], "value": 107.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 158.0, 153.0, 150.0, 149.0, 152.0, 157.0, 161.0, 152.0, 158.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 60.0, 60.0, 61.0, 61.0, 62.0, 67.0, 59.0, 59.0, 60.0], "value": 61.4, "unit": "score"}]}]} 16:44:57 INFO - Return code: 0 16:44:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:44:57 INFO - # TBPL SUCCESS # 16:44:57 INFO - Running post-action listener: _package_coverage_data 16:44:57 INFO - Running post-action listener: _resource_record_post_action 16:44:57 INFO - [mozharness: 2017-09-18 23:44:57.706716Z] Finished run-tests step (success) 16:44:57 INFO - Running post-run listener: _resource_record_post_run 16:44:57 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 330096640; Read time: 200; Write time: 265032 16:44:57 INFO - TinderboxPrint: CPU usage
13.1% 16:44:57 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 200 16:44:57 INFO - TinderboxPrint: I/O write bytes / time
330,096,640 / 265,032 16:44:57 INFO - TinderboxPrint: CPU idle
8,213.4 (86.9%) 16:44:57 INFO - TinderboxPrint: CPU user
1,185.6 (12.5%) 16:44:57 INFO - TinderboxPrint: Swap in / out
0 / 0 16:44:57 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12582912; Read time: 0; Write time: 948 16:44:57 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:44:57 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 4096; Write bytes: 316489728; Read time: 200; Write time: 264072 16:44:58 INFO - Running post-run listener: _upload_blobber_files 16:44:58 INFO - Blob upload gear active. 16:44:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:44:58 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 16:44:58 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'] 16:44:58 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 16:44:58 INFO - (blobuploader) - INFO - Open directory for files ... 16:44:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:44:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:44:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:44:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:44:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:44:59 INFO - (blobuploader) - INFO - Done attempting. 16:44:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:44:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:44:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:45:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:45:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:45:06 INFO - (blobuploader) - INFO - Done attempting. 16:45:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:45:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:45:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:45:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:45:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:45:07 INFO - (blobuploader) - INFO - Done attempting. 16:45:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:45:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:45:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:45:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:45:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:45:08 INFO - (blobuploader) - INFO - Done attempting. 16:45:08 INFO - (blobuploader) - INFO - Iteration through files over. 16:45:08 INFO - Return code: 0 16:45:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:45:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:45:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf9e399e71f743489b443bb6928495d60bbfb3d8c9f3f6a8a3dbf095ec5df353e2b0d58a90705ea20b2d24b637316f12cc6218567de93b336e17683ae0e27f62", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a321b49a0caf7c7ea858b56ff4fb4ed5cd35099c913a9bcfe37dfecd43f60d279d1adee2ee49a3e31a6945e052588f1061865642d7dc703fd327de4c446bc7fd", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f15ecfac9b50ccb655a00187e5df2de8571187dc569251a5bdbdfcf7678e23ba2dada04df8fe6829e4f5bea51bd35ce2bdddb1296fa07f4429225d953b94133d", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5afc592307446024ecaed5105bd11f0599a2b1f0f055908d82347a48321046b788fd6be1cccc3c9dadc1ee1cc596aad3b630d0c52c559112b7f761ad76cb715c"} 16:45:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:45:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:45:08 INFO - Contents: 16:45:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf9e399e71f743489b443bb6928495d60bbfb3d8c9f3f6a8a3dbf095ec5df353e2b0d58a90705ea20b2d24b637316f12cc6218567de93b336e17683ae0e27f62", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a321b49a0caf7c7ea858b56ff4fb4ed5cd35099c913a9bcfe37dfecd43f60d279d1adee2ee49a3e31a6945e052588f1061865642d7dc703fd327de4c446bc7fd", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f15ecfac9b50ccb655a00187e5df2de8571187dc569251a5bdbdfcf7678e23ba2dada04df8fe6829e4f5bea51bd35ce2bdddb1296fa07f4429225d953b94133d", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5afc592307446024ecaed5105bd11f0599a2b1f0f055908d82347a48321046b788fd6be1cccc3c9dadc1ee1cc596aad3b630d0c52c559112b7f761ad76cb715c"} 16:45:08 INFO - Running post-run listener: copy_logs_to_upload_dir 16:45:08 INFO - Copying logs to upload dir... 16:45:08 INFO - mkdir: /builds/slave/test/build/upload/logs 16:45:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.481918 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-18 16:45:09.006908) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 16:45:09.011953) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf9e399e71f743489b443bb6928495d60bbfb3d8c9f3f6a8a3dbf095ec5df353e2b0d58a90705ea20b2d24b637316f12cc6218567de93b336e17683ae0e27f62", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a321b49a0caf7c7ea858b56ff4fb4ed5cd35099c913a9bcfe37dfecd43f60d279d1adee2ee49a3e31a6945e052588f1061865642d7dc703fd327de4c446bc7fd", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f15ecfac9b50ccb655a00187e5df2de8571187dc569251a5bdbdfcf7678e23ba2dada04df8fe6829e4f5bea51bd35ce2bdddb1296fa07f4429225d953b94133d", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5afc592307446024ecaed5105bd11f0599a2b1f0f055908d82347a48321046b788fd6be1cccc3c9dadc1ee1cc596aad3b630d0c52c559112b7f761ad76cb715c"} build_url:https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011392 build_url: 'https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf9e399e71f743489b443bb6928495d60bbfb3d8c9f3f6a8a3dbf095ec5df353e2b0d58a90705ea20b2d24b637316f12cc6218567de93b336e17683ae0e27f62", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a321b49a0caf7c7ea858b56ff4fb4ed5cd35099c913a9bcfe37dfecd43f60d279d1adee2ee49a3e31a6945e052588f1061865642d7dc703fd327de4c446bc7fd", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f15ecfac9b50ccb655a00187e5df2de8571187dc569251a5bdbdfcf7678e23ba2dada04df8fe6829e4f5bea51bd35ce2bdddb1296fa07f4429225d953b94133d", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5afc592307446024ecaed5105bd11f0599a2b1f0f055908d82347a48321046b788fd6be1cccc3c9dadc1ee1cc596aad3b630d0c52c559112b7f761ad76cb715c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 16:45:09.047828) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 16:45:09.048152) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505776950.866687-1192876190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 16:45:09.130339) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 16:45:09.130658) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 16:45:09.130999) ========= ========= Total master_lag: 0.31 =========