builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-010 starttime: 1507111765.28 results: success (0) revision: 294f332a35538940469b1a2576615ff5ffe1e016 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-04 03:09:25.282005) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-04 03:09:25.292692) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-04 03:09:25.293060) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-04 03:09:25.365459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 03:09:25.365776) ========= 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=eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-04 03:09:25-- 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% 45.5M=0s 2017-10-04 03:09:25 (45.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.161884 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 03:09:25.576178) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 03:09:25.576603) ========= 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=eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020255 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 03:09:25.634581) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 03:09:25.634965) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 294f332a35538940469b1a2576615ff5ffe1e016 --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 294f332a35538940469b1a2576615ff5ffe1e016 --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=eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-04 03:09:25,680 truncating revision to first 12 chars 2017-10-04 03:09:25,680 Setting DEBUG logging. 2017-10-04 03:09:25,680 attempt 1/10 2017-10-04 03:09:25,680 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/294f332a3553?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-04 03:09:25,932 unpacking tar archive at: mozilla-central-294f332a3553/testing/mozharness/ program finished with exit code 0 elapsedTime=0.574819 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 03:09:26.229711) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-04 03:09:26.230079) ========= script_repo_revision: 294f332a35538940469b1a2576615ff5ffe1e016 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-04 03:09:26.230497) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-04 03:09:26.230769) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-04 03:09:26.253133) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-10-04 03:09:26.253792) ========= /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=eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:09:26 INFO - MultiFileLogger online at 20171004 03:09:26 in /builds/slave/test 03:09:26 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 03:09:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:09:26 INFO - {'append_to_log': False, 03:09:26 INFO - 'base_work_dir': '/builds/slave/test', 03:09:26 INFO - 'blob_upload_branch': 'Firefox', 03:09:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:09:26 INFO - 'branch': 'Firefox', 03:09:26 INFO - 'buildbot_json_path': 'buildprops.json', 03:09:26 INFO - 'code_coverage': False, 03:09:26 INFO - 'config_files': ('talos/linux_config.py',), 03:09:26 INFO - 'default_actions': ('clobber', 03:09:26 INFO - 'read-buildbot-config', 03:09:26 INFO - 'download-and-extract', 03:09:26 INFO - 'populate-webroot', 03:09:26 INFO - 'create-virtualenv', 03:09:26 INFO - 'install', 03:09:26 INFO - 'setup-mitmproxy', 03:09:26 INFO - 'run-tests'), 03:09:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:09:26 INFO - 'disable_ccov_upload': False, 03:09:26 INFO - 'disable_stylo': False, 03:09:26 INFO - 'download_minidump_stackwalk': True, 03:09:26 INFO - 'download_symbols': 'ondemand', 03:09:26 INFO - 'enable_stylo': False, 03:09:26 INFO - 'enable_webrender': False, 03:09:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:09:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:09:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:09:26 INFO - 'gecko_profile': False, 03:09:26 INFO - 'gecko_profile_interval': 0, 03:09:26 INFO - 'installer_path': 'installer.exe', 03:09:26 INFO - 'log_level': 'info', 03:09:26 INFO - 'log_name': 'talos', 03:09:26 INFO - 'log_to_console': True, 03:09:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:09:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:09:26 INFO - 'opt_config_files': (), 03:09:26 INFO - 'pip_index': False, 03:09:26 INFO - 'suite': 'dromaeojs-e10s', 03:09:26 INFO - 'system_bits': '32', 03:09:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:09:26 INFO - 'title': 'talos-linux64-ix-010', 03:09:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:09:26 INFO - 'use_talos_json': True, 03:09:26 INFO - 'verify': 'False', 03:09:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:09:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:09:26 INFO - 'work_dir': 'build'} 03:09:26 INFO - [mozharness: 2017-10-04 10:09:26.541122Z] Running clobber step. 03:09:26 INFO - Running pre-action listener: _resource_record_pre_action 03:09:26 INFO - Running main action method: clobber 03:09:26 INFO - rmtree: /builds/slave/test/build 03:09:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:09:27 INFO - Running post-action listener: _resource_record_post_action 03:09:27 INFO - [mozharness: 2017-10-04 10:09:27.493857Z] Finished clobber step (success) 03:09:27 INFO - [mozharness: 2017-10-04 10:09:27.493955Z] Running read-buildbot-config step. 03:09:27 INFO - Running pre-action listener: _resource_record_pre_action 03:09:27 INFO - Running main action method: read_buildbot_config 03:09:27 INFO - Using buildbot properties: 03:09:27 INFO - { 03:09:27 INFO - "project": "", 03:09:27 INFO - "product": "firefox", 03:09:27 INFO - "who": "archaeopteryx@coole-files.de", 03:09:27 INFO - "installer_path": "public/build/target.tar.bz2", 03:09:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 03:09:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:09:27 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 03:09:27 INFO - "stage_platform": "linux64-qr", 03:09:27 INFO - "basedir": "/builds/slave/test", 03:09:27 INFO - "buildnumber": 119, 03:09:27 INFO - "platform": "ubuntu64_hw_qr", 03:09:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:09:27 INFO - "slavebuilddir": "test", 03:09:27 INFO - "taskId": "WYSqs-mPRAS5T_k5haAnRg", 03:09:27 INFO - "branch": "mozilla-central", 03:09:27 INFO - "script_repo_revision": "production", 03:09:27 INFO - "revision": "294f332a35538940469b1a2576615ff5ffe1e016", 03:09:27 INFO - "slavename": "talos-linux64-ix-010", 03:09:27 INFO - "repo_path": "mozilla-central" 03:09:27 INFO - } 03:09:27 INFO - Finding installer, test and symbols from parent task. 03:09:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WYSqs-mPRAS5T_k5haAnRg'}, attempt #1 03:09:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WYSqs-mPRAS5T_k5haAnRg'}, attempt #1 03:09:28 INFO - Task dependencies: H90Ggu_YRcaJpU0yVW5aGA 03:09:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H90Ggu_YRcaJpU0yVW5aGA'}, attempt #1 03:09:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/H90Ggu_YRcaJpU0yVW5aGA/artifacts/public/build/target.tar.bz2 03:09:28 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/H90Ggu_YRcaJpU0yVW5aGA/artifacts/public/build/target.test_packages.json 03:09:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/H90Ggu_YRcaJpU0yVW5aGA/artifacts/public/build/target.crashreporter-symbols.zip 03:09:28 INFO - Running post-action listener: _resource_record_post_action 03:09:28 INFO - [mozharness: 2017-10-04 10:09:28.820626Z] Finished read-buildbot-config step (success) 03:09:28 INFO - [mozharness: 2017-10-04 10:09:28.820845Z] Running download-and-extract step. 03:09:28 INFO - Running pre-action listener: _resource_record_pre_action 03:09:28 INFO - Running main action method: download_and_extract 03:09:28 INFO - mkdir: /builds/slave/test/build/tests 03:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:28 INFO - trying https://queue.taskcluster.net/v1/task/H90Ggu_YRcaJpU0yVW5aGA/artifacts/public/build/target.test_packages.json 03:09:28 INFO - Downloading https://queue.taskcluster.net/v1/task/H90Ggu_YRcaJpU0yVW5aGA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:09:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H90Ggu_YRcaJpU0yVW5aGA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:09:29 INFO - Downloaded 989 bytes. 03:09:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:09:29 INFO - Using the following test package requirements: 03:09:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:09:29 INFO - u'common': [u'target.common.tests.zip'], 03:09:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:09:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:09:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:09:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:09:29 INFO - u'mozbase': [u'target.common.tests.zip'], 03:09:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:09:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:09:29 INFO - u'web-platform': [u'target.common.tests.zip', 03:09:29 INFO - u'target.web-platform.tests.tar.gz'], 03:09:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:09:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:09:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H90Ggu_YRcaJpU0yVW5aGA/artifacts/public/build/target.common.tests.zip 03:09:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H90Ggu_YRcaJpU0yVW5aGA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:09:29 INFO - Fetch https://queue.taskcluster.net/v1/task/H90Ggu_YRcaJpU0yVW5aGA/artifacts/public/build/target.common.tests.zip into memory 03:09:30 INFO - Content-Length response header: 55310557 03:09:30 INFO - Bytes received: 55310557 03:09:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H90Ggu_YRcaJpU0yVW5aGA/artifacts/public/build/target.talos.tests.zip 03:09:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H90Ggu_YRcaJpU0yVW5aGA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:09:42 INFO - Fetch https://queue.taskcluster.net/v1/task/H90Ggu_YRcaJpU0yVW5aGA/artifacts/public/build/target.talos.tests.zip into memory 03:09:43 INFO - Content-Length response header: 14533844 03:09:43 INFO - Bytes received: 14533844 03:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:43 INFO - trying https://queue.taskcluster.net/v1/task/H90Ggu_YRcaJpU0yVW5aGA/artifacts/public/build/target.tar.bz2 03:09:43 INFO - Downloading https://queue.taskcluster.net/v1/task/H90Ggu_YRcaJpU0yVW5aGA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:09:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H90Ggu_YRcaJpU0yVW5aGA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:09:44 INFO - Downloaded 63280646 bytes. 03:09:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H90Ggu_YRcaJpU0yVW5aGA/artifacts/public/build/target.tar.bz2 03:09:44 INFO - mkdir: /builds/slave/test/properties 03:09:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:09:44 INFO - Writing to file /builds/slave/test/properties/build_url 03:09:44 INFO - Contents: 03:09:44 INFO - build_url:https://queue.taskcluster.net/v1/task/H90Ggu_YRcaJpU0yVW5aGA/artifacts/public/build/target.tar.bz2 03:09:44 INFO - Running post-action listener: _resource_record_post_action 03:09:44 INFO - Running post-action listener: find_tests_for_verification 03:09:44 INFO - Running post-action listener: set_extra_try_arguments 03:09:44 INFO - [mozharness: 2017-10-04 10:09:44.436493Z] Finished download-and-extract step (success) 03:09:44 INFO - [mozharness: 2017-10-04 10:09:44.436591Z] Running populate-webroot step. 03:09:44 INFO - Running pre-action listener: _resource_record_pre_action 03:09:44 INFO - Running main action method: populate_webroot 03:09:44 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:09:44 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:09:44 INFO - 'tests': ['tresize', 03:09:44 INFO - 'tcanvasmark']}, 03:09:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:09:44 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:09:44 INFO - 'tests': ['dromaeo_css', 03:09:44 INFO - 'kraken']}, 03:09:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:09:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:09:44 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:09:44 INFO - 'talos_options': ['--disable-stylo'], 03:09:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:09:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:09:44 INFO - 'tests': ['damp', 'tps']}, 03:09:44 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:09:44 INFO - 'talos_options': ['--disable-stylo'], 03:09:44 INFO - 'tests': ['damp', 'tps']}, 03:09:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:09:44 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:09:44 INFO - 'tests': ['dromaeo_dom']}, 03:09:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:09:44 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:09:44 INFO - 'tests': ['basic_compositor_video', 03:09:44 INFO - 'glvideo']}, 03:09:44 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:09:44 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:09:44 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:09:44 INFO - 'talos_options': ['--disable-stylo'], 03:09:44 INFO - 'tests': ['ts_paint_webext', 03:09:44 INFO - 'tp5o_webext']}, 03:09:44 INFO - 'other-e10s': {'tests': ['a11yr', 03:09:44 INFO - 'ts_paint', 03:09:44 INFO - 'tpaint', 03:09:44 INFO - 'sessionrestore', 03:09:44 INFO - 'sessionrestore_many_windows', 03:09:44 INFO - 'sessionrestore_no_auto_restore', 03:09:44 INFO - 'tabpaint', 03:09:44 INFO - 'cpstartup']}, 03:09:44 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:09:44 INFO - 'tests': ['a11yr', 03:09:44 INFO - 'ts_paint', 03:09:44 INFO - 'tpaint', 03:09:44 INFO - 'sessionrestore', 03:09:44 INFO - 'sessionrestore_many_windows', 03:09:44 INFO - 'sessionrestore_no_auto_restore', 03:09:44 INFO - 'tabpaint', 03:09:44 INFO - 'cpstartup']}, 03:09:44 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 03:09:44 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:09:44 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:09:44 INFO - 'tests': ['perf_reftest_singletons']}, 03:09:44 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:09:44 INFO - 'tests': ['perf_reftest']}, 03:09:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:09:44 INFO - 'tsvgr_opacity', 03:09:44 INFO - 'tart', 03:09:44 INFO - 'tscrollx', 03:09:44 INFO - 'tsvg_static']}, 03:09:44 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:09:44 INFO - 'tests': ['tsvgx', 03:09:44 INFO - 'tsvgr_opacity', 03:09:44 INFO - 'tart', 03:09:44 INFO - 'tscrollx', 03:09:44 INFO - 'tsvg_static']}, 03:09:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:09:44 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:09:44 INFO - 'talos_options': ['--disable-stylo'], 03:09:44 INFO - 'tests': ['tp5o']}, 03:09:44 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:09:44 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:09:44 INFO - 'talos_options': ['--mitmproxy', 03:09:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:09:44 INFO - '--firstNonBlankPaint'], 03:09:44 INFO - 'tests': ['tp6_google', 03:09:44 INFO - 'tp6_youtube', 03:09:44 INFO - 'tp6_amazon', 03:09:44 INFO - 'tp6_facebook']}, 03:09:44 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:09:44 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:09:44 INFO - 'talos_options': ['--disable-stylo', 03:09:44 INFO - '--mitmproxy', 03:09:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:09:44 INFO - '--firstNonBlankPaint'], 03:09:44 INFO - 'tests': ['tp6_google', 03:09:44 INFO - 'tp6_youtube', 03:09:44 INFO - 'tp6_amazon', 03:09:44 INFO - 'tp6_facebook']}, 03:09:44 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:09:44 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:09:44 INFO - 'talos_options': ['--stylo-threads=1', 03:09:44 INFO - '--mitmproxy', 03:09:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:09:44 INFO - '--firstNonBlankPaint'], 03:09:44 INFO - 'tests': ['tp6_google', 03:09:44 INFO - 'tp6_youtube', 03:09:44 INFO - 'tp6_amazon', 03:09:44 INFO - 'tp6_facebook']}, 03:09:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:09:44 INFO - 'talos_options': ['--xperf_path', 03:09:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:09:44 INFO - 'tests': ['tp5n']}, 03:09:44 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:09:44 INFO - 'talos_options': ['--disable-stylo', 03:09:44 INFO - '--xperf_path', 03:09:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:09:44 INFO - 'tests': ['tp5n']}}} 03:09:44 INFO - Running post-action listener: _resource_record_post_action 03:09:44 INFO - [mozharness: 2017-10-04 10:09:44.452342Z] Finished populate-webroot step (success) 03:09:44 INFO - [mozharness: 2017-10-04 10:09:44.452431Z] Running create-virtualenv step. 03:09:44 INFO - Running pre-action listener: _resource_record_pre_action 03:09:44 INFO - Running main action method: create_virtualenv 03:09:44 INFO - Creating virtualenv /builds/slave/test/build/venv 03:09:44 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:09:44 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:09:44 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:09:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:09:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:09:45 INFO - Installing distribute.............................................................................................................................................................................................done. 03:09:45 INFO - Installing pip...............done. 03:09:45 INFO - Return code: 0 03:09:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:09:45 INFO - Reading from file tmpfile_stdout 03:09:45 INFO - Output received: 03:09:45 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:09:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2767b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2909d60>, '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 0x290aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290aef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207', '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 03:09:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:09:45 INFO - Using env: {'DISPLAY': ':0', 03:09:45 INFO - 'HOME': '/home/cltbld', 03:09:45 INFO - 'LANG': 'en_US.UTF-8', 03:09:45 INFO - 'LANGUAGE': 'en_US:en', 03:09:45 INFO - 'LOGNAME': 'cltbld', 03:09:45 INFO - 'MAIL': '/var/mail/cltbld', 03:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:45 INFO - 'MOZ_NO_REMOTE': '1', 03:09:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:45 INFO - 'NO_EM_RESTART': '1', 03:09:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:45 INFO - 'PWD': '/builds/slave/test', 03:09:45 INFO - 'SHELL': '/bin/bash', 03:09:45 INFO - 'SHLVL': '1', 03:09:45 INFO - 'TERM': 'linux', 03:09:45 INFO - 'TMOUT': '86400', 03:09:45 INFO - 'USER': 'cltbld', 03:09:45 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207', 03:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:45 INFO - '_': '/tools/buildbot/bin/python'} 03:09:48 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:09:48 INFO - Downloading/unpacking pip>=1.5 03:09:48 INFO - Running setup.py egg_info for package pip 03:09:48 INFO - warning: no files found matching 'pip/cacert.pem' 03:09:48 INFO - warning: no files found matching '*.html' under directory 'docs' 03:09:48 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:09:48 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:09:48 INFO - Installing collected packages: pip 03:09:48 INFO - Found existing installation: pip 1.1 03:09:48 INFO - Uninstalling pip: 03:09:48 INFO - Successfully uninstalled pip 03:09:48 INFO - Running setup.py install for pip 03:09:48 INFO - warning: no files found matching 'pip/cacert.pem' 03:09:48 INFO - warning: no files found matching '*.html' under directory 'docs' 03:09:48 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:09:48 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:09:48 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:09:48 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:09:48 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:09:48 INFO - Successfully installed pip 03:09:48 INFO - Cleaning up... 03:09:48 INFO - Return code: 0 03:09:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x259f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2767b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2909d60>, '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 0x290aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290aef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207', '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 03:09:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:09:48 INFO - Using env: {'DISPLAY': ':0', 03:09:48 INFO - 'HOME': '/home/cltbld', 03:09:48 INFO - 'LANG': 'en_US.UTF-8', 03:09:48 INFO - 'LANGUAGE': 'en_US:en', 03:09:48 INFO - 'LOGNAME': 'cltbld', 03:09:48 INFO - 'MAIL': '/var/mail/cltbld', 03:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:48 INFO - 'MOZ_NO_REMOTE': '1', 03:09:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:48 INFO - 'NO_EM_RESTART': '1', 03:09:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:48 INFO - 'PWD': '/builds/slave/test', 03:09:48 INFO - 'SHELL': '/bin/bash', 03:09:48 INFO - 'SHLVL': '1', 03:09:48 INFO - 'TERM': 'linux', 03:09:48 INFO - 'TMOUT': '86400', 03:09:48 INFO - 'USER': 'cltbld', 03:09:48 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207', 03:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:48 INFO - '_': '/tools/buildbot/bin/python'} 03:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:49 INFO - Downloading/unpacking psutil>=3.1.1 03:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:09:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:09:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:09:50 INFO - Installing collected packages: psutil 03:09:50 INFO - Running setup.py install for psutil 03:09:50 INFO - building 'psutil._psutil_linux' extension 03:09:50 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 03:09:51 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 03:09:51 INFO - building 'psutil._psutil_posix' extension 03:09:51 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 03:09:51 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 03:09:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:09:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:09:51 INFO - Successfully installed psutil 03:09:51 INFO - Cleaning up... 03:09:51 INFO - Return code: 0 03:09:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:09: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')]} 03:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09: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')]} 03:09:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2767b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2909d60>, '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 0x290aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290aef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207', '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 03:09:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:09:51 INFO - Using env: {'DISPLAY': ':0', 03:09:51 INFO - 'HOME': '/home/cltbld', 03:09:51 INFO - 'LANG': 'en_US.UTF-8', 03:09:51 INFO - 'LANGUAGE': 'en_US:en', 03:09:51 INFO - 'LOGNAME': 'cltbld', 03:09:51 INFO - 'MAIL': '/var/mail/cltbld', 03:09:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:51 INFO - 'MOZ_NO_REMOTE': '1', 03:09:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:51 INFO - 'NO_EM_RESTART': '1', 03:09:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:51 INFO - 'PWD': '/builds/slave/test', 03:09:51 INFO - 'SHELL': '/bin/bash', 03:09:51 INFO - 'SHLVL': '1', 03:09:51 INFO - 'TERM': 'linux', 03:09:51 INFO - 'TMOUT': '86400', 03:09:51 INFO - 'USER': 'cltbld', 03:09:51 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207', 03:09:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:51 INFO - '_': '/tools/buildbot/bin/python'} 03:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:09:53 INFO - Installing collected packages: mozsystemmonitor 03:09:53 INFO - Running setup.py install for mozsystemmonitor 03:09:53 INFO - Successfully installed mozsystemmonitor 03:09:53 INFO - Cleaning up... 03:09:54 INFO - Return code: 0 03:09:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2767b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2909d60>, '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 0x290aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290aef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207', '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 03:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:09:54 INFO - Using env: {'DISPLAY': ':0', 03:09:54 INFO - 'HOME': '/home/cltbld', 03:09:54 INFO - 'LANG': 'en_US.UTF-8', 03:09:54 INFO - 'LANGUAGE': 'en_US:en', 03:09:54 INFO - 'LOGNAME': 'cltbld', 03:09:54 INFO - 'MAIL': '/var/mail/cltbld', 03:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:54 INFO - 'MOZ_NO_REMOTE': '1', 03:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:54 INFO - 'NO_EM_RESTART': '1', 03:09:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:54 INFO - 'PWD': '/builds/slave/test', 03:09:54 INFO - 'SHELL': '/bin/bash', 03:09:54 INFO - 'SHLVL': '1', 03:09:54 INFO - 'TERM': 'linux', 03:09:54 INFO - 'TMOUT': '86400', 03:09:54 INFO - 'USER': 'cltbld', 03:09:54 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207', 03:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:54 INFO - '_': '/tools/buildbot/bin/python'} 03:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:54 INFO - Downloading/unpacking jsonschema==2.5.1 03:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:09:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:09:55 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 03:09:55 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 03:09:55 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 03:09:55 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 03:09:55 INFO - Downloading functools32-3.2.3-2.tar.gz 03:09:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:09:55 INFO - warning: no files found matching '*.txt' 03:09:55 INFO - no previously-included directories found matching 'build' 03:09:55 INFO - no previously-included directories found matching 'dist' 03:09:55 INFO - no previously-included directories found matching '.git*' 03:09:55 INFO - Installing collected packages: jsonschema, functools32 03:09:56 INFO - Running setup.py install for functools32 03:09:56 INFO - warning: no files found matching '*.txt' 03:09:56 INFO - no previously-included directories found matching 'build' 03:09:56 INFO - no previously-included directories found matching 'dist' 03:09:56 INFO - no previously-included directories found matching '.git*' 03:09:56 INFO - Successfully installed jsonschema functools32 03:09:56 INFO - Cleaning up... 03:09:56 INFO - Return code: 0 03:09:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:09:56 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')]} 03:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:56 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')]} 03:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:56 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 0x259f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2767b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2909d60>, '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 0x290aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290aef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207', '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 03:09:56 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 03:09:56 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 03:09:56 INFO - Using env: {'DISPLAY': ':0', 03:09:56 INFO - 'HOME': '/home/cltbld', 03:09:56 INFO - 'LANG': 'en_US.UTF-8', 03:09:56 INFO - 'LANGUAGE': 'en_US:en', 03:09:56 INFO - 'LOGNAME': 'cltbld', 03:09:56 INFO - 'MAIL': '/var/mail/cltbld', 03:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:56 INFO - 'MOZ_NO_REMOTE': '1', 03:09:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:56 INFO - 'NO_EM_RESTART': '1', 03:09:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:56 INFO - 'PWD': '/builds/slave/test', 03:09:56 INFO - 'SHELL': '/bin/bash', 03:09:56 INFO - 'SHLVL': '1', 03:09:56 INFO - 'TERM': 'linux', 03:09:56 INFO - 'TMOUT': '86400', 03:09:56 INFO - 'USER': 'cltbld', 03:09:56 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207', 03:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:56 INFO - '_': '/tools/buildbot/bin/python'} 03:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:09:56 INFO - Cleaning up... 03:09:56 INFO - Return code: 0 03:09:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:09:56 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')]} 03:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:56 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')]} 03:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:56 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 0x259f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2767b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2909d60>, '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 0x290aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290aef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207', '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 03:09:56 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 03:09:56 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 03:09:56 INFO - Using env: {'DISPLAY': ':0', 03:09:56 INFO - 'HOME': '/home/cltbld', 03:09:56 INFO - 'LANG': 'en_US.UTF-8', 03:09:56 INFO - 'LANGUAGE': 'en_US:en', 03:09:56 INFO - 'LOGNAME': 'cltbld', 03:09:56 INFO - 'MAIL': '/var/mail/cltbld', 03:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:56 INFO - 'MOZ_NO_REMOTE': '1', 03:09:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:56 INFO - 'NO_EM_RESTART': '1', 03:09:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:56 INFO - 'PWD': '/builds/slave/test', 03:09:56 INFO - 'SHELL': '/bin/bash', 03:09:56 INFO - 'SHLVL': '1', 03:09:56 INFO - 'TERM': 'linux', 03:09:56 INFO - 'TMOUT': '86400', 03:09:56 INFO - 'USER': 'cltbld', 03:09:56 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207', 03:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:56 INFO - '_': '/tools/buildbot/bin/python'} 03:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:56 INFO - Downloading/unpacking blobuploader==1.2.4 03:09:56 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 03:09:56 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 03:09:56 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 03:09:56 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 03:09:57 INFO - Downloading blobuploader-1.2.4.tar.gz 03:09:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:09:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:09:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:58 INFO - Downloading docopt-0.6.1.tar.gz 03:09:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:09:58 INFO - Installing collected packages: blobuploader, requests, docopt 03:09:58 INFO - Running setup.py install for blobuploader 03:09:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:09:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:09:58 INFO - Running setup.py install for requests 03:09:58 INFO - Running setup.py install for docopt 03:09:58 INFO - Successfully installed blobuploader requests docopt 03:09:58 INFO - Cleaning up... 03:09:58 INFO - Return code: 0 03:09:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:09:58 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')]} 03:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:58 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')]} 03:09:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:58 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 0x259f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2767b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2909d60>, '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 0x290aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290aef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207', '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 03:09:58 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 03:09:58 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 03:09:58 INFO - Using env: {'DISPLAY': ':0', 03:09:58 INFO - 'HOME': '/home/cltbld', 03:09:58 INFO - 'LANG': 'en_US.UTF-8', 03:09:58 INFO - 'LANGUAGE': 'en_US:en', 03:09:58 INFO - 'LOGNAME': 'cltbld', 03:09:58 INFO - 'MAIL': '/var/mail/cltbld', 03:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:58 INFO - 'MOZ_NO_REMOTE': '1', 03:09:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:58 INFO - 'NO_EM_RESTART': '1', 03:09:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:58 INFO - 'PWD': '/builds/slave/test', 03:09:58 INFO - 'SHELL': '/bin/bash', 03:09:58 INFO - 'SHLVL': '1', 03:09:58 INFO - 'TERM': 'linux', 03:09:58 INFO - 'TMOUT': '86400', 03:09:58 INFO - 'USER': 'cltbld', 03:09:58 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207', 03:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:58 INFO - '_': '/tools/buildbot/bin/python'} 03:09:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:09:59 INFO - Running setup.py (path:/tmp/pip-ltvosh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:09:59 INFO - Running setup.py (path:/tmp/pip-pWupaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:09:59 INFO - Running setup.py (path:/tmp/pip-dVxXmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:09:59 INFO - Running setup.py (path:/tmp/pip-EwMLGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:09:59 INFO - Running setup.py (path:/tmp/pip-HX4O4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:09:59 INFO - Running setup.py (path:/tmp/pip-baGtCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:09:59 INFO - Running setup.py (path:/tmp/pip-GxOIRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:09:59 INFO - Running setup.py (path:/tmp/pip-Zwpv27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:09:59 INFO - Running setup.py (path:/tmp/pip-Rr7eC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:09:59 INFO - Running setup.py (path:/tmp/pip-BbU3K1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:09:59 INFO - Running setup.py (path:/tmp/pip-lhJEO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:09:59 INFO - Running setup.py (path:/tmp/pip-pU2lPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:09:59 INFO - Running setup.py (path:/tmp/pip-ui3dYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:09:59 INFO - Running setup.py (path:/tmp/pip-PTDuI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:00 INFO - Running setup.py (path:/tmp/pip-DvioWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:10:00 INFO - Running setup.py (path:/tmp/pip-ITUrDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:10:00 INFO - Running setup.py (path:/tmp/pip-TcEQiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:10:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:10:00 INFO - Running setup.py install for manifestparser 03:10:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:10:00 INFO - Running setup.py install for mozcrash 03:10:00 INFO - Running setup.py install for mozdebug 03:10:00 INFO - Running setup.py install for mozdevice 03:10:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:10:00 INFO - Running setup.py install for mozfile 03:10:00 INFO - Running setup.py install for mozhttpd 03:10:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:10:00 INFO - Running setup.py install for mozinfo 03:10:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:10:00 INFO - Running setup.py install for mozInstall 03:10:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:10:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:10:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:10:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:10:01 INFO - Running setup.py install for mozleak 03:10:01 INFO - Running setup.py install for mozlog 03:10:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:10:01 INFO - Running setup.py install for moznetwork 03:10:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:10:01 INFO - Running setup.py install for mozprocess 03:10:01 INFO - Running setup.py install for mozprofile 03:10:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:10:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:10:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:10:01 INFO - Running setup.py install for mozrunner 03:10:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:10:01 INFO - Running setup.py install for mozscreenshot 03:10:01 INFO - Running setup.py install for moztest 03:10:01 INFO - Running setup.py install for mozversion 03:10:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:10:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:10:01 INFO - Cleaning up... 03:10:02 INFO - Return code: 0 03:10:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:02 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 0x259f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2767b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2909d60>, '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 0x290aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290aef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207', '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 03:10:02 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 03:10:02 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 03:10:02 INFO - Using env: {'DISPLAY': ':0', 03:10:02 INFO - 'HOME': '/home/cltbld', 03:10:02 INFO - 'LANG': 'en_US.UTF-8', 03:10:02 INFO - 'LANGUAGE': 'en_US:en', 03:10:02 INFO - 'LOGNAME': 'cltbld', 03:10:02 INFO - 'MAIL': '/var/mail/cltbld', 03:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:02 INFO - 'MOZ_NO_REMOTE': '1', 03:10:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:02 INFO - 'NO_EM_RESTART': '1', 03:10:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:02 INFO - 'PWD': '/builds/slave/test', 03:10:02 INFO - 'SHELL': '/bin/bash', 03:10:02 INFO - 'SHLVL': '1', 03:10:02 INFO - 'TERM': 'linux', 03:10:02 INFO - 'TMOUT': '86400', 03:10:02 INFO - 'USER': 'cltbld', 03:10:02 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207', 03:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:02 INFO - '_': '/tools/buildbot/bin/python'} 03:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:10:02 INFO - Running setup.py (path:/tmp/pip-bKE7Qu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:10:02 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)) 03:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:10:02 INFO - Running setup.py (path:/tmp/pip-ctyB_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:10:02 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)) 03:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:10:02 INFO - Running setup.py (path:/tmp/pip-L05_GR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:10:02 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)) 03:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:10:02 INFO - Running setup.py (path:/tmp/pip-Ek0ogf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:10:02 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)) 03:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:10:02 INFO - Running setup.py (path:/tmp/pip-MK_CcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:10:02 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)) 03:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:10:02 INFO - Running setup.py (path:/tmp/pip-Lpa4sY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:10:02 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)) 03:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:10:02 INFO - Running setup.py (path:/tmp/pip-bVklim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:10:02 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)) 03:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:10:02 INFO - Running setup.py (path:/tmp/pip-ycHdrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:10:02 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)) 03:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:10:02 INFO - Running setup.py (path:/tmp/pip-J8tsQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:10:02 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)) 03:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:10:02 INFO - Running setup.py (path:/tmp/pip-N7Aq0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:10:02 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)) 03:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:10:02 INFO - Running setup.py (path:/tmp/pip-ojNifO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:10:03 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)) 03:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:10:03 INFO - Running setup.py (path:/tmp/pip-7dmLEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:10:03 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)) 03:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:10:03 INFO - Running setup.py (path:/tmp/pip-_RmDy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:10:03 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)) 03:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:10:03 INFO - Running setup.py (path:/tmp/pip-70Cg7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:10:03 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)) 03:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:03 INFO - Running setup.py (path:/tmp/pip-1QjBcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:03 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)) 03:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:10:03 INFO - Running setup.py (path:/tmp/pip-x9JbG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:10:03 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)) 03:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:10:03 INFO - Running setup.py (path:/tmp/pip-wjdYVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:10:03 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)) 03:10:03 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)) 03:10:03 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)) 03:10:03 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)) 03:10:03 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)) 03:10:03 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)) 03:10:03 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)) 03:10:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:10:03 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 03:10:03 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 03:10:03 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 03:10:03 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 03:10:04 INFO - Downloading blessings-1.6.tar.gz 03:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:10:04 INFO - Installing collected packages: blessings 03:10:04 INFO - Running setup.py install for blessings 03:10:04 INFO - Successfully installed blessings 03:10:04 INFO - Cleaning up... 03:10:04 INFO - Return code: 0 03:10:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:10:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:10:05 INFO - Reading from file tmpfile_stdout 03:10:05 INFO - Current package versions: 03:10:05 INFO - argparse == 1.2.1 03:10:05 INFO - blessings == 1.6 03:10:05 INFO - blobuploader == 1.2.4 03:10:05 INFO - docopt == 0.6.1 03:10:05 INFO - functools32 == 3.2.3-2 03:10:05 INFO - jsonschema == 2.5.1 03:10:05 INFO - manifestparser == 1.1 03:10:05 INFO - mozInstall == 1.13 03:10:05 INFO - mozcrash == 1.0 03:10:05 INFO - mozdebug == 0.1 03:10:05 INFO - mozdevice == 0.51 03:10:05 INFO - mozfile == 1.2 03:10:05 INFO - mozhttpd == 0.7 03:10:05 INFO - mozinfo == 0.10 03:10:05 INFO - mozleak == 0.1 03:10:05 INFO - mozlog == 3.5 03:10:05 INFO - moznetwork == 0.27 03:10:05 INFO - mozprocess == 0.25 03:10:05 INFO - mozprofile == 0.28 03:10:05 INFO - mozrunner == 6.13 03:10:05 INFO - mozscreenshot == 0.1 03:10:05 INFO - mozsystemmonitor == 0.3 03:10:05 INFO - moztest == 0.8 03:10:05 INFO - mozversion == 1.4 03:10:05 INFO - psutil == 3.1.1 03:10:05 INFO - requests == 1.2.3 03:10:05 INFO - wsgiref == 0.1.2 03:10:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:10: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')]} 03:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10: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')]} 03:10:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:05 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 0x259f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2767b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2909d60>, '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 0x290aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290aef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207', '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 03:10:05 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 03:10:05 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 03:10:05 INFO - Using env: {'DISPLAY': ':0', 03:10:05 INFO - 'HOME': '/home/cltbld', 03:10:05 INFO - 'LANG': 'en_US.UTF-8', 03:10:05 INFO - 'LANGUAGE': 'en_US:en', 03:10:05 INFO - 'LOGNAME': 'cltbld', 03:10:05 INFO - 'MAIL': '/var/mail/cltbld', 03:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:05 INFO - 'MOZ_NO_REMOTE': '1', 03:10:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:05 INFO - 'NO_EM_RESTART': '1', 03:10:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:05 INFO - 'PWD': '/builds/slave/test', 03:10:05 INFO - 'SHELL': '/bin/bash', 03:10:05 INFO - 'SHLVL': '1', 03:10:05 INFO - 'TERM': 'linux', 03:10:05 INFO - 'TMOUT': '86400', 03:10:05 INFO - 'USER': 'cltbld', 03:10:05 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207', 03:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:05 INFO - '_': '/tools/buildbot/bin/python'} 03:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:05 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)) 03:10:05 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)) 03:10:05 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)) 03:10:05 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)) 03:10:05 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)) 03:10:05 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)) 03:10:05 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)) 03:10:05 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)) 03:10:05 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)) 03:10:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:10:05 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 03:10:05 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 03:10:05 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 03:10:05 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 03:10:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:10:06 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)) 03:10:06 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)) 03:10:06 INFO - Installing collected packages: simplejson 03:10:06 INFO - Running setup.py install for simplejson 03:10:06 INFO - building 'simplejson._speedups' extension 03:10:06 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 03:10:07 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 03:10:07 INFO - Successfully installed simplejson 03:10:07 INFO - Cleaning up... 03:10:07 INFO - Return code: 0 03:10:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:10:07 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')]} 03:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:07 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')]} 03:10:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:07 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 0x259f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2767b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2909d60>, '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 0x290aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290aef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207', '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 03:10:07 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 03:10:07 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 03:10:07 INFO - Using env: {'DISPLAY': ':0', 03:10:07 INFO - 'HOME': '/home/cltbld', 03:10:07 INFO - 'LANG': 'en_US.UTF-8', 03:10:07 INFO - 'LANGUAGE': 'en_US:en', 03:10:07 INFO - 'LOGNAME': 'cltbld', 03:10:07 INFO - 'MAIL': '/var/mail/cltbld', 03:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:07 INFO - 'MOZ_NO_REMOTE': '1', 03:10:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:07 INFO - 'NO_EM_RESTART': '1', 03:10:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:07 INFO - 'PWD': '/builds/slave/test', 03:10:07 INFO - 'SHELL': '/bin/bash', 03:10:07 INFO - 'SHLVL': '1', 03:10:07 INFO - 'TERM': 'linux', 03:10:07 INFO - 'TMOUT': '86400', 03:10:07 INFO - 'USER': 'cltbld', 03:10:07 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207', 03:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:07 INFO - '_': '/tools/buildbot/bin/python'} 03:10:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:10:07 INFO - Cleaning up... 03:10:07 INFO - Return code: 0 03:10:07 INFO - Running post-action listener: _resource_record_post_action 03:10:07 INFO - Running post-action listener: _start_resource_monitoring 03:10:07 INFO - Starting resource monitoring. 03:10:07 INFO - [mozharness: 2017-10-04 10:10:07.769759Z] Finished create-virtualenv step (success) 03:10:07 INFO - [mozharness: 2017-10-04 10:10:07.770699Z] Running install step. 03:10:07 INFO - Running pre-action listener: _resource_record_pre_action 03:10:07 INFO - Running main action method: install 03:10:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:10:07 INFO - Reading from file tmpfile_stdout 03:10:07 INFO - Detecting whether we're running mozinstall >=1.0... 03:10:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:10:08 INFO - Reading from file tmpfile_stdout 03:10:08 INFO - Output received: 03:10:08 INFO - Usage: mozinstall [options] installer 03:10:08 INFO - Options: 03:10:08 INFO - -h, --help show this help message and exit 03:10:08 INFO - -d DEST, --destination=DEST 03:10:08 INFO - Directory to install application into. [default: 03:10:08 INFO - "/builds/slave/test"] 03:10:08 INFO - --app=APP Application being installed. [default: firefox] 03:10:08 INFO - mkdir: /builds/slave/test/build/application 03:10:08 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'] 03:10:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:10:26 INFO - Reading from file tmpfile_stdout 03:10:26 INFO - Output received: 03:10:26 INFO - /builds/slave/test/build/application/firefox/firefox 03:10:26 INFO - Running post-action listener: _resource_record_post_action 03:10:26 INFO - [mozharness: 2017-10-04 10:10:26.199252Z] Finished install step (success) 03:10:26 INFO - [mozharness: 2017-10-04 10:10:26.199400Z] Running setup-mitmproxy step. 03:10:26 INFO - Running pre-action listener: _resource_record_pre_action 03:10:26 INFO - Running main action method: setup_mitmproxy 03:10:26 INFO - Skipping: mitmproxy is not required 03:10:26 INFO - Running post-action listener: _resource_record_post_action 03:10:26 INFO - [mozharness: 2017-10-04 10:10:26.199929Z] Finished setup-mitmproxy step (success) 03:10:26 INFO - [mozharness: 2017-10-04 10:10:26.200041Z] Running run-tests step. 03:10:26 INFO - Running pre-action listener: _resource_record_pre_action 03:10:26 INFO - Running pre-action listener: _set_gcov_prefix 03:10:26 INFO - Running main action method: run_tests 03:10:26 WARNING - Try message not found. 03:10:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:10:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:10:26 INFO - Python 2.7.3 03:10:26 INFO - Return code: 0 03:10:26 INFO - grabbing minidump binary from tooltool 03:10: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')]} 03:10:26 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 0x2909d60>, '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 0x290aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290aef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:10:26 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 03:10:26 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 03:10:26 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 03:10:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:10:26 INFO - Return code: 0 03:10:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:10:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:10:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:10:26 INFO - ENV: RUST_BACKTRACE is now full 03:10:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:10:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:10:26 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/H90Ggu_YRcaJpU0yVW5aGA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 03:10:26 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/H90Ggu_YRcaJpU0yVW5aGA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 03:10:26 INFO - Using env: {'DISPLAY': ':0', 03:10:26 INFO - 'HOME': '/home/cltbld', 03:10:26 INFO - 'LANG': 'en_US.UTF-8', 03:10:26 INFO - 'LANGUAGE': 'en_US:en', 03:10:26 INFO - 'LOGNAME': 'cltbld', 03:10:26 INFO - 'MAIL': '/var/mail/cltbld', 03:10:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:10:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:10:26 INFO - 'MOZ_ACCELERATED': '1', 03:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:26 INFO - 'MOZ_NO_REMOTE': '1', 03:10:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:10:26 INFO - 'MOZ_WEBRENDER': '1', 03:10:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:26 INFO - 'NO_EM_RESTART': '1', 03:10:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:26 INFO - 'PWD': '/builds/slave/test', 03:10:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:10:26 INFO - 'RUST_BACKTRACE': 'full', 03:10:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:10:26 INFO - 'SHELL': '/bin/bash', 03:10:26 INFO - 'SHLVL': '1', 03:10:26 INFO - 'TERM': 'linux', 03:10:26 INFO - 'TMOUT': '86400', 03:10:26 INFO - 'USER': 'cltbld', 03:10:26 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207', 03:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:26 INFO - '_': '/tools/buildbot/bin/python'} 03:10:26 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/H90Ggu_YRcaJpU0yVW5aGA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 03:10:26 INFO - mozversion application_buildid: 20171004091411 03:10:26 INFO - mozversion application_changeset: 294f332a35538940469b1a2576615ff5ffe1e016 03:10:26 INFO - mozversion application_display_name: Nightly 03:10:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:10:26 INFO - mozversion application_name: Firefox 03:10:26 INFO - mozversion application_remotingname: firefox 03:10:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:10:26 INFO - mozversion application_vendor: Mozilla 03:10:26 INFO - mozversion application_version: 58.0a1 03:10:26 INFO - mozversion platform_buildid: 20171004091411 03:10:26 INFO - mozversion platform_changeset: 294f332a35538940469b1a2576615ff5ffe1e016 03:10:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:10:26 INFO - mozversion platform_version: 58.0a1 03:10:26 INFO - using testdate: 1507111826 03:10:26 INFO - actual date: 1507111826 03:10:26 INFO - starting webserver on 'localhost:34413' 03:10:26 INFO - SUITE-START | Running 2 tests 03:10:26 INFO - TEST-START | dromaeo_css 03:10:26 INFO - Initialising browser for dromaeo_css test... 03:10:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34413/getInfo.html -profile /tmp/tmpiKJVe3/profile 03:10:26 INFO - TEST-INFO | started process 3644 (/builds/slave/test/build/application/firefox/firefox http://localhost:34413/getInfo.html) 03:10:36 INFO - TEST-INFO | 3644: exit 0 03:10:36 INFO - Browser initialized. 03:10:36 INFO - Running cycle 1/1 for dromaeo_css test... 03:10:36 INFO - Using env: {'DISPLAY': ':0', 03:10:36 INFO - 'HOME': '/home/cltbld', 03:10:36 INFO - 'JSGC_DISABLE_POISONING': '1', 03:10:36 INFO - 'LANG': 'en_US.UTF-8', 03:10:36 INFO - 'LANGUAGE': 'en_US:en', 03:10:36 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:10:36 INFO - 'LOGNAME': 'cltbld', 03:10:36 INFO - 'MAIL': '/var/mail/cltbld', 03:10:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:10:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:10:36 INFO - 'MOZ_ACCELERATED': '1', 03:10:36 INFO - 'MOZ_CRASHREPORTER': '1', 03:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:36 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:10:36 INFO - 'MOZ_NO_REMOTE': '1', 03:10:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:10:36 INFO - 'MOZ_WEBRENDER': '1', 03:10:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:36 INFO - 'NO_EM_RESTART': '1', 03:10:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:36 INFO - 'PWD': '/builds/slave/test', 03:10:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:10:36 INFO - 'RUST_BACKTRACE': 'full', 03:10:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:10:36 INFO - 'SHELL': '/bin/bash', 03:10:36 INFO - 'SHLVL': '1', 03:10:36 INFO - 'TERM': 'linux', 03:10:36 INFO - 'TMOUT': '86400', 03:10:36 INFO - 'USER': 'cltbld', 03:10:36 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207', 03:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:36 INFO - '_': '/tools/buildbot/bin/python'} 03:10:36 INFO - TEST-INFO | started process 3889 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiKJVe3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:10:37 INFO - PID 3889 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:10:37 INFO - PID 3889 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:10:38 INFO - PID 3889 | 03:10:38 INFO - PID 3889 | (/builds/slave/test/build/application/firefox/firefox:3949): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:10:38 INFO - PID 3889 | 03:10:48 INFO - PID 3889 | RSS: Main: 210051072 03:10:48 INFO - PID 3889 | 03:13:45 INFO - PID 3889 | Cycle 1(1): loaded http://localhost:34413/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34413/tests/dromaeo/cssquery-ext.html) 03:13:46 INFO - PID 3889 | RSS: Main: 204513280 03:13:46 INFO - PID 3889 | 03:16:49 INFO - PID 3889 | Cycle 1(1): loaded http://localhost:34413/tests/dromaeo/cssquery-ext.html (next: http://localhost:34413/tests/dromaeo/cssquery-jquery.html) 03:16:49 INFO - PID 3889 | RSS: Main: 205168640 03:16:49 INFO - PID 3889 | 03:19:51 INFO - PID 3889 | Cycle 1(1): loaded http://localhost:34413/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34413/tests/dromaeo/cssquery-mootools.html) 03:19:52 INFO - PID 3889 | RSS: Main: 205189120 03:19:52 INFO - PID 3889 | 03:22:54 INFO - PID 3889 | Cycle 1(1): loaded http://localhost:34413/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34413/tests/dromaeo/cssquery-prototype.html) 03:22:55 INFO - PID 3889 | RSS: Main: 206098432 03:22:55 INFO - PID 3889 | 03:25:58 INFO - PID 3889 | Cycle 1(1): loaded http://localhost:34413/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34413/tests/dromaeo/cssquery-yui.html) 03:25:59 INFO - PID 3889 | RSS: Main: 209068032 03:25:59 INFO - PID 3889 | 03:29:01 INFO - PID 3889 | Cycle 1(1): loaded http://localhost:34413/tests/dromaeo/cssquery-yui.html (next: http://localhost:34413/tests/dromaeo/cssquery-dojo.html) 03:29:01 INFO - PID 3889 | RSS: Main: 209121280 03:29:01 INFO - PID 3889 | 03:29:01 INFO - PID 3889 | __start_tp_report 03:29:01 INFO - PID 3889 | _x_x_mozilla_page_load 03:29:01 INFO - PID 3889 | _x_x_mozilla_page_load_details 03:29:01 INFO - PID 3889 | |i|pagename|runs| 03:29:01 INFO - PID 3889 | |0;dojo.html;3075.4464196444637;3108.0365086823085;3114.5639610454527;3133.9529907051397;3154.747620190385;6342.778002769904;6397.712102955366;6400.455961243294;6422.839429014277;6446.709898054587;6157.599756015856;6314.400131987454;6319.399657032574;6331.5884467509695;6347.841303967403;5752.050911599581;5792.189093526888;5855.297364316288;5895.4399332063385;5924.259467566554;5812.4768770810615;5816.360200377955;5836.066229403296;5844.860252250813;5943;5626.099824028156;5729.341125770548;5737.39757325479;5807.82576522705;5895.145203945425;5825.970870145665;5831.825045248649;5893.351731309553;5895.557833162487;5904.822855314304;5662.263905692274;5708.885822283531;5817.7091145442555;5877.9412205877825;5885.558583106242;6083.48290395317;6227.439530442282;6227.875442491125;6241.750329986795;6270.3416141305415;6740.157480314961;6821.829454263633;6837.213720422115;6855;6872.140982377203;6761.222459417131;6806.081179040815;6817.863642727168;6872.037914691947;6912.032315475837;6129.111278864584;6229.813105606839;6296.433321001086;6371.617702937839;6383.808485745389;6954.965225173842;7040.401565866856;7044.788656340318;7078.362947334765;7089.22018577956;6610.735570577219;6671.466282697373;6696.430803381767;6712.093867327946;6769.796906092825;6620.86758264832;6726.697298621476;6767.120274364301;6769.966150169316;6848.520603557703;6702.497312701566;6727.629980351127;6742.190937087483;6742.898856517156;6746.763863264762;6580.86838263232;6730.461563074942;6760.695768690421;6781.186257649114;6793.422559082434;5140.640155189176;5283.471652834686;5320.042392369411;5373.9731301343245;5386.865328366822;4604.424446944132;4668.8132474701315;4672.275797251432;4680.180968330528;4729.668923175344;5794.855128621818;5808.419158084158;5820.185174075633;5868.972929737279;5893.911591326134;6816.931830681729;6830.385265326046;6850.451963842881;6910.30896910315;6912.343327383891;5594.664320140804;5677.233573467529;5714.228579141763;5801.82594522165;5825.79609713658;5804.593678442553;5835.066389377679;5851.531877449879;5855.473007429352;5863.5309175265875;6482.57863238888;6586.8353291168105;6689.832754181184;6692.631905245161;6700.396964273239;6757.695903684247;6843.418309443753;6867.278935711778;6873;6928.341807528277;6341.0805433212845;6416.390442907917;6433.9678301610065;6559.639219842955;6604.702788374439;6701.463882889455;6715.127033485615;6748.325167483409;6771.695273712597;6791.524593278423;6706.228783689938;6792.150981127359;6853.691583878638;6872.072270243453;6876.553024053421;6454.386833250834;6567.540272181092;6569.507286953593;6651.06885036105;6657.866842663217;6404.199475065617;6554.082428459924;6580.374864387875;6602;6653.367930046637;6370.840728981812;6431.935680643321;6433.903491447726;6466.159399278064;6490.415862572202;6571.244306904767;6633.1045308882685;6665.433438157811;6683.699233534599;6715.227748808754;6289.40250676185;6361.363863613787;6365.745370185141;6402.871942561216;6473.805785826433 03:29:01 INFO - PID 3889 | |1;ext.html;867.1631875240392;885.0220506340494;891.7725979875131;896.0457113174465;896.6099746610223;37861.62138378615;41538;41858.58141418589;41975.370369444405;41989.58010419895;38487;38530;38632.22735545287;38706.61293387065;38739.41890871639;7192.31672991065;7205.567665940061;7267.854642907138;7268.3458488736005;7669.38644908406;7848.332891704212;7901.367890568769;7933.127355990865;7948.364130869517;7958.4031197660115;7868.921310786876;7927.4847134936335;7934.285914267714;7956.323712484445;7961.641726122339;7928.524288542706;7941.880871786928;7951.840963180733;7978.760637180894;7980.960095199545;7841.607919604054;7879.251471110236;7893;7896.881546776803;7901.565413902233;36687.816560917025;37296;37416.625833741586;37545.43681844774;37628.49486020556;3567.8929632111076;3593.245418462126;3593.4609808528667;3622.5471816022996;3627.5828279747902;31253.687463125305;31263;31461.685383146334;31573.526397104062;31761.20596985094;5220.1647736362;5238.083335416287;5264.710440925747;5284.260203571503;5292.391374991887;180192;181460;182059;182256;183035.16964830316;41719.582804172176;48380.75809621;48408.515914841104;48602.75698621555;48650.756746216044;43527.34708979368;43779.12441751147;50914.49085509172;51468;51758.74120629373;15024;15120.621984450478;15152.621184470476;15174.165420901736;15194.088354698753;12022.519099235933;12103.273803571637;12177;12183.512659493697;12187.573434929735;14287.499937502345;14319.78520322196;14324.713505729827;14441.205733684748;14445.205513696848;5730.77076916927;5769.798057068067;5812.186293918855;5825.7378417971295;5969.641821490724;984.867042949207;1005.7385079879137;1007.2294694558668;1018.4602160854758;1027.6300531808542;23179.652305215433;23186.42033949131;23287.301380958597;23354.7664523356;23666.64500032501;1106.9335839849634;1123.253036730565;1126.3579759536985;1127.3010733345213;1131.3438205840594;12166.81749773754;12241.143119981516;12298.262104273772;12314.692132696575;12331.876681233252;226981;227518;227657;228008;228194;51113.48886511162;51747.223791643155;51767.741161293954;52324.73837630863;52411.73794131005;1401.6425811418023;1430.6280367104628;1446.2479510654612;1456.4683890380147;1458.2052781234254;22662.530038018962;22748.545029099656;22827.543449131255;23237.41906452352;23441.179558715365;36842.81578592197;36963.26073478461;37333;37398;37433.7539747616;192487;193843;193924;194409;194871;29956.25109372196;32582.674173257965;32973.34053318968;34419.311613768084;34686.65313346834;43292;43297.35053974256;43533.12933741371;43765.78117109394;44151;32150;32171.83914080508;32331.19172020718;32344;32486.350272993936;31304.686953130178;31423.528647069856;31515.84242078775;31551.84224078865;31689.524657130623;35984.64015359813;36051.639483605875;36118.638813612575;36370.4544431839;36389.63610363862;30794.846025769726;31224.531632025082;31404;31411.05766826999;31847.522287165248;23134.168620481796;23191;23871.761282387648;23891.163809266593;24183.637245441685 03:29:01 INFO - PID 3889 | |2;jquery.html;563.2508763344752;570.2387312937228;571.1233256950582;588.367504932198;594.9405059494051;22429.55140897183;23189.884050579767;23292.767072329272;23440.765592344073;23489;23357.883210583925;24791.38021549462;25158.24525264245;25303.746962530367;25707;6540.378664026922;6738.730450781963;6748.089007983908;6821.079154314179;6827.5903445793165;6700.3969642732145;6846.4865135114815;6847.383735463832;6852.349026842442;6856.691448884812;6349.269833969083;6640.833979150511;6811.352921472452;6834.589924604515;6835.863282734343;6637.900431493507;6658.600483970978;6702.698378572976;6706.765263215764;6721.193456785217;6205.906911396332;6211.130441738161;6229.6573688447115;6236.345183755686;6257.812265632038;26681.866590666923;28245.15264542067;28557.85721071402;28607.427851443063;28658;2043.2133628552965;2055.8149766520937;2064.8038436348525;2068.338131797825;2070.3064473401428;19084.80915190844;19349.51626209342;19565.80434195654;19619.705704414446;19668.606627867506;2383.512544802864;2410.1684918703018;2427.4416884116577;2463.7659422354845;2465.506898620265;124115.3794231023;129237;139137;146368.2681586596;146937;14464.746303333415;14729.410823566937;14836.035657682216;14859.702805944036;14948.786011007685;23175.652365214537;23258.185963491196;23266.185683501335;23351.53296934052;23406.531869362516;9603.567839447242;9723.805523889625;9776.36453630526;9808;9839.212862970946;8867.290616750644;8873.668949657604;8883.466991980373;8928.776780580538;9006.549672516348;9009.23421509179;9146.588403521857;9163.541822908828;9229.215516681023;9312.580933857993;2627.316897606636;2646.3256555987405;2673.425213579051;2709.5935609658313;2718.9048383306886;945.4472923107637;965.1265604627823;967.1585720423136;977.7066879935991;980.7597138701063;17978.820211797974;18130.184141713653;18137.909310453364;18149.54626134331;18539;1004.7739258666887;1020.9795804084025;1027.6557353286732;1033.9689809305733;1037.3516552154904;10152.492375381202;10163.441010744333;10245.897541024495;10351.482425878676;10358.39444886044;505303;507667;517174;524775;524822;117916.41041794908;119056.40471797585;121141.39429302797;121162;122926.38536807259;1018.6078359831519;1126.915481338903;1163.1567113842395;1199.8560172779496;1199.9280043197436;20248.797512024692;20345.084471199127;20416.795832042084;20686.896565517076;20721.171153153704;55812;56618.716906415204;58184.127238090616;58356.4164358368;58704;69823.6508817473;70339.94490082756;70777;70815.29184708087;72643;14511.782323264948;14676.3395647194;14886.181260030802;14899;14919.776203356741;22318.665220021387;22463.43841403978;22898.427539310986;22941.770582293964;23193.420164496023;18243.635127297646;18311.72532411988;18344.449666510027;18436.539086522946;18636.627267454845;15942.521724348288;16222.67554648924;16663.08353040546;16756.413525526546;17050.721195910108;18726.157322920775;18851.622967540847;18921.053947302855;19046.04769761534;19050.952197629264;13446.663833403853;14520.927395362956;14533.34599942984;14537.636559086108;14581.85418145805;17808.732869006715;17825.821741782416;17916;17954.64090718152;18049.819501805337 03:29:01 INFO - PID 3889 | |3;mootools.html;1297.9610611681649;1343.7312537492503;1351.5674984005122;1360.2382665707205;1373.3407964177202;14998.40006399744;15545.145017024059;15694.76457853133;15699.607509812246;15778.60553486162;15621.609459763511;15660;15687.372505099782;15724.921375393136;15775.368985240606;2682.771964383025;2857.22854829196;2863.226928729242;2863.9284017899513;2865.154779340089;2697.5009623219767;2799.1602519244248;2804.9439011219765;2805.1724741201397;2805.4809860175833;2686.932826679329;2755.0357374918817;2798.202512283989;2801.033643393026;2801.355688191717;2767.6955534891244;2787.052402183247;2798.8320700758018;2809.8735556899887;2814.493391189585;2661.161734053767;2706.120510833987;2706.715794841533;2729.9044533441233;2732.43984983078;14900.850991490055;15249.923750381176;15273;15274.38902443901;15274.847251527453;8245.95877020617;8476.406651534395;8480.787980300542;8558.486490810508;8564.871526927102;5222.399424066205;5255.080360936859;5417.83746487606;5445.673259604437;5503.147012213113;1812.8730988830787;1850.3338798032698;1874.4095609882843;1882.105999650169;1903.8381737552324;27690.030848920193;27877.86061069682;27979.860100699774;27986.86006569954;28307.292317692016;6690.19717633887;6770.356816102462;6980;7094.92905070953;7104.183018952886;17710.11449427549;17729.46811595654;17801.287948481917;17811.376601819135;17929.641407172043;7977.162397948248;8155.714549990722;8157.75526734199;8160.061592916772;8161.836763264821;7036.261192574808;7458.105027396748;7469.850602988018;7495.962520187364;7532.209118042636;5280.234366016906;5403.972980135074;5455.318085239345;5461.672299662033;5688.8862222755315;1449.8840092792552;1497.7903093566908;1570.2227397438112;1581.7864588280665;1584.3662534986097;825.7192554531488;826.7478419082238;827.6358402302967;832.1927730101792;842.8440738463404;7857.685692572348;8009.279164875189;8012.5192488450875;8071.192880711999;8108.2297181767635;941.3928016429364;958.4009993753904;965.2229954886244;968.5883499512679;969.6896992962185;4347.804348804311;4353.25994580922;4370.2352088384405;4955.306257124005;5111.718855462986;21650.458738531663;22767.31698049061;22831.543369132523;22832.885835571047;22909.885450572972;21213.469663258544;22231.999560019514;22292.21977230789;22369.776302237096;22533.661995070088;11504.654860354203;11859.34773587461;11881.108916831272;11893.92954634087;11924.701882453008;7800.804979875548;7801.765947021599;7847.332976697045;7851.136374998631;7939.364850811806;18847.434576962714;18930.905345473184;18965;19079.141438635572;19223;18921.71617425767;19962.30131945375;20047.69928451045;20283.492912677302;20449.795502044788;10856.34861908288;10909.890901090888;11045.613403530839;11052.723681908017;11107.333559986104;13529.72940541164;14532.27338633043;14687.92656036713;14688.632784180481;14697.265136743334;11755.294682319089;11903.821442678194;11905.809419058025;11966.58116965902;12039.75920481603;11620.76758464809;11664;11702.70743231426;11733.120015999006;11839;10865;10923.508442119964;11009.559617615205;11071.280366776135;11115.333080015225;7032.472564557576;7067.82330441743;7233.421326293778;7246.673899674633;7333.339999399866;6880.621565813928;7013.649317534001;7159.64201789898;7166.068411106523;7230.096237970254 03:29:01 INFO - PID 3889 | |4;prototype.html;498.44544243201904;504.1605726465433;516.1560848013497;523.8690327418145;526.552430434131;6035.818925432239;6161.599496032761;6213.7435856438315;6257.655828929407;6277.811665650026;6067.544934129947;6088.573799834014;6090.390960903907;6154.230471384668;6300.936990630093;4913.803447862081;4961.355023846912;4961.3798275215595;4963.999999999982;4967.503249675022;4717.716936983775;4945.381827271591;4963.925541116886;4984.501549845023;4988.825391111312;4854.611631069523;4931.334269873575;4932.408111026682;4948.802047918079;4997.15048441764;4898.485659005806;4921.384826896638;4961.908380156396;4987.177115775893;4992.90014199714;4414.426124603781;4443.955560444387;4454.443194600675;4470.9105817883465;4492.8556802461;6068.817935461943;6143.447089761943;6175.536834737368;6186.133941248228;6189.6905154742535;5692.48767610917;5704.543636509111;5714.285714285715;5715.714214289269;5724.282715185469;6443.96778016107;6501.219853617549;6516.218053833523;6524.445422139124;6534.281229064799;4795.328653988445;4796.496367881392;4807.375041244616;4831.4926932671915;4846.660733748639;6844.007618895282;6851.931480685179;6898.655067246667;6916.135483064617;6946.51374403797;5003.424606170337;5005.499450055038;5024.196128619404;5028.371453568304;5035.16919708244;5016.021875734197;5027.497250274943;5048.646594738333;5088.160453525127;5100.591952643779;5644.125160600113;5655.575831812548;5668.744906479218;5675.233843431167;5683.261176047087;6283.560150789493;6547.934520654732;6562.7202695473925;6592.934070659232;6621.9006714899315;1683.4108062178384;1686.9156542173089;1704.4375356132693;1718.52740496362;1755.5611097225694;1200.165884710118;1229.8401207842924;1230.329470438613;1239.3803098450774;1253.0038619297497;5524.861878452991;5608.327000759935;5631.493165615114;5641.351244606841;5647.604667673223;6580.5722628029025;6589.80230593083;6614.933850661528;6732.461403087741;6748.662566871637;5585.832425027255;5635.605507614428;5699.202111704365;5702.714864256854;5771.913421298684;3486.4944583035826;3521.2429327694667;3549.1304630365207;3553.733469989761;3591.9281614367565;6395.904061439082;6437.002264648987;6494.188226471691;6512.869742605216;6517.543771935919;6852.903535434307;6859.5541289816;6922.307769223037;6940.271271516519;6941.167059952838;6329.544204832822;6453.419192272624;6512.674366281667;6514.42680141351;6553.967230163818;6681.599104053772;6697.631630260187;6733.6296503692765;6755.493337999571;6791.453205048107;6574.572652777554;6647.302033286629;6720.32796720324;6736.663166841737;6741.59550426976;6370.458511026614;6459.773907913201;6495.870082598416;6513.413792758485;6554.4756419487285;4892.94801617654;4902.9019419610695;4949.208126699855;4971.527704868032;4992.825251116194;6309.589876658002;6606.8348291293105;6610.70251838678;6637.435817955527;6697.12937318165;6340.207474065742;6374.139491168633;6383.297837237993;6464.806055818333;6573.835654108494;6433.710483028181;6436.452901503425;6468.6442245676935;6497.610143391412;6503.569214772742;6342.302346741762;6357.078223657451;6376.80869573895;6438.3883531064475;6470.7088181032905;6340.714667839866;6487.448566871869;6496.382843629847;6530.738770449128;6614.933850661624;6149.938500614937;6262.248530176408;6271.560990730605;6273.6987245777245;6296.968515157395 03:29:01 INFO - PID 3889 | |5;yui.html;879.0813599788221;891.7235656946351;903.7650210945152;905.0270958719376;908.5548081440093;19373;19635.5091122722;19677.212911483522;19740.506487337825;19753.703694444594;18005;18166.545836354064;18310.26758929641;18351.54121146972;18402.81597184028;944.7213072143734;951.2152474208771;954.7183580843633;958.9568469418892;967.8596603492489;964.7732782796037;965.7489052846275;967.2407160379104;978.6574698855414;980.2060331131806;979.3683074416997;1014.2697257974247;1015.2030655935092;1021.6322124035341;1024.7438140464883;1006.1799633298874;1008.2891561449161;1012.6354512375539;1015.5480811039091;1021.5352014833232;734.2070563791146;741.1735914455344;743.7880204141794;745.7389913530221;749.5240522268344;18262.452126436227;18359.724604130948;18503.2598696052;18616.90691546547;18733.437996860117;21359.466013349636;21558.78441215599;21729;21734.239301624526;21872.343829685135;17352.438280554685;17738.379156729454;17771.111444427726;17782.110894455356;17843.821561784345;3628.38317486028;3650.6349365063547;3655.305491956546;3663.1208509957687;3665.908352291214;132155;144701;146424;147900;148389;17652.205650745746;17750.91124544369;17819.376321828673;17992.460226193234;18100.366487172887;32190;32375.514367284508;32417.189570260933;32428.189295267333;32448.188795279835;9587.616495340248;9790.657326993522;9813;9854.359466634789;9861.950690246646;4622.399088118523;4641.86074417768;4675.742834144155;4698.906021879543;4734.19518681825;5536.529395001389;5581.748821303051;5640.351359593617;5679.403662615448;5745.540356771532;1080.9243352965218;1105.8451816745662;1114.5653195253858;1118.8489553910117;1121.9495122719497;649.5518092516148;679.2596070283415;684.4900549090959;687.9931200688029;689.5001124185026;11590.594329198437;11886.583969561023;11979.43701337589;12723.936380318039;12751.107422480338;658.3219284137347;663.9668016599151;666.4967949198324;679.8368391585984;682.3176823176823;5058.747062646853;5197.29836472079;5220.765065572058;5415.1335786274;5442.510174084351;130025;135803;135891;138154.47382104804;140996;113740;118526.40736796433;118834.40582797203;119034.4048279753;120229.39885300517;95359.52320238354;96910.51544742231;99081;99620.50189749004;99744.99999999854;9866;9962.153216976349;10070.14403775658;10101.191904647463;10221.74445638865;48633.270500941806;49306;49573;50587;50936;62085;63358;64585;64808.35191648212;65053;15491.84508154949;15714.371425143323;15872.682546349239;15956;15993.600159996093;17748.11259436997;17855.464336069937;18129.728054078936;18200.36298729591;18213.45359639213;15775.842241577897;15845.445409411077;15982.28079736438;16025.679486409974;16049.839501604834;15990.600234994217;16177.838221617632;16208.432704855273;16295.755563666316;16345.918270408572;15488.303026364067;15669.138197399252;15927.522174334788;16052.839471605135;16077.598060048593;11523.942380288381;11637;11665.825012624988;11925.224860384047;11952;11356.034737047443;11405.942970285096;11417.771644567229;11452.770944581229;11966.22219555726 03:29:01 INFO - PID 3889 | __end_tp_report 03:29:01 INFO - PID 3889 | __start_cc_report 03:29:01 INFO - PID 3889 | _x_x_mozilla_cycle_collect,302 03:29:01 INFO - PID 3889 | __end_cc_report 03:29:01 INFO - PID 3889 | __startTimestamp1507112941550__endTimestamp 03:29:01 INFO - PID 3889 | 03:29:01 INFO - PID 3889 | ------- Summary: start ------- 03:29:01 INFO - PID 3889 | Number of tests: 6 03:29:01 INFO - PID 3889 | 03:29:01 INFO - PID 3889 | [#0] dojo.html Cycles:165 Average:6223.97 Median:6431.94 stddev:761.23 (11.8%) stddev-sans-first:722.38 03:29:01 INFO - PID 3889 | Values: 3075.4 3108.0 3114.6 3134.0 3154.7 6342.8 6397.7 6400.5 6422.8 6446.7 6157.6 6314.4 6319.4 6331.6 6347.8 5752.1 5792.2 5855.3 5895.4 5924.3 5812.5 5816.4 5836.1 5844.9 5943.0 5626.1 5729.3 5737.4 5807.8 5895.1 5826.0 5831.8 5893.4 5895.6 5904.8 5662.3 5708.9 5817.7 5877.9 5885.6 6083.5 6227.4 6227.9 6241.8 6270.3 6740.2 6821.8 6837.2 6855.0 6872.1 6761.2 6806.1 6817.9 6872.0 6912.0 6129.1 6229.8 6296.4 6371.6 6383.8 6955.0 7040.4 7044.8 7078.4 7089.2 6610.7 6671.5 6696.4 6712.1 6769.8 6620.9 6726.7 6767.1 6770.0 6848.5 6702.5 6727.6 6742.2 6742.9 6746.8 6580.9 6730.5 6760.7 6781.2 6793.4 5140.6 5283.5 5320.0 5374.0 5386.9 4604.4 4668.8 4672.3 4680.2 4729.7 5794.9 5808.4 5820.2 5869.0 5893.9 6816.9 6830.4 6850.5 6910.3 6912.3 5594.7 5677.2 5714.2 5801.8 5825.8 5804.6 5835.1 5851.5 5855.5 5863.5 6482.6 6586.8 6689.8 6692.6 6700.4 6757.7 6843.4 6867.3 6873.0 6928.3 6341.1 6416.4 6434.0 6559.6 6604.7 6701.5 6715.1 6748.3 6771.7 6791.5 6706.2 6792.2 6853.7 6872.1 6876.6 6454.4 6567.5 6569.5 6651.1 6657.9 6404.2 6554.1 6580.4 6602.0 6653.4 6370.8 6431.9 6433.9 6466.2 6490.4 6571.2 6633.1 6665.4 6683.7 6715.2 6289.4 6361.4 6365.7 6402.9 6473.8 03:29:01 INFO - PID 3889 | 03:29:01 INFO - PID 3889 | [#1] ext.html Cycles:180 Average:36838.78 Median:3593.35 stddev:52296.32 (1455.4%) stddev-sans-first:52373.28 03:29:01 INFO - PID 3889 | Values: 867.2 885.0 891.8 896.0 896.6 37861.6 41538.0 41858.6 41975.4 41989.6 38487.0 38530.0 38632.2 38706.6 38739.4 7192.3 7205.6 7267.9 7268.3 7669.4 7848.3 7901.4 7933.1 7948.4 7958.4 7868.9 7927.5 7934.3 7956.3 7961.6 7928.5 7941.9 7951.8 7978.8 7981.0 7841.6 7879.3 7893.0 7896.9 7901.6 36687.8 37296.0 37416.6 37545.4 37628.5 3567.9 3593.2 3593.5 3622.5 3627.6 31253.7 31263.0 31461.7 31573.5 31761.2 5220.2 5238.1 5264.7 5284.3 5292.4 180192.0 181460.0 182059.0 182256.0 183035.2 41719.6 48380.8 48408.5 48602.8 48650.8 43527.3 43779.1 50914.5 51468.0 51758.7 15024.0 15120.6 15152.6 15174.2 15194.1 12022.5 12103.3 12177.0 12183.5 12187.6 14287.5 14319.8 14324.7 14441.2 14445.2 5730.8 5769.8 5812.2 5825.7 5969.6 984.9 1005.7 1007.2 1018.5 1027.6 23179.7 23186.4 23287.3 23354.8 23666.6 1106.9 1123.3 1126.4 1127.3 1131.3 12166.8 12241.1 12298.3 12314.7 12331.9 226981.0 227518.0 227657.0 228008.0 228194.0 51113.5 51747.2 51767.7 52324.7 52411.7 1401.6 1430.6 1446.2 1456.5 1458.2 22662.5 22748.5 22827.5 23237.4 23441.2 36842.8 36963.3 37333.0 37398.0 37433.8 192487.0 193843.0 193924.0 194409.0 194871.0 29956.3 32582.7 32973.3 34419.3 34686.7 43292.0 43297.4 43533.1 43765.8 44151.0 32150.0 32171.8 32331.2 32344.0 32486.4 31304.7 31423.5 31515.8 31551.8 31689.5 35984.6 36051.6 36118.6 36370.5 36389.6 30794.8 31224.5 31404.0 31411.1 31847.5 23134.2 23191.0 23871.8 23891.2 24183.6 03:29:01 INFO - PID 3889 | 03:29:01 INFO - PID 3889 | [#2] jquery.html Cycles:180 Average:35557.77 Median:23322.15 stddev:86710.71 (371.8%) stddev-sans-first:86914.14 03:29:01 INFO - PID 3889 | Values: 563.3 570.2 571.1 588.4 594.9 22429.6 23189.9 23292.8 23440.8 23489.0 23357.9 24791.4 25158.2 25303.7 25707.0 6540.4 6738.7 6748.1 6821.1 6827.6 6700.4 6846.5 6847.4 6852.3 6856.7 6349.3 6640.8 6811.4 6834.6 6835.9 6637.9 6658.6 6702.7 6706.8 6721.2 6205.9 6211.1 6229.7 6236.3 6257.8 26681.9 28245.2 28557.9 28607.4 28658.0 2043.2 2055.8 2064.8 2068.3 2070.3 19084.8 19349.5 19565.8 19619.7 19668.6 2383.5 2410.2 2427.4 2463.8 2465.5 124115.4 129237.0 139137.0 146368.3 146937.0 14464.7 14729.4 14836.0 14859.7 14948.8 23175.7 23258.2 23266.2 23351.5 23406.5 9603.6 9723.8 9776.4 9808.0 9839.2 8867.3 8873.7 8883.5 8928.8 9006.5 9009.2 9146.6 9163.5 9229.2 9312.6 2627.3 2646.3 2673.4 2709.6 2718.9 945.4 965.1 967.2 977.7 980.8 17978.8 18130.2 18137.9 18149.5 18539.0 1004.8 1021.0 1027.7 1034.0 1037.4 10152.5 10163.4 10245.9 10351.5 10358.4 505303.0 507667.0 517174.0 524775.0 524822.0 117916.4 119056.4 121141.4 121162.0 122926.4 1018.6 1126.9 1163.2 1199.9 1199.9 20248.8 20345.1 20416.8 20686.9 20721.2 55812.0 56618.7 58184.1 58356.4 58704.0 69823.7 70339.9 70777.0 70815.3 72643.0 14511.8 14676.3 14886.2 14899.0 14919.8 22318.7 22463.4 22898.4 22941.8 23193.4 18243.6 18311.7 18344.4 18436.5 18636.6 15942.5 16222.7 16663.1 16756.4 17050.7 18726.2 18851.6 18921.1 19046.0 19051.0 13446.7 14520.9 14533.3 14537.6 14581.9 17808.7 17825.8 17916.0 17954.6 18049.8 03:29:01 INFO - PID 3889 | 03:29:01 INFO - PID 3889 | [#3] mootools.html Cycles:180 Average:9573.41 Median:2718.31 stddev:6978.04 (256.7%) stddev-sans-first:6969.91 03:29:01 INFO - PID 3889 | Values: 1298.0 1343.7 1351.6 1360.2 1373.3 14998.4 15545.1 15694.8 15699.6 15778.6 15621.6 15660.0 15687.4 15724.9 15775.4 2682.8 2857.2 2863.2 2863.9 2865.2 2697.5 2799.2 2804.9 2805.2 2805.5 2686.9 2755.0 2798.2 2801.0 2801.4 2767.7 2787.1 2798.8 2809.9 2814.5 2661.2 2706.1 2706.7 2729.9 2732.4 14900.9 15249.9 15273.0 15274.4 15274.8 8246.0 8476.4 8480.8 8558.5 8564.9 5222.4 5255.1 5417.8 5445.7 5503.1 1812.9 1850.3 1874.4 1882.1 1903.8 27690.0 27877.9 27979.9 27986.9 28307.3 6690.2 6770.4 6980.0 7094.9 7104.2 17710.1 17729.5 17801.3 17811.4 17929.6 7977.2 8155.7 8157.8 8160.1 8161.8 7036.3 7458.1 7469.9 7496.0 7532.2 5280.2 5404.0 5455.3 5461.7 5688.9 1449.9 1497.8 1570.2 1581.8 1584.4 825.7 826.7 827.6 832.2 842.8 7857.7 8009.3 8012.5 8071.2 8108.2 941.4 958.4 965.2 968.6 969.7 4347.8 4353.3 4370.2 4955.3 5111.7 21650.5 22767.3 22831.5 22832.9 22909.9 21213.5 22232.0 22292.2 22369.8 22533.7 11504.7 11859.3 11881.1 11893.9 11924.7 7800.8 7801.8 7847.3 7851.1 7939.4 18847.4 18930.9 18965.0 19079.1 19223.0 18921.7 19962.3 20047.7 20283.5 20449.8 10856.3 10909.9 11045.6 11052.7 11107.3 13529.7 14532.3 14687.9 14688.6 14697.3 11755.3 11903.8 11905.8 11966.6 12039.8 11620.8 11664.0 11702.7 11733.1 11839.0 10865.0 10923.5 11009.6 11071.3 11115.3 7032.5 7067.8 7233.4 7246.7 7333.3 6880.6 7013.6 7159.6 7166.1 7230.1 03:29:01 INFO - PID 3889 | 03:29:01 INFO - PID 3889 | [#4] prototype.html Cycles:180 Average:5475.34 Median:6146.69 stddev:1538.52 (25.0%) stddev-sans-first:1496.80 03:29:01 INFO - PID 3889 | Values: 498.4 504.2 516.2 523.9 526.6 6035.8 6161.6 6213.7 6257.7 6277.8 6067.5 6088.6 6090.4 6154.2 6300.9 4913.8 4961.4 4961.4 4964.0 4967.5 4717.7 4945.4 4963.9 4984.5 4988.8 4854.6 4931.3 4932.4 4948.8 4997.2 4898.5 4921.4 4961.9 4987.2 4992.9 4414.4 4444.0 4454.4 4470.9 4492.9 6068.8 6143.4 6175.5 6186.1 6189.7 5692.5 5704.5 5714.3 5715.7 5724.3 6444.0 6501.2 6516.2 6524.4 6534.3 4795.3 4796.5 4807.4 4831.5 4846.7 6844.0 6851.9 6898.7 6916.1 6946.5 5003.4 5005.5 5024.2 5028.4 5035.2 5016.0 5027.5 5048.6 5088.2 5100.6 5644.1 5655.6 5668.7 5675.2 5683.3 6283.6 6547.9 6562.7 6592.9 6621.9 1683.4 1686.9 1704.4 1718.5 1755.6 1200.2 1229.8 1230.3 1239.4 1253.0 5524.9 5608.3 5631.5 5641.4 5647.6 6580.6 6589.8 6614.9 6732.5 6748.7 5585.8 5635.6 5699.2 5702.7 5771.9 3486.5 3521.2 3549.1 3553.7 3591.9 6395.9 6437.0 6494.2 6512.9 6517.5 6852.9 6859.6 6922.3 6940.3 6941.2 6329.5 6453.4 6512.7 6514.4 6554.0 6681.6 6697.6 6733.6 6755.5 6791.5 6574.6 6647.3 6720.3 6736.7 6741.6 6370.5 6459.8 6495.9 6513.4 6554.5 4892.9 4902.9 4949.2 4971.5 4992.8 6309.6 6606.8 6610.7 6637.4 6697.1 6340.2 6374.1 6383.3 6464.8 6573.8 6433.7 6436.5 6468.6 6497.6 6503.6 6342.3 6357.1 6376.8 6438.4 6470.7 6340.7 6487.4 6496.4 6530.7 6614.9 6149.9 6262.2 6271.6 6273.7 6297.0 03:29:01 INFO - PID 3889 | 03:29:01 INFO - PID 3889 | [#5] yui.html Cycles:180 Average:25567.21 Median:18675.17 stddev:37817.10 (202.5%) stddev-sans-first:37877.76 03:29:01 INFO - PID 3889 | Values: 879.1 891.7 903.8 905.0 908.6 19373.0 19635.5 19677.2 19740.5 19753.7 18005.0 18166.5 18310.3 18351.5 18402.8 944.7 951.2 954.7 959.0 967.9 964.8 965.7 967.2 978.7 980.2 979.4 1014.3 1015.2 1021.6 1024.7 1006.2 1008.3 1012.6 1015.5 1021.5 734.2 741.2 743.8 745.7 749.5 18262.5 18359.7 18503.3 18616.9 18733.4 21359.5 21558.8 21729.0 21734.2 21872.3 17352.4 17738.4 17771.1 17782.1 17843.8 3628.4 3650.6 3655.3 3663.1 3665.9 132155.0 144701.0 146424.0 147900.0 148389.0 17652.2 17750.9 17819.4 17992.5 18100.4 32190.0 32375.5 32417.2 32428.2 32448.2 9587.6 9790.7 9813.0 9854.4 9862.0 4622.4 4641.9 4675.7 4698.9 4734.2 5536.5 5581.7 5640.4 5679.4 5745.5 1080.9 1105.8 1114.6 1118.8 1121.9 649.6 679.3 684.5 688.0 689.5 11590.6 11886.6 11979.4 12723.9 12751.1 658.3 664.0 666.5 679.8 682.3 5058.7 5197.3 5220.8 5415.1 5442.5 130025.0 135803.0 135891.0 138154.5 140996.0 113740.0 118526.4 118834.4 119034.4 120229.4 95359.5 96910.5 99081.0 99620.5 99745.0 9866.0 9962.2 10070.1 10101.2 10221.7 48633.3 49306.0 49573.0 50587.0 50936.0 62085.0 63358.0 64585.0 64808.4 65053.0 15491.8 15714.4 15872.7 15956.0 15993.6 17748.1 17855.5 18129.7 18200.4 18213.5 15775.8 15845.4 15982.3 16025.7 16049.8 15990.6 16177.8 16208.4 16295.8 16345.9 15488.3 15669.1 15927.5 16052.8 16077.6 11523.9 11637.0 11665.8 11925.2 11952.0 11356.0 11405.9 11417.8 11452.8 11966.2 03:29:01 INFO - PID 3889 | -------- Summary: end -------- 03:29:01 INFO - PID 3889 | 03:29:02 INFO - TEST-INFO | 3889: exit 0 03:29:02 INFO - TEST-OK | dromaeo_css | took 1115537ms 03:29:02 INFO - TEST-START | kraken 03:29:02 INFO - Initialising browser for kraken test... 03:29:02 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34413/getInfo.html -profile /tmp/tmphlVhNh/profile 03:29:02 INFO - TEST-INFO | started process 4329 (/builds/slave/test/build/application/firefox/firefox http://localhost:34413/getInfo.html) 03:29:09 INFO - TEST-INFO | 4329: exit 0 03:29:09 INFO - Browser initialized. 03:29:09 INFO - Running cycle 1/1 for kraken test... 03:29:09 INFO - Using env: {'DISPLAY': ':0', 03:29:09 INFO - 'HOME': '/home/cltbld', 03:29:09 INFO - 'JSGC_DISABLE_POISONING': '1', 03:29:09 INFO - 'LANG': 'en_US.UTF-8', 03:29:09 INFO - 'LANGUAGE': 'en_US:en', 03:29:09 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:29:09 INFO - 'LOGNAME': 'cltbld', 03:29:09 INFO - 'MAIL': '/var/mail/cltbld', 03:29:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:29:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:29:09 INFO - 'MOZ_ACCELERATED': '1', 03:29:09 INFO - 'MOZ_CRASHREPORTER': '1', 03:29:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:09 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:29:09 INFO - 'MOZ_NO_REMOTE': '1', 03:29:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:29:09 INFO - 'MOZ_WEBRENDER': '1', 03:29:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:09 INFO - 'NO_EM_RESTART': '1', 03:29:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:09 INFO - 'PWD': '/builds/slave/test', 03:29:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:29:09 INFO - 'RUST_BACKTRACE': 'full', 03:29:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:29:09 INFO - 'SHELL': '/bin/bash', 03:29:09 INFO - 'SHLVL': '1', 03:29:09 INFO - 'TERM': 'linux', 03:29:09 INFO - 'TMOUT': '86400', 03:29:09 INFO - 'USER': 'cltbld', 03:29:09 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207', 03:29:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:09 INFO - '_': '/tools/buildbot/bin/python'} 03:29:09 INFO - TEST-INFO | started process 4574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphlVhNh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:10 INFO - PID 4574 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:29:10 INFO - PID 4574 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:29:10 INFO - PID 4574 | 03:29:10 INFO - PID 4574 | (/builds/slave/test/build/application/firefox/firefox:4632): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:29:10 INFO - PID 4574 | 03:29:20 INFO - PID 4574 | RSS: Main: 209588224 03:29:20 INFO - PID 4574 | 03:29:23 INFO - PID 4574 | Cycle 1(1): loaded http://localhost:34413/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34413/tests/kraken/driver.html?testName=audio-beat-detection) 03:29:24 INFO - PID 4574 | RSS: Main: 206667776 03:29:24 INFO - PID 4574 | 03:29:27 INFO - PID 4574 | Cycle 1(1): loaded http://localhost:34413/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34413/tests/kraken/driver.html?testName=audio-dft) 03:29:27 INFO - PID 4574 | RSS: Main: 206364672 03:29:27 INFO - PID 4574 | 03:29:30 INFO - PID 4574 | Cycle 1(1): loaded http://localhost:34413/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34413/tests/kraken/driver.html?testName=audio-fft) 03:29:31 INFO - PID 4574 | RSS: Main: 202539008 03:29:31 INFO - PID 4574 | 03:29:33 INFO - PID 4574 | Cycle 1(1): loaded http://localhost:34413/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34413/tests/kraken/driver.html?testName=audio-oscillator) 03:29:34 INFO - PID 4574 | RSS: Main: 203132928 03:29:34 INFO - PID 4574 | 03:29:36 INFO - PID 4574 | Cycle 1(1): loaded http://localhost:34413/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34413/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:29:37 INFO - PID 4574 | RSS: Main: 203677696 03:29:37 INFO - PID 4574 | 03:29:40 INFO - PID 4574 | Cycle 1(1): loaded http://localhost:34413/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34413/tests/kraken/driver.html?testName=imaging-darkroom) 03:29:41 INFO - PID 4574 | RSS: Main: 205582336 03:29:41 INFO - PID 4574 | 03:29:44 INFO - PID 4574 | Cycle 1(1): loaded http://localhost:34413/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34413/tests/kraken/driver.html?testName=imaging-desaturate) 03:29:45 INFO - PID 4574 | RSS: Main: 204652544 03:29:45 INFO - PID 4574 | 03:29:48 INFO - PID 4574 | Cycle 1(1): loaded http://localhost:34413/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34413/tests/kraken/driver.html?testName=json-parse-financial) 03:29:49 INFO - PID 4574 | RSS: Main: 205307904 03:29:49 INFO - PID 4574 | 03:29:50 INFO - PID 4574 | Cycle 1(1): loaded http://localhost:34413/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34413/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:29:51 INFO - PID 4574 | RSS: Main: 205860864 03:29:51 INFO - PID 4574 | 03:29:53 INFO - PID 4574 | Cycle 1(1): loaded http://localhost:34413/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34413/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:29:53 INFO - PID 4574 | RSS: Main: 205496320 03:29:53 INFO - PID 4574 | 03:29:55 INFO - PID 4574 | Cycle 1(1): loaded http://localhost:34413/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34413/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:29:56 INFO - PID 4574 | RSS: Main: 205910016 03:29:56 INFO - PID 4574 | 03:29:59 INFO - PID 4574 | Cycle 1(1): loaded http://localhost:34413/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34413/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:29:59 INFO - PID 4574 | RSS: Main: 206393344 03:29:59 INFO - PID 4574 | 03:30:02 INFO - PID 4574 | Cycle 1(1): loaded http://localhost:34413/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34413/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:30:03 INFO - PID 4574 | RSS: Main: 206176256 03:30:03 INFO - PID 4574 | 03:30:05 INFO - PID 4574 | Cycle 1(1): loaded http://localhost:34413/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34413/tests/kraken/driver.html?testName=ai-astar) 03:30:05 INFO - PID 4574 | RSS: Main: 207380480 03:30:05 INFO - PID 4574 | 03:30:05 INFO - PID 4574 | __start_tp_report 03:30:05 INFO - PID 4574 | _x_x_mozilla_page_load 03:30:05 INFO - PID 4574 | _x_x_mozilla_page_load_details 03:30:05 INFO - PID 4574 | |i|pagename|runs| 03:30:05 INFO - PID 4574 | |0;ai-astar;111;117;109;108;107;113;111;108;108;112 03:30:05 INFO - PID 4574 | |1;audio-beat-detection;128;125;115;114;117;118;124;116;120;148 03:30:05 INFO - PID 4574 | |2;audio-dft;171;163;163;170;168;167;167;175;171;174 03:30:05 INFO - PID 4574 | |3;audio-fft;82;79;81;84;74;78;78;79;78;82 03:30:05 INFO - PID 4574 | |4;audio-oscillator;80;80;90;85;88;79;79;83;80;78 03:30:05 INFO - PID 4574 | |5;imaging-gaussian-blur;114;114;122;116;115;119;114;120;122;119 03:30:05 INFO - PID 4574 | |6;imaging-darkroom;147;156;149;150;155;157;159;153;149;149 03:30:05 INFO - PID 4574 | |7;imaging-desaturate;100;96;95;101;96;98;96;102;101;98 03:30:05 INFO - PID 4574 | |8;json-parse-financial;67;57;54;55;52;58;53;55;52;52 03:30:05 INFO - PID 4574 | |9;json-stringify-tinderbox;42;42;43;37;37;37;44;46;37;37 03:30:05 INFO - PID 4574 | |10;stanford-crypto-aes;81;72;86;74;77;73;77;74;72;78 03:30:05 INFO - PID 4574 | |11;stanford-crypto-ccm;111;112;109;116;118;111;126;117;114;110 03:30:05 INFO - PID 4574 | |12;stanford-crypto-pbkdf2;173;159;162;161;159;168;161;160;169;172 03:30:05 INFO - PID 4574 | |13;stanford-crypto-sha256-iterative;66;64;62;66;62;66;71;62;62;67 03:30:05 INFO - PID 4574 | __end_tp_report 03:30:05 INFO - PID 4574 | __start_cc_report 03:30:05 INFO - PID 4574 | _x_x_mozilla_cycle_collect,785 03:30:05 INFO - PID 4574 | __end_cc_report 03:30:05 INFO - PID 4574 | __startTimestamp1507113005423__endTimestamp 03:30:05 INFO - PID 4574 | 03:30:05 INFO - PID 4574 | ------- Summary: start ------- 03:30:05 INFO - PID 4574 | Number of tests: 14 03:30:05 INFO - PID 4574 | 03:30:05 INFO - PID 4574 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:3.06 (2.8%) stddev-sans-first:3.24 03:30:05 INFO - PID 4574 | Values: 111.0 117.0 109.0 108.0 107.0 113.0 111.0 108.0 108.0 112.0 03:30:05 INFO - PID 4574 | 03:30:05 INFO - PID 4574 | [#1] audio-beat-detection Cycles:10 Average:122.50 Median:122.00 stddev:10.09 (8.3%) stddev-sans-first:10.51 03:30:05 INFO - PID 4574 | Values: 128.0 125.0 115.0 114.0 117.0 118.0 124.0 116.0 120.0 148.0 03:30:05 INFO - PID 4574 | 03:30:05 INFO - PID 4574 | [#2] audio-dft Cycles:10 Average:168.90 Median:170.50 stddev:4.09 (2.4%) stddev-sans-first:4.27 03:30:05 INFO - PID 4574 | Values: 171.0 163.0 163.0 170.0 168.0 167.0 167.0 175.0 171.0 174.0 03:30:05 INFO - PID 4574 | 03:30:05 INFO - PID 4574 | [#3] audio-fft Cycles:10 Average:79.50 Median:80.00 stddev:2.84 (3.5%) stddev-sans-first:2.86 03:30:05 INFO - PID 4574 | Values: 82.0 79.0 81.0 84.0 74.0 78.0 78.0 79.0 78.0 82.0 03:30:05 INFO - PID 4574 | 03:30:05 INFO - PID 4574 | [#4] audio-oscillator Cycles:10 Average:82.20 Median:81.50 stddev:4.16 (5.1%) stddev-sans-first:4.33 03:30:05 INFO - PID 4574 | Values: 80.0 80.0 90.0 85.0 88.0 79.0 79.0 83.0 80.0 78.0 03:30:05 INFO - PID 4574 | 03:30:05 INFO - PID 4574 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:119.00 stddev:3.27 (2.8%) stddev-sans-first:3.22 03:30:05 INFO - PID 4574 | Values: 114.0 114.0 122.0 116.0 115.0 119.0 114.0 120.0 122.0 119.0 03:30:05 INFO - PID 4574 | 03:30:05 INFO - PID 4574 | [#6] imaging-darkroom Cycles:10 Average:152.40 Median:154.00 stddev:4.14 (2.7%) stddev-sans-first:3.91 03:30:05 INFO - PID 4574 | Values: 147.0 156.0 149.0 150.0 155.0 157.0 159.0 153.0 149.0 149.0 03:30:05 INFO - PID 4574 | 03:30:05 INFO - PID 4574 | [#7] imaging-desaturate Cycles:10 Average:98.30 Median:96.00 stddev:2.54 (2.6%) stddev-sans-first:2.62 03:30:05 INFO - PID 4574 | Values: 100.0 96.0 95.0 101.0 96.0 98.0 96.0 102.0 101.0 98.0 03:30:05 INFO - PID 4574 | 03:30:05 INFO - PID 4574 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.00 stddev:4.55 (8.3%) stddev-sans-first:2.22 03:30:05 INFO - PID 4574 | Values: 67.0 57.0 54.0 55.0 52.0 58.0 53.0 55.0 52.0 52.0 03:30:05 INFO - PID 4574 | 03:30:05 INFO - PID 4574 | [#9] json-stringify-tinderbox Cycles:10 Average:40.20 Median:42.00 stddev:3.55 (8.5%) stddev-sans-first:3.71 03:30:05 INFO - PID 4574 | Values: 42.0 42.0 43.0 37.0 37.0 37.0 44.0 46.0 37.0 37.0 03:30:05 INFO - PID 4574 | 03:30:05 INFO - PID 4574 | [#10] stanford-crypto-aes Cycles:10 Average:76.40 Median:77.00 stddev:4.45 (5.8%) stddev-sans-first:4.40 03:30:05 INFO - PID 4574 | Values: 81.0 72.0 86.0 74.0 77.0 73.0 77.0 74.0 72.0 78.0 03:30:05 INFO - PID 4574 | 03:30:05 INFO - PID 4574 | [#11] stanford-crypto-ccm Cycles:10 Average:114.40 Median:115.00 stddev:5.10 (4.4%) stddev-sans-first:5.26 03:30:05 INFO - PID 4574 | Values: 111.0 112.0 109.0 116.0 118.0 111.0 126.0 117.0 114.0 110.0 03:30:05 INFO - PID 4574 | 03:30:05 INFO - PID 4574 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.40 Median:165.00 stddev:5.50 (3.3%) stddev-sans-first:4.88 03:30:05 INFO - PID 4574 | Values: 173.0 159.0 162.0 161.0 159.0 168.0 161.0 160.0 169.0 172.0 03:30:05 INFO - PID 4574 | 03:30:05 INFO - PID 4574 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:66.00 stddev:2.97 (4.5%) stddev-sans-first:3.12 03:30:05 INFO - PID 4574 | Values: 66.0 64.0 62.0 66.0 62.0 66.0 71.0 62.0 62.0 67.0 03:30:05 INFO - PID 4574 | -------- Summary: end -------- 03:30:05 INFO - PID 4574 | 03:30:05 INFO - PID 4574 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:30:06 INFO - TEST-INFO | 4574: exit 0 03:30:06 INFO - TEST-OK | kraken | took 64112ms 03:30:06 INFO - SUITE-END | took 1179s 03:30:06 INFO - Completed test suite (00:19:39) 03:30:06 INFO - javascript benchmark 03:30:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8540.79971303832, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3075.4464196444637, 3108.0365086823085, 3114.5639610454527, 3133.9529907051397, 3154.747620190385, 6342.778002769904, 6397.712102955366, 6400.455961243294, 6422.839429014277, 6446.709898054587, 6157.599756015856, 6314.400131987454, 6319.399657032574, 6331.5884467509695, 6347.841303967403, 5752.050911599581, 5792.189093526888, 5855.297364316288, 5895.4399332063385, 5924.259467566554, 5812.4768770810615, 5816.360200377955, 5836.066229403296, 5844.860252250813, 5943.0, 5626.099824028156, 5729.341125770548, 5737.39757325479, 5807.82576522705, 5895.145203945425, 5825.970870145665, 5831.825045248649, 5893.351731309553, 5895.557833162487, 5904.822855314304, 5662.263905692274, 5708.885822283531, 5817.7091145442555, 5877.9412205877825, 5885.558583106242, 6083.48290395317, 6227.439530442282, 6227.875442491125, 6241.750329986795, 6270.3416141305415, 6740.157480314961, 6821.829454263633, 6837.213720422115, 6855.0, 6872.140982377203, 6761.222459417131, 6806.081179040815, 6817.863642727168, 6872.037914691947, 6912.032315475837, 6129.111278864584, 6229.813105606839, 6296.433321001086, 6371.617702937839, 6383.808485745389, 6954.965225173842, 7040.401565866856, 7044.788656340318, 7078.362947334765, 7089.22018577956, 6610.735570577219, 6671.466282697373, 6696.430803381767, 6712.093867327946, 6769.796906092825, 6620.86758264832, 6726.697298621476, 6767.120274364301, 6769.966150169316, 6848.520603557703, 6702.497312701566, 6727.629980351127, 6742.190937087483, 6742.898856517156, 6746.763863264762, 6580.86838263232, 6730.461563074942, 6760.695768690421, 6781.186257649114, 6793.422559082434, 5140.640155189176, 5283.471652834686, 5320.042392369411, 5373.9731301343245, 5386.865328366822, 4604.424446944132, 4668.8132474701315, 4672.275797251432, 4680.180968330528, 4729.668923175344, 5794.855128621818, 5808.419158084158, 5820.185174075633, 5868.972929737279, 5893.911591326134, 6816.931830681729, 6830.385265326046, 6850.451963842881, 6910.30896910315, 6912.343327383891, 5594.664320140804, 5677.233573467529, 5714.228579141763, 5801.82594522165, 5825.79609713658, 5804.593678442553, 5835.066389377679, 5851.531877449879, 5855.473007429352, 5863.5309175265875, 6482.57863238888, 6586.8353291168105, 6689.832754181184, 6692.631905245161, 6700.396964273239, 6757.695903684247, 6843.418309443753, 6867.278935711778, 6873.0, 6928.341807528277, 6341.0805433212845, 6416.390442907917, 6433.9678301610065, 6559.639219842955, 6604.702788374439, 6701.463882889455, 6715.127033485615, 6748.325167483409, 6771.695273712597, 6791.524593278423, 6706.228783689938, 6792.150981127359, 6853.691583878638, 6872.072270243453, 6876.553024053421, 6454.386833250834, 6567.540272181092, 6569.507286953593, 6651.06885036105, 6657.866842663217, 6404.199475065617, 6554.082428459924, 6580.374864387875, 6602.0, 6653.367930046637, 6370.840728981812, 6431.935680643321, 6433.903491447726, 6466.159399278064, 6490.415862572202, 6571.244306904767, 6633.1045308882685, 6665.433438157811, 6683.699233534599, 6715.227748808754, 6289.40250676185, 6361.363863613787, 6365.745370185141, 6402.871942561216, 6473.805785826433], "value": 6164.584144330244, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [867.1631875240392, 885.0220506340494, 891.7725979875131, 896.0457113174465, 896.6099746610223, 37861.62138378615, 41538.0, 41858.58141418589, 41975.370369444405, 41989.58010419895, 38487.0, 38530.0, 38632.22735545287, 38706.61293387065, 38739.41890871639, 7192.31672991065, 7205.567665940061, 7267.854642907138, 7268.3458488736005, 7669.38644908406, 7848.332891704212, 7901.367890568769, 7933.127355990865, 7948.364130869517, 7958.4031197660115, 7868.921310786876, 7927.4847134936335, 7934.285914267714, 7956.323712484445, 7961.641726122339, 7928.524288542706, 7941.880871786928, 7951.840963180733, 7978.760637180894, 7980.960095199545, 7841.607919604054, 7879.251471110236, 7893.0, 7896.881546776803, 7901.565413902233, 36687.816560917025, 37296.0, 37416.625833741586, 37545.43681844774, 37628.49486020556, 3567.8929632111076, 3593.245418462126, 3593.4609808528667, 3622.5471816022996, 3627.5828279747902, 31253.687463125305, 31263.0, 31461.685383146334, 31573.526397104062, 31761.20596985094, 5220.1647736362, 5238.083335416287, 5264.710440925747, 5284.260203571503, 5292.391374991887, 180192.0, 181460.0, 182059.0, 182256.0, 183035.16964830316, 41719.582804172176, 48380.75809621, 48408.515914841104, 48602.75698621555, 48650.756746216044, 43527.34708979368, 43779.12441751147, 50914.49085509172, 51468.0, 51758.74120629373, 15024.0, 15120.621984450478, 15152.621184470476, 15174.165420901736, 15194.088354698753, 12022.519099235933, 12103.273803571637, 12177.0, 12183.512659493697, 12187.573434929735, 14287.499937502345, 14319.78520322196, 14324.713505729827, 14441.205733684748, 14445.205513696848, 5730.77076916927, 5769.798057068067, 5812.186293918855, 5825.7378417971295, 5969.641821490724, 984.867042949207, 1005.7385079879137, 1007.2294694558668, 1018.4602160854758, 1027.6300531808542, 23179.652305215433, 23186.42033949131, 23287.301380958597, 23354.7664523356, 23666.64500032501, 1106.9335839849634, 1123.253036730565, 1126.3579759536985, 1127.3010733345213, 1131.3438205840594, 12166.81749773754, 12241.143119981516, 12298.262104273772, 12314.692132696575, 12331.876681233252, 226981.0, 227518.0, 227657.0, 228008.0, 228194.0, 51113.48886511162, 51747.223791643155, 51767.741161293954, 52324.73837630863, 52411.73794131005, 1401.6425811418023, 1430.6280367104628, 1446.2479510654612, 1456.4683890380147, 1458.2052781234254, 22662.530038018962, 22748.545029099656, 22827.543449131255, 23237.41906452352, 23441.179558715365, 36842.81578592197, 36963.26073478461, 37333.0, 37398.0, 37433.7539747616, 192487.0, 193843.0, 193924.0, 194409.0, 194871.0, 29956.25109372196, 32582.674173257965, 32973.34053318968, 34419.311613768084, 34686.65313346834, 43292.0, 43297.35053974256, 43533.12933741371, 43765.78117109394, 44151.0, 32150.0, 32171.83914080508, 32331.19172020718, 32344.0, 32486.350272993936, 31304.686953130178, 31423.528647069856, 31515.84242078775, 31551.84224078865, 31689.524657130623, 35984.64015359813, 36051.639483605875, 36118.638813612575, 36370.4544431839, 36389.63610363862, 30794.846025769726, 31224.531632025082, 31404.0, 31411.05766826999, 31847.522287165248, 23134.168620481796, 23191.0, 23871.761282387648, 23891.163809266593, 24183.637245441685], "value": 17018.916583417024, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.2508763344752, 570.2387312937228, 571.1233256950582, 588.367504932198, 594.9405059494051, 22429.55140897183, 23189.884050579767, 23292.767072329272, 23440.765592344073, 23489.0, 23357.883210583925, 24791.38021549462, 25158.24525264245, 25303.746962530367, 25707.0, 6540.378664026922, 6738.730450781963, 6748.089007983908, 6821.079154314179, 6827.5903445793165, 6700.3969642732145, 6846.4865135114815, 6847.383735463832, 6852.349026842442, 6856.691448884812, 6349.269833969083, 6640.833979150511, 6811.352921472452, 6834.589924604515, 6835.863282734343, 6637.900431493507, 6658.600483970978, 6702.698378572976, 6706.765263215764, 6721.193456785217, 6205.906911396332, 6211.130441738161, 6229.6573688447115, 6236.345183755686, 6257.812265632038, 26681.866590666923, 28245.15264542067, 28557.85721071402, 28607.427851443063, 28658.0, 2043.2133628552965, 2055.8149766520937, 2064.8038436348525, 2068.338131797825, 2070.3064473401428, 19084.80915190844, 19349.51626209342, 19565.80434195654, 19619.705704414446, 19668.606627867506, 2383.512544802864, 2410.1684918703018, 2427.4416884116577, 2463.7659422354845, 2465.506898620265, 124115.3794231023, 129237.0, 139137.0, 146368.2681586596, 146937.0, 14464.746303333415, 14729.410823566937, 14836.035657682216, 14859.702805944036, 14948.786011007685, 23175.652365214537, 23258.185963491196, 23266.185683501335, 23351.53296934052, 23406.531869362516, 9603.567839447242, 9723.805523889625, 9776.36453630526, 9808.0, 9839.212862970946, 8867.290616750644, 8873.668949657604, 8883.466991980373, 8928.776780580538, 9006.549672516348, 9009.23421509179, 9146.588403521857, 9163.541822908828, 9229.215516681023, 9312.580933857993, 2627.316897606636, 2646.3256555987405, 2673.425213579051, 2709.5935609658313, 2718.9048383306886, 945.4472923107637, 965.1265604627823, 967.1585720423136, 977.7066879935991, 980.7597138701063, 17978.820211797974, 18130.184141713653, 18137.909310453364, 18149.54626134331, 18539.0, 1004.7739258666887, 1020.9795804084025, 1027.6557353286732, 1033.9689809305733, 1037.3516552154904, 10152.492375381202, 10163.441010744333, 10245.897541024495, 10351.482425878676, 10358.39444886044, 505303.0, 507667.0, 517174.0, 524775.0, 524822.0, 117916.41041794908, 119056.40471797585, 121141.39429302797, 121162.0, 122926.38536807259, 1018.6078359831519, 1126.915481338903, 1163.1567113842395, 1199.8560172779496, 1199.9280043197436, 20248.797512024692, 20345.084471199127, 20416.795832042084, 20686.896565517076, 20721.171153153704, 55812.0, 56618.716906415204, 58184.127238090616, 58356.4164358368, 58704.0, 69823.6508817473, 70339.94490082756, 70777.0, 70815.29184708087, 72643.0, 14511.782323264948, 14676.3395647194, 14886.181260030802, 14899.0, 14919.776203356741, 22318.665220021387, 22463.43841403978, 22898.427539310986, 22941.770582293964, 23193.420164496023, 18243.635127297646, 18311.72532411988, 18344.449666510027, 18436.539086522946, 18636.627267454845, 15942.521724348288, 16222.67554648924, 16663.08353040546, 16756.413525526546, 17050.721195910108, 18726.157322920775, 18851.622967540847, 18921.053947302855, 19046.04769761534, 19050.952197629264, 13446.663833403853, 14520.927395362956, 14533.34599942984, 14537.636559086108, 14581.85418145805, 17808.732869006715, 17825.821741782416, 17916.0, 17954.64090718152, 18049.819501805337], "value": 11967.266740552583, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1297.9610611681649, 1343.7312537492503, 1351.5674984005122, 1360.2382665707205, 1373.3407964177202, 14998.40006399744, 15545.145017024059, 15694.76457853133, 15699.607509812246, 15778.60553486162, 15621.609459763511, 15660.0, 15687.372505099782, 15724.921375393136, 15775.368985240606, 2682.771964383025, 2857.22854829196, 2863.226928729242, 2863.9284017899513, 2865.154779340089, 2697.5009623219767, 2799.1602519244248, 2804.9439011219765, 2805.1724741201397, 2805.4809860175833, 2686.932826679329, 2755.0357374918817, 2798.202512283989, 2801.033643393026, 2801.355688191717, 2767.6955534891244, 2787.052402183247, 2798.8320700758018, 2809.8735556899887, 2814.493391189585, 2661.161734053767, 2706.120510833987, 2706.715794841533, 2729.9044533441233, 2732.43984983078, 14900.850991490055, 15249.923750381176, 15273.0, 15274.38902443901, 15274.847251527453, 8245.95877020617, 8476.406651534395, 8480.787980300542, 8558.486490810508, 8564.871526927102, 5222.399424066205, 5255.080360936859, 5417.83746487606, 5445.673259604437, 5503.147012213113, 1812.8730988830787, 1850.3338798032698, 1874.4095609882843, 1882.105999650169, 1903.8381737552324, 27690.030848920193, 27877.86061069682, 27979.860100699774, 27986.86006569954, 28307.292317692016, 6690.19717633887, 6770.356816102462, 6980.0, 7094.92905070953, 7104.183018952886, 17710.11449427549, 17729.46811595654, 17801.287948481917, 17811.376601819135, 17929.641407172043, 7977.162397948248, 8155.714549990722, 8157.75526734199, 8160.061592916772, 8161.836763264821, 7036.261192574808, 7458.105027396748, 7469.850602988018, 7495.962520187364, 7532.209118042636, 5280.234366016906, 5403.972980135074, 5455.318085239345, 5461.672299662033, 5688.8862222755315, 1449.8840092792552, 1497.7903093566908, 1570.2227397438112, 1581.7864588280665, 1584.3662534986097, 825.7192554531488, 826.7478419082238, 827.6358402302967, 832.1927730101792, 842.8440738463404, 7857.685692572348, 8009.279164875189, 8012.5192488450875, 8071.192880711999, 8108.2297181767635, 941.3928016429364, 958.4009993753904, 965.2229954886244, 968.5883499512679, 969.6896992962185, 4347.804348804311, 4353.25994580922, 4370.2352088384405, 4955.306257124005, 5111.718855462986, 21650.458738531663, 22767.31698049061, 22831.543369132523, 22832.885835571047, 22909.885450572972, 21213.469663258544, 22231.999560019514, 22292.21977230789, 22369.776302237096, 22533.661995070088, 11504.654860354203, 11859.34773587461, 11881.108916831272, 11893.92954634087, 11924.701882453008, 7800.804979875548, 7801.765947021599, 7847.332976697045, 7851.136374998631, 7939.364850811806, 18847.434576962714, 18930.905345473184, 18965.0, 19079.141438635572, 19223.0, 18921.71617425767, 19962.30131945375, 20047.69928451045, 20283.492912677302, 20449.795502044788, 10856.34861908288, 10909.890901090888, 11045.613403530839, 11052.723681908017, 11107.333559986104, 13529.72940541164, 14532.27338633043, 14687.92656036713, 14688.632784180481, 14697.265136743334, 11755.294682319089, 11903.821442678194, 11905.809419058025, 11966.58116965902, 12039.75920481603, 11620.76758464809, 11664.0, 11702.70743231426, 11733.120015999006, 11839.0, 10865.0, 10923.508442119964, 11009.559617615205, 11071.280366776135, 11115.333080015225, 7032.472564557576, 7067.82330441743, 7233.421326293778, 7246.673899674633, 7333.339999399866, 6880.621565813928, 7013.649317534001, 7159.64201789898, 7166.068411106523, 7230.096237970254], "value": 6766.703373857212, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.44544243201904, 504.1605726465433, 516.1560848013497, 523.8690327418145, 526.552430434131, 6035.818925432239, 6161.599496032761, 6213.7435856438315, 6257.655828929407, 6277.811665650026, 6067.544934129947, 6088.573799834014, 6090.390960903907, 6154.230471384668, 6300.936990630093, 4913.803447862081, 4961.355023846912, 4961.3798275215595, 4963.999999999982, 4967.503249675022, 4717.716936983775, 4945.381827271591, 4963.925541116886, 4984.501549845023, 4988.825391111312, 4854.611631069523, 4931.334269873575, 4932.408111026682, 4948.802047918079, 4997.15048441764, 4898.485659005806, 4921.384826896638, 4961.908380156396, 4987.177115775893, 4992.90014199714, 4414.426124603781, 4443.955560444387, 4454.443194600675, 4470.9105817883465, 4492.8556802461, 6068.817935461943, 6143.447089761943, 6175.536834737368, 6186.133941248228, 6189.6905154742535, 5692.48767610917, 5704.543636509111, 5714.285714285715, 5715.714214289269, 5724.282715185469, 6443.96778016107, 6501.219853617549, 6516.218053833523, 6524.445422139124, 6534.281229064799, 4795.328653988445, 4796.496367881392, 4807.375041244616, 4831.4926932671915, 4846.660733748639, 6844.007618895282, 6851.931480685179, 6898.655067246667, 6916.135483064617, 6946.51374403797, 5003.424606170337, 5005.499450055038, 5024.196128619404, 5028.371453568304, 5035.16919708244, 5016.021875734197, 5027.497250274943, 5048.646594738333, 5088.160453525127, 5100.591952643779, 5644.125160600113, 5655.575831812548, 5668.744906479218, 5675.233843431167, 5683.261176047087, 6283.560150789493, 6547.934520654732, 6562.7202695473925, 6592.934070659232, 6621.9006714899315, 1683.4108062178384, 1686.9156542173089, 1704.4375356132693, 1718.52740496362, 1755.5611097225694, 1200.165884710118, 1229.8401207842924, 1230.329470438613, 1239.3803098450774, 1253.0038619297497, 5524.861878452991, 5608.327000759935, 5631.493165615114, 5641.351244606841, 5647.604667673223, 6580.5722628029025, 6589.80230593083, 6614.933850661528, 6732.461403087741, 6748.662566871637, 5585.832425027255, 5635.605507614428, 5699.202111704365, 5702.714864256854, 5771.913421298684, 3486.4944583035826, 3521.2429327694667, 3549.1304630365207, 3553.733469989761, 3591.9281614367565, 6395.904061439082, 6437.002264648987, 6494.188226471691, 6512.869742605216, 6517.543771935919, 6852.903535434307, 6859.5541289816, 6922.307769223037, 6940.271271516519, 6941.167059952838, 6329.544204832822, 6453.419192272624, 6512.674366281667, 6514.42680141351, 6553.967230163818, 6681.599104053772, 6697.631630260187, 6733.6296503692765, 6755.493337999571, 6791.453205048107, 6574.572652777554, 6647.302033286629, 6720.32796720324, 6736.663166841737, 6741.59550426976, 6370.458511026614, 6459.773907913201, 6495.870082598416, 6513.413792758485, 6554.4756419487285, 4892.94801617654, 4902.9019419610695, 4949.208126699855, 4971.527704868032, 4992.825251116194, 6309.589876658002, 6606.8348291293105, 6610.70251838678, 6637.435817955527, 6697.12937318165, 6340.207474065742, 6374.139491168633, 6383.297837237993, 6464.806055818333, 6573.835654108494, 6433.710483028181, 6436.452901503425, 6468.6442245676935, 6497.610143391412, 6503.569214772742, 6342.302346741762, 6357.078223657451, 6376.80869573895, 6438.3883531064475, 6470.7088181032905, 6340.714667839866, 6487.448566871869, 6496.382843629847, 6530.738770449128, 6614.933850661624, 6149.938500614937, 6262.248530176408, 6271.560990730605, 6273.6987245777245, 6296.968515157395], "value": 5023.493773804717, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [879.0813599788221, 891.7235656946351, 903.7650210945152, 905.0270958719376, 908.5548081440093, 19373.0, 19635.5091122722, 19677.212911483522, 19740.506487337825, 19753.703694444594, 18005.0, 18166.545836354064, 18310.26758929641, 18351.54121146972, 18402.81597184028, 944.7213072143734, 951.2152474208771, 954.7183580843633, 958.9568469418892, 967.8596603492489, 964.7732782796037, 965.7489052846275, 967.2407160379104, 978.6574698855414, 980.2060331131806, 979.3683074416997, 1014.2697257974247, 1015.2030655935092, 1021.6322124035341, 1024.7438140464883, 1006.1799633298874, 1008.2891561449161, 1012.6354512375539, 1015.5480811039091, 1021.5352014833232, 734.2070563791146, 741.1735914455344, 743.7880204141794, 745.7389913530221, 749.5240522268344, 18262.452126436227, 18359.724604130948, 18503.2598696052, 18616.90691546547, 18733.437996860117, 21359.466013349636, 21558.78441215599, 21729.0, 21734.239301624526, 21872.343829685135, 17352.438280554685, 17738.379156729454, 17771.111444427726, 17782.110894455356, 17843.821561784345, 3628.38317486028, 3650.6349365063547, 3655.305491956546, 3663.1208509957687, 3665.908352291214, 132155.0, 144701.0, 146424.0, 147900.0, 148389.0, 17652.205650745746, 17750.91124544369, 17819.376321828673, 17992.460226193234, 18100.366487172887, 32190.0, 32375.514367284508, 32417.189570260933, 32428.189295267333, 32448.188795279835, 9587.616495340248, 9790.657326993522, 9813.0, 9854.359466634789, 9861.950690246646, 4622.399088118523, 4641.86074417768, 4675.742834144155, 4698.906021879543, 4734.19518681825, 5536.529395001389, 5581.748821303051, 5640.351359593617, 5679.403662615448, 5745.540356771532, 1080.9243352965218, 1105.8451816745662, 1114.5653195253858, 1118.8489553910117, 1121.9495122719497, 649.5518092516148, 679.2596070283415, 684.4900549090959, 687.9931200688029, 689.5001124185026, 11590.594329198437, 11886.583969561023, 11979.43701337589, 12723.936380318039, 12751.107422480338, 658.3219284137347, 663.9668016599151, 666.4967949198324, 679.8368391585984, 682.3176823176823, 5058.747062646853, 5197.29836472079, 5220.765065572058, 5415.1335786274, 5442.510174084351, 130025.0, 135803.0, 135891.0, 138154.47382104804, 140996.0, 113740.0, 118526.40736796433, 118834.40582797203, 119034.4048279753, 120229.39885300517, 95359.52320238354, 96910.51544742231, 99081.0, 99620.50189749004, 99744.99999999854, 9866.0, 9962.153216976349, 10070.14403775658, 10101.191904647463, 10221.74445638865, 48633.270500941806, 49306.0, 49573.0, 50587.0, 50936.0, 62085.0, 63358.0, 64585.0, 64808.35191648212, 65053.0, 15491.84508154949, 15714.371425143323, 15872.682546349239, 15956.0, 15993.600159996093, 17748.11259436997, 17855.464336069937, 18129.728054078936, 18200.36298729591, 18213.45359639213, 15775.842241577897, 15845.445409411077, 15982.28079736438, 16025.679486409974, 16049.839501604834, 15990.600234994217, 16177.838221617632, 16208.432704855273, 16295.755563666316, 16345.918270408572, 15488.303026364067, 15669.138197399252, 15927.522174334788, 16052.839471605135, 16077.598060048593, 11523.942380288381, 11637.0, 11665.825012624988, 11925.224860384047, 11952.0, 11356.034737047443, 11405.942970285096, 11417.771644567229, 11452.770944581229, 11966.22219555726], "value": 9093.938348689018, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1447.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 117.0, 109.0, 108.0, 107.0, 113.0, 111.0, 108.0, 108.0, 112.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 125.0, 115.0, 114.0, 117.0, 118.0, 124.0, 116.0, 120.0, 148.0], "value": 122.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 163.0, 163.0, 170.0, 168.0, 167.0, 167.0, 175.0, 171.0, 174.0], "value": 168.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 81.0, 84.0, 74.0, 78.0, 78.0, 79.0, 78.0, 82.0], "value": 79.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 90.0, 85.0, 88.0, 79.0, 79.0, 83.0, 80.0, 78.0], "value": 82.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 122.0, 116.0, 115.0, 119.0, 114.0, 120.0, 122.0, 119.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 156.0, 149.0, 150.0, 155.0, 157.0, 159.0, 153.0, 149.0, 149.0], "value": 152.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 96.0, 95.0, 101.0, 96.0, 98.0, 96.0, 102.0, 101.0, 98.0], "value": 98.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 57.0, 54.0, 55.0, 52.0, 58.0, 53.0, 55.0, 52.0, 52.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [42.0, 42.0, 43.0, 37.0, 37.0, 37.0, 44.0, 46.0, 37.0, 37.0], "value": 40.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 72.0, 86.0, 74.0, 77.0, 73.0, 77.0, 74.0, 72.0, 78.0], "value": 76.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 109.0, 116.0, 118.0, 111.0, 126.0, 117.0, 114.0, 110.0], "value": 114.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 159.0, 162.0, 161.0, 159.0, 168.0, 161.0, 160.0, 169.0, 172.0], "value": 164.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 62.0, 66.0, 62.0, 66.0, 71.0, 62.0, 62.0, 67.0], "value": 64.8, "unit": "score"}]}]} 03:30:06 INFO - Return code: 0 03:30:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:30:06 INFO - # TBPL SUCCESS # 03:30:06 INFO - Running post-action listener: _package_coverage_data 03:30:06 INFO - Running post-action listener: _resource_record_post_action 03:30:06 INFO - [mozharness: 2017-10-04 10:30:06.703946Z] Finished run-tests step (success) 03:30:06 INFO - Running post-run listener: _resource_record_post_run 03:30:06 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 20185088; Write bytes: 395026432; Read time: 13264; Write time: 412916 03:30:06 INFO - TinderboxPrint: CPU usage
13.3% 03:30:06 INFO - TinderboxPrint: I/O read bytes / time
20,185,088 / 13,264 03:30:06 INFO - TinderboxPrint: I/O write bytes / time
395,026,432 / 412,916 03:30:06 INFO - TinderboxPrint: CPU idle
8,277.9 (86.7%) 03:30:06 INFO - TinderboxPrint: CPU user
1,199.6 (12.6%) 03:30:06 INFO - TinderboxPrint: Swap in / out
0 / 0 03:30:06 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 4096; Write bytes: 103301120; Read time: 364; Write time: 174844 03:30:06 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:30:06 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 18030592; Write bytes: 243195904; Read time: 12596; Write time: 127728 03:30:07 INFO - Running post-run listener: _upload_blobber_files 03:30:07 INFO - Blob upload gear active. 03:30:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:30:07 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 03:30:07 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'] 03:30:07 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 03:30:07 INFO - (blobuploader) - INFO - Open directory for files ... 03:30:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:30:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:30:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:15 INFO - (blobuploader) - INFO - Done attempting. 03:30:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:30:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:30:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:16 INFO - (blobuploader) - INFO - Done attempting. 03:30:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:30:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:30:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:17 INFO - (blobuploader) - INFO - Done attempting. 03:30:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:30:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:30:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:18 INFO - (blobuploader) - INFO - Done attempting. 03:30:18 INFO - (blobuploader) - INFO - Iteration through files over. 03:30:18 INFO - Return code: 0 03:30:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:30:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:30:18 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca029086820d5f52103b69b0c19d2940766e8375338a706ad0a652692fc6a3bc608be01fe250fe6004f717007ac49084cccbbff2cc2cc10d5f441e0ef1c2a72b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7f4d7ceda4cebe3150b2a3276aad02fe2eee6969d6c92b3fb4fb6d87fcb4bc665578938b61fca9a83e652befa87fa68a2c36b1653f6401a652c2cdee670207a", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa75232f0c1a10b16909dfaef44e54af45e57dc44cff12c048c5e1de4aa49c0e2bb9bc204440cddea2f21ba1844ba66c3b05977b5be65a34d3823daefc507641", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e8fc3ec84664b22a81090da9dbf436db78ab80147b80af98dfe9b728b732c5335ce71f7b7c1bf119da310c063bd30306e8f52f0cd01d8aa77ceacf5c7265dde"} 03:30:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:30:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:30:18 INFO - Contents: 03:30:18 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca029086820d5f52103b69b0c19d2940766e8375338a706ad0a652692fc6a3bc608be01fe250fe6004f717007ac49084cccbbff2cc2cc10d5f441e0ef1c2a72b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7f4d7ceda4cebe3150b2a3276aad02fe2eee6969d6c92b3fb4fb6d87fcb4bc665578938b61fca9a83e652befa87fa68a2c36b1653f6401a652c2cdee670207a", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa75232f0c1a10b16909dfaef44e54af45e57dc44cff12c048c5e1de4aa49c0e2bb9bc204440cddea2f21ba1844ba66c3b05977b5be65a34d3823daefc507641", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e8fc3ec84664b22a81090da9dbf436db78ab80147b80af98dfe9b728b732c5335ce71f7b7c1bf119da310c063bd30306e8f52f0cd01d8aa77ceacf5c7265dde"} 03:30:18 INFO - Running post-run listener: copy_logs_to_upload_dir 03:30:18 INFO - Copying logs to upload dir... 03:30:18 INFO - mkdir: /builds/slave/test/build/upload/logs 03:30:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.088963 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-10-04 03:30:18.391289) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-04 03:30:18.398862) ========= 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=eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207 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/ca029086820d5f52103b69b0c19d2940766e8375338a706ad0a652692fc6a3bc608be01fe250fe6004f717007ac49084cccbbff2cc2cc10d5f441e0ef1c2a72b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7f4d7ceda4cebe3150b2a3276aad02fe2eee6969d6c92b3fb4fb6d87fcb4bc665578938b61fca9a83e652befa87fa68a2c36b1653f6401a652c2cdee670207a", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa75232f0c1a10b16909dfaef44e54af45e57dc44cff12c048c5e1de4aa49c0e2bb9bc204440cddea2f21ba1844ba66c3b05977b5be65a34d3823daefc507641", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e8fc3ec84664b22a81090da9dbf436db78ab80147b80af98dfe9b728b732c5335ce71f7b7c1bf119da310c063bd30306e8f52f0cd01d8aa77ceacf5c7265dde"} build_url:https://queue.taskcluster.net/v1/task/H90Ggu_YRcaJpU0yVW5aGA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011217 build_url: 'https://queue.taskcluster.net/v1/task/H90Ggu_YRcaJpU0yVW5aGA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca029086820d5f52103b69b0c19d2940766e8375338a706ad0a652692fc6a3bc608be01fe250fe6004f717007ac49084cccbbff2cc2cc10d5f441e0ef1c2a72b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7f4d7ceda4cebe3150b2a3276aad02fe2eee6969d6c92b3fb4fb6d87fcb4bc665578938b61fca9a83e652befa87fa68a2c36b1653f6401a652c2cdee670207a", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa75232f0c1a10b16909dfaef44e54af45e57dc44cff12c048c5e1de4aa49c0e2bb9bc204440cddea2f21ba1844ba66c3b05977b5be65a34d3823daefc507641", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e8fc3ec84664b22a81090da9dbf436db78ab80147b80af98dfe9b728b732c5335ce71f7b7c1bf119da310c063bd30306e8f52f0cd01d8aa77ceacf5c7265dde"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-04 03:30:18.430654) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 03:30:18.430956) ========= 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=eca2ab57546de7b41f256b19000001ef-1507111301.147239-617066207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004375 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 03:30:18.510174) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-04 03:30:18.510461) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-04 03:30:18.510783) ========= ========= Total master_lag: 0.25 =========