builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-015 starttime: 1505410239.1 results: success (0) revision: 943c2c2a1daf5cd0d3287c1974eb510615d5ed5b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 10:30:39.107966) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 10:30:39.108481) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 10:30:39.108771) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 10:30:39.243434) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 10:30:39.246176) ========= 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=20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-14 10:30:39-- 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% 220M=0s 2017-09-14 10:30:39 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.103650 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 10:30:39.390244) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 10:30:39.390557) ========= 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=20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019240 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 10:30:39.455400) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 10:30:39.459305) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 943c2c2a1daf5cd0d3287c1974eb510615d5ed5b --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 943c2c2a1daf5cd0d3287c1974eb510615d5ed5b --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=20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-14 10:30:39,917 truncating revision to first 12 chars 2017-09-14 10:30:39,917 Setting DEBUG logging. 2017-09-14 10:30:39,917 attempt 1/10 2017-09-14 10:30:39,917 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/943c2c2a1daf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-14 10:30:40,437 unpacking tar archive at: mozilla-central-943c2c2a1daf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.796688 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 10:30:40.283669) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 10:30:40.283956) ========= script_repo_revision: 943c2c2a1daf5cd0d3287c1974eb510615d5ed5b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 10:30:40.284316) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 10:30:40.284597) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 10:30:40.298843) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-14 10:30:40.299120) ========= /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=20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:30:40 INFO - MultiFileLogger online at 20170914 10:30:40 in /builds/slave/test 10:30:40 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 10:30:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:30:40 INFO - {'append_to_log': False, 10:30:40 INFO - 'base_work_dir': '/builds/slave/test', 10:30:40 INFO - 'blob_upload_branch': 'Firefox', 10:30:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:30:40 INFO - 'branch': 'Firefox', 10:30:40 INFO - 'buildbot_json_path': 'buildprops.json', 10:30:40 INFO - 'code_coverage': False, 10:30:40 INFO - 'config_files': ('talos/linux_config.py',), 10:30:40 INFO - 'default_actions': ('clobber', 10:30:40 INFO - 'read-buildbot-config', 10:30:40 INFO - 'download-and-extract', 10:30:40 INFO - 'populate-webroot', 10:30:40 INFO - 'create-virtualenv', 10:30:40 INFO - 'install', 10:30:40 INFO - 'setup-mitmproxy', 10:30:40 INFO - 'run-tests'), 10:30:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:30:40 INFO - 'disable_ccov_upload': False, 10:30:40 INFO - 'disable_stylo': False, 10:30:40 INFO - 'download_minidump_stackwalk': True, 10:30:40 INFO - 'download_symbols': 'ondemand', 10:30:40 INFO - 'enable_stylo': False, 10:30:40 INFO - 'enable_webrender': False, 10:30:40 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 10:30:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:30:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:30:40 INFO - 'gecko_profile': False, 10:30:40 INFO - 'gecko_profile_interval': 0, 10:30:40 INFO - 'installer_path': 'installer.exe', 10:30:40 INFO - 'log_level': 'info', 10:30:40 INFO - 'log_name': 'talos', 10:30:40 INFO - 'log_to_console': True, 10:30:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:30:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:30:40 INFO - 'opt_config_files': (), 10:30:40 INFO - 'pip_index': False, 10:30:40 INFO - 'suite': 'dromaeojs-e10s', 10:30:40 INFO - 'system_bits': '32', 10:30:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:30:40 INFO - 'title': 'talos-linux64-ix-015', 10:30:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:30:40 INFO - 'use_talos_json': True, 10:30:40 INFO - 'verify': 'False', 10:30:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:30:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:30:40 INFO - 'work_dir': 'build'} 10:30:40 INFO - [mozharness: 2017-09-14 17:30:40.892839Z] Running clobber step. 10:30:40 INFO - Running pre-action listener: _resource_record_pre_action 10:30:40 INFO - Running main action method: clobber 10:30:40 INFO - rmtree: /builds/slave/test/build 10:30:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:30:42 INFO - Running post-action listener: _resource_record_post_action 10:30:42 INFO - [mozharness: 2017-09-14 17:30:42.397657Z] Finished clobber step (success) 10:30:42 INFO - [mozharness: 2017-09-14 17:30:42.397754Z] Running read-buildbot-config step. 10:30:42 INFO - Running pre-action listener: _resource_record_pre_action 10:30:42 INFO - Running main action method: read_buildbot_config 10:30:42 INFO - Using buildbot properties: 10:30:42 INFO - { 10:30:42 INFO - "project": "", 10:30:42 INFO - "product": "firefox", 10:30:42 INFO - "who": "ryanvm@gmail.com", 10:30:42 INFO - "installer_path": "public/build/target.tar.bz2", 10:30:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:30:42 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 10:30:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 10:30:42 INFO - "stage_platform": "linux64-pgo", 10:30:42 INFO - "basedir": "/builds/slave/test", 10:30:42 INFO - "buildnumber": 158, 10:30:42 INFO - "platform": "ubuntu64_hw", 10:30:42 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:30:42 INFO - "slavebuilddir": "test", 10:30:42 INFO - "taskId": "TuD2ahVRSoi5keK-usHTIw", 10:30:42 INFO - "branch": "mozilla-central", 10:30:42 INFO - "script_repo_revision": "production", 10:30:42 INFO - "revision": "943c2c2a1daf5cd0d3287c1974eb510615d5ed5b", 10:30:42 INFO - "slavename": "talos-linux64-ix-015", 10:30:42 INFO - "repo_path": "mozilla-central" 10:30:42 INFO - } 10:30:42 INFO - Finding installer, test and symbols from parent task. 10:30:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TuD2ahVRSoi5keK-usHTIw'}, attempt #1 10:30:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TuD2ahVRSoi5keK-usHTIw'}, attempt #1 10:30:43 INFO - Task dependencies: GExoNZT9Sqq3GjuszWpuhw 10:30:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw'}, attempt #1 10:30:43 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.tar.bz2 10:30:43 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.test_packages.json 10:30:43 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.crashreporter-symbols.zip 10:30:43 INFO - Running post-action listener: _resource_record_post_action 10:30:43 INFO - [mozharness: 2017-09-14 17:30:43.772451Z] Finished read-buildbot-config step (success) 10:30:43 INFO - [mozharness: 2017-09-14 17:30:43.772668Z] Running download-and-extract step. 10:30:43 INFO - Running pre-action listener: _resource_record_pre_action 10:30:43 INFO - Running main action method: download_and_extract 10:30:43 INFO - mkdir: /builds/slave/test/build/tests 10:30: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')]} 10:30:43 INFO - trying https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.test_packages.json 10:30:43 INFO - Downloading https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:30:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:30:44 INFO - Downloaded 989 bytes. 10:30:44 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:30:44 INFO - Using the following test package requirements: 10:30:44 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:30:44 INFO - u'common': [u'target.common.tests.zip'], 10:30:44 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:30:44 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:30:44 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:30:44 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:30:44 INFO - u'mozbase': [u'target.common.tests.zip'], 10:30:44 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:30:44 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:30:44 INFO - u'web-platform': [u'target.common.tests.zip', 10:30:44 INFO - u'target.web-platform.tests.tar.gz'], 10:30:44 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:30:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 10:30:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.common.tests.zip 10:30:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:30:44 INFO - Fetch https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.common.tests.zip into memory 10:30:46 INFO - Content-Length response header: 55193481 10:30:46 INFO - Bytes received: 55193481 10:30:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.talos.tests.zip 10:30:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:30:57 INFO - Fetch https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.talos.tests.zip into memory 10:30:58 INFO - Content-Length response header: 14500356 10:30:58 INFO - Bytes received: 14500356 10:30:59 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')]} 10:30:59 INFO - trying https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.tar.bz2 10:30:59 INFO - Downloading https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:30:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:31:01 INFO - Downloaded 62178071 bytes. 10:31:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.tar.bz2 10:31:01 INFO - mkdir: /builds/slave/test/properties 10:31:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:31:01 INFO - Writing to file /builds/slave/test/properties/build_url 10:31:01 INFO - Contents: 10:31:01 INFO - build_url:https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.tar.bz2 10:31:01 INFO - Running post-action listener: _resource_record_post_action 10:31:01 INFO - Running post-action listener: find_tests_for_verification 10:31:01 INFO - Running post-action listener: set_extra_try_arguments 10:31:01 INFO - [mozharness: 2017-09-14 17:31:01.311932Z] Finished download-and-extract step (success) 10:31:01 INFO - [mozharness: 2017-09-14 17:31:01.312031Z] Running populate-webroot step. 10:31:01 INFO - Running pre-action listener: _resource_record_pre_action 10:31:01 INFO - Running main action method: populate_webroot 10:31:01 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:31:01 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:31:01 INFO - 'tests': ['tresize', 10:31:01 INFO - 'tcanvasmark']}, 10:31:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:31:01 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:31:01 INFO - 'tests': ['dromaeo_css', 10:31:01 INFO - 'kraken']}, 10:31:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:31:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:31:01 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:31:01 INFO - 'talos_options': ['--disable-stylo'], 10:31:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:31:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:31:01 INFO - 'tests': ['damp', 'tps']}, 10:31:01 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:31:01 INFO - 'talos_options': ['--disable-stylo'], 10:31:01 INFO - 'tests': ['damp', 'tps']}, 10:31:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:31:01 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:31:01 INFO - 'tests': ['dromaeo_dom']}, 10:31:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:31:01 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:31:01 INFO - 'tests': ['basic_compositor_video', 10:31:01 INFO - 'glvideo']}, 10:31:01 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:31:01 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:31:01 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:31:01 INFO - 'talos_options': ['--disable-stylo'], 10:31:01 INFO - 'tests': ['ts_paint_webext', 10:31:01 INFO - 'tp5o_webext']}, 10:31:01 INFO - 'other-e10s': {'tests': ['a11yr', 10:31:01 INFO - 'ts_paint', 10:31:01 INFO - 'tpaint', 10:31:01 INFO - 'sessionrestore', 10:31:01 INFO - 'sessionrestore_many_windows', 10:31:01 INFO - 'sessionrestore_no_auto_restore', 10:31:01 INFO - 'tabpaint']}, 10:31:01 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:31:01 INFO - 'tests': ['a11yr', 10:31:01 INFO - 'ts_paint', 10:31:01 INFO - 'tpaint', 10:31:01 INFO - 'sessionrestore', 10:31:01 INFO - 'sessionrestore_many_windows', 10:31:01 INFO - 'sessionrestore_no_auto_restore', 10:31:01 INFO - 'tabpaint']}, 10:31:01 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:31:01 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:31:01 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:31:01 INFO - 'tests': ['bloom_basic_singleton']}, 10:31:01 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:31:01 INFO - 'tests': ['bloom_basic']}, 10:31:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:31:01 INFO - 'tsvgr_opacity', 10:31:01 INFO - 'tart', 10:31:01 INFO - 'tscrollx', 10:31:01 INFO - 'tsvg_static']}, 10:31:01 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:31:01 INFO - 'tests': ['tsvgx', 10:31:01 INFO - 'tsvgr_opacity', 10:31:01 INFO - 'tart', 10:31:01 INFO - 'tscrollx', 10:31:01 INFO - 'tsvg_static']}, 10:31:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:31:01 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:31:01 INFO - 'talos_options': ['--disable-stylo'], 10:31:01 INFO - 'tests': ['tp5o']}, 10:31:01 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:31:01 INFO - 'talos_options': ['--mitmproxy', 10:31:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:31:01 INFO - '--firstNonBlankPaint'], 10:31:01 INFO - 'tests': ['tp6_google', 10:31:01 INFO - 'tp6_youtube', 10:31:01 INFO - 'tp6_amazon', 10:31:01 INFO - 'tp6_facebook']}, 10:31:01 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:31:01 INFO - 'talos_options': ['--disable-stylo', 10:31:01 INFO - '--mitmproxy', 10:31:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:31:01 INFO - '--firstNonBlankPaint'], 10:31:01 INFO - 'tests': ['tp6_google', 10:31:01 INFO - 'tp6_youtube', 10:31:01 INFO - 'tp6_amazon', 10:31:01 INFO - 'tp6_facebook']}, 10:31:01 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:31:01 INFO - 'talos_options': ['--stylo-threads=1', 10:31:01 INFO - '--mitmproxy', 10:31:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:31:01 INFO - '--firstNonBlankPaint'], 10:31:01 INFO - 'tests': ['tp6_google', 10:31:01 INFO - 'tp6_youtube', 10:31:01 INFO - 'tp6_amazon', 10:31:01 INFO - 'tp6_facebook']}, 10:31:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:31:01 INFO - 'talos_options': ['--xperf_path', 10:31:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:31:01 INFO - 'tests': ['tp5n']}, 10:31:01 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:31:01 INFO - 'talos_options': ['--disable-stylo', 10:31:01 INFO - '--xperf_path', 10:31:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:31:01 INFO - 'tests': ['tp5n']}}} 10:31:01 INFO - Running post-action listener: _resource_record_post_action 10:31:01 INFO - [mozharness: 2017-09-14 17:31:01.326937Z] Finished populate-webroot step (success) 10:31:01 INFO - [mozharness: 2017-09-14 17:31:01.327026Z] Running create-virtualenv step. 10:31:01 INFO - Running pre-action listener: _resource_record_pre_action 10:31:01 INFO - Running main action method: create_virtualenv 10:31:01 INFO - Creating virtualenv /builds/slave/test/build/venv 10:31:01 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:31:01 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 10:31:01 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:31:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:31:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:31:01 INFO - Installing distribute.............................................................................................................................................................................................done. 10:31:02 INFO - Installing pip...............done. 10:31:02 INFO - Return code: 0 10:31:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:31:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:31:02 INFO - Reading from file tmpfile_stdout 10:31:02 INFO - Output received: 10:31:02 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 10:31:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:31: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')]} 10:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31: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')]} 10:31:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:02 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 0x1fbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2185a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2328a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c090>, '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 0x232cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2326f90>, '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': '20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697', '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 10:31:02 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 10:31:02 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 10:31:02 INFO - Using env: {'DISPLAY': ':0', 10:31:02 INFO - 'HOME': '/home/cltbld', 10:31:02 INFO - 'LANG': 'en_US.UTF-8', 10:31:02 INFO - 'LANGUAGE': 'en_US:en', 10:31:02 INFO - 'LOGNAME': 'cltbld', 10:31:02 INFO - 'MAIL': '/var/mail/cltbld', 10:31:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:02 INFO - 'MOZ_NO_REMOTE': '1', 10:31:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:02 INFO - 'NO_EM_RESTART': '1', 10:31:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:02 INFO - 'PWD': '/builds/slave/test', 10:31:02 INFO - 'SHELL': '/bin/bash', 10:31:02 INFO - 'SHLVL': '1', 10:31:02 INFO - 'TERM': 'linux', 10:31:02 INFO - 'TMOUT': '86400', 10:31:02 INFO - 'USER': 'cltbld', 10:31:02 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697', 10:31:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:02 INFO - '_': '/tools/buildbot/bin/python'} 10:31:03 INFO - Ignoring indexes: http://pypi.python.org/simple/ 10:31:03 INFO - Downloading/unpacking pip>=1.5 10:31:03 INFO - Running setup.py egg_info for package pip 10:31:03 INFO - warning: no files found matching 'pip/cacert.pem' 10:31:03 INFO - warning: no files found matching '*.html' under directory 'docs' 10:31:03 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 10:31:03 INFO - no previously-included directories found matching 'docs/_build/_sources' 10:31:03 INFO - Installing collected packages: pip 10:31:03 INFO - Found existing installation: pip 1.1 10:31:03 INFO - Uninstalling pip: 10:31:03 INFO - Successfully uninstalled pip 10:31:03 INFO - Running setup.py install for pip 10:31:03 INFO - warning: no files found matching 'pip/cacert.pem' 10:31:03 INFO - warning: no files found matching '*.html' under directory 'docs' 10:31:03 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 10:31:03 INFO - no previously-included directories found matching 'docs/_build/_sources' 10:31:03 INFO - Installing pip script to /builds/slave/test/build/venv/bin 10:31:03 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 10:31:03 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 10:31:03 INFO - Successfully installed pip 10:31:03 INFO - Cleaning up... 10:31:03 INFO - Return code: 0 10:31:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:03 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 0x1fbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2185a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2328a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c090>, '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 0x232cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2326f90>, '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': '20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697', '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 10:31:03 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 10:31:03 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 10:31:03 INFO - Using env: {'DISPLAY': ':0', 10:31:03 INFO - 'HOME': '/home/cltbld', 10:31:03 INFO - 'LANG': 'en_US.UTF-8', 10:31:03 INFO - 'LANGUAGE': 'en_US:en', 10:31:03 INFO - 'LOGNAME': 'cltbld', 10:31:03 INFO - 'MAIL': '/var/mail/cltbld', 10:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:03 INFO - 'MOZ_NO_REMOTE': '1', 10:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:03 INFO - 'NO_EM_RESTART': '1', 10:31:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:03 INFO - 'PWD': '/builds/slave/test', 10:31:03 INFO - 'SHELL': '/bin/bash', 10:31:03 INFO - 'SHLVL': '1', 10:31:03 INFO - 'TERM': 'linux', 10:31:03 INFO - 'TMOUT': '86400', 10:31:03 INFO - 'USER': 'cltbld', 10:31:03 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697', 10:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:03 INFO - '_': '/tools/buildbot/bin/python'} 10:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:03 INFO - Downloading/unpacking psutil>=3.1.1 10:31: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 10:31: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 10:31: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 10:31: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 10:31:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:31:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:31:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:31:05 INFO - Installing collected packages: psutil 10:31:05 INFO - Running setup.py install for psutil 10:31:05 INFO - building 'psutil._psutil_linux' extension 10:31:05 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 10:31:05 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 10:31:05 INFO - building 'psutil._psutil_posix' extension 10:31:05 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 10:31:05 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 10:31:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:31:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:31:05 INFO - Successfully installed psutil 10:31:05 INFO - Cleaning up... 10:31:06 INFO - Return code: 0 10:31:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:06 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 0x1fbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2185a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2328a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c090>, '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 0x232cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2326f90>, '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': '20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697', '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 10:31:06 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 10:31:06 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 10:31:06 INFO - Using env: {'DISPLAY': ':0', 10:31:06 INFO - 'HOME': '/home/cltbld', 10:31:06 INFO - 'LANG': 'en_US.UTF-8', 10:31:06 INFO - 'LANGUAGE': 'en_US:en', 10:31:06 INFO - 'LOGNAME': 'cltbld', 10:31:06 INFO - 'MAIL': '/var/mail/cltbld', 10:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:06 INFO - 'MOZ_NO_REMOTE': '1', 10:31:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:06 INFO - 'NO_EM_RESTART': '1', 10:31:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:06 INFO - 'PWD': '/builds/slave/test', 10:31:06 INFO - 'SHELL': '/bin/bash', 10:31:06 INFO - 'SHLVL': '1', 10:31:06 INFO - 'TERM': 'linux', 10:31:06 INFO - 'TMOUT': '86400', 10:31:06 INFO - 'USER': 'cltbld', 10:31:06 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697', 10:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:06 INFO - '_': '/tools/buildbot/bin/python'} 10:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:31:06 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 10:31:06 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 10:31:06 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 10:31:06 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 10:31:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:31:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:31:07 INFO - Installing collected packages: mozsystemmonitor 10:31:07 INFO - Running setup.py install for mozsystemmonitor 10:31:07 INFO - Successfully installed mozsystemmonitor 10:31:07 INFO - Cleaning up... 10:31:08 INFO - Return code: 0 10:31:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:31:08 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')]} 10:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:08 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')]} 10:31:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:08 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 0x1fbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2185a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2328a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c090>, '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 0x232cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2326f90>, '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': '20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697', '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 10:31:08 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 10:31:08 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 10:31:08 INFO - Using env: {'DISPLAY': ':0', 10:31:08 INFO - 'HOME': '/home/cltbld', 10:31:08 INFO - 'LANG': 'en_US.UTF-8', 10:31:08 INFO - 'LANGUAGE': 'en_US:en', 10:31:08 INFO - 'LOGNAME': 'cltbld', 10:31:08 INFO - 'MAIL': '/var/mail/cltbld', 10:31:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:08 INFO - 'MOZ_NO_REMOTE': '1', 10:31:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:08 INFO - 'NO_EM_RESTART': '1', 10:31:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:08 INFO - 'PWD': '/builds/slave/test', 10:31:08 INFO - 'SHELL': '/bin/bash', 10:31:08 INFO - 'SHLVL': '1', 10:31:08 INFO - 'TERM': 'linux', 10:31:08 INFO - 'TMOUT': '86400', 10:31:08 INFO - 'USER': 'cltbld', 10:31:08 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697', 10:31:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:08 INFO - '_': '/tools/buildbot/bin/python'} 10:31:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:08 INFO - Downloading/unpacking jsonschema==2.5.1 10:31:08 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 10:31:08 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 10:31:08 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 10:31:08 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 10:31:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:31:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:09 INFO - Downloading functools32-3.2.3-2.tar.gz 10:31:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:31:09 INFO - warning: no files found matching '*.txt' 10:31:09 INFO - no previously-included directories found matching 'build' 10:31:09 INFO - no previously-included directories found matching 'dist' 10:31:09 INFO - no previously-included directories found matching '.git*' 10:31:09 INFO - Installing collected packages: jsonschema, functools32 10:31:09 INFO - Running setup.py install for functools32 10:31:09 INFO - warning: no files found matching '*.txt' 10:31:09 INFO - no previously-included directories found matching 'build' 10:31:09 INFO - no previously-included directories found matching 'dist' 10:31:09 INFO - no previously-included directories found matching '.git*' 10:31:09 INFO - Successfully installed jsonschema functools32 10:31:09 INFO - Cleaning up... 10:31:10 INFO - Return code: 0 10:31:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:31:10 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')]} 10:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:10 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')]} 10:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:10 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 0x1fbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2185a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2328a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c090>, '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 0x232cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2326f90>, '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': '20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697', '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 10:31:10 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 10:31:10 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 10:31:10 INFO - Using env: {'DISPLAY': ':0', 10:31:10 INFO - 'HOME': '/home/cltbld', 10:31:10 INFO - 'LANG': 'en_US.UTF-8', 10:31:10 INFO - 'LANGUAGE': 'en_US:en', 10:31:10 INFO - 'LOGNAME': 'cltbld', 10:31:10 INFO - 'MAIL': '/var/mail/cltbld', 10:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:10 INFO - 'MOZ_NO_REMOTE': '1', 10:31:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:10 INFO - 'NO_EM_RESTART': '1', 10:31:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:10 INFO - 'PWD': '/builds/slave/test', 10:31:10 INFO - 'SHELL': '/bin/bash', 10:31:10 INFO - 'SHLVL': '1', 10:31:10 INFO - 'TERM': 'linux', 10:31:10 INFO - 'TMOUT': '86400', 10:31:10 INFO - 'USER': 'cltbld', 10:31:10 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697', 10:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:10 INFO - '_': '/tools/buildbot/bin/python'} 10:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:31:10 INFO - Cleaning up... 10:31:10 INFO - Return code: 0 10:31:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:31:10 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')]} 10:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:10 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')]} 10:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:10 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 0x1fbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2185a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2328a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c090>, '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 0x232cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2326f90>, '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': '20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697', '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 10:31:10 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 10:31:10 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 10:31:10 INFO - Using env: {'DISPLAY': ':0', 10:31:10 INFO - 'HOME': '/home/cltbld', 10:31:10 INFO - 'LANG': 'en_US.UTF-8', 10:31:10 INFO - 'LANGUAGE': 'en_US:en', 10:31:10 INFO - 'LOGNAME': 'cltbld', 10:31:10 INFO - 'MAIL': '/var/mail/cltbld', 10:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:10 INFO - 'MOZ_NO_REMOTE': '1', 10:31:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:10 INFO - 'NO_EM_RESTART': '1', 10:31:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:10 INFO - 'PWD': '/builds/slave/test', 10:31:10 INFO - 'SHELL': '/bin/bash', 10:31:10 INFO - 'SHLVL': '1', 10:31:10 INFO - 'TERM': 'linux', 10:31:10 INFO - 'TMOUT': '86400', 10:31:10 INFO - 'USER': 'cltbld', 10:31:10 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697', 10:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:10 INFO - '_': '/tools/buildbot/bin/python'} 10:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:10 INFO - Downloading/unpacking blobuploader==1.2.4 10:31:10 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 10:31:10 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 10:31:10 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 10:31:10 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 10:31:11 INFO - Downloading blobuploader-1.2.4.tar.gz 10:31:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:31:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:31:11 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 10:31:11 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 10:31:11 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 10:31:11 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 10:31:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:31:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:31:11 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 10:31:11 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 10:31:11 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 10:31:11 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 10:31:12 INFO - Downloading docopt-0.6.1.tar.gz 10:31:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:31:12 INFO - Installing collected packages: blobuploader, requests, docopt 10:31:12 INFO - Running setup.py install for blobuploader 10:31:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:31:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:31:12 INFO - Running setup.py install for requests 10:31:12 INFO - Running setup.py install for docopt 10:31:12 INFO - Successfully installed blobuploader requests docopt 10:31:12 INFO - Cleaning up... 10:31:12 INFO - Return code: 0 10:31:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:12 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 0x1fbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2185a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2328a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c090>, '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 0x232cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2326f90>, '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': '20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697', '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 10:31:12 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 10:31:12 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 10:31:12 INFO - Using env: {'DISPLAY': ':0', 10:31:12 INFO - 'HOME': '/home/cltbld', 10:31:12 INFO - 'LANG': 'en_US.UTF-8', 10:31:12 INFO - 'LANGUAGE': 'en_US:en', 10:31:12 INFO - 'LOGNAME': 'cltbld', 10:31:12 INFO - 'MAIL': '/var/mail/cltbld', 10:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:12 INFO - 'MOZ_NO_REMOTE': '1', 10:31:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:12 INFO - 'NO_EM_RESTART': '1', 10:31:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:12 INFO - 'PWD': '/builds/slave/test', 10:31:12 INFO - 'SHELL': '/bin/bash', 10:31:12 INFO - 'SHLVL': '1', 10:31:12 INFO - 'TERM': 'linux', 10:31:12 INFO - 'TMOUT': '86400', 10:31:12 INFO - 'USER': 'cltbld', 10:31:12 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697', 10:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:12 INFO - '_': '/tools/buildbot/bin/python'} 10:31:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:31:12 INFO - Running setup.py (path:/tmp/pip-WX8scO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:31:13 INFO - Running setup.py (path:/tmp/pip-ZrmJ8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:31:13 INFO - Running setup.py (path:/tmp/pip-nvS3CJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:31:13 INFO - Running setup.py (path:/tmp/pip-2Eqy5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:31:13 INFO - Running setup.py (path:/tmp/pip-8qXu2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:31:13 INFO - Running setup.py (path:/tmp/pip-9UgtXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:31:13 INFO - Running setup.py (path:/tmp/pip-uj7hEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:31:13 INFO - Running setup.py (path:/tmp/pip-fVenwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:31:13 INFO - Running setup.py (path:/tmp/pip-0neyRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:31:13 INFO - Running setup.py (path:/tmp/pip-HUQpeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:31:13 INFO - Running setup.py (path:/tmp/pip-TYs4W8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:31:13 INFO - Running setup.py (path:/tmp/pip-a31JLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:31:13 INFO - Running setup.py (path:/tmp/pip-rxkU4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:31:13 INFO - Running setup.py (path:/tmp/pip-Vx9aJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:13 INFO - Running setup.py (path:/tmp/pip-uFbRUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:31:14 INFO - Running setup.py (path:/tmp/pip-z0jcDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:31:14 INFO - Running setup.py (path:/tmp/pip-8GMbM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:31:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:31:14 INFO - Running setup.py install for manifestparser 10:31:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:31:14 INFO - Running setup.py install for mozcrash 10:31:14 INFO - Running setup.py install for mozdebug 10:31:14 INFO - Running setup.py install for mozdevice 10:31:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:31:14 INFO - Running setup.py install for mozfile 10:31:14 INFO - Running setup.py install for mozhttpd 10:31:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:31:14 INFO - Running setup.py install for mozinfo 10:31:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:31:14 INFO - Running setup.py install for mozInstall 10:31:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:31:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:31:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:31:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:31:14 INFO - Running setup.py install for mozleak 10:31:15 INFO - Running setup.py install for mozlog 10:31:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:31:15 INFO - Running setup.py install for moznetwork 10:31:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:31:15 INFO - Running setup.py install for mozprocess 10:31:15 INFO - Running setup.py install for mozprofile 10:31:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:31:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:31:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:31:15 INFO - Running setup.py install for mozrunner 10:31:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:31:15 INFO - Running setup.py install for mozscreenshot 10:31:15 INFO - Running setup.py install for moztest 10:31:15 INFO - Running setup.py install for mozversion 10:31:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:31:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:31:15 INFO - Cleaning up... 10:31:15 INFO - Return code: 0 10:31:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:31:15 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')]} 10:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:15 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')]} 10:31:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:15 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 0x1fbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2185a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2328a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c090>, '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 0x232cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2326f90>, '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': '20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697', '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 10:31:15 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 10:31:15 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 10:31:15 INFO - Using env: {'DISPLAY': ':0', 10:31:15 INFO - 'HOME': '/home/cltbld', 10:31:15 INFO - 'LANG': 'en_US.UTF-8', 10:31:15 INFO - 'LANGUAGE': 'en_US:en', 10:31:15 INFO - 'LOGNAME': 'cltbld', 10:31:15 INFO - 'MAIL': '/var/mail/cltbld', 10:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:15 INFO - 'MOZ_NO_REMOTE': '1', 10:31:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:15 INFO - 'NO_EM_RESTART': '1', 10:31:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:15 INFO - 'PWD': '/builds/slave/test', 10:31:15 INFO - 'SHELL': '/bin/bash', 10:31:15 INFO - 'SHLVL': '1', 10:31:15 INFO - 'TERM': 'linux', 10:31:15 INFO - 'TMOUT': '86400', 10:31:15 INFO - 'USER': 'cltbld', 10:31:15 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697', 10:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:15 INFO - '_': '/tools/buildbot/bin/python'} 10:31:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:31:16 INFO - Running setup.py (path:/tmp/pip-5dfyiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:31:16 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)) 10:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:31:16 INFO - Running setup.py (path:/tmp/pip-16xvOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:31:16 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)) 10:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:31:16 INFO - Running setup.py (path:/tmp/pip-qoBWrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:31:16 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)) 10:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:31:16 INFO - Running setup.py (path:/tmp/pip-DM7uwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:31:16 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)) 10:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:31:16 INFO - Running setup.py (path:/tmp/pip-Suv7YK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:31:16 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)) 10:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:31:16 INFO - Running setup.py (path:/tmp/pip-I40NX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:31:16 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)) 10:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:31:16 INFO - Running setup.py (path:/tmp/pip-2g75OT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:31:16 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)) 10:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:31:16 INFO - Running setup.py (path:/tmp/pip-7RaNzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:31:16 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)) 10:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:31:16 INFO - Running setup.py (path:/tmp/pip-7XCgKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:31:16 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)) 10:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:31:16 INFO - Running setup.py (path:/tmp/pip-wDGJVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:31:16 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)) 10:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:31:16 INFO - Running setup.py (path:/tmp/pip-El5KTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:31:16 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)) 10:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:31:16 INFO - Running setup.py (path:/tmp/pip-ui2DyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:31:17 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)) 10:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:31:17 INFO - Running setup.py (path:/tmp/pip-l8RvHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:31:17 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)) 10:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:31:17 INFO - Running setup.py (path:/tmp/pip-sRD25P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:31:17 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)) 10:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:17 INFO - Running setup.py (path:/tmp/pip-609y3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:17 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)) 10:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:31:17 INFO - Running setup.py (path:/tmp/pip-DL9z1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:31:17 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)) 10:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:31:17 INFO - Running setup.py (path:/tmp/pip-NR0_QX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:31:17 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)) 10:31:17 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)) 10:31:17 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)) 10:31:17 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)) 10:31:17 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)) 10:31:17 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)) 10:31:17 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)) 10:31:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:31:17 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 10:31:17 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 10:31:17 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 10:31:17 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 10:31:18 INFO - Downloading blessings-1.6.tar.gz 10:31:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:31:18 INFO - Installing collected packages: blessings 10:31:18 INFO - Running setup.py install for blessings 10:31:18 INFO - Successfully installed blessings 10:31:18 INFO - Cleaning up... 10:31:18 INFO - Return code: 0 10:31:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:31:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:31:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:31:18 INFO - Reading from file tmpfile_stdout 10:31:18 INFO - Current package versions: 10:31:18 INFO - argparse == 1.2.1 10:31:18 INFO - blessings == 1.6 10:31:18 INFO - blobuploader == 1.2.4 10:31:18 INFO - docopt == 0.6.1 10:31:18 INFO - functools32 == 3.2.3-2 10:31:18 INFO - jsonschema == 2.5.1 10:31:18 INFO - manifestparser == 1.1 10:31:18 INFO - mozInstall == 1.13 10:31:18 INFO - mozcrash == 1.0 10:31:18 INFO - mozdebug == 0.1 10:31:18 INFO - mozdevice == 0.51 10:31:18 INFO - mozfile == 1.2 10:31:18 INFO - mozhttpd == 0.7 10:31:18 INFO - mozinfo == 0.10 10:31:18 INFO - mozleak == 0.1 10:31:18 INFO - mozlog == 3.5 10:31:18 INFO - moznetwork == 0.27 10:31:18 INFO - mozprocess == 0.25 10:31:18 INFO - mozprofile == 0.28 10:31:18 INFO - mozrunner == 6.13 10:31:18 INFO - mozscreenshot == 0.1 10:31:18 INFO - mozsystemmonitor == 0.3 10:31:18 INFO - moztest == 0.8 10:31:18 INFO - mozversion == 1.4 10:31:18 INFO - psutil == 3.1.1 10:31:18 INFO - requests == 1.2.3 10:31:18 INFO - wsgiref == 0.1.2 10:31:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:31:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:18 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 0x1fbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2185a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2328a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c090>, '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 0x232cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2326f90>, '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': '20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697', '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 10:31:18 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 10:31:18 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 10:31:18 INFO - Using env: {'DISPLAY': ':0', 10:31:18 INFO - 'HOME': '/home/cltbld', 10:31:18 INFO - 'LANG': 'en_US.UTF-8', 10:31:18 INFO - 'LANGUAGE': 'en_US:en', 10:31:18 INFO - 'LOGNAME': 'cltbld', 10:31:18 INFO - 'MAIL': '/var/mail/cltbld', 10:31:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:18 INFO - 'MOZ_NO_REMOTE': '1', 10:31:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:18 INFO - 'NO_EM_RESTART': '1', 10:31:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:18 INFO - 'PWD': '/builds/slave/test', 10:31:18 INFO - 'SHELL': '/bin/bash', 10:31:18 INFO - 'SHLVL': '1', 10:31:18 INFO - 'TERM': 'linux', 10:31:18 INFO - 'TMOUT': '86400', 10:31:18 INFO - 'USER': 'cltbld', 10:31:18 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697', 10:31:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:18 INFO - '_': '/tools/buildbot/bin/python'} 10:31:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:19 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)) 10:31:19 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)) 10:31:19 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)) 10:31:19 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)) 10:31:19 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)) 10:31:19 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)) 10:31:19 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)) 10:31:19 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)) 10:31:19 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)) 10:31:19 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:31:20 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)) 10:31:20 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)) 10:31:20 INFO - Installing collected packages: simplejson 10:31:20 INFO - Running setup.py install for simplejson 10:31:20 INFO - building 'simplejson._speedups' extension 10:31:20 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 10:31:21 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 10:31:21 INFO - Successfully installed simplejson 10:31:21 INFO - Cleaning up... 10:31:21 INFO - Return code: 0 10:31:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:31:21 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')]} 10:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:21 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')]} 10:31:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:21 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 0x1fbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2185a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2328a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c090>, '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 0x232cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2326f90>, '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': '20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697', '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 10:31:21 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 10:31:21 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 10:31:21 INFO - Using env: {'DISPLAY': ':0', 10:31:21 INFO - 'HOME': '/home/cltbld', 10:31:21 INFO - 'LANG': 'en_US.UTF-8', 10:31:21 INFO - 'LANGUAGE': 'en_US:en', 10:31:21 INFO - 'LOGNAME': 'cltbld', 10:31:21 INFO - 'MAIL': '/var/mail/cltbld', 10:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:21 INFO - 'MOZ_NO_REMOTE': '1', 10:31:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:21 INFO - 'NO_EM_RESTART': '1', 10:31:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:21 INFO - 'PWD': '/builds/slave/test', 10:31:21 INFO - 'SHELL': '/bin/bash', 10:31:21 INFO - 'SHLVL': '1', 10:31:21 INFO - 'TERM': 'linux', 10:31:21 INFO - 'TMOUT': '86400', 10:31:21 INFO - 'USER': 'cltbld', 10:31:21 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697', 10:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:21 INFO - '_': '/tools/buildbot/bin/python'} 10:31:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:31:21 INFO - Cleaning up... 10:31:21 INFO - Return code: 0 10:31:21 INFO - Running post-action listener: _resource_record_post_action 10:31:21 INFO - Running post-action listener: _start_resource_monitoring 10:31:21 INFO - Starting resource monitoring. 10:31:21 INFO - [mozharness: 2017-09-14 17:31:21.688746Z] Finished create-virtualenv step (success) 10:31:21 INFO - [mozharness: 2017-09-14 17:31:21.689262Z] Running install step. 10:31:21 INFO - Running pre-action listener: _resource_record_pre_action 10:31:21 INFO - Running main action method: install 10:31:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:31:21 INFO - Reading from file tmpfile_stdout 10:31:21 INFO - Detecting whether we're running mozinstall >=1.0... 10:31:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:31:22 INFO - Reading from file tmpfile_stdout 10:31:22 INFO - Output received: 10:31:22 INFO - Usage: mozinstall [options] installer 10:31:22 INFO - Options: 10:31:22 INFO - -h, --help show this help message and exit 10:31:22 INFO - -d DEST, --destination=DEST 10:31:22 INFO - Directory to install application into. [default: 10:31:22 INFO - "/builds/slave/test"] 10:31:22 INFO - --app=APP Application being installed. [default: firefox] 10:31:22 INFO - mkdir: /builds/slave/test/build/application 10:31:22 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'] 10:31:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:31:40 INFO - Reading from file tmpfile_stdout 10:31:40 INFO - Output received: 10:31:40 INFO - /builds/slave/test/build/application/firefox/firefox 10:31:40 INFO - Running post-action listener: _resource_record_post_action 10:31:40 INFO - [mozharness: 2017-09-14 17:31:40.389469Z] Finished install step (success) 10:31:40 INFO - [mozharness: 2017-09-14 17:31:40.389720Z] Running setup-mitmproxy step. 10:31:40 INFO - Running pre-action listener: _resource_record_pre_action 10:31:40 INFO - Running main action method: setup_mitmproxy 10:31:40 INFO - Skipping: mitmproxy is not required 10:31:40 INFO - Running post-action listener: _resource_record_post_action 10:31:40 INFO - [mozharness: 2017-09-14 17:31:40.390844Z] Finished setup-mitmproxy step (success) 10:31:40 INFO - [mozharness: 2017-09-14 17:31:40.391063Z] Running run-tests step. 10:31:40 INFO - Running pre-action listener: _resource_record_pre_action 10:31:40 INFO - Running pre-action listener: _set_gcov_prefix 10:31:40 INFO - Running main action method: run_tests 10:31:40 WARNING - Try message not found. 10:31:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:31:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:31:40 INFO - Python 2.7.3 10:31:40 INFO - Return code: 0 10:31:40 INFO - grabbing minidump binary from tooltool 10:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:40 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 0x232c090>, '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 0x232cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2326f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:31:40 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 10:31:40 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 10:31:40 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 10:31:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:31:40 INFO - Return code: 0 10:31:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:31:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:31:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:31:40 INFO - ENV: RUST_BACKTRACE is now full 10:31:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:31:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:31:40 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/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 10:31:40 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/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 10:31:40 INFO - Using env: {'DISPLAY': ':0', 10:31:40 INFO - 'HOME': '/home/cltbld', 10:31:40 INFO - 'LANG': 'en_US.UTF-8', 10:31:40 INFO - 'LANGUAGE': 'en_US:en', 10:31:40 INFO - 'LOGNAME': 'cltbld', 10:31:40 INFO - 'MAIL': '/var/mail/cltbld', 10:31:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:31:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:40 INFO - 'MOZ_NO_REMOTE': '1', 10:31:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:31:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:40 INFO - 'NO_EM_RESTART': '1', 10:31:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:40 INFO - 'PWD': '/builds/slave/test', 10:31:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:31:40 INFO - 'RUST_BACKTRACE': 'full', 10:31:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:31:40 INFO - 'SHELL': '/bin/bash', 10:31:40 INFO - 'SHLVL': '1', 10:31:40 INFO - 'TERM': 'linux', 10:31:40 INFO - 'TMOUT': '86400', 10:31:40 INFO - 'USER': 'cltbld', 10:31:40 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697', 10:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:40 INFO - '_': '/tools/buildbot/bin/python'} 10:31:40 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/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 10:31:40 INFO - mozversion application_buildid: 20170914161400 10:31:40 INFO - mozversion application_changeset: 943c2c2a1daf5cd0d3287c1974eb510615d5ed5b 10:31:40 INFO - mozversion application_display_name: Nightly 10:31:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:31:40 INFO - mozversion application_name: Firefox 10:31:40 INFO - mozversion application_remotingname: firefox 10:31:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:31:40 INFO - mozversion application_vendor: Mozilla 10:31:40 INFO - mozversion application_version: 57.0a1 10:31:40 INFO - mozversion platform_buildid: 20170914161400 10:31:40 INFO - mozversion platform_changeset: 943c2c2a1daf5cd0d3287c1974eb510615d5ed5b 10:31:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:31:40 INFO - mozversion platform_version: 57.0a1 10:31:40 INFO - using testdate: 1505410300 10:31:40 INFO - actual date: 1505410300 10:31:40 INFO - starting webserver on 'localhost:37962' 10:31:40 INFO - SUITE-START | Running 2 tests 10:31:40 INFO - TEST-START | dromaeo_css 10:31:40 INFO - Initialising browser for dromaeo_css test... 10:31:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37962/getInfo.html -profile /tmp/tmpnlI9IH/profile 10:31:40 INFO - TEST-INFO | started process 18302 (/builds/slave/test/build/application/firefox/firefox http://localhost:37962/getInfo.html) 10:31:46 INFO - TEST-INFO | 18302: exit 0 10:31:46 INFO - Browser initialized. 10:31:46 INFO - Running cycle 1/1 for dromaeo_css test... 10:31:46 INFO - Using env: {'DISPLAY': ':0', 10:31:46 INFO - 'HOME': '/home/cltbld', 10:31:46 INFO - 'JSGC_DISABLE_POISONING': '1', 10:31:46 INFO - 'LANG': 'en_US.UTF-8', 10:31:46 INFO - 'LANGUAGE': 'en_US:en', 10:31:46 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 10:31:46 INFO - 'LOGNAME': 'cltbld', 10:31:46 INFO - 'MAIL': '/var/mail/cltbld', 10:31:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:31:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:31:46 INFO - 'MOZ_CRASHREPORTER': '1', 10:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:46 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 10:31:46 INFO - 'MOZ_NO_REMOTE': '1', 10:31:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:46 INFO - 'NO_EM_RESTART': '1', 10:31:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:46 INFO - 'PWD': '/builds/slave/test', 10:31:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:31:46 INFO - 'RUST_BACKTRACE': 'full', 10:31:46 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:31:46 INFO - 'SHELL': '/bin/bash', 10:31:46 INFO - 'SHLVL': '1', 10:31:46 INFO - 'TERM': 'linux', 10:31:46 INFO - 'TMOUT': '86400', 10:31:46 INFO - 'USER': 'cltbld', 10:31:46 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697', 10:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:46 INFO - '_': '/tools/buildbot/bin/python'} 10:31:46 INFO - TEST-INFO | started process 18538 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnlI9IH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:31:47 INFO - PID 18538 | 10:31:47 INFO - PID 18538 | (/builds/slave/test/build/application/firefox/firefox:18588): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:31:47 INFO - PID 18538 | 10:31:58 INFO - PID 18538 | RSS: Main: 164442112 10:31:58 INFO - PID 18538 | 10:34:55 INFO - PID 18538 | Cycle 1(1): loaded http://localhost:37962/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37962/tests/dromaeo/cssquery-ext.html) 10:34:56 INFO - PID 18538 | RSS: Main: 168980480 10:34:56 INFO - PID 18538 | 10:37:58 INFO - PID 18538 | Cycle 1(1): loaded http://localhost:37962/tests/dromaeo/cssquery-ext.html (next: http://localhost:37962/tests/dromaeo/cssquery-jquery.html) 10:37:59 INFO - PID 18538 | RSS: Main: 164876288 10:37:59 INFO - PID 18538 | 10:41:00 INFO - PID 18538 | Cycle 1(1): loaded http://localhost:37962/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37962/tests/dromaeo/cssquery-mootools.html) 10:41:01 INFO - PID 18538 | RSS: Main: 167571456 10:41:01 INFO - PID 18538 | 10:44:02 INFO - PID 18538 | Cycle 1(1): loaded http://localhost:37962/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37962/tests/dromaeo/cssquery-prototype.html) 10:44:03 INFO - PID 18538 | RSS: Main: 165982208 10:44:03 INFO - PID 18538 | 10:47:06 INFO - PID 18538 | Cycle 1(1): loaded http://localhost:37962/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37962/tests/dromaeo/cssquery-yui.html) 10:47:07 INFO - PID 18538 | RSS: Main: 166916096 10:47:07 INFO - PID 18538 | 10:50:08 INFO - PID 18538 | Cycle 1(1): loaded http://localhost:37962/tests/dromaeo/cssquery-yui.html (next: http://localhost:37962/tests/dromaeo/cssquery-dojo.html) 10:50:08 INFO - PID 18538 | RSS: Main: 170450944 10:50:08 INFO - PID 18538 | 10:50:08 INFO - PID 18538 | __start_tp_report 10:50:08 INFO - PID 18538 | _x_x_mozilla_page_load 10:50:08 INFO - PID 18538 | _x_x_mozilla_page_load_details 10:50:08 INFO - PID 18538 | |i|pagename|runs| 10:50:08 INFO - PID 18538 | |0;dojo.html;3839.7312188146825;3872.6514613684762;3872.8838134855955;3885.8445662173513;3889.124946886953;6132.938670613293;6323.922498227096;6327.873442531152;6407;6448.193975753031;6349.619022858632;6424.6145231286155;6457.741690332393;6477.611343319404;6506.902396464056;5450.127979523277;5499.092649712793;5752.769889204426;5778.306603207621;5786.334571524266;5673.319201695802;5734.684592347419;5759.16492108644;5781.710914454282;5828.358880523139;5589.888202235953;5640.492355688008;5641.830745077655;5659.8585035374035;5668.546516278729;5667.8583035424035;5717.2281741965135;5759.251297331362;5764.106563482667;5765.8558536036935;5679.290088738908;5744.655320680731;5762.683052432115;5771.336296325934;5771.567132465082;6380.744770209186;6382.808515744535;6388.616682999035;6435.806925792233;6448.903686373281;6700.698468568926;6805.251422343587;6815.625140617264;6909.067275917787;6989.510734248604;6861.176658800976;6943.548669336527;6969.23338432772;6975.8604827903155;6983.441324694012;6340.904886426707;6443.903341449882;6448.484121270287;6534.869302613921;6558.93441065588;7063.364297213276;7082.787516374517;7184.281571842774;7185.2814718527725;7195.064641596559;6774.187097548326;6780.525363224626;6864.24493305736;6872.518923675295;6875.5530890491955;6822.761203357958;6873.725050998004;6898.448124150056;6973.651317434108;6987.825304367329;6812.591244525344;6849.965750171317;6872.278410766898;6874.450043996469;6917.239103698589;6892.827679308058;6942.028116063755;6977.1278590176225;6994.195667498303;6997;5027.547520723152;5032.6980381177245;5046.1169295373165;5080.923786143211;5093.796248150033;4532.410786597721;4554.3851580036935;4569.771511424482;4639.280911458729;4656.115338085753;6414.262359828679;6425.775097871552;6468.5472016958365;6495.3179916109075;6507.154069970874;6929.618870962146;6941.097657304518;7013.228544860061;7023.929760702327;7047.647617619098;6302.149209856702;6328.493720502349;6360.7137678804565;6377.840553986188;6380.872382552323;5574.9721251393485;5596.300462442195;5613.326400831927;5635.21107045014;5639.182318563785;7129.18014428337;7145.8928116078305;7146.821329466805;7277.9636101820215;7288.526245794006;6860.108185935996;6861.108055952894;6921.204061532988;6924.169099708067;6941.0629565010095;7114.430845532242;7159.785206443815;7163.856722865409;7182.89225661605;7193.028941092885;6776.288489708707;6781.593104413751;6783.18601767791;6873.48448866327;6876.724931002704;6845.520813543004;6889.276625954403;6947.40947019509;6954.3045695430055;6957.060796792368;6575.769848055295;6594.769183078569;6607.141071660845;6613.636250006296;6643.169603799525;6527.184101987252;6677.399034086956;6724.125863637696;6744.662766861539;6748.392644662004;6547.574407663486;6563.113979612691;6639.2364878037715;6649.301823308677;6666.566673166229;6406.1031455597185;6597.60414375139;6671.566348187353;6682.097916781172;6789.626570538668;6554.934450655433;6563.901541476977;6569.146011018728;6614.570052946543;6618.867622647424 10:50:08 INFO - PID 18538 | |1;ext.html;952.2477242978047;978.5303054533823;981.5681100315855;982.3025651787231;982.7592239901226;41258.793706031465;45700.08599828002;45856.77071614641;45904.3114353285;45905.77047114764;41779.79110104445;41893.7905310473;42006.7899660502;42056;42114;7483.812904677386;8125.75622731319;8318.83362332756;8322.625481853302;8325.66697332106;8010.078840933309;8023.117457079717;8074.9596252018655;8080.878786818203;8083.797905052391;8029.799255018613;8060.798480038016;8125.1062383138105;8137.349012079019;8138.104808471093;8063.919360806375;8098.716544920959;8105.959470202641;8107.22981316774;8120.837583248361;8208.794780130485;8237.341012718967;8256.339492840558;8259.132791056913;8260.504369737835;40871.795641021905;41182.38226426606;41301.58698413037;41377.58622413797;41444.79277603623;3714.8699795507027;3762;3765.2281282337053;3777.414500752388;3788.9959160822405;33929.32141357184;33963.83018084918;33970.150746231295;33991.4901276481;34002.48996265058;5308;5514.80698175566;5556.555475561986;5571.0807716726695;5700.914486282709;207033.96483017638;208502;209179;209469;210490;45552.3167152493;46590.53409465862;51539;51615.74192129015;53001.734991324796;56275.43724562702;56278.15582766262;56417.717911411004;56437;56467.58831029175;17039.381258780395;17160.82839171617;17161.570960726083;17165.57086072858;17177.570560735832;13941.930290348484;13964.231967241696;13967.580972570839;13970.371333289822;14214.715705685829;15594.766078508832;15613.843861561467;15615.141167235912;15679.216039197994;15681.05913645185;5991.55063370249;6012.849678758066;6113.205283313141;6145.96927015371;6236.968815155895;1088.88022317545;1097.0839349143555;1103.426218366445;1109.9334039957628;1110.955561777536;26001.089961851245;26111.73888261093;26155.08457204027;26415.33961650974;26454;1191.874853140425;1200.5317926008863;1235.5366737473448;1235.8887700106854;1247.9376031198403;13478.797818032737;13514.662133446545;13643.59069227905;13732.45070197181;13924;273988;274384;275826;276118;276989.61505192344;57260;57324;57342.42657573454;57342.7132864333;57477.42522574721;1514.6364872430538;1518.3926429428318;1534.1485475561171;1548.6670365871391;1552.6661767719995;24859.378515537257;25279.36801579975;25283.494330113663;25356.366090847878;25672.358191045372;41136.79431602823;41186.1762764749;41262.1747565053;41393.58606414018;41395.379069314586;219564;219815;219903;220674;220749;36602.633973659926;39173.41239881347;39607.2078558433;39964.800175998935;40054.399184012844;50348.49651503438;51589.484105158466;51721.7413912928;51840;51944.48055519548;37211.25577488381;37451.43822842714;37527.624723752415;37553.62446375501;37712;37078.8146059268;37269;37310.253794924494;37448;37589.81205093957;43540.346894797236;43586.34620480759;43588.56411435972;43817;44002.779986099864;35175.12062198466;36028.819855900554;36145;36508.26983460369;36653.45019824758;25933.740662593886;26334.868325658248;26807.195784126507;26987.865060675358;27011.054613088447 10:50:08 INFO - PID 18538 | |2;jquery.html;589.6668382363964;599.4275466929083;606.6966516741629;613.3927411862257;620.857202843346;22763.203287884928;23279.883600581972;23475.530489390225;23493.88253058732;23502.764972350273;24081;26586.867065664646;26733.598996015076;26759;26811;6714;6798.0822588950605;6831.795046148623;6838.2819803920365;6872.965635171817;6315.621062736228;6564.5404821662505;6569.671516424183;6772.864542709143;6863.897041544381;6517.902231466508;6519.706613202417;6525.575837570543;6526.608403495782;6527.510436717242;6382.106505089291;6535.21577410709;6544.640044797534;6557.868842623168;6577.375149360803;6185.443310102068;6187.443130118311;6196;6196.969015154896;6211.09939058834;30104.69895301063;30466.54300185499;30602.387952241053;30719.232019199477;30722.231944201572;2238.82089432845;2275.1354485295647;2275.7155355580553;2276.6129757941026;2276.6243569810963;20070.49823754403;20451.079701413473;21037.158513659437;21044.789552104437;21083.578328433498;2502.1617758051075;2503.161440917295;2557.744225577446;2560.9359766005814;2579.909703160399;131523;136850.31574842162;138679.30660346634;147180;147611;15696.529104126894;16323.183840807913;16387.098709570848;16411.753823692656;16726.581835453966;25947.740522594533;26027.609585856226;26037.73962260391;26100.8694956524;26105.216843494727;10885;10935.56257749681;10948.124150067975;11076.11391088711;11166.106711463064;10069.093781559548;10194.388336699822;10201.744956376002;10276.845847312296;10305.639302624522;9709.126178643955;9742.220622350194;9806.215502759762;9863.112319891245;10055.59777608902;2720.1975417251956;2751.147144385247;2756.641636587231;2792.944141117166;2796.706345833699;1011.5599714124379;1048.951048951049;1050.2333296693457;1064.9361038337724;1079.611339917629;20793.688094678593;20962.213050039463;21041.368758937257;21278.36164915055;21599.35201943944;1104.2546281260277;1120.6694025262568;1121.9775604488027;1123.4944275076248;1126.8366086917351;11341.659750207507;11641.068714502819;11726.94136529312;11797.587084452174;11809;573036;573229;573993;580192;582119;129189;129700.3514982419;131921;133200;133297.33351333375;1112.1269803204445;1217.6773155113901;1229.993850030762;1231.8398608180878;1279.8720127987126;22085.33743987683;22086.337409877728;22159.66760498626;22194.77805221927;22278.331650050524;57244;58877.70561147167;58878.705606471696;60339.698301508215;61743.382566173765;76727.232727672;76757.23242767502;76924;77583.61208193922;77899.61050194713;15039.473618423302;15321.157336346609;15418.152001640017;15535.300911459237;15567.065976041475;24156.671383073397;24286.392840179138;24406.51186976286;24738.25785226446;24804.627930581417;19781.208751649774;19844;20100;20220.696689549965;20273.391798246077;16358.34566617322;17199.742003869702;17379.56551086233;17641.911790440965;18068.90965545164;19442.611147776683;20346.694799578316;20519.897400512902;20634.17463301451;20938.37184884456;15190.620234494227;15251.847481525043;15314.310856011729;15366.84633153654;15393;19612;19651.80348196557;19743;19773.20907163755;19851.503712407306 10:50:08 INFO - PID 18538 | |3;mootools.html;1420.9928950355247;1470.6396932751477;1476.9704605907882;1484.5768955847586;1487.6132205626534;16486.917565412186;17267.481975540722;17334.47996560105;17343.30626774929;17355.39256126036;16821.747673784903;17007.48977530676;17009.91495042526;17011.404600838974;17042.062686552235;2699;2715.511207982562;2759.2550011496883;2760.875760590768;2761.130243973152;2849.5868099125614;2881.3949070695076;2890.2340879666904;2890.7109289071136;2892.6962668919778;2834.0364276146106;2873.0375324266397;2878.5394336906097;2888.0469445083177;2890.537513997761;2768.709285525011;2795.6784969728437;2804.2568719289407;2816.633837601119;2829.1795379339965;2743.6158937748733;2771.8614069296455;2783.4572258409617;2790;2801.355688191707;15972.440964566184;16262.674746505003;16326;16372.099534525596;16399.672006559922;8420.578971051484;8687.000994885542;8693.304535637133;8721.171488708562;8723.302135829119;5308.469153084699;5630.690312032836;5655.26481557399;5656.688882111483;5924.348321684612;2074.572749882641;2128.8509804313703;2136.369770917583;2155.956880862374;2175.9564808703735;28465.715342846514;29091.70908290911;30586.847065764752;30856.69143308583;30965.38069238625;7898.407619428566;7900.762977110696;7953.681852725942;8088.878666820003;8166.714165004197;23421.41446463852;23422.648660270108;23423.297301080995;23460.64809027866;23497.530049399258;8824.249938755149;8926.642934282556;8930.285577153812;8954.641814327353;8970.910290897138;7757.4181936355;7816.8827467588035;7883.960580197062;8004.759857204293;8083.9191608083165;6121.479674227651;6144.2319710036245;6164.845878853064;6176.166217560572;6201.875962480725;1816.3824299738153;1820.3628729944414;1822.8906265624105;1831.716084006981;1842.1157844234842;892.4511425473287;901.7024381953939;910.7540963939832;912.2246090822748;912.9726108216764;8639.179277968582;8943.37396382247;8946.86579701292;8977.147171018743;9103.590338434786;718.877790775559;731.5025782467867;761.1893333599809;764.957927313992;773.114783572806;4873.147199240118;4893.363862697897;4921.237208232729;4966.180580204298;4982;23546;24653.876730616234;25309.114181003944;25487.107951221988;25523.106691266086;24631.137910173056;25003;25055.87472062628;25170.37074073163;25213.495730085295;10220.693379198636;11260.705018922929;12449.066320026035;12591.87408125907;12745.299008554619;8594.78513037179;8606.225439710455;8627.91372086271;8661.960564732273;8689.261412779984;21246;21407.357779266647;21471.8926405367;21551.353459396243;21714.674279885498;22611.88694056585;22808.771912280667;22897.427564310357;22987.540249195255;23004.769952300263;13658.317084145554;13960.650983725489;13996.510122146083;13997;14004.439822407398;15602.219889005732;15671;15750.842491574938;15786.973846699928;15950;12401.875981240071;12486.875131248571;12520.561780337644;12693.365331733561;12896.032797540409;12190.695232619255;12252;12272.815907761213;12500;12695.42870570808;10856.837147442953;10870.076043536388;10876.673699789018;10941.398223097805;11030.834537481784;7432.888506672512;7481.214472480311;7487.438442116972;7502.437317201341;7512.474126811071;7808.59944481064;7814.72648457324;7890.566018869017;7920.247576480225;7951.4036447267845 10:50:08 INFO - PID 18538 | |4;prototype.html;542.8383259823977;578.5776383240232;583.2942140010587;585.8857522783057;589.4076453164572;6344.587601805885;6395.552311338208;6399.712012959422;6403.327650596691;6454.419102280794;6139.81580552583;6148.10852426399;6167.229096362955;6184.958963542032;6274.529410294223;5127.9230811537855;5129.743512824362;5135.229715542661;5147.510986456281;5160.148575485059;5107.259447380127;5141.5886729061585;5172;5189.662671926313;5190.480951904817;4799.712017278957;4872.3909511311085;4885.975570122145;4894.094592500381;4948.628852836034;4914.631402644798;4957.082939656175;4967.076009952133;4979.327790748257;4996.150654388763;4511.503734589192;4511.796969136364;4523.208438523246;4526.728396296233;4533.38799262102;5942.078977758454;6148.385161483816;6177.7837775677635;6192.814215573495;6237.906431403532;5877.706114694291;5895.145203945447;5916.4675179233645;5941.138534912457;5972.701364931736;6605.438537724299;6647.76732814354;6681.064650948871;6710.7315707371645;6803.625800580966;5065.493450654942;5085.313482679828;5112.003159383921;5115.5396014358885;5134.563562097226;6753.4259587935085;6876.106106206161;6913.827154321132;6964.338387853146;6997.755078572276;5179.870503237374;5195.506426889439;5215.269862219292;5220.0946654470845;5249.527542521191;5249.265102885599;5277.255826969954;5278.392984806719;5278.683279003195;5324.1747529133045;5800.622959507618;5808.651480911159;5835.35811060783;5884.32330282023;5915.645061296336;6683.131192944983;6701.39687428124;6706.93293067063;6732.730690772314;6742.224644165885;1801.6937120689515;1816.4369045595909;1817.2549254805467;1819.963600727978;1824.8996305203075;1223.626793827891;1279.2899940532907;1287.922724636525;1299.883010529057;1310.488909325364;6205.441510264008;6270.15352927349;6279.811605651837;6301.243850737941;6309.716062777186;6581.670916454158;6771.492138089663;6810.795676129724;6836.179658440919;6853.588784672936;6165.660888651168;6179.69101544921;6195.96902015487;6198.442140207403;6246.219222597176;3479.321532301177;3575.334188883532;3583.498310236569;3602.2615363850346;3617.9276414471565;6971.407430368374;6995.79012629622;7003.3346832050875;7071;7075.929240707527;6747.696353664097;6917.239103698589;6931.0246579724535;6934.583924964519;6989.615571143636;6832.965835170892;6846.691898864563;6927.792166235021;6964.547304425196;7014.508984371045;6526.379993900762;6574.572652777554;6635.369639884203;6712.697928593323;6782.423494003065;6526.216853977553;6677.232118306457;6699.263081060982;6714.328567143247;6721.563098398588;6879.346462086094;6907;6932.306769323028;6940.861182776215;7044.471664625071;5123.28274041627;5154.355705536808;5167.560757335668;5188.688678679291;5208.244804503402;6538.705758240795;6627.801165965029;6748.865022699617;6792.150981127359;6806.693698783665;6165.84585385369;6403.551751377545;6451.419372256331;6458.580192287486;6474.546781725234;6484.735476582021;6490.188726409199;6526.4452521536205;6530.706118224786;6532.346765323429;6415.422611964946;6460.612363258219;6481.351864813481;6486.610803351814;6519.674016299261;6528.738850445929;6606.867862642816;6610.636414997221;6629.668516574248;6663.666816659051;6211.409916057967;6377.521685873671;6403.615783053032;6453.9354606453335;6476.546641735222 10:50:08 INFO - PID 18538 | |5;yui.html;958.3195930889073;962.7448726087586;974.8683927669763;976.6180854091461;994.9751256218593;20217.797822021774;20820.271290504817;20855.37433876986;20868.478288042807;20910.37268881934;17354.47936561902;17376;19252.229910803588;19481.805181948213;19497.707534386995;1036.108946306176;1062.8458873463383;1063.303536183799;1064.0423618743116;1064.3667018124204;1055.0978913029326;1061.946902654868;1064.084886997182;1064.2443864855961;1066.322884968047;1088.9237753357268;1120.9439528023606;1141.6004398460514;1141.8173092305233;1146.0430540498694;1078.7788503356794;1116.0959622705634;1118.5078565431224;1119.2445099557806;1130.9660710178666;814.2142832166928;814.4095530740166;814.975550733473;817.452306954342;817.9468334558235;21028.47428814292;21316.893415532977;21422.464438389008;21426.5714685707;21434.571308573897;21036.579268414545;22225.22211722598;22381.664275035888;22390.328290151323;22441;17861.7320740189;18201.362952296608;18249.270029198815;18250.269989200417;18375.264989400406;3959.6436320731273;3988.501437320335;3992.3612222044626;3995.20095980805;3996.860109896169;138864;157913;161260;161903;162056.9999999988;17892.46322610324;17949.461516154537;18196.63606727858;18328;18369.08154592265;34307;34817.12957176091;34825.65174348275;35762.82118589443;36142.63857361393;9950.651727189514;9951.054649808257;9952.601895924226;10015.148712359385;10022.649207277711;4450.287953927356;4527.071950250191;4582.656300777455;4618.56123668251;4618.930716039262;5910.940890591039;6018.578699491081;6024.819255422344;6025;6037.366076561985;1195.205188549622;1228.7603917236231;1231.5504840733247;1243.1981372015;1253.2793643654934;736.2931585677702;748.4798065344534;749.966251518683;759.3621358059256;770.0066913681401;12606.87393126057;12732;13407.932960335136;13855.307234638227;13979.440822367194;727.9162896266891;741.3587247031387;741.4402126394538;758.3478208740479;760.8782594784808;6189.460432912608;6236.812895613139;6279.811605651837;6293.150424692608;6354.523410744213;147896;148122;148129;152118;154487;99684.5015774931;100021.49989250152;114845.4257728706;119400;123251.3837430807;101831;107088;109886;110443;110989;13760.724785504033;14048.508302209373;14060.367283472473;14194;14229;52735;53050;53113.468865312396;53366.46633533615;54254.728726357695;68278.65860670665;68451;68671;69696.30303696898;70311;18382.81617183811;18511.53721156982;18854.811451885307;18896.811031889505;18923.526911827314;21576.67634985508;21625.783742162377;21771.891140544198;21854.344369668936;22162.88918555397;18389.632207356044;18493.53766155857;18583.070846457893;18675.159617817502;18678;18256.26974920988;18266.26934922588;18280.08599570043;18337.816621833612;18908.905455472635;17464.65070698604;17592.208350623998;17607.20767565488;17653;17656.382026629006;14480.637984050483;14531.636709082357;14821.295551011772;14983.250837458301;15037.172955487116;14953;15368.692626147638;15397.153156576496;15406.460773872861;15490.612734681723 10:50:08 INFO - PID 18538 | __end_tp_report 10:50:08 INFO - PID 18538 | __start_cc_report 10:50:08 INFO - PID 18538 | _x_x_mozilla_cycle_collect,347 10:50:08 INFO - PID 18538 | __end_cc_report 10:50:08 INFO - PID 18538 | __startTimestamp1505411408967__endTimestamp 10:50:08 INFO - PID 18538 | 10:50:08 INFO - PID 18538 | ------- Summary: start ------- 10:50:08 INFO - PID 18538 | Number of tests: 6 10:50:08 INFO - PID 18538 | 10:50:08 INFO - PID 18538 | [#0] dojo.html Cycles:165 Average:6355.40 Median:6575.77 stddev:763.68 (11.6%) stddev-sans-first:740.08 10:50:08 INFO - PID 18538 | Values: 3839.7 3872.7 3872.9 3885.8 3889.1 6132.9 6323.9 6327.9 6407.0 6448.2 6349.6 6424.6 6457.7 6477.6 6506.9 5450.1 5499.1 5752.8 5778.3 5786.3 5673.3 5734.7 5759.2 5781.7 5828.4 5589.9 5640.5 5641.8 5659.9 5668.5 5667.9 5717.2 5759.3 5764.1 5765.9 5679.3 5744.7 5762.7 5771.3 5771.6 6380.7 6382.8 6388.6 6435.8 6448.9 6700.7 6805.3 6815.6 6909.1 6989.5 6861.2 6943.5 6969.2 6975.9 6983.4 6340.9 6443.9 6448.5 6534.9 6558.9 7063.4 7082.8 7184.3 7185.3 7195.1 6774.2 6780.5 6864.2 6872.5 6875.6 6822.8 6873.7 6898.4 6973.7 6987.8 6812.6 6850.0 6872.3 6874.5 6917.2 6892.8 6942.0 6977.1 6994.2 6997.0 5027.5 5032.7 5046.1 5080.9 5093.8 4532.4 4554.4 4569.8 4639.3 4656.1 6414.3 6425.8 6468.5 6495.3 6507.2 6929.6 6941.1 7013.2 7023.9 7047.6 6302.1 6328.5 6360.7 6377.8 6380.9 5575.0 5596.3 5613.3 5635.2 5639.2 7129.2 7145.9 7146.8 7278.0 7288.5 6860.1 6861.1 6921.2 6924.2 6941.1 7114.4 7159.8 7163.9 7182.9 7193.0 6776.3 6781.6 6783.2 6873.5 6876.7 6845.5 6889.3 6947.4 6954.3 6957.1 6575.8 6594.8 6607.1 6613.6 6643.2 6527.2 6677.4 6724.1 6744.7 6748.4 6547.6 6563.1 6639.2 6649.3 6666.6 6406.1 6597.6 6671.6 6682.1 6789.6 6554.9 6563.9 6569.1 6614.6 6618.9 10:50:08 INFO - PID 18538 | 10:50:08 INFO - PID 18538 | [#1] ext.html Cycles:180 Average:42109.05 Median:21481.20 stddev:61411.74 (285.9%) stddev-sans-first:61506.26 10:50:08 INFO - PID 18538 | Values: 952.2 978.5 981.6 982.3 982.8 41258.8 45700.1 45856.8 45904.3 45905.8 41779.8 41893.8 42006.8 42056.0 42114.0 7483.8 8125.8 8318.8 8322.6 8325.7 8010.1 8023.1 8075.0 8080.9 8083.8 8029.8 8060.8 8125.1 8137.3 8138.1 8063.9 8098.7 8106.0 8107.2 8120.8 8208.8 8237.3 8256.3 8259.1 8260.5 40871.8 41182.4 41301.6 41377.6 41444.8 3714.9 3762.0 3765.2 3777.4 3789.0 33929.3 33963.8 33970.2 33991.5 34002.5 5308.0 5514.8 5556.6 5571.1 5700.9 207034.0 208502.0 209179.0 209469.0 210490.0 45552.3 46590.5 51539.0 51615.7 53001.7 56275.4 56278.2 56417.7 56437.0 56467.6 17039.4 17160.8 17161.6 17165.6 17177.6 13941.9 13964.2 13967.6 13970.4 14214.7 15594.8 15613.8 15615.1 15679.2 15681.1 5991.6 6012.8 6113.2 6146.0 6237.0 1088.9 1097.1 1103.4 1109.9 1111.0 26001.1 26111.7 26155.1 26415.3 26454.0 1191.9 1200.5 1235.5 1235.9 1247.9 13478.8 13514.7 13643.6 13732.5 13924.0 273988.0 274384.0 275826.0 276118.0 276989.6 57260.0 57324.0 57342.4 57342.7 57477.4 1514.6 1518.4 1534.1 1548.7 1552.7 24859.4 25279.4 25283.5 25356.4 25672.4 41136.8 41186.2 41262.2 41393.6 41395.4 219564.0 219815.0 219903.0 220674.0 220749.0 36602.6 39173.4 39607.2 39964.8 40054.4 50348.5 51589.5 51721.7 51840.0 51944.5 37211.3 37451.4 37527.6 37553.6 37712.0 37078.8 37269.0 37310.3 37448.0 37589.8 43540.3 43586.3 43588.6 43817.0 44002.8 35175.1 36028.8 36145.0 36508.3 36653.5 25933.7 26334.9 26807.2 26987.9 27011.1 10:50:08 INFO - PID 18538 | 10:50:08 INFO - PID 18538 | [#2] jquery.html Cycles:180 Average:38636.68 Median:12258.58 stddev:96431.51 (786.6%) stddev-sans-first:96659.71 10:50:08 INFO - PID 18538 | Values: 589.7 599.4 606.7 613.4 620.9 22763.2 23279.9 23475.5 23493.9 23502.8 24081.0 26586.9 26733.6 26759.0 26811.0 6714.0 6798.1 6831.8 6838.3 6873.0 6315.6 6564.5 6569.7 6772.9 6863.9 6517.9 6519.7 6525.6 6526.6 6527.5 6382.1 6535.2 6544.6 6557.9 6577.4 6185.4 6187.4 6196.0 6197.0 6211.1 30104.7 30466.5 30602.4 30719.2 30722.2 2238.8 2275.1 2275.7 2276.6 2276.6 20070.5 20451.1 21037.2 21044.8 21083.6 2502.2 2503.2 2557.7 2560.9 2579.9 131523.0 136850.3 138679.3 147180.0 147611.0 15696.5 16323.2 16387.1 16411.8 16726.6 25947.7 26027.6 26037.7 26100.9 26105.2 10885.0 10935.6 10948.1 11076.1 11166.1 10069.1 10194.4 10201.7 10276.8 10305.6 9709.1 9742.2 9806.2 9863.1 10055.6 2720.2 2751.1 2756.6 2792.9 2796.7 1011.6 1049.0 1050.2 1064.9 1079.6 20793.7 20962.2 21041.4 21278.4 21599.4 1104.3 1120.7 1122.0 1123.5 1126.8 11341.7 11641.1 11726.9 11797.6 11809.0 573036.0 573229.0 573993.0 580192.0 582119.0 129189.0 129700.4 131921.0 133200.0 133297.3 1112.1 1217.7 1230.0 1231.8 1279.9 22085.3 22086.3 22159.7 22194.8 22278.3 57244.0 58877.7 58878.7 60339.7 61743.4 76727.2 76757.2 76924.0 77583.6 77899.6 15039.5 15321.2 15418.2 15535.3 15567.1 24156.7 24286.4 24406.5 24738.3 24804.6 19781.2 19844.0 20100.0 20220.7 20273.4 16358.3 17199.7 17379.6 17641.9 18068.9 19442.6 20346.7 20519.9 20634.2 20938.4 15190.6 15251.8 15314.3 15366.8 15393.0 19612.0 19651.8 19743.0 19773.2 19851.5 10:50:08 INFO - PID 18538 | 10:50:08 INFO - PID 18538 | [#3] mootools.html Cycles:180 Average:10550.25 Median:2764.92 stddev:7900.12 (285.7%) stddev-sans-first:7892.50 10:50:08 INFO - PID 18538 | Values: 1421.0 1470.6 1477.0 1484.6 1487.6 16486.9 17267.5 17334.5 17343.3 17355.4 16821.7 17007.5 17009.9 17011.4 17042.1 2699.0 2715.5 2759.3 2760.9 2761.1 2849.6 2881.4 2890.2 2890.7 2892.7 2834.0 2873.0 2878.5 2888.0 2890.5 2768.7 2795.7 2804.3 2816.6 2829.2 2743.6 2771.9 2783.5 2790.0 2801.4 15972.4 16262.7 16326.0 16372.1 16399.7 8420.6 8687.0 8693.3 8721.2 8723.3 5308.5 5630.7 5655.3 5656.7 5924.3 2074.6 2128.9 2136.4 2156.0 2176.0 28465.7 29091.7 30586.8 30856.7 30965.4 7898.4 7900.8 7953.7 8088.9 8166.7 23421.4 23422.6 23423.3 23460.6 23497.5 8824.2 8926.6 8930.3 8954.6 8970.9 7757.4 7816.9 7884.0 8004.8 8083.9 6121.5 6144.2 6164.8 6176.2 6201.9 1816.4 1820.4 1822.9 1831.7 1842.1 892.5 901.7 910.8 912.2 913.0 8639.2 8943.4 8946.9 8977.1 9103.6 718.9 731.5 761.2 765.0 773.1 4873.1 4893.4 4921.2 4966.2 4982.0 23546.0 24653.9 25309.1 25487.1 25523.1 24631.1 25003.0 25055.9 25170.4 25213.5 10220.7 11260.7 12449.1 12591.9 12745.3 8594.8 8606.2 8627.9 8662.0 8689.3 21246.0 21407.4 21471.9 21551.4 21714.7 22611.9 22808.8 22897.4 22987.5 23004.8 13658.3 13960.7 13996.5 13997.0 14004.4 15602.2 15671.0 15750.8 15787.0 15950.0 12401.9 12486.9 12520.6 12693.4 12896.0 12190.7 12252.0 12272.8 12500.0 12695.4 10856.8 10870.1 10876.7 10941.4 11030.8 7432.9 7481.2 7487.4 7502.4 7512.5 7808.6 7814.7 7890.6 7920.2 7951.4 10:50:08 INFO - PID 18538 | 10:50:08 INFO - PID 18538 | [#4] prototype.html Cycles:180 Average:5635.60 Median:6242.06 stddev:1566.78 (25.1%) stddev-sans-first:1523.84 10:50:08 INFO - PID 18538 | Values: 542.8 578.6 583.3 585.9 589.4 6344.6 6395.6 6399.7 6403.3 6454.4 6139.8 6148.1 6167.2 6185.0 6274.5 5127.9 5129.7 5135.2 5147.5 5160.1 5107.3 5141.6 5172.0 5189.7 5190.5 4799.7 4872.4 4886.0 4894.1 4948.6 4914.6 4957.1 4967.1 4979.3 4996.2 4511.5 4511.8 4523.2 4526.7 4533.4 5942.1 6148.4 6177.8 6192.8 6237.9 5877.7 5895.1 5916.5 5941.1 5972.7 6605.4 6647.8 6681.1 6710.7 6803.6 5065.5 5085.3 5112.0 5115.5 5134.6 6753.4 6876.1 6913.8 6964.3 6997.8 5179.9 5195.5 5215.3 5220.1 5249.5 5249.3 5277.3 5278.4 5278.7 5324.2 5800.6 5808.7 5835.4 5884.3 5915.6 6683.1 6701.4 6706.9 6732.7 6742.2 1801.7 1816.4 1817.3 1820.0 1824.9 1223.6 1279.3 1287.9 1299.9 1310.5 6205.4 6270.2 6279.8 6301.2 6309.7 6581.7 6771.5 6810.8 6836.2 6853.6 6165.7 6179.7 6196.0 6198.4 6246.2 3479.3 3575.3 3583.5 3602.3 3617.9 6971.4 6995.8 7003.3 7071.0 7075.9 6747.7 6917.2 6931.0 6934.6 6989.6 6833.0 6846.7 6927.8 6964.5 7014.5 6526.4 6574.6 6635.4 6712.7 6782.4 6526.2 6677.2 6699.3 6714.3 6721.6 6879.3 6907.0 6932.3 6940.9 7044.5 5123.3 5154.4 5167.6 5188.7 5208.2 6538.7 6627.8 6748.9 6792.2 6806.7 6165.8 6403.6 6451.4 6458.6 6474.5 6484.7 6490.2 6526.4 6530.7 6532.3 6415.4 6460.6 6481.4 6486.6 6519.7 6528.7 6606.9 6610.6 6629.7 6663.7 6211.4 6377.5 6403.6 6453.9 6476.5 10:50:08 INFO - PID 18538 | 10:50:08 INFO - PID 18538 | [#5] yui.html Cycles:180 Average:27636.23 Median:18547.30 stddev:40215.16 (216.8%) stddev-sans-first:40278.09 10:50:08 INFO - PID 18538 | Values: 958.3 962.7 974.9 976.6 995.0 20217.8 20820.3 20855.4 20868.5 20910.4 17354.5 17376.0 19252.2 19481.8 19497.7 1036.1 1062.8 1063.3 1064.0 1064.4 1055.1 1061.9 1064.1 1064.2 1066.3 1088.9 1120.9 1141.6 1141.8 1146.0 1078.8 1116.1 1118.5 1119.2 1131.0 814.2 814.4 815.0 817.5 817.9 21028.5 21316.9 21422.5 21426.6 21434.6 21036.6 22225.2 22381.7 22390.3 22441.0 17861.7 18201.4 18249.3 18250.3 18375.3 3959.6 3988.5 3992.4 3995.2 3996.9 138864.0 157913.0 161260.0 161903.0 162057.0 17892.5 17949.5 18196.6 18328.0 18369.1 34307.0 34817.1 34825.7 35762.8 36142.6 9950.7 9951.1 9952.6 10015.1 10022.6 4450.3 4527.1 4582.7 4618.6 4618.9 5910.9 6018.6 6024.8 6025.0 6037.4 1195.2 1228.8 1231.6 1243.2 1253.3 736.3 748.5 750.0 759.4 770.0 12606.9 12732.0 13407.9 13855.3 13979.4 727.9 741.4 741.4 758.3 760.9 6189.5 6236.8 6279.8 6293.2 6354.5 147896.0 148122.0 148129.0 152118.0 154487.0 99684.5 100021.5 114845.4 119400.0 123251.4 101831.0 107088.0 109886.0 110443.0 110989.0 13760.7 14048.5 14060.4 14194.0 14229.0 52735.0 53050.0 53113.5 53366.5 54254.7 68278.7 68451.0 68671.0 69696.3 70311.0 18382.8 18511.5 18854.8 18896.8 18923.5 21576.7 21625.8 21771.9 21854.3 22162.9 18389.6 18493.5 18583.1 18675.2 18678.0 18256.3 18266.3 18280.1 18337.8 18908.9 17464.7 17592.2 17607.2 17653.0 17656.4 14480.6 14531.6 14821.3 14983.3 15037.2 14953.0 15368.7 15397.2 15406.5 15490.6 10:50:08 INFO - PID 18538 | -------- Summary: end -------- 10:50:08 INFO - PID 18538 | 10:50:09 INFO - TEST-INFO | 18538: exit 0 10:50:09 INFO - TEST-OK | dromaeo_css | took 1109003ms 10:50:09 INFO - TEST-START | kraken 10:50:09 INFO - Initialising browser for kraken test... 10:50:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37962/getInfo.html -profile /tmp/tmpq6MhgX/profile 10:50:09 INFO - TEST-INFO | started process 18911 (/builds/slave/test/build/application/firefox/firefox http://localhost:37962/getInfo.html) 10:50:14 INFO - TEST-INFO | 18911: exit 0 10:50:15 INFO - Browser initialized. 10:50:15 INFO - Running cycle 1/1 for kraken test... 10:50:15 INFO - Using env: {'DISPLAY': ':0', 10:50:15 INFO - 'HOME': '/home/cltbld', 10:50:15 INFO - 'JSGC_DISABLE_POISONING': '1', 10:50:15 INFO - 'LANG': 'en_US.UTF-8', 10:50:15 INFO - 'LANGUAGE': 'en_US:en', 10:50:15 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 10:50:15 INFO - 'LOGNAME': 'cltbld', 10:50:15 INFO - 'MAIL': '/var/mail/cltbld', 10:50:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:50:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:50:15 INFO - 'MOZ_CRASHREPORTER': '1', 10:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:15 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 10:50:15 INFO - 'MOZ_NO_REMOTE': '1', 10:50:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:50:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:15 INFO - 'NO_EM_RESTART': '1', 10:50:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:15 INFO - 'PWD': '/builds/slave/test', 10:50:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:50:15 INFO - 'RUST_BACKTRACE': 'full', 10:50:15 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:50:15 INFO - 'SHELL': '/bin/bash', 10:50:15 INFO - 'SHLVL': '1', 10:50:15 INFO - 'TERM': 'linux', 10:50:15 INFO - 'TMOUT': '86400', 10:50:15 INFO - 'USER': 'cltbld', 10:50:15 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697', 10:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:15 INFO - '_': '/tools/buildbot/bin/python'} 10:50:15 INFO - TEST-INFO | started process 19151 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq6MhgX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:50:15 INFO - PID 19151 | 10:50:15 INFO - PID 19151 | (/builds/slave/test/build/application/firefox/firefox:19201): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:50:15 INFO - PID 19151 | 10:50:26 INFO - PID 19151 | RSS: Main: 163430400 10:50:26 INFO - PID 19151 | 10:50:28 INFO - PID 19151 | Cycle 1(1): loaded http://localhost:37962/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37962/tests/kraken/driver.html?testName=audio-beat-detection) 10:50:29 INFO - PID 19151 | RSS: Main: 168845312 10:50:29 INFO - PID 19151 | 10:50:32 INFO - PID 19151 | Cycle 1(1): loaded http://localhost:37962/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37962/tests/kraken/driver.html?testName=audio-dft) 10:50:32 INFO - PID 19151 | RSS: Main: 169508864 10:50:32 INFO - PID 19151 | 10:50:35 INFO - PID 19151 | Cycle 1(1): loaded http://localhost:37962/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37962/tests/kraken/driver.html?testName=audio-fft) 10:50:36 INFO - PID 19151 | RSS: Main: 164716544 10:50:36 INFO - PID 19151 | 10:50:38 INFO - PID 19151 | Cycle 1(1): loaded http://localhost:37962/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37962/tests/kraken/driver.html?testName=audio-oscillator) 10:50:39 INFO - PID 19151 | RSS: Main: 166338560 10:50:39 INFO - PID 19151 | 10:50:41 INFO - PID 19151 | Cycle 1(1): loaded http://localhost:37962/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37962/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:50:41 INFO - PID 19151 | RSS: Main: 166187008 10:50:41 INFO - PID 19151 | 10:50:45 INFO - PID 19151 | Cycle 1(1): loaded http://localhost:37962/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37962/tests/kraken/driver.html?testName=imaging-darkroom) 10:50:45 INFO - PID 19151 | RSS: Main: 170287104 10:50:45 INFO - PID 19151 | 10:50:49 INFO - PID 19151 | Cycle 1(1): loaded http://localhost:37962/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37962/tests/kraken/driver.html?testName=imaging-desaturate) 10:50:49 INFO - PID 19151 | RSS: Main: 168927232 10:50:49 INFO - PID 19151 | 10:50:52 INFO - PID 19151 | Cycle 1(1): loaded http://localhost:37962/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37962/tests/kraken/driver.html?testName=json-parse-financial) 10:50:53 INFO - PID 19151 | RSS: Main: 168722432 10:50:53 INFO - PID 19151 | 10:50:54 INFO - PID 19151 | Cycle 1(1): loaded http://localhost:37962/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37962/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:50:55 INFO - PID 19151 | RSS: Main: 168235008 10:50:55 INFO - PID 19151 | 10:50:57 INFO - PID 19151 | Cycle 1(1): loaded http://localhost:37962/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37962/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:50:57 INFO - PID 19151 | RSS: Main: 169037824 10:50:57 INFO - PID 19151 | 10:50:59 INFO - PID 19151 | Cycle 1(1): loaded http://localhost:37962/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37962/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:51:00 INFO - PID 19151 | RSS: Main: 165531648 10:51:00 INFO - PID 19151 | 10:51:02 INFO - PID 19151 | Cycle 1(1): loaded http://localhost:37962/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37962/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:51:03 INFO - PID 19151 | RSS: Main: 166289408 10:51:03 INFO - PID 19151 | 10:51:06 INFO - PID 19151 | Cycle 1(1): loaded http://localhost:37962/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37962/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:51:07 INFO - PID 19151 | RSS: Main: 165801984 10:51:07 INFO - PID 19151 | 10:51:08 INFO - PID 19151 | Cycle 1(1): loaded http://localhost:37962/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37962/tests/kraken/driver.html?testName=ai-astar) 10:51:09 INFO - PID 19151 | RSS: Main: 168136704 10:51:09 INFO - PID 19151 | 10:51:09 INFO - PID 19151 | __start_tp_report 10:51:09 INFO - PID 19151 | _x_x_mozilla_page_load 10:51:09 INFO - PID 19151 | _x_x_mozilla_page_load_details 10:51:09 INFO - PID 19151 | |i|pagename|runs| 10:51:09 INFO - PID 19151 | |0;ai-astar;105;104;105;105;107;110;109;105;106;106 10:51:09 INFO - PID 19151 | |1;audio-beat-detection;114;113;116;116;112;139;118;113;116;116 10:51:09 INFO - PID 19151 | |2;audio-dft;162;163;161;163;162;164;162;163;163;163 10:51:09 INFO - PID 19151 | |3;audio-fft;73;76;75;72;73;76;77;74;76;75 10:51:09 INFO - PID 19151 | |4;audio-oscillator;79;79;80;78;78;84;78;83;78;79 10:51:09 INFO - PID 19151 | |5;imaging-gaussian-blur;110;113;113;113;114;110;113;111;113;115 10:51:09 INFO - PID 19151 | |6;imaging-darkroom;150;148;149;150;150;149;150;149;152;151 10:51:09 INFO - PID 19151 | |7;imaging-desaturate;94;93;94;94;93;94;94;94;94;96 10:51:09 INFO - PID 19151 | |8;json-parse-financial;45;44;44;45;43;45;46;45;43;44 10:51:09 INFO - PID 19151 | |9;json-stringify-tinderbox;38;38;38;40;38;46;38;38;37;38 10:51:09 INFO - PID 19151 | |10;stanford-crypto-aes;74;71;75;72;72;73;78;76;73;74 10:51:09 INFO - PID 19151 | |11;stanford-crypto-ccm;112;107;105;104;105;105;108;107;112;113 10:51:09 INFO - PID 19151 | |12;stanford-crypto-pbkdf2;174;164;150;159;159;151;162;159;153;158 10:51:09 INFO - PID 19151 | |13;stanford-crypto-sha256-iterative;60;61;61;64;60;60;61;62;58;64 10:51:09 INFO - PID 19151 | __end_tp_report 10:51:09 INFO - PID 19151 | __start_cc_report 10:51:09 INFO - PID 19151 | _x_x_mozilla_cycle_collect,902 10:51:09 INFO - PID 19151 | __end_cc_report 10:51:09 INFO - PID 19151 | __startTimestamp1505411468998__endTimestamp 10:51:09 INFO - PID 19151 | 10:51:09 INFO - PID 19151 | ------- Summary: start ------- 10:51:09 INFO - PID 19151 | Number of tests: 14 10:51:09 INFO - PID 19151 | 10:51:09 INFO - PID 19151 | [#0] ai-astar Cycles:10 Average:106.20 Median:106.00 stddev:1.93 (1.8%) stddev-sans-first:2.00 10:51:09 INFO - PID 19151 | Values: 105.0 104.0 105.0 105.0 107.0 110.0 109.0 105.0 106.0 106.0 10:51:09 INFO - PID 19151 | 10:51:09 INFO - PID 19151 | [#1] audio-beat-detection Cycles:10 Average:117.30 Median:116.00 stddev:7.85 (6.8%) stddev-sans-first:8.23 10:51:09 INFO - PID 19151 | Values: 114.0 113.0 116.0 116.0 112.0 139.0 118.0 113.0 116.0 116.0 10:51:09 INFO - PID 19151 | 10:51:09 INFO - PID 19151 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:0.84 (0.5%) stddev-sans-first:0.87 10:51:09 INFO - PID 19151 | Values: 162.0 163.0 161.0 163.0 162.0 164.0 162.0 163.0 163.0 163.0 10:51:09 INFO - PID 19151 | 10:51:09 INFO - PID 19151 | [#3] audio-fft Cycles:10 Average:74.70 Median:75.50 stddev:1.64 (2.2%) stddev-sans-first:1.62 10:51:09 INFO - PID 19151 | Values: 73.0 76.0 75.0 72.0 73.0 76.0 77.0 74.0 76.0 75.0 10:51:09 INFO - PID 19151 | 10:51:09 INFO - PID 19151 | [#4] audio-oscillator Cycles:10 Average:79.60 Median:79.00 stddev:2.17 (2.7%) stddev-sans-first:2.29 10:51:09 INFO - PID 19151 | Values: 79.0 79.0 80.0 78.0 78.0 84.0 78.0 83.0 78.0 79.0 10:51:09 INFO - PID 19151 | 10:51:09 INFO - PID 19151 | [#5] imaging-gaussian-blur Cycles:10 Average:112.50 Median:113.00 stddev:1.65 (1.5%) stddev-sans-first:1.48 10:51:09 INFO - PID 19151 | Values: 110.0 113.0 113.0 113.0 114.0 110.0 113.0 111.0 113.0 115.0 10:51:09 INFO - PID 19151 | 10:51:09 INFO - PID 19151 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:150.00 stddev:1.14 (0.8%) stddev-sans-first:1.20 10:51:09 INFO - PID 19151 | Values: 150.0 148.0 149.0 150.0 150.0 149.0 150.0 149.0 152.0 151.0 10:51:09 INFO - PID 19151 | 10:51:09 INFO - PID 19151 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 10:51:09 INFO - PID 19151 | Values: 94.0 93.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 96.0 10:51:09 INFO - PID 19151 | 10:51:09 INFO - PID 19151 | [#8] json-parse-financial Cycles:10 Average:44.40 Median:45.00 stddev:0.97 (2.1%) stddev-sans-first:1.00 10:51:09 INFO - PID 19151 | Values: 45.0 44.0 44.0 45.0 43.0 45.0 46.0 45.0 43.0 44.0 10:51:09 INFO - PID 19151 | 10:51:09 INFO - PID 19151 | [#9] json-stringify-tinderbox Cycles:10 Average:38.90 Median:38.00 stddev:2.60 (6.8%) stddev-sans-first:2.74 10:51:09 INFO - PID 19151 | Values: 38.0 38.0 38.0 40.0 38.0 46.0 38.0 38.0 37.0 38.0 10:51:09 INFO - PID 19151 | 10:51:09 INFO - PID 19151 | [#10] stanford-crypto-aes Cycles:10 Average:73.80 Median:74.00 stddev:2.10 (2.8%) stddev-sans-first:2.22 10:51:09 INFO - PID 19151 | Values: 74.0 71.0 75.0 72.0 72.0 73.0 78.0 76.0 73.0 74.0 10:51:09 INFO - PID 19151 | 10:51:09 INFO - PID 19151 | [#11] stanford-crypto-ccm Cycles:10 Average:107.80 Median:107.50 stddev:3.36 (3.1%) stddev-sans-first:3.20 10:51:09 INFO - PID 19151 | Values: 112.0 107.0 105.0 104.0 105.0 105.0 108.0 107.0 112.0 113.0 10:51:09 INFO - PID 19151 | 10:51:09 INFO - PID 19151 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.90 Median:159.00 stddev:7.00 (4.4%) stddev-sans-first:4.84 10:51:09 INFO - PID 19151 | Values: 174.0 164.0 150.0 159.0 159.0 151.0 162.0 159.0 153.0 158.0 10:51:09 INFO - PID 19151 | 10:51:09 INFO - PID 19151 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.10 Median:61.00 stddev:1.85 (3.0%) stddev-sans-first:1.92 10:51:09 INFO - PID 19151 | Values: 60.0 61.0 61.0 64.0 60.0 60.0 61.0 62.0 58.0 64.0 10:51:09 INFO - PID 19151 | -------- Summary: end -------- 10:51:09 INFO - PID 19151 | 10:51:09 INFO - PID 19151 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 10:51:09 INFO - TEST-INFO | 19151: exit 0 10:51:09 INFO - TEST-OK | kraken | took 59913ms 10:51:09 INFO - SUITE-END | took 1168s 10:51:10 INFO - Completed test suite (00:19:29) 10:51:10 INFO - javascript benchmark 10:51:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9123.117717090674, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3839.7312188146825, 3872.6514613684762, 3872.8838134855955, 3885.8445662173513, 3889.124946886953, 6132.938670613293, 6323.922498227096, 6327.873442531152, 6407.0, 6448.193975753031, 6349.619022858632, 6424.6145231286155, 6457.741690332393, 6477.611343319404, 6506.902396464056, 5450.127979523277, 5499.092649712793, 5752.769889204426, 5778.306603207621, 5786.334571524266, 5673.319201695802, 5734.684592347419, 5759.16492108644, 5781.710914454282, 5828.358880523139, 5589.888202235953, 5640.492355688008, 5641.830745077655, 5659.8585035374035, 5668.546516278729, 5667.8583035424035, 5717.2281741965135, 5759.251297331362, 5764.106563482667, 5765.8558536036935, 5679.290088738908, 5744.655320680731, 5762.683052432115, 5771.336296325934, 5771.567132465082, 6380.744770209186, 6382.808515744535, 6388.616682999035, 6435.806925792233, 6448.903686373281, 6700.698468568926, 6805.251422343587, 6815.625140617264, 6909.067275917787, 6989.510734248604, 6861.176658800976, 6943.548669336527, 6969.23338432772, 6975.8604827903155, 6983.441324694012, 6340.904886426707, 6443.903341449882, 6448.484121270287, 6534.869302613921, 6558.93441065588, 7063.364297213276, 7082.787516374517, 7184.281571842774, 7185.2814718527725, 7195.064641596559, 6774.187097548326, 6780.525363224626, 6864.24493305736, 6872.518923675295, 6875.5530890491955, 6822.761203357958, 6873.725050998004, 6898.448124150056, 6973.651317434108, 6987.825304367329, 6812.591244525344, 6849.965750171317, 6872.278410766898, 6874.450043996469, 6917.239103698589, 6892.827679308058, 6942.028116063755, 6977.1278590176225, 6994.195667498303, 6997.0, 5027.547520723152, 5032.6980381177245, 5046.1169295373165, 5080.923786143211, 5093.796248150033, 4532.410786597721, 4554.3851580036935, 4569.771511424482, 4639.280911458729, 4656.115338085753, 6414.262359828679, 6425.775097871552, 6468.5472016958365, 6495.3179916109075, 6507.154069970874, 6929.618870962146, 6941.097657304518, 7013.228544860061, 7023.929760702327, 7047.647617619098, 6302.149209856702, 6328.493720502349, 6360.7137678804565, 6377.840553986188, 6380.872382552323, 5574.9721251393485, 5596.300462442195, 5613.326400831927, 5635.21107045014, 5639.182318563785, 7129.18014428337, 7145.8928116078305, 7146.821329466805, 7277.9636101820215, 7288.526245794006, 6860.108185935996, 6861.108055952894, 6921.204061532988, 6924.169099708067, 6941.0629565010095, 7114.430845532242, 7159.785206443815, 7163.856722865409, 7182.89225661605, 7193.028941092885, 6776.288489708707, 6781.593104413751, 6783.18601767791, 6873.48448866327, 6876.724931002704, 6845.520813543004, 6889.276625954403, 6947.40947019509, 6954.3045695430055, 6957.060796792368, 6575.769848055295, 6594.769183078569, 6607.141071660845, 6613.636250006296, 6643.169603799525, 6527.184101987252, 6677.399034086956, 6724.125863637696, 6744.662766861539, 6748.392644662004, 6547.574407663486, 6563.113979612691, 6639.2364878037715, 6649.301823308677, 6666.566673166229, 6406.1031455597185, 6597.60414375139, 6671.566348187353, 6682.097916781172, 6789.626570538668, 6554.934450655433, 6563.901541476977, 6569.146011018728, 6614.570052946543, 6618.867622647424], "value": 6302.72475056384, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [952.2477242978047, 978.5303054533823, 981.5681100315855, 982.3025651787231, 982.7592239901226, 41258.793706031465, 45700.08599828002, 45856.77071614641, 45904.3114353285, 45905.77047114764, 41779.79110104445, 41893.7905310473, 42006.7899660502, 42056.0, 42114.0, 7483.812904677386, 8125.75622731319, 8318.83362332756, 8322.625481853302, 8325.66697332106, 8010.078840933309, 8023.117457079717, 8074.9596252018655, 8080.878786818203, 8083.797905052391, 8029.799255018613, 8060.798480038016, 8125.1062383138105, 8137.349012079019, 8138.104808471093, 8063.919360806375, 8098.716544920959, 8105.959470202641, 8107.22981316774, 8120.837583248361, 8208.794780130485, 8237.341012718967, 8256.339492840558, 8259.132791056913, 8260.504369737835, 40871.795641021905, 41182.38226426606, 41301.58698413037, 41377.58622413797, 41444.79277603623, 3714.8699795507027, 3762.0, 3765.2281282337053, 3777.414500752388, 3788.9959160822405, 33929.32141357184, 33963.83018084918, 33970.150746231295, 33991.4901276481, 34002.48996265058, 5308.0, 5514.80698175566, 5556.555475561986, 5571.0807716726695, 5700.914486282709, 207033.96483017638, 208502.0, 209179.0, 209469.0, 210490.0, 45552.3167152493, 46590.53409465862, 51539.0, 51615.74192129015, 53001.734991324796, 56275.43724562702, 56278.15582766262, 56417.717911411004, 56437.0, 56467.58831029175, 17039.381258780395, 17160.82839171617, 17161.570960726083, 17165.57086072858, 17177.570560735832, 13941.930290348484, 13964.231967241696, 13967.580972570839, 13970.371333289822, 14214.715705685829, 15594.766078508832, 15613.843861561467, 15615.141167235912, 15679.216039197994, 15681.05913645185, 5991.55063370249, 6012.849678758066, 6113.205283313141, 6145.96927015371, 6236.968815155895, 1088.88022317545, 1097.0839349143555, 1103.426218366445, 1109.9334039957628, 1110.955561777536, 26001.089961851245, 26111.73888261093, 26155.08457204027, 26415.33961650974, 26454.0, 1191.874853140425, 1200.5317926008863, 1235.5366737473448, 1235.8887700106854, 1247.9376031198403, 13478.797818032737, 13514.662133446545, 13643.59069227905, 13732.45070197181, 13924.0, 273988.0, 274384.0, 275826.0, 276118.0, 276989.61505192344, 57260.0, 57324.0, 57342.42657573454, 57342.7132864333, 57477.42522574721, 1514.6364872430538, 1518.3926429428318, 1534.1485475561171, 1548.6670365871391, 1552.6661767719995, 24859.378515537257, 25279.36801579975, 25283.494330113663, 25356.366090847878, 25672.358191045372, 41136.79431602823, 41186.1762764749, 41262.1747565053, 41393.58606414018, 41395.379069314586, 219564.0, 219815.0, 219903.0, 220674.0, 220749.0, 36602.633973659926, 39173.41239881347, 39607.2078558433, 39964.800175998935, 40054.399184012844, 50348.49651503438, 51589.484105158466, 51721.7413912928, 51840.0, 51944.48055519548, 37211.25577488381, 37451.43822842714, 37527.624723752415, 37553.62446375501, 37712.0, 37078.8146059268, 37269.0, 37310.253794924494, 37448.0, 37589.81205093957, 43540.346894797236, 43586.34620480759, 43588.56411435972, 43817.0, 44002.779986099864, 35175.12062198466, 36028.819855900554, 36145.0, 36508.26983460369, 36653.45019824758, 25933.740662593886, 26334.868325658248, 26807.195784126507, 26987.865060675358, 27011.054613088447], "value": 18846.538645501154, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.6668382363964, 599.4275466929083, 606.6966516741629, 613.3927411862257, 620.857202843346, 22763.203287884928, 23279.883600581972, 23475.530489390225, 23493.88253058732, 23502.764972350273, 24081.0, 26586.867065664646, 26733.598996015076, 26759.0, 26811.0, 6714.0, 6798.0822588950605, 6831.795046148623, 6838.2819803920365, 6872.965635171817, 6315.621062736228, 6564.5404821662505, 6569.671516424183, 6772.864542709143, 6863.897041544381, 6517.902231466508, 6519.706613202417, 6525.575837570543, 6526.608403495782, 6527.510436717242, 6382.106505089291, 6535.21577410709, 6544.640044797534, 6557.868842623168, 6577.375149360803, 6185.443310102068, 6187.443130118311, 6196.0, 6196.969015154896, 6211.09939058834, 30104.69895301063, 30466.54300185499, 30602.387952241053, 30719.232019199477, 30722.231944201572, 2238.82089432845, 2275.1354485295647, 2275.7155355580553, 2276.6129757941026, 2276.6243569810963, 20070.49823754403, 20451.079701413473, 21037.158513659437, 21044.789552104437, 21083.578328433498, 2502.1617758051075, 2503.161440917295, 2557.744225577446, 2560.9359766005814, 2579.909703160399, 131523.0, 136850.31574842162, 138679.30660346634, 147180.0, 147611.0, 15696.529104126894, 16323.183840807913, 16387.098709570848, 16411.753823692656, 16726.581835453966, 25947.740522594533, 26027.609585856226, 26037.73962260391, 26100.8694956524, 26105.216843494727, 10885.0, 10935.56257749681, 10948.124150067975, 11076.11391088711, 11166.106711463064, 10069.093781559548, 10194.388336699822, 10201.744956376002, 10276.845847312296, 10305.639302624522, 9709.126178643955, 9742.220622350194, 9806.215502759762, 9863.112319891245, 10055.59777608902, 2720.1975417251956, 2751.147144385247, 2756.641636587231, 2792.944141117166, 2796.706345833699, 1011.5599714124379, 1048.951048951049, 1050.2333296693457, 1064.9361038337724, 1079.611339917629, 20793.688094678593, 20962.213050039463, 21041.368758937257, 21278.36164915055, 21599.35201943944, 1104.2546281260277, 1120.6694025262568, 1121.9775604488027, 1123.4944275076248, 1126.8366086917351, 11341.659750207507, 11641.068714502819, 11726.94136529312, 11797.587084452174, 11809.0, 573036.0, 573229.0, 573993.0, 580192.0, 582119.0, 129189.0, 129700.3514982419, 131921.0, 133200.0, 133297.33351333375, 1112.1269803204445, 1217.6773155113901, 1229.993850030762, 1231.8398608180878, 1279.8720127987126, 22085.33743987683, 22086.337409877728, 22159.66760498626, 22194.77805221927, 22278.331650050524, 57244.0, 58877.70561147167, 58878.705606471696, 60339.698301508215, 61743.382566173765, 76727.232727672, 76757.23242767502, 76924.0, 77583.61208193922, 77899.61050194713, 15039.473618423302, 15321.157336346609, 15418.152001640017, 15535.300911459237, 15567.065976041475, 24156.671383073397, 24286.392840179138, 24406.51186976286, 24738.25785226446, 24804.627930581417, 19781.208751649774, 19844.0, 20100.0, 20220.696689549965, 20273.391798246077, 16358.34566617322, 17199.742003869702, 17379.56551086233, 17641.911790440965, 18068.90965545164, 19442.611147776683, 20346.694799578316, 20519.897400512902, 20634.17463301451, 20938.37184884456, 15190.620234494227, 15251.847481525043, 15314.310856011729, 15366.84633153654, 15393.0, 19612.0, 19651.80348196557, 19743.0, 19773.20907163755, 19851.503712407306], "value": 12756.012125733958, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1420.9928950355247, 1470.6396932751477, 1476.9704605907882, 1484.5768955847586, 1487.6132205626534, 16486.917565412186, 17267.481975540722, 17334.47996560105, 17343.30626774929, 17355.39256126036, 16821.747673784903, 17007.48977530676, 17009.91495042526, 17011.404600838974, 17042.062686552235, 2699.0, 2715.511207982562, 2759.2550011496883, 2760.875760590768, 2761.130243973152, 2849.5868099125614, 2881.3949070695076, 2890.2340879666904, 2890.7109289071136, 2892.6962668919778, 2834.0364276146106, 2873.0375324266397, 2878.5394336906097, 2888.0469445083177, 2890.537513997761, 2768.709285525011, 2795.6784969728437, 2804.2568719289407, 2816.633837601119, 2829.1795379339965, 2743.6158937748733, 2771.8614069296455, 2783.4572258409617, 2790.0, 2801.355688191707, 15972.440964566184, 16262.674746505003, 16326.0, 16372.099534525596, 16399.672006559922, 8420.578971051484, 8687.000994885542, 8693.304535637133, 8721.171488708562, 8723.302135829119, 5308.469153084699, 5630.690312032836, 5655.26481557399, 5656.688882111483, 5924.348321684612, 2074.572749882641, 2128.8509804313703, 2136.369770917583, 2155.956880862374, 2175.9564808703735, 28465.715342846514, 29091.70908290911, 30586.847065764752, 30856.69143308583, 30965.38069238625, 7898.407619428566, 7900.762977110696, 7953.681852725942, 8088.878666820003, 8166.714165004197, 23421.41446463852, 23422.648660270108, 23423.297301080995, 23460.64809027866, 23497.530049399258, 8824.249938755149, 8926.642934282556, 8930.285577153812, 8954.641814327353, 8970.910290897138, 7757.4181936355, 7816.8827467588035, 7883.960580197062, 8004.759857204293, 8083.9191608083165, 6121.479674227651, 6144.2319710036245, 6164.845878853064, 6176.166217560572, 6201.875962480725, 1816.3824299738153, 1820.3628729944414, 1822.8906265624105, 1831.716084006981, 1842.1157844234842, 892.4511425473287, 901.7024381953939, 910.7540963939832, 912.2246090822748, 912.9726108216764, 8639.179277968582, 8943.37396382247, 8946.86579701292, 8977.147171018743, 9103.590338434786, 718.877790775559, 731.5025782467867, 761.1893333599809, 764.957927313992, 773.114783572806, 4873.147199240118, 4893.363862697897, 4921.237208232729, 4966.180580204298, 4982.0, 23546.0, 24653.876730616234, 25309.114181003944, 25487.107951221988, 25523.106691266086, 24631.137910173056, 25003.0, 25055.87472062628, 25170.37074073163, 25213.495730085295, 10220.693379198636, 11260.705018922929, 12449.066320026035, 12591.87408125907, 12745.299008554619, 8594.78513037179, 8606.225439710455, 8627.91372086271, 8661.960564732273, 8689.261412779984, 21246.0, 21407.357779266647, 21471.8926405367, 21551.353459396243, 21714.674279885498, 22611.88694056585, 22808.771912280667, 22897.427564310357, 22987.540249195255, 23004.769952300263, 13658.317084145554, 13960.650983725489, 13996.510122146083, 13997.0, 14004.439822407398, 15602.219889005732, 15671.0, 15750.842491574938, 15786.973846699928, 15950.0, 12401.875981240071, 12486.875131248571, 12520.561780337644, 12693.365331733561, 12896.032797540409, 12190.695232619255, 12252.0, 12272.815907761213, 12500.0, 12695.42870570808, 10856.837147442953, 10870.076043536388, 10876.673699789018, 10941.398223097805, 11030.834537481784, 7432.888506672512, 7481.214472480311, 7487.438442116972, 7502.437317201341, 7512.474126811071, 7808.59944481064, 7814.72648457324, 7890.566018869017, 7920.247576480225, 7951.4036447267845], "value": 7296.31460647075, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.8383259823977, 578.5776383240232, 583.2942140010587, 585.8857522783057, 589.4076453164572, 6344.587601805885, 6395.552311338208, 6399.712012959422, 6403.327650596691, 6454.419102280794, 6139.81580552583, 6148.10852426399, 6167.229096362955, 6184.958963542032, 6274.529410294223, 5127.9230811537855, 5129.743512824362, 5135.229715542661, 5147.510986456281, 5160.148575485059, 5107.259447380127, 5141.5886729061585, 5172.0, 5189.662671926313, 5190.480951904817, 4799.712017278957, 4872.3909511311085, 4885.975570122145, 4894.094592500381, 4948.628852836034, 4914.631402644798, 4957.082939656175, 4967.076009952133, 4979.327790748257, 4996.150654388763, 4511.503734589192, 4511.796969136364, 4523.208438523246, 4526.728396296233, 4533.38799262102, 5942.078977758454, 6148.385161483816, 6177.7837775677635, 6192.814215573495, 6237.906431403532, 5877.706114694291, 5895.145203945447, 5916.4675179233645, 5941.138534912457, 5972.701364931736, 6605.438537724299, 6647.76732814354, 6681.064650948871, 6710.7315707371645, 6803.625800580966, 5065.493450654942, 5085.313482679828, 5112.003159383921, 5115.5396014358885, 5134.563562097226, 6753.4259587935085, 6876.106106206161, 6913.827154321132, 6964.338387853146, 6997.755078572276, 5179.870503237374, 5195.506426889439, 5215.269862219292, 5220.0946654470845, 5249.527542521191, 5249.265102885599, 5277.255826969954, 5278.392984806719, 5278.683279003195, 5324.1747529133045, 5800.622959507618, 5808.651480911159, 5835.35811060783, 5884.32330282023, 5915.645061296336, 6683.131192944983, 6701.39687428124, 6706.93293067063, 6732.730690772314, 6742.224644165885, 1801.6937120689515, 1816.4369045595909, 1817.2549254805467, 1819.963600727978, 1824.8996305203075, 1223.626793827891, 1279.2899940532907, 1287.922724636525, 1299.883010529057, 1310.488909325364, 6205.441510264008, 6270.15352927349, 6279.811605651837, 6301.243850737941, 6309.716062777186, 6581.670916454158, 6771.492138089663, 6810.795676129724, 6836.179658440919, 6853.588784672936, 6165.660888651168, 6179.69101544921, 6195.96902015487, 6198.442140207403, 6246.219222597176, 3479.321532301177, 3575.334188883532, 3583.498310236569, 3602.2615363850346, 3617.9276414471565, 6971.407430368374, 6995.79012629622, 7003.3346832050875, 7071.0, 7075.929240707527, 6747.696353664097, 6917.239103698589, 6931.0246579724535, 6934.583924964519, 6989.615571143636, 6832.965835170892, 6846.691898864563, 6927.792166235021, 6964.547304425196, 7014.508984371045, 6526.379993900762, 6574.572652777554, 6635.369639884203, 6712.697928593323, 6782.423494003065, 6526.216853977553, 6677.232118306457, 6699.263081060982, 6714.328567143247, 6721.563098398588, 6879.346462086094, 6907.0, 6932.306769323028, 6940.861182776215, 7044.471664625071, 5123.28274041627, 5154.355705536808, 5167.560757335668, 5188.688678679291, 5208.244804503402, 6538.705758240795, 6627.801165965029, 6748.865022699617, 6792.150981127359, 6806.693698783665, 6165.84585385369, 6403.551751377545, 6451.419372256331, 6458.580192287486, 6474.546781725234, 6484.735476582021, 6490.188726409199, 6526.4452521536205, 6530.706118224786, 6532.346765323429, 6415.422611964946, 6460.612363258219, 6481.351864813481, 6486.610803351814, 6519.674016299261, 6528.738850445929, 6606.867862642816, 6610.636414997221, 6629.668516574248, 6663.666816659051, 6211.409916057967, 6377.521685873671, 6403.615783053032, 6453.9354606453335, 6476.546641735222], "value": 5186.809039372332, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [958.3195930889073, 962.7448726087586, 974.8683927669763, 976.6180854091461, 994.9751256218593, 20217.797822021774, 20820.271290504817, 20855.37433876986, 20868.478288042807, 20910.37268881934, 17354.47936561902, 17376.0, 19252.229910803588, 19481.805181948213, 19497.707534386995, 1036.108946306176, 1062.8458873463383, 1063.303536183799, 1064.0423618743116, 1064.3667018124204, 1055.0978913029326, 1061.946902654868, 1064.084886997182, 1064.2443864855961, 1066.322884968047, 1088.9237753357268, 1120.9439528023606, 1141.6004398460514, 1141.8173092305233, 1146.0430540498694, 1078.7788503356794, 1116.0959622705634, 1118.5078565431224, 1119.2445099557806, 1130.9660710178666, 814.2142832166928, 814.4095530740166, 814.975550733473, 817.452306954342, 817.9468334558235, 21028.47428814292, 21316.893415532977, 21422.464438389008, 21426.5714685707, 21434.571308573897, 21036.579268414545, 22225.22211722598, 22381.664275035888, 22390.328290151323, 22441.0, 17861.7320740189, 18201.362952296608, 18249.270029198815, 18250.269989200417, 18375.264989400406, 3959.6436320731273, 3988.501437320335, 3992.3612222044626, 3995.20095980805, 3996.860109896169, 138864.0, 157913.0, 161260.0, 161903.0, 162056.9999999988, 17892.46322610324, 17949.461516154537, 18196.63606727858, 18328.0, 18369.08154592265, 34307.0, 34817.12957176091, 34825.65174348275, 35762.82118589443, 36142.63857361393, 9950.651727189514, 9951.054649808257, 9952.601895924226, 10015.148712359385, 10022.649207277711, 4450.287953927356, 4527.071950250191, 4582.656300777455, 4618.56123668251, 4618.930716039262, 5910.940890591039, 6018.578699491081, 6024.819255422344, 6025.0, 6037.366076561985, 1195.205188549622, 1228.7603917236231, 1231.5504840733247, 1243.1981372015, 1253.2793643654934, 736.2931585677702, 748.4798065344534, 749.966251518683, 759.3621358059256, 770.0066913681401, 12606.87393126057, 12732.0, 13407.932960335136, 13855.307234638227, 13979.440822367194, 727.9162896266891, 741.3587247031387, 741.4402126394538, 758.3478208740479, 760.8782594784808, 6189.460432912608, 6236.812895613139, 6279.811605651837, 6293.150424692608, 6354.523410744213, 147896.0, 148122.0, 148129.0, 152118.0, 154487.0, 99684.5015774931, 100021.49989250152, 114845.4257728706, 119400.0, 123251.3837430807, 101831.0, 107088.0, 109886.0, 110443.0, 110989.0, 13760.724785504033, 14048.508302209373, 14060.367283472473, 14194.0, 14229.0, 52735.0, 53050.0, 53113.468865312396, 53366.46633533615, 54254.728726357695, 68278.65860670665, 68451.0, 68671.0, 69696.30303696898, 70311.0, 18382.81617183811, 18511.53721156982, 18854.811451885307, 18896.811031889505, 18923.526911827314, 21576.67634985508, 21625.783742162377, 21771.891140544198, 21854.344369668936, 22162.88918555397, 18389.632207356044, 18493.53766155857, 18583.070846457893, 18675.159617817502, 18678.0, 18256.26974920988, 18266.26934922588, 18280.08599570043, 18337.816621833612, 18908.905455472635, 17464.65070698604, 17592.208350623998, 17607.20767565488, 17653.0, 17656.382026629006, 14480.637984050483, 14531.636709082357, 14821.295551011772, 14983.250837458301, 15037.172955487116, 14953.0, 15368.692626147638, 15397.153156576496, 15406.460773872861, 15490.612734681723], "value": 10054.354231640908, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1381.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 104.0, 105.0, 105.0, 107.0, 110.0, 109.0, 105.0, 106.0, 106.0], "value": 106.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 116.0, 116.0, 112.0, 139.0, 118.0, 113.0, 116.0, 116.0], "value": 117.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 163.0, 162.0, 164.0, 162.0, 163.0, 163.0, 163.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 75.0, 72.0, 73.0, 76.0, 77.0, 74.0, 76.0, 75.0], "value": 74.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 80.0, 78.0, 78.0, 84.0, 78.0, 83.0, 78.0, 79.0], "value": 79.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 113.0, 113.0, 114.0, 110.0, 113.0, 111.0, 113.0, 115.0], "value": 112.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 149.0, 150.0, 150.0, 149.0, 150.0, 149.0, 152.0, 151.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 96.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 44.0, 44.0, 45.0, 43.0, 45.0, 46.0, 45.0, 43.0, 44.0], "value": 44.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 40.0, 38.0, 46.0, 38.0, 38.0, 37.0, 38.0], "value": 38.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 71.0, 75.0, 72.0, 72.0, 73.0, 78.0, 76.0, 73.0, 74.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 105.0, 104.0, 105.0, 105.0, 108.0, 107.0, 112.0, 113.0], "value": 107.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 164.0, 150.0, 159.0, 159.0, 151.0, 162.0, 159.0, 153.0, 158.0], "value": 158.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 64.0, 60.0, 60.0, 61.0, 62.0, 58.0, 64.0], "value": 61.1, "unit": "score"}]}]} 10:51:10 INFO - Return code: 0 10:51:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:51:10 INFO - # TBPL SUCCESS # 10:51:10 INFO - Running post-action listener: _package_coverage_data 10:51:10 INFO - Running post-action listener: _resource_record_post_action 10:51:10 INFO - [mozharness: 2017-09-14 17:51:10.284343Z] Finished run-tests step (success) 10:51:10 INFO - Running post-run listener: _resource_record_post_run 10:51:10 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 8192; Write bytes: 398454784; Read time: 100; Write time: 343680 10:51:10 INFO - TinderboxPrint: CPU usage
13.1% 10:51:10 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 100 10:51:10 INFO - TinderboxPrint: I/O write bytes / time
398,454,784 / 343,680 10:51:10 INFO - TinderboxPrint: CPU idle
8,231.0 (86.9%) 10:51:10 INFO - TinderboxPrint: CPU user
1,188.8 (12.5%) 10:51:10 INFO - TinderboxPrint: Swap in / out
0 / 0 10:51:10 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 0; Write bytes: 75104256; Read time: 0; Write time: 77220 10:51:10 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:51:10 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 8192; Write bytes: 323350528; Read time: 100; Write time: 266460 10:51:10 INFO - Running post-run listener: _upload_blobber_files 10:51:10 INFO - Blob upload gear active. 10:51:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:51:10 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 10:51:10 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'] 10:51:10 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 10:51:11 INFO - (blobuploader) - INFO - Open directory for files ... 10:51:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:51:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:51:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:51:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:51:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:51:12 INFO - (blobuploader) - INFO - Done attempting. 10:51:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:51:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:51:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:51:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:51:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:51:19 INFO - (blobuploader) - INFO - Done attempting. 10:51:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:51:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:51:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:51:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:51:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:51:21 INFO - (blobuploader) - INFO - Done attempting. 10:51:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:51:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:51:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:51:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:51:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:51:22 INFO - (blobuploader) - INFO - Done attempting. 10:51:22 INFO - (blobuploader) - INFO - Iteration through files over. 10:51:22 INFO - Return code: 0 10:51:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:51:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:51:22 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a70a948400ae5f09e34d76f95b56696579e31d5d809011bac4ffff9f753a3408fcef040f416ecb2b381f1a575a2aaa5a25a2fb2f11146b9296322f19149d97ec", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e8715eccf2df74096d4b3106fc1ebec4452d8e2727dcbcaed14f833e673007637115e42404bca6ffdd7206447f8509b92ac88a60963adab4f877d7efedc4a9e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7231f84d777466cff9da03747233779ba51d5c85108575f09d0e6e9c76132d641aa45eedb6d5e4ee04e1730a858be106f23588231abdfc0a14a22007b14e228", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01d26557565874598cf9fd2fc9b7d3b6a31835eb320dd64e3c968bd4df6e834c33f6830e18959a92d6711baa36632854cce921fead98d50817a3061c29a275e4"} 10:51:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:51:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:51:22 INFO - Contents: 10:51:22 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a70a948400ae5f09e34d76f95b56696579e31d5d809011bac4ffff9f753a3408fcef040f416ecb2b381f1a575a2aaa5a25a2fb2f11146b9296322f19149d97ec", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e8715eccf2df74096d4b3106fc1ebec4452d8e2727dcbcaed14f833e673007637115e42404bca6ffdd7206447f8509b92ac88a60963adab4f877d7efedc4a9e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7231f84d777466cff9da03747233779ba51d5c85108575f09d0e6e9c76132d641aa45eedb6d5e4ee04e1730a858be106f23588231abdfc0a14a22007b14e228", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01d26557565874598cf9fd2fc9b7d3b6a31835eb320dd64e3c968bd4df6e834c33f6830e18959a92d6711baa36632854cce921fead98d50817a3061c29a275e4"} 10:51:22 INFO - Running post-run listener: copy_logs_to_upload_dir 10:51:22 INFO - Copying logs to upload dir... 10:51:22 INFO - mkdir: /builds/slave/test/build/upload/logs 10:51:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.817067 ========= master_lag: 0.40 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-14 10:51:22.513300) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 10:51:22.518222) ========= 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=20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697 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/a70a948400ae5f09e34d76f95b56696579e31d5d809011bac4ffff9f753a3408fcef040f416ecb2b381f1a575a2aaa5a25a2fb2f11146b9296322f19149d97ec", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e8715eccf2df74096d4b3106fc1ebec4452d8e2727dcbcaed14f833e673007637115e42404bca6ffdd7206447f8509b92ac88a60963adab4f877d7efedc4a9e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7231f84d777466cff9da03747233779ba51d5c85108575f09d0e6e9c76132d641aa45eedb6d5e4ee04e1730a858be106f23588231abdfc0a14a22007b14e228", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01d26557565874598cf9fd2fc9b7d3b6a31835eb320dd64e3c968bd4df6e834c33f6830e18959a92d6711baa36632854cce921fead98d50817a3061c29a275e4"} build_url:https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011445 build_url: 'https://queue.taskcluster.net/v1/task/GExoNZT9Sqq3GjuszWpuhw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a70a948400ae5f09e34d76f95b56696579e31d5d809011bac4ffff9f753a3408fcef040f416ecb2b381f1a575a2aaa5a25a2fb2f11146b9296322f19149d97ec", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e8715eccf2df74096d4b3106fc1ebec4452d8e2727dcbcaed14f833e673007637115e42404bca6ffdd7206447f8509b92ac88a60963adab4f877d7efedc4a9e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7231f84d777466cff9da03747233779ba51d5c85108575f09d0e6e9c76132d641aa45eedb6d5e4ee04e1730a858be106f23588231abdfc0a14a22007b14e228", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01d26557565874598cf9fd2fc9b7d3b6a31835eb320dd64e3c968bd4df6e834c33f6830e18959a92d6711baa36632854cce921fead98d50817a3061c29a275e4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 10:51:22.553662) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 10:51:22.553997) ========= 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=20e666a3d4cfbb71505a330e000001b4-1505409603.986095-1114898697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004715 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 10:51:22.607713) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 10:51:22.608680) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 10:51:22.608999) ========= ========= Total master_lag: 0.58 =========