builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-066 starttime: 1506386508.07 results: success (0) revision: e6b3498a39b94616ba36798fe0b71a3090b1b14c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 17:41:48.074141) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 17:41:48.074799) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 17:41:48.075128) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 17:41:48.115547) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:41:48.115953) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-25 17:41:48-- 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% 42.3M=0s 2017-09-25 17:41:48 (42.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.165294 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:41:48.298281) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:41:48.298629) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014067 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:41:48.349039) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:41:48.349374) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e6b3498a39b94616ba36798fe0b71a3090b1b14c --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 e6b3498a39b94616ba36798fe0b71a3090b1b14c --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=82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-25 17:41:48,400 truncating revision to first 12 chars 2017-09-25 17:41:48,401 Setting DEBUG logging. 2017-09-25 17:41:48,401 attempt 1/10 2017-09-25 17:41:48,401 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e6b3498a39b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-25 17:41:49,065 unpacking tar archive at: mozilla-central-e6b3498a39b9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.935825 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:41:49.301594) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 17:41:49.301931) ========= script_repo_revision: e6b3498a39b94616ba36798fe0b71a3090b1b14c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 17:41:49.302307) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 17:41:49.302570) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 17:41:49.317828) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-09-25 17:41:49.318252) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:41:49 INFO - MultiFileLogger online at 20170925 17:41:49 in /builds/slave/test 17:41:49 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 17:41:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:41:49 INFO - {'append_to_log': False, 17:41:49 INFO - 'base_work_dir': '/builds/slave/test', 17:41:49 INFO - 'blob_upload_branch': 'Firefox', 17:41:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:41:49 INFO - 'branch': 'Firefox', 17:41:49 INFO - 'buildbot_json_path': 'buildprops.json', 17:41:49 INFO - 'code_coverage': False, 17:41:49 INFO - 'config_files': ('talos/linux_config.py',), 17:41:49 INFO - 'default_actions': ('clobber', 17:41:49 INFO - 'read-buildbot-config', 17:41:49 INFO - 'download-and-extract', 17:41:49 INFO - 'populate-webroot', 17:41:49 INFO - 'create-virtualenv', 17:41:49 INFO - 'install', 17:41:49 INFO - 'setup-mitmproxy', 17:41:49 INFO - 'run-tests'), 17:41:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:41:49 INFO - 'disable_ccov_upload': False, 17:41:49 INFO - 'disable_stylo': False, 17:41:49 INFO - 'download_minidump_stackwalk': True, 17:41:49 INFO - 'download_symbols': 'ondemand', 17:41:49 INFO - 'enable_stylo': False, 17:41:49 INFO - 'enable_webrender': False, 17:41:49 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:41:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:41:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:41:49 INFO - 'gecko_profile': False, 17:41:49 INFO - 'gecko_profile_interval': 0, 17:41:49 INFO - 'installer_path': 'installer.exe', 17:41:49 INFO - 'log_level': 'info', 17:41:49 INFO - 'log_name': 'talos', 17:41:49 INFO - 'log_to_console': True, 17:41:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:41:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:41:49 INFO - 'opt_config_files': (), 17:41:49 INFO - 'pip_index': False, 17:41:49 INFO - 'suite': 'dromaeojs-e10s', 17:41:49 INFO - 'system_bits': '32', 17:41:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:41:49 INFO - 'title': 'talos-linux64-ix-066', 17:41:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:41:49 INFO - 'use_talos_json': True, 17:41:49 INFO - 'verify': 'False', 17:41:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:41:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:41:49 INFO - 'work_dir': 'build'} 17:41:49 INFO - [mozharness: 2017-09-26 00:41:49.589628Z] Running clobber step. 17:41:49 INFO - Running pre-action listener: _resource_record_pre_action 17:41:49 INFO - Running main action method: clobber 17:41:49 INFO - rmtree: /builds/slave/test/build 17:41:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:41:50 INFO - Running post-action listener: _resource_record_post_action 17:41:50 INFO - [mozharness: 2017-09-26 00:41:50.575788Z] Finished clobber step (success) 17:41:50 INFO - [mozharness: 2017-09-26 00:41:50.575885Z] Running read-buildbot-config step. 17:41:50 INFO - Running pre-action listener: _resource_record_pre_action 17:41:50 INFO - Running main action method: read_buildbot_config 17:41:50 INFO - Using buildbot properties: 17:41:50 INFO - { 17:41:50 INFO - "project": "", 17:41:50 INFO - "product": "firefox", 17:41:50 INFO - "who": "kwierso@gmail.com", 17:41:50 INFO - "installer_path": "public/build/target.tar.bz2", 17:41:50 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 17:41:50 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:41:50 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 17:41:50 INFO - "stage_platform": "linux64-qr", 17:41:50 INFO - "basedir": "/builds/slave/test", 17:41:50 INFO - "buildnumber": 82, 17:41:50 INFO - "platform": "ubuntu64_hw_qr", 17:41:50 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:41:50 INFO - "slavebuilddir": "test", 17:41:50 INFO - "taskId": "VOXQJ6UbSpq31do-PPEvmg", 17:41:50 INFO - "branch": "mozilla-central", 17:41:50 INFO - "script_repo_revision": "production", 17:41:50 INFO - "revision": "e6b3498a39b94616ba36798fe0b71a3090b1b14c", 17:41:50 INFO - "slavename": "talos-linux64-ix-066", 17:41:50 INFO - "repo_path": "mozilla-central" 17:41:50 INFO - } 17:41:50 INFO - Finding installer, test and symbols from parent task. 17:41:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VOXQJ6UbSpq31do-PPEvmg'}, attempt #1 17:41:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VOXQJ6UbSpq31do-PPEvmg'}, attempt #1 17:41:51 INFO - Task dependencies: YCRCLS0WQIqLyHDorScFGQ 17:41:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ'}, attempt #1 17:41:51 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.tar.bz2 17:41:51 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.test_packages.json 17:41:51 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.crashreporter-symbols.zip 17:41:51 INFO - Running post-action listener: _resource_record_post_action 17:41:51 INFO - [mozharness: 2017-09-26 00:41:51.887366Z] Finished read-buildbot-config step (success) 17:41:51 INFO - [mozharness: 2017-09-26 00:41:51.887585Z] Running download-and-extract step. 17:41:51 INFO - Running pre-action listener: _resource_record_pre_action 17:41:51 INFO - Running main action method: download_and_extract 17:41:51 INFO - mkdir: /builds/slave/test/build/tests 17:41: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')]} 17:41:51 INFO - trying https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.test_packages.json 17:41:51 INFO - Downloading https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:41:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:41:52 INFO - Downloaded 989 bytes. 17:41:52 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:41:52 INFO - Using the following test package requirements: 17:41:52 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:41:52 INFO - u'common': [u'target.common.tests.zip'], 17:41:52 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:41:52 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:41:52 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:41:52 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:41:52 INFO - u'mozbase': [u'target.common.tests.zip'], 17:41:52 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:41:52 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:41:52 INFO - u'web-platform': [u'target.common.tests.zip', 17:41:52 INFO - u'target.web-platform.tests.tar.gz'], 17:41:52 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:41:52 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 17:41:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.common.tests.zip 17:41:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:41:52 INFO - Fetch https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.common.tests.zip into memory 17:41:53 INFO - Content-Length response header: 54943837 17:41:53 INFO - Bytes received: 54943837 17:42:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.talos.tests.zip 17:42:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:42:04 INFO - Fetch https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.talos.tests.zip into memory 17:42:05 INFO - Content-Length response header: 14513823 17:42:05 INFO - Bytes received: 14513823 17:42:05 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')]} 17:42:05 INFO - trying https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.tar.bz2 17:42:05 INFO - Downloading https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:42:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:42:06 INFO - Downloaded 61658684 bytes. 17:42:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.tar.bz2 17:42:06 INFO - mkdir: /builds/slave/test/properties 17:42:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:42:06 INFO - Writing to file /builds/slave/test/properties/build_url 17:42:06 INFO - Contents: 17:42:06 INFO - build_url:https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.tar.bz2 17:42:06 INFO - Running post-action listener: _resource_record_post_action 17:42:06 INFO - Running post-action listener: find_tests_for_verification 17:42:06 INFO - Running post-action listener: set_extra_try_arguments 17:42:06 INFO - [mozharness: 2017-09-26 00:42:06.921005Z] Finished download-and-extract step (success) 17:42:06 INFO - [mozharness: 2017-09-26 00:42:06.921103Z] Running populate-webroot step. 17:42:06 INFO - Running pre-action listener: _resource_record_pre_action 17:42:06 INFO - Running main action method: populate_webroot 17:42:06 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:42:06 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:42:06 INFO - 'tests': ['tresize', 17:42:06 INFO - 'tcanvasmark']}, 17:42:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:42:06 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:42:06 INFO - 'tests': ['dromaeo_css', 17:42:06 INFO - 'kraken']}, 17:42:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:42:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:42:06 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:42:06 INFO - 'talos_options': ['--disable-stylo'], 17:42:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:42:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:42:06 INFO - 'tests': ['damp', 'tps']}, 17:42:06 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:42:06 INFO - 'talos_options': ['--disable-stylo'], 17:42:06 INFO - 'tests': ['damp', 'tps']}, 17:42:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:42:06 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:42:06 INFO - 'tests': ['dromaeo_dom']}, 17:42:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:42:06 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:42:06 INFO - 'tests': ['basic_compositor_video', 17:42:06 INFO - 'glvideo']}, 17:42:06 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:42:06 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:42:06 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:42:06 INFO - 'talos_options': ['--disable-stylo'], 17:42:06 INFO - 'tests': ['ts_paint_webext', 17:42:06 INFO - 'tp5o_webext']}, 17:42:06 INFO - 'other-e10s': {'tests': ['a11yr', 17:42:06 INFO - 'ts_paint', 17:42:06 INFO - 'tpaint', 17:42:06 INFO - 'sessionrestore', 17:42:06 INFO - 'sessionrestore_many_windows', 17:42:06 INFO - 'sessionrestore_no_auto_restore', 17:42:06 INFO - 'tabpaint']}, 17:42:06 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:42:06 INFO - 'tests': ['a11yr', 17:42:06 INFO - 'ts_paint', 17:42:06 INFO - 'tpaint', 17:42:06 INFO - 'sessionrestore', 17:42:06 INFO - 'sessionrestore_many_windows', 17:42:06 INFO - 'sessionrestore_no_auto_restore', 17:42:06 INFO - 'tabpaint']}, 17:42:06 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 17:42:06 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 17:42:06 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:42:06 INFO - 'tests': ['perf_reftest_singletons']}, 17:42:06 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:42:06 INFO - 'tests': ['perf_reftest']}, 17:42:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:42:06 INFO - 'tsvgr_opacity', 17:42:06 INFO - 'tart', 17:42:06 INFO - 'tscrollx', 17:42:06 INFO - 'tsvg_static']}, 17:42:06 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:42:06 INFO - 'tests': ['tsvgx', 17:42:06 INFO - 'tsvgr_opacity', 17:42:06 INFO - 'tart', 17:42:06 INFO - 'tscrollx', 17:42:06 INFO - 'tsvg_static']}, 17:42:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:42:06 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:42:06 INFO - 'talos_options': ['--disable-stylo'], 17:42:06 INFO - 'tests': ['tp5o']}, 17:42:06 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:42:06 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:42:06 INFO - 'talos_options': ['--mitmproxy', 17:42:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:42:06 INFO - '--firstNonBlankPaint'], 17:42:06 INFO - 'tests': ['tp6_google', 17:42:06 INFO - 'tp6_youtube', 17:42:06 INFO - 'tp6_amazon', 17:42:06 INFO - 'tp6_facebook']}, 17:42:06 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:42:06 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:42:06 INFO - 'talos_options': ['--disable-stylo', 17:42:06 INFO - '--mitmproxy', 17:42:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:42:06 INFO - '--firstNonBlankPaint'], 17:42:06 INFO - 'tests': ['tp6_google', 17:42:06 INFO - 'tp6_youtube', 17:42:06 INFO - 'tp6_amazon', 17:42:06 INFO - 'tp6_facebook']}, 17:42:06 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:42:06 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:42:06 INFO - 'talos_options': ['--stylo-threads=1', 17:42:06 INFO - '--mitmproxy', 17:42:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:42:06 INFO - '--firstNonBlankPaint'], 17:42:06 INFO - 'tests': ['tp6_google', 17:42:06 INFO - 'tp6_youtube', 17:42:06 INFO - 'tp6_amazon', 17:42:06 INFO - 'tp6_facebook']}, 17:42:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:42:06 INFO - 'talos_options': ['--xperf_path', 17:42:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:42:06 INFO - 'tests': ['tp5n']}, 17:42:06 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:42:06 INFO - 'talos_options': ['--disable-stylo', 17:42:06 INFO - '--xperf_path', 17:42:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:42:06 INFO - 'tests': ['tp5n']}}} 17:42:06 INFO - Running post-action listener: _resource_record_post_action 17:42:06 INFO - [mozharness: 2017-09-26 00:42:06.936607Z] Finished populate-webroot step (success) 17:42:06 INFO - [mozharness: 2017-09-26 00:42:06.936696Z] Running create-virtualenv step. 17:42:06 INFO - Running pre-action listener: _resource_record_pre_action 17:42:06 INFO - Running main action method: create_virtualenv 17:42:06 INFO - Creating virtualenv /builds/slave/test/build/venv 17:42:06 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:42:06 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:42:06 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:42:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:42:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:42:11 INFO - Installing distribute.............................................................................................................................................................................................done. 17:42:11 INFO - Installing pip...............done. 17:42:11 INFO - Return code: 0 17:42:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:42:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:42:11 INFO - Reading from file tmpfile_stdout 17:42:11 INFO - Output received: 17:42:11 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:42:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:42: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')]} 17:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42: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')]} 17:42:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11abb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13509c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134dd60>, '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 0x134ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134eef0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675', '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 17:42:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:42:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:42:11 INFO - Using env: {'DISPLAY': ':0', 17:42:11 INFO - 'HOME': '/home/cltbld', 17:42:11 INFO - 'LANG': 'en_US.UTF-8', 17:42:11 INFO - 'LANGUAGE': 'en_US:en', 17:42:11 INFO - 'LOGNAME': 'cltbld', 17:42:11 INFO - 'MAIL': '/var/mail/cltbld', 17:42:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:11 INFO - 'MOZ_NO_REMOTE': '1', 17:42:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:11 INFO - 'NO_EM_RESTART': '1', 17:42:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:11 INFO - 'PWD': '/builds/slave/test', 17:42:11 INFO - 'SHELL': '/bin/bash', 17:42:11 INFO - 'SHLVL': '1', 17:42:11 INFO - 'TERM': 'linux', 17:42:11 INFO - 'TMOUT': '86400', 17:42:11 INFO - 'USER': 'cltbld', 17:42:11 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675', 17:42:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:11 INFO - '_': '/tools/buildbot/bin/python'} 17:42:12 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:42:12 INFO - Downloading/unpacking pip>=1.5 17:42:12 INFO - Running setup.py egg_info for package pip 17:42:12 INFO - warning: no files found matching 'pip/cacert.pem' 17:42:12 INFO - warning: no files found matching '*.html' under directory 'docs' 17:42:12 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:42:12 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:42:12 INFO - Installing collected packages: pip 17:42:12 INFO - Found existing installation: pip 1.1 17:42:12 INFO - Uninstalling pip: 17:42:12 INFO - Successfully uninstalled pip 17:42:12 INFO - Running setup.py install for pip 17:42:12 INFO - warning: no files found matching 'pip/cacert.pem' 17:42:12 INFO - warning: no files found matching '*.html' under directory 'docs' 17:42:12 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:42:12 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:42:12 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:42:12 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:42:12 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:42:12 INFO - Successfully installed pip 17:42:12 INFO - Cleaning up... 17:42:12 INFO - Return code: 0 17:42:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:42:12 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')]} 17:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:12 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')]} 17:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:12 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 0xfe31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11abb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13509c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134dd60>, '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 0x134ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134eef0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675', '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 17:42:12 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 17:42:12 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 17:42:12 INFO - Using env: {'DISPLAY': ':0', 17:42:12 INFO - 'HOME': '/home/cltbld', 17:42:12 INFO - 'LANG': 'en_US.UTF-8', 17:42:12 INFO - 'LANGUAGE': 'en_US:en', 17:42:12 INFO - 'LOGNAME': 'cltbld', 17:42:12 INFO - 'MAIL': '/var/mail/cltbld', 17:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:12 INFO - 'MOZ_NO_REMOTE': '1', 17:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:12 INFO - 'NO_EM_RESTART': '1', 17:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:12 INFO - 'PWD': '/builds/slave/test', 17:42:12 INFO - 'SHELL': '/bin/bash', 17:42:12 INFO - 'SHLVL': '1', 17:42:12 INFO - 'TERM': 'linux', 17:42:12 INFO - 'TMOUT': '86400', 17:42:12 INFO - 'USER': 'cltbld', 17:42:12 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675', 17:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:12 INFO - '_': '/tools/buildbot/bin/python'} 17:42:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:13 INFO - Downloading/unpacking psutil>=3.1.1 17:42:13 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 17:42:13 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 17:42:13 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 17:42:13 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 17:42:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:42:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:42:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:42:14 INFO - Installing collected packages: psutil 17:42:14 INFO - Running setup.py install for psutil 17:42:14 INFO - building 'psutil._psutil_linux' extension 17:42:14 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 17:42:16 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 17:42:16 INFO - building 'psutil._psutil_posix' extension 17:42:16 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 17:42:16 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 17:42:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:42:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:42:16 INFO - Successfully installed psutil 17:42:16 INFO - Cleaning up... 17:42:16 INFO - Return code: 0 17:42:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:42:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:16 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 0xfe31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11abb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13509c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134dd60>, '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 0x134ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134eef0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675', '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 17:42:16 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 17:42:16 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 17:42:16 INFO - Using env: {'DISPLAY': ':0', 17:42:16 INFO - 'HOME': '/home/cltbld', 17:42:16 INFO - 'LANG': 'en_US.UTF-8', 17:42:16 INFO - 'LANGUAGE': 'en_US:en', 17:42:16 INFO - 'LOGNAME': 'cltbld', 17:42:16 INFO - 'MAIL': '/var/mail/cltbld', 17:42:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:16 INFO - 'MOZ_NO_REMOTE': '1', 17:42:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:16 INFO - 'NO_EM_RESTART': '1', 17:42:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:16 INFO - 'PWD': '/builds/slave/test', 17:42:16 INFO - 'SHELL': '/bin/bash', 17:42:16 INFO - 'SHLVL': '1', 17:42:16 INFO - 'TERM': 'linux', 17:42:16 INFO - 'TMOUT': '86400', 17:42:16 INFO - 'USER': 'cltbld', 17:42:16 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675', 17:42:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:16 INFO - '_': '/tools/buildbot/bin/python'} 17:42:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:42:16 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 17:42:16 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 17:42:16 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 17:42:16 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 17:42:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:42:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:42:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:42:17 INFO - Installing collected packages: mozsystemmonitor 17:42:17 INFO - Running setup.py install for mozsystemmonitor 17:42:18 INFO - Successfully installed mozsystemmonitor 17:42:18 INFO - Cleaning up... 17:42:18 INFO - Return code: 0 17:42:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:42:18 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')]} 17:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:18 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')]} 17:42:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:18 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 0xfe31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11abb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13509c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134dd60>, '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 0x134ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134eef0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675', '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 17:42:18 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 17:42:18 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 17:42:18 INFO - Using env: {'DISPLAY': ':0', 17:42:18 INFO - 'HOME': '/home/cltbld', 17:42:18 INFO - 'LANG': 'en_US.UTF-8', 17:42:18 INFO - 'LANGUAGE': 'en_US:en', 17:42:18 INFO - 'LOGNAME': 'cltbld', 17:42:18 INFO - 'MAIL': '/var/mail/cltbld', 17:42:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:18 INFO - 'MOZ_NO_REMOTE': '1', 17:42:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:18 INFO - 'NO_EM_RESTART': '1', 17:42:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:18 INFO - 'PWD': '/builds/slave/test', 17:42:18 INFO - 'SHELL': '/bin/bash', 17:42:18 INFO - 'SHLVL': '1', 17:42:18 INFO - 'TERM': 'linux', 17:42:18 INFO - 'TMOUT': '86400', 17:42:18 INFO - 'USER': 'cltbld', 17:42:18 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675', 17:42:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:18 INFO - '_': '/tools/buildbot/bin/python'} 17:42:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:18 INFO - Downloading/unpacking jsonschema==2.5.1 17:42:18 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 17:42:18 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 17:42:18 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 17:42:18 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 17:42:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:42:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:19 INFO - Downloading functools32-3.2.3-2.tar.gz 17:42:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:42:19 INFO - warning: no files found matching '*.txt' 17:42:19 INFO - no previously-included directories found matching 'build' 17:42:19 INFO - no previously-included directories found matching 'dist' 17:42:19 INFO - no previously-included directories found matching '.git*' 17:42:19 INFO - Installing collected packages: jsonschema, functools32 17:42:19 INFO - Running setup.py install for functools32 17:42:19 INFO - warning: no files found matching '*.txt' 17:42:19 INFO - no previously-included directories found matching 'build' 17:42:19 INFO - no previously-included directories found matching 'dist' 17:42:19 INFO - no previously-included directories found matching '.git*' 17:42:19 INFO - Successfully installed jsonschema functools32 17:42:19 INFO - Cleaning up... 17:42:19 INFO - Return code: 0 17:42:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:19 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 0xfe31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11abb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13509c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134dd60>, '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 0x134ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134eef0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675', '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 17:42:19 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 17:42:19 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 17:42:19 INFO - Using env: {'DISPLAY': ':0', 17:42:19 INFO - 'HOME': '/home/cltbld', 17:42:19 INFO - 'LANG': 'en_US.UTF-8', 17:42:19 INFO - 'LANGUAGE': 'en_US:en', 17:42:19 INFO - 'LOGNAME': 'cltbld', 17:42:19 INFO - 'MAIL': '/var/mail/cltbld', 17:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:19 INFO - 'MOZ_NO_REMOTE': '1', 17:42:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:19 INFO - 'NO_EM_RESTART': '1', 17:42:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:19 INFO - 'PWD': '/builds/slave/test', 17:42:19 INFO - 'SHELL': '/bin/bash', 17:42:19 INFO - 'SHLVL': '1', 17:42:19 INFO - 'TERM': 'linux', 17:42:19 INFO - 'TMOUT': '86400', 17:42:19 INFO - 'USER': 'cltbld', 17:42:19 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675', 17:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:19 INFO - '_': '/tools/buildbot/bin/python'} 17:42:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:42:19 INFO - Cleaning up... 17:42:19 INFO - Return code: 0 17:42:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:42:20 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')]} 17:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:20 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')]} 17:42:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:20 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 0xfe31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11abb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13509c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134dd60>, '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 0x134ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134eef0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675', '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 17:42:20 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 17:42:20 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 17:42:20 INFO - Using env: {'DISPLAY': ':0', 17:42:20 INFO - 'HOME': '/home/cltbld', 17:42:20 INFO - 'LANG': 'en_US.UTF-8', 17:42:20 INFO - 'LANGUAGE': 'en_US:en', 17:42:20 INFO - 'LOGNAME': 'cltbld', 17:42:20 INFO - 'MAIL': '/var/mail/cltbld', 17:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:20 INFO - 'MOZ_NO_REMOTE': '1', 17:42:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:20 INFO - 'NO_EM_RESTART': '1', 17:42:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:20 INFO - 'PWD': '/builds/slave/test', 17:42:20 INFO - 'SHELL': '/bin/bash', 17:42:20 INFO - 'SHLVL': '1', 17:42:20 INFO - 'TERM': 'linux', 17:42:20 INFO - 'TMOUT': '86400', 17:42:20 INFO - 'USER': 'cltbld', 17:42:20 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675', 17:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:20 INFO - '_': '/tools/buildbot/bin/python'} 17:42:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:20 INFO - Downloading/unpacking blobuploader==1.2.4 17:42:20 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 17:42:20 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 17:42:20 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 17:42:20 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 17:42:21 INFO - Downloading blobuploader-1.2.4.tar.gz 17:42:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:42:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:42:21 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 17:42:21 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 17:42:21 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 17:42:21 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 17:42:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:42:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:42:22 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 17:42:22 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 17:42:22 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 17:42:22 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 17:42:22 INFO - Downloading docopt-0.6.1.tar.gz 17:42:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:42:22 INFO - Installing collected packages: blobuploader, requests, docopt 17:42:22 INFO - Running setup.py install for blobuploader 17:42:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:42:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:42:22 INFO - Running setup.py install for requests 17:42:22 INFO - Running setup.py install for docopt 17:42:22 INFO - Successfully installed blobuploader requests docopt 17:42:22 INFO - Cleaning up... 17:42:23 INFO - Return code: 0 17:42:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:23 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 0xfe31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11abb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13509c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134dd60>, '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 0x134ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134eef0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675', '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 17:42:23 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 17:42:23 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 17:42:23 INFO - Using env: {'DISPLAY': ':0', 17:42:23 INFO - 'HOME': '/home/cltbld', 17:42:23 INFO - 'LANG': 'en_US.UTF-8', 17:42:23 INFO - 'LANGUAGE': 'en_US:en', 17:42:23 INFO - 'LOGNAME': 'cltbld', 17:42:23 INFO - 'MAIL': '/var/mail/cltbld', 17:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:23 INFO - 'MOZ_NO_REMOTE': '1', 17:42:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:23 INFO - 'NO_EM_RESTART': '1', 17:42:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:23 INFO - 'PWD': '/builds/slave/test', 17:42:23 INFO - 'SHELL': '/bin/bash', 17:42:23 INFO - 'SHLVL': '1', 17:42:23 INFO - 'TERM': 'linux', 17:42:23 INFO - 'TMOUT': '86400', 17:42:23 INFO - 'USER': 'cltbld', 17:42:23 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675', 17:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:23 INFO - '_': '/tools/buildbot/bin/python'} 17:42:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:42:23 INFO - Running setup.py (path:/tmp/pip-NqlWR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:42:23 INFO - Running setup.py (path:/tmp/pip-4g9Pih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:42:23 INFO - Running setup.py (path:/tmp/pip-xJpa3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:42:23 INFO - Running setup.py (path:/tmp/pip-waxdSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:42:23 INFO - Running setup.py (path:/tmp/pip-UpcSA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:42:23 INFO - Running setup.py (path:/tmp/pip-kY0xv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:42:23 INFO - Running setup.py (path:/tmp/pip-15Itkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:42:23 INFO - Running setup.py (path:/tmp/pip-wrPFlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:42:23 INFO - Running setup.py (path:/tmp/pip-GMfR76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:42:23 INFO - Running setup.py (path:/tmp/pip-FWH0EC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:42:24 INFO - Running setup.py (path:/tmp/pip-YyZ4TV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:42:24 INFO - Running setup.py (path:/tmp/pip-NNnOEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:42:24 INFO - Running setup.py (path:/tmp/pip-s16WfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:42:24 INFO - Running setup.py (path:/tmp/pip-21hpWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:24 INFO - Running setup.py (path:/tmp/pip-XWmnCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:42:24 INFO - Running setup.py (path:/tmp/pip-xReIn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:42:24 INFO - Running setup.py (path:/tmp/pip-MkZQ1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:42:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:42:24 INFO - Running setup.py install for manifestparser 17:42:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:42:24 INFO - Running setup.py install for mozcrash 17:42:24 INFO - Running setup.py install for mozdebug 17:42:24 INFO - Running setup.py install for mozdevice 17:42:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:42:24 INFO - Running setup.py install for mozfile 17:42:24 INFO - Running setup.py install for mozhttpd 17:42:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:42:25 INFO - Running setup.py install for mozinfo 17:42:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:42:25 INFO - Running setup.py install for mozInstall 17:42:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:42:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:42:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:42:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:42:25 INFO - Running setup.py install for mozleak 17:42:25 INFO - Running setup.py install for mozlog 17:42:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:42:25 INFO - Running setup.py install for moznetwork 17:42:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:42:25 INFO - Running setup.py install for mozprocess 17:42:25 INFO - Running setup.py install for mozprofile 17:42:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:42:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:42:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:42:25 INFO - Running setup.py install for mozrunner 17:42:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:42:25 INFO - Running setup.py install for mozscreenshot 17:42:25 INFO - Running setup.py install for moztest 17:42:26 INFO - Running setup.py install for mozversion 17:42:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:42:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:42:26 INFO - Cleaning up... 17:42:26 INFO - Return code: 0 17:42:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:42:26 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')]} 17:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:26 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')]} 17:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:26 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 0xfe31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11abb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13509c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134dd60>, '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 0x134ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134eef0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675', '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 17:42:26 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 17:42:26 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 17:42:26 INFO - Using env: {'DISPLAY': ':0', 17:42:26 INFO - 'HOME': '/home/cltbld', 17:42:26 INFO - 'LANG': 'en_US.UTF-8', 17:42:26 INFO - 'LANGUAGE': 'en_US:en', 17:42:26 INFO - 'LOGNAME': 'cltbld', 17:42:26 INFO - 'MAIL': '/var/mail/cltbld', 17:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:26 INFO - 'MOZ_NO_REMOTE': '1', 17:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:26 INFO - 'NO_EM_RESTART': '1', 17:42:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:26 INFO - 'PWD': '/builds/slave/test', 17:42:26 INFO - 'SHELL': '/bin/bash', 17:42:26 INFO - 'SHLVL': '1', 17:42:26 INFO - 'TERM': 'linux', 17:42:26 INFO - 'TMOUT': '86400', 17:42:26 INFO - 'USER': 'cltbld', 17:42:26 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675', 17:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:26 INFO - '_': '/tools/buildbot/bin/python'} 17:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:42:26 INFO - Running setup.py (path:/tmp/pip-v4jnth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:42:26 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)) 17:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:42:26 INFO - Running setup.py (path:/tmp/pip-FNpl1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:42:26 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)) 17:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:42:26 INFO - Running setup.py (path:/tmp/pip-XTLSPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:42:26 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)) 17:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:42:26 INFO - Running setup.py (path:/tmp/pip-GZ_b7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:42:26 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)) 17:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:42:26 INFO - Running setup.py (path:/tmp/pip-UX50FH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:42:26 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)) 17:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:42:26 INFO - Running setup.py (path:/tmp/pip-5xkw_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:42:26 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)) 17:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:42:26 INFO - Running setup.py (path:/tmp/pip-Ru9qpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:42:26 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)) 17:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:42:26 INFO - Running setup.py (path:/tmp/pip-0kcx9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:42:26 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)) 17:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:42:26 INFO - Running setup.py (path:/tmp/pip-B2tNgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:42:27 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)) 17:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:42:27 INFO - Running setup.py (path:/tmp/pip-Osfebo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:42:27 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)) 17:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:42:27 INFO - Running setup.py (path:/tmp/pip-USVBoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:42:27 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)) 17:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:42:27 INFO - Running setup.py (path:/tmp/pip-OEzghp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:42:27 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)) 17:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:42:27 INFO - Running setup.py (path:/tmp/pip-ATdgRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:42:27 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)) 17:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:42:27 INFO - Running setup.py (path:/tmp/pip-2Pcdx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:42:27 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)) 17:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:27 INFO - Running setup.py (path:/tmp/pip-V9vqxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:27 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)) 17:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:42:27 INFO - Running setup.py (path:/tmp/pip-eVfYKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:42:27 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)) 17:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:42:27 INFO - Running setup.py (path:/tmp/pip-9lumuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:42:27 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)) 17:42:27 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)) 17:42:27 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)) 17:42:27 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)) 17:42:27 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)) 17:42:27 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)) 17:42:27 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)) 17:42:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:42:27 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 17:42:27 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 17:42:27 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 17:42:27 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 17:42:28 INFO - Downloading blessings-1.6.tar.gz 17:42:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:42:28 INFO - Installing collected packages: blessings 17:42:28 INFO - Running setup.py install for blessings 17:42:28 INFO - Successfully installed blessings 17:42:28 INFO - Cleaning up... 17:42:29 INFO - Return code: 0 17:42:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:42:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:42:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:42:29 INFO - Reading from file tmpfile_stdout 17:42:29 INFO - Current package versions: 17:42:29 INFO - argparse == 1.2.1 17:42:29 INFO - blessings == 1.6 17:42:29 INFO - blobuploader == 1.2.4 17:42:29 INFO - docopt == 0.6.1 17:42:29 INFO - functools32 == 3.2.3-2 17:42:29 INFO - jsonschema == 2.5.1 17:42:29 INFO - manifestparser == 1.1 17:42:29 INFO - mozInstall == 1.13 17:42:29 INFO - mozcrash == 1.0 17:42:29 INFO - mozdebug == 0.1 17:42:29 INFO - mozdevice == 0.51 17:42:29 INFO - mozfile == 1.2 17:42:29 INFO - mozhttpd == 0.7 17:42:29 INFO - mozinfo == 0.10 17:42:29 INFO - mozleak == 0.1 17:42:29 INFO - mozlog == 3.5 17:42:29 INFO - moznetwork == 0.27 17:42:29 INFO - mozprocess == 0.25 17:42:29 INFO - mozprofile == 0.28 17:42:29 INFO - mozrunner == 6.13 17:42:29 INFO - mozscreenshot == 0.1 17:42:29 INFO - mozsystemmonitor == 0.3 17:42:29 INFO - moztest == 0.8 17:42:29 INFO - mozversion == 1.4 17:42:29 INFO - psutil == 3.1.1 17:42:29 INFO - requests == 1.2.3 17:42:29 INFO - wsgiref == 0.1.2 17:42:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:29 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 0xfe31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11abb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13509c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134dd60>, '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 0x134ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134eef0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675', '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 17:42:29 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 17:42:29 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 17:42:29 INFO - Using env: {'DISPLAY': ':0', 17:42:29 INFO - 'HOME': '/home/cltbld', 17:42:29 INFO - 'LANG': 'en_US.UTF-8', 17:42:29 INFO - 'LANGUAGE': 'en_US:en', 17:42:29 INFO - 'LOGNAME': 'cltbld', 17:42:29 INFO - 'MAIL': '/var/mail/cltbld', 17:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:29 INFO - 'MOZ_NO_REMOTE': '1', 17:42:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:29 INFO - 'NO_EM_RESTART': '1', 17:42:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:29 INFO - 'PWD': '/builds/slave/test', 17:42:29 INFO - 'SHELL': '/bin/bash', 17:42:29 INFO - 'SHLVL': '1', 17:42:29 INFO - 'TERM': 'linux', 17:42:29 INFO - 'TMOUT': '86400', 17:42:29 INFO - 'USER': 'cltbld', 17:42:29 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675', 17:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:29 INFO - '_': '/tools/buildbot/bin/python'} 17:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:29 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)) 17:42:29 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)) 17:42:29 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)) 17:42:29 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)) 17:42:29 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)) 17:42:29 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)) 17:42:29 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)) 17:42:29 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)) 17:42:29 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)) 17:42:29 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:42:29 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 17:42:29 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 17:42:29 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 17:42:29 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 17:42:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:42:30 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)) 17:42:30 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)) 17:42:30 INFO - Installing collected packages: simplejson 17:42:30 INFO - Running setup.py install for simplejson 17:42:30 INFO - building 'simplejson._speedups' extension 17:42:30 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 17:42:31 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 17:42:31 INFO - Successfully installed simplejson 17:42:31 INFO - Cleaning up... 17:42:31 INFO - Return code: 0 17:42:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11abb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13509c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134dd60>, '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 0x134ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134eef0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675', '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 17:42:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:42:31 INFO - Using env: {'DISPLAY': ':0', 17:42:31 INFO - 'HOME': '/home/cltbld', 17:42:31 INFO - 'LANG': 'en_US.UTF-8', 17:42:31 INFO - 'LANGUAGE': 'en_US:en', 17:42:31 INFO - 'LOGNAME': 'cltbld', 17:42:31 INFO - 'MAIL': '/var/mail/cltbld', 17:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:31 INFO - 'MOZ_NO_REMOTE': '1', 17:42:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:31 INFO - 'NO_EM_RESTART': '1', 17:42:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:31 INFO - 'PWD': '/builds/slave/test', 17:42:31 INFO - 'SHELL': '/bin/bash', 17:42:31 INFO - 'SHLVL': '1', 17:42:31 INFO - 'TERM': 'linux', 17:42:31 INFO - 'TMOUT': '86400', 17:42:31 INFO - 'USER': 'cltbld', 17:42:31 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675', 17:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:31 INFO - '_': '/tools/buildbot/bin/python'} 17:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:42:31 INFO - Cleaning up... 17:42:31 INFO - Return code: 0 17:42:31 INFO - Running post-action listener: _resource_record_post_action 17:42:31 INFO - Running post-action listener: _start_resource_monitoring 17:42:31 INFO - Starting resource monitoring. 17:42:31 INFO - [mozharness: 2017-09-26 00:42:31.998410Z] Finished create-virtualenv step (success) 17:42:31 INFO - [mozharness: 2017-09-26 00:42:31.999461Z] Running install step. 17:42:31 INFO - Running pre-action listener: _resource_record_pre_action 17:42:31 INFO - Running main action method: install 17:42:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:42:32 INFO - Reading from file tmpfile_stdout 17:42:32 INFO - Detecting whether we're running mozinstall >=1.0... 17:42:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:42:32 INFO - Reading from file tmpfile_stdout 17:42:32 INFO - Output received: 17:42:32 INFO - Usage: mozinstall [options] installer 17:42:32 INFO - Options: 17:42:32 INFO - -h, --help show this help message and exit 17:42:32 INFO - -d DEST, --destination=DEST 17:42:32 INFO - Directory to install application into. [default: 17:42:32 INFO - "/builds/slave/test"] 17:42:32 INFO - --app=APP Application being installed. [default: firefox] 17:42:32 INFO - mkdir: /builds/slave/test/build/application 17:42:32 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'] 17:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:42:50 INFO - Reading from file tmpfile_stdout 17:42:50 INFO - Output received: 17:42:50 INFO - /builds/slave/test/build/application/firefox/firefox 17:42:50 INFO - Running post-action listener: _resource_record_post_action 17:42:50 INFO - [mozharness: 2017-09-26 00:42:50.202393Z] Finished install step (success) 17:42:50 INFO - [mozharness: 2017-09-26 00:42:50.202746Z] Running setup-mitmproxy step. 17:42:50 INFO - Running pre-action listener: _resource_record_pre_action 17:42:50 INFO - Running main action method: setup_mitmproxy 17:42:50 INFO - Skipping: mitmproxy is not required 17:42:50 INFO - Running post-action listener: _resource_record_post_action 17:42:50 INFO - [mozharness: 2017-09-26 00:42:50.203884Z] Finished setup-mitmproxy step (success) 17:42:50 INFO - [mozharness: 2017-09-26 00:42:50.204106Z] Running run-tests step. 17:42:50 INFO - Running pre-action listener: _resource_record_pre_action 17:42:50 INFO - Running pre-action listener: _set_gcov_prefix 17:42:50 INFO - Running main action method: run_tests 17:42:50 WARNING - Try message not found. 17:42:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:42:50 INFO - Python 2.7.3 17:42:50 INFO - Return code: 0 17:42:50 INFO - grabbing minidump binary from tooltool 17:42:50 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')]} 17:42:50 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 0x134dd60>, '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 0x134ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134eef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:42:50 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 17:42:50 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 17:42:50 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 17:42:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:42:50 INFO - Return code: 0 17:42:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:42:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:42:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:42:50 INFO - ENV: RUST_BACKTRACE is now full 17:42:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:42:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:42:50 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/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 17:42:50 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/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 17:42:50 INFO - Using env: {'DISPLAY': ':0', 17:42:50 INFO - 'HOME': '/home/cltbld', 17:42:50 INFO - 'LANG': 'en_US.UTF-8', 17:42:50 INFO - 'LANGUAGE': 'en_US:en', 17:42:50 INFO - 'LOGNAME': 'cltbld', 17:42:50 INFO - 'MAIL': '/var/mail/cltbld', 17:42:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:42:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:42:50 INFO - 'MOZ_ACCELERATED': '1', 17:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:50 INFO - 'MOZ_NO_REMOTE': '1', 17:42:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:42:50 INFO - 'MOZ_WEBRENDER': '1', 17:42:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:50 INFO - 'NO_EM_RESTART': '1', 17:42:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:50 INFO - 'PWD': '/builds/slave/test', 17:42:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:42:50 INFO - 'RUST_BACKTRACE': 'full', 17:42:50 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:42:50 INFO - 'SHELL': '/bin/bash', 17:42:50 INFO - 'SHLVL': '1', 17:42:50 INFO - 'TERM': 'linux', 17:42:50 INFO - 'TMOUT': '86400', 17:42:50 INFO - 'USER': 'cltbld', 17:42:50 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675', 17:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:50 INFO - '_': '/tools/buildbot/bin/python'} 17:42:50 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/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 17:42:51 INFO - mozversion application_buildid: 20170925234146 17:42:51 INFO - mozversion application_changeset: e6b3498a39b94616ba36798fe0b71a3090b1b14c 17:42:51 INFO - mozversion application_display_name: Nightly 17:42:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:42:51 INFO - mozversion application_name: Firefox 17:42:51 INFO - mozversion application_remotingname: firefox 17:42:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:42:51 INFO - mozversion application_vendor: Mozilla 17:42:51 INFO - mozversion application_version: 58.0a1 17:42:51 INFO - mozversion platform_buildid: 20170925234146 17:42:51 INFO - mozversion platform_changeset: e6b3498a39b94616ba36798fe0b71a3090b1b14c 17:42:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:42:51 INFO - mozversion platform_version: 58.0a1 17:42:51 INFO - using testdate: 1506386571 17:42:51 INFO - actual date: 1506386571 17:42:51 INFO - starting webserver on 'localhost:33240' 17:42:51 INFO - SUITE-START | Running 2 tests 17:42:51 INFO - TEST-START | dromaeo_css 17:42:51 INFO - Initialising browser for dromaeo_css test... 17:42:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33240/getInfo.html -profile /tmp/tmpgh2DKB/profile 17:42:51 INFO - TEST-INFO | started process 3593 (/builds/slave/test/build/application/firefox/firefox http://localhost:33240/getInfo.html) 17:43:01 INFO - TEST-INFO | 3593: exit 0 17:43:01 INFO - Browser initialized. 17:43:01 INFO - Running cycle 1/1 for dromaeo_css test... 17:43:01 INFO - Using env: {'DISPLAY': ':0', 17:43:01 INFO - 'HOME': '/home/cltbld', 17:43:01 INFO - 'JSGC_DISABLE_POISONING': '1', 17:43:01 INFO - 'LANG': 'en_US.UTF-8', 17:43:01 INFO - 'LANGUAGE': 'en_US:en', 17:43:01 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:43:01 INFO - 'LOGNAME': 'cltbld', 17:43:01 INFO - 'MAIL': '/var/mail/cltbld', 17:43:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:43:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:43:01 INFO - 'MOZ_ACCELERATED': '1', 17:43:01 INFO - 'MOZ_CRASHREPORTER': '1', 17:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:01 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:43:01 INFO - 'MOZ_NO_REMOTE': '1', 17:43:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:43:01 INFO - 'MOZ_WEBRENDER': '1', 17:43:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:01 INFO - 'NO_EM_RESTART': '1', 17:43:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:01 INFO - 'PWD': '/builds/slave/test', 17:43:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:43:01 INFO - 'RUST_BACKTRACE': 'full', 17:43:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:43:01 INFO - 'SHELL': '/bin/bash', 17:43:01 INFO - 'SHLVL': '1', 17:43:01 INFO - 'TERM': 'linux', 17:43:01 INFO - 'TMOUT': '86400', 17:43:01 INFO - 'USER': 'cltbld', 17:43:01 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675', 17:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:01 INFO - '_': '/tools/buildbot/bin/python'} 17:43:01 INFO - TEST-INFO | started process 3839 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgh2DKB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:43:02 INFO - PID 3839 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 17:43:02 INFO - PID 3839 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 17:43:02 INFO - PID 3839 | 17:43:02 INFO - PID 3839 | (/builds/slave/test/build/application/firefox/firefox:3899): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:43:02 INFO - PID 3839 | 17:43:12 INFO - PID 3839 | RSS: Main: 201764864 17:43:12 INFO - PID 3839 | 17:46:09 INFO - PID 3839 | Cycle 1(1): loaded http://localhost:33240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33240/tests/dromaeo/cssquery-ext.html) 17:46:11 INFO - PID 3839 | RSS: Main: 203759616 17:46:11 INFO - PID 3839 | 17:49:13 INFO - PID 3839 | Cycle 1(1): loaded http://localhost:33240/tests/dromaeo/cssquery-ext.html (next: http://localhost:33240/tests/dromaeo/cssquery-jquery.html) 17:49:13 INFO - PID 3839 | RSS: Main: 207822848 17:49:13 INFO - PID 3839 | 17:52:16 INFO - PID 3839 | Cycle 1(1): loaded http://localhost:33240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33240/tests/dromaeo/cssquery-mootools.html) 17:52:16 INFO - PID 3839 | RSS: Main: 207171584 17:52:16 INFO - PID 3839 | 17:55:18 INFO - PID 3839 | Cycle 1(1): loaded http://localhost:33240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33240/tests/dromaeo/cssquery-prototype.html) 17:55:19 INFO - PID 3839 | RSS: Main: 208744448 17:55:19 INFO - PID 3839 | 17:58:23 INFO - PID 3839 | Cycle 1(1): loaded http://localhost:33240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33240/tests/dromaeo/cssquery-yui.html) 17:58:24 INFO - PID 3839 | RSS: Main: 206323712 17:58:24 INFO - PID 3839 | 18:01:25 INFO - PID 3839 | Cycle 1(1): loaded http://localhost:33240/tests/dromaeo/cssquery-yui.html (next: http://localhost:33240/tests/dromaeo/cssquery-dojo.html) 18:01:26 INFO - PID 3839 | RSS: Main: 206008320 18:01:26 INFO - PID 3839 | 18:01:26 INFO - PID 3839 | __start_tp_report 18:01:26 INFO - PID 3839 | _x_x_mozilla_page_load 18:01:26 INFO - PID 3839 | _x_x_mozilla_page_load_details 18:01:26 INFO - PID 3839 | |i|pagename|runs| 18:01:26 INFO - PID 3839 | |0;dojo.html;3094.7369473594745;3114.486109791886;3128.421242070219;3148.622165340158;3157.9368412631743;6006.639601623906;6171.845703857406;6175;6204.689765511729;6246.531510136747;6093.573449858512;6107.664078475682;6134.723937422816;6171.166892469515;6196.752129914809;5658.971705141479;5676.716164191795;5759.366469688352;5781.075027995522;5790.7683692652245;5762.164486149506;5773.624714393551;5829.038208695561;5850;5858;105.83807340747656;5593.272874526327;5610.663360198401;5704.942950570483;5840.532757379399;5654.6041777075625;5697.857553561153;5770.826875193751;5776.335721392052;5791.942080579182;5696.914546281809;5697.743601537941;5741.397153298885;5771.942280577225;5780.710964451802;6086.360932102154;6134.04922237054;6187.504999600022;6241.750329986795;6275.09011193379;6603.273639899608;6625.536212465129;6665.533412661116;6692.130023096966;6701.095352127498;6648.700808463631;6697.3637504437;6746.730130794763;6750.122484077087;6750.35871592198;6042.879142417171;6134.8159555213415;6161.44546990773;6210.4100110489435;6232.376762323776;6891.035255064345;6891.75878844238;6916.066331045245;6936.132983377078;6944.791656250321;6511.120998665215;6517.641529715816;6597.769078082244;6603.867922641616;6605;6610.669466526654;6617.966910165418;6618.96690516554;6673;6731.326867313327;6451.096846441502;6487.091807147003;6520.771772988018;6629.502787290972;6651.334866513407;6566.540342176002;6605.933940660628;6658.267590565034;6659;6720.764773232913;5245.291885595396;5299.8410047698635;5300.204969254565;5314.946850531523;5315.760790764425;4537.22867112585;4542.818287268538;4588.609968152745;4599.7470139142;4609.469910960215;5526.171074338801;5617.578681598897;5634.802781902614;5654.717264136777;5655.604107712503;6563.1796025496815;6613.272540020594;6649.268580456146;6667.733290668319;6693.263740988487;5613.382527921925;5667.801626943037;5686.3744988051285;5728.369879313273;5776.826695199151;5683.119116536944;5713.971430142906;5721.656700597978;5733.168690539932;5801;6301.464375528039;6340.9365906340345;6341.0805433212845;6380.776672816429;6421.8073457796345;6531.738730450824;6550.8362290943105;6575.408213260829;6609.173853268246;6657.500687448364;6438.323975982455;6497.155369801895;6527.445167160845;6554.442872355903;6565.212174539086;6575.243846957661;6575.835604109936;6576.145101136822;6658.201015878126;6676.065350850788;6553.279139294578;6657.434118100015;6702.597844129368;6795.830104247236;6818.386345228953;6437.25971513282;6440.581362211441;6488.416042556004;6522.641254731036;6526.836829079311;6393.4885209184085;6524.67376631176;6537.673116344259;6560.3111673273615;6560.8359791005605;6332.493400528039;6375.426211640789;6402.743890244338;6416.326285740117;6468.773592924414;6134.969325153345;6398.87202255943;6512.088307637029;6537.673116344259;6587.538872279086;6266.655333956493;6317.905231421624;6393.776217832354;6398;6399.520035997226 18:01:26 INFO - PID 3839 | |1;ext.html;864.9697260595879;887.9911200887991;889.6752685269875;892.6340200517785;895.7268033249857;38240.42639360412;41645;41699;42179;42249.57750422495;38698.226035479274;38702.419463708;38941.805290973505;39040;39072.80463597685;6989.685464154112;7063.682134303943;7136.607486588236;7136.644037632833;7138.07205063341;6929.72281108755;6953.791386258395;6976.058232138673;7010.509264351497;7019.227884932653;6980.755673551426;6994.0907682001525;6995.860082798341;6997.405220556258;7005.649717514129;7416.221296763843;7675.654595543214;7676.11724651661;7683.462157648967;7687.423443241752;7247.057882475245;7323.7070517179245;7326.084239470067;7328.853422931565;7328.963355183243;37320.81339593312;37866.24267514662;37932.81033594815;38100.23799524022;38374;3526.594441639193;3565.3047655707146;3596.1189508570305;3598.082488965297;3599.136207310227;31539.526907096413;31684.366312673847;31725.524117138262;31725.682743172503;31838.681613184035;4863.17326054568;4869.82955596556;4885.242787367928;4965.255211718235;5049.3183420238165;187734;188321;188938;189044;190357;42287.365689514685;42794.572054279684;47908.28137577939;48489.75755121202;48714.756426217646;51111.74444127756;51324.74337628288;51414.74292628513;51524.48475515272;51684;15477.922610386877;15485.612859678598;15589;15630.3747850087;15654.608634783994;12234.449449774782;12303;12314.322712250912;12362.75274494505;12595.874041259653;14350.569482915529;14365.20991345486;14420.927895360455;14558.927205363905;14636.341364638403;5781.306243250753;5796.971015144897;5882.470577648032;5900.822975310747;5912.87655345483;1001.9699409017741;1018.6027449294781;1025.9384436933808;1036.9014943580348;1038.314712289885;23241.651375229387;23481.765182347957;23576.29271121869;23642.7635723644;23820.7617923822;1113.7661091170944;1121.2767764791663;1141.8743938166795;1142.8971392574708;1147.8909503597145;12429.192102513307;12509;12540.372981350896;12580.622581322576;12606;226865;230002;230501;230543;230642;53234.46765532372;53810.730946345015;53893.73053134709;53910;53947.46052539503;1412.2303344677175;1481.9629509262354;1487.2861026707026;1493.1115985988536;1497.663025819182;22293;22705;22714.31857044225;22820.885895570416;22872.885635571714;36585.81707091554;36915.81542092272;36987.26025479529;37048.88853334404;37089.814550927076;195087;196816;197313;198698;199099;30120.397592048474;30862.228444288176;32558.186045349055;32831.83584082064;33853;40616;40883.38674919938;41329;41486.79256603698;42424.36363454613;30928;31204;31629.20926976844;31643.683563164075;32006.35987280288;30608.693913060586;30990;31424.214394639403;31523.842380787948;31630.683693163694;34840.82579587086;34906.30187396289;35139.29721405609;35201;35420.82289588536;30057.098287051424;30138.3972320548;30166.09501714952;30696.386072277983;31001.68998309988;23092.769072309064;23190.956406962065;23276.478143319164;23831.165909193096;24104.276871693877 18:01:26 INFO - PID 3839 | |2;jquery.html;587.5035594922289;588.6314319207837;589.245765420262;596.7076132694981;604.6009633641797;22212.88893555532;22936.541269174606;22976.08095676175;23009.194678186268;23167.30498085056;23799;24389.146379876707;24925.62611560828;25190.874045629793;25278.241652750447;6119.571629985891;6246.968765156168;6278.780242691507;6302.023186406092;6341.556091073627;6134.8466288342925;6198.256209254896;6223.408776166257;6226.252849658047;6241.438270555649;5981.371955944628;6112.174856394375;6156.907646385308;6168.0439531872635;6187.4431301182885;6138.416850399227;6198.0083186690135;6203.875922481548;6228.377162283736;6246.593971391891;5595.608307418483;5757.884842303172;5814.156947242626;5818.970905145447;5821.330546987108;27588.17235482939;28230.576541351897;28266;28311.575326370123;28328.15015549516;1988.3239698502578;2017.0217444539387;2023.6559784836613;2032.542677897476;2033.6542787726123;18973.43079707611;19104.331348402877;19493.902530487398;19575.21699132033;19581.706274405897;2414.9396265093337;2455.3493324269084;2461.040194324215;2465.8027357811334;2465.938351541208;122737;129377.35311323477;130927.34536327257;131828.34085829605;142248.99999999895;14224.171313506928;14320.992571644867;14663.34014969329;14764.657968247906;14949.53332700114;22438.551228975655;22989.425264368525;22995.310140695805;23022.539549208923;23063.308100757004;9899.307048506535;9901.851472227921;10091.394516328897;10115.342502737445;10201.38791672502;9273.258139348836;9290.349675522784;9354.859677104849;9357.204637605744;9365.62537498506;8675;8965.327600429993;9018.819623607491;9059.463350261805;9168.44989300644;2716.2122984334715;2742.2595899107127;2776.250412388644;2778.9023335782254;2845.1322346684046;954.5847556313026;968.5496244246459;970.4856426094041;971.155095067296;979.6424305128577;18412;18459.538511537317;18831.05844707759;18989.240430382906;19541.609167816565;1014.2342531388754;1030.6289735695143;1035.1304903880775;1036.0727149201573;1043.666026871409;10530.842037369446;10652.414117223627;10688.25182237236;10820.188485863591;10910;448286;449122;450880;452622;460048;105377.47311263395;106612.46693766481;108447.45776271068;109276;109295.45352273187;1139.5270962550615;1141.9486123124314;1170.3621526268034;1176.04152615618;1177.1936223686803;16641.583960401087;16951.66096678084;17264.913675431544;17422.390216342366;17591;52452.47547524476;52741.736291318295;53101.46898530965;53435.732821335645;53831;66908.3309166902;68006.31993679999;68145;68234.65882670753;69287.30712692809;13805.309734513034;14306.713865722835;14313;14378.784318235026;14385.42458301698;21661.458463537907;21840.781592183874;21963.450913727283;22077.116915323848;22146.335609931728;16501;16966.06686632247;17377.739333910253;17726.202320895332;17773;14611.196384198971;14683.706325873636;14845;15961.281742321391;16050.67898642044;15624.453144139901;16159.919200403923;16303;16376.508704738877;17822.732659009867;13844.446222151;13860;14039.227842468354;14073.296335183404;14073.718525629634;17270.395536156175;17720.55698607545;17762.91118544399;17763.289468421117;17992.730109048636 18:01:26 INFO - PID 3839 | |3;mootools.html;1314.8816606505416;1354.1062898487007;1362.8909687225023;1391.2556782121567;1393.9233342166183;14955.700885982274;15630.9839860409;15689.607759806011;15768.21158942054;15837.208139593033;15157.938944273905;15398.769018464704;15449.92275038626;15465.381384744625;15650.139242341667;2666.919992400231;2687.9731202687967;2735.589661550773;2740.4793089312966;2746.6703995520566;2661.467706458716;2690.1660485249536;2697.5144473994674;2708.444768822387;2713.782897368216;2440.5973014452593;2694.528457519926;2729.822561533494;2732.86335683216;2741.0269354379107;2701.4191948730922;2734.849583272919;2760.5721113227482;2762.1437354419995;2775.278427608826;2622.711501734827;2711.7966152538443;2712;2746.6841313249033;2748.189284161177;15110.924445377703;15308.770368444482;15394.461193858273;15512.922435387864;15529.844701553066;8149.877751833727;8368.3305335573;8402;8435.451695639764;8460.8730869037;5456.3204913730215;5572.637778544422;5598.972005139989;5657.717114144276;5720.08478643415;1848.7596612440432;1863.5806943437753;1865.272543707955;1898.8860668359944;1904.5048287445363;27453.17640470769;27534.44931101367;27693.446131077468;27699.584506232422;27776.861115694493;6763.661816909135;6990;7027.718891244395;7128.465365097639;7186.353228209382;17598.208080636403;17672.204750786244;17677.38129165473;17746.645067098587;17789.19948602316;7783.143854176036;7811.296983271533;7859.960700196577;7879.369650427952;7883.842323153504;7081.221065682771;7248.746293879689;7545.245475452411;7574.356179724675;7583.9620801895635;5096.694198348111;5224.242484839677;5231.895362092737;5265.76304066318;5268.2097685346735;1480.7556753135827;1484.7698606715976;1498.19846382185;1503.2033022498094;1516.5601975427223;840.6259214649544;864.0754392799644;880.6125304865839;888.8755574219614;892.9107089291149;8735.781605459915;8755.255803256794;8789.69236076747;8941.195292423583;9003.594838232295;975.2198241406846;975.8728668388023;985.3398223190479;1013.2501948558014;1023.902729240721;4335.7181783184;4491.258942274553;4530.456345238593;5016.623753218523;5367.302250707383;22303.44241393978;22352.88823555872;23047.308580742603;23184.65223021656;23282.301530954097;21229.363119106143;22273.777262227493;22595.774042259694;22640.207592734176;22709.659355109685;11671.35807530594;11901.642950711492;11955.103367247491;12052.698682532831;12206.389680515938;7611.7450904043335;7868.803279917819;7946.483478573874;8073.515589064675;8123.634436450256;18231.817681823013;18655.626887462447;19103.52241193981;19461.026948652794;19643;18877.622447550697;19467.90266048661;19996.300129495397;20288.391348259574;20473.48816279605;11555.133364997491;11636.709082273012;11714.355710436008;11761.823572646246;11784;14214.857851421768;14396.784048239075;14512.201828899511;14532;14628.414863405771;11424.428778561205;11966.521339146337;12117.75764484723;12143.574974875837;12355.69110772202;11111.611093611686;11189.72025699364;11734.823977640513;11786.939175474248;11847.52609895629;9579.089986451276;9755.170810480904;9766.414015159113;9797.657082002095;9800.558974846006;7146.285371462812;7299.9270007301375;7337.119545654556;7345.3021962913435;7485.588292643957;7242.927570724225;7282.308180722823;7317.195108538163;7332.45006624516;7410.444216683878 18:01:26 INFO - PID 3839 | |4;prototype.html;503.1833542579534;533.6744585802658;540.7350398304831;541.7887024060615;542.6391449685959;6146.293176284723;6248.281447633518;6259.123722678829;6262.373762623735;6263.530235232359;6061.363556826536;6171.950768369376;6181;6189.659568723719;6250.593711408756;4839.741667166527;5080.364954380702;5091.159958606825;5115.641905066628;5152.587792976553;5007.14878470659;5015.2226404907115;5040.420351659551;5048.848534543951;5054.646174767768;4940.975295123538;4969.503049695019;5015.799368025275;5022.723750193738;5052.671576347526;4984.476629953875;5010.3737032870895;5012.423571289294;5018.899622007576;5021.57316628087;4495.505494395614;4533.410656614652;4535.818567257305;4543.5002149763495;4556.612687921531;6026.879462410771;6073.301570319426;6088.360722124157;6105.206323178003;6189.659568723719;5672.574556908207;5684.4315568443235;5696.77212911483;5766.654000759968;5776.797812076557;6491.350864913518;6519.348065193491;6547.770828020996;6564.934350656527;6570.244421891496;4865.56209941107;4891.413030436335;4908.337374454439;4919.188333924898;4925.655204135712;6549.279579246279;6606.6036037837885;6613.603183808987;6684.565503242274;6718.664066796689;4986.12742770021;4995.9500404996215;5002.299678045077;5007.223880298559;5015.1975683890405;5039.672421292677;5080.364954380702;5096.592272618182;5100.591952643779;5105.259737338065;5630.774769009194;5668.8866222675315;5711.914321285184;5722.284714410699;5733.426657334233;6558.5409021369;6562.179727534059;6566.376194261537;6606.834829129214;6614.9669251654395;1727.2313820350075;1735.3145507524457;1746.2491128814731;1749.2215963895944;1749.58010077583;1183.3964678014102;1208.3535308610028;1218.8781121887741;1229.6842378654753;1244.1788419643174;5520.503154716095;5594.524465420403;5597.608167428241;5606.887862242732;5666.838298148869;6581.506387020992;6604.174478190226;6642.535022548472;6648.501362397743;6730.663466826639;5430.583390391238;5557.888842223133;5652.710652185871;5665.66006039639;5670.206171136044;3481.007912744906;3495.919927643048;3498.1954150545516;3506.8421921013105;3555;6268.529860260499;6308.842278943063;6402.9359706403275;6468.708908099147;6520.804375868732;6831.965840170867;6866.485013623998;6889.793306200822;6907.309269073053;6912.654367281616;6442.809444788794;6451.580647257913;6459;6501;6537.46976632613;6544.858467935323;6546.574472659262;6671.366220209073;6691.59850408977;6695;6475;6533.901991470037;6584.242812076673;6596.71364083999;6625.4699624029;6347.90478142819;6409.391107844747;6424.839379015562;6426.646534440651;6540.215174179129;4981.028699403581;4986.975065124651;5033.798648054183;5035.446100928968;5036.622253331088;6384.850726869208;6452.257990331172;6517.73929042833;6566.507511936528;6646.202455705346;6263;6386.840328991812;6402.791037092195;6405.903911441239;6427.003814408774;6359.87280254383;6391.48868090561;6407.935920640734;6429.903551446639;6481.5138864584405;6308.463780578702;6311.337309582428;6344.841378965562;6346.714397852015;6348.746050157942;6449.709763060768;6459.580127291711;6510.44661203803;6520.9347906520325;6552.901706474311;6291.96854015727;6321.385388666207;6330;6334.208223972004;6361.7137228823885 18:01:26 INFO - PID 3839 | |5;yui.html;900.7612982559618;912.6531917871208;921.7465197070804;925.070304344134;934.7616357828755;19325;19904.601907961867;19982.900085499554;20004.399868003984;20226.39320820374;18057.729134063;18298.72551911719;18326.45020649379;18345.816541834578;18383.172757225922;956.2636769687354;968.1577027985662;968.2641192693533;969.92725545584;971.1696499492938;973.3284034016541;978.9965285582264;979.5494072726518;980.9068138526865;981.8527220916848;1002.2082554781714;1033.7829055898271;1035.9637412690558;1041.526105621944;1041.5937784264142;1024.482636268687;1027.6711452335219;1028.2596530498029;1030.304544432509;1035.5702383510873;742.5433358484493;747.0848210941607;748.6668432547518;750.246002767221;751.1174370115093;19566.608667826564;19847.80152198474;20544.691829622567;20617.58764824695;20733.58532829335;21870.343889683336;22104.33686989393;22309;22362.55274894493;22622.547549048926;16818.579535511588;17060.146992650443;17134.314627415013;17246;17296.394626188023;3647.051766540692;3671.04552816267;3676.4117741161554;3702.9814850925573;3712.9628703713156;108883.45558272158;128616;140331.29834350865;142459;144241;17658.205380757896;17770.289188432576;17788;17902.194401251974;17925;31243.218919527193;32005.51991720126;32311.838440808115;32337.51493727596;32543.51184732231;8853.335999800041;9046.05016473274;9055.954720226357;9106.544672766335;9158.450492970444;4073.5926407359025;4156.210320039183;4170.186813571385;4185.6232939035635;4199.70602057853;5543.584231182677;5562.02664533705;5620.269364982608;5634.492895639412;5668;912.479886464722;1085.9619913302997;1089.2593036735095;1098.7692584557174;1121.2095472691733;591.2963573347703;605.642670824207;629.9118123462719;635.3360738028771;636.9936300636934;12169.2698438094;12350.814737778941;12398.318092504998;12408.503659853684;13209.801852972214;692.2834865913755;700.6776882634045;710.9608971506617;719.3525826755962;727.9526830755984;5507.834764957058;5550.4449555044175;5568.7215639217875;5619.606627536034;5645.774169033192;117164.41417792857;119884.40057799655;120550.39724801319;122552.38723806503;123190.38404808097;105381.47309263404;107645.46177269063;111783;113704.43147784208;115150.42424787823;92525.53737231271;93814;95122.04877951131;96881;97626;10409.47952602382;10442.216833737348;10496;10644.20168487382;10698.41158736277;41531.79234103931;42588.78705606576;44059;44495.777521112184;44655.55344446514;54211.91576168533;55826.44173558213;56846;57519.712401437726;58120.12819807791;13248.271345076113;13310.334483275603;13332.800008000082;13354.666133346356;13392.933035334761;18207.271709132016;18421.631567368844;18428.631427371645;18432.447026589223;18442.631147377244;12984;13029.15310504814;13104.279264640536;13213.537526186537;13291.268980206181;16293.103879286278;16425.178741063137;16604.83395166033;16636.001839889646;16852.15739213059;16243.269052892412;16262.756058659366;16396.344146234016;16565.585860353105;16578.83421165773;10559.208059395729;10587.682369528926;10609;10726.088282495763;10863.402512861552;11180.944095279472;11224.831627525431;11309.547618095185;11322.433878306216;11372.31766094037 18:01:26 INFO - PID 3839 | __end_tp_report 18:01:26 INFO - PID 3839 | __start_cc_report 18:01:26 INFO - PID 3839 | _x_x_mozilla_cycle_collect,290 18:01:26 INFO - PID 3839 | __end_cc_report 18:01:26 INFO - PID 3839 | __startTimestamp1506387686244__endTimestamp 18:01:26 INFO - PID 3839 | 18:01:26 INFO - PID 3839 | ------- Summary: start ------- 18:01:26 INFO - PID 3839 | Number of tests: 6 18:01:26 INFO - PID 3839 | 18:01:26 INFO - PID 3839 | [#0] dojo.html Cycles:165 Average:6078.22 Median:6375.43 stddev:866.04 (13.6%) stddev-sans-first:836.48 18:01:26 INFO - PID 3839 | Values: 3094.7 3114.5 3128.4 3148.6 3157.9 6006.6 6171.8 6175.0 6204.7 6246.5 6093.6 6107.7 6134.7 6171.2 6196.8 5659.0 5676.7 5759.4 5781.1 5790.8 5762.2 5773.6 5829.0 5850.0 5858.0 105.8 5593.3 5610.7 5704.9 5840.5 5654.6 5697.9 5770.8 5776.3 5791.9 5696.9 5697.7 5741.4 5771.9 5780.7 6086.4 6134.0 6187.5 6241.8 6275.1 6603.3 6625.5 6665.5 6692.1 6701.1 6648.7 6697.4 6746.7 6750.1 6750.4 6042.9 6134.8 6161.4 6210.4 6232.4 6891.0 6891.8 6916.1 6936.1 6944.8 6511.1 6517.6 6597.8 6603.9 6605.0 6610.7 6618.0 6619.0 6673.0 6731.3 6451.1 6487.1 6520.8 6629.5 6651.3 6566.5 6605.9 6658.3 6659.0 6720.8 5245.3 5299.8 5300.2 5314.9 5315.8 4537.2 4542.8 4588.6 4599.7 4609.5 5526.2 5617.6 5634.8 5654.7 5655.6 6563.2 6613.3 6649.3 6667.7 6693.3 5613.4 5667.8 5686.4 5728.4 5776.8 5683.1 5714.0 5721.7 5733.2 5801.0 6301.5 6340.9 6341.1 6380.8 6421.8 6531.7 6550.8 6575.4 6609.2 6657.5 6438.3 6497.2 6527.4 6554.4 6565.2 6575.2 6575.8 6576.1 6658.2 6676.1 6553.3 6657.4 6702.6 6795.8 6818.4 6437.3 6440.6 6488.4 6522.6 6526.8 6393.5 6524.7 6537.7 6560.3 6560.8 6332.5 6375.4 6402.7 6416.3 6468.8 6135.0 6398.9 6512.1 6537.7 6587.5 6266.7 6317.9 6393.8 6398.0 6399.5 18:01:26 INFO - PID 3839 | 18:01:26 INFO - PID 3839 | [#1] ext.html Cycles:180 Average:37083.63 Median:34873.56 stddev:53422.12 (153.2%) stddev-sans-first:53502.76 18:01:26 INFO - PID 3839 | Values: 865.0 888.0 889.7 892.6 895.7 38240.4 41645.0 41699.0 42179.0 42249.6 38698.2 38702.4 38941.8 39040.0 39072.8 6989.7 7063.7 7136.6 7136.6 7138.1 6929.7 6953.8 6976.1 7010.5 7019.2 6980.8 6994.1 6995.9 6997.4 7005.6 7416.2 7675.7 7676.1 7683.5 7687.4 7247.1 7323.7 7326.1 7328.9 7329.0 37320.8 37866.2 37932.8 38100.2 38374.0 3526.6 3565.3 3596.1 3598.1 3599.1 31539.5 31684.4 31725.5 31725.7 31838.7 4863.2 4869.8 4885.2 4965.3 5049.3 187734.0 188321.0 188938.0 189044.0 190357.0 42287.4 42794.6 47908.3 48489.8 48714.8 51111.7 51324.7 51414.7 51524.5 51684.0 15477.9 15485.6 15589.0 15630.4 15654.6 12234.4 12303.0 12314.3 12362.8 12595.9 14350.6 14365.2 14420.9 14558.9 14636.3 5781.3 5797.0 5882.5 5900.8 5912.9 1002.0 1018.6 1025.9 1036.9 1038.3 23241.7 23481.8 23576.3 23642.8 23820.8 1113.8 1121.3 1141.9 1142.9 1147.9 12429.2 12509.0 12540.4 12580.6 12606.0 226865.0 230002.0 230501.0 230543.0 230642.0 53234.5 53810.7 53893.7 53910.0 53947.5 1412.2 1482.0 1487.3 1493.1 1497.7 22293.0 22705.0 22714.3 22820.9 22872.9 36585.8 36915.8 36987.3 37048.9 37089.8 195087.0 196816.0 197313.0 198698.0 199099.0 30120.4 30862.2 32558.2 32831.8 33853.0 40616.0 40883.4 41329.0 41486.8 42424.4 30928.0 31204.0 31629.2 31643.7 32006.4 30608.7 30990.0 31424.2 31523.8 31630.7 34840.8 34906.3 35139.3 35201.0 35420.8 30057.1 30138.4 30166.1 30696.4 31001.7 23092.8 23191.0 23276.5 23831.2 24104.3 18:01:26 INFO - PID 3839 | 18:01:26 INFO - PID 3839 | [#2] jquery.html Cycles:180 Average:32740.23 Median:22956.31 stddev:76329.49 (332.5%) stddev-sans-first:76505.44 18:01:26 INFO - PID 3839 | Values: 587.5 588.6 589.2 596.7 604.6 22212.9 22936.5 22976.1 23009.2 23167.3 23799.0 24389.1 24925.6 25190.9 25278.2 6119.6 6247.0 6278.8 6302.0 6341.6 6134.8 6198.3 6223.4 6226.3 6241.4 5981.4 6112.2 6156.9 6168.0 6187.4 6138.4 6198.0 6203.9 6228.4 6246.6 5595.6 5757.9 5814.2 5819.0 5821.3 27588.2 28230.6 28266.0 28311.6 28328.2 1988.3 2017.0 2023.7 2032.5 2033.7 18973.4 19104.3 19493.9 19575.2 19581.7 2414.9 2455.3 2461.0 2465.8 2465.9 122737.0 129377.4 130927.3 131828.3 142249.0 14224.2 14321.0 14663.3 14764.7 14949.5 22438.6 22989.4 22995.3 23022.5 23063.3 9899.3 9901.9 10091.4 10115.3 10201.4 9273.3 9290.3 9354.9 9357.2 9365.6 8675.0 8965.3 9018.8 9059.5 9168.4 2716.2 2742.3 2776.3 2778.9 2845.1 954.6 968.5 970.5 971.2 979.6 18412.0 18459.5 18831.1 18989.2 19541.6 1014.2 1030.6 1035.1 1036.1 1043.7 10530.8 10652.4 10688.3 10820.2 10910.0 448286.0 449122.0 450880.0 452622.0 460048.0 105377.5 106612.5 108447.5 109276.0 109295.5 1139.5 1141.9 1170.4 1176.0 1177.2 16641.6 16951.7 17264.9 17422.4 17591.0 52452.5 52741.7 53101.5 53435.7 53831.0 66908.3 68006.3 68145.0 68234.7 69287.3 13805.3 14306.7 14313.0 14378.8 14385.4 21661.5 21840.8 21963.5 22077.1 22146.3 16501.0 16966.1 17377.7 17726.2 17773.0 14611.2 14683.7 14845.0 15961.3 16050.7 15624.5 16159.9 16303.0 16376.5 17822.7 13844.4 13860.0 14039.2 14073.3 14073.7 17270.4 17720.6 17762.9 17763.3 17992.7 18:01:26 INFO - PID 3839 | 18:01:26 INFO - PID 3839 | [#3] mootools.html Cycles:180 Average:9577.52 Median:2704.93 stddev:6966.44 (257.5%) stddev-sans-first:6958.32 18:01:26 INFO - PID 3839 | Values: 1314.9 1354.1 1362.9 1391.3 1393.9 14955.7 15631.0 15689.6 15768.2 15837.2 15157.9 15398.8 15449.9 15465.4 15650.1 2666.9 2688.0 2735.6 2740.5 2746.7 2661.5 2690.2 2697.5 2708.4 2713.8 2440.6 2694.5 2729.8 2732.9 2741.0 2701.4 2734.8 2760.6 2762.1 2775.3 2622.7 2711.8 2712.0 2746.7 2748.2 15110.9 15308.8 15394.5 15512.9 15529.8 8149.9 8368.3 8402.0 8435.5 8460.9 5456.3 5572.6 5599.0 5657.7 5720.1 1848.8 1863.6 1865.3 1898.9 1904.5 27453.2 27534.4 27693.4 27699.6 27776.9 6763.7 6990.0 7027.7 7128.5 7186.4 17598.2 17672.2 17677.4 17746.6 17789.2 7783.1 7811.3 7860.0 7879.4 7883.8 7081.2 7248.7 7545.2 7574.4 7584.0 5096.7 5224.2 5231.9 5265.8 5268.2 1480.8 1484.8 1498.2 1503.2 1516.6 840.6 864.1 880.6 888.9 892.9 8735.8 8755.3 8789.7 8941.2 9003.6 975.2 975.9 985.3 1013.3 1023.9 4335.7 4491.3 4530.5 5016.6 5367.3 22303.4 22352.9 23047.3 23184.7 23282.3 21229.4 22273.8 22595.8 22640.2 22709.7 11671.4 11901.6 11955.1 12052.7 12206.4 7611.7 7868.8 7946.5 8073.5 8123.6 18231.8 18655.6 19103.5 19461.0 19643.0 18877.6 19467.9 19996.3 20288.4 20473.5 11555.1 11636.7 11714.4 11761.8 11784.0 14214.9 14396.8 14512.2 14532.0 14628.4 11424.4 11966.5 12117.8 12143.6 12355.7 11111.6 11189.7 11734.8 11786.9 11847.5 9579.1 9755.2 9766.4 9797.7 9800.6 7146.3 7299.9 7337.1 7345.3 7485.6 7242.9 7282.3 7317.2 7332.5 7410.4 18:01:26 INFO - PID 3839 | 18:01:26 INFO - PID 3839 | [#4] prototype.html Cycles:180 Average:5471.63 Median:6159.12 stddev:1515.89 (24.6%) stddev-sans-first:1473.56 18:01:26 INFO - PID 3839 | Values: 503.2 533.7 540.7 541.8 542.6 6146.3 6248.3 6259.1 6262.4 6263.5 6061.4 6172.0 6181.0 6189.7 6250.6 4839.7 5080.4 5091.2 5115.6 5152.6 5007.1 5015.2 5040.4 5048.8 5054.6 4941.0 4969.5 5015.8 5022.7 5052.7 4984.5 5010.4 5012.4 5018.9 5021.6 4495.5 4533.4 4535.8 4543.5 4556.6 6026.9 6073.3 6088.4 6105.2 6189.7 5672.6 5684.4 5696.8 5766.7 5776.8 6491.4 6519.3 6547.8 6564.9 6570.2 4865.6 4891.4 4908.3 4919.2 4925.7 6549.3 6606.6 6613.6 6684.6 6718.7 4986.1 4996.0 5002.3 5007.2 5015.2 5039.7 5080.4 5096.6 5100.6 5105.3 5630.8 5668.9 5711.9 5722.3 5733.4 6558.5 6562.2 6566.4 6606.8 6615.0 1727.2 1735.3 1746.2 1749.2 1749.6 1183.4 1208.4 1218.9 1229.7 1244.2 5520.5 5594.5 5597.6 5606.9 5666.8 6581.5 6604.2 6642.5 6648.5 6730.7 5430.6 5557.9 5652.7 5665.7 5670.2 3481.0 3495.9 3498.2 3506.8 3555.0 6268.5 6308.8 6402.9 6468.7 6520.8 6832.0 6866.5 6889.8 6907.3 6912.7 6442.8 6451.6 6459.0 6501.0 6537.5 6544.9 6546.6 6671.4 6691.6 6695.0 6475.0 6533.9 6584.2 6596.7 6625.5 6347.9 6409.4 6424.8 6426.6 6540.2 4981.0 4987.0 5033.8 5035.4 5036.6 6384.9 6452.3 6517.7 6566.5 6646.2 6263.0 6386.8 6402.8 6405.9 6427.0 6359.9 6391.5 6407.9 6429.9 6481.5 6308.5 6311.3 6344.8 6346.7 6348.7 6449.7 6459.6 6510.4 6520.9 6552.9 6292.0 6321.4 6330.0 6334.2 6361.7 18:01:26 INFO - PID 3839 | 18:01:26 INFO - PID 3839 | [#5] yui.html Cycles:180 Average:24058.50 Median:19707.21 stddev:34734.16 (176.3%) stddev-sans-first:34788.07 18:01:26 INFO - PID 3839 | Values: 900.8 912.7 921.7 925.1 934.8 19325.0 19904.6 19982.9 20004.4 20226.4 18057.7 18298.7 18326.5 18345.8 18383.2 956.3 968.2 968.3 969.9 971.2 973.3 979.0 979.5 980.9 981.9 1002.2 1033.8 1036.0 1041.5 1041.6 1024.5 1027.7 1028.3 1030.3 1035.6 742.5 747.1 748.7 750.2 751.1 19566.6 19847.8 20544.7 20617.6 20733.6 21870.3 22104.3 22309.0 22362.6 22622.5 16818.6 17060.1 17134.3 17246.0 17296.4 3647.1 3671.0 3676.4 3703.0 3713.0 108883.5 128616.0 140331.3 142459.0 144241.0 17658.2 17770.3 17788.0 17902.2 17925.0 31243.2 32005.5 32311.8 32337.5 32543.5 8853.3 9046.1 9056.0 9106.5 9158.5 4073.6 4156.2 4170.2 4185.6 4199.7 5543.6 5562.0 5620.3 5634.5 5668.0 912.5 1086.0 1089.3 1098.8 1121.2 591.3 605.6 629.9 635.3 637.0 12169.3 12350.8 12398.3 12408.5 13209.8 692.3 700.7 711.0 719.4 728.0 5507.8 5550.4 5568.7 5619.6 5645.8 117164.4 119884.4 120550.4 122552.4 123190.4 105381.5 107645.5 111783.0 113704.4 115150.4 92525.5 93814.0 95122.0 96881.0 97626.0 10409.5 10442.2 10496.0 10644.2 10698.4 41531.8 42588.8 44059.0 44495.8 44655.6 54211.9 55826.4 56846.0 57519.7 58120.1 13248.3 13310.3 13332.8 13354.7 13392.9 18207.3 18421.6 18428.6 18432.4 18442.6 12984.0 13029.2 13104.3 13213.5 13291.3 16293.1 16425.2 16604.8 16636.0 16852.2 16243.3 16262.8 16396.3 16565.6 16578.8 10559.2 10587.7 10609.0 10726.1 10863.4 11180.9 11224.8 11309.5 11322.4 11372.3 18:01:26 INFO - PID 3839 | -------- Summary: end -------- 18:01:26 INFO - PID 3839 | 18:01:27 INFO - TEST-INFO | 3839: exit 0 18:01:27 INFO - TEST-OK | dromaeo_css | took 1116106ms 18:01:27 INFO - TEST-START | kraken 18:01:27 INFO - Initialising browser for kraken test... 18:01:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33240/getInfo.html -profile /tmp/tmp1dLrFG/profile 18:01:27 INFO - TEST-INFO | started process 4226 (/builds/slave/test/build/application/firefox/firefox http://localhost:33240/getInfo.html) 18:01:33 INFO - TEST-INFO | 4226: exit 0 18:01:33 INFO - Browser initialized. 18:01:33 INFO - Running cycle 1/1 for kraken test... 18:01:33 INFO - Using env: {'DISPLAY': ':0', 18:01:33 INFO - 'HOME': '/home/cltbld', 18:01:33 INFO - 'JSGC_DISABLE_POISONING': '1', 18:01:33 INFO - 'LANG': 'en_US.UTF-8', 18:01:33 INFO - 'LANGUAGE': 'en_US:en', 18:01:33 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:01:33 INFO - 'LOGNAME': 'cltbld', 18:01:33 INFO - 'MAIL': '/var/mail/cltbld', 18:01:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:01:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:01:33 INFO - 'MOZ_ACCELERATED': '1', 18:01:33 INFO - 'MOZ_CRASHREPORTER': '1', 18:01:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:33 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:01:33 INFO - 'MOZ_NO_REMOTE': '1', 18:01:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:01:33 INFO - 'MOZ_WEBRENDER': '1', 18:01:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:33 INFO - 'NO_EM_RESTART': '1', 18:01:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:33 INFO - 'PWD': '/builds/slave/test', 18:01:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:01:33 INFO - 'RUST_BACKTRACE': 'full', 18:01:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:01:33 INFO - 'SHELL': '/bin/bash', 18:01:33 INFO - 'SHLVL': '1', 18:01:33 INFO - 'TERM': 'linux', 18:01:33 INFO - 'TMOUT': '86400', 18:01:33 INFO - 'USER': 'cltbld', 18:01:33 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675', 18:01:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:33 INFO - '_': '/tools/buildbot/bin/python'} 18:01:33 INFO - TEST-INFO | started process 4474 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1dLrFG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:01:34 INFO - PID 4474 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 18:01:34 INFO - PID 4474 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 18:01:34 INFO - PID 4474 | 18:01:34 INFO - PID 4474 | (/builds/slave/test/build/application/firefox/firefox:4533): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:01:34 INFO - PID 4474 | 18:01:45 INFO - PID 4474 | RSS: Main: 205324288 18:01:45 INFO - PID 4474 | 18:01:47 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:33240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33240/tests/kraken/driver.html?testName=audio-beat-detection) 18:01:48 INFO - PID 4474 | RSS: Main: 205357056 18:01:48 INFO - PID 4474 | 18:01:51 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:33240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33240/tests/kraken/driver.html?testName=audio-dft) 18:01:51 INFO - PID 4474 | RSS: Main: 204902400 18:01:51 INFO - PID 4474 | 18:01:55 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:33240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33240/tests/kraken/driver.html?testName=audio-fft) 18:01:55 INFO - PID 4474 | RSS: Main: 200429568 18:01:55 INFO - PID 4474 | 18:01:57 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:33240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33240/tests/kraken/driver.html?testName=audio-oscillator) 18:01:58 INFO - PID 4474 | RSS: Main: 201818112 18:01:58 INFO - PID 4474 | 18:02:00 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:33240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:02:01 INFO - PID 4474 | RSS: Main: 201662464 18:02:01 INFO - PID 4474 | 18:02:04 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:33240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33240/tests/kraken/driver.html?testName=imaging-darkroom) 18:02:05 INFO - PID 4474 | RSS: Main: 204484608 18:02:05 INFO - PID 4474 | 18:02:08 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:33240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33240/tests/kraken/driver.html?testName=imaging-desaturate) 18:02:09 INFO - PID 4474 | RSS: Main: 204435456 18:02:09 INFO - PID 4474 | 18:02:12 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:33240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33240/tests/kraken/driver.html?testName=json-parse-financial) 18:02:13 INFO - PID 4474 | RSS: Main: 204279808 18:02:13 INFO - PID 4474 | 18:02:14 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:33240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:02:15 INFO - PID 4474 | RSS: Main: 205295616 18:02:15 INFO - PID 4474 | 18:02:17 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:33240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33240/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:02:17 INFO - PID 4474 | RSS: Main: 202473472 18:02:17 INFO - PID 4474 | 18:02:19 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:33240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:02:20 INFO - PID 4474 | RSS: Main: 201687040 18:02:20 INFO - PID 4474 | 18:02:23 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:33240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:02:23 INFO - PID 4474 | RSS: Main: 202899456 18:02:23 INFO - PID 4474 | 18:02:26 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:33240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:02:27 INFO - PID 4474 | RSS: Main: 202358784 18:02:27 INFO - PID 4474 | 18:02:29 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:33240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33240/tests/kraken/driver.html?testName=ai-astar) 18:02:29 INFO - PID 4474 | RSS: Main: 202235904 18:02:29 INFO - PID 4474 | 18:02:29 INFO - PID 4474 | __start_tp_report 18:02:29 INFO - PID 4474 | _x_x_mozilla_page_load 18:02:29 INFO - PID 4474 | _x_x_mozilla_page_load_details 18:02:29 INFO - PID 4474 | |i|pagename|runs| 18:02:29 INFO - PID 4474 | |0;ai-astar;114;115;109;107;107;106;108;117;114;107 18:02:29 INFO - PID 4474 | |1;audio-beat-detection;121;123;126;120;124;122;123;141;118;125 18:02:29 INFO - PID 4474 | |2;audio-dft;170;170;162;163;163;172;168;163;166;174 18:02:29 INFO - PID 4474 | |3;audio-fft;77;74;79;78;74;75;73;77;80;76 18:02:29 INFO - PID 4474 | |4;audio-oscillator;81;88;80;84;80;80;88;85;83;80 18:02:29 INFO - PID 4474 | |5;imaging-gaussian-blur;123;121;115;118;122;123;118;130;117;118 18:02:29 INFO - PID 4474 | |6;imaging-darkroom;149;149;148;147;150;147;148;147;153;149 18:02:29 INFO - PID 4474 | |7;imaging-desaturate;94;97;95;94;96;94;97;100;97;94 18:02:29 INFO - PID 4474 | |8;json-parse-financial;53;59;53;54;56;53;53;53;55;53 18:02:29 INFO - PID 4474 | |9;json-stringify-tinderbox;46;48;50;41;39;45;40;48;42;47 18:02:29 INFO - PID 4474 | |10;stanford-crypto-aes;82;74;80;77;84;74;77;80;73;80 18:02:29 INFO - PID 4474 | |11;stanford-crypto-ccm;133;116;111;112;120;112;117;119;122;117 18:02:29 INFO - PID 4474 | |12;stanford-crypto-pbkdf2;169;169;172;170;185;167;171;169;167;174 18:02:29 INFO - PID 4474 | |13;stanford-crypto-sha256-iterative;65;71;66;64;65;63;72;66;64;67 18:02:29 INFO - PID 4474 | __end_tp_report 18:02:29 INFO - PID 4474 | __start_cc_report 18:02:29 INFO - PID 4474 | _x_x_mozilla_cycle_collect,788 18:02:29 INFO - PID 4474 | __end_cc_report 18:02:29 INFO - PID 4474 | __startTimestamp1506387749583__endTimestamp 18:02:29 INFO - PID 4474 | 18:02:29 INFO - PID 4474 | ------- Summary: start ------- 18:02:29 INFO - PID 4474 | Number of tests: 14 18:02:29 INFO - PID 4474 | 18:02:29 INFO - PID 4474 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.50 stddev:4.12 (3.7%) stddev-sans-first:4.15 18:02:29 INFO - PID 4474 | Values: 114.0 115.0 109.0 107.0 107.0 106.0 108.0 117.0 114.0 107.0 18:02:29 INFO - PID 4474 | 18:02:29 INFO - PID 4474 | [#1] audio-beat-detection Cycles:10 Average:124.30 Median:123.50 stddev:6.33 (5.1%) stddev-sans-first:6.60 18:02:29 INFO - PID 4474 | Values: 121.0 123.0 126.0 120.0 124.0 122.0 123.0 141.0 118.0 125.0 18:02:29 INFO - PID 4474 | 18:02:29 INFO - PID 4474 | [#2] audio-dft Cycles:10 Average:167.10 Median:169.00 stddev:4.31 (2.5%) stddev-sans-first:4.44 18:02:29 INFO - PID 4474 | Values: 170.0 170.0 162.0 163.0 163.0 172.0 168.0 163.0 166.0 174.0 18:02:29 INFO - PID 4474 | 18:02:29 INFO - PID 4474 | [#3] audio-fft Cycles:10 Average:76.30 Median:77.00 stddev:2.31 (3.0%) stddev-sans-first:2.44 18:02:29 INFO - PID 4474 | Values: 77.0 74.0 79.0 78.0 74.0 75.0 73.0 77.0 80.0 76.0 18:02:29 INFO - PID 4474 | 18:02:29 INFO - PID 4474 | [#4] audio-oscillator Cycles:10 Average:82.90 Median:83.50 stddev:3.25 (3.9%) stddev-sans-first:3.37 18:02:29 INFO - PID 4474 | Values: 81.0 88.0 80.0 84.0 80.0 80.0 88.0 85.0 83.0 80.0 18:02:29 INFO - PID 4474 | 18:02:29 INFO - PID 4474 | [#5] imaging-gaussian-blur Cycles:10 Average:120.50 Median:121.50 stddev:4.30 (3.5%) stddev-sans-first:4.47 18:02:29 INFO - PID 4474 | Values: 123.0 121.0 115.0 118.0 122.0 123.0 118.0 130.0 117.0 118.0 18:02:29 INFO - PID 4474 | 18:02:29 INFO - PID 4474 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:1.83 (1.2%) stddev-sans-first:1.94 18:02:29 INFO - PID 4474 | Values: 149.0 149.0 148.0 147.0 150.0 147.0 148.0 147.0 153.0 149.0 18:02:29 INFO - PID 4474 | 18:02:29 INFO - PID 4474 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.50 stddev:1.99 (2.1%) stddev-sans-first:2.00 18:02:29 INFO - PID 4474 | Values: 94.0 97.0 95.0 94.0 96.0 94.0 97.0 100.0 97.0 94.0 18:02:29 INFO - PID 4474 | 18:02:29 INFO - PID 4474 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:53.50 stddev:1.99 (3.7%) stddev-sans-first:2.06 18:02:29 INFO - PID 4474 | Values: 53.0 59.0 53.0 54.0 56.0 53.0 53.0 53.0 55.0 53.0 18:02:29 INFO - PID 4474 | 18:02:29 INFO - PID 4474 | [#9] json-stringify-tinderbox Cycles:10 Average:44.60 Median:46.50 stddev:3.84 (8.2%) stddev-sans-first:4.03 18:02:29 INFO - PID 4474 | Values: 46.0 48.0 50.0 41.0 39.0 45.0 40.0 48.0 42.0 47.0 18:02:29 INFO - PID 4474 | 18:02:29 INFO - PID 4474 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:80.00 stddev:3.70 (4.6%) stddev-sans-first:3.64 18:02:29 INFO - PID 4474 | Values: 82.0 74.0 80.0 77.0 84.0 74.0 77.0 80.0 73.0 80.0 18:02:29 INFO - PID 4474 | 18:02:29 INFO - PID 4474 | [#11] stanford-crypto-ccm Cycles:10 Average:117.90 Median:118.00 stddev:6.44 (5.5%) stddev-sans-first:3.87 18:02:29 INFO - PID 4474 | Values: 133.0 116.0 111.0 112.0 120.0 112.0 117.0 119.0 122.0 117.0 18:02:29 INFO - PID 4474 | 18:02:29 INFO - PID 4474 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:170.50 stddev:5.27 (3.1%) stddev-sans-first:5.53 18:02:29 INFO - PID 4474 | Values: 169.0 169.0 172.0 170.0 185.0 167.0 171.0 169.0 167.0 174.0 18:02:29 INFO - PID 4474 | 18:02:29 INFO - PID 4474 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.00 stddev:2.98 (4.5%) stddev-sans-first:3.13 18:02:29 INFO - PID 4474 | Values: 65.0 71.0 66.0 64.0 65.0 63.0 72.0 66.0 64.0 67.0 18:02:29 INFO - PID 4474 | -------- Summary: end -------- 18:02:29 INFO - PID 4474 | 18:02:30 INFO - PID 4474 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:02:30 INFO - TEST-INFO | 4474: exit 0 18:02:30 INFO - TEST-OK | kraken | took 63451ms 18:02:30 INFO - SUITE-END | took 1179s 18:02:30 INFO - Completed test suite (00:19:39) 18:02:30 INFO - javascript benchmark 18:02:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8410.927605744104, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3094.7369473594745, 3114.486109791886, 3128.421242070219, 3148.622165340158, 3157.9368412631743, 6006.639601623906, 6171.845703857406, 6175.0, 6204.689765511729, 6246.531510136747, 6093.573449858512, 6107.664078475682, 6134.723937422816, 6171.166892469515, 6196.752129914809, 5658.971705141479, 5676.716164191795, 5759.366469688352, 5781.075027995522, 5790.7683692652245, 5762.164486149506, 5773.624714393551, 5829.038208695561, 5850.0, 5858.0, 105.83807340747656, 5593.272874526327, 5610.663360198401, 5704.942950570483, 5840.532757379399, 5654.6041777075625, 5697.857553561153, 5770.826875193751, 5776.335721392052, 5791.942080579182, 5696.914546281809, 5697.743601537941, 5741.397153298885, 5771.942280577225, 5780.710964451802, 6086.360932102154, 6134.04922237054, 6187.504999600022, 6241.750329986795, 6275.09011193379, 6603.273639899608, 6625.536212465129, 6665.533412661116, 6692.130023096966, 6701.095352127498, 6648.700808463631, 6697.3637504437, 6746.730130794763, 6750.122484077087, 6750.35871592198, 6042.879142417171, 6134.8159555213415, 6161.44546990773, 6210.4100110489435, 6232.376762323776, 6891.035255064345, 6891.75878844238, 6916.066331045245, 6936.132983377078, 6944.791656250321, 6511.120998665215, 6517.641529715816, 6597.769078082244, 6603.867922641616, 6605.0, 6610.669466526654, 6617.966910165418, 6618.96690516554, 6673.0, 6731.326867313327, 6451.096846441502, 6487.091807147003, 6520.771772988018, 6629.502787290972, 6651.334866513407, 6566.540342176002, 6605.933940660628, 6658.267590565034, 6659.0, 6720.764773232913, 5245.291885595396, 5299.8410047698635, 5300.204969254565, 5314.946850531523, 5315.760790764425, 4537.22867112585, 4542.818287268538, 4588.609968152745, 4599.7470139142, 4609.469910960215, 5526.171074338801, 5617.578681598897, 5634.802781902614, 5654.717264136777, 5655.604107712503, 6563.1796025496815, 6613.272540020594, 6649.268580456146, 6667.733290668319, 6693.263740988487, 5613.382527921925, 5667.801626943037, 5686.3744988051285, 5728.369879313273, 5776.826695199151, 5683.119116536944, 5713.971430142906, 5721.656700597978, 5733.168690539932, 5801.0, 6301.464375528039, 6340.9365906340345, 6341.0805433212845, 6380.776672816429, 6421.8073457796345, 6531.738730450824, 6550.8362290943105, 6575.408213260829, 6609.173853268246, 6657.500687448364, 6438.323975982455, 6497.155369801895, 6527.445167160845, 6554.442872355903, 6565.212174539086, 6575.243846957661, 6575.835604109936, 6576.145101136822, 6658.201015878126, 6676.065350850788, 6553.279139294578, 6657.434118100015, 6702.597844129368, 6795.830104247236, 6818.386345228953, 6437.25971513282, 6440.581362211441, 6488.416042556004, 6522.641254731036, 6526.836829079311, 6393.4885209184085, 6524.67376631176, 6537.673116344259, 6560.3111673273615, 6560.8359791005605, 6332.493400528039, 6375.426211640789, 6402.743890244338, 6416.326285740117, 6468.773592924414, 6134.969325153345, 6398.87202255943, 6512.088307637029, 6537.673116344259, 6587.538872279086, 6266.655333956493, 6317.905231421624, 6393.776217832354, 6398.0, 6399.520035997226], "value": 6016.8278636125215, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [864.9697260595879, 887.9911200887991, 889.6752685269875, 892.6340200517785, 895.7268033249857, 38240.42639360412, 41645.0, 41699.0, 42179.0, 42249.57750422495, 38698.226035479274, 38702.419463708, 38941.805290973505, 39040.0, 39072.80463597685, 6989.685464154112, 7063.682134303943, 7136.607486588236, 7136.644037632833, 7138.07205063341, 6929.72281108755, 6953.791386258395, 6976.058232138673, 7010.509264351497, 7019.227884932653, 6980.755673551426, 6994.0907682001525, 6995.860082798341, 6997.405220556258, 7005.649717514129, 7416.221296763843, 7675.654595543214, 7676.11724651661, 7683.462157648967, 7687.423443241752, 7247.057882475245, 7323.7070517179245, 7326.084239470067, 7328.853422931565, 7328.963355183243, 37320.81339593312, 37866.24267514662, 37932.81033594815, 38100.23799524022, 38374.0, 3526.594441639193, 3565.3047655707146, 3596.1189508570305, 3598.082488965297, 3599.136207310227, 31539.526907096413, 31684.366312673847, 31725.524117138262, 31725.682743172503, 31838.681613184035, 4863.17326054568, 4869.82955596556, 4885.242787367928, 4965.255211718235, 5049.3183420238165, 187734.0, 188321.0, 188938.0, 189044.0, 190357.0, 42287.365689514685, 42794.572054279684, 47908.28137577939, 48489.75755121202, 48714.756426217646, 51111.74444127756, 51324.74337628288, 51414.74292628513, 51524.48475515272, 51684.0, 15477.922610386877, 15485.612859678598, 15589.0, 15630.3747850087, 15654.608634783994, 12234.449449774782, 12303.0, 12314.322712250912, 12362.75274494505, 12595.874041259653, 14350.569482915529, 14365.20991345486, 14420.927895360455, 14558.927205363905, 14636.341364638403, 5781.306243250753, 5796.971015144897, 5882.470577648032, 5900.822975310747, 5912.87655345483, 1001.9699409017741, 1018.6027449294781, 1025.9384436933808, 1036.9014943580348, 1038.314712289885, 23241.651375229387, 23481.765182347957, 23576.29271121869, 23642.7635723644, 23820.7617923822, 1113.7661091170944, 1121.2767764791663, 1141.8743938166795, 1142.8971392574708, 1147.8909503597145, 12429.192102513307, 12509.0, 12540.372981350896, 12580.622581322576, 12606.0, 226865.0, 230002.0, 230501.0, 230543.0, 230642.0, 53234.46765532372, 53810.730946345015, 53893.73053134709, 53910.0, 53947.46052539503, 1412.2303344677175, 1481.9629509262354, 1487.2861026707026, 1493.1115985988536, 1497.663025819182, 22293.0, 22705.0, 22714.31857044225, 22820.885895570416, 22872.885635571714, 36585.81707091554, 36915.81542092272, 36987.26025479529, 37048.88853334404, 37089.814550927076, 195087.0, 196816.0, 197313.0, 198698.0, 199099.0, 30120.397592048474, 30862.228444288176, 32558.186045349055, 32831.83584082064, 33853.0, 40616.0, 40883.38674919938, 41329.0, 41486.79256603698, 42424.36363454613, 30928.0, 31204.0, 31629.20926976844, 31643.683563164075, 32006.35987280288, 30608.693913060586, 30990.0, 31424.214394639403, 31523.842380787948, 31630.683693163694, 34840.82579587086, 34906.30187396289, 35139.29721405609, 35201.0, 35420.82289588536, 30057.098287051424, 30138.3972320548, 30166.09501714952, 30696.386072277983, 31001.68998309988, 23092.769072309064, 23190.956406962065, 23276.478143319164, 23831.165909193096, 24104.276871693877], "value": 16848.414386304274, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.5035594922289, 588.6314319207837, 589.245765420262, 596.7076132694981, 604.6009633641797, 22212.88893555532, 22936.541269174606, 22976.08095676175, 23009.194678186268, 23167.30498085056, 23799.0, 24389.146379876707, 24925.62611560828, 25190.874045629793, 25278.241652750447, 6119.571629985891, 6246.968765156168, 6278.780242691507, 6302.023186406092, 6341.556091073627, 6134.8466288342925, 6198.256209254896, 6223.408776166257, 6226.252849658047, 6241.438270555649, 5981.371955944628, 6112.174856394375, 6156.907646385308, 6168.0439531872635, 6187.4431301182885, 6138.416850399227, 6198.0083186690135, 6203.875922481548, 6228.377162283736, 6246.593971391891, 5595.608307418483, 5757.884842303172, 5814.156947242626, 5818.970905145447, 5821.330546987108, 27588.17235482939, 28230.576541351897, 28266.0, 28311.575326370123, 28328.15015549516, 1988.3239698502578, 2017.0217444539387, 2023.6559784836613, 2032.542677897476, 2033.6542787726123, 18973.43079707611, 19104.331348402877, 19493.902530487398, 19575.21699132033, 19581.706274405897, 2414.9396265093337, 2455.3493324269084, 2461.040194324215, 2465.8027357811334, 2465.938351541208, 122737.0, 129377.35311323477, 130927.34536327257, 131828.34085829605, 142248.99999999895, 14224.171313506928, 14320.992571644867, 14663.34014969329, 14764.657968247906, 14949.53332700114, 22438.551228975655, 22989.425264368525, 22995.310140695805, 23022.539549208923, 23063.308100757004, 9899.307048506535, 9901.851472227921, 10091.394516328897, 10115.342502737445, 10201.38791672502, 9273.258139348836, 9290.349675522784, 9354.859677104849, 9357.204637605744, 9365.62537498506, 8675.0, 8965.327600429993, 9018.819623607491, 9059.463350261805, 9168.44989300644, 2716.2122984334715, 2742.2595899107127, 2776.250412388644, 2778.9023335782254, 2845.1322346684046, 954.5847556313026, 968.5496244246459, 970.4856426094041, 971.155095067296, 979.6424305128577, 18412.0, 18459.538511537317, 18831.05844707759, 18989.240430382906, 19541.609167816565, 1014.2342531388754, 1030.6289735695143, 1035.1304903880775, 1036.0727149201573, 1043.666026871409, 10530.842037369446, 10652.414117223627, 10688.25182237236, 10820.188485863591, 10910.0, 448286.0, 449122.0, 450880.0, 452622.0, 460048.0, 105377.47311263395, 106612.46693766481, 108447.45776271068, 109276.0, 109295.45352273187, 1139.5270962550615, 1141.9486123124314, 1170.3621526268034, 1176.04152615618, 1177.1936223686803, 16641.583960401087, 16951.66096678084, 17264.913675431544, 17422.390216342366, 17591.0, 52452.47547524476, 52741.736291318295, 53101.46898530965, 53435.732821335645, 53831.0, 66908.3309166902, 68006.31993679999, 68145.0, 68234.65882670753, 69287.30712692809, 13805.309734513034, 14306.713865722835, 14313.0, 14378.784318235026, 14385.42458301698, 21661.458463537907, 21840.781592183874, 21963.450913727283, 22077.116915323848, 22146.335609931728, 16501.0, 16966.06686632247, 17377.739333910253, 17726.202320895332, 17773.0, 14611.196384198971, 14683.706325873636, 14845.0, 15961.281742321391, 16050.67898642044, 15624.453144139901, 16159.919200403923, 16303.0, 16376.508704738877, 17822.732659009867, 13844.446222151, 13860.0, 14039.227842468354, 14073.296335183404, 14073.718525629634, 17270.395536156175, 17720.55698607545, 17762.91118544399, 17763.289468421117, 17992.730109048636], "value": 11564.995129233741, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.8816606505416, 1354.1062898487007, 1362.8909687225023, 1391.2556782121567, 1393.9233342166183, 14955.700885982274, 15630.9839860409, 15689.607759806011, 15768.21158942054, 15837.208139593033, 15157.938944273905, 15398.769018464704, 15449.92275038626, 15465.381384744625, 15650.139242341667, 2666.919992400231, 2687.9731202687967, 2735.589661550773, 2740.4793089312966, 2746.6703995520566, 2661.467706458716, 2690.1660485249536, 2697.5144473994674, 2708.444768822387, 2713.782897368216, 2440.5973014452593, 2694.528457519926, 2729.822561533494, 2732.86335683216, 2741.0269354379107, 2701.4191948730922, 2734.849583272919, 2760.5721113227482, 2762.1437354419995, 2775.278427608826, 2622.711501734827, 2711.7966152538443, 2712.0, 2746.6841313249033, 2748.189284161177, 15110.924445377703, 15308.770368444482, 15394.461193858273, 15512.922435387864, 15529.844701553066, 8149.877751833727, 8368.3305335573, 8402.0, 8435.451695639764, 8460.8730869037, 5456.3204913730215, 5572.637778544422, 5598.972005139989, 5657.717114144276, 5720.08478643415, 1848.7596612440432, 1863.5806943437753, 1865.272543707955, 1898.8860668359944, 1904.5048287445363, 27453.17640470769, 27534.44931101367, 27693.446131077468, 27699.584506232422, 27776.861115694493, 6763.661816909135, 6990.0, 7027.718891244395, 7128.465365097639, 7186.353228209382, 17598.208080636403, 17672.204750786244, 17677.38129165473, 17746.645067098587, 17789.19948602316, 7783.143854176036, 7811.296983271533, 7859.960700196577, 7879.369650427952, 7883.842323153504, 7081.221065682771, 7248.746293879689, 7545.245475452411, 7574.356179724675, 7583.9620801895635, 5096.694198348111, 5224.242484839677, 5231.895362092737, 5265.76304066318, 5268.2097685346735, 1480.7556753135827, 1484.7698606715976, 1498.19846382185, 1503.2033022498094, 1516.5601975427223, 840.6259214649544, 864.0754392799644, 880.6125304865839, 888.8755574219614, 892.9107089291149, 8735.781605459915, 8755.255803256794, 8789.69236076747, 8941.195292423583, 9003.594838232295, 975.2198241406846, 975.8728668388023, 985.3398223190479, 1013.2501948558014, 1023.902729240721, 4335.7181783184, 4491.258942274553, 4530.456345238593, 5016.623753218523, 5367.302250707383, 22303.44241393978, 22352.88823555872, 23047.308580742603, 23184.65223021656, 23282.301530954097, 21229.363119106143, 22273.777262227493, 22595.774042259694, 22640.207592734176, 22709.659355109685, 11671.35807530594, 11901.642950711492, 11955.103367247491, 12052.698682532831, 12206.389680515938, 7611.7450904043335, 7868.803279917819, 7946.483478573874, 8073.515589064675, 8123.634436450256, 18231.817681823013, 18655.626887462447, 19103.52241193981, 19461.026948652794, 19643.0, 18877.622447550697, 19467.90266048661, 19996.300129495397, 20288.391348259574, 20473.48816279605, 11555.133364997491, 11636.709082273012, 11714.355710436008, 11761.823572646246, 11784.0, 14214.857851421768, 14396.784048239075, 14512.201828899511, 14532.0, 14628.414863405771, 11424.428778561205, 11966.521339146337, 12117.75764484723, 12143.574974875837, 12355.69110772202, 11111.611093611686, 11189.72025699364, 11734.823977640513, 11786.939175474248, 11847.52609895629, 9579.089986451276, 9755.170810480904, 9766.414015159113, 9797.657082002095, 9800.558974846006, 7146.285371462812, 7299.9270007301375, 7337.119545654556, 7345.3021962913435, 7485.588292643957, 7242.927570724225, 7282.308180722823, 7317.195108538163, 7332.45006624516, 7410.444216683878], "value": 6773.862353603045, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.1833542579534, 533.6744585802658, 540.7350398304831, 541.7887024060615, 542.6391449685959, 6146.293176284723, 6248.281447633518, 6259.123722678829, 6262.373762623735, 6263.530235232359, 6061.363556826536, 6171.950768369376, 6181.0, 6189.659568723719, 6250.593711408756, 4839.741667166527, 5080.364954380702, 5091.159958606825, 5115.641905066628, 5152.587792976553, 5007.14878470659, 5015.2226404907115, 5040.420351659551, 5048.848534543951, 5054.646174767768, 4940.975295123538, 4969.503049695019, 5015.799368025275, 5022.723750193738, 5052.671576347526, 4984.476629953875, 5010.3737032870895, 5012.423571289294, 5018.899622007576, 5021.57316628087, 4495.505494395614, 4533.410656614652, 4535.818567257305, 4543.5002149763495, 4556.612687921531, 6026.879462410771, 6073.301570319426, 6088.360722124157, 6105.206323178003, 6189.659568723719, 5672.574556908207, 5684.4315568443235, 5696.77212911483, 5766.654000759968, 5776.797812076557, 6491.350864913518, 6519.348065193491, 6547.770828020996, 6564.934350656527, 6570.244421891496, 4865.56209941107, 4891.413030436335, 4908.337374454439, 4919.188333924898, 4925.655204135712, 6549.279579246279, 6606.6036037837885, 6613.603183808987, 6684.565503242274, 6718.664066796689, 4986.12742770021, 4995.9500404996215, 5002.299678045077, 5007.223880298559, 5015.1975683890405, 5039.672421292677, 5080.364954380702, 5096.592272618182, 5100.591952643779, 5105.259737338065, 5630.774769009194, 5668.8866222675315, 5711.914321285184, 5722.284714410699, 5733.426657334233, 6558.5409021369, 6562.179727534059, 6566.376194261537, 6606.834829129214, 6614.9669251654395, 1727.2313820350075, 1735.3145507524457, 1746.2491128814731, 1749.2215963895944, 1749.58010077583, 1183.3964678014102, 1208.3535308610028, 1218.8781121887741, 1229.6842378654753, 1244.1788419643174, 5520.503154716095, 5594.524465420403, 5597.608167428241, 5606.887862242732, 5666.838298148869, 6581.506387020992, 6604.174478190226, 6642.535022548472, 6648.501362397743, 6730.663466826639, 5430.583390391238, 5557.888842223133, 5652.710652185871, 5665.66006039639, 5670.206171136044, 3481.007912744906, 3495.919927643048, 3498.1954150545516, 3506.8421921013105, 3555.0, 6268.529860260499, 6308.842278943063, 6402.9359706403275, 6468.708908099147, 6520.804375868732, 6831.965840170867, 6866.485013623998, 6889.793306200822, 6907.309269073053, 6912.654367281616, 6442.809444788794, 6451.580647257913, 6459.0, 6501.0, 6537.46976632613, 6544.858467935323, 6546.574472659262, 6671.366220209073, 6691.59850408977, 6695.0, 6475.0, 6533.901991470037, 6584.242812076673, 6596.71364083999, 6625.4699624029, 6347.90478142819, 6409.391107844747, 6424.839379015562, 6426.646534440651, 6540.215174179129, 4981.028699403581, 4986.975065124651, 5033.798648054183, 5035.446100928968, 5036.622253331088, 6384.850726869208, 6452.257990331172, 6517.73929042833, 6566.507511936528, 6646.202455705346, 6263.0, 6386.840328991812, 6402.791037092195, 6405.903911441239, 6427.003814408774, 6359.87280254383, 6391.48868090561, 6407.935920640734, 6429.903551446639, 6481.5138864584405, 6308.463780578702, 6311.337309582428, 6344.841378965562, 6346.714397852015, 6348.746050157942, 6449.709763060768, 6459.580127291711, 6510.44661203803, 6520.9347906520325, 6552.901706474311, 6291.96854015727, 6321.385388666207, 6330.0, 6334.208223972004, 6361.7137228823885], "value": 5029.453003759185, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [900.7612982559618, 912.6531917871208, 921.7465197070804, 925.070304344134, 934.7616357828755, 19325.0, 19904.601907961867, 19982.900085499554, 20004.399868003984, 20226.39320820374, 18057.729134063, 18298.72551911719, 18326.45020649379, 18345.816541834578, 18383.172757225922, 956.2636769687354, 968.1577027985662, 968.2641192693533, 969.92725545584, 971.1696499492938, 973.3284034016541, 978.9965285582264, 979.5494072726518, 980.9068138526865, 981.8527220916848, 1002.2082554781714, 1033.7829055898271, 1035.9637412690558, 1041.526105621944, 1041.5937784264142, 1024.482636268687, 1027.6711452335219, 1028.2596530498029, 1030.304544432509, 1035.5702383510873, 742.5433358484493, 747.0848210941607, 748.6668432547518, 750.246002767221, 751.1174370115093, 19566.608667826564, 19847.80152198474, 20544.691829622567, 20617.58764824695, 20733.58532829335, 21870.343889683336, 22104.33686989393, 22309.0, 22362.55274894493, 22622.547549048926, 16818.579535511588, 17060.146992650443, 17134.314627415013, 17246.0, 17296.394626188023, 3647.051766540692, 3671.04552816267, 3676.4117741161554, 3702.9814850925573, 3712.9628703713156, 108883.45558272158, 128616.0, 140331.29834350865, 142459.0, 144241.0, 17658.205380757896, 17770.289188432576, 17788.0, 17902.194401251974, 17925.0, 31243.218919527193, 32005.51991720126, 32311.838440808115, 32337.51493727596, 32543.51184732231, 8853.335999800041, 9046.05016473274, 9055.954720226357, 9106.544672766335, 9158.450492970444, 4073.5926407359025, 4156.210320039183, 4170.186813571385, 4185.6232939035635, 4199.70602057853, 5543.584231182677, 5562.02664533705, 5620.269364982608, 5634.492895639412, 5668.0, 912.479886464722, 1085.9619913302997, 1089.2593036735095, 1098.7692584557174, 1121.2095472691733, 591.2963573347703, 605.642670824207, 629.9118123462719, 635.3360738028771, 636.9936300636934, 12169.2698438094, 12350.814737778941, 12398.318092504998, 12408.503659853684, 13209.801852972214, 692.2834865913755, 700.6776882634045, 710.9608971506617, 719.3525826755962, 727.9526830755984, 5507.834764957058, 5550.4449555044175, 5568.7215639217875, 5619.606627536034, 5645.774169033192, 117164.41417792857, 119884.40057799655, 120550.39724801319, 122552.38723806503, 123190.38404808097, 105381.47309263404, 107645.46177269063, 111783.0, 113704.43147784208, 115150.42424787823, 92525.53737231271, 93814.0, 95122.04877951131, 96881.0, 97626.0, 10409.47952602382, 10442.216833737348, 10496.0, 10644.20168487382, 10698.41158736277, 41531.79234103931, 42588.78705606576, 44059.0, 44495.777521112184, 44655.55344446514, 54211.91576168533, 55826.44173558213, 56846.0, 57519.712401437726, 58120.12819807791, 13248.271345076113, 13310.334483275603, 13332.800008000082, 13354.666133346356, 13392.933035334761, 18207.271709132016, 18421.631567368844, 18428.631427371645, 18432.447026589223, 18442.631147377244, 12984.0, 13029.15310504814, 13104.279264640536, 13213.537526186537, 13291.268980206181, 16293.103879286278, 16425.178741063137, 16604.83395166033, 16636.001839889646, 16852.15739213059, 16243.269052892412, 16262.756058659366, 16396.344146234016, 16565.585860353105, 16578.83421165773, 10559.208059395729, 10587.682369528926, 10609.0, 10726.088282495763, 10863.402512861552, 11180.944095279472, 11224.831627525431, 11309.547618095185, 11322.433878306216, 11372.31766094037], "value": 8863.576849890824, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1458.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 109.0, 107.0, 107.0, 106.0, 108.0, 117.0, 114.0, 107.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 123.0, 126.0, 120.0, 124.0, 122.0, 123.0, 141.0, 118.0, 125.0], "value": 124.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 162.0, 163.0, 163.0, 172.0, 168.0, 163.0, 166.0, 174.0], "value": 167.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 79.0, 78.0, 74.0, 75.0, 73.0, 77.0, 80.0, 76.0], "value": 76.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 88.0, 80.0, 84.0, 80.0, 80.0, 88.0, 85.0, 83.0, 80.0], "value": 82.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 121.0, 115.0, 118.0, 122.0, 123.0, 118.0, 130.0, 117.0, 118.0], "value": 120.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 147.0, 150.0, 147.0, 148.0, 147.0, 153.0, 149.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 97.0, 95.0, 94.0, 96.0, 94.0, 97.0, 100.0, 97.0, 94.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 59.0, 53.0, 54.0, 56.0, 53.0, 53.0, 53.0, 55.0, 53.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 48.0, 50.0, 41.0, 39.0, 45.0, 40.0, 48.0, 42.0, 47.0], "value": 44.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 74.0, 80.0, 77.0, 84.0, 74.0, 77.0, 80.0, 73.0, 80.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 116.0, 111.0, 112.0, 120.0, 112.0, 117.0, 119.0, 122.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 172.0, 170.0, 185.0, 167.0, 171.0, 169.0, 167.0, 174.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 66.0, 64.0, 65.0, 63.0, 72.0, 66.0, 64.0, 67.0], "value": 66.3, "unit": "score"}]}]} 18:02:30 INFO - Return code: 0 18:02:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:02:30 INFO - # TBPL SUCCESS # 18:02:30 INFO - Running post-action listener: _package_coverage_data 18:02:30 INFO - Running post-action listener: _resource_record_post_action 18:02:30 INFO - [mozharness: 2017-09-26 01:02:30.843534Z] Finished run-tests step (success) 18:02:30 INFO - Running post-run listener: _resource_record_post_run 18:02:30 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 19451904; Write bytes: 411324416; Read time: 9656; Write time: 351068 18:02:30 INFO - TinderboxPrint: CPU usage
13.3% 18:02:30 INFO - TinderboxPrint: I/O read bytes / time
19,451,904 / 9,656 18:02:30 INFO - TinderboxPrint: I/O write bytes / time
411,324,416 / 351,068 18:02:30 INFO - TinderboxPrint: CPU idle
8,276.3 (86.7%) 18:02:30 INFO - TinderboxPrint: CPU user
1,201.2 (12.6%) 18:02:30 INFO - TinderboxPrint: Swap in / out
0 / 0 18:02:30 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 15642624; Read time: 152; Write time: 3508 18:02:30 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:02:30 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 17297408; Write bytes: 331247616; Read time: 8980; Write time: 270748 18:02:31 INFO - Running post-run listener: _upload_blobber_files 18:02:31 INFO - Blob upload gear active. 18:02:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:02:31 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 18:02:31 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'] 18:02:31 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 18:02:31 INFO - (blobuploader) - INFO - Open directory for files ... 18:02:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:02:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:02:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:33 INFO - (blobuploader) - INFO - Done attempting. 18:02:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:02:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:02:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:34 INFO - (blobuploader) - INFO - Done attempting. 18:02:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:02:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:02:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:41 INFO - (blobuploader) - INFO - Done attempting. 18:02:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:02:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:02:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:42 INFO - (blobuploader) - INFO - Done attempting. 18:02:42 INFO - (blobuploader) - INFO - Iteration through files over. 18:02:42 INFO - Return code: 0 18:02:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:02:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:02:42 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4069f182cfe9e34ef1c04bed3f42f131afc17ff5c83e3e59119f32ef9ebad96fe3597a60787f94fcc6426a28a8036e6279b0d9f94aaf23e5310ce8bab4c54ae", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/223076f30d86bc8ec4ef3b78de36bb8043db8d8ce8d5a9d6dcf3abaf0f8438569f511c8f4a4860de69385ce8feecd856b53e16e304dac6fd349ea331ec497cb1", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f152011d7fbd3ef02fb93cbe92333c8b75098ef8ba1d27a1a920bc459087fa922e327d956435673ae8f14bfda561ad2bfeddb04c62553b42e53d4280ecf0121f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6cca1f88909354312d0555db71a20bf84d653e1b6b184b61f2be5325e8c7b45b275a8f4f15354861d0458b3b45855de0fbf0647a478f6e792fcbdad85b89955"} 18:02:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:02:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:02:42 INFO - Contents: 18:02:42 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4069f182cfe9e34ef1c04bed3f42f131afc17ff5c83e3e59119f32ef9ebad96fe3597a60787f94fcc6426a28a8036e6279b0d9f94aaf23e5310ce8bab4c54ae", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/223076f30d86bc8ec4ef3b78de36bb8043db8d8ce8d5a9d6dcf3abaf0f8438569f511c8f4a4860de69385ce8feecd856b53e16e304dac6fd349ea331ec497cb1", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f152011d7fbd3ef02fb93cbe92333c8b75098ef8ba1d27a1a920bc459087fa922e327d956435673ae8f14bfda561ad2bfeddb04c62553b42e53d4280ecf0121f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6cca1f88909354312d0555db71a20bf84d653e1b6b184b61f2be5325e8c7b45b275a8f4f15354861d0458b3b45855de0fbf0647a478f6e792fcbdad85b89955"} 18:02:42 INFO - Running post-run listener: copy_logs_to_upload_dir 18:02:42 INFO - Copying logs to upload dir... 18:02:42 INFO - mkdir: /builds/slave/test/build/upload/logs 18:02:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.935943 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-09-25 18:02:42.287360) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 18:02:42.291289) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4069f182cfe9e34ef1c04bed3f42f131afc17ff5c83e3e59119f32ef9ebad96fe3597a60787f94fcc6426a28a8036e6279b0d9f94aaf23e5310ce8bab4c54ae", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/223076f30d86bc8ec4ef3b78de36bb8043db8d8ce8d5a9d6dcf3abaf0f8438569f511c8f4a4860de69385ce8feecd856b53e16e304dac6fd349ea331ec497cb1", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f152011d7fbd3ef02fb93cbe92333c8b75098ef8ba1d27a1a920bc459087fa922e327d956435673ae8f14bfda561ad2bfeddb04c62553b42e53d4280ecf0121f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6cca1f88909354312d0555db71a20bf84d653e1b6b184b61f2be5325e8c7b45b275a8f4f15354861d0458b3b45855de0fbf0647a478f6e792fcbdad85b89955"} build_url:https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011261 build_url: 'https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4069f182cfe9e34ef1c04bed3f42f131afc17ff5c83e3e59119f32ef9ebad96fe3597a60787f94fcc6426a28a8036e6279b0d9f94aaf23e5310ce8bab4c54ae", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/223076f30d86bc8ec4ef3b78de36bb8043db8d8ce8d5a9d6dcf3abaf0f8438569f511c8f4a4860de69385ce8feecd856b53e16e304dac6fd349ea331ec497cb1", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f152011d7fbd3ef02fb93cbe92333c8b75098ef8ba1d27a1a920bc459087fa922e327d956435673ae8f14bfda561ad2bfeddb04c62553b42e53d4280ecf0121f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6cca1f88909354312d0555db71a20bf84d653e1b6b184b61f2be5325e8c7b45b275a8f4f15354861d0458b3b45855de0fbf0647a478f6e792fcbdad85b89955"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 18:02:42.320925) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 18:02:42.321303) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1506386506.750899-818820675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 18:02:42.405017) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 18:02:42.405320) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 18:02:42.405648) ========= ========= Total master_lag: 0.20 =========