builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-026 starttime: 1504722782.43 results: success (0) revision: 93dd2e456c0ecca00fb4d28744e88078a77deaf7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-06 11:33:02.429038) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-06 11:33:02.429529) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-06 11:33:02.429803) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-06 11:33:02.449766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 11:33:02.450174) ========= 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=41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-06 11:33:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.2M=0s 2017-09-06 11:33:02 (70.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.082687 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 11:33:02.553151) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 11:33:02.553493) ========= 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=41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020233 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 11:33:02.603790) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-06 11:33:02.607335) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 93dd2e456c0ecca00fb4d28744e88078a77deaf7 --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 93dd2e456c0ecca00fb4d28744e88078a77deaf7 --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=41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-06 11:33:02,774 truncating revision to first 12 chars 2017-09-06 11:33:02,774 Setting DEBUG logging. 2017-09-06 11:33:02,774 attempt 1/10 2017-09-06 11:33:02,774 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/93dd2e456c0e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-06 11:33:04,022 unpacking tar archive at: mozilla-central-93dd2e456c0e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.572141 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-06 11:33:04.198434) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-06 11:33:04.198778) ========= script_repo_revision: 93dd2e456c0ecca00fb4d28744e88078a77deaf7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-06 11:33:04.199179) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-06 11:33:04.199509) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-06 11:33:04.212958) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-09-06 11:33:04.213296) ========= /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=41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:33:04 INFO - MultiFileLogger online at 20170906 11:33:04 in /builds/slave/test 11:33:04 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:33:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:33:04 INFO - {'append_to_log': False, 11:33:04 INFO - 'base_work_dir': '/builds/slave/test', 11:33:04 INFO - 'blob_upload_branch': 'Firefox', 11:33:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:33:04 INFO - 'branch': 'Firefox', 11:33:04 INFO - 'buildbot_json_path': 'buildprops.json', 11:33:04 INFO - 'code_coverage': False, 11:33:04 INFO - 'config_files': ('talos/linux_config.py',), 11:33:04 INFO - 'default_actions': ('clobber', 11:33:04 INFO - 'read-buildbot-config', 11:33:04 INFO - 'download-and-extract', 11:33:04 INFO - 'populate-webroot', 11:33:04 INFO - 'create-virtualenv', 11:33:04 INFO - 'install', 11:33:04 INFO - 'setup-mitmproxy', 11:33:04 INFO - 'run-tests'), 11:33:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:33:04 INFO - 'disable_ccov_upload': False, 11:33:04 INFO - 'disable_stylo': False, 11:33:04 INFO - 'download_minidump_stackwalk': True, 11:33:04 INFO - 'download_symbols': 'ondemand', 11:33:04 INFO - 'enable_stylo': False, 11:33:04 INFO - 'enable_webrender': False, 11:33:04 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:33:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:33:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:33:04 INFO - 'gecko_profile': False, 11:33:04 INFO - 'gecko_profile_interval': 0, 11:33:04 INFO - 'installer_path': 'installer.exe', 11:33:04 INFO - 'log_level': 'info', 11:33:04 INFO - 'log_name': 'talos', 11:33:04 INFO - 'log_to_console': True, 11:33:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:33:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:33:04 INFO - 'opt_config_files': (), 11:33:04 INFO - 'pip_index': False, 11:33:04 INFO - 'suite': 'dromaeojs-e10s', 11:33:04 INFO - 'system_bits': '32', 11:33:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:33:04 INFO - 'title': 'talos-linux64-ix-026', 11:33:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:33:04 INFO - 'use_talos_json': True, 11:33:04 INFO - 'verify': 'False', 11:33:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:33:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:33:04 INFO - 'work_dir': 'build'} 11:33:04 INFO - [mozharness: 2017-09-06 18:33:04.527363Z] Running clobber step. 11:33:04 INFO - Running pre-action listener: _resource_record_pre_action 11:33:04 INFO - Running main action method: clobber 11:33:04 INFO - rmtree: /builds/slave/test/build 11:33:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:33:05 INFO - Running post-action listener: _resource_record_post_action 11:33:05 INFO - [mozharness: 2017-09-06 18:33:05.555376Z] Finished clobber step (success) 11:33:05 INFO - [mozharness: 2017-09-06 18:33:05.555473Z] Running read-buildbot-config step. 11:33:05 INFO - Running pre-action listener: _resource_record_pre_action 11:33:05 INFO - Running main action method: read_buildbot_config 11:33:05 INFO - Using buildbot properties: 11:33:05 INFO - { 11:33:05 INFO - "project": "", 11:33:05 INFO - "product": "firefox", 11:33:05 INFO - "who": "ffxbld@noreply.mozilla.org", 11:33:05 INFO - "installer_path": "public/build/target.tar.bz2", 11:33:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 11:33:05 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:33:05 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 11:33:05 INFO - "stage_platform": "linux64-stylosequential", 11:33:05 INFO - "basedir": "/builds/slave/test", 11:33:05 INFO - "buildnumber": 61, 11:33:05 INFO - "platform": "ubuntu64_hw_styloseq", 11:33:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:33:05 INFO - "slavebuilddir": "test", 11:33:05 INFO - "taskId": "cPs1uM5wTkWw0xtq0bcHTQ", 11:33:05 INFO - "branch": "mozilla-central", 11:33:05 INFO - "script_repo_revision": "production", 11:33:05 INFO - "revision": "93dd2e456c0ecca00fb4d28744e88078a77deaf7", 11:33:05 INFO - "slavename": "talos-linux64-ix-026", 11:33:05 INFO - "repo_path": "mozilla-central" 11:33:05 INFO - } 11:33:05 INFO - Finding installer, test and symbols from parent task. 11:33:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cPs1uM5wTkWw0xtq0bcHTQ'}, attempt #1 11:33:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cPs1uM5wTkWw0xtq0bcHTQ'}, attempt #1 11:33:06 INFO - Task dependencies: CNiQiOuNT32DU3L464s6DA 11:33:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CNiQiOuNT32DU3L464s6DA'}, attempt #1 11:33:06 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/CNiQiOuNT32DU3L464s6DA/artifacts/public/build/target.tar.bz2 11:33:06 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/CNiQiOuNT32DU3L464s6DA/artifacts/public/build/target.test_packages.json 11:33:06 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/CNiQiOuNT32DU3L464s6DA/artifacts/public/build/target.crashreporter-symbols.zip 11:33:06 INFO - Running post-action listener: _resource_record_post_action 11:33:06 INFO - [mozharness: 2017-09-06 18:33:06.955032Z] Finished read-buildbot-config step (success) 11:33:06 INFO - [mozharness: 2017-09-06 18:33:06.955249Z] Running download-and-extract step. 11:33:06 INFO - Running pre-action listener: _resource_record_pre_action 11:33:06 INFO - Running main action method: download_and_extract 11:33:06 INFO - mkdir: /builds/slave/test/build/tests 11:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:06 INFO - trying https://queue.taskcluster.net/v1/task/CNiQiOuNT32DU3L464s6DA/artifacts/public/build/target.test_packages.json 11:33:06 INFO - Downloading https://queue.taskcluster.net/v1/task/CNiQiOuNT32DU3L464s6DA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:33:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CNiQiOuNT32DU3L464s6DA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:33:07 INFO - Downloaded 989 bytes. 11:33:07 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:33:07 INFO - Using the following test package requirements: 11:33:07 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:33:07 INFO - u'common': [u'target.common.tests.zip'], 11:33:07 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:33:07 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:33:07 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:33:07 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:33:07 INFO - u'mozbase': [u'target.common.tests.zip'], 11:33:07 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:33:07 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:33:07 INFO - u'web-platform': [u'target.common.tests.zip', 11:33:07 INFO - u'target.web-platform.tests.tar.gz'], 11:33:07 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:33:07 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:33:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CNiQiOuNT32DU3L464s6DA/artifacts/public/build/target.common.tests.zip 11:33:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CNiQiOuNT32DU3L464s6DA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:33:07 INFO - Fetch https://queue.taskcluster.net/v1/task/CNiQiOuNT32DU3L464s6DA/artifacts/public/build/target.common.tests.zip into memory 11:33:08 INFO - Content-Length response header: 55020142 11:33:08 INFO - Bytes received: 55020142 11:33:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:33:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CNiQiOuNT32DU3L464s6DA/artifacts/public/build/target.common.tests.zip 11:33:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CNiQiOuNT32DU3L464s6DA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:33:19 INFO - Fetch https://queue.taskcluster.net/v1/task/CNiQiOuNT32DU3L464s6DA/artifacts/public/build/target.common.tests.zip into memory 11:33:20 INFO - Content-Length response header: 55020142 11:33:20 INFO - Bytes received: 55020142 11:33:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CNiQiOuNT32DU3L464s6DA/artifacts/public/build/target.talos.tests.zip 11:33:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CNiQiOuNT32DU3L464s6DA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:33:32 INFO - Fetch https://queue.taskcluster.net/v1/task/CNiQiOuNT32DU3L464s6DA/artifacts/public/build/target.talos.tests.zip into memory 11:33:33 INFO - Content-Length response header: 14496665 11:33:33 INFO - Bytes received: 14496665 11:33:33 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:33:33 INFO - trying https://queue.taskcluster.net/v1/task/CNiQiOuNT32DU3L464s6DA/artifacts/public/build/target.tar.bz2 11:33:33 INFO - Downloading https://queue.taskcluster.net/v1/task/CNiQiOuNT32DU3L464s6DA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:33:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CNiQiOuNT32DU3L464s6DA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:33:34 INFO - Downloaded 62680086 bytes. 11:33:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CNiQiOuNT32DU3L464s6DA/artifacts/public/build/target.tar.bz2 11:33:34 INFO - mkdir: /builds/slave/test/properties 11:33:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:33:34 INFO - Writing to file /builds/slave/test/properties/build_url 11:33:34 INFO - Contents: 11:33:34 INFO - build_url:https://queue.taskcluster.net/v1/task/CNiQiOuNT32DU3L464s6DA/artifacts/public/build/target.tar.bz2 11:33:34 INFO - Running post-action listener: _resource_record_post_action 11:33:34 INFO - Running post-action listener: find_tests_for_verification 11:33:34 INFO - Running post-action listener: set_extra_try_arguments 11:33:34 INFO - [mozharness: 2017-09-06 18:33:34.826995Z] Finished download-and-extract step (success) 11:33:34 INFO - [mozharness: 2017-09-06 18:33:34.827090Z] Running populate-webroot step. 11:33:34 INFO - Running pre-action listener: _resource_record_pre_action 11:33:34 INFO - Running main action method: populate_webroot 11:33:34 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:33:34 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:33:34 INFO - 'tests': ['tresize', 11:33:34 INFO - 'tcanvasmark']}, 11:33:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:33:34 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:33:34 INFO - 'tests': ['dromaeo_css', 11:33:34 INFO - 'kraken']}, 11:33:34 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:33:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:33:34 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:33:34 INFO - 'talos_options': ['--disable-stylo'], 11:33:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:33:34 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:33:34 INFO - 'tests': ['damp', 'tps']}, 11:33:34 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:33:34 INFO - 'talos_options': ['--disable-stylo'], 11:33:34 INFO - 'tests': ['damp', 'tps']}, 11:33:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:33:34 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:33:34 INFO - 'tests': ['dromaeo_dom']}, 11:33:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:33:34 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:33:34 INFO - 'tests': ['basic_compositor_video', 11:33:34 INFO - 'glvideo']}, 11:33:34 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:33:34 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:33:34 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:33:34 INFO - 'talos_options': ['--disable-stylo'], 11:33:34 INFO - 'tests': ['ts_paint_webext', 11:33:34 INFO - 'tp5o_webext']}, 11:33:34 INFO - 'other-e10s': {'tests': ['a11yr', 11:33:34 INFO - 'ts_paint', 11:33:34 INFO - 'tpaint', 11:33:34 INFO - 'sessionrestore', 11:33:34 INFO - 'sessionrestore_many_windows', 11:33:34 INFO - 'sessionrestore_no_auto_restore', 11:33:34 INFO - 'tabpaint']}, 11:33:34 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:33:34 INFO - 'tests': ['a11yr', 11:33:34 INFO - 'ts_paint', 11:33:34 INFO - 'tpaint', 11:33:34 INFO - 'sessionrestore', 11:33:34 INFO - 'sessionrestore_many_windows', 11:33:34 INFO - 'sessionrestore_no_auto_restore', 11:33:34 INFO - 'tabpaint']}, 11:33:34 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:33:34 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:33:34 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:33:34 INFO - 'tests': ['bloom_basic_singleton']}, 11:33:34 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:33:34 INFO - 'tests': ['bloom_basic']}, 11:33:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:33:34 INFO - 'tsvgr_opacity', 11:33:34 INFO - 'tart', 11:33:34 INFO - 'tscrollx', 11:33:34 INFO - 'tsvg_static']}, 11:33:34 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:33:34 INFO - 'tests': ['tsvgx', 11:33:34 INFO - 'tsvgr_opacity', 11:33:34 INFO - 'tart', 11:33:34 INFO - 'tscrollx', 11:33:34 INFO - 'tsvg_static']}, 11:33:34 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:33:34 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:33:34 INFO - 'talos_options': ['--disable-stylo'], 11:33:34 INFO - 'tests': ['tp5o']}, 11:33:34 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:33:34 INFO - 'talos_options': ['--mitmproxy', 11:33:34 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:33:34 INFO - '--firstNonBlankPaint'], 11:33:34 INFO - 'tests': ['tp6_google', 11:33:34 INFO - 'tp6_youtube', 11:33:34 INFO - 'tp6_amazon', 11:33:34 INFO - 'tp6_facebook']}, 11:33:34 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:33:34 INFO - 'talos_options': ['--disable-stylo', 11:33:34 INFO - '--mitmproxy', 11:33:34 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:33:34 INFO - '--firstNonBlankPaint'], 11:33:34 INFO - 'tests': ['tp6_google', 11:33:34 INFO - 'tp6_youtube', 11:33:34 INFO - 'tp6_amazon', 11:33:34 INFO - 'tp6_facebook']}, 11:33:34 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:33:34 INFO - 'talos_options': ['--stylo-threads=1', 11:33:34 INFO - '--mitmproxy', 11:33:34 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:33:34 INFO - '--firstNonBlankPaint'], 11:33:34 INFO - 'tests': ['tp6_google', 11:33:34 INFO - 'tp6_youtube', 11:33:34 INFO - 'tp6_amazon', 11:33:34 INFO - 'tp6_facebook']}, 11:33:34 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:33:34 INFO - 'talos_options': ['--xperf_path', 11:33:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:33:34 INFO - 'tests': ['tp5n']}, 11:33:34 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:33:34 INFO - 'talos_options': ['--disable-stylo', 11:33:34 INFO - '--xperf_path', 11:33:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:33:34 INFO - 'tests': ['tp5n']}}} 11:33:34 INFO - Running post-action listener: _resource_record_post_action 11:33:34 INFO - [mozharness: 2017-09-06 18:33:34.842019Z] Finished populate-webroot step (success) 11:33:34 INFO - [mozharness: 2017-09-06 18:33:34.842107Z] Running create-virtualenv step. 11:33:34 INFO - Running pre-action listener: _resource_record_pre_action 11:33:34 INFO - Running main action method: create_virtualenv 11:33:34 INFO - Creating virtualenv /builds/slave/test/build/venv 11:33:34 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:33:34 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:33:34 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:33:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:33:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:33:35 INFO - Installing distribute.............................................................................................................................................................................................done. 11:33:35 INFO - Installing pip...............done. 11:33:35 INFO - Return code: 0 11:33:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:33:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:33:35 INFO - Reading from file tmpfile_stdout 11:33:35 INFO - Output received: 11:33:35 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:33:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:33:35 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:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:35 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:33:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:35 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 0x21ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2375a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c090>, '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 0x251cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2516f90>, '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': '41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044', '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:33:35 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:33:35 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:33:35 INFO - Using env: {'DISPLAY': ':0', 11:33:35 INFO - 'HOME': '/home/cltbld', 11:33:35 INFO - 'LANG': 'en_US.UTF-8', 11:33:35 INFO - 'LANGUAGE': 'en_US:en', 11:33:35 INFO - 'LOGNAME': 'cltbld', 11:33:35 INFO - 'MAIL': '/var/mail/cltbld', 11:33:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:35 INFO - 'MOZ_NO_REMOTE': '1', 11:33:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:35 INFO - 'NO_EM_RESTART': '1', 11:33:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:35 INFO - 'PWD': '/builds/slave/test', 11:33:35 INFO - 'SHELL': '/bin/bash', 11:33:35 INFO - 'SHLVL': '1', 11:33:35 INFO - 'TERM': 'linux', 11:33:35 INFO - 'TMOUT': '86400', 11:33:35 INFO - 'USER': 'cltbld', 11:33:35 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044', 11:33:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:35 INFO - '_': '/tools/buildbot/bin/python'} 11:33:37 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:33:37 INFO - Downloading/unpacking pip>=1.5 11:33:37 INFO - Running setup.py egg_info for package pip 11:33:37 INFO - warning: no files found matching 'pip/cacert.pem' 11:33:37 INFO - warning: no files found matching '*.html' under directory 'docs' 11:33:37 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:33:37 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:33:37 INFO - Installing collected packages: pip 11:33:37 INFO - Found existing installation: pip 1.1 11:33:37 INFO - Uninstalling pip: 11:33:37 INFO - Successfully uninstalled pip 11:33:37 INFO - Running setup.py install for pip 11:33:37 INFO - warning: no files found matching 'pip/cacert.pem' 11:33:37 INFO - warning: no files found matching '*.html' under directory 'docs' 11:33:37 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:33:37 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:33:37 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:33:37 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:33:37 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:33:37 INFO - Successfully installed pip 11:33:37 INFO - Cleaning up... 11:33:37 INFO - Return code: 0 11:33:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:33: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:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33: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:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:37 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 0x21ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2375a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c090>, '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 0x251cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2516f90>, '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': '41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044', '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:33:37 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:33:37 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:33:37 INFO - Using env: {'DISPLAY': ':0', 11:33:37 INFO - 'HOME': '/home/cltbld', 11:33:37 INFO - 'LANG': 'en_US.UTF-8', 11:33:37 INFO - 'LANGUAGE': 'en_US:en', 11:33:37 INFO - 'LOGNAME': 'cltbld', 11:33:37 INFO - 'MAIL': '/var/mail/cltbld', 11:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:37 INFO - 'MOZ_NO_REMOTE': '1', 11:33:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:37 INFO - 'NO_EM_RESTART': '1', 11:33:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:37 INFO - 'PWD': '/builds/slave/test', 11:33:37 INFO - 'SHELL': '/bin/bash', 11:33:37 INFO - 'SHLVL': '1', 11:33:37 INFO - 'TERM': 'linux', 11:33:37 INFO - 'TMOUT': '86400', 11:33:37 INFO - 'USER': 'cltbld', 11:33:37 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044', 11:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:37 INFO - '_': '/tools/buildbot/bin/python'} 11:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:37 INFO - Downloading/unpacking psutil>=3.1.1 11:33:37 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:33:37 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:33:37 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:33:37 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:33:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:33:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:33:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:33:38 INFO - Installing collected packages: psutil 11:33:38 INFO - Running setup.py install for psutil 11:33:38 INFO - building 'psutil._psutil_linux' extension 11:33:38 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:33:38 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:33:38 INFO - building 'psutil._psutil_posix' extension 11:33:38 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:33:38 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:33:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:33:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:33:38 INFO - Successfully installed psutil 11:33:38 INFO - Cleaning up... 11:33:38 INFO - Return code: 0 11:33:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:38 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 0x21ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2375a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c090>, '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 0x251cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2516f90>, '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': '41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044', '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:33:38 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:33:38 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:33:38 INFO - Using env: {'DISPLAY': ':0', 11:33:38 INFO - 'HOME': '/home/cltbld', 11:33:38 INFO - 'LANG': 'en_US.UTF-8', 11:33:38 INFO - 'LANGUAGE': 'en_US:en', 11:33:38 INFO - 'LOGNAME': 'cltbld', 11:33:38 INFO - 'MAIL': '/var/mail/cltbld', 11:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:38 INFO - 'MOZ_NO_REMOTE': '1', 11:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:38 INFO - 'NO_EM_RESTART': '1', 11:33:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:38 INFO - 'PWD': '/builds/slave/test', 11:33:38 INFO - 'SHELL': '/bin/bash', 11:33:38 INFO - 'SHLVL': '1', 11:33:38 INFO - 'TERM': 'linux', 11:33:38 INFO - 'TMOUT': '86400', 11:33:38 INFO - 'USER': 'cltbld', 11:33:38 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044', 11:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:38 INFO - '_': '/tools/buildbot/bin/python'} 11:33:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:33:39 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:33:39 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:33:39 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:33:39 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:33:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:33:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:33:40 INFO - Installing collected packages: mozsystemmonitor 11:33:40 INFO - Running setup.py install for mozsystemmonitor 11:33:40 INFO - Successfully installed mozsystemmonitor 11:33:40 INFO - Cleaning up... 11:33:40 INFO - Return code: 0 11:33:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:33: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:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33: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:33:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:40 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 0x21ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2375a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c090>, '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 0x251cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2516f90>, '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': '41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044', '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:33:40 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:33:40 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:33:40 INFO - Using env: {'DISPLAY': ':0', 11:33:40 INFO - 'HOME': '/home/cltbld', 11:33:40 INFO - 'LANG': 'en_US.UTF-8', 11:33:40 INFO - 'LANGUAGE': 'en_US:en', 11:33:40 INFO - 'LOGNAME': 'cltbld', 11:33:40 INFO - 'MAIL': '/var/mail/cltbld', 11:33:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:40 INFO - 'MOZ_NO_REMOTE': '1', 11:33:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:40 INFO - 'NO_EM_RESTART': '1', 11:33:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:40 INFO - 'PWD': '/builds/slave/test', 11:33:40 INFO - 'SHELL': '/bin/bash', 11:33:40 INFO - 'SHLVL': '1', 11:33:40 INFO - 'TERM': 'linux', 11:33:40 INFO - 'TMOUT': '86400', 11:33:40 INFO - 'USER': 'cltbld', 11:33:40 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044', 11:33:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:40 INFO - '_': '/tools/buildbot/bin/python'} 11:33:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:40 INFO - Downloading/unpacking jsonschema==2.5.1 11:33:40 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:33:40 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:33:40 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:33:40 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:33:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:33:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:33: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:33: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:33: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:33: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:33:41 INFO - Downloading functools32-3.2.3-2.tar.gz 11:33:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:33:41 INFO - warning: no files found matching '*.txt' 11:33:41 INFO - no previously-included directories found matching 'build' 11:33:41 INFO - no previously-included directories found matching 'dist' 11:33:41 INFO - no previously-included directories found matching '.git*' 11:33:41 INFO - Installing collected packages: jsonschema, functools32 11:33:41 INFO - Running setup.py install for functools32 11:33:42 INFO - warning: no files found matching '*.txt' 11:33:42 INFO - no previously-included directories found matching 'build' 11:33:42 INFO - no previously-included directories found matching 'dist' 11:33:42 INFO - no previously-included directories found matching '.git*' 11:33:42 INFO - Successfully installed jsonschema functools32 11:33:42 INFO - Cleaning up... 11:33:42 INFO - Return code: 0 11:33:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2375a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c090>, '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 0x251cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2516f90>, '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': '41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044', '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:33:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:33:42 INFO - Using env: {'DISPLAY': ':0', 11:33:42 INFO - 'HOME': '/home/cltbld', 11:33:42 INFO - 'LANG': 'en_US.UTF-8', 11:33:42 INFO - 'LANGUAGE': 'en_US:en', 11:33:42 INFO - 'LOGNAME': 'cltbld', 11:33:42 INFO - 'MAIL': '/var/mail/cltbld', 11:33:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:42 INFO - 'MOZ_NO_REMOTE': '1', 11:33:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:42 INFO - 'NO_EM_RESTART': '1', 11:33:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:42 INFO - 'PWD': '/builds/slave/test', 11:33:42 INFO - 'SHELL': '/bin/bash', 11:33:42 INFO - 'SHLVL': '1', 11:33:42 INFO - 'TERM': 'linux', 11:33:42 INFO - 'TMOUT': '86400', 11:33:42 INFO - 'USER': 'cltbld', 11:33:42 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044', 11:33:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:42 INFO - '_': '/tools/buildbot/bin/python'} 11:33:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:33:42 INFO - Cleaning up... 11:33:42 INFO - Return code: 0 11:33:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2375a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c090>, '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 0x251cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2516f90>, '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': '41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044', '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:33:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:33:42 INFO - Using env: {'DISPLAY': ':0', 11:33:42 INFO - 'HOME': '/home/cltbld', 11:33:42 INFO - 'LANG': 'en_US.UTF-8', 11:33:42 INFO - 'LANGUAGE': 'en_US:en', 11:33:42 INFO - 'LOGNAME': 'cltbld', 11:33:42 INFO - 'MAIL': '/var/mail/cltbld', 11:33:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:42 INFO - 'MOZ_NO_REMOTE': '1', 11:33:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:42 INFO - 'NO_EM_RESTART': '1', 11:33:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:42 INFO - 'PWD': '/builds/slave/test', 11:33:42 INFO - 'SHELL': '/bin/bash', 11:33:42 INFO - 'SHLVL': '1', 11:33:42 INFO - 'TERM': 'linux', 11:33:42 INFO - 'TMOUT': '86400', 11:33:42 INFO - 'USER': 'cltbld', 11:33:42 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044', 11:33:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:42 INFO - '_': '/tools/buildbot/bin/python'} 11:33:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:42 INFO - Downloading/unpacking blobuploader==1.2.4 11:33:42 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:33:42 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:33:42 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:33:42 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:33:43 INFO - Downloading blobuploader-1.2.4.tar.gz 11:33:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:33:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:33: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:33: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:33: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:33: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:33:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:33:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:33:44 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:33:44 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:33:44 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:33:44 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:33:44 INFO - Downloading docopt-0.6.1.tar.gz 11:33:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:33:44 INFO - Installing collected packages: blobuploader, requests, docopt 11:33:44 INFO - Running setup.py install for blobuploader 11:33:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:33:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:33:44 INFO - Running setup.py install for requests 11:33:44 INFO - Running setup.py install for docopt 11:33:44 INFO - Successfully installed blobuploader requests docopt 11:33:44 INFO - Cleaning up... 11:33:44 INFO - Return code: 0 11:33:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:44 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 0x21ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2375a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c090>, '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 0x251cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2516f90>, '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': '41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044', '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:33:44 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:33:44 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:33:44 INFO - Using env: {'DISPLAY': ':0', 11:33:44 INFO - 'HOME': '/home/cltbld', 11:33:44 INFO - 'LANG': 'en_US.UTF-8', 11:33:44 INFO - 'LANGUAGE': 'en_US:en', 11:33:44 INFO - 'LOGNAME': 'cltbld', 11:33:44 INFO - 'MAIL': '/var/mail/cltbld', 11:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:44 INFO - 'MOZ_NO_REMOTE': '1', 11:33:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:44 INFO - 'NO_EM_RESTART': '1', 11:33:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:44 INFO - 'PWD': '/builds/slave/test', 11:33:44 INFO - 'SHELL': '/bin/bash', 11:33:44 INFO - 'SHLVL': '1', 11:33:44 INFO - 'TERM': 'linux', 11:33:44 INFO - 'TMOUT': '86400', 11:33:44 INFO - 'USER': 'cltbld', 11:33:44 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044', 11:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:44 INFO - '_': '/tools/buildbot/bin/python'} 11:33:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:33:45 INFO - Running setup.py (path:/tmp/pip-2rWNrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:33:45 INFO - Running setup.py (path:/tmp/pip-lgU_OP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:33:45 INFO - Running setup.py (path:/tmp/pip-mzqnfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:33:45 INFO - Running setup.py (path:/tmp/pip-JHUp4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:33:45 INFO - Running setup.py (path:/tmp/pip-IuTWPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:33:45 INFO - Running setup.py (path:/tmp/pip-aUglzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:33:45 INFO - Running setup.py (path:/tmp/pip-Jkt5iD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:33:45 INFO - Running setup.py (path:/tmp/pip-xqlZTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:33:45 INFO - Running setup.py (path:/tmp/pip-7IOYMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:33:45 INFO - Running setup.py (path:/tmp/pip-PaaOE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:33:45 INFO - Running setup.py (path:/tmp/pip-sOsROz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:33:45 INFO - Running setup.py (path:/tmp/pip-HUtRG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:33:45 INFO - Running setup.py (path:/tmp/pip-_fDUdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:33:46 INFO - Running setup.py (path:/tmp/pip-gdz2OA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:33:46 INFO - Running setup.py (path:/tmp/pip-XJdFlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:33:46 INFO - Running setup.py (path:/tmp/pip-Cbgld7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:33:46 INFO - Running setup.py (path:/tmp/pip-GtPfxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:33:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:33:46 INFO - Running setup.py install for manifestparser 11:33:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:33:46 INFO - Running setup.py install for mozcrash 11:33:46 INFO - Running setup.py install for mozdebug 11:33:46 INFO - Running setup.py install for mozdevice 11:33:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:33:46 INFO - Running setup.py install for mozfile 11:33:46 INFO - Running setup.py install for mozhttpd 11:33:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:33:46 INFO - Running setup.py install for mozinfo 11:33:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:33:46 INFO - Running setup.py install for mozInstall 11:33:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:33:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:33:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:33:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:33:47 INFO - Running setup.py install for mozleak 11:33:47 INFO - Running setup.py install for mozlog 11:33:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:33:47 INFO - Running setup.py install for moznetwork 11:33:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:33:47 INFO - Running setup.py install for mozprocess 11:33:47 INFO - Running setup.py install for mozprofile 11:33:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:33:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:33:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:33:47 INFO - Running setup.py install for mozrunner 11:33:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:33:47 INFO - Running setup.py install for mozscreenshot 11:33:47 INFO - Running setup.py install for moztest 11:33:47 INFO - Running setup.py install for mozversion 11:33:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:33:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:33:48 INFO - Cleaning up... 11:33:48 INFO - Return code: 0 11:33:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:48 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 0x21ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2375a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c090>, '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 0x251cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2516f90>, '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': '41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044', '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:33:48 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:33:48 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:33:48 INFO - Using env: {'DISPLAY': ':0', 11:33:48 INFO - 'HOME': '/home/cltbld', 11:33:48 INFO - 'LANG': 'en_US.UTF-8', 11:33:48 INFO - 'LANGUAGE': 'en_US:en', 11:33:48 INFO - 'LOGNAME': 'cltbld', 11:33:48 INFO - 'MAIL': '/var/mail/cltbld', 11:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:48 INFO - 'MOZ_NO_REMOTE': '1', 11:33:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:48 INFO - 'NO_EM_RESTART': '1', 11:33:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:48 INFO - 'PWD': '/builds/slave/test', 11:33:48 INFO - 'SHELL': '/bin/bash', 11:33:48 INFO - 'SHLVL': '1', 11:33:48 INFO - 'TERM': 'linux', 11:33:48 INFO - 'TMOUT': '86400', 11:33:48 INFO - 'USER': 'cltbld', 11:33:48 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044', 11:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:48 INFO - '_': '/tools/buildbot/bin/python'} 11:33:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:33:48 INFO - Running setup.py (path:/tmp/pip-gXgccT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:33:48 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:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:33:48 INFO - Running setup.py (path:/tmp/pip-5E7ybJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:33:48 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:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:33:48 INFO - Running setup.py (path:/tmp/pip-_a7Npm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:33:48 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:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:33:48 INFO - Running setup.py (path:/tmp/pip-qHfKin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:33:48 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:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:33:48 INFO - Running setup.py (path:/tmp/pip-S8kpZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:33:48 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:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:33:48 INFO - Running setup.py (path:/tmp/pip-8NgmxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:33:48 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:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:33:48 INFO - Running setup.py (path:/tmp/pip-Aggu1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:33:48 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:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:33:48 INFO - Running setup.py (path:/tmp/pip-vC8UMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:33:48 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:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:33:48 INFO - Running setup.py (path:/tmp/pip-E7Dhph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:33:48 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:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:33:48 INFO - Running setup.py (path:/tmp/pip-7ZC5o3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:33:48 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:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:33:48 INFO - Running setup.py (path:/tmp/pip-PkEMrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:33:49 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:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:33:49 INFO - Running setup.py (path:/tmp/pip-QKEOjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:33:49 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:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:33:49 INFO - Running setup.py (path:/tmp/pip-hgiu7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:33:49 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:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:33:49 INFO - Running setup.py (path:/tmp/pip-8TS08a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:33:49 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:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:33:49 INFO - Running setup.py (path:/tmp/pip-cxzq24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:33:49 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:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:33:49 INFO - Running setup.py (path:/tmp/pip-I_ePoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:33:49 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:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:33:49 INFO - Running setup.py (path:/tmp/pip-i74bU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:33:49 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:33:49 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:33:49 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:33:49 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:33:49 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:33:49 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:33:49 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:33:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:50 INFO - Downloading blessings-1.6.tar.gz 11:33:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:33:50 INFO - Installing collected packages: blessings 11:33:50 INFO - Running setup.py install for blessings 11:33:50 INFO - Successfully installed blessings 11:33:50 INFO - Cleaning up... 11:33:50 INFO - Return code: 0 11:33:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:33:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:33:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:33:51 INFO - Reading from file tmpfile_stdout 11:33:51 INFO - Current package versions: 11:33:51 INFO - argparse == 1.2.1 11:33:51 INFO - blessings == 1.6 11:33:51 INFO - blobuploader == 1.2.4 11:33:51 INFO - docopt == 0.6.1 11:33:51 INFO - functools32 == 3.2.3-2 11:33:51 INFO - jsonschema == 2.5.1 11:33:51 INFO - manifestparser == 1.1 11:33:51 INFO - mozInstall == 1.13 11:33:51 INFO - mozcrash == 1.0 11:33:51 INFO - mozdebug == 0.1 11:33:51 INFO - mozdevice == 0.51 11:33:51 INFO - mozfile == 1.2 11:33:51 INFO - mozhttpd == 0.7 11:33:51 INFO - mozinfo == 0.10 11:33:51 INFO - mozleak == 0.1 11:33:51 INFO - mozlog == 3.5 11:33:51 INFO - moznetwork == 0.27 11:33:51 INFO - mozprocess == 0.25 11:33:51 INFO - mozprofile == 0.28 11:33:51 INFO - mozrunner == 6.13 11:33:51 INFO - mozscreenshot == 0.1 11:33:51 INFO - mozsystemmonitor == 0.3 11:33:51 INFO - moztest == 0.8 11:33:51 INFO - mozversion == 1.4 11:33:51 INFO - psutil == 3.1.1 11:33:51 INFO - requests == 1.2.3 11:33:51 INFO - wsgiref == 0.1.2 11:33:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:51 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 0x21ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2375a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c090>, '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 0x251cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2516f90>, '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': '41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044', '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:33:51 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:33:51 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:33:51 INFO - Using env: {'DISPLAY': ':0', 11:33:51 INFO - 'HOME': '/home/cltbld', 11:33:51 INFO - 'LANG': 'en_US.UTF-8', 11:33:51 INFO - 'LANGUAGE': 'en_US:en', 11:33:51 INFO - 'LOGNAME': 'cltbld', 11:33:51 INFO - 'MAIL': '/var/mail/cltbld', 11:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:51 INFO - 'MOZ_NO_REMOTE': '1', 11:33:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:51 INFO - 'NO_EM_RESTART': '1', 11:33:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:51 INFO - 'PWD': '/builds/slave/test', 11:33:51 INFO - 'SHELL': '/bin/bash', 11:33:51 INFO - 'SHLVL': '1', 11:33:51 INFO - 'TERM': 'linux', 11:33:51 INFO - 'TMOUT': '86400', 11:33:51 INFO - 'USER': 'cltbld', 11:33:51 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044', 11:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:51 INFO - '_': '/tools/buildbot/bin/python'} 11:33:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:51 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:33:51 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:33:51 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:33:51 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:33:51 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:33:51 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:33:51 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:33:51 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:33:51 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:33:51 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:33:53 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:33:53 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:33:53 INFO - Installing collected packages: simplejson 11:33:53 INFO - Running setup.py install for simplejson 11:33:53 INFO - building 'simplejson._speedups' extension 11:33:53 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:33:54 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:33:54 INFO - Successfully installed simplejson 11:33:54 INFO - Cleaning up... 11:33:54 INFO - Return code: 0 11:33:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:33: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:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33: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:33:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2375a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c090>, '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 0x251cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2516f90>, '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': '41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044', '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:33:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:33:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:33:54 INFO - Using env: {'DISPLAY': ':0', 11:33:54 INFO - 'HOME': '/home/cltbld', 11:33:54 INFO - 'LANG': 'en_US.UTF-8', 11:33:54 INFO - 'LANGUAGE': 'en_US:en', 11:33:54 INFO - 'LOGNAME': 'cltbld', 11:33:54 INFO - 'MAIL': '/var/mail/cltbld', 11:33:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:54 INFO - 'MOZ_NO_REMOTE': '1', 11:33:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:54 INFO - 'NO_EM_RESTART': '1', 11:33:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:54 INFO - 'PWD': '/builds/slave/test', 11:33:54 INFO - 'SHELL': '/bin/bash', 11:33:54 INFO - 'SHLVL': '1', 11:33:54 INFO - 'TERM': 'linux', 11:33:54 INFO - 'TMOUT': '86400', 11:33:54 INFO - 'USER': 'cltbld', 11:33:54 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044', 11:33:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:54 INFO - '_': '/tools/buildbot/bin/python'} 11:33:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:33:54 INFO - Cleaning up... 11:33:54 INFO - Return code: 0 11:33:54 INFO - Running post-action listener: _resource_record_post_action 11:33:54 INFO - Running post-action listener: _start_resource_monitoring 11:33:54 INFO - Starting resource monitoring. 11:33:54 INFO - [mozharness: 2017-09-06 18:33:54.713783Z] Finished create-virtualenv step (success) 11:33:54 INFO - [mozharness: 2017-09-06 18:33:54.714292Z] Running install step. 11:33:54 INFO - Running pre-action listener: _resource_record_pre_action 11:33:54 INFO - Running main action method: install 11:33:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:33:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:33:54 INFO - Reading from file tmpfile_stdout 11:33:54 INFO - Detecting whether we're running mozinstall >=1.0... 11:33:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:33:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:33:55 INFO - Reading from file tmpfile_stdout 11:33:55 INFO - Output received: 11:33:55 INFO - Usage: mozinstall [options] installer 11:33:55 INFO - Options: 11:33:55 INFO - -h, --help show this help message and exit 11:33:55 INFO - -d DEST, --destination=DEST 11:33:55 INFO - Directory to install application into. [default: 11:33:55 INFO - "/builds/slave/test"] 11:33:55 INFO - --app=APP Application being installed. [default: firefox] 11:33:55 INFO - mkdir: /builds/slave/test/build/application 11:33:55 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:33:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:34:11 INFO - Reading from file tmpfile_stdout 11:34:11 INFO - Output received: 11:34:11 INFO - /builds/slave/test/build/application/firefox/firefox 11:34:11 INFO - Running post-action listener: _resource_record_post_action 11:34:11 INFO - [mozharness: 2017-09-06 18:34:11.556360Z] Finished install step (success) 11:34:11 INFO - [mozharness: 2017-09-06 18:34:11.556609Z] Running setup-mitmproxy step. 11:34:11 INFO - Running pre-action listener: _resource_record_pre_action 11:34:11 INFO - Running main action method: setup_mitmproxy 11:34:11 INFO - Skipping: mitmproxy is not required 11:34:11 INFO - Running post-action listener: _resource_record_post_action 11:34:11 INFO - [mozharness: 2017-09-06 18:34:11.557802Z] Finished setup-mitmproxy step (success) 11:34:11 INFO - [mozharness: 2017-09-06 18:34:11.558018Z] Running run-tests step. 11:34:11 INFO - Running pre-action listener: _resource_record_pre_action 11:34:11 INFO - Running pre-action listener: _set_gcov_prefix 11:34:11 INFO - Running main action method: run_tests 11:34:11 WARNING - Try message not found. 11:34:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:34:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:34:11 INFO - Python 2.7.3 11:34:11 INFO - Return code: 0 11:34:11 INFO - grabbing minidump binary from tooltool 11:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:11 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 0x251c090>, '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 0x251cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2516f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:34:11 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:34:11 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:34:11 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:34:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:34:11 INFO - Return code: 0 11:34:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:34:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:34:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:34:11 INFO - ENV: RUST_BACKTRACE is now full 11:34:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:34:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:34:11 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/CNiQiOuNT32DU3L464s6DA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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:34:11 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/CNiQiOuNT32DU3L464s6DA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-026 --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:34:11 INFO - Using env: {'DISPLAY': ':0', 11:34:11 INFO - 'HOME': '/home/cltbld', 11:34:11 INFO - 'LANG': 'en_US.UTF-8', 11:34:11 INFO - 'LANGUAGE': 'en_US:en', 11:34:11 INFO - 'LOGNAME': 'cltbld', 11:34:11 INFO - 'MAIL': '/var/mail/cltbld', 11:34:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:34:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:11 INFO - 'MOZ_NO_REMOTE': '1', 11:34:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:34:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:11 INFO - 'NO_EM_RESTART': '1', 11:34:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:11 INFO - 'PWD': '/builds/slave/test', 11:34:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:34:11 INFO - 'RUST_BACKTRACE': 'full', 11:34:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:34:11 INFO - 'SHELL': '/bin/bash', 11:34:11 INFO - 'SHLVL': '1', 11:34:11 INFO - 'STYLO_FORCE_ENABLED': '1', 11:34:11 INFO - 'STYLO_THREADS': '1', 11:34:11 INFO - 'TERM': 'linux', 11:34:11 INFO - 'TMOUT': '86400', 11:34:11 INFO - 'USER': 'cltbld', 11:34:11 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044', 11:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:11 INFO - '_': '/tools/buildbot/bin/python'} 11:34:11 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/CNiQiOuNT32DU3L464s6DA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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:34:11 INFO - mozversion application_buildid: 20170906173802 11:34:11 INFO - mozversion application_changeset: 93dd2e456c0ecca00fb4d28744e88078a77deaf7 11:34:11 INFO - mozversion application_display_name: Nightly 11:34:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:34:11 INFO - mozversion application_name: Firefox 11:34:11 INFO - mozversion application_remotingname: firefox 11:34:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:34:11 INFO - mozversion application_vendor: Mozilla 11:34:11 INFO - mozversion application_version: 57.0a1 11:34:11 INFO - mozversion platform_buildid: 20170906173802 11:34:11 INFO - mozversion platform_changeset: 93dd2e456c0ecca00fb4d28744e88078a77deaf7 11:34:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:34:11 INFO - mozversion platform_version: 57.0a1 11:34:11 INFO - using testdate: 1504722851 11:34:11 INFO - actual date: 1504722851 11:34:11 INFO - starting webserver on 'localhost:36518' 11:34:11 INFO - SUITE-START | Running 2 tests 11:34:11 INFO - TEST-START | dromaeo_css 11:34:11 INFO - Initialising browser for dromaeo_css test... 11:34:11 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36518/getInfo.html -profile /tmp/tmpCoI2cP/profile 11:34:11 INFO - TEST-INFO | started process 19302 (/builds/slave/test/build/application/firefox/firefox http://localhost:36518/getInfo.html) 11:34:17 INFO - TEST-INFO | 19302: exit 0 11:34:17 INFO - Browser initialized. 11:34:17 INFO - Running cycle 1/1 for dromaeo_css test... 11:34:17 INFO - Using env: {'DISPLAY': ':0', 11:34:17 INFO - 'HOME': '/home/cltbld', 11:34:17 INFO - 'JSGC_DISABLE_POISONING': '1', 11:34:17 INFO - 'LANG': 'en_US.UTF-8', 11:34:17 INFO - 'LANGUAGE': 'en_US:en', 11:34:17 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:34:17 INFO - 'LOGNAME': 'cltbld', 11:34:17 INFO - 'MAIL': '/var/mail/cltbld', 11:34:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:34:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:34:17 INFO - 'MOZ_CRASHREPORTER': '1', 11:34:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:17 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:34:17 INFO - 'MOZ_NO_REMOTE': '1', 11:34:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:34:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:17 INFO - 'NO_EM_RESTART': '1', 11:34:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:17 INFO - 'PWD': '/builds/slave/test', 11:34:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:34:17 INFO - 'RUST_BACKTRACE': 'full', 11:34:17 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:34:17 INFO - 'SHELL': '/bin/bash', 11:34:17 INFO - 'SHLVL': '1', 11:34:17 INFO - 'STYLO_FORCE_ENABLED': '1', 11:34:17 INFO - 'STYLO_THREADS': '1', 11:34:17 INFO - 'TERM': 'linux', 11:34:17 INFO - 'TMOUT': '86400', 11:34:17 INFO - 'USER': 'cltbld', 11:34:17 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044', 11:34:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:17 INFO - '_': '/tools/buildbot/bin/python'} 11:34:17 INFO - TEST-INFO | started process 19484 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCoI2cP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:34:18 INFO - PID 19484 | 11:34:18 INFO - PID 19484 | (/builds/slave/test/build/application/firefox/firefox:19536): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:34:18 INFO - PID 19484 | 11:34:29 INFO - PID 19484 | RSS: Main: 172572672 11:34:29 INFO - PID 19484 | 11:37:26 INFO - PID 19484 | Cycle 1(1): loaded http://localhost:36518/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36518/tests/dromaeo/cssquery-ext.html) 11:37:27 INFO - PID 19484 | RSS: Main: 175493120 11:37:27 INFO - PID 19484 | 11:40:29 INFO - PID 19484 | Cycle 1(1): loaded http://localhost:36518/tests/dromaeo/cssquery-ext.html (next: http://localhost:36518/tests/dromaeo/cssquery-jquery.html) 11:40:29 INFO - PID 19484 | RSS: Main: 170405888 11:40:29 INFO - PID 19484 | 11:43:31 INFO - PID 19484 | Cycle 1(1): loaded http://localhost:36518/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36518/tests/dromaeo/cssquery-mootools.html) 11:43:31 INFO - PID 19484 | RSS: Main: 174116864 11:43:31 INFO - PID 19484 | 11:46:33 INFO - PID 19484 | Cycle 1(1): loaded http://localhost:36518/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36518/tests/dromaeo/cssquery-prototype.html) 11:46:34 INFO - PID 19484 | RSS: Main: 172503040 11:46:34 INFO - PID 19484 | 11:49:37 INFO - PID 19484 | Cycle 1(1): loaded http://localhost:36518/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36518/tests/dromaeo/cssquery-yui.html) 11:49:38 INFO - PID 19484 | RSS: Main: 173883392 11:49:38 INFO - PID 19484 | 11:52:39 INFO - PID 19484 | Cycle 1(1): loaded http://localhost:36518/tests/dromaeo/cssquery-yui.html (next: http://localhost:36518/tests/dromaeo/cssquery-dojo.html) 11:52:40 INFO - PID 19484 | RSS: Main: 176537600 11:52:40 INFO - PID 19484 | 11:52:40 INFO - PID 19484 | __start_tp_report 11:52:40 INFO - PID 19484 | _x_x_mozilla_page_load 11:52:40 INFO - PID 19484 | _x_x_mozilla_page_load_details 11:52:40 INFO - PID 19484 | |i|pagename|runs| 11:52:40 INFO - PID 19484 | |0;dojo.html;3291.2430141067553;3295.7033866951983;3302.3725492156486;3336.666333366664;3341.398548261315;6456.451201647859;6463.7853324481985;6485.027245913109;6518.576292540982;6548.901766473501;6362.395572420624;6449.387308205724;6453.322401147871;6474.482041436686;6474.514411419151;5893.263342082239;5895.587308888379;5915.319738230094;5934.287885453751;5965.224520812289;6012.789552365668;6027.186329845458;6027.246594175728;6041.426064523863;6056.818295451144;5897.11543268511;5969.22400087988;5972.223610930573;5987.790427335044;6004.729787159588;5765;5816.040353341694;5830.271216097988;5948.613340132878;5951.315598706139;5890.676012819294;5893.057110862242;5931.851703707399;5983.491403230731;5986.431289027535;6425.389587989133;6445.806625801233;6464.579802312882;6491.058796474485;6552.082708420825;6755.898661520081;6828.0440738296675;6840.965795171042;6861.828454288633;6998.860022799516;6913.965430172867;6915.412189963859;6940.72237110515;7030.507864449491;7035.753748618774;6492.610443373413;6494.675266236669;6506.902396464056;6508.316626754217;6513.706883190268;6991.196012458632;7092.716291348288;7192;7195.496315257987;7202.783916482409;6668.099806526154;6781.796546103625;6790.320967903269;6847.554908930903;6873.450123990069;6863.794086177422;6888.242293347727;6942.93057069433;6956.2000369958105;6958.095447591882;6944.722211111499;6951.756688515878;6988.056612357368;6995.370416662525;7015.088038554955;6856.24581296057;6895;6928.4803639726215;6944;7016.7544135954995;5348.679079255257;5443.782248710087;5454.836354909359;5479.972600136974;5518.834434966958;4709.0817290628;4742.786574604151;4770.546798054179;4823.3729615149805;4827.131116399082;6091.939080609137;6113.938860611426;6172.753089876354;6174.8147555573405;6180.258368995659;6973.302669733088;6975.337342952412;6981.197162326296;7057;7063.223045464994;5970.223870896755;6061;6072.51419886408;6075.878482430415;6157.199564056644;5943.613665111754;5948.464638182498;5953.226080609493;5955.970220148958;5956.55325850563;6610.900836487456;6634.86730265392;6639.933600664028;6696.531242812956;6708.765193218214;6899.965500172467;6982.615956122462;6990.545614535039;6999.685014174476;7007.614581198083;6599.967000164968;6605.801825945229;6633.502487313374;6695.230048544479;6703.363180497845;6628.337166283333;6705.731770729116;6711.932880671131;6772.221194562689;6836.350546698056;6997.510174287751;7023.157221133497;7032.472564557781;7055.223925368308;7059.682314295972;6709.127813384424;6767.323267673193;6772.0857684212;6776.661166941732;6806.6256355900905;6696.397324240842;6707.631080290631;6723.2604413515455;6798.4221341184575;6834.419074378733;6452.419282264619;6545.312742162195;6555;6656.134702488645;6666.400023997863;6789.355011273921;6802.93197068023;6823.761168359084;6824.556403833735;6871.4502839773695;6547.181602299713;6569.146011018537;6647.169103862017;6648.401643852077;6676.732930682912 11:52:40 INFO - PID 19484 | |1;ext.html;743.546436673629;795.5107608820574;820.2822530285999;821.6754382019099;1137.7269455330722;29599.704002959963;30545;39157.41263881044;40213.7989310053;40404.79797601015;38965;39287.41068883969;39332.80333598335;39391.60608393915;39405;7417.443691723115;7627.656755446018;7670.539767613933;7678.308952194301;7694.807629809244;7583.848323033536;7673.271039251262;7677.692892284302;7680.193579674137;7680.308772210527;7642.04474440695;7691.615419229044;7695.653695583712;7702.268284512962;7707.036620422447;7667.194944530827;7690.15408305086;7697.461177717562;7698.807529811744;7710.922890771105;7535.849283014364;7559.886601700979;7562.697492100309;7624.161342252348;7633.809154771119;35982;36399.454008189896;36403;36419.63580364189;36431.81784091089;3549.6627820357025;3574.4459608760685;3584;3589.5513060867393;3598;29982.400351992837;30124;30145.849270753726;30165.245868853235;30172.396552069054;4914.508549145093;5066.771995260222;5121.385433747937;5173.0688476074665;5181.870453238662;169663;172219;172542.137289314;172572.99999999875;173112;45328;45329.77335113303;45343.31985020227;45508;45563.54436455659;47636.28545571819;47694.761526192146;47711.761441192575;47734;47770.52229477661;13736.519221827188;13853.930730346283;15737.606559836096;16028.278727457293;16041.679166416607;12929.54746583884;13274.203547787163;13296.800547991788;13301.06892517534;13322.067455278038;13169.868301317056;13395.995300352317;13437.932810336082;13444.395002224728;13497.527586534621;5570.3315602128005;5693.4875861172695;5718.370979192286;5728.885422291614;5821.068629019336;1005.3515482513737;1013.3970287678819;1025.7281820317621;1039.1998161415668;1051.2063392138887;22188.89055547216;22618.321450356514;22623.547529049327;23011.079556817538;23050.077996879936;1116.8715597706205;1122.7305446692735;1135.1429670598645;1140.509580880213;1143.102664408452;11861.46623401949;11900.166988310908;11946.820797688042;11962.222455540363;12075.275483470845;234372;236752;236897;237036;237520;50666.74666626643;50963.7451812746;51065.48934510607;51169.744151279;51327;1410.774276115837;1440.8847292216808;1467.8091848059898;1468.875145612635;1479.0238442627815;22103.557928841656;22222.555548889253;22391.664125037812;22588.435289117904;22796;35907.28185436329;35957;35994.28011439704;35995.46006809952;36048.8197559021;195558;195926;195955;196182;196210;32028.839855800572;32083.518747219277;33126;33690.83154584211;33726.83136584301;40569;41849;41929;42202.788986054875;42256.1548769029;31550;31785;31957.20106997344;32041.198970025936;32454.675453245167;31616.36767264596;31696.20759480939;31783.205419864687;31845.20386990344;32256.193595160308;34840.9547713569;35737.64262357447;35746.463803042454;35803.46294805632;36076.639233607326;30982.69017309798;31423.21441963969;31467.213319667193;31744.6825531751;31778.682213178497;23168;23261.04929724768;23686.644700329165;23691.881540592185;23840.880795595913 11:52:40 INFO - PID 19484 | |2;jquery.html;567.2597260574951;568.6843801690062;571.4713889652073;576.3084298841386;587.9323877754059;21719;22445.887770561167;22836.54326913463;22909.198178063773;22932.65601015982;25673.22980310589;26097.217083487478;26136.346591335227;26419.471610567776;26419.86790066047;6571.737130514785;6754.66226688666;6757.526973111884;6763.357481039294;6779.220389655179;6727.360900714424;6903.723851045977;7185.425165986709;7208.459365547578;7262.600556969364;7166.068411106548;7169.713211471561;7172.211056783775;7177.461690373217;7235.493515453921;7242.601656908868;7250.891236631454;7251.637418129125;7254.202037775841;7259.128904531463;7082;7091.361777440004;7097.680604372816;7099.183593886717;7101.325374089453;30629.38741225163;31434.528482072557;31560.684393156003;31748.523772143435;31775.364492710018;2100.0444797617047;2122.61792877282;2129.4144110369616;2130.499332656824;2132.6907598398147;20341.389758307127;20903.37289881306;20918;21013.264535741328;21084.05121769524;1855.1002763659615;2022.1608032666427;2063.8348932085546;2073.0463986566197;2548.617707343895;136340;138231;139143.30428347894;139855;140258.2987085058;20744.896275518528;21672.674909876365;21800.34598962034;22831.657525137136;22951.54096918052;43724.344134838;43812;43822.34266486005;43904.78047609805;43999.78000109979;11474.139439542068;11540.307581545134;11593.913095642696;11632.825507617392;11634.941825290989;8646;9036.096390361043;9642.903570964341;9719.222462203006;9785.510724463747;10729.946350268356;10793.946030269799;11522.193446458667;11560.479778409992;11655;3544.8422545196677;3650.872219472306;3928.6639950555277;3934.586868378779;3972.106276087857;968.4576637083256;983.468926779531;986.1666891476691;995.7162208770466;996.7358649957768;19875.900620496806;20491.59016819655;20527.79472205259;20771.68842467364;20813.479663008548;1063.0698139128262;1064.2497039587226;1065.5205157679075;1073.1575713065206;1074.8710154781477;11023.889761102286;11516.136289778133;11553.826692599618;11565.19043666952;11601.18791684574;453718;456953;463384;465128;465858;112515;113103;114084;115699;118090;1162.3548930343572;1169.6257197696655;1187.566538213563;1190.6070996571111;1201.5854530187246;18698.626027479648;18752;21190;22350.664740028587;22454;54927;58312;59914;60676.69661651664;60716.39283607284;71533.28466715266;72108.63945680238;72219.63890180516;72908;73278.63360683376;14529.346179422162;15031.323590438238;15033.022853514487;15041.548753536974;15244.314005869985;22982.655260170777;23038.42403939848;23116.768832312133;23330.65004024907;23427.76572234256;18688.34590789316;19117.522061948563;19141.521461963563;19181;19259.61480770405;16053.67892642164;16109.516714498584;16194.67610647804;16288.918555407621;17450.301987920848;18122.81877181211;19356.61286774285;19356.70964935499;19408.61182776365;19418.223271069564;14818.184999825113;14896.702065958836;14920.403183872957;14923.179225142721;15003.774943376076;18393.724094138866;18630.254789808256;18661;18665;18731.531711707317 11:52:40 INFO - PID 19484 | |3;mootools.html;1300.71384295455;1335.9332033398327;1361.0880709924356;1364.4064831798166;1366.398784534804;14964.925175374121;15129.167895765728;15677.608059798496;15756.92121539392;15766.132862692548;15530.30113644886;15806.13066281354;15823.446179383724;15887.920560397211;15890.284937177827;2772.514809908268;2818.422223444189;2824.985875070632;2826.985865070672;2833.150054983507;2737.671479422472;2939.3092623233524;2941.2793865502877;2949.7935144539892;2949.9557506637416;2753.408017276285;2850.50116229659;2857.6427946506687;2897.507423737959;2898.30440694234;2774.1677496750895;2796.6504186976626;2799.1182777425047;2805.4809860175833;2810.7470327670508;2533.8859751311234;2562.743725627441;2571.434284457416;2578.355411147213;2580.109862097573;14877.851221487756;15242.161681107535;15243.542693719206;15279.465218717292;15283;7884.842303153905;8138.2268684475475;8139.348852091818;8157.388195885333;8165;5317.821421029398;5477.808276710336;5510.6969116698565;5605.747741351649;5614.466625670555;1983.2860170338668;2003.4991252186953;2004.188303736989;2039.836813054952;2048.7439070116234;26021.349466263306;26156.607650885253;26182.476350472883;26198.476030479284;26292;7385.187629360766;7455.403567714569;7609.086909570887;7675.5010924289745;7703.3067023968115;17142.828571714123;17155.828441715672;17157.742633860504;17188.484345469657;17211.655766884593;7917.881231781528;8060.596970151469;8071.636776345079;8072.031356237172;8079.959600201962;7406.259374062658;7460.29127232912;7517.699292028257;7536.133344665324;7540.811479713051;5193.688378697215;5418.91871621926;5419;5442.292501974797;5448.700321482356;1494.2304713072776;1502.1813111854067;1503.0305452982766;1506.1791323728594;1514.530495546362;911.1662828511837;927.888653361601;931.0828833599035;941.096547314572;945.2910317262053;7890.842183156305;7940.28537431634;7976.122626511079;7988.440809143421;8001.399895007781;714.9428045756327;721.0950257426896;722.544796778037;727.4943913979733;731.7877815433571;5255.106631872591;5416.674999500043;5513.476219759116;5525.475079867406;5588.30146231721;20711;21191.894040530005;21542.676859847114;21578.676319855214;21811.23660671869;20026.399208023493;21435.46411339729;21475.785242147693;21581.24465643695;21668.183136192194;11399.886001140048;11618.419079046183;11664.358460284597;11686.47410866513;11693.239939403911;8432.662693492191;8687.86968195465;8939.73180804577;9057.18485336323;9331.486768227813;18273.3604323848;18361.632767344847;18478.630427391647;18622.813771862107;18860.811391885905;18826.52933676669;18955.14701838393;18968.715469267696;19178.328758493943;19257.5185620355;11666.88333116658;12487.438065286902;12664.240145591293;12709.36453177319;12726.87273127257;14109.717805643624;14274;14276.21480818565;14279.143251404948;14280.928595356956;11397.08823294118;11408.82886756716;11424.314541127558;11541.653750387166;11706.88293117058;11159.665210043711;11241.66275011751;11370.54517819311;11496.94251528737;11688.649340519798;10054.34646747959;10101.545430455793;10106.646267380607;10130.746731331776;10163.593456261962;7295.708171673074;7327.377172940147;7332.670029848563;7339;7347.595882226529;7239.2155691900925;7439.070116235471;7455.888161677471;7473.6263186841525;7479.88780168287 11:52:40 INFO - PID 19484 | |4;prototype.html;494.30699853003455;504.2738456622461;522.6524361299736;528.2868128027163;529.4255732530205;6221.898043604247;6348.619082855032;6398.168238129043;6433.388828061338;6493.967530162355;6173.228346456693;6185.474234690057;6195.876082478348;6196.411340922605;6274.466670333016;4987.152184128707;5039.546440820325;5049.192129259319;5056.367954005749;5111.284420181178;4988.925166122511;5002.699838009731;5030.144875371196;5031.647784655075;5113.795448182087;4980.178270585349;5010.899782004358;5036.244563315496;5085;5119.12974794284;4969.180085285923;4989.276554899538;5003.749812509396;5034.798608055673;5047;4538.3873177120995;4542.931856022163;4551.635869130461;4552.089582083563;4578.633709303248;6241.438270555626;6272.905906411407;6278.434940855345;6281.434670879597;6295.370462953668;5741.3110426748635;5786.566007549451;5793.913091303634;5820.708964551755;5833.708314584296;6498.642574658392;6612.43794277487;6629.7016634251095;6630.867382652368;6655.401013908723;4873.926891096637;4887.9735255596015;4915.188993816052;4952.380952380952;4952.479989601076;6961.512694111414;6990.196127445358;7013.684384202723;7045.753398631024;7088.610126443044;4995.175795993693;5034.79860805571;5046.082488654288;5048.242763585418;5061.5950723942;5063.316452278968;5134.922976155361;5135.512126347991;5142.871428214325;5149.45930677281;5695.288088988877;5735.677050794435;5765.913511297334;5772.7113644317615;5793.159991801165;6588.96705516479;6606.570572912745;6646.670665866846;6655.900161497581;6717.596944183365;1675.4722262487278;1704.3949397963793;1897.023033137935;1931.72506145943;1944.6791279439017;1424.6295963049474;1438.4605772835187;1465.8021167142513;1470.3016067368128;1486.5540337898587;5871.706414679249;5873.442023007808;5880.353161152269;5918.171455996164;5952.523798096142;6532.608043517404;6765.086713293643;6804.6257455840405;6883.793486195422;6900.896486552605;5973.611715238582;5976.342602313742;6000.549958753024;6010.3689112643415;6032.909506357408;3509.4560343146854;3509.8069606171907;3589.1565482111682;3610.819459027038;3625.546806649169;6500.382463665944;6576.86846263072;6637.767678131242;6647.833804154935;6682.164729408824;6882.8623427531165;6947.3747362736585;7026.543274687129;7027.121609798775;7142.607156606437;6485.61086334812;6556.737730490727;6563.442107420923;6608.413980644611;6670.9332906670315;6779.966100169468;6859.965700171667;6888.311168883071;6896.793061214167;6905.551139175937;6716.899246511404;6767.492438067066;6768.7139443505575;6780.626495910209;6802.727890884309;6563.835904102245;6564.540482166202;6564.737410503526;6568.489247473203;6666.633335166613;4967.677100988424;4990.750462476934;5057.342545469212;5072.51811077947;5074.746262686925;6521.217453905561;6767.729290828312;6872.450203983769;6878.896816547855;6936.445084393135;6330.252310766925;6486.902696459651;6630.602163870183;6644.368784965421;6674.199096108498;6591.604503729792;6637.1703537057865;6638.668066596748;6660.933390666031;6680.432163266177;6275.34108918557;6466.159399278252;6472.773452929125;6517.902231466437;6519.152510173647;6495.642739649175;6528.183977002875;6592.274849766618;6628.469722422291;6657.2677005528385;6334.1765570475545;6350.634613558107;6416.230052393743;6456.967715161394;6457.838554036187 11:52:40 INFO - PID 19484 | |5;yui.html;900.4732231644488;918.5269586163126;921.2123634292684;921.3826736086821;928.7863791327994;18671.906640466797;19720.605587888233;19806.30677926271;19882.403527894152;21737.3478795636;19449.31927382542;20524.28165014225;20823.27118550851;20838.166473341047;20850.374488765323;752.849430113978;979.7746518300795;979.7893452907623;980.9068138526828;984.7291994701443;995.6017592962836;1004.0511716427978;1005.612839056961;1007.5969612155124;1008.1279693065519;1049.9947500262526;1053.3206082077056;1055.984160237597;1056.2553399853123;1057.471264367816;1038.2576457832647;1041.3231399590252;1042.4996001919046;1042.7601651620093;1043.2488608202082;770.803445121496;771.0285040848515;771.0516065239731;773.0684525147184;774.3534148985603;18508.44474665762;18726.157322920502;18795.812041879544;20186.697199542017;20301.086451109586;20846.374608761762;21051;21432.892835535877;21581;21620.675689864664;16966.066866322348;17079.573010674707;17345.306187752474;17566.38517651889;17647.558811029827;3708.7774733516076;3749.268892565951;3752.1182522107283;3752.8123593820474;3753.3431649461236;121341;123017.76982230153;123238;124428;124870;16454.177291135395;16694.165291735364;16759.41342053022;16907;17039.659206815795;29922.55116173259;29973.550396744067;30431.239219019702;30433.69566304353;30461.390772184433;7831.6475758591005;8177.304929080976;8435.493870367798;8521.44610600309;8547.829043419097;4135.545090040093;4299.355096735515;4316.633086187647;4338;4338.891527711832;5361.0618141825025;5426.647267927572;5525.336959564797;5535.418781027934;5541.445855414507;1128.0468004536153;1132.2413982631656;1143.1597775634903;1143.6397534776518;1146.2320245435412;693.7121094745725;702.4977141343963;709.3474003916306;719.2016861283971;720.5316544246282;11933.522659093713;12202.572909948109;12266.75466490683;12403.25580465175;12426.316552589513;642.2934771751037;643.9227292724903;686.6978529447027;697.7209116353499;699.2622782964022;5632.098864181793;5961.660100705689;6019.909701354483;6093.329733729286;6125.663088530174;109269.45365273123;109987.45006274918;110961;113079.43460282646;115187.42406287914;93945.5302723482;97599.51200243953;99619.50190249148;103168;103265;84294.57852710698;84628.57685711655;84829.15170848336;88031.55984220166;90188;9760.463174525185;9806.558704858442;9895.505224738878;9924.206063515046;10183.33808302458;41405.37891931563;41544;41638.37542436927;43488.56511434845;43743.125137496434;54365.45634543762;55818.72090639521;69807.30192698009;71221.64389178022;73076;18176.27294908189;18371.448856534324;18371.90814045921;18446.72329915079;18598.628027439645;19339.129739162054;19879.900600496905;20311.390658280274;21535.569288613828;22206.77793222047;18914.43256702301;19177.137028834015;19310.8068919309;19478;19493.415197544095;19775;19781.10985005707;19864.304749333704;19866.801331987073;19964.50088747735;18607.627847443247;18713.345032923782;18752.81247187565;18796.530086747942;19598.510037249183;13608.387622556811;13858.861411385757;14103.224322661941;14368.712625747217;14442;14149.646258843612;14470.276486175439;14595.489157879423;14611.634709132357;14781.92609036948 11:52:40 INFO - PID 19484 | __end_tp_report 11:52:40 INFO - PID 19484 | __start_cc_report 11:52:40 INFO - PID 19484 | _x_x_mozilla_cycle_collect,349 11:52:40 INFO - PID 19484 | __end_cc_report 11:52:40 INFO - PID 19484 | __startTimestamp1504723960139__endTimestamp 11:52:40 INFO - PID 19484 | 11:52:40 INFO - PID 19484 | ------- Summary: start ------- 11:52:40 INFO - PID 19484 | Number of tests: 6 11:52:40 INFO - PID 19484 | 11:52:40 INFO - PID 19484 | [#0] dojo.html Cycles:165 Average:6379.06 Median:6610.90 stddev:752.28 (11.4%) stddev-sans-first:714.53 11:52:40 INFO - PID 19484 | Values: 3291.2 3295.7 3302.4 3336.7 3341.4 6456.5 6463.8 6485.0 6518.6 6548.9 6362.4 6449.4 6453.3 6474.5 6474.5 5893.3 5895.6 5915.3 5934.3 5965.2 6012.8 6027.2 6027.2 6041.4 6056.8 5897.1 5969.2 5972.2 5987.8 6004.7 5765.0 5816.0 5830.3 5948.6 5951.3 5890.7 5893.1 5931.9 5983.5 5986.4 6425.4 6445.8 6464.6 6491.1 6552.1 6755.9 6828.0 6841.0 6861.8 6998.9 6914.0 6915.4 6940.7 7030.5 7035.8 6492.6 6494.7 6506.9 6508.3 6513.7 6991.2 7092.7 7192.0 7195.5 7202.8 6668.1 6781.8 6790.3 6847.6 6873.5 6863.8 6888.2 6942.9 6956.2 6958.1 6944.7 6951.8 6988.1 6995.4 7015.1 6856.2 6895.0 6928.5 6944.0 7016.8 5348.7 5443.8 5454.8 5480.0 5518.8 4709.1 4742.8 4770.5 4823.4 4827.1 6091.9 6113.9 6172.8 6174.8 6180.3 6973.3 6975.3 6981.2 7057.0 7063.2 5970.2 6061.0 6072.5 6075.9 6157.2 5943.6 5948.5 5953.2 5956.0 5956.6 6610.9 6634.9 6639.9 6696.5 6708.8 6900.0 6982.6 6990.5 6999.7 7007.6 6600.0 6605.8 6633.5 6695.2 6703.4 6628.3 6705.7 6711.9 6772.2 6836.4 6997.5 7023.2 7032.5 7055.2 7059.7 6709.1 6767.3 6772.1 6776.7 6806.6 6696.4 6707.6 6723.3 6798.4 6834.4 6452.4 6545.3 6555.0 6656.1 6666.4 6789.4 6802.9 6823.8 6824.6 6871.5 6547.2 6569.1 6647.2 6648.4 6676.7 11:52:40 INFO - PID 19484 | 11:52:40 INFO - PID 19484 | [#1] ext.html Cycles:180 Average:36426.30 Median:33408.42 stddev:52663.03 (157.6%) stddev-sans-first:52742.60 11:52:40 INFO - PID 19484 | Values: 743.5 795.5 820.3 821.7 1137.7 29599.7 30545.0 39157.4 40213.8 40404.8 38965.0 39287.4 39332.8 39391.6 39405.0 7417.4 7627.7 7670.5 7678.3 7694.8 7583.8 7673.3 7677.7 7680.2 7680.3 7642.0 7691.6 7695.7 7702.3 7707.0 7667.2 7690.2 7697.5 7698.8 7710.9 7535.8 7559.9 7562.7 7624.2 7633.8 35982.0 36399.5 36403.0 36419.6 36431.8 3549.7 3574.4 3584.0 3589.6 3598.0 29982.4 30124.0 30145.8 30165.2 30172.4 4914.5 5066.8 5121.4 5173.1 5181.9 169663.0 172219.0 172542.1 172573.0 173112.0 45328.0 45329.8 45343.3 45508.0 45563.5 47636.3 47694.8 47711.8 47734.0 47770.5 13736.5 13853.9 15737.6 16028.3 16041.7 12929.5 13274.2 13296.8 13301.1 13322.1 13169.9 13396.0 13437.9 13444.4 13497.5 5570.3 5693.5 5718.4 5728.9 5821.1 1005.4 1013.4 1025.7 1039.2 1051.2 22188.9 22618.3 22623.5 23011.1 23050.1 1116.9 1122.7 1135.1 1140.5 1143.1 11861.5 11900.2 11946.8 11962.2 12075.3 234372.0 236752.0 236897.0 237036.0 237520.0 50666.7 50963.7 51065.5 51169.7 51327.0 1410.8 1440.9 1467.8 1468.9 1479.0 22103.6 22222.6 22391.7 22588.4 22796.0 35907.3 35957.0 35994.3 35995.5 36048.8 195558.0 195926.0 195955.0 196182.0 196210.0 32028.8 32083.5 33126.0 33690.8 33726.8 40569.0 41849.0 41929.0 42202.8 42256.2 31550.0 31785.0 31957.2 32041.2 32454.7 31616.4 31696.2 31783.2 31845.2 32256.2 34841.0 35737.6 35746.5 35803.5 36076.6 30982.7 31423.2 31467.2 31744.7 31778.7 23168.0 23261.0 23686.6 23691.9 23840.9 11:52:40 INFO - PID 19484 | 11:52:40 INFO - PID 19484 | [#2] jquery.html Cycles:180 Average:35304.26 Median:22075.51 stddev:77995.21 (353.3%) stddev-sans-first:78170.40 11:52:40 INFO - PID 19484 | Values: 567.3 568.7 571.5 576.3 587.9 21719.0 22445.9 22836.5 22909.2 22932.7 25673.2 26097.2 26136.3 26419.5 26419.9 6571.7 6754.7 6757.5 6763.4 6779.2 6727.4 6903.7 7185.4 7208.5 7262.6 7166.1 7169.7 7172.2 7177.5 7235.5 7242.6 7250.9 7251.6 7254.2 7259.1 7082.0 7091.4 7097.7 7099.2 7101.3 30629.4 31434.5 31560.7 31748.5 31775.4 2100.0 2122.6 2129.4 2130.5 2132.7 20341.4 20903.4 20918.0 21013.3 21084.1 1855.1 2022.2 2063.8 2073.0 2548.6 136340.0 138231.0 139143.3 139855.0 140258.3 20744.9 21672.7 21800.3 22831.7 22951.5 43724.3 43812.0 43822.3 43904.8 43999.8 11474.1 11540.3 11593.9 11632.8 11634.9 8646.0 9036.1 9642.9 9719.2 9785.5 10729.9 10793.9 11522.2 11560.5 11655.0 3544.8 3650.9 3928.7 3934.6 3972.1 968.5 983.5 986.2 995.7 996.7 19875.9 20491.6 20527.8 20771.7 20813.5 1063.1 1064.2 1065.5 1073.2 1074.9 11023.9 11516.1 11553.8 11565.2 11601.2 453718.0 456953.0 463384.0 465128.0 465858.0 112515.0 113103.0 114084.0 115699.0 118090.0 1162.4 1169.6 1187.6 1190.6 1201.6 18698.6 18752.0 21190.0 22350.7 22454.0 54927.0 58312.0 59914.0 60676.7 60716.4 71533.3 72108.6 72219.6 72908.0 73278.6 14529.3 15031.3 15033.0 15041.5 15244.3 22982.7 23038.4 23116.8 23330.7 23427.8 18688.3 19117.5 19141.5 19181.0 19259.6 16053.7 16109.5 16194.7 16288.9 17450.3 18122.8 19356.6 19356.7 19408.6 19418.2 14818.2 14896.7 14920.4 14923.2 15003.8 18393.7 18630.3 18661.0 18665.0 18731.5 11:52:40 INFO - PID 19484 | 11:52:40 INFO - PID 19484 | [#3] mootools.html Cycles:180 Average:9467.61 Median:26088.98 stddev:6632.72 (25.4%) stddev-sans-first:6622.94 11:52:40 INFO - PID 19484 | Values: 1300.7 1335.9 1361.1 1364.4 1366.4 14964.9 15129.2 15677.6 15756.9 15766.1 15530.3 15806.1 15823.4 15887.9 15890.3 2772.5 2818.4 2825.0 2827.0 2833.2 2737.7 2939.3 2941.3 2949.8 2950.0 2753.4 2850.5 2857.6 2897.5 2898.3 2774.2 2796.7 2799.1 2805.5 2810.7 2533.9 2562.7 2571.4 2578.4 2580.1 14877.9 15242.2 15243.5 15279.5 15283.0 7884.8 8138.2 8139.3 8157.4 8165.0 5317.8 5477.8 5510.7 5605.7 5614.5 1983.3 2003.5 2004.2 2039.8 2048.7 26021.3 26156.6 26182.5 26198.5 26292.0 7385.2 7455.4 7609.1 7675.5 7703.3 17142.8 17155.8 17157.7 17188.5 17211.7 7917.9 8060.6 8071.6 8072.0 8080.0 7406.3 7460.3 7517.7 7536.1 7540.8 5193.7 5418.9 5419.0 5442.3 5448.7 1494.2 1502.2 1503.0 1506.2 1514.5 911.2 927.9 931.1 941.1 945.3 7890.8 7940.3 7976.1 7988.4 8001.4 714.9 721.1 722.5 727.5 731.8 5255.1 5416.7 5513.5 5525.5 5588.3 20711.0 21191.9 21542.7 21578.7 21811.2 20026.4 21435.5 21475.8 21581.2 21668.2 11399.9 11618.4 11664.4 11686.5 11693.2 8432.7 8687.9 8939.7 9057.2 9331.5 18273.4 18361.6 18478.6 18622.8 18860.8 18826.5 18955.1 18968.7 19178.3 19257.5 11666.9 12487.4 12664.2 12709.4 12726.9 14109.7 14274.0 14276.2 14279.1 14280.9 11397.1 11408.8 11424.3 11541.7 11706.9 11159.7 11241.7 11370.5 11496.9 11688.6 10054.3 10101.5 10106.6 10130.7 10163.6 7295.7 7327.4 7332.7 7339.0 7347.6 7239.2 7439.1 7455.9 7473.6 7479.9 11:52:40 INFO - PID 19484 | 11:52:40 INFO - PID 19484 | [#4] prototype.html Cycles:180 Average:5593.29 Median:6257.17 stddev:1550.53 (24.8%) stddev-sans-first:1506.91 11:52:40 INFO - PID 19484 | Values: 494.3 504.3 522.7 528.3 529.4 6221.9 6348.6 6398.2 6433.4 6494.0 6173.2 6185.5 6195.9 6196.4 6274.5 4987.2 5039.5 5049.2 5056.4 5111.3 4988.9 5002.7 5030.1 5031.6 5113.8 4980.2 5010.9 5036.2 5085.0 5119.1 4969.2 4989.3 5003.7 5034.8 5047.0 4538.4 4542.9 4551.6 4552.1 4578.6 6241.4 6272.9 6278.4 6281.4 6295.4 5741.3 5786.6 5793.9 5820.7 5833.7 6498.6 6612.4 6629.7 6630.9 6655.4 4873.9 4888.0 4915.2 4952.4 4952.5 6961.5 6990.2 7013.7 7045.8 7088.6 4995.2 5034.8 5046.1 5048.2 5061.6 5063.3 5134.9 5135.5 5142.9 5149.5 5695.3 5735.7 5765.9 5772.7 5793.2 6589.0 6606.6 6646.7 6655.9 6717.6 1675.5 1704.4 1897.0 1931.7 1944.7 1424.6 1438.5 1465.8 1470.3 1486.6 5871.7 5873.4 5880.4 5918.2 5952.5 6532.6 6765.1 6804.6 6883.8 6900.9 5973.6 5976.3 6000.5 6010.4 6032.9 3509.5 3509.8 3589.2 3610.8 3625.5 6500.4 6576.9 6637.8 6647.8 6682.2 6882.9 6947.4 7026.5 7027.1 7142.6 6485.6 6556.7 6563.4 6608.4 6670.9 6780.0 6860.0 6888.3 6896.8 6905.6 6716.9 6767.5 6768.7 6780.6 6802.7 6563.8 6564.5 6564.7 6568.5 6666.6 4967.7 4990.8 5057.3 5072.5 5074.7 6521.2 6767.7 6872.5 6878.9 6936.4 6330.3 6486.9 6630.6 6644.4 6674.2 6591.6 6637.2 6638.7 6660.9 6680.4 6275.3 6466.2 6472.8 6517.9 6519.2 6495.6 6528.2 6592.3 6628.5 6657.3 6334.2 6350.6 6416.2 6457.0 6457.8 11:52:40 INFO - PID 19484 | 11:52:40 INFO - PID 19484 | [#5] yui.html Cycles:180 Average:23818.55 Median:20673.78 stddev:31973.60 (154.7%) stddev-sans-first:32016.99 11:52:40 INFO - PID 19484 | Values: 900.5 918.5 921.2 921.4 928.8 18671.9 19720.6 19806.3 19882.4 21737.3 19449.3 20524.3 20823.3 20838.2 20850.4 752.8 979.8 979.8 980.9 984.7 995.6 1004.1 1005.6 1007.6 1008.1 1050.0 1053.3 1056.0 1056.3 1057.5 1038.3 1041.3 1042.5 1042.8 1043.2 770.8 771.0 771.1 773.1 774.4 18508.4 18726.2 18795.8 20186.7 20301.1 20846.4 21051.0 21432.9 21581.0 21620.7 16966.1 17079.6 17345.3 17566.4 17647.6 3708.8 3749.3 3752.1 3752.8 3753.3 121341.0 123017.8 123238.0 124428.0 124870.0 16454.2 16694.2 16759.4 16907.0 17039.7 29922.6 29973.6 30431.2 30433.7 30461.4 7831.6 8177.3 8435.5 8521.4 8547.8 4135.5 4299.4 4316.6 4338.0 4338.9 5361.1 5426.6 5525.3 5535.4 5541.4 1128.0 1132.2 1143.2 1143.6 1146.2 693.7 702.5 709.3 719.2 720.5 11933.5 12202.6 12266.8 12403.3 12426.3 642.3 643.9 686.7 697.7 699.3 5632.1 5961.7 6019.9 6093.3 6125.7 109269.5 109987.5 110961.0 113079.4 115187.4 93945.5 97599.5 99619.5 103168.0 103265.0 84294.6 84628.6 84829.2 88031.6 90188.0 9760.5 9806.6 9895.5 9924.2 10183.3 41405.4 41544.0 41638.4 43488.6 43743.1 54365.5 55818.7 69807.3 71221.6 73076.0 18176.3 18371.4 18371.9 18446.7 18598.6 19339.1 19879.9 20311.4 21535.6 22206.8 18914.4 19177.1 19310.8 19478.0 19493.4 19775.0 19781.1 19864.3 19866.8 19964.5 18607.6 18713.3 18752.8 18796.5 19598.5 13608.4 13858.9 14103.2 14368.7 14442.0 14149.6 14470.3 14595.5 14611.6 14781.9 11:52:40 INFO - PID 19484 | -------- Summary: end -------- 11:52:40 INFO - PID 19484 | 11:52:40 INFO - TEST-INFO | 19484: exit 0 11:52:40 INFO - TEST-OK | dromaeo_css | took 1108957ms 11:52:40 INFO - TEST-START | kraken 11:52:40 INFO - Initialising browser for kraken test... 11:52:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36518/getInfo.html -profile /tmp/tmph9_vwP/profile 11:52:40 INFO - TEST-INFO | started process 19853 (/builds/slave/test/build/application/firefox/firefox http://localhost:36518/getInfo.html) 11:52:46 INFO - TEST-INFO | 19853: exit 0 11:52:46 INFO - Browser initialized. 11:52:46 INFO - Running cycle 1/1 for kraken test... 11:52:46 INFO - Using env: {'DISPLAY': ':0', 11:52:46 INFO - 'HOME': '/home/cltbld', 11:52:46 INFO - 'JSGC_DISABLE_POISONING': '1', 11:52:46 INFO - 'LANG': 'en_US.UTF-8', 11:52:46 INFO - 'LANGUAGE': 'en_US:en', 11:52:46 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:52:46 INFO - 'LOGNAME': 'cltbld', 11:52:46 INFO - 'MAIL': '/var/mail/cltbld', 11:52:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:52:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:52:46 INFO - 'MOZ_CRASHREPORTER': '1', 11:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:46 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:52:46 INFO - 'MOZ_NO_REMOTE': '1', 11:52:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:52:46 INFO - 'NO_EM_RESTART': '1', 11:52:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:46 INFO - 'PWD': '/builds/slave/test', 11:52:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:52:46 INFO - 'RUST_BACKTRACE': 'full', 11:52:46 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:52:46 INFO - 'SHELL': '/bin/bash', 11:52:46 INFO - 'SHLVL': '1', 11:52:46 INFO - 'STYLO_FORCE_ENABLED': '1', 11:52:46 INFO - 'STYLO_THREADS': '1', 11:52:46 INFO - 'TERM': 'linux', 11:52:46 INFO - 'TMOUT': '86400', 11:52:46 INFO - 'USER': 'cltbld', 11:52:46 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044', 11:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:46 INFO - '_': '/tools/buildbot/bin/python'} 11:52:46 INFO - TEST-INFO | started process 20039 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph9_vwP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:52:47 INFO - PID 20039 | 11:52:47 INFO - PID 20039 | (/builds/slave/test/build/application/firefox/firefox:20091): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:52:47 INFO - PID 20039 | 11:52:57 INFO - PID 20039 | RSS: Main: 173412352 11:52:57 INFO - PID 20039 | 11:53:00 INFO - PID 20039 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36518/tests/kraken/driver.html?testName=audio-beat-detection) 11:53:01 INFO - PID 20039 | RSS: Main: 179245056 11:53:01 INFO - PID 20039 | 11:53:03 INFO - PID 20039 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36518/tests/kraken/driver.html?testName=audio-dft) 11:53:04 INFO - PID 20039 | RSS: Main: 179683328 11:53:04 INFO - PID 20039 | 11:53:07 INFO - PID 20039 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36518/tests/kraken/driver.html?testName=audio-fft) 11:53:08 INFO - PID 20039 | RSS: Main: 174100480 11:53:08 INFO - PID 20039 | 11:53:10 INFO - PID 20039 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36518/tests/kraken/driver.html?testName=audio-oscillator) 11:53:10 INFO - PID 20039 | RSS: Main: 174784512 11:53:10 INFO - PID 20039 | 11:53:13 INFO - PID 20039 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36518/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:53:13 INFO - PID 20039 | RSS: Main: 175198208 11:53:13 INFO - PID 20039 | 11:53:16 INFO - PID 20039 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36518/tests/kraken/driver.html?testName=imaging-darkroom) 11:53:17 INFO - PID 20039 | RSS: Main: 177057792 11:53:17 INFO - PID 20039 | 11:53:20 INFO - PID 20039 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36518/tests/kraken/driver.html?testName=imaging-desaturate) 11:53:21 INFO - PID 20039 | RSS: Main: 177184768 11:53:21 INFO - PID 20039 | 11:53:24 INFO - PID 20039 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36518/tests/kraken/driver.html?testName=json-parse-financial) 11:53:25 INFO - PID 20039 | RSS: Main: 177164288 11:53:25 INFO - PID 20039 | 11:53:26 INFO - PID 20039 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36518/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:53:27 INFO - PID 20039 | RSS: Main: 177758208 11:53:27 INFO - PID 20039 | 11:53:28 INFO - PID 20039 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36518/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:53:29 INFO - PID 20039 | RSS: Main: 177713152 11:53:29 INFO - PID 20039 | 11:53:31 INFO - PID 20039 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36518/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:53:32 INFO - PID 20039 | RSS: Main: 175058944 11:53:32 INFO - PID 20039 | 11:53:34 INFO - PID 20039 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:53:35 INFO - PID 20039 | RSS: Main: 175263744 11:53:35 INFO - PID 20039 | 11:53:38 INFO - PID 20039 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:53:39 INFO - PID 20039 | RSS: Main: 175071232 11:53:39 INFO - PID 20039 | 11:53:41 INFO - PID 20039 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36518/tests/kraken/driver.html?testName=ai-astar) 11:53:41 INFO - PID 20039 | RSS: Main: 176951296 11:53:41 INFO - PID 20039 | 11:53:41 INFO - PID 20039 | __start_tp_report 11:53:41 INFO - PID 20039 | _x_x_mozilla_page_load 11:53:41 INFO - PID 20039 | _x_x_mozilla_page_load_details 11:53:41 INFO - PID 20039 | |i|pagename|runs| 11:53:41 INFO - PID 20039 | |0;ai-astar;98;106;100;107;106;107;109;99;108;109 11:53:41 INFO - PID 20039 | |1;audio-beat-detection;145;115;140;167;119;144;147;117;176;117 11:53:41 INFO - PID 20039 | |2;audio-dft;164;165;161;162;161;162;160;166;166;162 11:53:41 INFO - PID 20039 | |3;audio-fft;74;74;74;171;75;75;73;75;173;74 11:53:41 INFO - PID 20039 | |4;audio-oscillator;83;79;133;79;78;78;123;79;79;130 11:53:41 INFO - PID 20039 | |5;imaging-gaussian-blur;113;114;114;115;115;114;114;114;115;114 11:53:41 INFO - PID 20039 | |6;imaging-darkroom;148;148;149;148;149;147;148;147;148;149 11:53:41 INFO - PID 20039 | |7;imaging-desaturate;94;94;94;94;93;94;95;94;94;94 11:53:41 INFO - PID 20039 | |8;json-parse-financial;52;53;53;52;51;52;51;51;52;54 11:53:41 INFO - PID 20039 | |9;json-stringify-tinderbox;38;39;38;38;38;38;38;39;37;38 11:53:41 INFO - PID 20039 | |10;stanford-crypto-aes;73;78;76;75;74;74;75;75;75;73 11:53:41 INFO - PID 20039 | |11;stanford-crypto-ccm;121;122;128;125;120;120;119;122;121;164 11:53:41 INFO - PID 20039 | |12;stanford-crypto-pbkdf2;172;170;175;190;167;171;184;181;170;168 11:53:41 INFO - PID 20039 | |13;stanford-crypto-sha256-iterative;67;64;69;65;69;66;63;64;65;64 11:53:41 INFO - PID 20039 | __end_tp_report 11:53:41 INFO - PID 20039 | __start_cc_report 11:53:41 INFO - PID 20039 | _x_x_mozilla_cycle_collect,929 11:53:41 INFO - PID 20039 | __end_cc_report 11:53:41 INFO - PID 20039 | __startTimestamp1504724021402__endTimestamp 11:53:41 INFO - PID 20039 | 11:53:41 INFO - PID 20039 | ------- Summary: start ------- 11:53:41 INFO - PID 20039 | Number of tests: 14 11:53:41 INFO - PID 20039 | 11:53:41 INFO - PID 20039 | [#0] ai-astar Cycles:10 Average:104.90 Median:108.50 stddev:4.23 (3.9%) stddev-sans-first:3.67 11:53:41 INFO - PID 20039 | Values: 98.0 106.0 100.0 107.0 106.0 107.0 109.0 99.0 108.0 109.0 11:53:41 INFO - PID 20039 | 11:53:41 INFO - PID 20039 | [#1] audio-beat-detection Cycles:10 Average:138.70 Median:144.50 stddev:21.66 (15.0%) stddev-sans-first:22.85 11:53:41 INFO - PID 20039 | Values: 145.0 115.0 140.0 167.0 119.0 144.0 147.0 117.0 176.0 117.0 11:53:41 INFO - PID 20039 | 11:53:41 INFO - PID 20039 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:2.18 (1.3%) stddev-sans-first:2.28 11:53:41 INFO - PID 20039 | Values: 164.0 165.0 161.0 162.0 161.0 162.0 160.0 166.0 166.0 162.0 11:53:41 INFO - PID 20039 | 11:53:41 INFO - PID 20039 | [#3] audio-fft Cycles:10 Average:93.80 Median:74.00 stddev:41.22 (55.7%) stddev-sans-first:43.10 11:53:41 INFO - PID 20039 | Values: 74.0 74.0 74.0 171.0 75.0 75.0 73.0 75.0 173.0 74.0 11:53:41 INFO - PID 20039 | 11:53:41 INFO - PID 20039 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:79.00 stddev:24.02 (30.4%) stddev-sans-first:25.13 11:53:41 INFO - PID 20039 | Values: 83.0 79.0 133.0 79.0 78.0 78.0 123.0 79.0 79.0 130.0 11:53:41 INFO - PID 20039 | 11:53:41 INFO - PID 20039 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.50 11:53:41 INFO - PID 20039 | Values: 113.0 114.0 114.0 115.0 115.0 114.0 114.0 114.0 115.0 114.0 11:53:41 INFO - PID 20039 | 11:53:41 INFO - PID 20039 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 11:53:41 INFO - PID 20039 | Values: 148.0 148.0 149.0 148.0 149.0 147.0 148.0 147.0 148.0 149.0 11:53:41 INFO - PID 20039 | 11:53:41 INFO - PID 20039 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 11:53:41 INFO - PID 20039 | Values: 94.0 94.0 94.0 94.0 93.0 94.0 95.0 94.0 94.0 94.0 11:53:41 INFO - PID 20039 | 11:53:41 INFO - PID 20039 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:0.99 (1.9%) stddev-sans-first:1.05 11:53:41 INFO - PID 20039 | Values: 52.0 53.0 53.0 52.0 51.0 52.0 51.0 51.0 52.0 54.0 11:53:41 INFO - PID 20039 | 11:53:41 INFO - PID 20039 | [#9] json-stringify-tinderbox Cycles:10 Average:38.10 Median:38.00 stddev:0.57 (1.5%) stddev-sans-first:0.60 11:53:41 INFO - PID 20039 | Values: 38.0 39.0 38.0 38.0 38.0 38.0 38.0 39.0 37.0 38.0 11:53:41 INFO - PID 20039 | 11:53:41 INFO - PID 20039 | [#10] stanford-crypto-aes Cycles:10 Average:74.80 Median:75.00 stddev:1.48 (2.0%) stddev-sans-first:1.41 11:53:41 INFO - PID 20039 | Values: 73.0 78.0 76.0 75.0 74.0 74.0 75.0 75.0 75.0 73.0 11:53:41 INFO - PID 20039 | 11:53:41 INFO - PID 20039 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:122.00 stddev:13.55 (11.1%) stddev-sans-first:14.24 11:53:41 INFO - PID 20039 | Values: 121.0 122.0 128.0 125.0 120.0 120.0 119.0 122.0 121.0 164.0 11:53:41 INFO - PID 20039 | 11:53:41 INFO - PID 20039 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:173.50 stddev:7.67 (4.4%) stddev-sans-first:8.07 11:53:41 INFO - PID 20039 | Values: 172.0 170.0 175.0 190.0 167.0 171.0 184.0 181.0 170.0 168.0 11:53:41 INFO - PID 20039 | 11:53:41 INFO - PID 20039 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.50 stddev:2.12 (3.2%) stddev-sans-first:2.19 11:53:41 INFO - PID 20039 | Values: 67.0 64.0 69.0 65.0 69.0 66.0 63.0 64.0 65.0 64.0 11:53:41 INFO - PID 20039 | -------- Summary: end -------- 11:53:41 INFO - PID 20039 | 11:53:41 INFO - PID 20039 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:53:42 INFO - TEST-INFO | 20039: exit 0 11:53:42 INFO - TEST-OK | kraken | took 61300ms 11:53:42 INFO - SUITE-END | took 1170s 11:53:42 INFO - Completed test suite (00:19:30) 11:53:42 INFO - javascript benchmark 11:53:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8715.849865128297, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3291.2430141067553, 3295.7033866951983, 3302.3725492156486, 3336.666333366664, 3341.398548261315, 6456.451201647859, 6463.7853324481985, 6485.027245913109, 6518.576292540982, 6548.901766473501, 6362.395572420624, 6449.387308205724, 6453.322401147871, 6474.482041436686, 6474.514411419151, 5893.263342082239, 5895.587308888379, 5915.319738230094, 5934.287885453751, 5965.224520812289, 6012.789552365668, 6027.186329845458, 6027.246594175728, 6041.426064523863, 6056.818295451144, 5897.11543268511, 5969.22400087988, 5972.223610930573, 5987.790427335044, 6004.729787159588, 5765.0, 5816.040353341694, 5830.271216097988, 5948.613340132878, 5951.315598706139, 5890.676012819294, 5893.057110862242, 5931.851703707399, 5983.491403230731, 5986.431289027535, 6425.389587989133, 6445.806625801233, 6464.579802312882, 6491.058796474485, 6552.082708420825, 6755.898661520081, 6828.0440738296675, 6840.965795171042, 6861.828454288633, 6998.860022799516, 6913.965430172867, 6915.412189963859, 6940.72237110515, 7030.507864449491, 7035.753748618774, 6492.610443373413, 6494.675266236669, 6506.902396464056, 6508.316626754217, 6513.706883190268, 6991.196012458632, 7092.716291348288, 7192.0, 7195.496315257987, 7202.783916482409, 6668.099806526154, 6781.796546103625, 6790.320967903269, 6847.554908930903, 6873.450123990069, 6863.794086177422, 6888.242293347727, 6942.93057069433, 6956.2000369958105, 6958.095447591882, 6944.722211111499, 6951.756688515878, 6988.056612357368, 6995.370416662525, 7015.088038554955, 6856.24581296057, 6895.0, 6928.4803639726215, 6944.0, 7016.7544135954995, 5348.679079255257, 5443.782248710087, 5454.836354909359, 5479.972600136974, 5518.834434966958, 4709.0817290628, 4742.786574604151, 4770.546798054179, 4823.3729615149805, 4827.131116399082, 6091.939080609137, 6113.938860611426, 6172.753089876354, 6174.8147555573405, 6180.258368995659, 6973.302669733088, 6975.337342952412, 6981.197162326296, 7057.0, 7063.223045464994, 5970.223870896755, 6061.0, 6072.51419886408, 6075.878482430415, 6157.199564056644, 5943.613665111754, 5948.464638182498, 5953.226080609493, 5955.970220148958, 5956.55325850563, 6610.900836487456, 6634.86730265392, 6639.933600664028, 6696.531242812956, 6708.765193218214, 6899.965500172467, 6982.615956122462, 6990.545614535039, 6999.685014174476, 7007.614581198083, 6599.967000164968, 6605.801825945229, 6633.502487313374, 6695.230048544479, 6703.363180497845, 6628.337166283333, 6705.731770729116, 6711.932880671131, 6772.221194562689, 6836.350546698056, 6997.510174287751, 7023.157221133497, 7032.472564557781, 7055.223925368308, 7059.682314295972, 6709.127813384424, 6767.323267673193, 6772.0857684212, 6776.661166941732, 6806.6256355900905, 6696.397324240842, 6707.631080290631, 6723.2604413515455, 6798.4221341184575, 6834.419074378733, 6452.419282264619, 6545.312742162195, 6555.0, 6656.134702488645, 6666.400023997863, 6789.355011273921, 6802.93197068023, 6823.761168359084, 6824.556403833735, 6871.4502839773695, 6547.181602299713, 6569.146011018537, 6647.169103862017, 6648.401643852077, 6676.732930682912], "value": 6322.939149161925, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.546436673629, 795.5107608820574, 820.2822530285999, 821.6754382019099, 1137.7269455330722, 29599.704002959963, 30545.0, 39157.41263881044, 40213.7989310053, 40404.79797601015, 38965.0, 39287.41068883969, 39332.80333598335, 39391.60608393915, 39405.0, 7417.443691723115, 7627.656755446018, 7670.539767613933, 7678.308952194301, 7694.807629809244, 7583.848323033536, 7673.271039251262, 7677.692892284302, 7680.193579674137, 7680.308772210527, 7642.04474440695, 7691.615419229044, 7695.653695583712, 7702.268284512962, 7707.036620422447, 7667.194944530827, 7690.15408305086, 7697.461177717562, 7698.807529811744, 7710.922890771105, 7535.849283014364, 7559.886601700979, 7562.697492100309, 7624.161342252348, 7633.809154771119, 35982.0, 36399.454008189896, 36403.0, 36419.63580364189, 36431.81784091089, 3549.6627820357025, 3574.4459608760685, 3584.0, 3589.5513060867393, 3598.0, 29982.400351992837, 30124.0, 30145.849270753726, 30165.245868853235, 30172.396552069054, 4914.508549145093, 5066.771995260222, 5121.385433747937, 5173.0688476074665, 5181.870453238662, 169663.0, 172219.0, 172542.137289314, 172572.99999999875, 173112.0, 45328.0, 45329.77335113303, 45343.31985020227, 45508.0, 45563.54436455659, 47636.28545571819, 47694.761526192146, 47711.761441192575, 47734.0, 47770.52229477661, 13736.519221827188, 13853.930730346283, 15737.606559836096, 16028.278727457293, 16041.679166416607, 12929.54746583884, 13274.203547787163, 13296.800547991788, 13301.06892517534, 13322.067455278038, 13169.868301317056, 13395.995300352317, 13437.932810336082, 13444.395002224728, 13497.527586534621, 5570.3315602128005, 5693.4875861172695, 5718.370979192286, 5728.885422291614, 5821.068629019336, 1005.3515482513737, 1013.3970287678819, 1025.7281820317621, 1039.1998161415668, 1051.2063392138887, 22188.89055547216, 22618.321450356514, 22623.547529049327, 23011.079556817538, 23050.077996879936, 1116.8715597706205, 1122.7305446692735, 1135.1429670598645, 1140.509580880213, 1143.102664408452, 11861.46623401949, 11900.166988310908, 11946.820797688042, 11962.222455540363, 12075.275483470845, 234372.0, 236752.0, 236897.0, 237036.0, 237520.0, 50666.74666626643, 50963.7451812746, 51065.48934510607, 51169.744151279, 51327.0, 1410.774276115837, 1440.8847292216808, 1467.8091848059898, 1468.875145612635, 1479.0238442627815, 22103.557928841656, 22222.555548889253, 22391.664125037812, 22588.435289117904, 22796.0, 35907.28185436329, 35957.0, 35994.28011439704, 35995.46006809952, 36048.8197559021, 195558.0, 195926.0, 195955.0, 196182.0, 196210.0, 32028.839855800572, 32083.518747219277, 33126.0, 33690.83154584211, 33726.83136584301, 40569.0, 41849.0, 41929.0, 42202.788986054875, 42256.1548769029, 31550.0, 31785.0, 31957.20106997344, 32041.198970025936, 32454.675453245167, 31616.36767264596, 31696.20759480939, 31783.205419864687, 31845.20386990344, 32256.193595160308, 34840.9547713569, 35737.64262357447, 35746.463803042454, 35803.46294805632, 36076.639233607326, 30982.69017309798, 31423.21441963969, 31467.213319667193, 31744.6825531751, 31778.682213178497, 23168.0, 23261.04929724768, 23686.644700329165, 23691.881540592185, 23840.880795595913], "value": 16754.917032172674, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.2597260574951, 568.6843801690062, 571.4713889652073, 576.3084298841386, 587.9323877754059, 21719.0, 22445.887770561167, 22836.54326913463, 22909.198178063773, 22932.65601015982, 25673.22980310589, 26097.217083487478, 26136.346591335227, 26419.471610567776, 26419.86790066047, 6571.737130514785, 6754.66226688666, 6757.526973111884, 6763.357481039294, 6779.220389655179, 6727.360900714424, 6903.723851045977, 7185.425165986709, 7208.459365547578, 7262.600556969364, 7166.068411106548, 7169.713211471561, 7172.211056783775, 7177.461690373217, 7235.493515453921, 7242.601656908868, 7250.891236631454, 7251.637418129125, 7254.202037775841, 7259.128904531463, 7082.0, 7091.361777440004, 7097.680604372816, 7099.183593886717, 7101.325374089453, 30629.38741225163, 31434.528482072557, 31560.684393156003, 31748.523772143435, 31775.364492710018, 2100.0444797617047, 2122.61792877282, 2129.4144110369616, 2130.499332656824, 2132.6907598398147, 20341.389758307127, 20903.37289881306, 20918.0, 21013.264535741328, 21084.05121769524, 1855.1002763659615, 2022.1608032666427, 2063.8348932085546, 2073.0463986566197, 2548.617707343895, 136340.0, 138231.0, 139143.30428347894, 139855.0, 140258.2987085058, 20744.896275518528, 21672.674909876365, 21800.34598962034, 22831.657525137136, 22951.54096918052, 43724.344134838, 43812.0, 43822.34266486005, 43904.78047609805, 43999.78000109979, 11474.139439542068, 11540.307581545134, 11593.913095642696, 11632.825507617392, 11634.941825290989, 8646.0, 9036.096390361043, 9642.903570964341, 9719.222462203006, 9785.510724463747, 10729.946350268356, 10793.946030269799, 11522.193446458667, 11560.479778409992, 11655.0, 3544.8422545196677, 3650.872219472306, 3928.6639950555277, 3934.586868378779, 3972.106276087857, 968.4576637083256, 983.468926779531, 986.1666891476691, 995.7162208770466, 996.7358649957768, 19875.900620496806, 20491.59016819655, 20527.79472205259, 20771.68842467364, 20813.479663008548, 1063.0698139128262, 1064.2497039587226, 1065.5205157679075, 1073.1575713065206, 1074.8710154781477, 11023.889761102286, 11516.136289778133, 11553.826692599618, 11565.19043666952, 11601.18791684574, 453718.0, 456953.0, 463384.0, 465128.0, 465858.0, 112515.0, 113103.0, 114084.0, 115699.0, 118090.0, 1162.3548930343572, 1169.6257197696655, 1187.566538213563, 1190.6070996571111, 1201.5854530187246, 18698.626027479648, 18752.0, 21190.0, 22350.664740028587, 22454.0, 54927.0, 58312.0, 59914.0, 60676.69661651664, 60716.39283607284, 71533.28466715266, 72108.63945680238, 72219.63890180516, 72908.0, 73278.63360683376, 14529.346179422162, 15031.323590438238, 15033.022853514487, 15041.548753536974, 15244.314005869985, 22982.655260170777, 23038.42403939848, 23116.768832312133, 23330.65004024907, 23427.76572234256, 18688.34590789316, 19117.522061948563, 19141.521461963563, 19181.0, 19259.61480770405, 16053.67892642164, 16109.516714498584, 16194.67610647804, 16288.918555407621, 17450.301987920848, 18122.81877181211, 19356.61286774285, 19356.70964935499, 19408.61182776365, 19418.223271069564, 14818.184999825113, 14896.702065958836, 14920.403183872957, 14923.179225142721, 15003.774943376076, 18393.724094138866, 18630.254789808256, 18661.0, 18665.0, 18731.531711707317], "value": 12861.516904507607, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.71384295455, 1335.9332033398327, 1361.0880709924356, 1364.4064831798166, 1366.398784534804, 14964.925175374121, 15129.167895765728, 15677.608059798496, 15756.92121539392, 15766.132862692548, 15530.30113644886, 15806.13066281354, 15823.446179383724, 15887.920560397211, 15890.284937177827, 2772.514809908268, 2818.422223444189, 2824.985875070632, 2826.985865070672, 2833.150054983507, 2737.671479422472, 2939.3092623233524, 2941.2793865502877, 2949.7935144539892, 2949.9557506637416, 2753.408017276285, 2850.50116229659, 2857.6427946506687, 2897.507423737959, 2898.30440694234, 2774.1677496750895, 2796.6504186976626, 2799.1182777425047, 2805.4809860175833, 2810.7470327670508, 2533.8859751311234, 2562.743725627441, 2571.434284457416, 2578.355411147213, 2580.109862097573, 14877.851221487756, 15242.161681107535, 15243.542693719206, 15279.465218717292, 15283.0, 7884.842303153905, 8138.2268684475475, 8139.348852091818, 8157.388195885333, 8165.0, 5317.821421029398, 5477.808276710336, 5510.6969116698565, 5605.747741351649, 5614.466625670555, 1983.2860170338668, 2003.4991252186953, 2004.188303736989, 2039.836813054952, 2048.7439070116234, 26021.349466263306, 26156.607650885253, 26182.476350472883, 26198.476030479284, 26292.0, 7385.187629360766, 7455.403567714569, 7609.086909570887, 7675.5010924289745, 7703.3067023968115, 17142.828571714123, 17155.828441715672, 17157.742633860504, 17188.484345469657, 17211.655766884593, 7917.881231781528, 8060.596970151469, 8071.636776345079, 8072.031356237172, 8079.959600201962, 7406.259374062658, 7460.29127232912, 7517.699292028257, 7536.133344665324, 7540.811479713051, 5193.688378697215, 5418.91871621926, 5419.0, 5442.292501974797, 5448.700321482356, 1494.2304713072776, 1502.1813111854067, 1503.0305452982766, 1506.1791323728594, 1514.530495546362, 911.1662828511837, 927.888653361601, 931.0828833599035, 941.096547314572, 945.2910317262053, 7890.842183156305, 7940.28537431634, 7976.122626511079, 7988.440809143421, 8001.399895007781, 714.9428045756327, 721.0950257426896, 722.544796778037, 727.4943913979733, 731.7877815433571, 5255.106631872591, 5416.674999500043, 5513.476219759116, 5525.475079867406, 5588.30146231721, 20711.0, 21191.894040530005, 21542.676859847114, 21578.676319855214, 21811.23660671869, 20026.399208023493, 21435.46411339729, 21475.785242147693, 21581.24465643695, 21668.183136192194, 11399.886001140048, 11618.419079046183, 11664.358460284597, 11686.47410866513, 11693.239939403911, 8432.662693492191, 8687.86968195465, 8939.73180804577, 9057.18485336323, 9331.486768227813, 18273.3604323848, 18361.632767344847, 18478.630427391647, 18622.813771862107, 18860.811391885905, 18826.52933676669, 18955.14701838393, 18968.715469267696, 19178.328758493943, 19257.5185620355, 11666.88333116658, 12487.438065286902, 12664.240145591293, 12709.36453177319, 12726.87273127257, 14109.717805643624, 14274.0, 14276.21480818565, 14279.143251404948, 14280.928595356956, 11397.08823294118, 11408.82886756716, 11424.314541127558, 11541.653750387166, 11706.88293117058, 11159.665210043711, 11241.66275011751, 11370.54517819311, 11496.94251528737, 11688.649340519798, 10054.34646747959, 10101.545430455793, 10106.646267380607, 10130.746731331776, 10163.593456261962, 7295.708171673074, 7327.377172940147, 7332.670029848563, 7339.0, 7347.595882226529, 7239.2155691900925, 7439.070116235471, 7455.888161677471, 7473.6263186841525, 7479.88780168287], "value": 6763.695542199579, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.30699853003455, 504.2738456622461, 522.6524361299736, 528.2868128027163, 529.4255732530205, 6221.898043604247, 6348.619082855032, 6398.168238129043, 6433.388828061338, 6493.967530162355, 6173.228346456693, 6185.474234690057, 6195.876082478348, 6196.411340922605, 6274.466670333016, 4987.152184128707, 5039.546440820325, 5049.192129259319, 5056.367954005749, 5111.284420181178, 4988.925166122511, 5002.699838009731, 5030.144875371196, 5031.647784655075, 5113.795448182087, 4980.178270585349, 5010.899782004358, 5036.244563315496, 5085.0, 5119.12974794284, 4969.180085285923, 4989.276554899538, 5003.749812509396, 5034.798608055673, 5047.0, 4538.3873177120995, 4542.931856022163, 4551.635869130461, 4552.089582083563, 4578.633709303248, 6241.438270555626, 6272.905906411407, 6278.434940855345, 6281.434670879597, 6295.370462953668, 5741.3110426748635, 5786.566007549451, 5793.913091303634, 5820.708964551755, 5833.708314584296, 6498.642574658392, 6612.43794277487, 6629.7016634251095, 6630.867382652368, 6655.401013908723, 4873.926891096637, 4887.9735255596015, 4915.188993816052, 4952.380952380952, 4952.479989601076, 6961.512694111414, 6990.196127445358, 7013.684384202723, 7045.753398631024, 7088.610126443044, 4995.175795993693, 5034.79860805571, 5046.082488654288, 5048.242763585418, 5061.5950723942, 5063.316452278968, 5134.922976155361, 5135.512126347991, 5142.871428214325, 5149.45930677281, 5695.288088988877, 5735.677050794435, 5765.913511297334, 5772.7113644317615, 5793.159991801165, 6588.96705516479, 6606.570572912745, 6646.670665866846, 6655.900161497581, 6717.596944183365, 1675.4722262487278, 1704.3949397963793, 1897.023033137935, 1931.72506145943, 1944.6791279439017, 1424.6295963049474, 1438.4605772835187, 1465.8021167142513, 1470.3016067368128, 1486.5540337898587, 5871.706414679249, 5873.442023007808, 5880.353161152269, 5918.171455996164, 5952.523798096142, 6532.608043517404, 6765.086713293643, 6804.6257455840405, 6883.793486195422, 6900.896486552605, 5973.611715238582, 5976.342602313742, 6000.549958753024, 6010.3689112643415, 6032.909506357408, 3509.4560343146854, 3509.8069606171907, 3589.1565482111682, 3610.819459027038, 3625.546806649169, 6500.382463665944, 6576.86846263072, 6637.767678131242, 6647.833804154935, 6682.164729408824, 6882.8623427531165, 6947.3747362736585, 7026.543274687129, 7027.121609798775, 7142.607156606437, 6485.61086334812, 6556.737730490727, 6563.442107420923, 6608.413980644611, 6670.9332906670315, 6779.966100169468, 6859.965700171667, 6888.311168883071, 6896.793061214167, 6905.551139175937, 6716.899246511404, 6767.492438067066, 6768.7139443505575, 6780.626495910209, 6802.727890884309, 6563.835904102245, 6564.540482166202, 6564.737410503526, 6568.489247473203, 6666.633335166613, 4967.677100988424, 4990.750462476934, 5057.342545469212, 5072.51811077947, 5074.746262686925, 6521.217453905561, 6767.729290828312, 6872.450203983769, 6878.896816547855, 6936.445084393135, 6330.252310766925, 6486.902696459651, 6630.602163870183, 6644.368784965421, 6674.199096108498, 6591.604503729792, 6637.1703537057865, 6638.668066596748, 6660.933390666031, 6680.432163266177, 6275.34108918557, 6466.159399278252, 6472.773452929125, 6517.902231466437, 6519.152510173647, 6495.642739649175, 6528.183977002875, 6592.274849766618, 6628.469722422291, 6657.2677005528385, 6334.1765570475545, 6350.634613558107, 6416.230052393743, 6456.967715161394, 6457.838554036187], "value": 5149.74523301239, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [900.4732231644488, 918.5269586163126, 921.2123634292684, 921.3826736086821, 928.7863791327994, 18671.906640466797, 19720.605587888233, 19806.30677926271, 19882.403527894152, 21737.3478795636, 19449.31927382542, 20524.28165014225, 20823.27118550851, 20838.166473341047, 20850.374488765323, 752.849430113978, 979.7746518300795, 979.7893452907623, 980.9068138526828, 984.7291994701443, 995.6017592962836, 1004.0511716427978, 1005.612839056961, 1007.5969612155124, 1008.1279693065519, 1049.9947500262526, 1053.3206082077056, 1055.984160237597, 1056.2553399853123, 1057.471264367816, 1038.2576457832647, 1041.3231399590252, 1042.4996001919046, 1042.7601651620093, 1043.2488608202082, 770.803445121496, 771.0285040848515, 771.0516065239731, 773.0684525147184, 774.3534148985603, 18508.44474665762, 18726.157322920502, 18795.812041879544, 20186.697199542017, 20301.086451109586, 20846.374608761762, 21051.0, 21432.892835535877, 21581.0, 21620.675689864664, 16966.066866322348, 17079.573010674707, 17345.306187752474, 17566.38517651889, 17647.558811029827, 3708.7774733516076, 3749.268892565951, 3752.1182522107283, 3752.8123593820474, 3753.3431649461236, 121341.0, 123017.76982230153, 123238.0, 124428.0, 124870.0, 16454.177291135395, 16694.165291735364, 16759.41342053022, 16907.0, 17039.659206815795, 29922.55116173259, 29973.550396744067, 30431.239219019702, 30433.69566304353, 30461.390772184433, 7831.6475758591005, 8177.304929080976, 8435.493870367798, 8521.44610600309, 8547.829043419097, 4135.545090040093, 4299.355096735515, 4316.633086187647, 4338.0, 4338.891527711832, 5361.0618141825025, 5426.647267927572, 5525.336959564797, 5535.418781027934, 5541.445855414507, 1128.0468004536153, 1132.2413982631656, 1143.1597775634903, 1143.6397534776518, 1146.2320245435412, 693.7121094745725, 702.4977141343963, 709.3474003916306, 719.2016861283971, 720.5316544246282, 11933.522659093713, 12202.572909948109, 12266.75466490683, 12403.25580465175, 12426.316552589513, 642.2934771751037, 643.9227292724903, 686.6978529447027, 697.7209116353499, 699.2622782964022, 5632.098864181793, 5961.660100705689, 6019.909701354483, 6093.329733729286, 6125.663088530174, 109269.45365273123, 109987.45006274918, 110961.0, 113079.43460282646, 115187.42406287914, 93945.5302723482, 97599.51200243953, 99619.50190249148, 103168.0, 103265.0, 84294.57852710698, 84628.57685711655, 84829.15170848336, 88031.55984220166, 90188.0, 9760.463174525185, 9806.558704858442, 9895.505224738878, 9924.206063515046, 10183.33808302458, 41405.37891931563, 41544.0, 41638.37542436927, 43488.56511434845, 43743.125137496434, 54365.45634543762, 55818.72090639521, 69807.30192698009, 71221.64389178022, 73076.0, 18176.27294908189, 18371.448856534324, 18371.90814045921, 18446.72329915079, 18598.628027439645, 19339.129739162054, 19879.900600496905, 20311.390658280274, 21535.569288613828, 22206.77793222047, 18914.43256702301, 19177.137028834015, 19310.8068919309, 19478.0, 19493.415197544095, 19775.0, 19781.10985005707, 19864.304749333704, 19866.801331987073, 19964.50088747735, 18607.627847443247, 18713.345032923782, 18752.81247187565, 18796.530086747942, 19598.510037249183, 13608.387622556811, 13858.861411385757, 14103.224322661941, 14368.712625747217, 14442.0, 14149.646258843612, 14470.276486175439, 14595.489157879423, 14611.634709132357, 14781.92609036948], "value": 9236.55908506675, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1482.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 106.0, 100.0, 107.0, 106.0, 107.0, 109.0, 99.0, 108.0, 109.0], "value": 104.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 115.0, 140.0, 167.0, 119.0, 144.0, 147.0, 117.0, 176.0, 117.0], "value": 138.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 161.0, 162.0, 161.0, 162.0, 160.0, 166.0, 166.0, 162.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 171.0, 75.0, 75.0, 73.0, 75.0, 173.0, 74.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 79.0, 133.0, 79.0, 78.0, 78.0, 123.0, 79.0, 79.0, 130.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 115.0, 115.0, 114.0, 114.0, 114.0, 115.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 148.0, 149.0, 147.0, 148.0, 147.0, 148.0, 149.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 53.0, 52.0, 51.0, 52.0, 51.0, 51.0, 52.0, 54.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 38.0, 38.0, 38.0, 38.0, 38.0, 39.0, 37.0, 38.0], "value": 38.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 78.0, 76.0, 75.0, 74.0, 74.0, 75.0, 75.0, 75.0, 73.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 122.0, 128.0, 125.0, 120.0, 120.0, 119.0, 122.0, 121.0, 164.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 170.0, 175.0, 190.0, 167.0, 171.0, 184.0, 181.0, 170.0, 168.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 69.0, 65.0, 69.0, 66.0, 63.0, 64.0, 65.0, 64.0], "value": 65.6, "unit": "score"}]}]} 11:53:42 INFO - Return code: 0 11:53:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:53:42 INFO - # TBPL SUCCESS # 11:53:42 INFO - Running post-action listener: _package_coverage_data 11:53:42 INFO - Running post-action listener: _resource_record_post_action 11:53:42 INFO - [mozharness: 2017-09-06 18:53:42.696474Z] Finished run-tests step (success) 11:53:42 INFO - Running post-run listener: _resource_record_post_run 11:53:42 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391614464; Read time: 12; Write time: 198420 11:53:42 INFO - TinderboxPrint: CPU usage
13.1% 11:53:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:53:42 INFO - TinderboxPrint: I/O write bytes / time
391,614,464 / 198,420 11:53:42 INFO - TinderboxPrint: CPU idle
8,227.0 (86.9%) 11:53:42 INFO - TinderboxPrint: CPU user
1,191.4 (12.6%) 11:53:42 INFO - TinderboxPrint: Swap in / out
0 / 0 11:53:42 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106639360; Read time: 0; Write time: 67896 11:53:42 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:53:42 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284975104; Read time: 12; Write time: 130524 11:53:43 INFO - Running post-run listener: _upload_blobber_files 11:53:43 INFO - Blob upload gear active. 11:53:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:53:43 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:53:43 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:53:43 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:53:43 INFO - (blobuploader) - INFO - Open directory for files ... 11:53:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:53:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:53:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:53:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:53:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:53:45 INFO - (blobuploader) - INFO - Done attempting. 11:53:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:53:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:53:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:53:46 INFO - (blobuploader) - CRITICAL - Something went wrong on blobber! 11:53:46 INFO - (blobuploader) - INFO - Upload failed. Trying again ... 11:53:46 INFO - (blobuploader) - INFO - Done attempting. 11:53:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:53:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:53:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:53:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:53:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:53:51 INFO - (blobuploader) - INFO - Done attempting. 11:53:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:53:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:53:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:53:53 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:53:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:53:53 INFO - (blobuploader) - INFO - Done attempting. 11:53:53 INFO - (blobuploader) - INFO - Iteration through files over. 11:53:53 INFO - Return code: 0 11:53:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:53:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:53:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": null, "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9afa1bcbe0b6afe710d58eaf24aa620d38f1563b6d866deaa641eaae9b75e0dda98be408d507edd5d8300dba100b5f4f84e413d203681102de29552e1e50c2fb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e74913595c2e96b3839cda9f24e06fa203c2e436f9576205f916681c2fa03f1742835a69bc334f126ee87e728b9ed6b553066ad08c00d9b86654b211c00f828", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84829c9d12623b378e1a2b21e9d1174506ce9b7abec371d5936f7ed67004d55c2919ea6fcb226f489f63d409a85d8acfcec0bae8fdb0153e68abadc60925ab92"} 11:53:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:53:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:53:53 INFO - Contents: 11:53:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": null, "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9afa1bcbe0b6afe710d58eaf24aa620d38f1563b6d866deaa641eaae9b75e0dda98be408d507edd5d8300dba100b5f4f84e413d203681102de29552e1e50c2fb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e74913595c2e96b3839cda9f24e06fa203c2e436f9576205f916681c2fa03f1742835a69bc334f126ee87e728b9ed6b553066ad08c00d9b86654b211c00f828", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84829c9d12623b378e1a2b21e9d1174506ce9b7abec371d5936f7ed67004d55c2919ea6fcb226f489f63d409a85d8acfcec0bae8fdb0153e68abadc60925ab92"} 11:53:53 INFO - Running post-run listener: copy_logs_to_upload_dir 11:53:53 INFO - Copying logs to upload dir... 11:53:53 INFO - mkdir: /builds/slave/test/build/upload/logs 11:53:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.318447 ========= master_lag: -0.34 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-09-06 11:53:53.196076) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-06 11:53:53.201945) ========= 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=41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": null, "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9afa1bcbe0b6afe710d58eaf24aa620d38f1563b6d866deaa641eaae9b75e0dda98be408d507edd5d8300dba100b5f4f84e413d203681102de29552e1e50c2fb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e74913595c2e96b3839cda9f24e06fa203c2e436f9576205f916681c2fa03f1742835a69bc334f126ee87e728b9ed6b553066ad08c00d9b86654b211c00f828", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84829c9d12623b378e1a2b21e9d1174506ce9b7abec371d5936f7ed67004d55c2919ea6fcb226f489f63d409a85d8acfcec0bae8fdb0153e68abadc60925ab92"} build_url:https://queue.taskcluster.net/v1/task/CNiQiOuNT32DU3L464s6DA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.010029 build_url: 'https://queue.taskcluster.net/v1/task/CNiQiOuNT32DU3L464s6DA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": null, "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9afa1bcbe0b6afe710d58eaf24aa620d38f1563b6d866deaa641eaae9b75e0dda98be408d507edd5d8300dba100b5f4f84e413d203681102de29552e1e50c2fb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e74913595c2e96b3839cda9f24e06fa203c2e436f9576205f916681c2fa03f1742835a69bc334f126ee87e728b9ed6b553066ad08c00d9b86654b211c00f828", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84829c9d12623b378e1a2b21e9d1174506ce9b7abec371d5936f7ed67004d55c2919ea6fcb226f489f63d409a85d8acfcec0bae8fdb0153e68abadc60925ab92"}' ========= master_lag: 0.24 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-06 11:53:53.449992) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 11:53:53.450311) ========= 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=41bf3e9aed84707956354da8000001c5-1504722780.885571-770088044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004654 ========= master_lag: 0.30 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 11:53:53.756771) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-06 11:53:53.760090) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-06 11:53:53.760379) ========= ========= Total master_lag: 0.27 =========