builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-072 starttime: 1504289449.99 results: success (0) revision: d1292636950a4ac1bb818cf05b113e3fcd6babe1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-01 11:10:49.992658) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-01 11:10:49.993127) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-01 11:10:49.993397) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-01 11:10:50.011419) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 11:10:50.011757) ========= 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=199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-01 11:10:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 54.1M=0s 2017-09-01 11:10:50 (54.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.160930 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 11:10:50.187188) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 11:10:50.187560) ========= 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=199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022517 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 11:10:50.237760) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-01 11:10:50.238091) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d1292636950a4ac1bb818cf05b113e3fcd6babe1 --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 d1292636950a4ac1bb818cf05b113e3fcd6babe1 --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=199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-01 11:10:50,285 truncating revision to first 12 chars 2017-09-01 11:10:50,285 Setting DEBUG logging. 2017-09-01 11:10:50,285 attempt 1/10 2017-09-01 11:10:50,285 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d1292636950a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-01 11:10:51,644 unpacking tar archive at: mozilla-central-d1292636950a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.758853 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-01 11:10:52.014299) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-01 11:10:52.014617) ========= script_repo_revision: d1292636950a4ac1bb818cf05b113e3fcd6babe1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-01 11:10:52.015014) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-01 11:10:52.015280) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-01 11:10:52.027689) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-09-01 11:10:52.027984) ========= /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=199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:10:52 INFO - MultiFileLogger online at 20170901 11:10:52 in /builds/slave/test 11:10:52 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 11:10:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:10:52 INFO - {'append_to_log': False, 11:10:52 INFO - 'base_work_dir': '/builds/slave/test', 11:10:52 INFO - 'blob_upload_branch': 'Firefox', 11:10:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:10:52 INFO - 'branch': 'Firefox', 11:10:52 INFO - 'buildbot_json_path': 'buildprops.json', 11:10:52 INFO - 'code_coverage': False, 11:10:52 INFO - 'config_files': ('talos/linux_config.py',), 11:10:52 INFO - 'default_actions': ('clobber', 11:10:52 INFO - 'read-buildbot-config', 11:10:52 INFO - 'download-and-extract', 11:10:52 INFO - 'populate-webroot', 11:10:52 INFO - 'create-virtualenv', 11:10:52 INFO - 'install', 11:10:52 INFO - 'setup-mitmproxy', 11:10:52 INFO - 'run-tests'), 11:10:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:10:52 INFO - 'disable_ccov_upload': False, 11:10:52 INFO - 'disable_stylo': False, 11:10:52 INFO - 'download_minidump_stackwalk': True, 11:10:52 INFO - 'download_symbols': 'ondemand', 11:10:52 INFO - 'enable_stylo': False, 11:10:52 INFO - 'enable_webrender': False, 11:10:52 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:10:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:10:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:10:52 INFO - 'gecko_profile': False, 11:10:52 INFO - 'gecko_profile_interval': 0, 11:10:52 INFO - 'installer_path': 'installer.exe', 11:10:52 INFO - 'log_level': 'info', 11:10:52 INFO - 'log_name': 'talos', 11:10:52 INFO - 'log_to_console': True, 11:10:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:10:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:10:52 INFO - 'opt_config_files': (), 11:10:52 INFO - 'pip_index': False, 11:10:52 INFO - 'suite': 'dromaeojs-e10s', 11:10:52 INFO - 'system_bits': '32', 11:10:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:10:52 INFO - 'title': 'talos-linux64-ix-072', 11:10:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:10:52 INFO - 'use_talos_json': True, 11:10:52 INFO - 'verify': 'False', 11:10:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:10:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:10:52 INFO - 'work_dir': 'build'} 11:10:52 INFO - [mozharness: 2017-09-01 18:10:52.312525Z] Running clobber step. 11:10:52 INFO - Running pre-action listener: _resource_record_pre_action 11:10:52 INFO - Running main action method: clobber 11:10:52 INFO - rmtree: /builds/slave/test/build 11:10:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:10:53 INFO - Running post-action listener: _resource_record_post_action 11:10:53 INFO - [mozharness: 2017-09-01 18:10:53.277921Z] Finished clobber step (success) 11:10:53 INFO - [mozharness: 2017-09-01 18:10:53.278083Z] Running read-buildbot-config step. 11:10:53 INFO - Running pre-action listener: _resource_record_pre_action 11:10:53 INFO - Running main action method: read_buildbot_config 11:10:53 INFO - Using buildbot properties: 11:10:53 INFO - { 11:10:53 INFO - "project": "", 11:10:53 INFO - "product": "firefox", 11:10:53 INFO - "who": "ffxbld@noreply.mozilla.org", 11:10:53 INFO - "installer_path": "public/build/target.tar.bz2", 11:10:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 11:10:53 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:10:53 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 11:10:53 INFO - "stage_platform": "linux64-stylo", 11:10:53 INFO - "basedir": "/builds/slave/test", 11:10:53 INFO - "buildnumber": 292, 11:10:53 INFO - "platform": "ubuntu64_hw_stylo", 11:10:53 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:10:53 INFO - "slavebuilddir": "test", 11:10:53 INFO - "taskId": "R27hVkSYTe2rspyT7-alFQ", 11:10:53 INFO - "branch": "mozilla-central", 11:10:53 INFO - "script_repo_revision": "production", 11:10:53 INFO - "revision": "d1292636950a4ac1bb818cf05b113e3fcd6babe1", 11:10:53 INFO - "slavename": "talos-linux64-ix-072", 11:10:53 INFO - "repo_path": "mozilla-central" 11:10:53 INFO - } 11:10:53 INFO - Finding installer, test and symbols from parent task. 11:10:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R27hVkSYTe2rspyT7-alFQ'}, attempt #1 11:10:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R27hVkSYTe2rspyT7-alFQ'}, attempt #1 11:10:54 INFO - Task dependencies: Aa8zsAsLT3StNXVbTCD9Tg 11:10:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Aa8zsAsLT3StNXVbTCD9Tg'}, attempt #1 11:10:54 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Aa8zsAsLT3StNXVbTCD9Tg/artifacts/public/build/target.tar.bz2 11:10:54 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Aa8zsAsLT3StNXVbTCD9Tg/artifacts/public/build/target.test_packages.json 11:10:54 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Aa8zsAsLT3StNXVbTCD9Tg/artifacts/public/build/target.crashreporter-symbols.zip 11:10:54 INFO - Running post-action listener: _resource_record_post_action 11:10:54 INFO - [mozharness: 2017-09-01 18:10:54.658622Z] Finished read-buildbot-config step (success) 11:10:54 INFO - [mozharness: 2017-09-01 18:10:54.658839Z] Running download-and-extract step. 11:10:54 INFO - Running pre-action listener: _resource_record_pre_action 11:10:54 INFO - Running main action method: download_and_extract 11:10:54 INFO - mkdir: /builds/slave/test/build/tests 11:10: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')]} 11:10:54 INFO - trying https://queue.taskcluster.net/v1/task/Aa8zsAsLT3StNXVbTCD9Tg/artifacts/public/build/target.test_packages.json 11:10:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Aa8zsAsLT3StNXVbTCD9Tg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:10:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Aa8zsAsLT3StNXVbTCD9Tg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:10:55 INFO - Downloaded 989 bytes. 11:10:55 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:10:55 INFO - Using the following test package requirements: 11:10:55 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:10:55 INFO - u'common': [u'target.common.tests.zip'], 11:10:55 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:10:55 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:10:55 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:10:55 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:10:55 INFO - u'mozbase': [u'target.common.tests.zip'], 11:10:55 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:10:55 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:10:55 INFO - u'web-platform': [u'target.common.tests.zip', 11:10:55 INFO - u'target.web-platform.tests.tar.gz'], 11:10:55 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:10:55 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:10:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Aa8zsAsLT3StNXVbTCD9Tg/artifacts/public/build/target.common.tests.zip 11:10:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Aa8zsAsLT3StNXVbTCD9Tg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:10:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Aa8zsAsLT3StNXVbTCD9Tg/artifacts/public/build/target.common.tests.zip into memory 11:10:56 INFO - Content-Length response header: 54957534 11:10:56 INFO - Bytes received: 54957534 11:11:07 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:11:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Aa8zsAsLT3StNXVbTCD9Tg/artifacts/public/build/target.common.tests.zip 11:11:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Aa8zsAsLT3StNXVbTCD9Tg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:11:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Aa8zsAsLT3StNXVbTCD9Tg/artifacts/public/build/target.common.tests.zip into memory 11:11:08 INFO - Content-Length response header: 54957534 11:11:08 INFO - Bytes received: 54957534 11:11:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Aa8zsAsLT3StNXVbTCD9Tg/artifacts/public/build/target.talos.tests.zip 11:11:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Aa8zsAsLT3StNXVbTCD9Tg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:11:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Aa8zsAsLT3StNXVbTCD9Tg/artifacts/public/build/target.talos.tests.zip into memory 11:11:22 INFO - Content-Length response header: 14496650 11:11:22 INFO - Bytes received: 14496650 11:11:23 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')]} 11:11:23 INFO - trying https://queue.taskcluster.net/v1/task/Aa8zsAsLT3StNXVbTCD9Tg/artifacts/public/build/target.tar.bz2 11:11:23 INFO - Downloading https://queue.taskcluster.net/v1/task/Aa8zsAsLT3StNXVbTCD9Tg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:11:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Aa8zsAsLT3StNXVbTCD9Tg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:11:24 INFO - Downloaded 62605694 bytes. 11:11:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Aa8zsAsLT3StNXVbTCD9Tg/artifacts/public/build/target.tar.bz2 11:11:24 INFO - mkdir: /builds/slave/test/properties 11:11:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:11:24 INFO - Writing to file /builds/slave/test/properties/build_url 11:11:24 INFO - Contents: 11:11:24 INFO - build_url:https://queue.taskcluster.net/v1/task/Aa8zsAsLT3StNXVbTCD9Tg/artifacts/public/build/target.tar.bz2 11:11:24 INFO - Running post-action listener: _resource_record_post_action 11:11:24 INFO - Running post-action listener: find_tests_for_verification 11:11:24 INFO - Running post-action listener: set_extra_try_arguments 11:11:24 INFO - [mozharness: 2017-09-01 18:11:24.124302Z] Finished download-and-extract step (success) 11:11:24 INFO - [mozharness: 2017-09-01 18:11:24.124398Z] Running populate-webroot step. 11:11:24 INFO - Running pre-action listener: _resource_record_pre_action 11:11:24 INFO - Running main action method: populate_webroot 11:11:24 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:11:24 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:11:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:11:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:11:24 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:11:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:11:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:11:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:11:24 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:11:24 INFO - 'talos_options': ['--enable-stylo'], 11:11:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:11:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:11:24 INFO - 'tests': ['damp', 'tps']}, 11:11:24 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:11:24 INFO - 'talos_options': ['--enable-stylo'], 11:11:24 INFO - 'tests': ['damp', 'tps']}, 11:11:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:11:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:11:24 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:11:24 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 11:11:24 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:11:24 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:11:24 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:11:24 INFO - 'talos_options': ['--enable-stylo'], 11:11:24 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:11:24 INFO - 'other-e10s': {'tests': ['a11yr', 11:11:24 INFO - 'ts_paint', 11:11:24 INFO - 'tpaint', 11:11:24 INFO - 'sessionrestore', 11:11:24 INFO - 'sessionrestore_many_windows', 11:11:24 INFO - 'sessionrestore_no_auto_restore', 11:11:24 INFO - 'tabpaint']}, 11:11:24 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:11:24 INFO - 'tests': ['a11yr', 11:11:24 INFO - 'ts_paint', 11:11:24 INFO - 'tpaint', 11:11:24 INFO - 'sessionrestore', 11:11:24 INFO - 'sessionrestore_many_windows', 11:11:24 INFO - 'sessionrestore_no_auto_restore', 11:11:24 INFO - 'tabpaint']}, 11:11:24 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:11:24 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:11:24 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:11:24 INFO - 'tests': ['bloom_basic_singleton']}, 11:11:24 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:11:24 INFO - 'tests': ['bloom_basic']}, 11:11:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:11:24 INFO - 'tsvgr_opacity', 11:11:24 INFO - 'tart', 11:11:24 INFO - 'tscrollx', 11:11:24 INFO - 'tsvg_static']}, 11:11:24 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:11:24 INFO - 'tests': ['tsvgx', 11:11:24 INFO - 'tsvgr_opacity', 11:11:24 INFO - 'tart', 11:11:24 INFO - 'tscrollx', 11:11:24 INFO - 'tsvg_static']}, 11:11:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:11:24 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:11:24 INFO - 'talos_options': ['--enable-stylo'], 11:11:24 INFO - 'tests': ['tp5o']}, 11:11:24 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:11:24 INFO - 'talos_options': ['--mitmproxy', 11:11:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:11:24 INFO - '--firstNonBlankPaint'], 11:11:24 INFO - 'tests': ['tp6_google', 11:11:24 INFO - 'tp6_youtube', 11:11:24 INFO - 'tp6_amazon', 11:11:24 INFO - 'tp6_facebook']}, 11:11:24 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:11:24 INFO - 'talos_options': ['--enable-stylo', 11:11:24 INFO - '--mitmproxy', 11:11:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:11:24 INFO - '--firstNonBlankPaint'], 11:11:24 INFO - 'tests': ['tp6_google', 11:11:24 INFO - 'tp6_youtube', 11:11:24 INFO - 'tp6_amazon', 11:11:24 INFO - 'tp6_facebook']}, 11:11:24 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:11:24 INFO - 'talos_options': ['--enable-stylo', 11:11:24 INFO - '--stylo-threads=1', 11:11:24 INFO - '--mitmproxy', 11:11:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:11:24 INFO - '--firstNonBlankPaint'], 11:11:24 INFO - 'tests': ['tp6_google', 11:11:24 INFO - 'tp6_youtube', 11:11:24 INFO - 'tp6_amazon', 11:11:24 INFO - 'tp6_facebook']}, 11:11:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:11:24 INFO - 'talos_options': ['--xperf_path', 11:11:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:11:24 INFO - 'tests': ['tp5n']}, 11:11:24 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:11:24 INFO - 'talos_options': ['--enable-stylo', 11:11:24 INFO - '--xperf_path', 11:11:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:11:24 INFO - 'tests': ['tp5n']}}} 11:11:24 INFO - Running post-action listener: _resource_record_post_action 11:11:24 INFO - [mozharness: 2017-09-01 18:11:24.139160Z] Finished populate-webroot step (success) 11:11:24 INFO - [mozharness: 2017-09-01 18:11:24.139249Z] Running create-virtualenv step. 11:11:24 INFO - Running pre-action listener: _resource_record_pre_action 11:11:24 INFO - Running main action method: create_virtualenv 11:11:24 INFO - Creating virtualenv /builds/slave/test/build/venv 11:11:24 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:11:24 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:11:24 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:11:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:11:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:11:26 INFO - Installing distribute.............................................................................................................................................................................................done. 11:11:27 INFO - Installing pip...............done. 11:11:27 INFO - Return code: 0 11:11:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:11:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:11:27 INFO - Reading from file tmpfile_stdout 11:11:27 INFO - Output received: 11:11:27 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:11:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:11:27 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')]} 11:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:27 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')]} 11:11:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:27 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 0xaaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1f090>, '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 0xe1fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe19f90>, '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': '199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337', '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 11:11:27 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 11:11:27 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 11:11:27 INFO - Using env: {'DISPLAY': ':0', 11:11:27 INFO - 'HOME': '/home/cltbld', 11:11:27 INFO - 'LANG': 'en_US.UTF-8', 11:11:27 INFO - 'LANGUAGE': 'en_US:en', 11:11:27 INFO - 'LOGNAME': 'cltbld', 11:11:27 INFO - 'MAIL': '/var/mail/cltbld', 11:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:27 INFO - 'MOZ_NO_REMOTE': '1', 11:11:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:27 INFO - 'NO_EM_RESTART': '1', 11:11:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:27 INFO - 'PWD': '/builds/slave/test', 11:11:27 INFO - 'SHELL': '/bin/bash', 11:11:27 INFO - 'SHLVL': '1', 11:11:27 INFO - 'TERM': 'linux', 11:11:27 INFO - 'TMOUT': '86400', 11:11:27 INFO - 'USER': 'cltbld', 11:11:27 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337', 11:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:27 INFO - '_': '/tools/buildbot/bin/python'} 11:11:28 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:11:28 INFO - Downloading/unpacking pip>=1.5 11:11:28 INFO - Running setup.py egg_info for package pip 11:11:28 INFO - warning: no files found matching 'pip/cacert.pem' 11:11:28 INFO - warning: no files found matching '*.html' under directory 'docs' 11:11:28 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:11:28 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:11:28 INFO - Installing collected packages: pip 11:11:28 INFO - Found existing installation: pip 1.1 11:11:28 INFO - Uninstalling pip: 11:11:28 INFO - Successfully uninstalled pip 11:11:28 INFO - Running setup.py install for pip 11:11:28 INFO - warning: no files found matching 'pip/cacert.pem' 11:11:28 INFO - warning: no files found matching '*.html' under directory 'docs' 11:11:28 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:11:28 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:11:28 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:11:28 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:11:28 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:11:28 INFO - Successfully installed pip 11:11:28 INFO - Cleaning up... 11:11:28 INFO - Return code: 0 11:11:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:11:28 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')]} 11:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:28 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')]} 11:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:28 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 0xaaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1f090>, '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 0xe1fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe19f90>, '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': '199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337', '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 11:11:28 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 11:11:28 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 11:11:28 INFO - Using env: {'DISPLAY': ':0', 11:11:28 INFO - 'HOME': '/home/cltbld', 11:11:28 INFO - 'LANG': 'en_US.UTF-8', 11:11:28 INFO - 'LANGUAGE': 'en_US:en', 11:11:28 INFO - 'LOGNAME': 'cltbld', 11:11:28 INFO - 'MAIL': '/var/mail/cltbld', 11:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:28 INFO - 'MOZ_NO_REMOTE': '1', 11:11:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:28 INFO - 'NO_EM_RESTART': '1', 11:11:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:28 INFO - 'PWD': '/builds/slave/test', 11:11:28 INFO - 'SHELL': '/bin/bash', 11:11:28 INFO - 'SHLVL': '1', 11:11:28 INFO - 'TERM': 'linux', 11:11:28 INFO - 'TMOUT': '86400', 11:11:28 INFO - 'USER': 'cltbld', 11:11:28 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337', 11:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:28 INFO - '_': '/tools/buildbot/bin/python'} 11:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:28 INFO - Downloading/unpacking psutil>=3.1.1 11:11:28 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 11:11:28 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 11:11:28 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 11:11:28 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 11:11:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:11:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:11:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:11:30 INFO - Installing collected packages: psutil 11:11:30 INFO - Running setup.py install for psutil 11:11:30 INFO - building 'psutil._psutil_linux' extension 11:11:30 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 11:11:30 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 11:11:31 INFO - building 'psutil._psutil_posix' extension 11:11:31 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 11:11:31 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 11:11:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:11:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:11:31 INFO - Successfully installed psutil 11:11:31 INFO - Cleaning up... 11:11:31 INFO - Return code: 0 11:11:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:11:31 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')]} 11:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:31 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')]} 11:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:31 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 0xaaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1f090>, '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 0xe1fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe19f90>, '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': '199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337', '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 11:11:31 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 11:11:31 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 11:11:31 INFO - Using env: {'DISPLAY': ':0', 11:11:31 INFO - 'HOME': '/home/cltbld', 11:11:31 INFO - 'LANG': 'en_US.UTF-8', 11:11:31 INFO - 'LANGUAGE': 'en_US:en', 11:11:31 INFO - 'LOGNAME': 'cltbld', 11:11:31 INFO - 'MAIL': '/var/mail/cltbld', 11:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:31 INFO - 'MOZ_NO_REMOTE': '1', 11:11:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:31 INFO - 'NO_EM_RESTART': '1', 11:11:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:31 INFO - 'PWD': '/builds/slave/test', 11:11:31 INFO - 'SHELL': '/bin/bash', 11:11:31 INFO - 'SHLVL': '1', 11:11:31 INFO - 'TERM': 'linux', 11:11:31 INFO - 'TMOUT': '86400', 11:11:31 INFO - 'USER': 'cltbld', 11:11:31 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337', 11:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:31 INFO - '_': '/tools/buildbot/bin/python'} 11:11:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:11:31 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 11:11:31 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 11:11:31 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 11:11:31 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 11:11:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:11:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:11:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:11:32 INFO - Installing collected packages: mozsystemmonitor 11:11:32 INFO - Running setup.py install for mozsystemmonitor 11:11:32 INFO - Successfully installed mozsystemmonitor 11:11:32 INFO - Cleaning up... 11:11:32 INFO - Return code: 0 11:11:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:11:32 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')]} 11:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:32 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')]} 11:11:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:32 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 0xaaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1f090>, '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 0xe1fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe19f90>, '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': '199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337', '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 11:11:32 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 11:11:32 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 11:11:32 INFO - Using env: {'DISPLAY': ':0', 11:11:32 INFO - 'HOME': '/home/cltbld', 11:11:32 INFO - 'LANG': 'en_US.UTF-8', 11:11:32 INFO - 'LANGUAGE': 'en_US:en', 11:11:32 INFO - 'LOGNAME': 'cltbld', 11:11:32 INFO - 'MAIL': '/var/mail/cltbld', 11:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:32 INFO - 'MOZ_NO_REMOTE': '1', 11:11:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:32 INFO - 'NO_EM_RESTART': '1', 11:11:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:32 INFO - 'PWD': '/builds/slave/test', 11:11:32 INFO - 'SHELL': '/bin/bash', 11:11:32 INFO - 'SHLVL': '1', 11:11:32 INFO - 'TERM': 'linux', 11:11:32 INFO - 'TMOUT': '86400', 11:11:32 INFO - 'USER': 'cltbld', 11:11:32 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337', 11:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:32 INFO - '_': '/tools/buildbot/bin/python'} 11:11:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:33 INFO - Downloading/unpacking jsonschema==2.5.1 11:11:33 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 11:11:33 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 11:11:33 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 11:11:33 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 11:11:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:11:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:11:34 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 11:11:34 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 11:11:34 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 11:11:34 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 11:11:34 INFO - Downloading functools32-3.2.3-2.tar.gz 11:11:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:11:34 INFO - warning: no files found matching '*.txt' 11:11:34 INFO - no previously-included directories found matching 'build' 11:11:34 INFO - no previously-included directories found matching 'dist' 11:11:34 INFO - no previously-included directories found matching '.git*' 11:11:34 INFO - Installing collected packages: jsonschema, functools32 11:11:34 INFO - Running setup.py install for functools32 11:11:34 INFO - warning: no files found matching '*.txt' 11:11:34 INFO - no previously-included directories found matching 'build' 11:11:34 INFO - no previously-included directories found matching 'dist' 11:11:34 INFO - no previously-included directories found matching '.git*' 11:11:34 INFO - Successfully installed jsonschema functools32 11:11:34 INFO - Cleaning up... 11:11:34 INFO - Return code: 0 11:11:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:11:34 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')]} 11:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:34 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')]} 11:11:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:34 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 0xaaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1f090>, '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 0xe1fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe19f90>, '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': '199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337', '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 11:11:34 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 11:11:34 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 11:11:34 INFO - Using env: {'DISPLAY': ':0', 11:11:34 INFO - 'HOME': '/home/cltbld', 11:11:34 INFO - 'LANG': 'en_US.UTF-8', 11:11:34 INFO - 'LANGUAGE': 'en_US:en', 11:11:34 INFO - 'LOGNAME': 'cltbld', 11:11:34 INFO - 'MAIL': '/var/mail/cltbld', 11:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:34 INFO - 'MOZ_NO_REMOTE': '1', 11:11:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:34 INFO - 'NO_EM_RESTART': '1', 11:11:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:34 INFO - 'PWD': '/builds/slave/test', 11:11:34 INFO - 'SHELL': '/bin/bash', 11:11:34 INFO - 'SHLVL': '1', 11:11:34 INFO - 'TERM': 'linux', 11:11:34 INFO - 'TMOUT': '86400', 11:11:34 INFO - 'USER': 'cltbld', 11:11:34 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337', 11:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:34 INFO - '_': '/tools/buildbot/bin/python'} 11:11:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:11:34 INFO - Cleaning up... 11:11:34 INFO - Return code: 0 11:11:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:11:34 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')]} 11:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:34 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')]} 11:11:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:34 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 0xaaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1f090>, '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 0xe1fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe19f90>, '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': '199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337', '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 11:11:34 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 11:11:34 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 11:11:34 INFO - Using env: {'DISPLAY': ':0', 11:11:34 INFO - 'HOME': '/home/cltbld', 11:11:34 INFO - 'LANG': 'en_US.UTF-8', 11:11:34 INFO - 'LANGUAGE': 'en_US:en', 11:11:34 INFO - 'LOGNAME': 'cltbld', 11:11:34 INFO - 'MAIL': '/var/mail/cltbld', 11:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:34 INFO - 'MOZ_NO_REMOTE': '1', 11:11:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:34 INFO - 'NO_EM_RESTART': '1', 11:11:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:34 INFO - 'PWD': '/builds/slave/test', 11:11:34 INFO - 'SHELL': '/bin/bash', 11:11:34 INFO - 'SHLVL': '1', 11:11:34 INFO - 'TERM': 'linux', 11:11:34 INFO - 'TMOUT': '86400', 11:11:34 INFO - 'USER': 'cltbld', 11:11:34 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337', 11:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:34 INFO - '_': '/tools/buildbot/bin/python'} 11:11:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:34 INFO - Downloading/unpacking blobuploader==1.2.4 11:11:34 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 11:11:34 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 11:11:34 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 11:11:34 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 11:11:36 INFO - Downloading blobuploader-1.2.4.tar.gz 11:11:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:11:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:11:36 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 11:11:36 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 11:11:36 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 11:11:36 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 11:11:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:11:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:11:36 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 11:11:36 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 11:11:36 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 11:11:36 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 11:11:36 INFO - Downloading docopt-0.6.1.tar.gz 11:11:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:11:36 INFO - Installing collected packages: blobuploader, requests, docopt 11:11:36 INFO - Running setup.py install for blobuploader 11:11:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:11:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:11:36 INFO - Running setup.py install for requests 11:11:37 INFO - Running setup.py install for docopt 11:11:37 INFO - Successfully installed blobuploader requests docopt 11:11:37 INFO - Cleaning up... 11:11:37 INFO - Return code: 0 11:11:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:11:37 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')]} 11:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:37 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')]} 11:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:37 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 0xaaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1f090>, '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 0xe1fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe19f90>, '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': '199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337', '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 11:11:37 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 11:11:37 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 11:11:37 INFO - Using env: {'DISPLAY': ':0', 11:11:37 INFO - 'HOME': '/home/cltbld', 11:11:37 INFO - 'LANG': 'en_US.UTF-8', 11:11:37 INFO - 'LANGUAGE': 'en_US:en', 11:11:37 INFO - 'LOGNAME': 'cltbld', 11:11:37 INFO - 'MAIL': '/var/mail/cltbld', 11:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:37 INFO - 'MOZ_NO_REMOTE': '1', 11:11:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:37 INFO - 'NO_EM_RESTART': '1', 11:11:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:37 INFO - 'PWD': '/builds/slave/test', 11:11:37 INFO - 'SHELL': '/bin/bash', 11:11:37 INFO - 'SHLVL': '1', 11:11:37 INFO - 'TERM': 'linux', 11:11:37 INFO - 'TMOUT': '86400', 11:11:37 INFO - 'USER': 'cltbld', 11:11:37 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337', 11:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:37 INFO - '_': '/tools/buildbot/bin/python'} 11:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:11:37 INFO - Running setup.py (path:/tmp/pip-F5eCSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:11:37 INFO - Running setup.py (path:/tmp/pip-BmeFft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:11:37 INFO - Running setup.py (path:/tmp/pip-6X8Jd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:11:37 INFO - Running setup.py (path:/tmp/pip-l2jQk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:11:37 INFO - Running setup.py (path:/tmp/pip-ok9Xhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:11:37 INFO - Running setup.py (path:/tmp/pip-tQOhZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:11:37 INFO - Running setup.py (path:/tmp/pip-ljbDgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:11:38 INFO - Running setup.py (path:/tmp/pip-wLKuja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:11:38 INFO - Running setup.py (path:/tmp/pip-k4sQTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:11:38 INFO - Running setup.py (path:/tmp/pip-14hEVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:11:38 INFO - Running setup.py (path:/tmp/pip-t6TRUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:11:38 INFO - Running setup.py (path:/tmp/pip-As4iHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:11:38 INFO - Running setup.py (path:/tmp/pip-Z0jjJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:11:38 INFO - Running setup.py (path:/tmp/pip-YYRuTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:11:38 INFO - Running setup.py (path:/tmp/pip-O4Msnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:11:38 INFO - Running setup.py (path:/tmp/pip-v7x7_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:11:38 INFO - Running setup.py (path:/tmp/pip-m_t9XP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:11:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:11:38 INFO - Running setup.py install for manifestparser 11:11:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:11:38 INFO - Running setup.py install for mozcrash 11:11:38 INFO - Running setup.py install for mozdebug 11:11:39 INFO - Running setup.py install for mozdevice 11:11:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:11:39 INFO - Running setup.py install for mozfile 11:11:39 INFO - Running setup.py install for mozhttpd 11:11:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:11:39 INFO - Running setup.py install for mozinfo 11:11:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:11:39 INFO - Running setup.py install for mozInstall 11:11:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:11:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:11:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:11:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:11:39 INFO - Running setup.py install for mozleak 11:11:39 INFO - Running setup.py install for mozlog 11:11:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:11:39 INFO - Running setup.py install for moznetwork 11:11:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:11:39 INFO - Running setup.py install for mozprocess 11:11:39 INFO - Running setup.py install for mozprofile 11:11:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:11:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:11:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:11:40 INFO - Running setup.py install for mozrunner 11:11:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:11:40 INFO - Running setup.py install for mozscreenshot 11:11:40 INFO - Running setup.py install for moztest 11:11:40 INFO - Running setup.py install for mozversion 11:11:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:11:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:11:40 INFO - Cleaning up... 11:11:40 INFO - Return code: 0 11:11:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:11:40 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')]} 11:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:40 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')]} 11:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:40 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 0xaaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1f090>, '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 0xe1fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe19f90>, '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': '199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337', '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 11:11:40 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 11:11:40 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 11:11:40 INFO - Using env: {'DISPLAY': ':0', 11:11:40 INFO - 'HOME': '/home/cltbld', 11:11:40 INFO - 'LANG': 'en_US.UTF-8', 11:11:40 INFO - 'LANGUAGE': 'en_US:en', 11:11:40 INFO - 'LOGNAME': 'cltbld', 11:11:40 INFO - 'MAIL': '/var/mail/cltbld', 11:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:40 INFO - 'MOZ_NO_REMOTE': '1', 11:11:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:40 INFO - 'NO_EM_RESTART': '1', 11:11:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:40 INFO - 'PWD': '/builds/slave/test', 11:11:40 INFO - 'SHELL': '/bin/bash', 11:11:40 INFO - 'SHLVL': '1', 11:11:40 INFO - 'TERM': 'linux', 11:11:40 INFO - 'TMOUT': '86400', 11:11:40 INFO - 'USER': 'cltbld', 11:11:40 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337', 11:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:40 INFO - '_': '/tools/buildbot/bin/python'} 11:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:11:40 INFO - Running setup.py (path:/tmp/pip-BuV2nN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:11:40 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)) 11:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:11:40 INFO - Running setup.py (path:/tmp/pip-0L_HPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:11:40 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)) 11:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:11:40 INFO - Running setup.py (path:/tmp/pip-q5sdVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:11:40 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)) 11:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:11:40 INFO - Running setup.py (path:/tmp/pip-zR85Ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:11:41 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)) 11:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:11:41 INFO - Running setup.py (path:/tmp/pip-phLKCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:11:41 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)) 11:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:11:41 INFO - Running setup.py (path:/tmp/pip-69EjPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:11:41 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)) 11:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:11:41 INFO - Running setup.py (path:/tmp/pip-y7DIyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:11:41 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)) 11:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:11:41 INFO - Running setup.py (path:/tmp/pip-YChmO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:11:41 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)) 11:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:11:41 INFO - Running setup.py (path:/tmp/pip-rEvv4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:11:41 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)) 11:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:11:41 INFO - Running setup.py (path:/tmp/pip-sVSacg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:11:41 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)) 11:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:11:41 INFO - Running setup.py (path:/tmp/pip-QJDoH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:11:41 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)) 11:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:11:41 INFO - Running setup.py (path:/tmp/pip-c3wKre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:11:41 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)) 11:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:11:41 INFO - Running setup.py (path:/tmp/pip-4bR9Fp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:11:41 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)) 11:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:11:41 INFO - Running setup.py (path:/tmp/pip-CuZGkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:11:41 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)) 11:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:11:41 INFO - Running setup.py (path:/tmp/pip-TObesV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:11:41 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)) 11:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:11:41 INFO - Running setup.py (path:/tmp/pip-FcB1Bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:11:41 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)) 11:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:11:41 INFO - Running setup.py (path:/tmp/pip-iWpTCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:11:41 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)) 11:11:41 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)) 11:11:41 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)) 11:11:41 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)) 11:11:41 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)) 11:11:41 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)) 11:11:41 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)) 11:11:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:11:41 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 11:11:41 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 11:11:41 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 11:11:41 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 11:11:43 INFO - Downloading blessings-1.6.tar.gz 11:11:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:11:43 INFO - Installing collected packages: blessings 11:11:43 INFO - Running setup.py install for blessings 11:11:43 INFO - Successfully installed blessings 11:11:43 INFO - Cleaning up... 11:11:43 INFO - Return code: 0 11:11:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:11:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:11:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:11:43 INFO - Reading from file tmpfile_stdout 11:11:43 INFO - Current package versions: 11:11:43 INFO - argparse == 1.2.1 11:11:43 INFO - blessings == 1.6 11:11:43 INFO - blobuploader == 1.2.4 11:11:43 INFO - docopt == 0.6.1 11:11:43 INFO - functools32 == 3.2.3-2 11:11:43 INFO - jsonschema == 2.5.1 11:11:43 INFO - manifestparser == 1.1 11:11:43 INFO - mozInstall == 1.13 11:11:43 INFO - mozcrash == 1.0 11:11:43 INFO - mozdebug == 0.1 11:11:43 INFO - mozdevice == 0.51 11:11:43 INFO - mozfile == 1.2 11:11:43 INFO - mozhttpd == 0.7 11:11:43 INFO - mozinfo == 0.10 11:11:43 INFO - mozleak == 0.1 11:11:43 INFO - mozlog == 3.5 11:11:43 INFO - moznetwork == 0.27 11:11:43 INFO - mozprocess == 0.25 11:11:43 INFO - mozprofile == 0.28 11:11:43 INFO - mozrunner == 6.13 11:11:43 INFO - mozscreenshot == 0.1 11:11:43 INFO - mozsystemmonitor == 0.3 11:11:43 INFO - moztest == 0.8 11:11:43 INFO - mozversion == 1.4 11:11:43 INFO - psutil == 3.1.1 11:11:43 INFO - requests == 1.2.3 11:11:43 INFO - wsgiref == 0.1.2 11:11:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:43 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 0xaaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1f090>, '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 0xe1fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe19f90>, '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': '199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337', '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 11:11:43 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 11:11:43 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 11:11:43 INFO - Using env: {'DISPLAY': ':0', 11:11:43 INFO - 'HOME': '/home/cltbld', 11:11:43 INFO - 'LANG': 'en_US.UTF-8', 11:11:43 INFO - 'LANGUAGE': 'en_US:en', 11:11:43 INFO - 'LOGNAME': 'cltbld', 11:11:43 INFO - 'MAIL': '/var/mail/cltbld', 11:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:43 INFO - 'MOZ_NO_REMOTE': '1', 11:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:43 INFO - 'NO_EM_RESTART': '1', 11:11:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:43 INFO - 'PWD': '/builds/slave/test', 11:11:43 INFO - 'SHELL': '/bin/bash', 11:11:43 INFO - 'SHLVL': '1', 11:11:43 INFO - 'TERM': 'linux', 11:11:43 INFO - 'TMOUT': '86400', 11:11:43 INFO - 'USER': 'cltbld', 11:11:43 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337', 11:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:43 INFO - '_': '/tools/buildbot/bin/python'} 11:11:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:43 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)) 11:11:43 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)) 11:11:43 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)) 11:11:43 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)) 11:11:43 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)) 11:11:43 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)) 11:11:43 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)) 11:11:43 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)) 11:11:43 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)) 11:11:43 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:11:44 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)) 11:11:44 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)) 11:11:44 INFO - Installing collected packages: simplejson 11:11:44 INFO - Running setup.py install for simplejson 11:11:45 INFO - building 'simplejson._speedups' extension 11:11:45 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 11:11:45 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 11:11:45 INFO - Successfully installed simplejson 11:11:45 INFO - Cleaning up... 11:11:45 INFO - Return code: 0 11:11:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:11: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')]} 11:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11: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')]} 11:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:45 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 0xaaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1f090>, '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 0xe1fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe19f90>, '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': '199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337', '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 11:11:45 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 11:11:45 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 11:11:45 INFO - Using env: {'DISPLAY': ':0', 11:11:45 INFO - 'HOME': '/home/cltbld', 11:11:45 INFO - 'LANG': 'en_US.UTF-8', 11:11:45 INFO - 'LANGUAGE': 'en_US:en', 11:11:45 INFO - 'LOGNAME': 'cltbld', 11:11:45 INFO - 'MAIL': '/var/mail/cltbld', 11:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:45 INFO - 'MOZ_NO_REMOTE': '1', 11:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:45 INFO - 'NO_EM_RESTART': '1', 11:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:45 INFO - 'PWD': '/builds/slave/test', 11:11:45 INFO - 'SHELL': '/bin/bash', 11:11:45 INFO - 'SHLVL': '1', 11:11:45 INFO - 'TERM': 'linux', 11:11:45 INFO - 'TMOUT': '86400', 11:11:45 INFO - 'USER': 'cltbld', 11:11:45 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337', 11:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:45 INFO - '_': '/tools/buildbot/bin/python'} 11:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:11:46 INFO - Cleaning up... 11:11:46 INFO - Return code: 0 11:11:46 INFO - Running post-action listener: _resource_record_post_action 11:11:46 INFO - Running post-action listener: _start_resource_monitoring 11:11:46 INFO - Starting resource monitoring. 11:11:46 INFO - [mozharness: 2017-09-01 18:11:46.256164Z] Finished create-virtualenv step (success) 11:11:46 INFO - [mozharness: 2017-09-01 18:11:46.257183Z] Running install step. 11:11:46 INFO - Running pre-action listener: _resource_record_pre_action 11:11:46 INFO - Running main action method: install 11:11:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:11:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:11:46 INFO - Reading from file tmpfile_stdout 11:11:46 INFO - Detecting whether we're running mozinstall >=1.0... 11:11:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:11:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:11:46 INFO - Reading from file tmpfile_stdout 11:11:46 INFO - Output received: 11:11:46 INFO - Usage: mozinstall [options] installer 11:11:46 INFO - Options: 11:11:46 INFO - -h, --help show this help message and exit 11:11:46 INFO - -d DEST, --destination=DEST 11:11:46 INFO - Directory to install application into. [default: 11:11:46 INFO - "/builds/slave/test"] 11:11:46 INFO - --app=APP Application being installed. [default: firefox] 11:11:46 INFO - mkdir: /builds/slave/test/build/application 11:11:46 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'] 11:11:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:12:03 INFO - Reading from file tmpfile_stdout 11:12:03 INFO - Output received: 11:12:03 INFO - /builds/slave/test/build/application/firefox/firefox 11:12:03 INFO - Running post-action listener: _resource_record_post_action 11:12:03 INFO - [mozharness: 2017-09-01 18:12:03.080752Z] Finished install step (success) 11:12:03 INFO - [mozharness: 2017-09-01 18:12:03.080895Z] Running setup-mitmproxy step. 11:12:03 INFO - Running pre-action listener: _resource_record_pre_action 11:12:03 INFO - Running main action method: setup_mitmproxy 11:12:03 INFO - Skipping: mitmproxy is not required 11:12:03 INFO - Running post-action listener: _resource_record_post_action 11:12:03 INFO - [mozharness: 2017-09-01 18:12:03.081618Z] Finished setup-mitmproxy step (success) 11:12:03 INFO - [mozharness: 2017-09-01 18:12:03.081844Z] Running run-tests step. 11:12:03 INFO - Running pre-action listener: _resource_record_pre_action 11:12:03 INFO - Running pre-action listener: _set_gcov_prefix 11:12:03 INFO - Running main action method: run_tests 11:12:03 WARNING - Try message not found. 11:12:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:12:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:12:03 INFO - Python 2.7.3 11:12:03 INFO - Return code: 0 11:12:03 INFO - grabbing minidump binary from tooltool 11:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:03 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 0xe1f090>, '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 0xe1fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe19f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:12:03 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 11:12:03 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 11:12:03 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 11:12:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:12:03 INFO - Return code: 0 11:12:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:12:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:12:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:12:03 INFO - ENV: RUST_BACKTRACE is now full 11:12:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:12:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:12:03 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/Aa8zsAsLT3StNXVbTCD9Tg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--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 11:12:03 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/Aa8zsAsLT3StNXVbTCD9Tg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-072 --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 11:12:03 INFO - Using env: {'DISPLAY': ':0', 11:12:03 INFO - 'HOME': '/home/cltbld', 11:12:03 INFO - 'LANG': 'en_US.UTF-8', 11:12:03 INFO - 'LANGUAGE': 'en_US:en', 11:12:03 INFO - 'LOGNAME': 'cltbld', 11:12:03 INFO - 'MAIL': '/var/mail/cltbld', 11:12:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:12:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:03 INFO - 'MOZ_NO_REMOTE': '1', 11:12:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:03 INFO - 'NO_EM_RESTART': '1', 11:12:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:03 INFO - 'PWD': '/builds/slave/test', 11:12:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:12:03 INFO - 'RUST_BACKTRACE': 'full', 11:12:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:12:03 INFO - 'SHELL': '/bin/bash', 11:12:03 INFO - 'SHLVL': '1', 11:12:03 INFO - 'STYLO_FORCE_ENABLED': '1', 11:12:03 INFO - 'TERM': 'linux', 11:12:03 INFO - 'TMOUT': '86400', 11:12:03 INFO - 'USER': 'cltbld', 11:12:03 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337', 11:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:03 INFO - '_': '/tools/buildbot/bin/python'} 11:12:03 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/Aa8zsAsLT3StNXVbTCD9Tg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--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 11:12:03 INFO - mozversion application_buildid: 20170901171938 11:12:03 INFO - mozversion application_changeset: d1292636950a4ac1bb818cf05b113e3fcd6babe1 11:12:03 INFO - mozversion application_display_name: Nightly 11:12:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:12:03 INFO - mozversion application_name: Firefox 11:12:03 INFO - mozversion application_remotingname: firefox 11:12:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:12:03 INFO - mozversion application_vendor: Mozilla 11:12:03 INFO - mozversion application_version: 57.0a1 11:12:03 INFO - mozversion platform_buildid: 20170901171938 11:12:03 INFO - mozversion platform_changeset: d1292636950a4ac1bb818cf05b113e3fcd6babe1 11:12:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:12:03 INFO - mozversion platform_version: 57.0a1 11:12:03 INFO - using testdate: 1504289523 11:12:03 INFO - actual date: 1504289523 11:12:03 INFO - starting webserver on 'localhost:34319' 11:12:03 INFO - SUITE-START | Running 2 tests 11:12:03 INFO - TEST-START | dromaeo_css 11:12:03 INFO - Initialising browser for dromaeo_css test... 11:12:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34319/getInfo.html -profile /tmp/tmpfaAgiZ/profile 11:12:03 INFO - TEST-INFO | started process 3534 (/builds/slave/test/build/application/firefox/firefox http://localhost:34319/getInfo.html) 11:12:10 INFO - TEST-INFO | 3534: exit 0 11:12:10 INFO - Browser initialized. 11:12:10 INFO - Running cycle 1/1 for dromaeo_css test... 11:12:10 INFO - Using env: {'DISPLAY': ':0', 11:12:10 INFO - 'HOME': '/home/cltbld', 11:12:10 INFO - 'JSGC_DISABLE_POISONING': '1', 11:12:10 INFO - 'LANG': 'en_US.UTF-8', 11:12:10 INFO - 'LANGUAGE': 'en_US:en', 11:12:10 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:12:10 INFO - 'LOGNAME': 'cltbld', 11:12:10 INFO - 'MAIL': '/var/mail/cltbld', 11:12:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:12:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:12:10 INFO - 'MOZ_CRASHREPORTER': '1', 11:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:10 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:12:10 INFO - 'MOZ_NO_REMOTE': '1', 11:12:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:10 INFO - 'NO_EM_RESTART': '1', 11:12:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:10 INFO - 'PWD': '/builds/slave/test', 11:12:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:12:10 INFO - 'RUST_BACKTRACE': 'full', 11:12:10 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:12:10 INFO - 'SHELL': '/bin/bash', 11:12:10 INFO - 'SHLVL': '1', 11:12:10 INFO - 'STYLO_FORCE_ENABLED': '1', 11:12:10 INFO - 'TERM': 'linux', 11:12:10 INFO - 'TMOUT': '86400', 11:12:10 INFO - 'USER': 'cltbld', 11:12:10 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337', 11:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:10 INFO - '_': '/tools/buildbot/bin/python'} 11:12:10 INFO - TEST-INFO | started process 3734 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfaAgiZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:12:11 INFO - PID 3734 | 11:12:11 INFO - PID 3734 | (/builds/slave/test/build/application/firefox/firefox:3786): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:12:11 INFO - PID 3734 | 11:12:21 INFO - PID 3734 | RSS: Main: 171347968 11:12:21 INFO - PID 3734 | 11:15:20 INFO - PID 3734 | Cycle 1(1): loaded http://localhost:34319/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34319/tests/dromaeo/cssquery-ext.html) 11:15:21 INFO - PID 3734 | RSS: Main: 171798528 11:15:21 INFO - PID 3734 | 11:18:23 INFO - PID 3734 | Cycle 1(1): loaded http://localhost:34319/tests/dromaeo/cssquery-ext.html (next: http://localhost:34319/tests/dromaeo/cssquery-jquery.html) 11:18:24 INFO - PID 3734 | RSS: Main: 170799104 11:18:24 INFO - PID 3734 | 11:21:26 INFO - PID 3734 | Cycle 1(1): loaded http://localhost:34319/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34319/tests/dromaeo/cssquery-mootools.html) 11:21:26 INFO - PID 3734 | RSS: Main: 172793856 11:21:26 INFO - PID 3734 | 11:24:28 INFO - PID 3734 | Cycle 1(1): loaded http://localhost:34319/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34319/tests/dromaeo/cssquery-prototype.html) 11:24:28 INFO - PID 3734 | RSS: Main: 171102208 11:24:28 INFO - PID 3734 | 11:27:32 INFO - PID 3734 | Cycle 1(1): loaded http://localhost:34319/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34319/tests/dromaeo/cssquery-yui.html) 11:27:33 INFO - PID 3734 | RSS: Main: 172441600 11:27:33 INFO - PID 3734 | 11:30:34 INFO - PID 3734 | Cycle 1(1): loaded http://localhost:34319/tests/dromaeo/cssquery-yui.html (next: http://localhost:34319/tests/dromaeo/cssquery-dojo.html) 11:30:35 INFO - PID 3734 | RSS: Main: 175034368 11:30:35 INFO - PID 3734 | 11:30:35 INFO - PID 3734 | __start_tp_report 11:30:35 INFO - PID 3734 | _x_x_mozilla_page_load 11:30:35 INFO - PID 3734 | _x_x_mozilla_page_load_details 11:30:35 INFO - PID 3734 | |i|pagename|runs| 11:30:35 INFO - PID 3734 | |0;dojo.html;3244.821534815584;3296.439605267105;3304.966950330496;3329.5671562696853;3358.294758100799;6194.442500174989;6366.5861718988235;6373.394527519884;6421.678916054196;6459.51553633477;6432.614043157414;6439.678016099199;6472.5792823466445;6508.2515510716285;6525.869482610345;5716.828495145152;5856.912146317787;5905.055191169414;5932.317783454893;5964.19483369746;5813.215215945836;5826.883462330751;5901.3508514063415;5915.852103697421;5935.317438494585;5820.82537523875;5849.736761845727;5912.142739302799;5926.674032928187;5940.7920722774925;5693.629914055573;5835.941640583625;5909.084091965752;5921.111833225008;5947.821565353046;5748.8850222995725;5755.827325180251;5803.419658034163;5805.274340707411;5832.708364581754;6363.681815909186;6411.551191416603;6417.582857114273;6454.741810327581;6459.386358295955;6831.555948863308;6838.076859623937;6845.863082738367;6898.275681053467;6944;6902.758403455905;6955.234924158389;6963.303669633046;6971.233164351917;6990.405815505637;6263.060540918898;6343.904841427382;6347.0479428086155;6354.682265886687;6360.236771587439;6807.251202367835;6891.000804883364;6915.585064896122;7010.263922288188;7011.859762804817;6538.705758240891;6574.211094668574;6578.967105164444;6596;6609.6695165241545;6647.202335719745;6706.362895524917;6725.529212955144;6726.865462690719;6840.726370945106;6825.48808839339;6848.623325717033;6849.554778939353;6857.657117144123;6866;6757.358050985148;6790;6847.726090956306;6873.518853680294;6917.377436030782;5373.650712703662;5413.2692086568595;5430;5487.2317875497465;5509.586780991442;4657.46439159501;4669.813207471663;4764.595009424238;4797.112534181188;4830.830920917751;6063.181470501514;6076.5442591805795;6081.239845019372;6102.572819902653;6107.725152368154;6867.381935625817;6871.965640171868;6951.200611929592;6966.233714291424;6970.65146742671;6007;6026.800153257548;6092.147099406086;6105.633661980295;6109.75560977556;5830.7084645767545;5915.231019967377;5934.673592952429;5993.670348130808;5995.61028533144;6746.4265537429865;6757.898631520531;6779;6787.321267873173;6789.25318214996;6780.966095169492;6904.723811047502;6934.930650693428;6942.548734332252;6981.75563855283;6682;6709.094272273181;6780.762673306411;6796.150481189851;6814.420774234048;6500.707468164039;6621.668916554249;6742.6628668567355;6766.391024807791;6802.14973128359;6837.35045170708;6868.107146070979;6939.132608423947;6960.860782784417;6964.303569642995;6653.567518111307;6665.800025999228;6731.427828634621;6732.697028633625;6733.797986060426;6631.270560238467;6632.2372927114;6729.798106056826;6764.255931847394;6777.254502004874;6458.418742313214;6588.868222635425;6593.868122637425;6681;6689.130413046273;6618.007298905202;6646.0695502628705;6661.866762664623;6709.7316107355155;6712.630805305755;6389.616623002635;6473.093766872547;6473.805785826433;6477.481801455778;6479.902801457888 11:30:35 INFO - PID 3734 | |1;ext.html;812.0945146162028;832.9666813327467;854.4616891358444;882.3735148044888;883.3463237204467;41111.79444102779;41985;42055.36916946248;42136.57863421365;42356;38451.23097538047;38520.61479385205;38688.41967370485;38717.806410967976;38725.80637096811;6965.303469653032;7079.61062141582;7087.751928682497;7111.040009598715;7115.608641524714;7582.734604288851;7832.647530861096;7839.921600783976;7840.647170877296;7850.489718168329;7813.296803287703;7863.056433228021;7878.251566101211;7878.290953814156;7880.172581878877;7619.123800762928;7791.415643826707;7872.094709108468;7875.645595948196;7879.960600196962;7729.34300584451;7779.688812447495;7783.299503044696;7799.337056350217;7812.843743125162;38528.42207366892;38851.611483885084;38926.61073389286;39040.21919561593;39099.21801563981;3538.327717733648;3585.103724068983;3585.8386372613295;3585.9641403585892;3586.0317714217017;32361.35277294441;32410.70357185733;32417.6758232417;32426.67573324284;32471.188220294447;5078.339815823956;5244;5246.527812496894;5252.553532949704;5261.500157485033;189860;191728;192312;192459;199680;49425.25862112071;49468.50531494711;49630;49654.25518617224;49720.25419618709;51227.23159152616;51332.48667513352;51406.429678515924;51428;51494.22758658623;14622.926885365505;14761.040532365361;14776.113433194043;14822.703545929022;14932.552023439313;11937.522499100112;11946.044316454663;11950.88049119515;11958.402079896145;11968.880311196777;14127.223002734949;14150.433982640785;14184.503542375967;14316.141031538142;14317.64205894861;5645.68948707825;5660.5471562274915;5744.684042377709;5780.710964451845;5781.072517486725;971.2327261463506;1004.3973615830444;1011.9696409107738;1019.5361110694616;1021.5352014833232;22922.42693932665;23036.308910732703;23069.88465057664;23189.7681023191;23338.64992025121;1096.8793432722393;1099.9780004399868;1100.147385776014;1110.9833352499718;1113.8551988241638;12059.758804823854;12203.816942745865;12242.326672032945;12250.571230006906;12305.138640295272;230692;230719;232140;232213;232295;54454.455455444935;54504.18243726347;54670;54710;54798.452015479335;1417.836948750907;1433.3048471491318;1434.3115304653825;1440.1359184489431;1446.9855301447062;22420.439489012904;22614.773852261926;22676.206332778274;22744.886275569177;22901.88549057244;37984;38088.61911380962;38099.80950095232;38145;38176.236475270896;192032;192704;193074;193096;193472;30714.84642576862;33063.50404743979;33974.49038264478;35292;35303.646963531064;43018.35472467853;44450.555494445936;44694.3295850569;44724;44763.77618111888;31654.525182122747;31675.52486712747;31731.04806855798;32510.674893250765;32651.18372040718;31539.14080312028;31665.366692666477;31845.840770796924;31910.84044579762;32516.674833251363;36157.81921090378;36158.4576231362;36597.634023659426;36600.45099323459;36817.631823682495;31163.688363116984;31873.840630796698;31916.840415798702;32126.83936580302;32224.83887580547;23161;23174.073037078328;23377.298681039596;23846.52306953886;23948.40128996789 11:30:35 INFO - PID 3734 | |2;jquery.html;576.7404667899443;583.5731636149613;584.5265335078585;592.4993380593397;594.5629961977946;22175.667364989516;23006.53986920263;23086.769132308673;23129.421764455878;24237.272881813573;24510.632340514905;25145.87427062867;25188.874055629698;25225.369365765866;25307.240782776502;6820.079289295943;6962.686679099427;6973.6513174341335;6977.267386924376;6978.930210697904;6134.079888016789;6471.352864713538;6768.8307792305095;6793.286704895989;6810.557313774613;6761.8309542261595;6764.6617669116595;6765.086713293692;6767.796966091;6768.695408706595;6750.493712971523;6751.763688270887;6757.391834734848;6759.526833121683;6761.966190169018;6257.780977665805;6261.06084087386;6275.215598050244;6276.560640755149;6279.37206279373;28593.428131437257;29429.26426839346;29430;29440;29692.8515357424;2005.5587770690424;2034.471037530238;2035.7862424445368;2036.256766280312;2036.4399790057705;19871.503212419804;20488.38534843957;20489.38531844047;20497.897510512503;20501.28245511415;2395.221552995266;2414.2877851033986;2465.963010554843;2466.0382450844186;2475.616279476684;127984;130292;130404.34797826046;131130;131679;14693.338799754038;14697.309809371845;15118.522739769915;15319.693606127816;15674.68650626981;22944.196953106562;22950.770492295196;22998;23023.19418820333;23033.07867685274;9395.906040939502;9496.19282361007;9558.562566545486;9636.855447168298;9730.172935300438;7295.781126566211;8483.703070392507;8592.398532102818;8654.78363040929;8706.782330441663;7950.920490795018;9060.682876099438;9077.364584479155;9158.67944621935;9323.953380233192;2613.3989182488135;2622.2002289301563;2668.266226787649;2706.323419145214;2819.1542537238747;982.189693502863;982.2093214961882;991.4249735153738;999.6701088640731;1007.5314978535016;19708.40874773759;19802.405927822187;19871.205151794056;20089.379024793387;20401.48996275105;1043.3062013760916;1048.926575139733;1061.0927656853435;1062.436908438529;1067.514281002142;10837.945810270898;10926.836097458385;11005.779884402267;11112.495204117771;11161.497732602053;452163;464243;467364;472769;483415;106788;110694;112644;112648;114370;1172.9061675065975;1179.127445690183;1183.5739133911784;1191.9106067045007;1193.1945936492832;17575.384861529787;17649.91175044168;17705.20326585281;17779.644407112042;17835.197416116047;58225.708871457064;60079.699601501714;60090.699546501986;60987.39012609995;61863;67329.32670673427;75360.24639753532;78794.21205788098;79437.60281198558;79732.60133699294;11932.522699091938;12382;12908.935455322664;14567.198804065454;15046.322915469049;18902.7164592534;23568.175113870933;23584.29247122589;23595;23885;18673.346432874783;18673.813261867752;18905.527361816065;18976.620467590295;18995.145218465477;16878.324867005183;16889.493315200565;17412.82587174112;17456.91271543634;17918.372856949944;19526.707099393803;19571.70642440393;19691.803081968996;19999.500012499804;20013.199472020955;14248.216348100954;14628.561143165296;14930.328135234158;14932.178730169944;14989.775153372926;18837.623247535248;18980.620387592448;19088.904555477133;19090.618187636446;19198.13608387598 11:30:35 INFO - PID 3734 | |3;mootools.html;1332.2805684930136;1356.9619241280423;1380.6479347766324;1381.2748307138745;1388.8263967004125;14718.926405367958;14863.777043344358;15496.225188740575;15520.456784012562;15602.843971560282;15863.603409914758;16202.918985405086;16219.513414597552;16228.675426491493;16230;2616.699079605851;2789.4560560690675;2850.9002184923534;2855.771538276933;2857.3570946536965;2794.6506686664165;2824.915252542427;2826.618406515125;2826.618406515125;2826.915192544227;2748.8350698958025;2757.1590664847213;2790.218738753142;2800.1179628417085;2805.298675331167;2568.460623269116;2568.6018667106628;2592.5333439980795;2594.338443696864;2597.571400718879;2679.5310820606314;2706.8105232633725;2707.187843646918;2710.6476158099517;2711.3221694576355;15094.320755566026;15247.085174889542;15466.226688665634;15474.690506189925;15504.379824806994;7791.532508049535;8032.638531266107;8041.437099403044;8070.757877263692;8079.515229086215;5292.153255479105;5408.5402740766685;5499.670019798825;5522.088855338864;5541.196526503634;1944.222311075567;1953.8046195380348;1960.3334866145578;1993.3720877923552;2008.8392928565827;27058.052968146218;27258.5911211332;27290.31774205641;27292.044778432857;27318.5902211467;6499.3175716549085;6502.382273683992;6579.638119903451;6776.356246156607;6789.524733268624;17656.382026629006;17661.7350739739;17668.11659417024;17668.646627067388;17682.11589420524;7355.485116041826;7615.5430674159725;7619.657115429819;7623.199564045806;7624.771256862303;6971.058907047483;7057.153141623038;7132.572045677276;7153.213146553875;7158.713651453988;5345.492178243061;5467.125259958388;5477.808276710296;5492.368377636543;5522.834314970557;1590.0618635005403;1591.1964457948893;1605.783219265384;1606.068480281434;1618.1504710027095;874.0996773323487;904.8461761500561;905.538175530471;917.9541022948825;920.7513971227731;7866.528008319405;7871.48835325702;7967.601619918981;8015.078265999485;8022.759317220492;718.7484380466794;979.4319294808994;1002.7743757654615;1008.3647302199568;1009.1472705563787;5039.899202015939;5617.691026993472;5619.325680918234;5666.546676265889;5860.062390017662;21812.672809907865;22489.55020899573;22514.437139071328;22577.322680319616;22676.206332778274;21677.132914683552;22179;22391.440213994454;22641.2075577354;22718.09127634876;11667.183297169116;11816.704582385337;11829.645110646694;11915.821262681067;11927.522899083939;8059.556724380215;8589;8847.823043538965;8896.644134234559;8909.73270801877;18780.248790048245;19001;19084;19162.233510659975;19208.13563389679;19353.742006769517;19639.214431422584;19639.901800490905;19687.90156049268;19831.801681982997;11547.826782598437;11897.40512974365;11986.220895641756;12219.205751626116;12466.376681166086;13497.86502134966;13583.86416135826;13621.114627549177;13623.591292261248;13641.454341826216;11082.722931926766;11095.889041109485;11170.888291116984;11235.15736319763;11356.886431135583;11071;11113.666590002313;11198.83201751958;11214.607488737855;11431.142664300045;9198.356115071882;9426.905730942603;9427.858582121136;9436.197923176333;9439.433633981984;7226.819329516594;7231.16841563227;7249.311315425026;7260;7294.598797066213;7260.346568808833;7263.128424589083;7297.452691048086;7306.525075870051;7374.815629609303 11:30:35 INFO - PID 3734 | |4;prototype.html;492.7289990505226;504.11276153969004;510.1124044163155;515.0960065085775;537.8440252326825;6381.266154392246;6395.840103997402;6397.136386587815;6469.353064693529;6500.38246366595;6121.796153384778;6235.625862448256;6272.623642581449;6296.842578935529;6320.304766475684;4988.65079444439;5070.188769796833;5218.791248350061;5227.47725227478;5233.581313494911;5049.596032317424;5093.719845408501;5100.566451851597;5117.923231151536;5118.820841270556;4969.279454479099;5026.395568940641;5039.496050394968;5068.797248110071;5073.873153171164;4969.304297398367;5046.0160268747795;5073.873153171164;5087.56755675768;5107.438181799999;4507.1211113832815;4578.519255478193;4589.334546490773;4596.241620132674;4601;6123.601965872204;6179.5674302798825;6256.468200202989;6296.748130074791;6352.205974253218;5696.487316141525;5705.515031222351;5745.822106468164;5787.536997040269;5810.302763668345;6590.967045164792;6636.170478690164;6637.535372523926;6662.0340050692375;6705;4928.950710492921;4956.2565615157655;4970.229614409773;4974.925376119361;4988.975055124737;6617.834554136137;6803.557768745065;6843.247242803288;7000.929990700079;7085.43316534676;5022.522860328263;5062.873428164326;5085.644004919694;5106.055379754757;5112.233165025276;5086.567641750418;5124.256982737482;5148.99189316167;5164.509371609691;5176.378834539879;5739.770409183586;5760.251167348218;5769.249997500298;5786.103154011135;5823.272090988627;6638.701258443285;6718.899216511756;6750.898736518956;6759.831004224934;6768.175980570962;1784.3754685860106;1792.345793785259;1794.3091909614632;1794.9820501795075;1802.6394721055842;1177.534873724874;1230.1880758699215;1243.0863315463127;1244.440001999104;1246.6135497995651;5916.792912248051;5927.865968251426;5962.34414214436;5968.492678122321;6051.697415129226;6815.659217039228;6911.447084233249;6922.688479018456;6961.965190174017;6983.511154219156;5975.223220981332;5989.341172471025;6002.789902353396;6005.309389420186;6023.728932197974;3648.872289469856;3653.3789255826573;3681.7238707097076;3706.258748250361;3707.5180226570915;6390.384349918205;6609.867802644017;6655.567388119756;6671.866562668816;6716.832079197961;6878.3465570770695;6964.895526567106;7040.718371265194;7045.542039767399;7069.399101076466;6517.543771935919;6666.766663166766;6672.499562532927;6688.7324507019175;6710.127683401127;6847.863042739217;6849.691763870538;6864.7940561783225;6879.245792322926;6914.792556223321;6834;6838.521303508706;6861.313868613099;6873.793786186422;6918.5502942308585;6645.468362531083;6667.4996876171435;6684.4318232950745;6688.163979502562;6701.899471507833;5046.747662616928;5073.365829271341;5108.66793658411;5113.744312784272;5121.948780512147;6547.508936829661;6730.798076057726;6813.89779153323;6869.385694361921;6917.443575195541;6509.804705858832;6525.3800888915475;6537.82175843823;6562.489068348411;6655.866882662222;6431.649353635602;6531.412172904462;6578;6596.472282217315;6607.735690572324;6425.871482570229;6440.32376600469;6570.638614876228;6576.2766095730385;6590.143281373583;6616.702248398929;6661.234772785313;6663.46692264608;6696.0960270362875;6753.797386078426;6391.552591318563;6473.320301368289;6477.352264773485;6498.512611554058;6516.543841931019 11:30:35 INFO - PID 3734 | |5;yui.html;899.6086702284507;903.8463461211593;909.3589019741081;919.3013309884494;925.1303774452015;20648.277310294143;24176.395590110256;24176.87911560442;24231.27306180813;24249.63625545616;20884;21841.563168736615;21842.453938651503;21868.562628747415;22072.558548829013;965.4159233663638;987.5555999800083;987.8715766950287;988.9456079915602;990.0396615283164;892.4823602310644;929.5770424456856;989.737719504332;994.666786626481;996.093554865073;1047.4082143588887;1047.528612124543;1051.7475805806628;1053.2995557953952;1055.37205362809;1031.8194315994672;1038.833786594145;1038.8493668418037;1041.2398948767404;1041.2919214933843;762;762.0626629246003;762.2758379539459;762.6339357108619;763.3511515212081;19133.234670613158;19177.32879349216;19370.32203872872;19572.119254633435;20345.593088138303;21774.891125544273;21779;22035.889820550954;22225.333240002827;22254;15684.843151568452;15823.050616962904;15941.601459963595;15986.040837549785;16089.356425742957;3616.27674465108;3666.32173047987;3667.523221981152;3668.248009158116;3670.137517683342;127513;127839.36080319632;128816.35591821981;132055.33972330173;132929;16044.839551604335;16317.42888998903;16412.261448234858;16484.505464836075;16673;30139.09582712522;30747;30943.535846962313;30989;31141.532877006863;8265.95867020661;8276.379271554657;8327.292180164754;8367.581620918929;8371.079181290053;4106.425100485934;4193.895152621209;4208;4223.5864168664575;4247.490301163818;5255.500727430888;5336.653117547347;5359.249705041298;5378.2470454136455;5383.623146379716;942.9669961551313;965.6234068713208;989.1345073061071;991.2020823237219;991.4299277915084;654.6628486329544;666.4135560706644;690.4165979747106;702.0697575712202;709;11554;11667.241629294069;11728.237664551776;12255.448504817305;12876.61370158878;670.3196255800269;688.9379955804002;706.6078326528826;714.1965289049818;730.1493759769915;4689.742064186503;4753.643476739258;4820.903581928342;4866.586340161055;4868.123737727172;114614;114935;116501;117095.41452292685;117152.41423792997;98236;100045.49977250067;102903;103020.48489757653;105678;89183.55408223048;92207.53896230475;93000.06999929914;93491.5325423355;94087;10327;10453.634122805664;10473.895261047292;10579.15366770641;10628.202884783517;31721.66922473107;40824.79587602162;42177.78911105425;43039.56960430356;44683.32975005443;73449.6327518359;73710.63144684242;73742.26257737353;74447;74914.62542687252;18521.444356669323;18802.811971880106;19000.809991899903;19019.524511887314;19085.141168647722;19028.33400830964;19591.31430399929;19608.215671372986;20749.58500830005;20869.895650521652;17679.646407072043;17682.292708291523;17689.557761056076;17699.911500442417;17883.821161788735;18942.621147577247;19003.90498047501;19083.236670533024;19432;19691.507712307306;17020.744688829924;17939.910300448413;18184.181711823265;18314.725279121092;18975.33586324472;12805.8079128815;13823.654408639864;13943.651408714863;14309.212993285053;14537.200453975132;13023.674408139872;13144.60566183016;13200.537981170997;13268.270245136224;13457.932710336385 11:30:35 INFO - PID 3734 | __end_tp_report 11:30:35 INFO - PID 3734 | __start_cc_report 11:30:35 INFO - PID 3734 | _x_x_mozilla_cycle_collect,343 11:30:35 INFO - PID 3734 | __end_cc_report 11:30:35 INFO - PID 3734 | __startTimestamp1504290635088__endTimestamp 11:30:35 INFO - PID 3734 | 11:30:35 INFO - PID 3734 | ------- Summary: start ------- 11:30:35 INFO - PID 3734 | Number of tests: 6 11:30:35 INFO - PID 3734 | 11:30:35 INFO - PID 3734 | [#0] dojo.html Cycles:165 Average:6312.91 Median:6538.71 stddev:736.32 (11.3%) stddev-sans-first:698.13 11:30:35 INFO - PID 3734 | Values: 3244.8 3296.4 3305.0 3329.6 3358.3 6194.4 6366.6 6373.4 6421.7 6459.5 6432.6 6439.7 6472.6 6508.3 6525.9 5716.8 5856.9 5905.1 5932.3 5964.2 5813.2 5826.9 5901.4 5915.9 5935.3 5820.8 5849.7 5912.1 5926.7 5940.8 5693.6 5835.9 5909.1 5921.1 5947.8 5748.9 5755.8 5803.4 5805.3 5832.7 6363.7 6411.6 6417.6 6454.7 6459.4 6831.6 6838.1 6845.9 6898.3 6944.0 6902.8 6955.2 6963.3 6971.2 6990.4 6263.1 6343.9 6347.0 6354.7 6360.2 6807.3 6891.0 6915.6 7010.3 7011.9 6538.7 6574.2 6579.0 6596.0 6609.7 6647.2 6706.4 6725.5 6726.9 6840.7 6825.5 6848.6 6849.6 6857.7 6866.0 6757.4 6790.0 6847.7 6873.5 6917.4 5373.7 5413.3 5430.0 5487.2 5509.6 4657.5 4669.8 4764.6 4797.1 4830.8 6063.2 6076.5 6081.2 6102.6 6107.7 6867.4 6872.0 6951.2 6966.2 6970.7 6007.0 6026.8 6092.1 6105.6 6109.8 5830.7 5915.2 5934.7 5993.7 5995.6 6746.4 6757.9 6779.0 6787.3 6789.3 6781.0 6904.7 6934.9 6942.5 6981.8 6682.0 6709.1 6780.8 6796.2 6814.4 6500.7 6621.7 6742.7 6766.4 6802.1 6837.4 6868.1 6939.1 6960.9 6964.3 6653.6 6665.8 6731.4 6732.7 6733.8 6631.3 6632.2 6729.8 6764.3 6777.3 6458.4 6588.9 6593.9 6681.0 6689.1 6618.0 6646.1 6661.9 6709.7 6712.6 6389.6 6473.1 6473.8 6477.5 6479.9 11:30:35 INFO - PID 3734 | 11:30:35 INFO - PID 3734 | [#1] ext.html Cycles:180 Average:37588.32 Median:3585.47 stddev:53598.50 (1494.9%) stddev-sans-first:53677.73 11:30:35 INFO - PID 3734 | Values: 812.1 833.0 854.5 882.4 883.3 41111.8 41985.0 42055.4 42136.6 42356.0 38451.2 38520.6 38688.4 38717.8 38725.8 6965.3 7079.6 7087.8 7111.0 7115.6 7582.7 7832.6 7839.9 7840.6 7850.5 7813.3 7863.1 7878.3 7878.3 7880.2 7619.1 7791.4 7872.1 7875.6 7880.0 7729.3 7779.7 7783.3 7799.3 7812.8 38528.4 38851.6 38926.6 39040.2 39099.2 3538.3 3585.1 3585.8 3586.0 3586.0 32361.4 32410.7 32417.7 32426.7 32471.2 5078.3 5244.0 5246.5 5252.6 5261.5 189860.0 191728.0 192312.0 192459.0 199680.0 49425.3 49468.5 49630.0 49654.3 49720.3 51227.2 51332.5 51406.4 51428.0 51494.2 14622.9 14761.0 14776.1 14822.7 14932.6 11937.5 11946.0 11950.9 11958.4 11968.9 14127.2 14150.4 14184.5 14316.1 14317.6 5645.7 5660.5 5744.7 5780.7 5781.1 971.2 1004.4 1012.0 1019.5 1021.5 22922.4 23036.3 23069.9 23189.8 23338.6 1096.9 1100.0 1100.1 1111.0 1113.9 12059.8 12203.8 12242.3 12250.6 12305.1 230692.0 230719.0 232140.0 232213.0 232295.0 54454.5 54504.2 54670.0 54710.0 54798.5 1417.8 1433.3 1434.3 1440.1 1447.0 22420.4 22614.8 22676.2 22744.9 22901.9 37984.0 38088.6 38099.8 38145.0 38176.2 192032.0 192704.0 193074.0 193096.0 193472.0 30714.8 33063.5 33974.5 35292.0 35303.6 43018.4 44450.6 44694.3 44724.0 44763.8 31654.5 31675.5 31731.0 32510.7 32651.2 31539.1 31665.4 31845.8 31910.8 32516.7 36157.8 36158.5 36597.6 36600.5 36817.6 31163.7 31873.8 31916.8 32126.8 32224.8 23161.0 23174.1 23377.3 23846.5 23948.4 11:30:35 INFO - PID 3734 | 11:30:35 INFO - PID 3734 | [#2] jquery.html Cycles:180 Average:34102.21 Median:23348.80 stddev:78914.50 (338.0%) stddev-sans-first:79095.73 11:30:35 INFO - PID 3734 | Values: 576.7 583.6 584.5 592.5 594.6 22175.7 23006.5 23086.8 23129.4 24237.3 24510.6 25145.9 25188.9 25225.4 25307.2 6820.1 6962.7 6973.7 6977.3 6978.9 6134.1 6471.4 6768.8 6793.3 6810.6 6761.8 6764.7 6765.1 6767.8 6768.7 6750.5 6751.8 6757.4 6759.5 6762.0 6257.8 6261.1 6275.2 6276.6 6279.4 28593.4 29429.3 29430.0 29440.0 29692.9 2005.6 2034.5 2035.8 2036.3 2036.4 19871.5 20488.4 20489.4 20497.9 20501.3 2395.2 2414.3 2466.0 2466.0 2475.6 127984.0 130292.0 130404.3 131130.0 131679.0 14693.3 14697.3 15118.5 15319.7 15674.7 22944.2 22950.8 22998.0 23023.2 23033.1 9395.9 9496.2 9558.6 9636.9 9730.2 7295.8 8483.7 8592.4 8654.8 8706.8 7950.9 9060.7 9077.4 9158.7 9324.0 2613.4 2622.2 2668.3 2706.3 2819.2 982.2 982.2 991.4 999.7 1007.5 19708.4 19802.4 19871.2 20089.4 20401.5 1043.3 1048.9 1061.1 1062.4 1067.5 10837.9 10926.8 11005.8 11112.5 11161.5 452163.0 464243.0 467364.0 472769.0 483415.0 106788.0 110694.0 112644.0 112648.0 114370.0 1172.9 1179.1 1183.6 1191.9 1193.2 17575.4 17649.9 17705.2 17779.6 17835.2 58225.7 60079.7 60090.7 60987.4 61863.0 67329.3 75360.2 78794.2 79437.6 79732.6 11932.5 12382.0 12908.9 14567.2 15046.3 18902.7 23568.2 23584.3 23595.0 23885.0 18673.3 18673.8 18905.5 18976.6 18995.1 16878.3 16889.5 17412.8 17456.9 17918.4 19526.7 19571.7 19691.8 19999.5 20013.2 14248.2 14628.6 14930.3 14932.2 14989.8 18837.6 18980.6 19088.9 19090.6 19198.1 11:30:35 INFO - PID 3734 | 11:30:35 INFO - PID 3734 | [#3] mootools.html Cycles:180 Average:9491.75 Median:14882.43 stddev:6881.69 (46.2%) stddev-sans-first:6873.69 11:30:35 INFO - PID 3734 | Values: 1332.3 1357.0 1380.6 1381.3 1388.8 14718.9 14863.8 15496.2 15520.5 15602.8 15863.6 16202.9 16219.5 16228.7 16230.0 2616.7 2789.5 2850.9 2855.8 2857.4 2794.7 2824.9 2826.6 2826.6 2826.9 2748.8 2757.2 2790.2 2800.1 2805.3 2568.5 2568.6 2592.5 2594.3 2597.6 2679.5 2706.8 2707.2 2710.6 2711.3 15094.3 15247.1 15466.2 15474.7 15504.4 7791.5 8032.6 8041.4 8070.8 8079.5 5292.2 5408.5 5499.7 5522.1 5541.2 1944.2 1953.8 1960.3 1993.4 2008.8 27058.1 27258.6 27290.3 27292.0 27318.6 6499.3 6502.4 6579.6 6776.4 6789.5 17656.4 17661.7 17668.1 17668.6 17682.1 7355.5 7615.5 7619.7 7623.2 7624.8 6971.1 7057.2 7132.6 7153.2 7158.7 5345.5 5467.1 5477.8 5492.4 5522.8 1590.1 1591.2 1605.8 1606.1 1618.2 874.1 904.8 905.5 918.0 920.8 7866.5 7871.5 7967.6 8015.1 8022.8 718.7 979.4 1002.8 1008.4 1009.1 5039.9 5617.7 5619.3 5666.5 5860.1 21812.7 22489.6 22514.4 22577.3 22676.2 21677.1 22179.0 22391.4 22641.2 22718.1 11667.2 11816.7 11829.6 11915.8 11927.5 8059.6 8589.0 8847.8 8896.6 8909.7 18780.2 19001.0 19084.0 19162.2 19208.1 19353.7 19639.2 19639.9 19687.9 19831.8 11547.8 11897.4 11986.2 12219.2 12466.4 13497.9 13583.9 13621.1 13623.6 13641.5 11082.7 11095.9 11170.9 11235.2 11356.9 11071.0 11113.7 11198.8 11214.6 11431.1 9198.4 9426.9 9427.9 9436.2 9439.4 7226.8 7231.2 7249.3 7260.0 7294.6 7260.3 7263.1 7297.5 7306.5 7374.8 11:30:35 INFO - PID 3734 | 11:30:35 INFO - PID 3734 | [#4] prototype.html Cycles:180 Average:5616.64 Median:6284.69 stddev:1573.01 (25.0%) stddev-sans-first:1529.68 11:30:35 INFO - PID 3734 | Values: 492.7 504.1 510.1 515.1 537.8 6381.3 6395.8 6397.1 6469.4 6500.4 6121.8 6235.6 6272.6 6296.8 6320.3 4988.7 5070.2 5218.8 5227.5 5233.6 5049.6 5093.7 5100.6 5117.9 5118.8 4969.3 5026.4 5039.5 5068.8 5073.9 4969.3 5046.0 5073.9 5087.6 5107.4 4507.1 4578.5 4589.3 4596.2 4601.0 6123.6 6179.6 6256.5 6296.7 6352.2 5696.5 5705.5 5745.8 5787.5 5810.3 6591.0 6636.2 6637.5 6662.0 6705.0 4929.0 4956.3 4970.2 4974.9 4989.0 6617.8 6803.6 6843.2 7000.9 7085.4 5022.5 5062.9 5085.6 5106.1 5112.2 5086.6 5124.3 5149.0 5164.5 5176.4 5739.8 5760.3 5769.2 5786.1 5823.3 6638.7 6718.9 6750.9 6759.8 6768.2 1784.4 1792.3 1794.3 1795.0 1802.6 1177.5 1230.2 1243.1 1244.4 1246.6 5916.8 5927.9 5962.3 5968.5 6051.7 6815.7 6911.4 6922.7 6962.0 6983.5 5975.2 5989.3 6002.8 6005.3 6023.7 3648.9 3653.4 3681.7 3706.3 3707.5 6390.4 6609.9 6655.6 6671.9 6716.8 6878.3 6964.9 7040.7 7045.5 7069.4 6517.5 6666.8 6672.5 6688.7 6710.1 6847.9 6849.7 6864.8 6879.2 6914.8 6834.0 6838.5 6861.3 6873.8 6918.6 6645.5 6667.5 6684.4 6688.2 6701.9 5046.7 5073.4 5108.7 5113.7 5121.9 6547.5 6730.8 6813.9 6869.4 6917.4 6509.8 6525.4 6537.8 6562.5 6655.9 6431.6 6531.4 6578.0 6596.5 6607.7 6425.9 6440.3 6570.6 6576.3 6590.1 6616.7 6661.2 6663.5 6696.1 6753.8 6391.6 6473.3 6477.4 6498.5 6516.5 11:30:35 INFO - PID 3734 | 11:30:35 INFO - PID 3734 | [#5] yui.html Cycles:180 Average:24514.39 Median:21952.23 stddev:33716.64 (153.6%) stddev-sans-first:33764.59 11:30:35 INFO - PID 3734 | Values: 899.6 903.8 909.4 919.3 925.1 20648.3 24176.4 24176.9 24231.3 24249.6 20884.0 21841.6 21842.5 21868.6 22072.6 965.4 987.6 987.9 988.9 990.0 892.5 929.6 989.7 994.7 996.1 1047.4 1047.5 1051.7 1053.3 1055.4 1031.8 1038.8 1038.8 1041.2 1041.3 762.0 762.1 762.3 762.6 763.4 19133.2 19177.3 19370.3 19572.1 20345.6 21774.9 21779.0 22035.9 22225.3 22254.0 15684.8 15823.1 15941.6 15986.0 16089.4 3616.3 3666.3 3667.5 3668.2 3670.1 127513.0 127839.4 128816.4 132055.3 132929.0 16044.8 16317.4 16412.3 16484.5 16673.0 30139.1 30747.0 30943.5 30989.0 31141.5 8266.0 8276.4 8327.3 8367.6 8371.1 4106.4 4193.9 4208.0 4223.6 4247.5 5255.5 5336.7 5359.2 5378.2 5383.6 943.0 965.6 989.1 991.2 991.4 654.7 666.4 690.4 702.1 709.0 11554.0 11667.2 11728.2 12255.4 12876.6 670.3 688.9 706.6 714.2 730.1 4689.7 4753.6 4820.9 4866.6 4868.1 114614.0 114935.0 116501.0 117095.4 117152.4 98236.0 100045.5 102903.0 103020.5 105678.0 89183.6 92207.5 93000.1 93491.5 94087.0 10327.0 10453.6 10473.9 10579.2 10628.2 31721.7 40824.8 42177.8 43039.6 44683.3 73449.6 73710.6 73742.3 74447.0 74914.6 18521.4 18802.8 19000.8 19019.5 19085.1 19028.3 19591.3 19608.2 20749.6 20869.9 17679.6 17682.3 17689.6 17699.9 17883.8 18942.6 19003.9 19083.2 19432.0 19691.5 17020.7 17939.9 18184.2 18314.7 18975.3 12805.8 13823.7 13943.7 14309.2 14537.2 13023.7 13144.6 13200.5 13268.3 13457.9 11:30:35 INFO - PID 3734 | -------- Summary: end -------- 11:30:35 INFO - PID 3734 | 11:30:35 INFO - TEST-INFO | 3734: exit 0 11:30:35 INFO - TEST-OK | dromaeo_css | took 1112360ms 11:30:35 INFO - TEST-START | kraken 11:30:35 INFO - Initialising browser for kraken test... 11:30:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34319/getInfo.html -profile /tmp/tmpOvMc6E/profile 11:30:35 INFO - TEST-INFO | started process 4123 (/builds/slave/test/build/application/firefox/firefox http://localhost:34319/getInfo.html) 11:30:41 INFO - TEST-INFO | 4123: exit 0 11:30:42 INFO - Browser initialized. 11:30:42 INFO - Running cycle 1/1 for kraken test... 11:30:42 INFO - Using env: {'DISPLAY': ':0', 11:30:42 INFO - 'HOME': '/home/cltbld', 11:30:42 INFO - 'JSGC_DISABLE_POISONING': '1', 11:30:42 INFO - 'LANG': 'en_US.UTF-8', 11:30:42 INFO - 'LANGUAGE': 'en_US:en', 11:30:42 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:30:42 INFO - 'LOGNAME': 'cltbld', 11:30:42 INFO - 'MAIL': '/var/mail/cltbld', 11:30:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:30:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:30:42 INFO - 'MOZ_CRASHREPORTER': '1', 11:30:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:42 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:30:42 INFO - 'MOZ_NO_REMOTE': '1', 11:30:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:30:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:42 INFO - 'NO_EM_RESTART': '1', 11:30:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:42 INFO - 'PWD': '/builds/slave/test', 11:30:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:30:42 INFO - 'RUST_BACKTRACE': 'full', 11:30:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:30:42 INFO - 'SHELL': '/bin/bash', 11:30:42 INFO - 'SHLVL': '1', 11:30:42 INFO - 'STYLO_FORCE_ENABLED': '1', 11:30:42 INFO - 'TERM': 'linux', 11:30:42 INFO - 'TMOUT': '86400', 11:30:42 INFO - 'USER': 'cltbld', 11:30:42 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337', 11:30:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:42 INFO - '_': '/tools/buildbot/bin/python'} 11:30:42 INFO - TEST-INFO | started process 4322 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOvMc6E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:30:43 INFO - PID 4322 | 11:30:43 INFO - PID 4322 | (/builds/slave/test/build/application/firefox/firefox:4374): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:30:43 INFO - PID 4322 | 11:30:53 INFO - PID 4322 | RSS: Main: 170868736 11:30:53 INFO - PID 4322 | 11:30:56 INFO - PID 4322 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34319/tests/kraken/driver.html?testName=audio-beat-detection) 11:30:56 INFO - PID 4322 | RSS: Main: 176648192 11:30:56 INFO - PID 4322 | 11:30:59 INFO - PID 4322 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34319/tests/kraken/driver.html?testName=audio-dft) 11:31:00 INFO - PID 4322 | RSS: Main: 176791552 11:31:00 INFO - PID 4322 | 11:31:03 INFO - PID 4322 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34319/tests/kraken/driver.html?testName=audio-fft) 11:31:03 INFO - PID 4322 | RSS: Main: 170381312 11:31:03 INFO - PID 4322 | 11:31:06 INFO - PID 4322 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34319/tests/kraken/driver.html?testName=audio-oscillator) 11:31:06 INFO - PID 4322 | RSS: Main: 171245568 11:31:06 INFO - PID 4322 | 11:31:08 INFO - PID 4322 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34319/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:31:09 INFO - PID 4322 | RSS: Main: 171597824 11:31:09 INFO - PID 4322 | 11:31:12 INFO - PID 4322 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34319/tests/kraken/driver.html?testName=imaging-darkroom) 11:31:13 INFO - PID 4322 | RSS: Main: 174268416 11:31:13 INFO - PID 4322 | 11:31:16 INFO - PID 4322 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34319/tests/kraken/driver.html?testName=imaging-desaturate) 11:31:17 INFO - PID 4322 | RSS: Main: 173920256 11:31:17 INFO - PID 4322 | 11:31:20 INFO - PID 4322 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34319/tests/kraken/driver.html?testName=json-parse-financial) 11:31:20 INFO - PID 4322 | RSS: Main: 174497792 11:31:20 INFO - PID 4322 | 11:31:22 INFO - PID 4322 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34319/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:31:23 INFO - PID 4322 | RSS: Main: 174845952 11:31:23 INFO - PID 4322 | 11:31:24 INFO - PID 4322 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34319/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:31:25 INFO - PID 4322 | RSS: Main: 174292992 11:31:25 INFO - PID 4322 | 11:31:27 INFO - PID 4322 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34319/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:31:28 INFO - PID 4322 | RSS: Main: 171298816 11:31:28 INFO - PID 4322 | 11:31:30 INFO - PID 4322 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34319/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:31:31 INFO - PID 4322 | RSS: Main: 171483136 11:31:31 INFO - PID 4322 | 11:31:34 INFO - PID 4322 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34319/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:31:35 INFO - PID 4322 | RSS: Main: 171651072 11:31:35 INFO - PID 4322 | 11:31:36 INFO - PID 4322 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34319/tests/kraken/driver.html?testName=ai-astar) 11:31:37 INFO - PID 4322 | RSS: Main: 173252608 11:31:37 INFO - PID 4322 | 11:31:37 INFO - PID 4322 | __start_tp_report 11:31:37 INFO - PID 4322 | _x_x_mozilla_page_load 11:31:37 INFO - PID 4322 | _x_x_mozilla_page_load_details 11:31:37 INFO - PID 4322 | |i|pagename|runs| 11:31:37 INFO - PID 4322 | |0;ai-astar;102;109;94;107;109;108;115;110;109;108 11:31:37 INFO - PID 4322 | |1;audio-beat-detection;146;113;145;177;122;145;141;118;167;118 11:31:37 INFO - PID 4322 | |2;audio-dft;165;165;163;162;162;163;167;169;163;161 11:31:37 INFO - PID 4322 | |3;audio-fft;73;74;74;187;75;73;73;87;95;77 11:31:37 INFO - PID 4322 | |4;audio-oscillator;80;80;125;79;79;80;124;80;79;129 11:31:37 INFO - PID 4322 | |5;imaging-gaussian-blur;114;114;115;115;117;115;114;114;114;113 11:31:37 INFO - PID 4322 | |6;imaging-darkroom;150;147;148;148;148;148;148;149;148;147 11:31:37 INFO - PID 4322 | |7;imaging-desaturate;94;94;93;94;94;94;94;98;96;93 11:31:37 INFO - PID 4322 | |8;json-parse-financial;53;54;54;54;54;54;54;53;55;54 11:31:37 INFO - PID 4322 | |9;json-stringify-tinderbox;38;38;38;38;38;38;38;38;38;38 11:31:37 INFO - PID 4322 | |10;stanford-crypto-aes;78;76;76;74;74;79;75;76;74;77 11:31:37 INFO - PID 4322 | |11;stanford-crypto-ccm;123;122;120;135;114;123;116;132;118;159 11:31:37 INFO - PID 4322 | |12;stanford-crypto-pbkdf2;175;170;171;179;176;175;167;168;177;191 11:31:37 INFO - PID 4322 | |13;stanford-crypto-sha256-iterative;63;67;65;67;64;62;62;65;66;62 11:31:37 INFO - PID 4322 | __end_tp_report 11:31:37 INFO - PID 4322 | __start_cc_report 11:31:37 INFO - PID 4322 | _x_x_mozilla_cycle_collect,937 11:31:37 INFO - PID 4322 | __end_cc_report 11:31:37 INFO - PID 4322 | __startTimestamp1504290697053__endTimestamp 11:31:37 INFO - PID 4322 | 11:31:37 INFO - PID 4322 | ------- Summary: start ------- 11:31:37 INFO - PID 4322 | Number of tests: 14 11:31:37 INFO - PID 4322 | 11:31:37 INFO - PID 4322 | [#0] ai-astar Cycles:10 Average:107.10 Median:109.00 stddev:5.59 (5.1%) stddev-sans-first:5.61 11:31:37 INFO - PID 4322 | Values: 102.0 109.0 94.0 107.0 109.0 108.0 115.0 110.0 109.0 108.0 11:31:37 INFO - PID 4322 | 11:31:37 INFO - PID 4322 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:145.00 stddev:21.60 (14.9%) stddev-sans-first:22.77 11:31:37 INFO - PID 4322 | Values: 146.0 113.0 145.0 177.0 122.0 145.0 141.0 118.0 167.0 118.0 11:31:37 INFO - PID 4322 | 11:31:37 INFO - PID 4322 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:2.49 (1.5%) stddev-sans-first:2.62 11:31:37 INFO - PID 4322 | Values: 165.0 165.0 163.0 162.0 162.0 163.0 167.0 169.0 163.0 161.0 11:31:37 INFO - PID 4322 | 11:31:37 INFO - PID 4322 | [#3] audio-fft Cycles:10 Average:88.80 Median:74.50 stddev:35.28 (47.4%) stddev-sans-first:36.95 11:31:37 INFO - PID 4322 | Values: 73.0 74.0 74.0 187.0 75.0 73.0 73.0 87.0 95.0 77.0 11:31:37 INFO - PID 4322 | 11:31:37 INFO - PID 4322 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:79.50 stddev:22.47 (28.3%) stddev-sans-first:23.29 11:31:37 INFO - PID 4322 | Values: 80.0 80.0 125.0 79.0 79.0 80.0 124.0 80.0 79.0 129.0 11:31:37 INFO - PID 4322 | 11:31:37 INFO - PID 4322 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.50 stddev:1.08 (0.9%) stddev-sans-first:1.13 11:31:37 INFO - PID 4322 | Values: 114.0 114.0 115.0 115.0 117.0 115.0 114.0 114.0 114.0 113.0 11:31:37 INFO - PID 4322 | 11:31:37 INFO - PID 4322 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.60 11:31:37 INFO - PID 4322 | Values: 150.0 147.0 148.0 148.0 148.0 148.0 148.0 149.0 148.0 147.0 11:31:37 INFO - PID 4322 | 11:31:37 INFO - PID 4322 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:1.51 (1.6%) stddev-sans-first:1.59 11:31:37 INFO - PID 4322 | Values: 94.0 94.0 93.0 94.0 94.0 94.0 94.0 98.0 96.0 93.0 11:31:37 INFO - PID 4322 | 11:31:37 INFO - PID 4322 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:0.57 (1.1%) stddev-sans-first:0.50 11:31:37 INFO - PID 4322 | Values: 53.0 54.0 54.0 54.0 54.0 54.0 54.0 53.0 55.0 54.0 11:31:37 INFO - PID 4322 | 11:31:37 INFO - PID 4322 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:38.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 11:31:37 INFO - PID 4322 | Values: 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 11:31:37 INFO - PID 4322 | 11:31:37 INFO - PID 4322 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:76.00 stddev:1.73 (2.3%) stddev-sans-first:1.66 11:31:37 INFO - PID 4322 | Values: 78.0 76.0 76.0 74.0 74.0 79.0 75.0 76.0 74.0 77.0 11:31:37 INFO - PID 4322 | 11:31:37 INFO - PID 4322 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:123.00 stddev:13.26 (10.8%) stddev-sans-first:14.02 11:31:37 INFO - PID 4322 | Values: 123.0 122.0 120.0 135.0 114.0 123.0 116.0 132.0 118.0 159.0 11:31:37 INFO - PID 4322 | 11:31:37 INFO - PID 4322 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:175.50 stddev:6.92 (3.9%) stddev-sans-first:7.34 11:31:37 INFO - PID 4322 | Values: 175.0 170.0 171.0 179.0 176.0 175.0 167.0 168.0 177.0 191.0 11:31:37 INFO - PID 4322 | 11:31:37 INFO - PID 4322 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:65.00 stddev:2.00 (3.1%) stddev-sans-first:2.07 11:31:37 INFO - PID 4322 | Values: 63.0 67.0 65.0 67.0 64.0 62.0 62.0 65.0 66.0 62.0 11:31:37 INFO - PID 4322 | -------- Summary: end -------- 11:31:37 INFO - PID 4322 | 11:31:37 INFO - PID 4322 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:31:37 INFO - TEST-INFO | 4322: exit 0 11:31:37 INFO - TEST-OK | kraken | took 61835ms 11:31:37 INFO - SUITE-END | took 1174s 11:31:38 INFO - Completed test suite (00:19:34) 11:31:38 INFO - javascript benchmark 11:31:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8620.12935494881, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3244.821534815584, 3296.439605267105, 3304.966950330496, 3329.5671562696853, 3358.294758100799, 6194.442500174989, 6366.5861718988235, 6373.394527519884, 6421.678916054196, 6459.51553633477, 6432.614043157414, 6439.678016099199, 6472.5792823466445, 6508.2515510716285, 6525.869482610345, 5716.828495145152, 5856.912146317787, 5905.055191169414, 5932.317783454893, 5964.19483369746, 5813.215215945836, 5826.883462330751, 5901.3508514063415, 5915.852103697421, 5935.317438494585, 5820.82537523875, 5849.736761845727, 5912.142739302799, 5926.674032928187, 5940.7920722774925, 5693.629914055573, 5835.941640583625, 5909.084091965752, 5921.111833225008, 5947.821565353046, 5748.8850222995725, 5755.827325180251, 5803.419658034163, 5805.274340707411, 5832.708364581754, 6363.681815909186, 6411.551191416603, 6417.582857114273, 6454.741810327581, 6459.386358295955, 6831.555948863308, 6838.076859623937, 6845.863082738367, 6898.275681053467, 6944.0, 6902.758403455905, 6955.234924158389, 6963.303669633046, 6971.233164351917, 6990.405815505637, 6263.060540918898, 6343.904841427382, 6347.0479428086155, 6354.682265886687, 6360.236771587439, 6807.251202367835, 6891.000804883364, 6915.585064896122, 7010.263922288188, 7011.859762804817, 6538.705758240891, 6574.211094668574, 6578.967105164444, 6596.0, 6609.6695165241545, 6647.202335719745, 6706.362895524917, 6725.529212955144, 6726.865462690719, 6840.726370945106, 6825.48808839339, 6848.623325717033, 6849.554778939353, 6857.657117144123, 6866.0, 6757.358050985148, 6790.0, 6847.726090956306, 6873.518853680294, 6917.377436030782, 5373.650712703662, 5413.2692086568595, 5430.0, 5487.2317875497465, 5509.586780991442, 4657.46439159501, 4669.813207471663, 4764.595009424238, 4797.112534181188, 4830.830920917751, 6063.181470501514, 6076.5442591805795, 6081.239845019372, 6102.572819902653, 6107.725152368154, 6867.381935625817, 6871.965640171868, 6951.200611929592, 6966.233714291424, 6970.65146742671, 6007.0, 6026.800153257548, 6092.147099406086, 6105.633661980295, 6109.75560977556, 5830.7084645767545, 5915.231019967377, 5934.673592952429, 5993.670348130808, 5995.61028533144, 6746.4265537429865, 6757.898631520531, 6779.0, 6787.321267873173, 6789.25318214996, 6780.966095169492, 6904.723811047502, 6934.930650693428, 6942.548734332252, 6981.75563855283, 6682.0, 6709.094272273181, 6780.762673306411, 6796.150481189851, 6814.420774234048, 6500.707468164039, 6621.668916554249, 6742.6628668567355, 6766.391024807791, 6802.14973128359, 6837.35045170708, 6868.107146070979, 6939.132608423947, 6960.860782784417, 6964.303569642995, 6653.567518111307, 6665.800025999228, 6731.427828634621, 6732.697028633625, 6733.797986060426, 6631.270560238467, 6632.2372927114, 6729.798106056826, 6764.255931847394, 6777.254502004874, 6458.418742313214, 6588.868222635425, 6593.868122637425, 6681.0, 6689.130413046273, 6618.007298905202, 6646.0695502628705, 6661.866762664623, 6709.7316107355155, 6712.630805305755, 6389.616623002635, 6473.093766872547, 6473.805785826433, 6477.481801455778, 6479.902801457888], "value": 6258.78125028601, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [812.0945146162028, 832.9666813327467, 854.4616891358444, 882.3735148044888, 883.3463237204467, 41111.79444102779, 41985.0, 42055.36916946248, 42136.57863421365, 42356.0, 38451.23097538047, 38520.61479385205, 38688.41967370485, 38717.806410967976, 38725.80637096811, 6965.303469653032, 7079.61062141582, 7087.751928682497, 7111.040009598715, 7115.608641524714, 7582.734604288851, 7832.647530861096, 7839.921600783976, 7840.647170877296, 7850.489718168329, 7813.296803287703, 7863.056433228021, 7878.251566101211, 7878.290953814156, 7880.172581878877, 7619.123800762928, 7791.415643826707, 7872.094709108468, 7875.645595948196, 7879.960600196962, 7729.34300584451, 7779.688812447495, 7783.299503044696, 7799.337056350217, 7812.843743125162, 38528.42207366892, 38851.611483885084, 38926.61073389286, 39040.21919561593, 39099.21801563981, 3538.327717733648, 3585.103724068983, 3585.8386372613295, 3585.9641403585892, 3586.0317714217017, 32361.35277294441, 32410.70357185733, 32417.6758232417, 32426.67573324284, 32471.188220294447, 5078.339815823956, 5244.0, 5246.527812496894, 5252.553532949704, 5261.500157485033, 189860.0, 191728.0, 192312.0, 192459.0, 199680.0, 49425.25862112071, 49468.50531494711, 49630.0, 49654.25518617224, 49720.25419618709, 51227.23159152616, 51332.48667513352, 51406.429678515924, 51428.0, 51494.22758658623, 14622.926885365505, 14761.040532365361, 14776.113433194043, 14822.703545929022, 14932.552023439313, 11937.522499100112, 11946.044316454663, 11950.88049119515, 11958.402079896145, 11968.880311196777, 14127.223002734949, 14150.433982640785, 14184.503542375967, 14316.141031538142, 14317.64205894861, 5645.68948707825, 5660.5471562274915, 5744.684042377709, 5780.710964451845, 5781.072517486725, 971.2327261463506, 1004.3973615830444, 1011.9696409107738, 1019.5361110694616, 1021.5352014833232, 22922.42693932665, 23036.308910732703, 23069.88465057664, 23189.7681023191, 23338.64992025121, 1096.8793432722393, 1099.9780004399868, 1100.147385776014, 1110.9833352499718, 1113.8551988241638, 12059.758804823854, 12203.816942745865, 12242.326672032945, 12250.571230006906, 12305.138640295272, 230692.0, 230719.0, 232140.0, 232213.0, 232295.0, 54454.455455444935, 54504.18243726347, 54670.0, 54710.0, 54798.452015479335, 1417.836948750907, 1433.3048471491318, 1434.3115304653825, 1440.1359184489431, 1446.9855301447062, 22420.439489012904, 22614.773852261926, 22676.206332778274, 22744.886275569177, 22901.88549057244, 37984.0, 38088.61911380962, 38099.80950095232, 38145.0, 38176.236475270896, 192032.0, 192704.0, 193074.0, 193096.0, 193472.0, 30714.84642576862, 33063.50404743979, 33974.49038264478, 35292.0, 35303.646963531064, 43018.35472467853, 44450.555494445936, 44694.3295850569, 44724.0, 44763.77618111888, 31654.525182122747, 31675.52486712747, 31731.04806855798, 32510.674893250765, 32651.18372040718, 31539.14080312028, 31665.366692666477, 31845.840770796924, 31910.84044579762, 32516.674833251363, 36157.81921090378, 36158.4576231362, 36597.634023659426, 36600.45099323459, 36817.631823682495, 31163.688363116984, 31873.840630796698, 31916.840415798702, 32126.83936580302, 32224.83887580547, 23161.0, 23174.073037078328, 23377.298681039596, 23846.52306953886, 23948.40128996789], "value": 17091.128464670343, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.7404667899443, 583.5731636149613, 584.5265335078585, 592.4993380593397, 594.5629961977946, 22175.667364989516, 23006.53986920263, 23086.769132308673, 23129.421764455878, 24237.272881813573, 24510.632340514905, 25145.87427062867, 25188.874055629698, 25225.369365765866, 25307.240782776502, 6820.079289295943, 6962.686679099427, 6973.6513174341335, 6977.267386924376, 6978.930210697904, 6134.079888016789, 6471.352864713538, 6768.8307792305095, 6793.286704895989, 6810.557313774613, 6761.8309542261595, 6764.6617669116595, 6765.086713293692, 6767.796966091, 6768.695408706595, 6750.493712971523, 6751.763688270887, 6757.391834734848, 6759.526833121683, 6761.966190169018, 6257.780977665805, 6261.06084087386, 6275.215598050244, 6276.560640755149, 6279.37206279373, 28593.428131437257, 29429.26426839346, 29430.0, 29440.0, 29692.8515357424, 2005.5587770690424, 2034.471037530238, 2035.7862424445368, 2036.256766280312, 2036.4399790057705, 19871.503212419804, 20488.38534843957, 20489.38531844047, 20497.897510512503, 20501.28245511415, 2395.221552995266, 2414.2877851033986, 2465.963010554843, 2466.0382450844186, 2475.616279476684, 127984.0, 130292.0, 130404.34797826046, 131130.0, 131679.0, 14693.338799754038, 14697.309809371845, 15118.522739769915, 15319.693606127816, 15674.68650626981, 22944.196953106562, 22950.770492295196, 22998.0, 23023.19418820333, 23033.07867685274, 9395.906040939502, 9496.19282361007, 9558.562566545486, 9636.855447168298, 9730.172935300438, 7295.781126566211, 8483.703070392507, 8592.398532102818, 8654.78363040929, 8706.782330441663, 7950.920490795018, 9060.682876099438, 9077.364584479155, 9158.67944621935, 9323.953380233192, 2613.3989182488135, 2622.2002289301563, 2668.266226787649, 2706.323419145214, 2819.1542537238747, 982.189693502863, 982.2093214961882, 991.4249735153738, 999.6701088640731, 1007.5314978535016, 19708.40874773759, 19802.405927822187, 19871.205151794056, 20089.379024793387, 20401.48996275105, 1043.3062013760916, 1048.926575139733, 1061.0927656853435, 1062.436908438529, 1067.514281002142, 10837.945810270898, 10926.836097458385, 11005.779884402267, 11112.495204117771, 11161.497732602053, 452163.0, 464243.0, 467364.0, 472769.0, 483415.0, 106788.0, 110694.0, 112644.0, 112648.0, 114370.0, 1172.9061675065975, 1179.127445690183, 1183.5739133911784, 1191.9106067045007, 1193.1945936492832, 17575.384861529787, 17649.91175044168, 17705.20326585281, 17779.644407112042, 17835.197416116047, 58225.708871457064, 60079.699601501714, 60090.699546501986, 60987.39012609995, 61863.0, 67329.32670673427, 75360.24639753532, 78794.21205788098, 79437.60281198558, 79732.60133699294, 11932.522699091938, 12382.0, 12908.935455322664, 14567.198804065454, 15046.322915469049, 18902.7164592534, 23568.175113870933, 23584.29247122589, 23595.0, 23885.0, 18673.346432874783, 18673.813261867752, 18905.527361816065, 18976.620467590295, 18995.145218465477, 16878.324867005183, 16889.493315200565, 17412.82587174112, 17456.91271543634, 17918.372856949944, 19526.707099393803, 19571.70642440393, 19691.803081968996, 19999.500012499804, 20013.199472020955, 14248.216348100954, 14628.561143165296, 14930.328135234158, 14932.178730169944, 14989.775153372926, 18837.623247535248, 18980.620387592448, 19088.904555477133, 19090.618187636446, 19198.13608387598], "value": 12009.671493488679, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.2805684930136, 1356.9619241280423, 1380.6479347766324, 1381.2748307138745, 1388.8263967004125, 14718.926405367958, 14863.777043344358, 15496.225188740575, 15520.456784012562, 15602.843971560282, 15863.603409914758, 16202.918985405086, 16219.513414597552, 16228.675426491493, 16230.0, 2616.699079605851, 2789.4560560690675, 2850.9002184923534, 2855.771538276933, 2857.3570946536965, 2794.6506686664165, 2824.915252542427, 2826.618406515125, 2826.618406515125, 2826.915192544227, 2748.8350698958025, 2757.1590664847213, 2790.218738753142, 2800.1179628417085, 2805.298675331167, 2568.460623269116, 2568.6018667106628, 2592.5333439980795, 2594.338443696864, 2597.571400718879, 2679.5310820606314, 2706.8105232633725, 2707.187843646918, 2710.6476158099517, 2711.3221694576355, 15094.320755566026, 15247.085174889542, 15466.226688665634, 15474.690506189925, 15504.379824806994, 7791.532508049535, 8032.638531266107, 8041.437099403044, 8070.757877263692, 8079.515229086215, 5292.153255479105, 5408.5402740766685, 5499.670019798825, 5522.088855338864, 5541.196526503634, 1944.222311075567, 1953.8046195380348, 1960.3334866145578, 1993.3720877923552, 2008.8392928565827, 27058.052968146218, 27258.5911211332, 27290.31774205641, 27292.044778432857, 27318.5902211467, 6499.3175716549085, 6502.382273683992, 6579.638119903451, 6776.356246156607, 6789.524733268624, 17656.382026629006, 17661.7350739739, 17668.11659417024, 17668.646627067388, 17682.11589420524, 7355.485116041826, 7615.5430674159725, 7619.657115429819, 7623.199564045806, 7624.771256862303, 6971.058907047483, 7057.153141623038, 7132.572045677276, 7153.213146553875, 7158.713651453988, 5345.492178243061, 5467.125259958388, 5477.808276710296, 5492.368377636543, 5522.834314970557, 1590.0618635005403, 1591.1964457948893, 1605.783219265384, 1606.068480281434, 1618.1504710027095, 874.0996773323487, 904.8461761500561, 905.538175530471, 917.9541022948825, 920.7513971227731, 7866.528008319405, 7871.48835325702, 7967.601619918981, 8015.078265999485, 8022.759317220492, 718.7484380466794, 979.4319294808994, 1002.7743757654615, 1008.3647302199568, 1009.1472705563787, 5039.899202015939, 5617.691026993472, 5619.325680918234, 5666.546676265889, 5860.062390017662, 21812.672809907865, 22489.55020899573, 22514.437139071328, 22577.322680319616, 22676.206332778274, 21677.132914683552, 22179.0, 22391.440213994454, 22641.2075577354, 22718.09127634876, 11667.183297169116, 11816.704582385337, 11829.645110646694, 11915.821262681067, 11927.522899083939, 8059.556724380215, 8589.0, 8847.823043538965, 8896.644134234559, 8909.73270801877, 18780.248790048245, 19001.0, 19084.0, 19162.233510659975, 19208.13563389679, 19353.742006769517, 19639.214431422584, 19639.901800490905, 19687.90156049268, 19831.801681982997, 11547.826782598437, 11897.40512974365, 11986.220895641756, 12219.205751626116, 12466.376681166086, 13497.86502134966, 13583.86416135826, 13621.114627549177, 13623.591292261248, 13641.454341826216, 11082.722931926766, 11095.889041109485, 11170.888291116984, 11235.15736319763, 11356.886431135583, 11071.0, 11113.666590002313, 11198.83201751958, 11214.607488737855, 11431.142664300045, 9198.356115071882, 9426.905730942603, 9427.858582121136, 9436.197923176333, 9439.433633981984, 7226.819329516594, 7231.16841563227, 7249.311315425026, 7260.0, 7294.598797066213, 7260.346568808833, 7263.128424589083, 7297.452691048086, 7306.525075870051, 7374.815629609303], "value": 6759.74499133855, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.7289990505226, 504.11276153969004, 510.1124044163155, 515.0960065085775, 537.8440252326825, 6381.266154392246, 6395.840103997402, 6397.136386587815, 6469.353064693529, 6500.38246366595, 6121.796153384778, 6235.625862448256, 6272.623642581449, 6296.842578935529, 6320.304766475684, 4988.65079444439, 5070.188769796833, 5218.791248350061, 5227.47725227478, 5233.581313494911, 5049.596032317424, 5093.719845408501, 5100.566451851597, 5117.923231151536, 5118.820841270556, 4969.279454479099, 5026.395568940641, 5039.496050394968, 5068.797248110071, 5073.873153171164, 4969.304297398367, 5046.0160268747795, 5073.873153171164, 5087.56755675768, 5107.438181799999, 4507.1211113832815, 4578.519255478193, 4589.334546490773, 4596.241620132674, 4601.0, 6123.601965872204, 6179.5674302798825, 6256.468200202989, 6296.748130074791, 6352.205974253218, 5696.487316141525, 5705.515031222351, 5745.822106468164, 5787.536997040269, 5810.302763668345, 6590.967045164792, 6636.170478690164, 6637.535372523926, 6662.0340050692375, 6705.0, 4928.950710492921, 4956.2565615157655, 4970.229614409773, 4974.925376119361, 4988.975055124737, 6617.834554136137, 6803.557768745065, 6843.247242803288, 7000.929990700079, 7085.43316534676, 5022.522860328263, 5062.873428164326, 5085.644004919694, 5106.055379754757, 5112.233165025276, 5086.567641750418, 5124.256982737482, 5148.99189316167, 5164.509371609691, 5176.378834539879, 5739.770409183586, 5760.251167348218, 5769.249997500298, 5786.103154011135, 5823.272090988627, 6638.701258443285, 6718.899216511756, 6750.898736518956, 6759.831004224934, 6768.175980570962, 1784.3754685860106, 1792.345793785259, 1794.3091909614632, 1794.9820501795075, 1802.6394721055842, 1177.534873724874, 1230.1880758699215, 1243.0863315463127, 1244.440001999104, 1246.6135497995651, 5916.792912248051, 5927.865968251426, 5962.34414214436, 5968.492678122321, 6051.697415129226, 6815.659217039228, 6911.447084233249, 6922.688479018456, 6961.965190174017, 6983.511154219156, 5975.223220981332, 5989.341172471025, 6002.789902353396, 6005.309389420186, 6023.728932197974, 3648.872289469856, 3653.3789255826573, 3681.7238707097076, 3706.258748250361, 3707.5180226570915, 6390.384349918205, 6609.867802644017, 6655.567388119756, 6671.866562668816, 6716.832079197961, 6878.3465570770695, 6964.895526567106, 7040.718371265194, 7045.542039767399, 7069.399101076466, 6517.543771935919, 6666.766663166766, 6672.499562532927, 6688.7324507019175, 6710.127683401127, 6847.863042739217, 6849.691763870538, 6864.7940561783225, 6879.245792322926, 6914.792556223321, 6834.0, 6838.521303508706, 6861.313868613099, 6873.793786186422, 6918.5502942308585, 6645.468362531083, 6667.4996876171435, 6684.4318232950745, 6688.163979502562, 6701.899471507833, 5046.747662616928, 5073.365829271341, 5108.66793658411, 5113.744312784272, 5121.948780512147, 6547.508936829661, 6730.798076057726, 6813.89779153323, 6869.385694361921, 6917.443575195541, 6509.804705858832, 6525.3800888915475, 6537.82175843823, 6562.489068348411, 6655.866882662222, 6431.649353635602, 6531.412172904462, 6578.0, 6596.472282217315, 6607.735690572324, 6425.871482570229, 6440.32376600469, 6570.638614876228, 6576.2766095730385, 6590.143281373583, 6616.702248398929, 6661.234772785313, 6663.46692264608, 6696.0960270362875, 6753.797386078426, 6391.552591318563, 6473.320301368289, 6477.352264773485, 6498.512611554058, 6516.543841931019], "value": 5150.14713668347, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [899.6086702284507, 903.8463461211593, 909.3589019741081, 919.3013309884494, 925.1303774452015, 20648.277310294143, 24176.395590110256, 24176.87911560442, 24231.27306180813, 24249.63625545616, 20884.0, 21841.563168736615, 21842.453938651503, 21868.562628747415, 22072.558548829013, 965.4159233663638, 987.5555999800083, 987.8715766950287, 988.9456079915602, 990.0396615283164, 892.4823602310644, 929.5770424456856, 989.737719504332, 994.666786626481, 996.093554865073, 1047.4082143588887, 1047.528612124543, 1051.7475805806628, 1053.2995557953952, 1055.37205362809, 1031.8194315994672, 1038.833786594145, 1038.8493668418037, 1041.2398948767404, 1041.2919214933843, 762.0, 762.0626629246003, 762.2758379539459, 762.6339357108619, 763.3511515212081, 19133.234670613158, 19177.32879349216, 19370.32203872872, 19572.119254633435, 20345.593088138303, 21774.891125544273, 21779.0, 22035.889820550954, 22225.333240002827, 22254.0, 15684.843151568452, 15823.050616962904, 15941.601459963595, 15986.040837549785, 16089.356425742957, 3616.27674465108, 3666.32173047987, 3667.523221981152, 3668.248009158116, 3670.137517683342, 127513.0, 127839.36080319632, 128816.35591821981, 132055.33972330173, 132929.0, 16044.839551604335, 16317.42888998903, 16412.261448234858, 16484.505464836075, 16673.0, 30139.09582712522, 30747.0, 30943.535846962313, 30989.0, 31141.532877006863, 8265.95867020661, 8276.379271554657, 8327.292180164754, 8367.581620918929, 8371.079181290053, 4106.425100485934, 4193.895152621209, 4208.0, 4223.5864168664575, 4247.490301163818, 5255.500727430888, 5336.653117547347, 5359.249705041298, 5378.2470454136455, 5383.623146379716, 942.9669961551313, 965.6234068713208, 989.1345073061071, 991.2020823237219, 991.4299277915084, 654.6628486329544, 666.4135560706644, 690.4165979747106, 702.0697575712202, 709.0, 11554.0, 11667.241629294069, 11728.237664551776, 12255.448504817305, 12876.61370158878, 670.3196255800269, 688.9379955804002, 706.6078326528826, 714.1965289049818, 730.1493759769915, 4689.742064186503, 4753.643476739258, 4820.903581928342, 4866.586340161055, 4868.123737727172, 114614.0, 114935.0, 116501.0, 117095.41452292685, 117152.41423792997, 98236.0, 100045.49977250067, 102903.0, 103020.48489757653, 105678.0, 89183.55408223048, 92207.53896230475, 93000.06999929914, 93491.5325423355, 94087.0, 10327.0, 10453.634122805664, 10473.895261047292, 10579.15366770641, 10628.202884783517, 31721.66922473107, 40824.79587602162, 42177.78911105425, 43039.56960430356, 44683.32975005443, 73449.6327518359, 73710.63144684242, 73742.26257737353, 74447.0, 74914.62542687252, 18521.444356669323, 18802.811971880106, 19000.809991899903, 19019.524511887314, 19085.141168647722, 19028.33400830964, 19591.31430399929, 19608.215671372986, 20749.58500830005, 20869.895650521652, 17679.646407072043, 17682.292708291523, 17689.557761056076, 17699.911500442417, 17883.821161788735, 18942.621147577247, 19003.90498047501, 19083.236670533024, 19432.0, 19691.507712307306, 17020.744688829924, 17939.910300448413, 18184.181711823265, 18314.725279121092, 18975.33586324472, 12805.8079128815, 13823.654408639864, 13943.651408714863, 14309.212993285053, 14537.200453975132, 13023.674408139872, 13144.60566183016, 13200.537981170997, 13268.270245136224, 13457.932710336385], "value": 9173.108342375217, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1482.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 109.0, 94.0, 107.0, 109.0, 108.0, 115.0, 110.0, 109.0, 108.0], "value": 107.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 113.0, 145.0, 177.0, 122.0, 145.0, 141.0, 118.0, 167.0, 118.0], "value": 139.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 163.0, 162.0, 162.0, 163.0, 167.0, 169.0, 163.0, 161.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 187.0, 75.0, 73.0, 73.0, 87.0, 95.0, 77.0], "value": 88.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 125.0, 79.0, 79.0, 80.0, 124.0, 80.0, 79.0, 129.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 115.0, 117.0, 115.0, 114.0, 114.0, 114.0, 113.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 149.0, 148.0, 147.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 98.0, 96.0, 93.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 53.0, 55.0, 54.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 74.0, 74.0, 79.0, 75.0, 76.0, 74.0, 77.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 122.0, 120.0, 135.0, 114.0, 123.0, 116.0, 132.0, 118.0, 159.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 170.0, 171.0, 179.0, 176.0, 175.0, 167.0, 168.0, 177.0, 191.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 65.0, 67.0, 64.0, 62.0, 62.0, 65.0, 66.0, 62.0], "value": 64.3, "unit": "score"}]}]} 11:31:38 INFO - Return code: 0 11:31:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:31:38 INFO - # TBPL SUCCESS # 11:31:38 INFO - Running post-action listener: _package_coverage_data 11:31:38 INFO - Running post-action listener: _resource_record_post_action 11:31:38 INFO - [mozharness: 2017-09-01 18:31:38.365124Z] Finished run-tests step (success) 11:31:38 INFO - Running post-run listener: _resource_record_post_run 11:31:38 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 5287936; Write bytes: 398348288; Read time: 2348; Write time: 261712 11:31:38 INFO - TinderboxPrint: CPU usage
13.1% 11:31:38 INFO - TinderboxPrint: I/O read bytes / time
5,287,936 / 2,348 11:31:38 INFO - TinderboxPrint: I/O write bytes / time
398,348,288 / 261,712 11:31:38 INFO - TinderboxPrint: CPU idle
8,256.8 (86.9%) 11:31:38 INFO - TinderboxPrint: CPU user
1,193.7 (12.6%) 11:31:38 INFO - TinderboxPrint: Swap in / out
0 / 0 11:31:38 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 28672; Write bytes: 116355072; Read time: 84; Write time: 129588 11:31:38 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:31:38 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 3514368; Write bytes: 281993216; Read time: 2224; Write time: 132124 11:31:39 INFO - Running post-run listener: _upload_blobber_files 11:31:39 INFO - Blob upload gear active. 11:31:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:31:39 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 11:31:39 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'] 11:31:39 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 11:31:39 INFO - (blobuploader) - INFO - Open directory for files ... 11:31:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:31:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:31:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:31:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:31:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:31:43 INFO - (blobuploader) - INFO - Done attempting. 11:31:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:31:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:31:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:31:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:31:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:31:44 INFO - (blobuploader) - INFO - Done attempting. 11:31:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:31:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:31:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:31:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:31:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:31:45 INFO - (blobuploader) - INFO - Done attempting. 11:31:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:31:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:31:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:31:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:31:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:31:46 INFO - (blobuploader) - INFO - Done attempting. 11:31:46 INFO - (blobuploader) - INFO - Iteration through files over. 11:31:46 INFO - Return code: 0 11:31:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:31:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:31:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a82b3770f82be87363e6375e56c5fa766e859e06c0452ba0ce7cc04268eed57164d83f85b3c97f3ea42513f6079cd0767a33cef3a658dac1c25a8ff597590aa9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fd71b47da6717654532ae827e57d05e55f64f8ab657eb2c66f305314a30bf52226265760a39c0899fce271d6d1dd91bbedb1377074d2304f8480e166a8ff053", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07d0bdbf2edc18ff240fd4e293e3a402f8c5ed35d0eebc138191b532af9eeedcc9f94639be95c9ffad9430c8928da7f1de24b4788284b347bc9a986b42af4217", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2dd358279af171cafcb7cd83d14f0c9c2f807402754a1701dbe8db138324a5c04b7c18da229c15e28db7649370d3d0738979bf69158337a316b729a283f1989"} 11:31:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:31:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:31:46 INFO - Contents: 11:31:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a82b3770f82be87363e6375e56c5fa766e859e06c0452ba0ce7cc04268eed57164d83f85b3c97f3ea42513f6079cd0767a33cef3a658dac1c25a8ff597590aa9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fd71b47da6717654532ae827e57d05e55f64f8ab657eb2c66f305314a30bf52226265760a39c0899fce271d6d1dd91bbedb1377074d2304f8480e166a8ff053", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07d0bdbf2edc18ff240fd4e293e3a402f8c5ed35d0eebc138191b532af9eeedcc9f94639be95c9ffad9430c8928da7f1de24b4788284b347bc9a986b42af4217", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2dd358279af171cafcb7cd83d14f0c9c2f807402754a1701dbe8db138324a5c04b7c18da229c15e28db7649370d3d0738979bf69158337a316b729a283f1989"} 11:31:46 INFO - Running post-run listener: copy_logs_to_upload_dir 11:31:46 INFO - Copying logs to upload dir... 11:31:46 INFO - mkdir: /builds/slave/test/build/upload/logs 11:31:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.167662 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-09-01 11:31:46.253645) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-01 11:31:46.257286) ========= 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=199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337 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/a82b3770f82be87363e6375e56c5fa766e859e06c0452ba0ce7cc04268eed57164d83f85b3c97f3ea42513f6079cd0767a33cef3a658dac1c25a8ff597590aa9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fd71b47da6717654532ae827e57d05e55f64f8ab657eb2c66f305314a30bf52226265760a39c0899fce271d6d1dd91bbedb1377074d2304f8480e166a8ff053", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07d0bdbf2edc18ff240fd4e293e3a402f8c5ed35d0eebc138191b532af9eeedcc9f94639be95c9ffad9430c8928da7f1de24b4788284b347bc9a986b42af4217", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2dd358279af171cafcb7cd83d14f0c9c2f807402754a1701dbe8db138324a5c04b7c18da229c15e28db7649370d3d0738979bf69158337a316b729a283f1989"} build_url:https://queue.taskcluster.net/v1/task/Aa8zsAsLT3StNXVbTCD9Tg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011242 build_url: 'https://queue.taskcluster.net/v1/task/Aa8zsAsLT3StNXVbTCD9Tg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a82b3770f82be87363e6375e56c5fa766e859e06c0452ba0ce7cc04268eed57164d83f85b3c97f3ea42513f6079cd0767a33cef3a658dac1c25a8ff597590aa9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fd71b47da6717654532ae827e57d05e55f64f8ab657eb2c66f305314a30bf52226265760a39c0899fce271d6d1dd91bbedb1377074d2304f8480e166a8ff053", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07d0bdbf2edc18ff240fd4e293e3a402f8c5ed35d0eebc138191b532af9eeedcc9f94639be95c9ffad9430c8928da7f1de24b4788284b347bc9a986b42af4217", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2dd358279af171cafcb7cd83d14f0c9c2f807402754a1701dbe8db138324a5c04b7c18da229c15e28db7649370d3d0738979bf69158337a316b729a283f1989"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-01 11:31:46.285477) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 11:31:46.285906) ========= 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=199fb4c72b90437b990b419b000001c5-1504289448.700532-1087072337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004567 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 11:31:46.368991) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-01 11:31:46.369515) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-01 11:31:46.370018) ========= ========= Total master_lag: 0.21 =========