builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-008 starttime: 1504203616.66 results: success (0) revision: 4984da22242841a5d84c4e5fd866e93a450d9723 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-31 11:20:16.662852) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-31 11:20:16.663290) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-31 11:20:16.663570) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-31 11:20:16.679251) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 11:20:16.679548) ========= 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=32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-31 11:20:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2017-08-31 11:20:17 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.085333 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 11:20:16.782949) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 11:20:16.783262) ========= 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=32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017983 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 11:20:16.834043) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 11:20:16.834418) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4984da22242841a5d84c4e5fd866e93a450d9723 --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 4984da22242841a5d84c4e5fd866e93a450d9723 --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=32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-31 11:20:17,794 truncating revision to first 12 chars 2017-08-31 11:20:17,794 Setting DEBUG logging. 2017-08-31 11:20:17,794 attempt 1/10 2017-08-31 11:20:17,794 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4984da222428?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-31 11:20:18,099 unpacking tar archive at: mozilla-central-4984da222428/testing/mozharness/ program finished with exit code 0 elapsedTime=0.610454 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 11:20:17.459629) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-31 11:20:17.459953) ========= script_repo_revision: 4984da22242841a5d84c4e5fd866e93a450d9723 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-31 11:20:17.460338) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-31 11:20:17.460604) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-31 11:20:17.476342) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-31 11:20:17.476696) ========= /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=32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:20:18 INFO - MultiFileLogger online at 20170831 11:20:18 in /builds/slave/test 11:20:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:20:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:20:18 INFO - {'append_to_log': False, 11:20:18 INFO - 'base_work_dir': '/builds/slave/test', 11:20:18 INFO - 'blob_upload_branch': 'Firefox', 11:20:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:20:18 INFO - 'branch': 'Firefox', 11:20:18 INFO - 'buildbot_json_path': 'buildprops.json', 11:20:18 INFO - 'code_coverage': False, 11:20:18 INFO - 'config_files': ('talos/linux_config.py',), 11:20:18 INFO - 'default_actions': ('clobber', 11:20:18 INFO - 'read-buildbot-config', 11:20:18 INFO - 'download-and-extract', 11:20:18 INFO - 'populate-webroot', 11:20:18 INFO - 'create-virtualenv', 11:20:18 INFO - 'install', 11:20:18 INFO - 'setup-mitmproxy', 11:20:18 INFO - 'run-tests'), 11:20:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:20:18 INFO - 'disable_ccov_upload': False, 11:20:18 INFO - 'disable_stylo': False, 11:20:18 INFO - 'download_minidump_stackwalk': True, 11:20:18 INFO - 'download_symbols': 'ondemand', 11:20:18 INFO - 'enable_stylo': False, 11:20:18 INFO - 'enable_webrender': False, 11:20:18 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:20:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:20:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:20:18 INFO - 'gecko_profile': False, 11:20:18 INFO - 'gecko_profile_interval': 0, 11:20:18 INFO - 'installer_path': 'installer.exe', 11:20:18 INFO - 'log_level': 'info', 11:20:18 INFO - 'log_name': 'talos', 11:20:18 INFO - 'log_to_console': True, 11:20:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:20:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:20:18 INFO - 'opt_config_files': (), 11:20:18 INFO - 'pip_index': False, 11:20:18 INFO - 'suite': 'dromaeojs-e10s', 11:20:18 INFO - 'system_bits': '32', 11:20:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:20:18 INFO - 'title': 'talos-linux64-ix-008', 11:20:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:20:18 INFO - 'use_talos_json': True, 11:20:18 INFO - 'verify': 'False', 11:20:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:20:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:20:18 INFO - 'work_dir': 'build'} 11:20:18 INFO - [mozharness: 2017-08-31 18:20:18.577775Z] Running clobber step. 11:20:18 INFO - Running pre-action listener: _resource_record_pre_action 11:20:18 INFO - Running main action method: clobber 11:20:18 INFO - rmtree: /builds/slave/test/build 11:20:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:20:19 INFO - Running post-action listener: _resource_record_post_action 11:20:19 INFO - [mozharness: 2017-08-31 18:20:19.586794Z] Finished clobber step (success) 11:20:19 INFO - [mozharness: 2017-08-31 18:20:19.586892Z] Running read-buildbot-config step. 11:20:19 INFO - Running pre-action listener: _resource_record_pre_action 11:20:19 INFO - Running main action method: read_buildbot_config 11:20:19 INFO - Using buildbot properties: 11:20:19 INFO - { 11:20:19 INFO - "project": "", 11:20:19 INFO - "product": "firefox", 11:20:19 INFO - "who": "ffxbld@noreply.mozilla.org", 11:20:19 INFO - "installer_path": "public/build/target.tar.bz2", 11:20:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 11:20:19 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:20:19 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 11:20:19 INFO - "stage_platform": "linux64-stylosequential", 11:20:19 INFO - "basedir": "/builds/slave/test", 11:20:19 INFO - "buildnumber": 52, 11:20:19 INFO - "platform": "ubuntu64_hw_styloseq", 11:20:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:20:19 INFO - "slavebuilddir": "test", 11:20:19 INFO - "taskId": "V-AfhYhxR4GLoj_6zVMf7w", 11:20:19 INFO - "branch": "mozilla-central", 11:20:19 INFO - "script_repo_revision": "production", 11:20:19 INFO - "revision": "4984da22242841a5d84c4e5fd866e93a450d9723", 11:20:19 INFO - "slavename": "talos-linux64-ix-008", 11:20:19 INFO - "repo_path": "mozilla-central" 11:20:19 INFO - } 11:20:19 INFO - Finding installer, test and symbols from parent task. 11:20:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V-AfhYhxR4GLoj_6zVMf7w'}, attempt #1 11:20:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V-AfhYhxR4GLoj_6zVMf7w'}, attempt #1 11:20:20 INFO - Task dependencies: JlZ4lx7RTwaSgq5fLFMGvQ 11:20:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ'}, attempt #1 11:20:21 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.tar.bz2 11:20:21 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.test_packages.json 11:20:21 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.crashreporter-symbols.zip 11:20:21 INFO - Running post-action listener: _resource_record_post_action 11:20:21 INFO - [mozharness: 2017-08-31 18:20:21.086745Z] Finished read-buildbot-config step (success) 11:20:21 INFO - [mozharness: 2017-08-31 18:20:21.086961Z] Running download-and-extract step. 11:20:21 INFO - Running pre-action listener: _resource_record_pre_action 11:20:21 INFO - Running main action method: download_and_extract 11:20:21 INFO - mkdir: /builds/slave/test/build/tests 11:20: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')]} 11:20:21 INFO - trying https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.test_packages.json 11:20:21 INFO - Downloading https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:20:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:20:21 INFO - Downloaded 989 bytes. 11:20:21 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:20:21 INFO - Using the following test package requirements: 11:20:21 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:20:21 INFO - u'common': [u'target.common.tests.zip'], 11:20:21 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:20:21 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:20:21 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:20:21 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:20:21 INFO - u'mozbase': [u'target.common.tests.zip'], 11:20:21 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:20:21 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:20:21 INFO - u'web-platform': [u'target.common.tests.zip', 11:20:21 INFO - u'target.web-platform.tests.tar.gz'], 11:20:21 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:20:21 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:20:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.common.tests.zip 11:20:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:20:21 INFO - Fetch https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.common.tests.zip into memory 11:20:22 INFO - Content-Length response header: 54932997 11:20:22 INFO - Bytes received: 54932997 11:20:33 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:20:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.common.tests.zip 11:20:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:20:33 INFO - Fetch https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.common.tests.zip into memory 11:20:37 INFO - Content-Length response header: 54932997 11:20:37 INFO - Bytes received: 54932997 11:20:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.talos.tests.zip 11:20:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:20:49 INFO - Fetch https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.talos.tests.zip into memory 11:20:50 INFO - Content-Length response header: 14496650 11:20:50 INFO - Bytes received: 14496650 11:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:50 INFO - trying https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.tar.bz2 11:20:50 INFO - Downloading https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:20:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:20:52 INFO - Downloaded 62586538 bytes. 11:20:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.tar.bz2 11:20:52 INFO - mkdir: /builds/slave/test/properties 11:20:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:20:52 INFO - Writing to file /builds/slave/test/properties/build_url 11:20:52 INFO - Contents: 11:20:52 INFO - build_url:https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.tar.bz2 11:20:52 INFO - Running post-action listener: _resource_record_post_action 11:20:52 INFO - Running post-action listener: find_tests_for_verification 11:20:52 INFO - Running post-action listener: set_extra_try_arguments 11:20:52 INFO - [mozharness: 2017-08-31 18:20:52.064775Z] Finished download-and-extract step (success) 11:20:52 INFO - [mozharness: 2017-08-31 18:20:52.064872Z] Running populate-webroot step. 11:20:52 INFO - Running pre-action listener: _resource_record_pre_action 11:20:52 INFO - Running main action method: populate_webroot 11:20:52 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:20:52 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:20:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:20:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:20:52 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:20:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:20:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:20:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:52 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:20:52 INFO - 'talos_options': ['--enable-stylo'], 11:20:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:20:52 INFO - 'tests': ['damp', 'tps']}, 11:20:52 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:20:52 INFO - 'talos_options': ['--enable-stylo'], 11:20:52 INFO - 'tests': ['damp', 'tps']}, 11:20:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:20:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:20:52 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:20:52 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 11:20:52 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:20:52 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:20:52 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:20:52 INFO - 'talos_options': ['--enable-stylo'], 11:20:52 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:20:52 INFO - 'other-e10s': {'tests': ['a11yr', 11:20:52 INFO - 'ts_paint', 11:20:52 INFO - 'tpaint', 11:20:52 INFO - 'sessionrestore', 11:20:52 INFO - 'sessionrestore_many_windows', 11:20:52 INFO - 'sessionrestore_no_auto_restore', 11:20:52 INFO - 'tabpaint']}, 11:20:52 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:20:52 INFO - 'tests': ['a11yr', 11:20:52 INFO - 'ts_paint', 11:20:52 INFO - 'tpaint', 11:20:52 INFO - 'sessionrestore', 11:20:52 INFO - 'sessionrestore_many_windows', 11:20:52 INFO - 'sessionrestore_no_auto_restore', 11:20:52 INFO - 'tabpaint']}, 11:20:52 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:20:52 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:20:52 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:20:52 INFO - 'tests': ['bloom_basic_singleton']}, 11:20:52 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:20:52 INFO - 'tests': ['bloom_basic']}, 11:20:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:20:52 INFO - 'tsvgr_opacity', 11:20:52 INFO - 'tart', 11:20:52 INFO - 'tscrollx', 11:20:52 INFO - 'tsvg_static']}, 11:20:52 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:20:52 INFO - 'tests': ['tsvgx', 11:20:52 INFO - 'tsvgr_opacity', 11:20:52 INFO - 'tart', 11:20:52 INFO - 'tscrollx', 11:20:52 INFO - 'tsvg_static']}, 11:20:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:20:52 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:20:52 INFO - 'talos_options': ['--enable-stylo'], 11:20:52 INFO - 'tests': ['tp5o']}, 11:20:52 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:20:52 INFO - 'talos_options': ['--mitmproxy', 11:20:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:20:52 INFO - '--firstNonBlankPaint'], 11:20:52 INFO - 'tests': ['tp6_google', 11:20:52 INFO - 'tp6_youtube', 11:20:52 INFO - 'tp6_amazon', 11:20:52 INFO - 'tp6_facebook']}, 11:20:52 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:20:52 INFO - 'talos_options': ['--enable-stylo', 11:20:52 INFO - '--mitmproxy', 11:20:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:20:52 INFO - '--firstNonBlankPaint'], 11:20:52 INFO - 'tests': ['tp6_google', 11:20:52 INFO - 'tp6_youtube', 11:20:52 INFO - 'tp6_amazon', 11:20:52 INFO - 'tp6_facebook']}, 11:20:52 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:20:52 INFO - 'talos_options': ['--enable-stylo', 11:20:52 INFO - '--stylo-threads=1', 11:20:52 INFO - '--mitmproxy', 11:20:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:20:52 INFO - '--firstNonBlankPaint'], 11:20:52 INFO - 'tests': ['tp6_google', 11:20:52 INFO - 'tp6_youtube', 11:20:52 INFO - 'tp6_amazon', 11:20:52 INFO - 'tp6_facebook']}, 11:20:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:20:52 INFO - 'talos_options': ['--xperf_path', 11:20:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:52 INFO - 'tests': ['tp5n']}, 11:20:52 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:20:52 INFO - 'talos_options': ['--enable-stylo', 11:20:52 INFO - '--xperf_path', 11:20:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:52 INFO - 'tests': ['tp5n']}}} 11:20:52 INFO - Running post-action listener: _resource_record_post_action 11:20:52 INFO - [mozharness: 2017-08-31 18:20:52.079158Z] Finished populate-webroot step (success) 11:20:52 INFO - [mozharness: 2017-08-31 18:20:52.079247Z] Running create-virtualenv step. 11:20:52 INFO - Running pre-action listener: _resource_record_pre_action 11:20:52 INFO - Running main action method: create_virtualenv 11:20:52 INFO - Creating virtualenv /builds/slave/test/build/venv 11:20:52 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:20:52 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:20:52 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:20:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:20:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:20:52 INFO - Installing distribute.............................................................................................................................................................................................done. 11:20:52 INFO - Installing pip...............done. 11:20:52 INFO - Return code: 0 11:20:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:20:53 INFO - Reading from file tmpfile_stdout 11:20:53 INFO - Output received: 11:20:53 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:20:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:53 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 0x223c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2404a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25abb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a8580>, '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 0x25a9480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a9910>, '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': '32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:20:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:20:53 INFO - Using env: {'DISPLAY': ':0', 11:20:53 INFO - 'HOME': '/home/cltbld', 11:20:53 INFO - 'LANG': 'en_US.UTF-8', 11:20:53 INFO - 'LANGUAGE': 'en_US:en', 11:20:53 INFO - 'LOGNAME': 'cltbld', 11:20:53 INFO - 'MAIL': '/var/mail/cltbld', 11:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:53 INFO - 'MOZ_NO_REMOTE': '1', 11:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:53 INFO - 'NO_EM_RESTART': '1', 11:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:53 INFO - 'PWD': '/builds/slave/test', 11:20:53 INFO - 'SHELL': '/bin/bash', 11:20:53 INFO - 'SHLVL': '1', 11:20:53 INFO - 'TERM': 'linux', 11:20:53 INFO - 'TMOUT': '86400', 11:20:53 INFO - 'USER': 'cltbld', 11:20:53 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532', 11:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:53 INFO - '_': '/tools/buildbot/bin/python'} 11:20:54 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:20:54 INFO - Downloading/unpacking pip>=1.5 11:20:54 INFO - Running setup.py egg_info for package pip 11:20:54 INFO - warning: no files found matching 'pip/cacert.pem' 11:20:54 INFO - warning: no files found matching '*.html' under directory 'docs' 11:20:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:20:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:20:54 INFO - Installing collected packages: pip 11:20:54 INFO - Found existing installation: pip 1.1 11:20:54 INFO - Uninstalling pip: 11:20:54 INFO - Successfully uninstalled pip 11:20:54 INFO - Running setup.py install for pip 11:20:54 INFO - warning: no files found matching 'pip/cacert.pem' 11:20:54 INFO - warning: no files found matching '*.html' under directory 'docs' 11:20:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:20:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:20:54 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:20:54 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:20:54 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:20:54 INFO - Successfully installed pip 11:20:54 INFO - Cleaning up... 11:20:54 INFO - Return code: 0 11:20:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x223c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2404a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25abb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a8580>, '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 0x25a9480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a9910>, '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': '32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:20:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:20:54 INFO - Using env: {'DISPLAY': ':0', 11:20:54 INFO - 'HOME': '/home/cltbld', 11:20:54 INFO - 'LANG': 'en_US.UTF-8', 11:20:54 INFO - 'LANGUAGE': 'en_US:en', 11:20:54 INFO - 'LOGNAME': 'cltbld', 11:20:54 INFO - 'MAIL': '/var/mail/cltbld', 11:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:54 INFO - 'MOZ_NO_REMOTE': '1', 11:20:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:54 INFO - 'NO_EM_RESTART': '1', 11:20:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:54 INFO - 'PWD': '/builds/slave/test', 11:20:54 INFO - 'SHELL': '/bin/bash', 11:20:54 INFO - 'SHLVL': '1', 11:20:54 INFO - 'TERM': 'linux', 11:20:54 INFO - 'TMOUT': '86400', 11:20:54 INFO - 'USER': 'cltbld', 11:20:54 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532', 11:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:54 INFO - '_': '/tools/buildbot/bin/python'} 11:20:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:54 INFO - Downloading/unpacking psutil>=3.1.1 11:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:20:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:55 INFO - Installing collected packages: psutil 11:20:55 INFO - Running setup.py install for psutil 11:20:55 INFO - building 'psutil._psutil_linux' extension 11:20:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:20:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:20:55 INFO - building 'psutil._psutil_posix' extension 11:20:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:20:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:20:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:56 INFO - Successfully installed psutil 11:20:56 INFO - Cleaning up... 11:20:56 INFO - Return code: 0 11:20:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:20:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2404a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25abb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a8580>, '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 0x25a9480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a9910>, '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': '32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:20:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:20:56 INFO - Using env: {'DISPLAY': ':0', 11:20:56 INFO - 'HOME': '/home/cltbld', 11:20:56 INFO - 'LANG': 'en_US.UTF-8', 11:20:56 INFO - 'LANGUAGE': 'en_US:en', 11:20:56 INFO - 'LOGNAME': 'cltbld', 11:20:56 INFO - 'MAIL': '/var/mail/cltbld', 11:20:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:56 INFO - 'MOZ_NO_REMOTE': '1', 11:20:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:56 INFO - 'NO_EM_RESTART': '1', 11:20:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:56 INFO - 'PWD': '/builds/slave/test', 11:20:56 INFO - 'SHELL': '/bin/bash', 11:20:56 INFO - 'SHLVL': '1', 11:20:56 INFO - 'TERM': 'linux', 11:20:56 INFO - 'TMOUT': '86400', 11:20:56 INFO - 'USER': 'cltbld', 11:20:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532', 11:20:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:56 INFO - '_': '/tools/buildbot/bin/python'} 11:20:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:20:57 INFO - Installing collected packages: mozsystemmonitor 11:20:57 INFO - Running setup.py install for mozsystemmonitor 11:20:57 INFO - Successfully installed mozsystemmonitor 11:20:57 INFO - Cleaning up... 11:20:57 INFO - Return code: 0 11:20:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:57 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 0x223c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2404a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25abb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a8580>, '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 0x25a9480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a9910>, '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': '32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:20:57 INFO - Using env: {'DISPLAY': ':0', 11:20:57 INFO - 'HOME': '/home/cltbld', 11:20:57 INFO - 'LANG': 'en_US.UTF-8', 11:20:57 INFO - 'LANGUAGE': 'en_US:en', 11:20:57 INFO - 'LOGNAME': 'cltbld', 11:20:57 INFO - 'MAIL': '/var/mail/cltbld', 11:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:57 INFO - 'MOZ_NO_REMOTE': '1', 11:20:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:57 INFO - 'NO_EM_RESTART': '1', 11:20:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:57 INFO - 'PWD': '/builds/slave/test', 11:20:57 INFO - 'SHELL': '/bin/bash', 11:20:57 INFO - 'SHLVL': '1', 11:20:57 INFO - 'TERM': 'linux', 11:20:57 INFO - 'TMOUT': '86400', 11:20:57 INFO - 'USER': 'cltbld', 11:20:57 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532', 11:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:57 INFO - '_': '/tools/buildbot/bin/python'} 11:20:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:57 INFO - Downloading/unpacking jsonschema==2.5.1 11:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:20:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:59 INFO - Downloading functools32-3.2.3-2.tar.gz 11:20:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:20:59 INFO - warning: no files found matching '*.txt' 11:20:59 INFO - no previously-included directories found matching 'build' 11:20:59 INFO - no previously-included directories found matching 'dist' 11:20:59 INFO - no previously-included directories found matching '.git*' 11:20:59 INFO - Installing collected packages: jsonschema, functools32 11:20:59 INFO - Running setup.py install for functools32 11:20:59 INFO - warning: no files found matching '*.txt' 11:20:59 INFO - no previously-included directories found matching 'build' 11:20:59 INFO - no previously-included directories found matching 'dist' 11:20:59 INFO - no previously-included directories found matching '.git*' 11:20:59 INFO - Successfully installed jsonschema functools32 11:20:59 INFO - Cleaning up... 11:20:59 INFO - Return code: 0 11:20:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:20: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')]} 11:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20: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')]} 11:20:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:59 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 0x223c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2404a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25abb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a8580>, '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 0x25a9480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a9910>, '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': '32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:20:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:20:59 INFO - Using env: {'DISPLAY': ':0', 11:20:59 INFO - 'HOME': '/home/cltbld', 11:20:59 INFO - 'LANG': 'en_US.UTF-8', 11:20:59 INFO - 'LANGUAGE': 'en_US:en', 11:20:59 INFO - 'LOGNAME': 'cltbld', 11:20:59 INFO - 'MAIL': '/var/mail/cltbld', 11:20:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:59 INFO - 'MOZ_NO_REMOTE': '1', 11:20:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:59 INFO - 'NO_EM_RESTART': '1', 11:20:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:59 INFO - 'PWD': '/builds/slave/test', 11:20:59 INFO - 'SHELL': '/bin/bash', 11:20:59 INFO - 'SHLVL': '1', 11:20:59 INFO - 'TERM': 'linux', 11:20:59 INFO - 'TMOUT': '86400', 11:20:59 INFO - 'USER': 'cltbld', 11:20:59 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532', 11:20:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:59 INFO - '_': '/tools/buildbot/bin/python'} 11:20:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:20:59 INFO - Cleaning up... 11:20:59 INFO - Return code: 0 11:20:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:20: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')]} 11:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20: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')]} 11:20:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:59 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 0x223c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2404a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25abb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a8580>, '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 0x25a9480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a9910>, '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': '32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:20:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:20:59 INFO - Using env: {'DISPLAY': ':0', 11:20:59 INFO - 'HOME': '/home/cltbld', 11:20:59 INFO - 'LANG': 'en_US.UTF-8', 11:20:59 INFO - 'LANGUAGE': 'en_US:en', 11:20:59 INFO - 'LOGNAME': 'cltbld', 11:20:59 INFO - 'MAIL': '/var/mail/cltbld', 11:20:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:59 INFO - 'MOZ_NO_REMOTE': '1', 11:20:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:59 INFO - 'NO_EM_RESTART': '1', 11:20:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:59 INFO - 'PWD': '/builds/slave/test', 11:20:59 INFO - 'SHELL': '/bin/bash', 11:20:59 INFO - 'SHLVL': '1', 11:20:59 INFO - 'TERM': 'linux', 11:20:59 INFO - 'TMOUT': '86400', 11:20:59 INFO - 'USER': 'cltbld', 11:20:59 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532', 11:20:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:59 INFO - '_': '/tools/buildbot/bin/python'} 11:20:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:59 INFO - Downloading/unpacking blobuploader==1.2.4 11:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:00 INFO - Downloading blobuploader-1.2.4.tar.gz 11:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:21:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:21:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:01 INFO - Downloading docopt-0.6.1.tar.gz 11:21:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:21:01 INFO - Installing collected packages: blobuploader, requests, docopt 11:21:01 INFO - Running setup.py install for blobuploader 11:21:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:21:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:21:01 INFO - Running setup.py install for requests 11:21:02 INFO - Running setup.py install for docopt 11:21:02 INFO - Successfully installed blobuploader requests docopt 11:21:02 INFO - Cleaning up... 11:21:02 INFO - Return code: 0 11:21:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21: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')]} 11:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21: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')]} 11:21:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:02 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 0x223c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2404a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25abb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a8580>, '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 0x25a9480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a9910>, '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': '32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:21:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:21:02 INFO - Using env: {'DISPLAY': ':0', 11:21:02 INFO - 'HOME': '/home/cltbld', 11:21:02 INFO - 'LANG': 'en_US.UTF-8', 11:21:02 INFO - 'LANGUAGE': 'en_US:en', 11:21:02 INFO - 'LOGNAME': 'cltbld', 11:21:02 INFO - 'MAIL': '/var/mail/cltbld', 11:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:02 INFO - 'MOZ_NO_REMOTE': '1', 11:21:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:02 INFO - 'NO_EM_RESTART': '1', 11:21:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:02 INFO - 'PWD': '/builds/slave/test', 11:21:02 INFO - 'SHELL': '/bin/bash', 11:21:02 INFO - 'SHLVL': '1', 11:21:02 INFO - 'TERM': 'linux', 11:21:02 INFO - 'TMOUT': '86400', 11:21:02 INFO - 'USER': 'cltbld', 11:21:02 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532', 11:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:02 INFO - '_': '/tools/buildbot/bin/python'} 11:21:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:21:02 INFO - Running setup.py (path:/tmp/pip-nNY55t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:21:02 INFO - Running setup.py (path:/tmp/pip-qkAJ06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:21:02 INFO - Running setup.py (path:/tmp/pip-4n9RFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:21:02 INFO - Running setup.py (path:/tmp/pip-4xGWHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:21:02 INFO - Running setup.py (path:/tmp/pip-AeQGDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:21:02 INFO - Running setup.py (path:/tmp/pip-owIPN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:21:02 INFO - Running setup.py (path:/tmp/pip-Aa4DQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:21:02 INFO - Running setup.py (path:/tmp/pip-uC8pyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:21:02 INFO - Running setup.py (path:/tmp/pip-whDIm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:21:03 INFO - Running setup.py (path:/tmp/pip-Yih1Ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:21:03 INFO - Running setup.py (path:/tmp/pip-bOf1g_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:21:03 INFO - Running setup.py (path:/tmp/pip-gTkLtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:21:03 INFO - Running setup.py (path:/tmp/pip-1UxsxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:21:03 INFO - Running setup.py (path:/tmp/pip-ndJ0Dl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:03 INFO - Running setup.py (path:/tmp/pip-ykWNJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:21:03 INFO - Running setup.py (path:/tmp/pip-zm8VpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:21:03 INFO - Running setup.py (path:/tmp/pip-GAuoCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:21:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:21:03 INFO - Running setup.py install for manifestparser 11:21:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:21:03 INFO - Running setup.py install for mozcrash 11:21:03 INFO - Running setup.py install for mozdebug 11:21:03 INFO - Running setup.py install for mozdevice 11:21:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:21:03 INFO - Running setup.py install for mozfile 11:21:04 INFO - Running setup.py install for mozhttpd 11:21:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:21:04 INFO - Running setup.py install for mozinfo 11:21:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:21:04 INFO - Running setup.py install for mozInstall 11:21:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:21:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:21:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:21:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:21:04 INFO - Running setup.py install for mozleak 11:21:04 INFO - Running setup.py install for mozlog 11:21:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:21:04 INFO - Running setup.py install for moznetwork 11:21:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:21:04 INFO - Running setup.py install for mozprocess 11:21:04 INFO - Running setup.py install for mozprofile 11:21:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:21:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:21:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:21:04 INFO - Running setup.py install for mozrunner 11:21:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:21:05 INFO - Running setup.py install for mozscreenshot 11:21:05 INFO - Running setup.py install for moztest 11:21:05 INFO - Running setup.py install for mozversion 11:21:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:21:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:21:05 INFO - Cleaning up... 11:21:05 INFO - Return code: 0 11:21:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:05 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 0x223c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2404a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25abb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a8580>, '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 0x25a9480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a9910>, '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': '32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:21:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:21:05 INFO - Using env: {'DISPLAY': ':0', 11:21:05 INFO - 'HOME': '/home/cltbld', 11:21:05 INFO - 'LANG': 'en_US.UTF-8', 11:21:05 INFO - 'LANGUAGE': 'en_US:en', 11:21:05 INFO - 'LOGNAME': 'cltbld', 11:21:05 INFO - 'MAIL': '/var/mail/cltbld', 11:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:05 INFO - 'MOZ_NO_REMOTE': '1', 11:21:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:05 INFO - 'NO_EM_RESTART': '1', 11:21:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:05 INFO - 'PWD': '/builds/slave/test', 11:21:05 INFO - 'SHELL': '/bin/bash', 11:21:05 INFO - 'SHLVL': '1', 11:21:05 INFO - 'TERM': 'linux', 11:21:05 INFO - 'TMOUT': '86400', 11:21:05 INFO - 'USER': 'cltbld', 11:21:05 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532', 11:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:05 INFO - '_': '/tools/buildbot/bin/python'} 11:21:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:21:05 INFO - Running setup.py (path:/tmp/pip-tAiAA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:21:05 INFO - Running setup.py (path:/tmp/pip-rEi5a4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:21:05 INFO - Running setup.py (path:/tmp/pip-eKJSF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:21:05 INFO - Running setup.py (path:/tmp/pip-cm4GD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:21:05 INFO - Running setup.py (path:/tmp/pip-yPZd4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:21:05 INFO - Running setup.py (path:/tmp/pip-8arJlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:21:06 INFO - Running setup.py (path:/tmp/pip-04I5cT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:21:06 INFO - Running setup.py (path:/tmp/pip-1yfcX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:21:06 INFO - Running setup.py (path:/tmp/pip-SdVmPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:21:06 INFO - Running setup.py (path:/tmp/pip-ZJeVUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:21:06 INFO - Running setup.py (path:/tmp/pip-bvC0fz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:21:06 INFO - Running setup.py (path:/tmp/pip-pJZ268-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:21:06 INFO - Running setup.py (path:/tmp/pip-HbwF9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:21:06 INFO - Running setup.py (path:/tmp/pip-MRFxRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:06 INFO - Running setup.py (path:/tmp/pip-Xv8b5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:21:06 INFO - Running setup.py (path:/tmp/pip-e4ifNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:21:06 INFO - Running setup.py (path:/tmp/pip-asazcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:21:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:21: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 11:21: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 11:21: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 11:21: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 11:21:07 INFO - Downloading blessings-1.6.tar.gz 11:21:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:21:07 INFO - Installing collected packages: blessings 11:21:07 INFO - Running setup.py install for blessings 11:21:08 INFO - Successfully installed blessings 11:21:08 INFO - Cleaning up... 11:21:08 INFO - Return code: 0 11:21:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:21:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:08 INFO - Reading from file tmpfile_stdout 11:21:08 INFO - Current package versions: 11:21:08 INFO - argparse == 1.2.1 11:21:08 INFO - blessings == 1.6 11:21:08 INFO - blobuploader == 1.2.4 11:21:08 INFO - docopt == 0.6.1 11:21:08 INFO - functools32 == 3.2.3-2 11:21:08 INFO - jsonschema == 2.5.1 11:21:08 INFO - manifestparser == 1.1 11:21:08 INFO - mozInstall == 1.13 11:21:08 INFO - mozcrash == 1.0 11:21:08 INFO - mozdebug == 0.1 11:21:08 INFO - mozdevice == 0.51 11:21:08 INFO - mozfile == 1.2 11:21:08 INFO - mozhttpd == 0.7 11:21:08 INFO - mozinfo == 0.10 11:21:08 INFO - mozleak == 0.1 11:21:08 INFO - mozlog == 3.5 11:21:08 INFO - moznetwork == 0.27 11:21:08 INFO - mozprocess == 0.25 11:21:08 INFO - mozprofile == 0.28 11:21:08 INFO - mozrunner == 6.13 11:21:08 INFO - mozscreenshot == 0.1 11:21:08 INFO - mozsystemmonitor == 0.3 11:21:08 INFO - moztest == 0.8 11:21:08 INFO - mozversion == 1.4 11:21:08 INFO - psutil == 3.1.1 11:21:08 INFO - requests == 1.2.3 11:21:08 INFO - wsgiref == 0.1.2 11:21:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21: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')]} 11:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21: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')]} 11:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:08 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 0x223c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2404a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25abb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a8580>, '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 0x25a9480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a9910>, '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': '32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:21:08 INFO - Using env: {'DISPLAY': ':0', 11:21:08 INFO - 'HOME': '/home/cltbld', 11:21:08 INFO - 'LANG': 'en_US.UTF-8', 11:21:08 INFO - 'LANGUAGE': 'en_US:en', 11:21:08 INFO - 'LOGNAME': 'cltbld', 11:21:08 INFO - 'MAIL': '/var/mail/cltbld', 11:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:08 INFO - 'MOZ_NO_REMOTE': '1', 11:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:08 INFO - 'NO_EM_RESTART': '1', 11:21:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:08 INFO - 'PWD': '/builds/slave/test', 11:21:08 INFO - 'SHELL': '/bin/bash', 11:21:08 INFO - 'SHLVL': '1', 11:21:08 INFO - 'TERM': 'linux', 11:21:08 INFO - 'TMOUT': '86400', 11:21:08 INFO - 'USER': 'cltbld', 11:21:08 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532', 11:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:08 INFO - '_': '/tools/buildbot/bin/python'} 11:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:21:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:21: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 11:21: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 11:21: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 11:21: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 11:21:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:21:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:21:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:21:09 INFO - Installing collected packages: simplejson 11:21:09 INFO - Running setup.py install for simplejson 11:21:09 INFO - building 'simplejson._speedups' extension 11:21:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:21:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:21:10 INFO - Successfully installed simplejson 11:21:10 INFO - Cleaning up... 11:21:10 INFO - Return code: 0 11:21:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:21: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')]} 11:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21: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')]} 11:21:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2404a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25abb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a8580>, '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 0x25a9480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a9910>, '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': '32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21: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', 'jsonschema'] in /builds/slave/test/build 11:21: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 jsonschema 11:21:10 INFO - Using env: {'DISPLAY': ':0', 11:21:10 INFO - 'HOME': '/home/cltbld', 11:21:10 INFO - 'LANG': 'en_US.UTF-8', 11:21:10 INFO - 'LANGUAGE': 'en_US:en', 11:21:10 INFO - 'LOGNAME': 'cltbld', 11:21:10 INFO - 'MAIL': '/var/mail/cltbld', 11:21:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:10 INFO - 'MOZ_NO_REMOTE': '1', 11:21:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:10 INFO - 'NO_EM_RESTART': '1', 11:21:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:10 INFO - 'PWD': '/builds/slave/test', 11:21:10 INFO - 'SHELL': '/bin/bash', 11:21:10 INFO - 'SHLVL': '1', 11:21:10 INFO - 'TERM': 'linux', 11:21:10 INFO - 'TMOUT': '86400', 11:21:10 INFO - 'USER': 'cltbld', 11:21:10 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532', 11:21:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:10 INFO - '_': '/tools/buildbot/bin/python'} 11:21:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:21:11 INFO - Cleaning up... 11:21:11 INFO - Return code: 0 11:21:11 INFO - Running post-action listener: _resource_record_post_action 11:21:11 INFO - Running post-action listener: _start_resource_monitoring 11:21:11 INFO - Starting resource monitoring. 11:21:11 INFO - [mozharness: 2017-08-31 18:21:11.053961Z] Finished create-virtualenv step (success) 11:21:11 INFO - [mozharness: 2017-08-31 18:21:11.054469Z] Running install step. 11:21:11 INFO - Running pre-action listener: _resource_record_pre_action 11:21:11 INFO - Running main action method: install 11:21:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:11 INFO - Reading from file tmpfile_stdout 11:21:11 INFO - Detecting whether we're running mozinstall >=1.0... 11:21:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:21:11 INFO - Reading from file tmpfile_stdout 11:21:11 INFO - Output received: 11:21:11 INFO - Usage: mozinstall [options] installer 11:21:11 INFO - Options: 11:21:11 INFO - -h, --help show this help message and exit 11:21:11 INFO - -d DEST, --destination=DEST 11:21:11 INFO - Directory to install application into. [default: 11:21:11 INFO - "/builds/slave/test"] 11:21:11 INFO - --app=APP Application being installed. [default: firefox] 11:21:11 INFO - mkdir: /builds/slave/test/build/application 11:21:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:21:27 INFO - Reading from file tmpfile_stdout 11:21:27 INFO - Output received: 11:21:27 INFO - /builds/slave/test/build/application/firefox/firefox 11:21:27 INFO - Running post-action listener: _resource_record_post_action 11:21:27 INFO - [mozharness: 2017-08-31 18:21:27.902220Z] Finished install step (success) 11:21:27 INFO - [mozharness: 2017-08-31 18:21:27.902472Z] Running setup-mitmproxy step. 11:21:27 INFO - Running pre-action listener: _resource_record_pre_action 11:21:27 INFO - Running main action method: setup_mitmproxy 11:21:27 INFO - Skipping: mitmproxy is not required 11:21:27 INFO - Running post-action listener: _resource_record_post_action 11:21:27 INFO - [mozharness: 2017-08-31 18:21:27.903600Z] Finished setup-mitmproxy step (success) 11:21:27 INFO - [mozharness: 2017-08-31 18:21:27.903819Z] Running run-tests step. 11:21:27 INFO - Running pre-action listener: _resource_record_pre_action 11:21:27 INFO - Running pre-action listener: _set_gcov_prefix 11:21:27 INFO - Running main action method: run_tests 11:21:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:21:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:21:27 INFO - Python 2.7.3 11:21:27 INFO - Return code: 0 11:21:27 INFO - grabbing minidump binary from tooltool 11:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:27 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 0x25a8580>, '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 0x25a9480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a9910>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:21:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:21:27 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:21:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:21:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:21:28 INFO - Return code: 0 11:21:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:21:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:21:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:21:28 INFO - ENV: RUST_BACKTRACE is now full 11:21:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:21:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:21:28 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/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:21:28 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/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:21:28 INFO - Using env: {'DISPLAY': ':0', 11:21:28 INFO - 'HOME': '/home/cltbld', 11:21:28 INFO - 'LANG': 'en_US.UTF-8', 11:21:28 INFO - 'LANGUAGE': 'en_US:en', 11:21:28 INFO - 'LOGNAME': 'cltbld', 11:21:28 INFO - 'MAIL': '/var/mail/cltbld', 11:21:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:21:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:28 INFO - 'MOZ_NO_REMOTE': '1', 11:21:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:28 INFO - 'NO_EM_RESTART': '1', 11:21:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:28 INFO - 'PWD': '/builds/slave/test', 11:21:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:21:28 INFO - 'RUST_BACKTRACE': 'full', 11:21:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:21:28 INFO - 'SHELL': '/bin/bash', 11:21:28 INFO - 'SHLVL': '1', 11:21:28 INFO - 'STYLO_FORCE_ENABLED': '1', 11:21:28 INFO - 'STYLO_THREADS': '1', 11:21:28 INFO - 'TERM': 'linux', 11:21:28 INFO - 'TMOUT': '86400', 11:21:28 INFO - 'USER': 'cltbld', 11:21:28 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532', 11:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:28 INFO - '_': '/tools/buildbot/bin/python'} 11:21:28 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/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:21:28 INFO - mozversion application_buildid: 20170831172745 11:21:28 INFO - mozversion application_changeset: 4984da22242841a5d84c4e5fd866e93a450d9723 11:21:28 INFO - mozversion application_display_name: Nightly 11:21:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:21:28 INFO - mozversion application_name: Firefox 11:21:28 INFO - mozversion application_remotingname: firefox 11:21:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:21:28 INFO - mozversion application_vendor: Mozilla 11:21:28 INFO - mozversion application_version: 57.0a1 11:21:28 INFO - mozversion platform_buildid: 20170831172745 11:21:28 INFO - mozversion platform_changeset: 4984da22242841a5d84c4e5fd866e93a450d9723 11:21:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:21:28 INFO - mozversion platform_version: 57.0a1 11:21:28 INFO - using testdate: 1504203688 11:21:28 INFO - actual date: 1504203688 11:21:28 INFO - starting webserver on 'localhost:42560' 11:21:28 INFO - SUITE-START | Running 2 tests 11:21:28 INFO - TEST-START | dromaeo_css 11:21:28 INFO - Initialising browser for dromaeo_css test... 11:21:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42560/getInfo.html -profile /tmp/tmpvGXA_e/profile 11:21:28 INFO - TEST-INFO | started process 12959 (/builds/slave/test/build/application/firefox/firefox http://localhost:42560/getInfo.html) 11:21:33 INFO - TEST-INFO | 12959: exit 0 11:21:33 INFO - Browser initialized. 11:21:33 INFO - Running cycle 1/1 for dromaeo_css test... 11:21:33 INFO - Using env: {'DISPLAY': ':0', 11:21:33 INFO - 'HOME': '/home/cltbld', 11:21:33 INFO - 'JSGC_DISABLE_POISONING': '1', 11:21:33 INFO - 'LANG': 'en_US.UTF-8', 11:21:33 INFO - 'LANGUAGE': 'en_US:en', 11:21:33 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:21:33 INFO - 'LOGNAME': 'cltbld', 11:21:33 INFO - 'MAIL': '/var/mail/cltbld', 11:21:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:21:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:21:33 INFO - 'MOZ_CRASHREPORTER': '1', 11:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:33 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:21:33 INFO - 'MOZ_NO_REMOTE': '1', 11:21:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:21:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:33 INFO - 'NO_EM_RESTART': '1', 11:21:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:33 INFO - 'PWD': '/builds/slave/test', 11:21:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:21:33 INFO - 'RUST_BACKTRACE': 'full', 11:21:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:21:33 INFO - 'SHELL': '/bin/bash', 11:21:33 INFO - 'SHLVL': '1', 11:21:33 INFO - 'STYLO_FORCE_ENABLED': '1', 11:21:33 INFO - 'STYLO_THREADS': '1', 11:21:33 INFO - 'TERM': 'linux', 11:21:33 INFO - 'TMOUT': '86400', 11:21:33 INFO - 'USER': 'cltbld', 11:21:33 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532', 11:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:33 INFO - '_': '/tools/buildbot/bin/python'} 11:21:33 INFO - TEST-INFO | started process 13140 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvGXA_e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:34 INFO - PID 13140 | 11:21:34 INFO - PID 13140 | (/builds/slave/test/build/application/firefox/firefox:13191): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:21:34 INFO - PID 13140 | 11:21:44 INFO - PID 13140 | RSS: Main: 172597248 11:21:44 INFO - PID 13140 | 11:24:43 INFO - PID 13140 | Cycle 1(1): loaded http://localhost:42560/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42560/tests/dromaeo/cssquery-ext.html) 11:24:44 INFO - PID 13140 | RSS: Main: 174411776 11:24:44 INFO - PID 13140 | 11:27:46 INFO - PID 13140 | Cycle 1(1): loaded http://localhost:42560/tests/dromaeo/cssquery-ext.html (next: http://localhost:42560/tests/dromaeo/cssquery-jquery.html) 11:27:47 INFO - PID 13140 | RSS: Main: 170840064 11:27:47 INFO - PID 13140 | 11:30:48 INFO - PID 13140 | Cycle 1(1): loaded http://localhost:42560/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42560/tests/dromaeo/cssquery-mootools.html) 11:30:49 INFO - PID 13140 | RSS: Main: 170934272 11:30:49 INFO - PID 13140 | 11:33:51 INFO - PID 13140 | Cycle 1(1): loaded http://localhost:42560/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42560/tests/dromaeo/cssquery-prototype.html) 11:33:51 INFO - PID 13140 | RSS: Main: 171851776 11:33:51 INFO - PID 13140 | 11:36:55 INFO - PID 13140 | Cycle 1(1): loaded http://localhost:42560/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42560/tests/dromaeo/cssquery-yui.html) 11:36:56 INFO - PID 13140 | RSS: Main: 172695552 11:36:56 INFO - PID 13140 | 11:39:57 INFO - PID 13140 | Cycle 1(1): loaded http://localhost:42560/tests/dromaeo/cssquery-yui.html (next: http://localhost:42560/tests/dromaeo/cssquery-dojo.html) 11:39:58 INFO - PID 13140 | RSS: Main: 175935488 11:39:58 INFO - PID 13140 | 11:39:58 INFO - PID 13140 | __start_tp_report 11:39:58 INFO - PID 13140 | _x_x_mozilla_page_load 11:39:58 INFO - PID 13140 | _x_x_mozilla_page_load_details 11:39:58 INFO - PID 13140 | |i|pagename|runs| 11:39:58 INFO - PID 13140 | |0;dojo.html;3301.884434044809;3311.983440082799;3328.118048717089;3337.532745415641;3356.8825091121785;6240.656763877985;6296.779612713562;6314.336994615568;6315.778947736831;6402.359764023596;6112.235970503687;6247.71885265163;6266.248050233967;6268.091126786613;6271.623702577848;5733.111367738007;5777.046787280115;5800.941990580082;5802.245708057968;5916.3787802280785;5822.417758224165;5823.563232757539;5896.204012458306;5898.380670029649;5899.823005309848;1110.3656049782267;5716.8284951451105;5728.742206600671;5822.184894114827;5934.525237980951;5686.459786320293;5798.3911689272445;5883.70581470929;5889.087191485327;5892.734826932799;5794.797182098607;5802.709864506758;5880.26496687914;5882.205902203234;5883.882322353529;6282.623042617458;6295.779647712354;6310;6348.904766428507;6394;6741.3258674132685;6754.324567543206;6755.5271131020845;6826.863462730767;6873.518853680244;6573.1783527059115;6654.6672666366485;6670.899936500957;6710.865782684368;6925.930740692579;6301.054841773679;6333.524985626096;6345.873082538324;6356.523260755462;6376.426121649074;6890.965545172342;6911.516193866381;7005.05431766705;7007.194172670208;7023.086998690138;6358.23701155855;6604.768833090819;6653.833654158588;6698.832529186712;6711.563748356341;6632.734690612418;6673.232578253466;6677.23211830636;6680.565763225375;6696.0960270362875;6657.833554161185;6710;6798.558093723892;6798.592084474947;6799.93200067993;6793.184817821893;6850.109485766819;6859.5541289816;6869.965650171717;6870.038194652752;5215.478452154754;5282.260483532308;5307.124324486494;5387.218853266255;5408.78364865401;4569.885752856205;4584.33527138563;4589.036302376471;4598.8620341389815;4605.838795642204;5818.301803783573;5819.214406055128;5822.272215973004;5921.2302400688495;5941.108833674897;6768.086308348408;6802.65986700663;6835.4189893859575;6864.97025446187;6899.413549848319;5892.175095486636;5902.911456328158;5969.611975221596;5972.701364931736;5978;5819.214406055213;5820.447057529528;5895.498882594941;5897.76408943646;5900.232969713909;6381.202349706286;6502.122213501211;6565.967170164118;6660.034295027194;6663.267040625527;6853.520253582301;6863.794086177223;6895.069165662772;6895.138107736533;6921.757738479129;6572.178477690289;6610.272869984202;6709.530332876847;6710.664466776544;6727.899081513683;6476.449501792212;6698.966505167443;6722.630255336004;6791.694373753292;6820.113385260083;6605.504587155887;6712.228093769279;6798.8640227196165;6817.352351526597;6829.317068293131;6493.155889734304;6505.186851643544;6517.934820651923;6582.3746744059235;6585.242697089704;6450.548461607643;6461.903071453838;6530.379613936669;6537.836554086186;6542.574732642363;6315.336889626523;6408.910485217431;6443.71003304843;6529.314421985813;6536.542442029012;6586.901196481961;6589.04458853454;6706.6981985811735;6719.059331693469;6725.361090696376;6405.487560995202;6439.8068057958335;6485.740570377132;6520.315366886409;6523.24982627004 11:39:58 INFO - PID 13140 | |1;ext.html;757.5076200469694;800.1038836503117;835.2274146414567;839.9706010289641;1138.7096290445936;28826.423471530557;29258;38974.22051558971;40140.39789403154;40144.598554014454;39050.21899562007;39368.409473857915;39372.40941385881;39415;39462.210755784865;7587.506812057226;7685.654145563435;7820.25707557784;7826.413019023567;7831.29518343349;7551.131619863731;7682.423818213629;7695.846083078335;7712.922870771276;7719.189485104067;7665.156832748393;7677.654505547263;7681.9231807682045;7739.264769846855;7752.651130699132;7639.159692433828;7678.500897441704;7696.692132314756;7697.422693297997;7699.268569485918;7603.353714934237;7672.232776722339;7674.117476490219;7674.884876726854;7676.577788221645;36452;36587.451188231935;36639.08402289938;36758.44862327067;36774.63225367766;3165.113768144923;3206.7434605231524;3208.631007434152;3210.133264018702;3212.9518057228925;30537.389252215053;30580.54129188064;30639.08082757521;30686;30733.385332293452;5148.2020286855595;5155.922661160085;5188.325517682677;5212.609054320941;5285.735713214324;187057;187343;189718;189880;190359.04820475949;46039.53960460419;46094.30858537125;46207;46279.76860115678;46327.536724633;47375.52624473711;47398;47408.051838963715;47804.5219547807;47807.521924781;11980.101492387932;12208.267503949613;13634.1137826041;13834.30828458573;13841.653958651113;10951.4524273786;11132.387718675389;11191.776164476665;11202.047825934724;11202.943985280184;13743.862561374259;13866.930665346608;13925.791113133311;13978.650533736534;14053.71892562143;5890.852728681817;5975.940240597625;5981.730822112929;5984.521238300926;5992.940070599326;1021.6219998600566;1032.4166845732138;1043.4626167523732;1045.46158728255;1049.2497864027105;21986.340409787732;22465.663015054786;22714.545709085727;22741.772582273967;22899.885500572724;1113.8997490225918;1124.7469319403233;1125.5272785430138;1127.0870594818223;1128.7121783945042;11910.880891191151;11922.403879805976;11927.105467090003;11997.940010300068;12003;225060;225632;226106;226131;226686;49484.50515494871;49548;49689.503104968484;49739.25391119136;49788.502114979114;1421.5877395555174;1438.1083728088652;1439.330711219288;1450.7243623711672;1451.867543316215;22287.77712222857;22369.217077402212;22420.775792241868;22569.09723611103;22900.541989160458;36357.27285454329;36493.81753091217;36547.634523655484;36565.268694625425;36626;189763;189904;190177;190338;190448;32498.675013249565;32627;34297.65702342945;34972.65027349694;35017.474737878445;43099.35350969675;44706;44729;44824.77587612041;45370.546294537955;32215.35569288648;32554.348913021135;32600.510992335607;32686;32744.34511309713;31378;31739.365212695157;31808.522872156474;31835.20411989719;32402.189945251557;35861.82069089638;36119.81940090283;36156.27687446184;36185.45721814228;36265;30213.546796797626;31520.684793151773;31659.52510712387;31922;32039.03882883517;21974.340769776933;22256.666150008088;22307.553848922606;22522.436939076655;22697.205597803997 11:39:58 INFO - PID 13140 | |2;jquery.html;556.115775916293;564.1143404854375;569.9145128230765;577.4629594477137;587.5622661117467;21797.564048719018;22420.77579224207;22537.887310563445;22583.096676132976;22598.88700556495;24930.50138997219;25513.744862551368;25577.825884799815;25583.872080639572;25593;6499.675016249193;6664.533482656216;6665.466762659;6665.900011499832;6670.466362690997;6303.2436107667145;6525.902111468332;6593.109930159439;6654.401103900648;6659.300773418794;6565.015247712833;6600.966995165018;6602.471802255832;6605.405513503783;6606.14120164378;6600.570962887397;6612.86774264512;6617.404433600951;6617.834554136161;6618.238902526199;6128.172696685935;6140.4473597376;6147.170132032164;6151;6152.630842149485;27342;28364.71635283662;28940.27649308763;29336.853315733286;29562.852185738935;2071.9378418647466;2090.989545052265;2103.684447332897;2106.799854013866;2120.385088324384;18889.811101888943;20227.190912363487;21155.365339039854;21211.575768484545;21234.78765212359;2325.395397196724;2336.4626135988647;2399.2442380650214;2403.242978461779;2410.7227668818136;145626;151672.2416387922;152108;152237;152267;20605.939406059275;20997.790022099583;21719.891400542896;21918.671219931715;22659.660105098435;42938.78530607327;42960.57039429628;43047.78476107599;43143.35284970728;43153.784231078644;10634.149268058536;10741.462926853626;10798.190135739851;10826.729331766612;10844.891551084545;8701.869471957925;8793.648254069765;8812.8678069829;8846.513441760764;8911.064338244521;11638.1271404645;11691.76616467666;11708.590199342982;11802.586909458129;11825.408729563487;4122.649574786117;4146.295129827937;4188.581141885848;4232.788360581959;4369.737815731066;963.5471328475605;979.7844474215661;986.6743974488402;989.2135752077116;996.3473924579412;19182;19460.610787784164;19466.61066778685;19821.702674459895;23120.7687923122;995.4176806568094;1050.579768092769;1050.858134151895;1056.6248981611418;1062.8990245926625;10693.41186234749;10709.196810239264;10807.567697292177;10829.24195306321;10915.95354828401;486573;492266;500220;503998;515486;120238;122721.38639306925;123400;125388.37305813412;125790;1215.6474622359594;1236.202649291202;1257.207958985833;1259.2318685601776;1268.239056566053;17108.48674539766;17137.22882470267;17408.47774566765;17704.734428983316;17826.732599011284;52173.21740173976;53225;55314.17028744492;55850.72074639601;55923;73491;74265;74636.25363746293;74781.50436991338;74984.62507687644;14059.297035147996;14095.365708542935;14193.716125677221;14258.928705356408;14301.92849035748;20781.792182078592;20893.686594700786;22643.20748773785;22838.42903927415;22950.311490655306;16420;16656.333746649998;17066.829331706525;18425.26298948027;18586.628267434848;15064.02083864589;15129.773053404428;15556.222188890737;16491.17544122813;16763;18582.628347432707;19803.207871684972;19893.701594475806;20019;20224.797752022292;14273.500427484989;14480.203588802717;14483.493077742229;14520.636984075483;14525.418983240974;16269.918650406673;16440.095794731405;16579.253933572778;16599.668006639557;16623.335066597683 11:39:58 INFO - PID 13140 | |3;mootools.html;1316.927568983706;1382.0878220374555;1393.4844107680146;1395.3441882315315;1408.6126315263302;12726.363681815896;15122.395104195833;15735.763963540541;15780.684386312281;15810.84189158108;12811.871881281184;15247.16140612266;15641.296141673623;15662.451814186506;15673.451429199951;2707.1743118348895;2762.2541913683294;2777.3056735816044;2777.847218402987;2779.12457575864;2651.496215719007;2670.8531030793297;2768.1557125076843;2798.8040837141407;2799.958000629992;2815.81697189682;2841.1334542964387;2862.1556640790914;2866.9283267918363;2866.956995645067;2605.1012400721816;2689.7713694336003;2690.5560582503863;2694.892204311825;2695.151027426374;2625.8708755235243;2654.707982121965;2660.813743037988;2664.733526647339;2666.2534490342737;14962.326695298629;15302.158381289024;15304.617384565363;15314.310856011507;15317.693646127014;7983.840323193562;8271.255586997138;8279.834403311961;8281.461704989217;8284.83430331396;5063.721495317756;5259.447757985433;5382.703951282678;5461.508464238238;5497.505224529811;1852.435007322766;1893.185930050078;1898.734177215191;1935.5161209697576;1947.9415617531497;22384.77615223843;23007.999999999833;26658.33354166142;26762.73237267622;26816.195514134608;6764.763233286812;6832.965835170792;6938.653067346713;7040.577565346096;7048.083749112582;17169.48491545256;17213.827861721475;17238.569035774206;17239.22423490946;17256;7938.6427610757655;8071.313938315191;8071.878921816177;8073.11195768465;8074.636641351153;7414.592197429193;7436.442266830009;7465.925340746631;7499.400047996256;7507.249275072559;5192.247124166975;5267.920981185285;5329.920051199235;5361.624686272002;5368.8657783554945;1465.728840164573;1469.7281003014477;1476.4979906831513;1485.6406388154933;1499.272852666456;879.2570278114982;891.7101941868918;896.9865452018225;909.4861403307243;913.2100732866023;7892.723754668559;7942.126366099725;8003.6798528058225;8064.233897779702;8123.431359804875;718.8993540904278;730.0582248898967;731.5647189921988;738.2986163145034;746.4289818289013;5328.92006619901;5484.561235101182;5511.58663100269;5557.194206839986;6010.669413182317;21500.354989350344;21975.23086691958;22108.55782884333;22627.88686056559;22726.20458283952;21883.452913677287;22053.448663783533;22093;22467.10131594718;22477.21329753451;11455.427228638535;11539.76920461586;11730.413479326171;11749.236299640666;11802.763944721057;8975.102489750972;9137.40606860552;9155.816883662157;9204.447733135765;9211.263098952202;19024.334148304744;19069.046547672282;19254;19494.512637184183;19874.304399345954;19042.33351832679;19463.61072778565;19664.41006769799;19738;19841.900790495954;11676.357800321064;11921.642350729491;11934.880651193724;11957.880421195676;11980.400979950793;14082;14351.067180633643;14406.135631862122;14414.063085899383;14416.279186040447;11145.888541114486;11230.101591872468;11303.660890173307;11371.886281137082;11520.654380368602;10962;11189.552417903193;11205.271657342246;11293.71765705864;11346.489407976826;8759.474431534129;8979.191872731486;8983.921929368518;8985.640574377214;9013.819723605622;7296.7081316746735;7309.342159205485;7319.4144468443465;7329.963350183215;7330;7522.8871566925445;7573.583452910143;7585.127710313384;7609.923900760921;7742 11:39:58 INFO - PID 13140 | |4;prototype.html;501.861987953313;508.3899320815022;519.1900635009385;522.7229568328787;529.9163211233029;6265.404786545271;6283.120363149163;6334.642639401119;6354.8729025419525;6391.360863913618;6179.289381721103;6187.35032821554;6187.5668703190795;6201.193844800181;6209.720562574684;4846.127697014536;5076.746162691869;5080.009398167359;5131.306668799297;5134.589232861381;4869.879927616633;4996.375453068366;4999.150144475448;5030.471800460954;5059.11465493539;4921.532454416824;4924.482929292427;4973.428055773578;4979.30289759434;4994.500549944994;4908.092002979461;4928.67963582366;4959.404871415453;4969.627277954168;4982.227754698028;4473.127740090684;4490.797914093873;4511.210538155809;4517.119161763458;4540.409746732937;6072.666003369813;6134.693265336716;6202.131701561785;6207.410296021871;6219.315875253718;5706.3152421709665;5716.799912003102;5716.857078573027;5719.742611582489;5729.197912292282;6599.901001484982;6604.537682362236;6609.93390066098;6612.636305003223;6616.702248398834;4906.90186196274;4916.901661966776;4918.01639672067;4924.753762311906;4925.7783399747095;6653.700583473756;6799.898001529882;6806.829829254309;6886.931130688679;6965.756198533027;5019.548240658358;5029.421616514074;5039.732120545769;5042.7982880685095;5046.419661738947;5075.3402057732255;5117.155669314596;5127.179651255781;5150.922736158961;5155.587552995751;5697.7151142443545;5716.742746576331;5737.88524229513;5738.741756620962;5739.139129130664;6654.933450665529;6655.267920528738;6687.264400915896;6691.360616648953;6702.9447184453675;1769.8053214146435;1778.7954385245862;1784.3665498748016;1794.793598736136;1795.5780391607962;1187.2935603316014;1229.567553799831;1234.9444275007647;1246.2833870524485;1251.874812518759;5800.622959507618;5822.184894114827;5830.766769329264;5845.444682755132;5856.970715146397;6708.698108585126;6732.966335168293;6734.259231484532;6739.427148692318;6819.31806819324;5713.942860571341;5722;5724.79963201286;5734.684592347461;5748.19525266463;3545.663161999606;3610.494530765695;3632.800195989246;3634.1459756957092;3639.6724294813594;6162.938370616236;6521.673916304166;6544.181977252843;6553.4101930826455;6577.599176300616;6885.414739747178;6889.655517224219;6896.965515172392;6941.375276225164;6956.826079347956;6522.347765223534;6608.306127856506;6624.768133115318;6634.83412914681;6671.13275274221;6674.365935236145;6687.4984376171005;6717.731290748316;6722.764703235559;6768.4585233182215;6719.260881302955;6721.361470660279;6733.2593414725325;6766.8646627068165;6786.3892249697765;6626.271110177973;6651.866962660816;6668.633225172662;6684.632345220865;6687.531872768859;5054.949450505448;5056.974715126401;5068.26510156018;5068.594512438923;5077.136886729191;6526.967365163144;6637.867242655217;6664.100346453167;6776.220734615582;6798.558093723892;6474.5791523550815;6481.902771458337;6511.544191906711;6513.120728701565;6527.988161834924;6498.3826536478955;6522.869542609026;6563.278039415756;6565.737370505126;6579.144711187707;6428.839279018062;6468.288488266381;6470.773522926675;6508.479321654351;6518.120053792677;6567.507436942153;6584.209894812653;6587.901181482186;6594.142761440982;6597.977313516412;6287.182666253358;6287.96856015717;6338.651374174465;6356.9046464304;6374.330695276929 11:39:58 INFO - PID 13140 | |5;yui.html;902.5261737587765;909.499775123682;925.1303774452015;926.7405126564564;930.8184903943734;18046.09769511524;19168.520786980316;19199;19288.614227715454;21908.561828763453;20345.796542034575;21202.46993825155;21288.148474061058;21292.787072129275;21430;953.9904600953971;971.4171497101718;972.7130496503513;976.6337623391229;980.4362491567342;964.5996911281844;986.1617625018748;989.4953573677441;989.8911119776855;994.5723338964278;1065.9413732244761;1071.0949247885562;1071.0949247885562;1071.4803320389606;1071.9892801072006;1058.798828222643;1059.3061544688242;1061.5912873543703;1062.0812996757827;1062.1768129699467;776.2043904997366;777.8638738220789;779.6569509415839;779.7699678594771;780.0795061827042;17517.386891458736;17611.383601574013;17822.48508876747;17826.91086544572;18958.14688339028;20956.89521552398;20960.685589716166;21057;21639.567208655895;21783.564328713495;16624.83375166257;16750.664986700198;16759.564857561658;16783.412580559743;16855.662886742197;3685.5208822852856;3715.3126671565847;3715.5912849586525;3718.0704823794053;3720.3489389356755;119686;121354.99999999911;121759.3912030443;127221.36389318087;129795.7020429793;16924.661506769797;17528.824711752975;17625.647487050188;17799.555011124827;17842.643147137245;30699.079027629206;30828.38343233123;30917.0724878254;31328.530072048936;31362.21594460157;7892.921070789219;8322.50064996102;8852.911470885338;9188.586513606904;9325.207357374564;4473.575010374009;4599.126166028511;4603.49361570227;4603.769811509411;4611.976940115278;5295.761690723926;5391.245225668409;5399.865003374868;5419.214213939035;5450.291462109901;1011.1051719228535;1032.3805716569998;1038.076112260089;1041.5156952017348;1042.2443728297076;683.7265093962355;694.6214313199318;699.1400577289962;699.9055127557816;707.5825263094799;11476.827847582294;11534;11913.52345906154;12714.27573055913;13202.207867527979;685.9245482996866;690.6167077272062;692.3803196139528;695.4957655699577;705.6295444891371;5864.648121112661;6294.307626161119;6336.271328797247;6377.808665740035;6427.967860160669;105294;106741;109047.45476272727;109676.80646387028;111287.44356278167;96968.51515742377;99164;99426;99485.50257248813;100762;83970;85540.14459855446;85740.57129714312;88411.55794220988;89262.55368723244;11625.12811539121;11785.292882426738;11846.644600661994;11894.821577676168;11970.700732481757;38868.6113138865;39630.2073958525;39846.40230396488;40717;41108.79445602753;51612.74193629008;52030;52887;53256.467435325154;53385.7330713344;16498.75251871247;16737.832621674115;16938.23777930021;16992.57518562046;17057.402990895258;18127.093645317946;19884.204631815144;20077.196912123352;20663.070161842454;20668.58662826765;18704.906475467535;18719.34482293168;18768;18788.718169227745;18831;16721;17421;17447.30210791554;18204.908975455568;19076.713849292548;17413.91293043527;17420.564485887953;17491.912540437217;17547.912260439127;17765.378211762527;11105.777884442428;11537.307761533999;11777.764444711229;11895.762084758084;12186.817197742219;12319.815202772144;12379;12672.619821405373;12732.681682958;13135.868641313464 11:39:58 INFO - PID 13140 | __end_tp_report 11:39:58 INFO - PID 13140 | __start_cc_report 11:39:58 INFO - PID 13140 | _x_x_mozilla_cycle_collect,366 11:39:58 INFO - PID 13140 | __end_cc_report 11:39:58 INFO - PID 13140 | __startTimestamp1504204798176__endTimestamp 11:39:58 INFO - PID 13140 | 11:39:58 INFO - PID 13140 | ------- Summary: start ------- 11:39:58 INFO - PID 13140 | Number of tests: 6 11:39:58 INFO - PID 13140 | 11:39:58 INFO - PID 13140 | [#0] dojo.html Cycles:165 Average:6203.35 Median:6450.55 stddev:829.53 (12.9%) stddev-sans-first:800.24 11:39:58 INFO - PID 13140 | Values: 3301.9 3312.0 3328.1 3337.5 3356.9 6240.7 6296.8 6314.3 6315.8 6402.4 6112.2 6247.7 6266.2 6268.1 6271.6 5733.1 5777.0 5800.9 5802.2 5916.4 5822.4 5823.6 5896.2 5898.4 5899.8 1110.4 5716.8 5728.7 5822.2 5934.5 5686.5 5798.4 5883.7 5889.1 5892.7 5794.8 5802.7 5880.3 5882.2 5883.9 6282.6 6295.8 6310.0 6348.9 6394.0 6741.3 6754.3 6755.5 6826.9 6873.5 6573.2 6654.7 6670.9 6710.9 6925.9 6301.1 6333.5 6345.9 6356.5 6376.4 6891.0 6911.5 7005.1 7007.2 7023.1 6358.2 6604.8 6653.8 6698.8 6711.6 6632.7 6673.2 6677.2 6680.6 6696.1 6657.8 6710.0 6798.6 6798.6 6799.9 6793.2 6850.1 6859.6 6870.0 6870.0 5215.5 5282.3 5307.1 5387.2 5408.8 4569.9 4584.3 4589.0 4598.9 4605.8 5818.3 5819.2 5822.3 5921.2 5941.1 6768.1 6802.7 6835.4 6865.0 6899.4 5892.2 5902.9 5969.6 5972.7 5978.0 5819.2 5820.4 5895.5 5897.8 5900.2 6381.2 6502.1 6566.0 6660.0 6663.3 6853.5 6863.8 6895.1 6895.1 6921.8 6572.2 6610.3 6709.5 6710.7 6727.9 6476.4 6699.0 6722.6 6791.7 6820.1 6605.5 6712.2 6798.9 6817.4 6829.3 6493.2 6505.2 6517.9 6582.4 6585.2 6450.5 6461.9 6530.4 6537.8 6542.6 6315.3 6408.9 6443.7 6529.3 6536.5 6586.9 6589.0 6706.7 6719.1 6725.4 6405.5 6439.8 6485.7 6520.3 6523.2 11:39:58 INFO - PID 13140 | 11:39:58 INFO - PID 13140 | [#1] ext.html Cycles:180 Average:36448.91 Median:32577.43 stddev:52419.30 (160.9%) stddev-sans-first:52497.84 11:39:58 INFO - PID 13140 | Values: 757.5 800.1 835.2 840.0 1138.7 28826.4 29258.0 38974.2 40140.4 40144.6 39050.2 39368.4 39372.4 39415.0 39462.2 7587.5 7685.7 7820.3 7826.4 7831.3 7551.1 7682.4 7695.8 7712.9 7719.2 7665.2 7677.7 7681.9 7739.3 7752.7 7639.2 7678.5 7696.7 7697.4 7699.3 7603.4 7672.2 7674.1 7674.9 7676.6 36452.0 36587.5 36639.1 36758.4 36774.6 3165.1 3206.7 3208.6 3210.1 3213.0 30537.4 30580.5 30639.1 30686.0 30733.4 5148.2 5155.9 5188.3 5212.6 5285.7 187057.0 187343.0 189718.0 189880.0 190359.0 46039.5 46094.3 46207.0 46279.8 46327.5 47375.5 47398.0 47408.1 47804.5 47807.5 11980.1 12208.3 13634.1 13834.3 13841.7 10951.5 11132.4 11191.8 11202.0 11202.9 13743.9 13866.9 13925.8 13978.7 14053.7 5890.9 5975.9 5981.7 5984.5 5992.9 1021.6 1032.4 1043.5 1045.5 1049.2 21986.3 22465.7 22714.5 22741.8 22899.9 1113.9 1124.7 1125.5 1127.1 1128.7 11910.9 11922.4 11927.1 11997.9 12003.0 225060.0 225632.0 226106.0 226131.0 226686.0 49484.5 49548.0 49689.5 49739.3 49788.5 1421.6 1438.1 1439.3 1450.7 1451.9 22287.8 22369.2 22420.8 22569.1 22900.5 36357.3 36493.8 36547.6 36565.3 36626.0 189763.0 189904.0 190177.0 190338.0 190448.0 32498.7 32627.0 34297.7 34972.7 35017.5 43099.4 44706.0 44729.0 44824.8 45370.5 32215.4 32554.3 32600.5 32686.0 32744.3 31378.0 31739.4 31808.5 31835.2 32402.2 35861.8 36119.8 36156.3 36185.5 36265.0 30213.5 31520.7 31659.5 31922.0 32039.0 21974.3 22256.7 22307.6 22522.4 22697.2 11:39:58 INFO - PID 13140 | 11:39:58 INFO - PID 13140 | [#2] jquery.html Cycles:180 Average:36376.50 Median:22479.33 stddev:84713.96 (376.9%) stddev-sans-first:84908.92 11:39:58 INFO - PID 13140 | Values: 556.1 564.1 569.9 577.5 587.6 21797.6 22420.8 22537.9 22583.1 22598.9 24930.5 25513.7 25577.8 25583.9 25593.0 6499.7 6664.5 6665.5 6665.9 6670.5 6303.2 6525.9 6593.1 6654.4 6659.3 6565.0 6601.0 6602.5 6605.4 6606.1 6600.6 6612.9 6617.4 6617.8 6618.2 6128.2 6140.4 6147.2 6151.0 6152.6 27342.0 28364.7 28940.3 29336.9 29562.9 2071.9 2091.0 2103.7 2106.8 2120.4 18889.8 20227.2 21155.4 21211.6 21234.8 2325.4 2336.5 2399.2 2403.2 2410.7 145626.0 151672.2 152108.0 152237.0 152267.0 20605.9 20997.8 21719.9 21918.7 22659.7 42938.8 42960.6 43047.8 43143.4 43153.8 10634.1 10741.5 10798.2 10826.7 10844.9 8701.9 8793.6 8812.9 8846.5 8911.1 11638.1 11691.8 11708.6 11802.6 11825.4 4122.6 4146.3 4188.6 4232.8 4369.7 963.5 979.8 986.7 989.2 996.3 19182.0 19460.6 19466.6 19821.7 23120.8 995.4 1050.6 1050.9 1056.6 1062.9 10693.4 10709.2 10807.6 10829.2 10916.0 486573.0 492266.0 500220.0 503998.0 515486.0 120238.0 122721.4 123400.0 125388.4 125790.0 1215.6 1236.2 1257.2 1259.2 1268.2 17108.5 17137.2 17408.5 17704.7 17826.7 52173.2 53225.0 55314.2 55850.7 55923.0 73491.0 74265.0 74636.3 74781.5 74984.6 14059.3 14095.4 14193.7 14258.9 14301.9 20781.8 20893.7 22643.2 22838.4 22950.3 16420.0 16656.3 17066.8 18425.3 18586.6 15064.0 15129.8 15556.2 16491.2 16763.0 18582.6 19803.2 19893.7 20019.0 20224.8 14273.5 14480.2 14483.5 14520.6 14525.4 16269.9 16440.1 16579.3 16599.7 16623.3 11:39:58 INFO - PID 13140 | 11:39:58 INFO - PID 13140 | [#3] mootools.html Cycles:180 Average:9423.93 Median:14716.79 stddev:6702.53 (45.5%) stddev-sans-first:6693.66 11:39:58 INFO - PID 13140 | Values: 1316.9 1382.1 1393.5 1395.3 1408.6 12726.4 15122.4 15735.8 15780.7 15810.8 12811.9 15247.2 15641.3 15662.5 15673.5 2707.2 2762.3 2777.3 2777.8 2779.1 2651.5 2670.9 2768.2 2798.8 2800.0 2815.8 2841.1 2862.2 2866.9 2867.0 2605.1 2689.8 2690.6 2694.9 2695.2 2625.9 2654.7 2660.8 2664.7 2666.3 14962.3 15302.2 15304.6 15314.3 15317.7 7983.8 8271.3 8279.8 8281.5 8284.8 5063.7 5259.4 5382.7 5461.5 5497.5 1852.4 1893.2 1898.7 1935.5 1947.9 22384.8 23008.0 26658.3 26762.7 26816.2 6764.8 6833.0 6938.7 7040.6 7048.1 17169.5 17213.8 17238.6 17239.2 17256.0 7938.6 8071.3 8071.9 8073.1 8074.6 7414.6 7436.4 7465.9 7499.4 7507.2 5192.2 5267.9 5329.9 5361.6 5368.9 1465.7 1469.7 1476.5 1485.6 1499.3 879.3 891.7 897.0 909.5 913.2 7892.7 7942.1 8003.7 8064.2 8123.4 718.9 730.1 731.6 738.3 746.4 5328.9 5484.6 5511.6 5557.2 6010.7 21500.4 21975.2 22108.6 22627.9 22726.2 21883.5 22053.4 22093.0 22467.1 22477.2 11455.4 11539.8 11730.4 11749.2 11802.8 8975.1 9137.4 9155.8 9204.4 9211.3 19024.3 19069.0 19254.0 19494.5 19874.3 19042.3 19463.6 19664.4 19738.0 19841.9 11676.4 11921.6 11934.9 11957.9 11980.4 14082.0 14351.1 14406.1 14414.1 14416.3 11145.9 11230.1 11303.7 11371.9 11520.7 10962.0 11189.6 11205.3 11293.7 11346.5 8759.5 8979.2 8983.9 8985.6 9013.8 7296.7 7309.3 7319.4 7330.0 7330.0 7522.9 7573.6 7585.1 7609.9 7742.0 11:39:58 INFO - PID 13140 | 11:39:58 INFO - PID 13140 | [#4] prototype.html Cycles:180 Average:5542.74 Median:6194.38 stddev:1550.32 (25.0%) stddev-sans-first:1507.80 11:39:58 INFO - PID 13140 | Values: 501.9 508.4 519.2 522.7 529.9 6265.4 6283.1 6334.6 6354.9 6391.4 6179.3 6187.4 6187.6 6201.2 6209.7 4846.1 5076.7 5080.0 5131.3 5134.6 4869.9 4996.4 4999.2 5030.5 5059.1 4921.5 4924.5 4973.4 4979.3 4994.5 4908.1 4928.7 4959.4 4969.6 4982.2 4473.1 4490.8 4511.2 4517.1 4540.4 6072.7 6134.7 6202.1 6207.4 6219.3 5706.3 5716.8 5716.9 5719.7 5729.2 6599.9 6604.5 6609.9 6612.6 6616.7 4906.9 4916.9 4918.0 4924.8 4925.8 6653.7 6799.9 6806.8 6886.9 6965.8 5019.5 5029.4 5039.7 5042.8 5046.4 5075.3 5117.2 5127.2 5150.9 5155.6 5697.7 5716.7 5737.9 5738.7 5739.1 6654.9 6655.3 6687.3 6691.4 6702.9 1769.8 1778.8 1784.4 1794.8 1795.6 1187.3 1229.6 1234.9 1246.3 1251.9 5800.6 5822.2 5830.8 5845.4 5857.0 6708.7 6733.0 6734.3 6739.4 6819.3 5713.9 5722.0 5724.8 5734.7 5748.2 3545.7 3610.5 3632.8 3634.1 3639.7 6162.9 6521.7 6544.2 6553.4 6577.6 6885.4 6889.7 6897.0 6941.4 6956.8 6522.3 6608.3 6624.8 6634.8 6671.1 6674.4 6687.5 6717.7 6722.8 6768.5 6719.3 6721.4 6733.3 6766.9 6786.4 6626.3 6651.9 6668.6 6684.6 6687.5 5054.9 5057.0 5068.3 5068.6 5077.1 6527.0 6637.9 6664.1 6776.2 6798.6 6474.6 6481.9 6511.5 6513.1 6528.0 6498.4 6522.9 6563.3 6565.7 6579.1 6428.8 6468.3 6470.8 6508.5 6518.1 6567.5 6584.2 6587.9 6594.1 6598.0 6287.2 6288.0 6338.7 6356.9 6374.3 11:39:58 INFO - PID 13140 | 11:39:58 INFO - PID 13140 | [#5] yui.html Cycles:180 Average:23110.43 Median:20812.74 stddev:31358.80 (150.7%) stddev-sans-first:31402.43 11:39:58 INFO - PID 13140 | Values: 902.5 909.5 925.1 926.7 930.8 18046.1 19168.5 19199.0 19288.6 21908.6 20345.8 21202.5 21288.1 21292.8 21430.0 954.0 971.4 972.7 976.6 980.4 964.6 986.2 989.5 989.9 994.6 1065.9 1071.1 1071.1 1071.5 1072.0 1058.8 1059.3 1061.6 1062.1 1062.2 776.2 777.9 779.7 779.8 780.1 17517.4 17611.4 17822.5 17826.9 18958.1 20956.9 20960.7 21057.0 21639.6 21783.6 16624.8 16750.7 16759.6 16783.4 16855.7 3685.5 3715.3 3715.6 3718.1 3720.3 119686.0 121355.0 121759.4 127221.4 129795.7 16924.7 17528.8 17625.6 17799.6 17842.6 30699.1 30828.4 30917.1 31328.5 31362.2 7892.9 8322.5 8852.9 9188.6 9325.2 4473.6 4599.1 4603.5 4603.8 4612.0 5295.8 5391.2 5399.9 5419.2 5450.3 1011.1 1032.4 1038.1 1041.5 1042.2 683.7 694.6 699.1 699.9 707.6 11476.8 11534.0 11913.5 12714.3 13202.2 685.9 690.6 692.4 695.5 705.6 5864.6 6294.3 6336.3 6377.8 6428.0 105294.0 106741.0 109047.5 109676.8 111287.4 96968.5 99164.0 99426.0 99485.5 100762.0 83970.0 85540.1 85740.6 88411.6 89262.6 11625.1 11785.3 11846.6 11894.8 11970.7 38868.6 39630.2 39846.4 40717.0 41108.8 51612.7 52030.0 52887.0 53256.5 53385.7 16498.8 16737.8 16938.2 16992.6 17057.4 18127.1 19884.2 20077.2 20663.1 20668.6 18704.9 18719.3 18768.0 18788.7 18831.0 16721.0 17421.0 17447.3 18204.9 19076.7 17413.9 17420.6 17491.9 17547.9 17765.4 11105.8 11537.3 11777.8 11895.8 12186.8 12319.8 12379.0 12672.6 12732.7 13135.9 11:39:58 INFO - PID 13140 | -------- Summary: end -------- 11:39:58 INFO - PID 13140 | 11:39:58 INFO - TEST-INFO | 13140: exit 0 11:39:58 INFO - TEST-OK | dromaeo_css | took 1110594ms 11:39:58 INFO - TEST-START | kraken 11:39:58 INFO - Initialising browser for kraken test... 11:39:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42560/getInfo.html -profile /tmp/tmp5MOna5/profile 11:39:58 INFO - TEST-INFO | started process 13513 (/builds/slave/test/build/application/firefox/firefox http://localhost:42560/getInfo.html) 11:40:04 INFO - TEST-INFO | 13513: exit 0 11:40:04 INFO - Browser initialized. 11:40:04 INFO - Running cycle 1/1 for kraken test... 11:40:04 INFO - Using env: {'DISPLAY': ':0', 11:40:04 INFO - 'HOME': '/home/cltbld', 11:40:04 INFO - 'JSGC_DISABLE_POISONING': '1', 11:40:04 INFO - 'LANG': 'en_US.UTF-8', 11:40:04 INFO - 'LANGUAGE': 'en_US:en', 11:40:04 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:40:04 INFO - 'LOGNAME': 'cltbld', 11:40:04 INFO - 'MAIL': '/var/mail/cltbld', 11:40:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:40:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:40:04 INFO - 'MOZ_CRASHREPORTER': '1', 11:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:04 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:40:04 INFO - 'MOZ_NO_REMOTE': '1', 11:40:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:04 INFO - 'NO_EM_RESTART': '1', 11:40:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:04 INFO - 'PWD': '/builds/slave/test', 11:40:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:40:04 INFO - 'RUST_BACKTRACE': 'full', 11:40:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:40:04 INFO - 'SHELL': '/bin/bash', 11:40:04 INFO - 'SHLVL': '1', 11:40:04 INFO - 'STYLO_FORCE_ENABLED': '1', 11:40:04 INFO - 'STYLO_THREADS': '1', 11:40:04 INFO - 'TERM': 'linux', 11:40:04 INFO - 'TMOUT': '86400', 11:40:04 INFO - 'USER': 'cltbld', 11:40:04 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532', 11:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:04 INFO - '_': '/tools/buildbot/bin/python'} 11:40:04 INFO - TEST-INFO | started process 13695 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5MOna5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:40:05 INFO - PID 13695 | 11:40:05 INFO - PID 13695 | (/builds/slave/test/build/application/firefox/firefox:13746): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:40:05 INFO - PID 13695 | 11:40:15 INFO - PID 13695 | RSS: Main: 173740032 11:40:15 INFO - PID 13695 | 11:40:18 INFO - PID 13695 | Cycle 1(1): loaded http://localhost:42560/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42560/tests/kraken/driver.html?testName=audio-beat-detection) 11:40:18 INFO - PID 13695 | RSS: Main: 177598464 11:40:18 INFO - PID 13695 | 11:40:21 INFO - PID 13695 | Cycle 1(1): loaded http://localhost:42560/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42560/tests/kraken/driver.html?testName=audio-dft) 11:40:22 INFO - PID 13695 | RSS: Main: 182476800 11:40:22 INFO - PID 13695 | 11:40:25 INFO - PID 13695 | Cycle 1(1): loaded http://localhost:42560/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42560/tests/kraken/driver.html?testName=audio-fft) 11:40:25 INFO - PID 13695 | RSS: Main: 175607808 11:40:25 INFO - PID 13695 | 11:40:28 INFO - PID 13695 | Cycle 1(1): loaded http://localhost:42560/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42560/tests/kraken/driver.html?testName=audio-oscillator) 11:40:28 INFO - PID 13695 | RSS: Main: 175894528 11:40:28 INFO - PID 13695 | 11:40:30 INFO - PID 13695 | Cycle 1(1): loaded http://localhost:42560/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42560/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:40:31 INFO - PID 13695 | RSS: Main: 176070656 11:40:31 INFO - PID 13695 | 11:40:34 INFO - PID 13695 | Cycle 1(1): loaded http://localhost:42560/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42560/tests/kraken/driver.html?testName=imaging-darkroom) 11:40:35 INFO - PID 13695 | RSS: Main: 177205248 11:40:35 INFO - PID 13695 | 11:40:38 INFO - PID 13695 | Cycle 1(1): loaded http://localhost:42560/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42560/tests/kraken/driver.html?testName=imaging-desaturate) 11:40:39 INFO - PID 13695 | RSS: Main: 177438720 11:40:39 INFO - PID 13695 | 11:40:42 INFO - PID 13695 | Cycle 1(1): loaded http://localhost:42560/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42560/tests/kraken/driver.html?testName=json-parse-financial) 11:40:42 INFO - PID 13695 | RSS: Main: 177549312 11:40:42 INFO - PID 13695 | 11:40:44 INFO - PID 13695 | Cycle 1(1): loaded http://localhost:42560/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42560/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:40:45 INFO - PID 13695 | RSS: Main: 177864704 11:40:45 INFO - PID 13695 | 11:40:46 INFO - PID 13695 | Cycle 1(1): loaded http://localhost:42560/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42560/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:40:47 INFO - PID 13695 | RSS: Main: 177512448 11:40:47 INFO - PID 13695 | 11:40:49 INFO - PID 13695 | Cycle 1(1): loaded http://localhost:42560/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42560/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:40:50 INFO - PID 13695 | RSS: Main: 174370816 11:40:50 INFO - PID 13695 | 11:40:52 INFO - PID 13695 | Cycle 1(1): loaded http://localhost:42560/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42560/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:40:53 INFO - PID 13695 | RSS: Main: 174514176 11:40:53 INFO - PID 13695 | 11:40:56 INFO - PID 13695 | Cycle 1(1): loaded http://localhost:42560/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42560/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:40:57 INFO - PID 13695 | RSS: Main: 174358528 11:40:57 INFO - PID 13695 | 11:40:58 INFO - PID 13695 | Cycle 1(1): loaded http://localhost:42560/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42560/tests/kraken/driver.html?testName=ai-astar) 11:40:59 INFO - PID 13695 | RSS: Main: 175882240 11:40:59 INFO - PID 13695 | 11:40:59 INFO - PID 13695 | __start_tp_report 11:40:59 INFO - PID 13695 | _x_x_mozilla_page_load 11:40:59 INFO - PID 13695 | _x_x_mozilla_page_load_details 11:40:59 INFO - PID 13695 | |i|pagename|runs| 11:40:59 INFO - PID 13695 | |0;ai-astar;97;107;100;107;108;108;108;98;109;111 11:40:59 INFO - PID 13695 | |1;audio-beat-detection;148;115;146;172;120;143;146;118;192;118 11:40:59 INFO - PID 13695 | |2;audio-dft;163;161;162;161;163;161;168;167;167;164 11:40:59 INFO - PID 13695 | |3;audio-fft;73;73;73;166;75;75;79;73;150;75 11:40:59 INFO - PID 13695 | |4;audio-oscillator;79;78;134;78;79;79;130;79;79;125 11:40:59 INFO - PID 13695 | |5;imaging-gaussian-blur;115;114;114;114;114;117;116;114;113;114 11:40:59 INFO - PID 13695 | |6;imaging-darkroom;148;149;148;148;150;148;148;147;149;147 11:40:59 INFO - PID 13695 | |7;imaging-desaturate;94;94;94;94;94;94;94;94;94;94 11:40:59 INFO - PID 13695 | |8;json-parse-financial;52;51;53;56;56;52;51;52;52;52 11:40:59 INFO - PID 13695 | |9;json-stringify-tinderbox;37;37;38;37;38;38;37;38;37;38 11:40:59 INFO - PID 13695 | |10;stanford-crypto-aes;74;74;74;77;73;75;74;75;75;77 11:40:59 INFO - PID 13695 | |11;stanford-crypto-ccm;120;123;118;124;120;117;113;130;121;167 11:40:59 INFO - PID 13695 | |12;stanford-crypto-pbkdf2;180;172;172;169;183;170;184;177;171;168 11:40:59 INFO - PID 13695 | |13;stanford-crypto-sha256-iterative;66;64;64;67;66;64;65;62;64;63 11:40:59 INFO - PID 13695 | __end_tp_report 11:40:59 INFO - PID 13695 | __start_cc_report 11:40:59 INFO - PID 13695 | _x_x_mozilla_cycle_collect,937 11:40:59 INFO - PID 13695 | __end_cc_report 11:40:59 INFO - PID 13695 | __startTimestamp1504204859084__endTimestamp 11:40:59 INFO - PID 13695 | 11:40:59 INFO - PID 13695 | ------- Summary: start ------- 11:40:59 INFO - PID 13695 | Number of tests: 14 11:40:59 INFO - PID 13695 | 11:40:59 INFO - PID 13695 | [#0] ai-astar Cycles:10 Average:105.30 Median:108.50 stddev:4.99 (4.6%) stddev-sans-first:4.29 11:40:59 INFO - PID 13695 | Values: 97.0 107.0 100.0 107.0 108.0 108.0 108.0 98.0 109.0 111.0 11:40:59 INFO - PID 13695 | 11:40:59 INFO - PID 13695 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:146.00 stddev:25.46 (17.4%) stddev-sans-first:26.90 11:40:59 INFO - PID 13695 | Values: 148.0 115.0 146.0 172.0 120.0 143.0 146.0 118.0 192.0 118.0 11:40:59 INFO - PID 13695 | 11:40:59 INFO - PID 13695 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:2.71 (1.7%) stddev-sans-first:2.86 11:40:59 INFO - PID 13695 | Values: 163.0 161.0 162.0 161.0 163.0 161.0 168.0 167.0 167.0 164.0 11:40:59 INFO - PID 13695 | 11:40:59 INFO - PID 13695 | [#3] audio-fft Cycles:10 Average:91.20 Median:74.00 stddev:35.46 (47.9%) stddev-sans-first:36.99 11:40:59 INFO - PID 13695 | Values: 73.0 73.0 73.0 166.0 75.0 75.0 79.0 73.0 150.0 75.0 11:40:59 INFO - PID 13695 | 11:40:59 INFO - PID 13695 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:79.00 stddev:24.71 (31.3%) stddev-sans-first:25.60 11:40:59 INFO - PID 13695 | Values: 79.0 78.0 134.0 78.0 79.0 79.0 130.0 79.0 79.0 125.0 11:40:59 INFO - PID 13695 | 11:40:59 INFO - PID 13695 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.00 stddev:1.18 (1.0%) stddev-sans-first:1.24 11:40:59 INFO - PID 13695 | Values: 115.0 114.0 114.0 114.0 114.0 117.0 116.0 114.0 113.0 114.0 11:40:59 INFO - PID 13695 | 11:40:59 INFO - PID 13695 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 11:40:59 INFO - PID 13695 | Values: 148.0 149.0 148.0 148.0 150.0 148.0 148.0 147.0 149.0 147.0 11:40:59 INFO - PID 13695 | 11:40:59 INFO - PID 13695 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 11:40:59 INFO - PID 13695 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 11:40:59 INFO - PID 13695 | 11:40:59 INFO - PID 13695 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:52.00 stddev:1.83 (3.5%) stddev-sans-first:1.92 11:40:59 INFO - PID 13695 | Values: 52.0 51.0 53.0 56.0 56.0 52.0 51.0 52.0 52.0 52.0 11:40:59 INFO - PID 13695 | 11:40:59 INFO - PID 13695 | [#9] json-stringify-tinderbox Cycles:10 Average:37.50 Median:38.00 stddev:0.53 (1.4%) stddev-sans-first:0.53 11:40:59 INFO - PID 13695 | Values: 37.0 37.0 38.0 37.0 38.0 38.0 37.0 38.0 37.0 38.0 11:40:59 INFO - PID 13695 | 11:40:59 INFO - PID 13695 | [#10] stanford-crypto-aes Cycles:10 Average:74.80 Median:75.00 stddev:1.32 (1.8%) stddev-sans-first:1.36 11:40:59 INFO - PID 13695 | Values: 74.0 74.0 74.0 77.0 73.0 75.0 74.0 75.0 75.0 77.0 11:40:59 INFO - PID 13695 | 11:40:59 INFO - PID 13695 | [#11] stanford-crypto-ccm Cycles:10 Average:125.30 Median:122.00 stddev:15.33 (12.6%) stddev-sans-first:16.14 11:40:59 INFO - PID 13695 | Values: 120.0 123.0 118.0 124.0 120.0 117.0 113.0 130.0 121.0 167.0 11:40:59 INFO - PID 13695 | 11:40:59 INFO - PID 13695 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.60 Median:174.50 stddev:5.93 (3.4%) stddev-sans-first:5.96 11:40:59 INFO - PID 13695 | Values: 180.0 172.0 172.0 169.0 183.0 170.0 184.0 177.0 171.0 168.0 11:40:59 INFO - PID 13695 | 11:40:59 INFO - PID 13695 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:64.50 stddev:1.51 (2.3%) stddev-sans-first:1.50 11:40:59 INFO - PID 13695 | Values: 66.0 64.0 64.0 67.0 66.0 64.0 65.0 62.0 64.0 63.0 11:40:59 INFO - PID 13695 | -------- Summary: end -------- 11:40:59 INFO - PID 13695 | 11:40:59 INFO - PID 13695 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:40:59 INFO - TEST-INFO | 13695: exit 0 11:40:59 INFO - TEST-OK | kraken | took 60934ms 11:40:59 INFO - SUITE-END | took 1171s 11:41:00 INFO - Completed test suite (00:19:31) 11:41:00 INFO - javascript benchmark 11:41:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8573.081502223955, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3301.884434044809, 3311.983440082799, 3328.118048717089, 3337.532745415641, 3356.8825091121785, 6240.656763877985, 6296.779612713562, 6314.336994615568, 6315.778947736831, 6402.359764023596, 6112.235970503687, 6247.71885265163, 6266.248050233967, 6268.091126786613, 6271.623702577848, 5733.111367738007, 5777.046787280115, 5800.941990580082, 5802.245708057968, 5916.3787802280785, 5822.417758224165, 5823.563232757539, 5896.204012458306, 5898.380670029649, 5899.823005309848, 1110.3656049782267, 5716.8284951451105, 5728.742206600671, 5822.184894114827, 5934.525237980951, 5686.459786320293, 5798.3911689272445, 5883.70581470929, 5889.087191485327, 5892.734826932799, 5794.797182098607, 5802.709864506758, 5880.26496687914, 5882.205902203234, 5883.882322353529, 6282.623042617458, 6295.779647712354, 6310.0, 6348.904766428507, 6394.0, 6741.3258674132685, 6754.324567543206, 6755.5271131020845, 6826.863462730767, 6873.518853680244, 6573.1783527059115, 6654.6672666366485, 6670.899936500957, 6710.865782684368, 6925.930740692579, 6301.054841773679, 6333.524985626096, 6345.873082538324, 6356.523260755462, 6376.426121649074, 6890.965545172342, 6911.516193866381, 7005.05431766705, 7007.194172670208, 7023.086998690138, 6358.23701155855, 6604.768833090819, 6653.833654158588, 6698.832529186712, 6711.563748356341, 6632.734690612418, 6673.232578253466, 6677.23211830636, 6680.565763225375, 6696.0960270362875, 6657.833554161185, 6710.0, 6798.558093723892, 6798.592084474947, 6799.93200067993, 6793.184817821893, 6850.109485766819, 6859.5541289816, 6869.965650171717, 6870.038194652752, 5215.478452154754, 5282.260483532308, 5307.124324486494, 5387.218853266255, 5408.78364865401, 4569.885752856205, 4584.33527138563, 4589.036302376471, 4598.8620341389815, 4605.838795642204, 5818.301803783573, 5819.214406055128, 5822.272215973004, 5921.2302400688495, 5941.108833674897, 6768.086308348408, 6802.65986700663, 6835.4189893859575, 6864.97025446187, 6899.413549848319, 5892.175095486636, 5902.911456328158, 5969.611975221596, 5972.701364931736, 5978.0, 5819.214406055213, 5820.447057529528, 5895.498882594941, 5897.76408943646, 5900.232969713909, 6381.202349706286, 6502.122213501211, 6565.967170164118, 6660.034295027194, 6663.267040625527, 6853.520253582301, 6863.794086177223, 6895.069165662772, 6895.138107736533, 6921.757738479129, 6572.178477690289, 6610.272869984202, 6709.530332876847, 6710.664466776544, 6727.899081513683, 6476.449501792212, 6698.966505167443, 6722.630255336004, 6791.694373753292, 6820.113385260083, 6605.504587155887, 6712.228093769279, 6798.8640227196165, 6817.352351526597, 6829.317068293131, 6493.155889734304, 6505.186851643544, 6517.934820651923, 6582.3746744059235, 6585.242697089704, 6450.548461607643, 6461.903071453838, 6530.379613936669, 6537.836554086186, 6542.574732642363, 6315.336889626523, 6408.910485217431, 6443.71003304843, 6529.314421985813, 6536.542442029012, 6586.901196481961, 6589.04458853454, 6706.6981985811735, 6719.059331693469, 6725.361090696376, 6405.487560995202, 6439.8068057958335, 6485.740570377132, 6520.315366886409, 6523.24982627004], "value": 6145.901698314963, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.5076200469694, 800.1038836503117, 835.2274146414567, 839.9706010289641, 1138.7096290445936, 28826.423471530557, 29258.0, 38974.22051558971, 40140.39789403154, 40144.598554014454, 39050.21899562007, 39368.409473857915, 39372.40941385881, 39415.0, 39462.210755784865, 7587.506812057226, 7685.654145563435, 7820.25707557784, 7826.413019023567, 7831.29518343349, 7551.131619863731, 7682.423818213629, 7695.846083078335, 7712.922870771276, 7719.189485104067, 7665.156832748393, 7677.654505547263, 7681.9231807682045, 7739.264769846855, 7752.651130699132, 7639.159692433828, 7678.500897441704, 7696.692132314756, 7697.422693297997, 7699.268569485918, 7603.353714934237, 7672.232776722339, 7674.117476490219, 7674.884876726854, 7676.577788221645, 36452.0, 36587.451188231935, 36639.08402289938, 36758.44862327067, 36774.63225367766, 3165.113768144923, 3206.7434605231524, 3208.631007434152, 3210.133264018702, 3212.9518057228925, 30537.389252215053, 30580.54129188064, 30639.08082757521, 30686.0, 30733.385332293452, 5148.2020286855595, 5155.922661160085, 5188.325517682677, 5212.609054320941, 5285.735713214324, 187057.0, 187343.0, 189718.0, 189880.0, 190359.04820475949, 46039.53960460419, 46094.30858537125, 46207.0, 46279.76860115678, 46327.536724633, 47375.52624473711, 47398.0, 47408.051838963715, 47804.5219547807, 47807.521924781, 11980.101492387932, 12208.267503949613, 13634.1137826041, 13834.30828458573, 13841.653958651113, 10951.4524273786, 11132.387718675389, 11191.776164476665, 11202.047825934724, 11202.943985280184, 13743.862561374259, 13866.930665346608, 13925.791113133311, 13978.650533736534, 14053.71892562143, 5890.852728681817, 5975.940240597625, 5981.730822112929, 5984.521238300926, 5992.940070599326, 1021.6219998600566, 1032.4166845732138, 1043.4626167523732, 1045.46158728255, 1049.2497864027105, 21986.340409787732, 22465.663015054786, 22714.545709085727, 22741.772582273967, 22899.885500572724, 1113.8997490225918, 1124.7469319403233, 1125.5272785430138, 1127.0870594818223, 1128.7121783945042, 11910.880891191151, 11922.403879805976, 11927.105467090003, 11997.940010300068, 12003.0, 225060.0, 225632.0, 226106.0, 226131.0, 226686.0, 49484.50515494871, 49548.0, 49689.503104968484, 49739.25391119136, 49788.502114979114, 1421.5877395555174, 1438.1083728088652, 1439.330711219288, 1450.7243623711672, 1451.867543316215, 22287.77712222857, 22369.217077402212, 22420.775792241868, 22569.09723611103, 22900.541989160458, 36357.27285454329, 36493.81753091217, 36547.634523655484, 36565.268694625425, 36626.0, 189763.0, 189904.0, 190177.0, 190338.0, 190448.0, 32498.675013249565, 32627.0, 34297.65702342945, 34972.65027349694, 35017.474737878445, 43099.35350969675, 44706.0, 44729.0, 44824.77587612041, 45370.546294537955, 32215.35569288648, 32554.348913021135, 32600.510992335607, 32686.0, 32744.34511309713, 31378.0, 31739.365212695157, 31808.522872156474, 31835.20411989719, 32402.189945251557, 35861.82069089638, 36119.81940090283, 36156.27687446184, 36185.45721814228, 36265.0, 30213.546796797626, 31520.684793151773, 31659.52510712387, 31922.0, 32039.03882883517, 21974.340769776933, 22256.666150008088, 22307.553848922606, 22522.436939076655, 22697.205597803997], "value": 16670.699784726345, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.115775916293, 564.1143404854375, 569.9145128230765, 577.4629594477137, 587.5622661117467, 21797.564048719018, 22420.77579224207, 22537.887310563445, 22583.096676132976, 22598.88700556495, 24930.50138997219, 25513.744862551368, 25577.825884799815, 25583.872080639572, 25593.0, 6499.675016249193, 6664.533482656216, 6665.466762659, 6665.900011499832, 6670.466362690997, 6303.2436107667145, 6525.902111468332, 6593.109930159439, 6654.401103900648, 6659.300773418794, 6565.015247712833, 6600.966995165018, 6602.471802255832, 6605.405513503783, 6606.14120164378, 6600.570962887397, 6612.86774264512, 6617.404433600951, 6617.834554136161, 6618.238902526199, 6128.172696685935, 6140.4473597376, 6147.170132032164, 6151.0, 6152.630842149485, 27342.0, 28364.71635283662, 28940.27649308763, 29336.853315733286, 29562.852185738935, 2071.9378418647466, 2090.989545052265, 2103.684447332897, 2106.799854013866, 2120.385088324384, 18889.811101888943, 20227.190912363487, 21155.365339039854, 21211.575768484545, 21234.78765212359, 2325.395397196724, 2336.4626135988647, 2399.2442380650214, 2403.242978461779, 2410.7227668818136, 145626.0, 151672.2416387922, 152108.0, 152237.0, 152267.0, 20605.939406059275, 20997.790022099583, 21719.891400542896, 21918.671219931715, 22659.660105098435, 42938.78530607327, 42960.57039429628, 43047.78476107599, 43143.35284970728, 43153.784231078644, 10634.149268058536, 10741.462926853626, 10798.190135739851, 10826.729331766612, 10844.891551084545, 8701.869471957925, 8793.648254069765, 8812.8678069829, 8846.513441760764, 8911.064338244521, 11638.1271404645, 11691.76616467666, 11708.590199342982, 11802.586909458129, 11825.408729563487, 4122.649574786117, 4146.295129827937, 4188.581141885848, 4232.788360581959, 4369.737815731066, 963.5471328475605, 979.7844474215661, 986.6743974488402, 989.2135752077116, 996.3473924579412, 19182.0, 19460.610787784164, 19466.61066778685, 19821.702674459895, 23120.7687923122, 995.4176806568094, 1050.579768092769, 1050.858134151895, 1056.6248981611418, 1062.8990245926625, 10693.41186234749, 10709.196810239264, 10807.567697292177, 10829.24195306321, 10915.95354828401, 486573.0, 492266.0, 500220.0, 503998.0, 515486.0, 120238.0, 122721.38639306925, 123400.0, 125388.37305813412, 125790.0, 1215.6474622359594, 1236.202649291202, 1257.207958985833, 1259.2318685601776, 1268.239056566053, 17108.48674539766, 17137.22882470267, 17408.47774566765, 17704.734428983316, 17826.732599011284, 52173.21740173976, 53225.0, 55314.17028744492, 55850.72074639601, 55923.0, 73491.0, 74265.0, 74636.25363746293, 74781.50436991338, 74984.62507687644, 14059.297035147996, 14095.365708542935, 14193.716125677221, 14258.928705356408, 14301.92849035748, 20781.792182078592, 20893.686594700786, 22643.20748773785, 22838.42903927415, 22950.311490655306, 16420.0, 16656.333746649998, 17066.829331706525, 18425.26298948027, 18586.628267434848, 15064.02083864589, 15129.773053404428, 15556.222188890737, 16491.17544122813, 16763.0, 18582.628347432707, 19803.207871684972, 19893.701594475806, 20019.0, 20224.797752022292, 14273.500427484989, 14480.203588802717, 14483.493077742229, 14520.636984075483, 14525.418983240974, 16269.918650406673, 16440.095794731405, 16579.253933572778, 16599.668006639557, 16623.335066597683], "value": 12555.880353760054, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.927568983706, 1382.0878220374555, 1393.4844107680146, 1395.3441882315315, 1408.6126315263302, 12726.363681815896, 15122.395104195833, 15735.763963540541, 15780.684386312281, 15810.84189158108, 12811.871881281184, 15247.16140612266, 15641.296141673623, 15662.451814186506, 15673.451429199951, 2707.1743118348895, 2762.2541913683294, 2777.3056735816044, 2777.847218402987, 2779.12457575864, 2651.496215719007, 2670.8531030793297, 2768.1557125076843, 2798.8040837141407, 2799.958000629992, 2815.81697189682, 2841.1334542964387, 2862.1556640790914, 2866.9283267918363, 2866.956995645067, 2605.1012400721816, 2689.7713694336003, 2690.5560582503863, 2694.892204311825, 2695.151027426374, 2625.8708755235243, 2654.707982121965, 2660.813743037988, 2664.733526647339, 2666.2534490342737, 14962.326695298629, 15302.158381289024, 15304.617384565363, 15314.310856011507, 15317.693646127014, 7983.840323193562, 8271.255586997138, 8279.834403311961, 8281.461704989217, 8284.83430331396, 5063.721495317756, 5259.447757985433, 5382.703951282678, 5461.508464238238, 5497.505224529811, 1852.435007322766, 1893.185930050078, 1898.734177215191, 1935.5161209697576, 1947.9415617531497, 22384.77615223843, 23007.999999999833, 26658.33354166142, 26762.73237267622, 26816.195514134608, 6764.763233286812, 6832.965835170792, 6938.653067346713, 7040.577565346096, 7048.083749112582, 17169.48491545256, 17213.827861721475, 17238.569035774206, 17239.22423490946, 17256.0, 7938.6427610757655, 8071.313938315191, 8071.878921816177, 8073.11195768465, 8074.636641351153, 7414.592197429193, 7436.442266830009, 7465.925340746631, 7499.400047996256, 7507.249275072559, 5192.247124166975, 5267.920981185285, 5329.920051199235, 5361.624686272002, 5368.8657783554945, 1465.728840164573, 1469.7281003014477, 1476.4979906831513, 1485.6406388154933, 1499.272852666456, 879.2570278114982, 891.7101941868918, 896.9865452018225, 909.4861403307243, 913.2100732866023, 7892.723754668559, 7942.126366099725, 8003.6798528058225, 8064.233897779702, 8123.431359804875, 718.8993540904278, 730.0582248898967, 731.5647189921988, 738.2986163145034, 746.4289818289013, 5328.92006619901, 5484.561235101182, 5511.58663100269, 5557.194206839986, 6010.669413182317, 21500.354989350344, 21975.23086691958, 22108.55782884333, 22627.88686056559, 22726.20458283952, 21883.452913677287, 22053.448663783533, 22093.0, 22467.10131594718, 22477.21329753451, 11455.427228638535, 11539.76920461586, 11730.413479326171, 11749.236299640666, 11802.763944721057, 8975.102489750972, 9137.40606860552, 9155.816883662157, 9204.447733135765, 9211.263098952202, 19024.334148304744, 19069.046547672282, 19254.0, 19494.512637184183, 19874.304399345954, 19042.33351832679, 19463.61072778565, 19664.41006769799, 19738.0, 19841.900790495954, 11676.357800321064, 11921.642350729491, 11934.880651193724, 11957.880421195676, 11980.400979950793, 14082.0, 14351.067180633643, 14406.135631862122, 14414.063085899383, 14416.279186040447, 11145.888541114486, 11230.101591872468, 11303.660890173307, 11371.886281137082, 11520.654380368602, 10962.0, 11189.552417903193, 11205.271657342246, 11293.71765705864, 11346.489407976826, 8759.474431534129, 8979.191872731486, 8983.921929368518, 8985.640574377214, 9013.819723605622, 7296.7081316746735, 7309.342159205485, 7319.4144468443465, 7329.963350183215, 7330.0, 7522.8871566925445, 7573.583452910143, 7585.127710313384, 7609.923900760921, 7742.0], "value": 6696.885058816629, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.861987953313, 508.3899320815022, 519.1900635009385, 522.7229568328787, 529.9163211233029, 6265.404786545271, 6283.120363149163, 6334.642639401119, 6354.8729025419525, 6391.360863913618, 6179.289381721103, 6187.35032821554, 6187.5668703190795, 6201.193844800181, 6209.720562574684, 4846.127697014536, 5076.746162691869, 5080.009398167359, 5131.306668799297, 5134.589232861381, 4869.879927616633, 4996.375453068366, 4999.150144475448, 5030.471800460954, 5059.11465493539, 4921.532454416824, 4924.482929292427, 4973.428055773578, 4979.30289759434, 4994.500549944994, 4908.092002979461, 4928.67963582366, 4959.404871415453, 4969.627277954168, 4982.227754698028, 4473.127740090684, 4490.797914093873, 4511.210538155809, 4517.119161763458, 4540.409746732937, 6072.666003369813, 6134.693265336716, 6202.131701561785, 6207.410296021871, 6219.315875253718, 5706.3152421709665, 5716.799912003102, 5716.857078573027, 5719.742611582489, 5729.197912292282, 6599.901001484982, 6604.537682362236, 6609.93390066098, 6612.636305003223, 6616.702248398834, 4906.90186196274, 4916.901661966776, 4918.01639672067, 4924.753762311906, 4925.7783399747095, 6653.700583473756, 6799.898001529882, 6806.829829254309, 6886.931130688679, 6965.756198533027, 5019.548240658358, 5029.421616514074, 5039.732120545769, 5042.7982880685095, 5046.419661738947, 5075.3402057732255, 5117.155669314596, 5127.179651255781, 5150.922736158961, 5155.587552995751, 5697.7151142443545, 5716.742746576331, 5737.88524229513, 5738.741756620962, 5739.139129130664, 6654.933450665529, 6655.267920528738, 6687.264400915896, 6691.360616648953, 6702.9447184453675, 1769.8053214146435, 1778.7954385245862, 1784.3665498748016, 1794.793598736136, 1795.5780391607962, 1187.2935603316014, 1229.567553799831, 1234.9444275007647, 1246.2833870524485, 1251.874812518759, 5800.622959507618, 5822.184894114827, 5830.766769329264, 5845.444682755132, 5856.970715146397, 6708.698108585126, 6732.966335168293, 6734.259231484532, 6739.427148692318, 6819.31806819324, 5713.942860571341, 5722.0, 5724.79963201286, 5734.684592347461, 5748.19525266463, 3545.663161999606, 3610.494530765695, 3632.800195989246, 3634.1459756957092, 3639.6724294813594, 6162.938370616236, 6521.673916304166, 6544.181977252843, 6553.4101930826455, 6577.599176300616, 6885.414739747178, 6889.655517224219, 6896.965515172392, 6941.375276225164, 6956.826079347956, 6522.347765223534, 6608.306127856506, 6624.768133115318, 6634.83412914681, 6671.13275274221, 6674.365935236145, 6687.4984376171005, 6717.731290748316, 6722.764703235559, 6768.4585233182215, 6719.260881302955, 6721.361470660279, 6733.2593414725325, 6766.8646627068165, 6786.3892249697765, 6626.271110177973, 6651.866962660816, 6668.633225172662, 6684.632345220865, 6687.531872768859, 5054.949450505448, 5056.974715126401, 5068.26510156018, 5068.594512438923, 5077.136886729191, 6526.967365163144, 6637.867242655217, 6664.100346453167, 6776.220734615582, 6798.558093723892, 6474.5791523550815, 6481.902771458337, 6511.544191906711, 6513.120728701565, 6527.988161834924, 6498.3826536478955, 6522.869542609026, 6563.278039415756, 6565.737370505126, 6579.144711187707, 6428.839279018062, 6468.288488266381, 6470.773522926675, 6508.479321654351, 6518.120053792677, 6567.507436942153, 6584.209894812653, 6587.901181482186, 6594.142761440982, 6597.977313516412, 6287.182666253358, 6287.96856015717, 6338.651374174465, 6356.9046464304, 6374.330695276929], "value": 5087.085429361882, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [902.5261737587765, 909.499775123682, 925.1303774452015, 926.7405126564564, 930.8184903943734, 18046.09769511524, 19168.520786980316, 19199.0, 19288.614227715454, 21908.561828763453, 20345.796542034575, 21202.46993825155, 21288.148474061058, 21292.787072129275, 21430.0, 953.9904600953971, 971.4171497101718, 972.7130496503513, 976.6337623391229, 980.4362491567342, 964.5996911281844, 986.1617625018748, 989.4953573677441, 989.8911119776855, 994.5723338964278, 1065.9413732244761, 1071.0949247885562, 1071.0949247885562, 1071.4803320389606, 1071.9892801072006, 1058.798828222643, 1059.3061544688242, 1061.5912873543703, 1062.0812996757827, 1062.1768129699467, 776.2043904997366, 777.8638738220789, 779.6569509415839, 779.7699678594771, 780.0795061827042, 17517.386891458736, 17611.383601574013, 17822.48508876747, 17826.91086544572, 18958.14688339028, 20956.89521552398, 20960.685589716166, 21057.0, 21639.567208655895, 21783.564328713495, 16624.83375166257, 16750.664986700198, 16759.564857561658, 16783.412580559743, 16855.662886742197, 3685.5208822852856, 3715.3126671565847, 3715.5912849586525, 3718.0704823794053, 3720.3489389356755, 119686.0, 121354.99999999911, 121759.3912030443, 127221.36389318087, 129795.7020429793, 16924.661506769797, 17528.824711752975, 17625.647487050188, 17799.555011124827, 17842.643147137245, 30699.079027629206, 30828.38343233123, 30917.0724878254, 31328.530072048936, 31362.21594460157, 7892.921070789219, 8322.50064996102, 8852.911470885338, 9188.586513606904, 9325.207357374564, 4473.575010374009, 4599.126166028511, 4603.49361570227, 4603.769811509411, 4611.976940115278, 5295.761690723926, 5391.245225668409, 5399.865003374868, 5419.214213939035, 5450.291462109901, 1011.1051719228535, 1032.3805716569998, 1038.076112260089, 1041.5156952017348, 1042.2443728297076, 683.7265093962355, 694.6214313199318, 699.1400577289962, 699.9055127557816, 707.5825263094799, 11476.827847582294, 11534.0, 11913.52345906154, 12714.27573055913, 13202.207867527979, 685.9245482996866, 690.6167077272062, 692.3803196139528, 695.4957655699577, 705.6295444891371, 5864.648121112661, 6294.307626161119, 6336.271328797247, 6377.808665740035, 6427.967860160669, 105294.0, 106741.0, 109047.45476272727, 109676.80646387028, 111287.44356278167, 96968.51515742377, 99164.0, 99426.0, 99485.50257248813, 100762.0, 83970.0, 85540.14459855446, 85740.57129714312, 88411.55794220988, 89262.55368723244, 11625.12811539121, 11785.292882426738, 11846.644600661994, 11894.821577676168, 11970.700732481757, 38868.6113138865, 39630.2073958525, 39846.40230396488, 40717.0, 41108.79445602753, 51612.74193629008, 52030.0, 52887.0, 53256.467435325154, 53385.7330713344, 16498.75251871247, 16737.832621674115, 16938.23777930021, 16992.57518562046, 17057.402990895258, 18127.093645317946, 19884.204631815144, 20077.196912123352, 20663.070161842454, 20668.58662826765, 18704.906475467535, 18719.34482293168, 18768.0, 18788.718169227745, 18831.0, 16721.0, 17421.0, 17447.30210791554, 18204.908975455568, 19076.713849292548, 17413.91293043527, 17420.564485887953, 17491.912540437217, 17547.912260439127, 17765.378211762527, 11105.777884442428, 11537.307761533999, 11777.764444711229, 11895.762084758084, 12186.817197742219, 12319.815202772144, 12379.0, 12672.619821405373, 12732.681682958, 13135.868641313464], "value": 9058.738335273647, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1482.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 107.0, 100.0, 107.0, 108.0, 108.0, 108.0, 98.0, 109.0, 111.0], "value": 105.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 115.0, 146.0, 172.0, 120.0, 143.0, 146.0, 118.0, 192.0, 118.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 161.0, 163.0, 161.0, 168.0, 167.0, 167.0, 164.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 166.0, 75.0, 75.0, 79.0, 73.0, 150.0, 75.0], "value": 91.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 134.0, 78.0, 79.0, 79.0, 130.0, 79.0, 79.0, 125.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 114.0, 114.0, 117.0, 116.0, 114.0, 113.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 148.0, 150.0, 148.0, 148.0, 147.0, 149.0, 147.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 53.0, 56.0, 56.0, 52.0, 51.0, 52.0, 52.0, 52.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 38.0, 37.0, 38.0, 38.0, 37.0, 38.0, 37.0, 38.0], "value": 37.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 77.0, 73.0, 75.0, 74.0, 75.0, 75.0, 77.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 123.0, 118.0, 124.0, 120.0, 117.0, 113.0, 130.0, 121.0, 167.0], "value": 125.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 172.0, 172.0, 169.0, 183.0, 170.0, 184.0, 177.0, 171.0, 168.0], "value": 174.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 67.0, 66.0, 64.0, 65.0, 62.0, 64.0, 63.0], "value": 64.5, "unit": "score"}]}]} 11:41:00 INFO - Return code: 0 11:41:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:41:00 INFO - # TBPL SUCCESS # 11:41:00 INFO - Running post-action listener: _package_coverage_data 11:41:00 INFO - Running post-action listener: _resource_record_post_action 11:41:00 INFO - [mozharness: 2017-08-31 18:41:00.375092Z] Finished run-tests step (success) 11:41:00 INFO - Running post-run listener: _resource_record_post_run 11:41:00 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 20480; Write bytes: 397606912; Read time: 60; Write time: 267828 11:41:00 INFO - TinderboxPrint: CPU usage
13.1% 11:41:00 INFO - TinderboxPrint: I/O read bytes / time
20,480 / 60 11:41:00 INFO - TinderboxPrint: I/O write bytes / time
397,606,912 / 267,828 11:41:00 INFO - TinderboxPrint: CPU idle
8,239.0 (86.9%) 11:41:00 INFO - TinderboxPrint: CPU user
1,191.9 (12.6%) 11:41:00 INFO - TinderboxPrint: Swap in / out
0 / 0 11:41:00 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 112955392; Read time: 0; Write time: 75464 11:41:00 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:41:00 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 20480; Write bytes: 284651520; Read time: 60; Write time: 192364 11:41:01 INFO - Running post-run listener: _upload_blobber_files 11:41:01 INFO - Blob upload gear active. 11:41:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:41:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:41:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:41:01 INFO - (blobuploader) - INFO - Open directory for files ... 11:41:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:41:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:41:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:05 INFO - (blobuploader) - INFO - Done attempting. 11:41:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:41:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:41:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:06 INFO - (blobuploader) - INFO - Done attempting. 11:41:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:41:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:41:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:07 INFO - (blobuploader) - INFO - Done attempting. 11:41:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:41:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:41:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:09 INFO - (blobuploader) - INFO - Done attempting. 11:41:09 INFO - (blobuploader) - INFO - Iteration through files over. 11:41:09 INFO - Return code: 0 11:41:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:41:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:41:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ba85f639254a84e4da851670d62d4a5ca057b26f32b47e262c9a7518cf79f0efdf7e2d6aaa6ba6a2f9f21580c50969146e37eabd13f7864b4208001098dc51f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7db0e99866dc605b2879836606c98748e5baae89ba292facc9d3a85d076589642c1d2bb5c60320333077773e2a67e74dc3992872432df48d21e5e1d56cb58707", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/032109b8e7ce6109408f348be88bdaa17d65cd753c0ea3d7bae26d4ef832db259ffe663a2f183eeb5e4417ddcbf983a6cf29d90c80bf1b9013eb89d55512fd43", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95a93da627b73f3732f667362e6cc0bb10e1618d560038d7965ca1896916095be5a657c5db12214b334ea4aacc1dd752f043a00b80703a07c4088818a0699041"} 11:41:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:41:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:41:09 INFO - Contents: 11:41:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ba85f639254a84e4da851670d62d4a5ca057b26f32b47e262c9a7518cf79f0efdf7e2d6aaa6ba6a2f9f21580c50969146e37eabd13f7864b4208001098dc51f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7db0e99866dc605b2879836606c98748e5baae89ba292facc9d3a85d076589642c1d2bb5c60320333077773e2a67e74dc3992872432df48d21e5e1d56cb58707", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/032109b8e7ce6109408f348be88bdaa17d65cd753c0ea3d7bae26d4ef832db259ffe663a2f183eeb5e4417ddcbf983a6cf29d90c80bf1b9013eb89d55512fd43", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95a93da627b73f3732f667362e6cc0bb10e1618d560038d7965ca1896916095be5a657c5db12214b334ea4aacc1dd752f043a00b80703a07c4088818a0699041"} 11:41:09 INFO - Running post-run listener: copy_logs_to_upload_dir 11:41:09 INFO - Copying logs to upload dir... 11:41:09 INFO - mkdir: /builds/slave/test/build/upload/logs 11:41:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.325561 ========= master_lag: 0.95 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-31 11:41:09.755774) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-31 11:41:09.760671) ========= 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=32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ba85f639254a84e4da851670d62d4a5ca057b26f32b47e262c9a7518cf79f0efdf7e2d6aaa6ba6a2f9f21580c50969146e37eabd13f7864b4208001098dc51f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7db0e99866dc605b2879836606c98748e5baae89ba292facc9d3a85d076589642c1d2bb5c60320333077773e2a67e74dc3992872432df48d21e5e1d56cb58707", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/032109b8e7ce6109408f348be88bdaa17d65cd753c0ea3d7bae26d4ef832db259ffe663a2f183eeb5e4417ddcbf983a6cf29d90c80bf1b9013eb89d55512fd43", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95a93da627b73f3732f667362e6cc0bb10e1618d560038d7965ca1896916095be5a657c5db12214b334ea4aacc1dd752f043a00b80703a07c4088818a0699041"} build_url:https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011430 build_url: 'https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ba85f639254a84e4da851670d62d4a5ca057b26f32b47e262c9a7518cf79f0efdf7e2d6aaa6ba6a2f9f21580c50969146e37eabd13f7864b4208001098dc51f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7db0e99866dc605b2879836606c98748e5baae89ba292facc9d3a85d076589642c1d2bb5c60320333077773e2a67e74dc3992872432df48d21e5e1d56cb58707", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/032109b8e7ce6109408f348be88bdaa17d65cd753c0ea3d7bae26d4ef832db259ffe663a2f183eeb5e4417ddcbf983a6cf29d90c80bf1b9013eb89d55512fd43", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95a93da627b73f3732f667362e6cc0bb10e1618d560038d7965ca1896916095be5a657c5db12214b334ea4aacc1dd752f043a00b80703a07c4088818a0699041"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-31 11:41:09.790211) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 11:41:09.790571) ========= 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=32c5991c409366f7fec8a718000001d2-1504203616.281560-1209357532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 11:41:09.872096) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-31 11:41:09.875311) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-31 11:41:09.875663) ========= ========= Total master_lag: 1.11 =========