builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-015 starttime: 1501410461.89 results: success (0) revision: 6ee53b46474f74c231b1b569e8f2ecd9d0948a8f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-30 03:27:41.887304) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-30 03:27:41.887723) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-30 03:27:41.887996) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-30 03:27:41.917144) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:27:41.917404) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1501410051.880594-1781886007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-30 03:27:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 100M=0s 2017-07-30 03:27:42 (100 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.079957 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:27:42.016826) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:27:42.017179) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1501410051.880594-1781886007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014543 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:27:42.070384) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:27:42.070670) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6ee53b46474f74c231b1b569e8f2ecd9d0948a8f --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 6ee53b46474f74c231b1b569e8f2ecd9d0948a8f --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1501410051.880594-1781886007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-30 03:27:42,345 truncating revision to first 12 chars 2017-07-30 03:27:42,345 Setting DEBUG logging. 2017-07-30 03:27:42,345 attempt 1/10 2017-07-30 03:27:42,345 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6ee53b46474f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-30 03:27:42,644 unpacking tar archive at: mozilla-central-6ee53b46474f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.610937 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:27:42.696844) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-30 03:27:42.700173) ========= script_repo_revision: 6ee53b46474f74c231b1b569e8f2ecd9d0948a8f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-30 03:27:42.700550) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-30 03:27:42.700810) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-30 03:27:42.710363) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-07-30 03:27:42.710654) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1501410051.880594-1781886007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:27:43 INFO - MultiFileLogger online at 20170730 03:27:43 in /builds/slave/test 03:27:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:27:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:27:43 INFO - {'append_to_log': False, 03:27:43 INFO - 'base_work_dir': '/builds/slave/test', 03:27:43 INFO - 'blob_upload_branch': 'Firefox', 03:27:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:27:43 INFO - 'branch': 'Firefox', 03:27:43 INFO - 'buildbot_json_path': 'buildprops.json', 03:27:43 INFO - 'code_coverage': False, 03:27:43 INFO - 'config_files': ('talos/linux_config.py',), 03:27:43 INFO - 'default_actions': ('clobber', 03:27:43 INFO - 'read-buildbot-config', 03:27:43 INFO - 'download-and-extract', 03:27:43 INFO - 'populate-webroot', 03:27:43 INFO - 'create-virtualenv', 03:27:43 INFO - 'install', 03:27:43 INFO - 'setup-mitmproxy', 03:27:43 INFO - 'run-tests'), 03:27:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:27:43 INFO - 'disable_ccov_upload': False, 03:27:43 INFO - 'download_minidump_stackwalk': True, 03:27:43 INFO - 'download_symbols': 'ondemand', 03:27:43 INFO - 'enable_stylo': False, 03:27:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:27:43 INFO - 'tooltool.py': '/tools/tooltool.py', 03:27:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:27:43 INFO - '/tools/misc-python/virtualenv.py')}, 03:27:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:27:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:27:43 INFO - 'gecko_profile': False, 03:27:43 INFO - 'gecko_profile_interval': 0, 03:27:43 INFO - 'installer_path': 'installer.exe', 03:27:43 INFO - 'log_level': 'info', 03:27:43 INFO - 'log_name': 'talos', 03:27:43 INFO - 'log_to_console': True, 03:27:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:27:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:27:43 INFO - 'opt_config_files': (), 03:27:43 INFO - 'pip_index': False, 03:27:43 INFO - 'suite': 'dromaeojs-e10s', 03:27:43 INFO - 'system_bits': '32', 03:27:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:27:43 INFO - 'title': 'talos-linux64-ix-015', 03:27:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:27:43 INFO - 'use_talos_json': True, 03:27:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:27:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:27:43 INFO - 'work_dir': 'build'} 03:27:43 INFO - [mozharness: 2017-07-30 10:27:43.086416Z] Running clobber step. 03:27:43 INFO - Running pre-action listener: _resource_record_pre_action 03:27:43 INFO - Running main action method: clobber 03:27:43 INFO - rmtree: /builds/slave/test/build 03:27:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:27:44 INFO - Running post-action listener: _resource_record_post_action 03:27:44 INFO - [mozharness: 2017-07-30 10:27:44.631096Z] Finished clobber step (success) 03:27:44 INFO - [mozharness: 2017-07-30 10:27:44.631197Z] Running read-buildbot-config step. 03:27:44 INFO - Running pre-action listener: _resource_record_pre_action 03:27:44 INFO - Running main action method: read_buildbot_config 03:27:44 INFO - Using buildbot properties: 03:27:44 INFO - { 03:27:44 INFO - "project": "", 03:27:44 INFO - "product": "firefox", 03:27:44 INFO - "who": "archaeopteryx@coole-files.de", 03:27:44 INFO - "installer_path": "public/build/target.tar.bz2", 03:27:44 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:27:44 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:27:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 03:27:44 INFO - "stage_platform": "linux64-pgo", 03:27:44 INFO - "basedir": "/builds/slave/test", 03:27:44 INFO - "buildnumber": 91, 03:27:44 INFO - "platform": "ubuntu64_hw", 03:27:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:27:44 INFO - "slavebuilddir": "test", 03:27:44 INFO - "taskId": "KKjlOVUOS3KZcWWZQZbqVw", 03:27:44 INFO - "branch": "mozilla-central", 03:27:44 INFO - "script_repo_revision": "production", 03:27:44 INFO - "revision": "6ee53b46474f74c231b1b569e8f2ecd9d0948a8f", 03:27:44 INFO - "slavename": "talos-linux64-ix-015", 03:27:44 INFO - "repo_path": "mozilla-central" 03:27:44 INFO - } 03:27:44 INFO - Finding installer, test and symbols from parent task. 03:27:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KKjlOVUOS3KZcWWZQZbqVw'}, attempt #1 03:27:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KKjlOVUOS3KZcWWZQZbqVw'}, attempt #1 03:27:45 INFO - Task dependencies: T-Lx5xutS1q2OwcNrwiKhw 03:27:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T-Lx5xutS1q2OwcNrwiKhw'}, attempt #1 03:27:45 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/T-Lx5xutS1q2OwcNrwiKhw/artifacts/public/build/target.tar.bz2 03:27:45 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/T-Lx5xutS1q2OwcNrwiKhw/artifacts/public/build/target.test_packages.json 03:27:45 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/T-Lx5xutS1q2OwcNrwiKhw/artifacts/public/build/target.crashreporter-symbols.zip 03:27:45 INFO - Running post-action listener: _resource_record_post_action 03:27:45 INFO - [mozharness: 2017-07-30 10:27:45.968136Z] Finished read-buildbot-config step (success) 03:27:45 INFO - [mozharness: 2017-07-30 10:27:45.968358Z] Running download-and-extract step. 03:27:45 INFO - Running pre-action listener: _resource_record_pre_action 03:27:45 INFO - Running main action method: download_and_extract 03:27:45 INFO - mkdir: /builds/slave/test/build/tests 03:27:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:45 INFO - trying https://queue.taskcluster.net/v1/task/T-Lx5xutS1q2OwcNrwiKhw/artifacts/public/build/target.test_packages.json 03:27:45 INFO - Downloading https://queue.taskcluster.net/v1/task/T-Lx5xutS1q2OwcNrwiKhw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:27:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T-Lx5xutS1q2OwcNrwiKhw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:27:46 INFO - Downloaded 989 bytes. 03:27:46 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:27:46 INFO - Using the following test package requirements: 03:27:46 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:27:46 INFO - u'common': [u'target.common.tests.zip'], 03:27:46 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:27:46 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:27:46 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:27:46 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:27:46 INFO - u'mozbase': [u'target.common.tests.zip'], 03:27:46 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:27:46 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:27:46 INFO - u'web-platform': [u'target.common.tests.zip', 03:27:46 INFO - u'target.web-platform.tests.tar.gz'], 03:27:46 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:27:46 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:27:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T-Lx5xutS1q2OwcNrwiKhw/artifacts/public/build/target.common.tests.zip 03:27:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T-Lx5xutS1q2OwcNrwiKhw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:27:46 INFO - Fetch https://queue.taskcluster.net/v1/task/T-Lx5xutS1q2OwcNrwiKhw/artifacts/public/build/target.common.tests.zip into memory 03:27:47 INFO - Content-Length response header: 73183072 03:27:47 INFO - Bytes received: 73183072 03:27:58 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:27:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T-Lx5xutS1q2OwcNrwiKhw/artifacts/public/build/target.common.tests.zip 03:27:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T-Lx5xutS1q2OwcNrwiKhw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:27:58 INFO - Fetch https://queue.taskcluster.net/v1/task/T-Lx5xutS1q2OwcNrwiKhw/artifacts/public/build/target.common.tests.zip into memory 03:28:00 INFO - Content-Length response header: 73183072 03:28:00 INFO - Bytes received: 73183072 03:28:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T-Lx5xutS1q2OwcNrwiKhw/artifacts/public/build/target.talos.tests.zip 03:28:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T-Lx5xutS1q2OwcNrwiKhw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:28:11 INFO - Fetch https://queue.taskcluster.net/v1/task/T-Lx5xutS1q2OwcNrwiKhw/artifacts/public/build/target.talos.tests.zip into memory 03:28:12 INFO - Content-Length response header: 14496686 03:28:12 INFO - Bytes received: 14496686 03:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:12 INFO - trying https://queue.taskcluster.net/v1/task/T-Lx5xutS1q2OwcNrwiKhw/artifacts/public/build/target.tar.bz2 03:28:12 INFO - Downloading https://queue.taskcluster.net/v1/task/T-Lx5xutS1q2OwcNrwiKhw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:28:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T-Lx5xutS1q2OwcNrwiKhw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:28:14 INFO - Downloaded 63089400 bytes. 03:28:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T-Lx5xutS1q2OwcNrwiKhw/artifacts/public/build/target.tar.bz2 03:28:14 INFO - mkdir: /builds/slave/test/properties 03:28:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:28:14 INFO - Writing to file /builds/slave/test/properties/build_url 03:28:14 INFO - Contents: 03:28:14 INFO - build_url:https://queue.taskcluster.net/v1/task/T-Lx5xutS1q2OwcNrwiKhw/artifacts/public/build/target.tar.bz2 03:28:14 INFO - Running post-action listener: _resource_record_post_action 03:28:14 INFO - Running post-action listener: set_extra_try_arguments 03:28:14 INFO - [mozharness: 2017-07-30 10:28:14.368159Z] Finished download-and-extract step (success) 03:28:14 INFO - [mozharness: 2017-07-30 10:28:14.368256Z] Running populate-webroot step. 03:28:14 INFO - Running pre-action listener: _resource_record_pre_action 03:28:14 INFO - Running main action method: populate_webroot 03:28:14 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:28:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:28:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:28:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:28:14 INFO - 'tests': ['damp', 'tps']}, 03:28:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:28:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:28:14 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:28:14 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:28:14 INFO - 'other-e10s': {'tests': ['a11yr', 03:28:14 INFO - 'ts_paint', 03:28:14 INFO - 'tpaint', 03:28:14 INFO - 'sessionrestore', 03:28:14 INFO - 'sessionrestore_many_windows', 03:28:14 INFO - 'sessionrestore_no_auto_restore', 03:28:14 INFO - 'tabpaint']}, 03:28:14 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:28:14 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:28:14 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:28:14 INFO - 'talos_options': ['--mitmproxy', 03:28:14 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:28:14 INFO - '--firstNonBlankPaint'], 03:28:14 INFO - 'tests': ['quantum_pageload_google', 03:28:14 INFO - 'quantum_pageload_youtube', 03:28:14 INFO - 'quantum_pageload_amazon', 03:28:14 INFO - 'quantum_pageload_facebook']}, 03:28:14 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:28:14 INFO - 'talos_options': ['--stylo', 03:28:14 INFO - '--mitmproxy', 03:28:14 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:28:14 INFO - '--firstNonBlankPaint'], 03:28:14 INFO - 'tests': ['quantum_pageload_google', 03:28:14 INFO - 'quantum_pageload_youtube', 03:28:14 INFO - 'quantum_pageload_amazon', 03:28:14 INFO - 'quantum_pageload_facebook']}, 03:28:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:28:14 INFO - 'tsvgr_opacity', 03:28:14 INFO - 'tart', 03:28:14 INFO - 'tscrollx', 03:28:14 INFO - 'cart', 03:28:14 INFO - 'tsvg_static']}, 03:28:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:28:14 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:28:14 INFO - 'talos_options': ['--stylo', 03:28:14 INFO - '--stylo-threads=1', 03:28:14 INFO - '--mitmproxy', 03:28:14 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:28:14 INFO - '--firstNonBlankPaint'], 03:28:14 INFO - 'tests': ['tp6_google', 03:28:14 INFO - 'tp6_youtube', 03:28:14 INFO - 'tp6_amazon', 03:28:14 INFO - 'tp6_facebook']}, 03:28:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:28:14 INFO - 'talos_options': ['--xperf_path', 03:28:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:14 INFO - 'tests': ['tp5n']}}} 03:28:14 INFO - Running post-action listener: _resource_record_post_action 03:28:14 INFO - [mozharness: 2017-07-30 10:28:14.376837Z] Finished populate-webroot step (success) 03:28:14 INFO - [mozharness: 2017-07-30 10:28:14.376927Z] Running create-virtualenv step. 03:28:14 INFO - Running pre-action listener: _resource_record_pre_action 03:28:14 INFO - Running main action method: create_virtualenv 03:28:14 INFO - Creating virtualenv /builds/slave/test/build/venv 03:28:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:28:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:28:14 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:28:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:28:14 INFO - Using real prefix '/usr' 03:28:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:28:15 INFO - Installing distribute.............................................................................................................................................................................................done. 03:28:16 INFO - Installing pip.................done. 03:28:16 INFO - Return code: 0 03:28:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:28:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:28:17 INFO - Reading from file tmpfile_stdout 03:28:17 INFO - Output received: 03:28:17 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:28:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:28:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:17 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 0x1ba21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f11d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0eeb0>, '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 0x1f0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f10240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1501410051.880594-1781886007', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:28:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:28:17 INFO - Using env: {'DISPLAY': ':0', 03:28:17 INFO - 'HOME': '/home/cltbld', 03:28:17 INFO - 'LANG': 'en_US.UTF-8', 03:28:17 INFO - 'LANGUAGE': 'en_US:en', 03:28:17 INFO - 'LOGNAME': 'cltbld', 03:28:17 INFO - 'MAIL': '/var/mail/cltbld', 03:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:17 INFO - 'MOZ_NO_REMOTE': '1', 03:28:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:17 INFO - 'NO_EM_RESTART': '1', 03:28:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:17 INFO - 'PWD': '/builds/slave/test', 03:28:17 INFO - 'SHELL': '/bin/bash', 03:28:17 INFO - 'SHLVL': '1', 03:28:17 INFO - 'TERM': 'linux', 03:28:17 INFO - 'TMOUT': '86400', 03:28:17 INFO - 'USER': 'cltbld', 03:28:17 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1501410051.880594-1781886007', 03:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:17 INFO - '_': '/tools/buildbot/bin/python'} 03:28:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:28:17 INFO - Cleaning up... 03:28:17 INFO - Return code: 0 03:28:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:28:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:17 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 0x1ba21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f11d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0eeb0>, '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 0x1f0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f10240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1501410051.880594-1781886007', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:28:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:28:17 INFO - Using env: {'DISPLAY': ':0', 03:28:17 INFO - 'HOME': '/home/cltbld', 03:28:17 INFO - 'LANG': 'en_US.UTF-8', 03:28:17 INFO - 'LANGUAGE': 'en_US:en', 03:28:17 INFO - 'LOGNAME': 'cltbld', 03:28:17 INFO - 'MAIL': '/var/mail/cltbld', 03:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:17 INFO - 'MOZ_NO_REMOTE': '1', 03:28:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:17 INFO - 'NO_EM_RESTART': '1', 03:28:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:17 INFO - 'PWD': '/builds/slave/test', 03:28:17 INFO - 'SHELL': '/bin/bash', 03:28:17 INFO - 'SHLVL': '1', 03:28:17 INFO - 'TERM': 'linux', 03:28:17 INFO - 'TMOUT': '86400', 03:28:17 INFO - 'USER': 'cltbld', 03:28:17 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1501410051.880594-1781886007', 03:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:17 INFO - '_': '/tools/buildbot/bin/python'} 03:28:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:17 INFO - Downloading/unpacking psutil>=3.1.1 03:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:28:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:18 INFO - Installing collected packages: psutil 03:28:18 INFO - Running setup.py install for psutil 03:28:18 INFO - building 'psutil._psutil_linux' extension 03:28:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:28:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:28:19 INFO - building 'psutil._psutil_posix' extension 03:28:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:28:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:28:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:19 INFO - Successfully installed psutil 03:28:19 INFO - Cleaning up... 03:28:19 INFO - Return code: 0 03:28:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:28:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f11d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0eeb0>, '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 0x1f0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f10240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1501410051.880594-1781886007', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:28:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:28:19 INFO - Using env: {'DISPLAY': ':0', 03:28:19 INFO - 'HOME': '/home/cltbld', 03:28:19 INFO - 'LANG': 'en_US.UTF-8', 03:28:19 INFO - 'LANGUAGE': 'en_US:en', 03:28:19 INFO - 'LOGNAME': 'cltbld', 03:28:19 INFO - 'MAIL': '/var/mail/cltbld', 03:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:19 INFO - 'MOZ_NO_REMOTE': '1', 03:28:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:19 INFO - 'NO_EM_RESTART': '1', 03:28:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:19 INFO - 'PWD': '/builds/slave/test', 03:28:19 INFO - 'SHELL': '/bin/bash', 03:28:19 INFO - 'SHLVL': '1', 03:28:19 INFO - 'TERM': 'linux', 03:28:19 INFO - 'TMOUT': '86400', 03:28:19 INFO - 'USER': 'cltbld', 03:28:19 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1501410051.880594-1781886007', 03:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:19 INFO - '_': '/tools/buildbot/bin/python'} 03:28:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:28:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:28:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:28:20 INFO - Installing collected packages: mozsystemmonitor 03:28:20 INFO - Running setup.py install for mozsystemmonitor 03:28:20 INFO - Successfully installed mozsystemmonitor 03:28:20 INFO - Cleaning up... 03:28:20 INFO - Return code: 0 03:28:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:28:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ba21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f11d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0eeb0>, '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 0x1f0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f10240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1501410051.880594-1781886007', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:28:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:28:20 INFO - Using env: {'DISPLAY': ':0', 03:28:20 INFO - 'HOME': '/home/cltbld', 03:28:20 INFO - 'LANG': 'en_US.UTF-8', 03:28:20 INFO - 'LANGUAGE': 'en_US:en', 03:28:20 INFO - 'LOGNAME': 'cltbld', 03:28:20 INFO - 'MAIL': '/var/mail/cltbld', 03:28:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:20 INFO - 'MOZ_NO_REMOTE': '1', 03:28:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:20 INFO - 'NO_EM_RESTART': '1', 03:28:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:20 INFO - 'PWD': '/builds/slave/test', 03:28:20 INFO - 'SHELL': '/bin/bash', 03:28:20 INFO - 'SHLVL': '1', 03:28:20 INFO - 'TERM': 'linux', 03:28:20 INFO - 'TMOUT': '86400', 03:28:20 INFO - 'USER': 'cltbld', 03:28:20 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1501410051.880594-1781886007', 03:28:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:20 INFO - '_': '/tools/buildbot/bin/python'} 03:28:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:21 INFO - Downloading/unpacking jsonschema==2.5.1 03:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:28:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:22 INFO - Downloading functools32-3.2.3-2.tar.gz 03:28:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:28:22 INFO - warning: no files found matching '*.txt' 03:28:22 INFO - no previously-included directories found matching 'build' 03:28:22 INFO - no previously-included directories found matching 'dist' 03:28:22 INFO - no previously-included directories found matching '.git*' 03:28:22 INFO - Installing collected packages: jsonschema, functools32 03:28:22 INFO - Running setup.py install for functools32 03:28:22 INFO - warning: no files found matching '*.txt' 03:28:22 INFO - no previously-included directories found matching 'build' 03:28:22 INFO - no previously-included directories found matching 'dist' 03:28:22 INFO - no previously-included directories found matching '.git*' 03:28:22 INFO - Successfully installed jsonschema functools32 03:28:22 INFO - Cleaning up... 03:28:22 INFO - Return code: 0 03:28:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:22 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 0x1ba21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f11d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0eeb0>, '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 0x1f0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f10240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1501410051.880594-1781886007', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:28:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:28:22 INFO - Using env: {'DISPLAY': ':0', 03:28:22 INFO - 'HOME': '/home/cltbld', 03:28:22 INFO - 'LANG': 'en_US.UTF-8', 03:28:22 INFO - 'LANGUAGE': 'en_US:en', 03:28:22 INFO - 'LOGNAME': 'cltbld', 03:28:22 INFO - 'MAIL': '/var/mail/cltbld', 03:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:22 INFO - 'MOZ_NO_REMOTE': '1', 03:28:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:22 INFO - 'NO_EM_RESTART': '1', 03:28:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:22 INFO - 'PWD': '/builds/slave/test', 03:28:22 INFO - 'SHELL': '/bin/bash', 03:28:22 INFO - 'SHLVL': '1', 03:28:22 INFO - 'TERM': 'linux', 03:28:22 INFO - 'TMOUT': '86400', 03:28:22 INFO - 'USER': 'cltbld', 03:28:22 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1501410051.880594-1781886007', 03:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:22 INFO - '_': '/tools/buildbot/bin/python'} 03:28:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:28:22 INFO - Cleaning up... 03:28:22 INFO - Return code: 0 03:28:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:22 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 0x1ba21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f11d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0eeb0>, '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 0x1f0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f10240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1501410051.880594-1781886007', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:28:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:28:22 INFO - Using env: {'DISPLAY': ':0', 03:28:22 INFO - 'HOME': '/home/cltbld', 03:28:22 INFO - 'LANG': 'en_US.UTF-8', 03:28:22 INFO - 'LANGUAGE': 'en_US:en', 03:28:22 INFO - 'LOGNAME': 'cltbld', 03:28:22 INFO - 'MAIL': '/var/mail/cltbld', 03:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:22 INFO - 'MOZ_NO_REMOTE': '1', 03:28:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:22 INFO - 'NO_EM_RESTART': '1', 03:28:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:22 INFO - 'PWD': '/builds/slave/test', 03:28:22 INFO - 'SHELL': '/bin/bash', 03:28:22 INFO - 'SHLVL': '1', 03:28:22 INFO - 'TERM': 'linux', 03:28:22 INFO - 'TMOUT': '86400', 03:28:22 INFO - 'USER': 'cltbld', 03:28:22 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1501410051.880594-1781886007', 03:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:22 INFO - '_': '/tools/buildbot/bin/python'} 03:28:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:23 INFO - Downloading/unpacking blobuploader==1.2.4 03:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:24 INFO - Downloading blobuploader-1.2.4.tar.gz 03:28:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:28:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:28:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:24 INFO - Downloading docopt-0.6.1.tar.gz 03:28:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:28:24 INFO - Installing collected packages: blobuploader, requests, docopt 03:28:24 INFO - Running setup.py install for blobuploader 03:28:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:28:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:28:24 INFO - Running setup.py install for requests 03:28:25 INFO - Running setup.py install for docopt 03:28:25 INFO - Successfully installed blobuploader requests docopt 03:28:25 INFO - Cleaning up... 03:28:25 INFO - Return code: 0 03:28:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:25 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 0x1ba21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f11d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0eeb0>, '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 0x1f0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f10240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1501410051.880594-1781886007', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:28:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:28:25 INFO - Using env: {'DISPLAY': ':0', 03:28:25 INFO - 'HOME': '/home/cltbld', 03:28:25 INFO - 'LANG': 'en_US.UTF-8', 03:28:25 INFO - 'LANGUAGE': 'en_US:en', 03:28:25 INFO - 'LOGNAME': 'cltbld', 03:28:25 INFO - 'MAIL': '/var/mail/cltbld', 03:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:25 INFO - 'MOZ_NO_REMOTE': '1', 03:28:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:25 INFO - 'NO_EM_RESTART': '1', 03:28:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:25 INFO - 'PWD': '/builds/slave/test', 03:28:25 INFO - 'SHELL': '/bin/bash', 03:28:25 INFO - 'SHLVL': '1', 03:28:25 INFO - 'TERM': 'linux', 03:28:25 INFO - 'TMOUT': '86400', 03:28:25 INFO - 'USER': 'cltbld', 03:28:25 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1501410051.880594-1781886007', 03:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:25 INFO - '_': '/tools/buildbot/bin/python'} 03:28:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:25 INFO - Running setup.py (path:/tmp/pip-K5iNrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:25 INFO - Running setup.py (path:/tmp/pip-R2RlAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:25 INFO - Running setup.py (path:/tmp/pip-ksIXKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:25 INFO - Running setup.py (path:/tmp/pip-9Uf_X6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:25 INFO - Running setup.py (path:/tmp/pip-ohdsdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:25 INFO - Running setup.py (path:/tmp/pip-vBMfym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:26 INFO - Running setup.py (path:/tmp/pip-_YaFB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:26 INFO - Running setup.py (path:/tmp/pip-vb0hyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:26 INFO - Running setup.py (path:/tmp/pip-qiMTKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:26 INFO - Running setup.py (path:/tmp/pip-f0oWgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:26 INFO - Running setup.py (path:/tmp/pip-l3J1sf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:26 INFO - Running setup.py (path:/tmp/pip-d52vCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:26 INFO - Running setup.py (path:/tmp/pip-9rUb6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:26 INFO - Running setup.py (path:/tmp/pip-J0BEFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:26 INFO - Running setup.py (path:/tmp/pip-6Ly0ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:26 INFO - Running setup.py (path:/tmp/pip-QfleQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:26 INFO - Running setup.py (path:/tmp/pip-81ZLI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:28:26 INFO - Running setup.py install for manifestparser 03:28:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:28:26 INFO - Running setup.py install for mozcrash 03:28:27 INFO - Running setup.py install for mozdebug 03:28:27 INFO - Running setup.py install for mozdevice 03:28:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:28:27 INFO - Running setup.py install for mozfile 03:28:27 INFO - Running setup.py install for mozhttpd 03:28:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:28:27 INFO - Running setup.py install for mozinfo 03:28:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:28:27 INFO - Running setup.py install for mozInstall 03:28:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:28:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:28:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:28:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:28:27 INFO - Running setup.py install for mozleak 03:28:27 INFO - Running setup.py install for mozlog 03:28:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:28:27 INFO - Running setup.py install for moznetwork 03:28:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:28:27 INFO - Running setup.py install for mozprocess 03:28:28 INFO - Running setup.py install for mozprofile 03:28:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:28:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:28:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:28:28 INFO - Running setup.py install for mozrunner 03:28:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:28:28 INFO - Running setup.py install for mozscreenshot 03:28:28 INFO - Running setup.py install for moztest 03:28:28 INFO - Running setup.py install for mozversion 03:28:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:28:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:28:28 INFO - Cleaning up... 03:28:28 INFO - Return code: 0 03:28:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:28 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 0x1ba21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f11d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0eeb0>, '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 0x1f0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f10240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1501410051.880594-1781886007', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:28:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:28:28 INFO - Using env: {'DISPLAY': ':0', 03:28:28 INFO - 'HOME': '/home/cltbld', 03:28:28 INFO - 'LANG': 'en_US.UTF-8', 03:28:28 INFO - 'LANGUAGE': 'en_US:en', 03:28:28 INFO - 'LOGNAME': 'cltbld', 03:28:28 INFO - 'MAIL': '/var/mail/cltbld', 03:28:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:28 INFO - 'MOZ_NO_REMOTE': '1', 03:28:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:28 INFO - 'NO_EM_RESTART': '1', 03:28:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:28 INFO - 'PWD': '/builds/slave/test', 03:28:28 INFO - 'SHELL': '/bin/bash', 03:28:28 INFO - 'SHLVL': '1', 03:28:28 INFO - 'TERM': 'linux', 03:28:28 INFO - 'TMOUT': '86400', 03:28:28 INFO - 'USER': 'cltbld', 03:28:28 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1501410051.880594-1781886007', 03:28:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:28 INFO - '_': '/tools/buildbot/bin/python'} 03:28:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:28 INFO - Running setup.py (path:/tmp/pip-8rD7uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:28 INFO - Running setup.py (path:/tmp/pip-rf4gfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:29 INFO - Running setup.py (path:/tmp/pip-Q89qH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:29 INFO - Running setup.py (path:/tmp/pip-z6kZtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:29 INFO - Running setup.py (path:/tmp/pip-yXYjcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:29 INFO - Running setup.py (path:/tmp/pip-ZK6rLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:29 INFO - Running setup.py (path:/tmp/pip-pxR1rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:29 INFO - Running setup.py (path:/tmp/pip-KEXJQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:29 INFO - Running setup.py (path:/tmp/pip-IeU2op-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:29 INFO - Running setup.py (path:/tmp/pip-9H6hIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:29 INFO - Running setup.py (path:/tmp/pip-MHghsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:29 INFO - Running setup.py (path:/tmp/pip-Q8dUU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:29 INFO - Running setup.py (path:/tmp/pip-Km1DcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:29 INFO - Running setup.py (path:/tmp/pip-D6xsYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:29 INFO - Running setup.py (path:/tmp/pip-u4SM4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:29 INFO - Running setup.py (path:/tmp/pip-PileaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:30 INFO - Running setup.py (path:/tmp/pip-XvLReS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:28:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:31 INFO - Downloading blessings-1.6.tar.gz 03:28:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:28:31 INFO - Installing collected packages: blessings 03:28:31 INFO - Running setup.py install for blessings 03:28:31 INFO - Successfully installed blessings 03:28:31 INFO - Cleaning up... 03:28:31 INFO - Return code: 0 03:28:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:28:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:31 INFO - Reading from file tmpfile_stdout 03:28:31 INFO - Current package versions: 03:28:31 INFO - argparse == 1.2.1 03:28:31 INFO - blessings == 1.6 03:28:31 INFO - blobuploader == 1.2.4 03:28:31 INFO - docopt == 0.6.1 03:28:31 INFO - functools32 == 3.2.3-2 03:28:31 INFO - jsonschema == 2.5.1 03:28:31 INFO - manifestparser == 1.1 03:28:31 INFO - mozInstall == 1.13 03:28:31 INFO - mozcrash == 1.0 03:28:31 INFO - mozdebug == 0.1 03:28:31 INFO - mozdevice == 0.51 03:28:31 INFO - mozfile == 1.2 03:28:31 INFO - mozhttpd == 0.7 03:28:31 INFO - mozinfo == 0.10 03:28:31 INFO - mozleak == 0.1 03:28:31 INFO - mozlog == 3.5 03:28:31 INFO - moznetwork == 0.27 03:28:31 INFO - mozprocess == 0.25 03:28:31 INFO - mozprofile == 0.28 03:28:31 INFO - mozrunner == 6.13 03:28:31 INFO - mozscreenshot == 0.1 03:28:31 INFO - mozsystemmonitor == 0.3 03:28:31 INFO - moztest == 0.8 03:28:31 INFO - mozversion == 1.4 03:28:31 INFO - psutil == 3.1.1 03:28:31 INFO - requests == 1.2.3 03:28:31 INFO - wsgiref == 0.1.2 03:28:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:31 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 0x1ba21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f11d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0eeb0>, '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 0x1f0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f10240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1501410051.880594-1781886007', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:28:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:28:31 INFO - Using env: {'DISPLAY': ':0', 03:28:31 INFO - 'HOME': '/home/cltbld', 03:28:31 INFO - 'LANG': 'en_US.UTF-8', 03:28:31 INFO - 'LANGUAGE': 'en_US:en', 03:28:31 INFO - 'LOGNAME': 'cltbld', 03:28:31 INFO - 'MAIL': '/var/mail/cltbld', 03:28:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:31 INFO - 'MOZ_NO_REMOTE': '1', 03:28:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:31 INFO - 'NO_EM_RESTART': '1', 03:28:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:31 INFO - 'PWD': '/builds/slave/test', 03:28:31 INFO - 'SHELL': '/bin/bash', 03:28:31 INFO - 'SHLVL': '1', 03:28:31 INFO - 'TERM': 'linux', 03:28:31 INFO - 'TMOUT': '86400', 03:28:31 INFO - 'USER': 'cltbld', 03:28:31 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1501410051.880594-1781886007', 03:28:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:31 INFO - '_': '/tools/buildbot/bin/python'} 03:28:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:28:31 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:32 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:28:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:28:33 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 03:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:28:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:28:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:28:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:28:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:28:33 INFO - Installing collected packages: marionette-driver, simplejson 03:28:33 INFO - Running setup.py install for marionette-driver 03:28:33 INFO - Running setup.py install for simplejson 03:28:33 INFO - building 'simplejson._speedups' extension 03:28:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:28:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:28:34 INFO - Successfully installed marionette-driver simplejson 03:28:34 INFO - Cleaning up... 03:28:34 INFO - Return code: 0 03:28:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:28:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:34 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 0x1ba21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f11d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0eeb0>, '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 0x1f0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f10240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1501410051.880594-1781886007', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:28:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:28:34 INFO - Using env: {'DISPLAY': ':0', 03:28:34 INFO - 'HOME': '/home/cltbld', 03:28:34 INFO - 'LANG': 'en_US.UTF-8', 03:28:34 INFO - 'LANGUAGE': 'en_US:en', 03:28:34 INFO - 'LOGNAME': 'cltbld', 03:28:34 INFO - 'MAIL': '/var/mail/cltbld', 03:28:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:34 INFO - 'MOZ_NO_REMOTE': '1', 03:28:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:34 INFO - 'NO_EM_RESTART': '1', 03:28:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:34 INFO - 'PWD': '/builds/slave/test', 03:28:34 INFO - 'SHELL': '/bin/bash', 03:28:34 INFO - 'SHLVL': '1', 03:28:34 INFO - 'TERM': 'linux', 03:28:34 INFO - 'TMOUT': '86400', 03:28:34 INFO - 'USER': 'cltbld', 03:28:34 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1501410051.880594-1781886007', 03:28:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:34 INFO - '_': '/tools/buildbot/bin/python'} 03:28:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:28:34 INFO - Cleaning up... 03:28:34 INFO - Return code: 0 03:28:34 INFO - Running post-action listener: _resource_record_post_action 03:28:34 INFO - Running post-action listener: _start_resource_monitoring 03:28:34 INFO - Starting resource monitoring. 03:28:34 INFO - [mozharness: 2017-07-30 10:28:34.666191Z] Finished create-virtualenv step (success) 03:28:34 INFO - [mozharness: 2017-07-30 10:28:34.666698Z] Running install step. 03:28:34 INFO - Running pre-action listener: _resource_record_pre_action 03:28:34 INFO - Running main action method: install 03:28:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:34 INFO - Reading from file tmpfile_stdout 03:28:34 INFO - Detecting whether we're running mozinstall >=1.0... 03:28:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:28:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:28:35 INFO - Reading from file tmpfile_stdout 03:28:35 INFO - Output received: 03:28:35 INFO - Usage: mozinstall [options] installer 03:28:35 INFO - Options: 03:28:35 INFO - -h, --help show this help message and exit 03:28:35 INFO - -d DEST, --destination=DEST 03:28:35 INFO - Directory to install application into. [default: 03:28:35 INFO - "/builds/slave/test"] 03:28:35 INFO - --app=APP Application being installed. [default: firefox] 03:28:35 INFO - mkdir: /builds/slave/test/build/application 03:28:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:28:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:28:53 INFO - Reading from file tmpfile_stdout 03:28:53 INFO - Output received: 03:28:53 INFO - /builds/slave/test/build/application/firefox/firefox 03:28:53 INFO - Running post-action listener: _resource_record_post_action 03:28:53 INFO - [mozharness: 2017-07-30 10:28:53.311030Z] Finished install step (success) 03:28:53 INFO - [mozharness: 2017-07-30 10:28:53.311285Z] Running setup-mitmproxy step. 03:28:53 INFO - Running pre-action listener: _resource_record_pre_action 03:28:53 INFO - Running main action method: setup_mitmproxy 03:28:53 INFO - Skipping: mitmproxy is not required 03:28:53 INFO - Running post-action listener: _resource_record_post_action 03:28:53 INFO - [mozharness: 2017-07-30 10:28:53.312427Z] Finished setup-mitmproxy step (success) 03:28:53 INFO - [mozharness: 2017-07-30 10:28:53.312647Z] Running run-tests step. 03:28:53 INFO - Running pre-action listener: _resource_record_pre_action 03:28:53 INFO - Running pre-action listener: _set_gcov_prefix 03:28:53 INFO - Running main action method: run_tests 03:28:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:28:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:28:53 INFO - Python 2.7.3 03:28:53 INFO - Return code: 0 03:28:53 INFO - grabbing minidump binary from tooltool 03:28: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')]} 03:28:53 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0x1f0eeb0>, '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 0x1f0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f10240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:28:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:28:53 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:28:53 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:28:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:28:53 INFO - Return code: 0 03:28:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:28:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:28:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:28:53 INFO - ENV: RUST_BACKTRACE is now 1 03:28:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:28:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:28:53 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/T-Lx5xutS1q2OwcNrwiKhw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:28:53 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/T-Lx5xutS1q2OwcNrwiKhw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:28:53 INFO - Using env: {'DISPLAY': ':0', 03:28:53 INFO - 'HOME': '/home/cltbld', 03:28:53 INFO - 'LANG': 'en_US.UTF-8', 03:28:53 INFO - 'LANGUAGE': 'en_US:en', 03:28:53 INFO - 'LOGNAME': 'cltbld', 03:28:53 INFO - 'MAIL': '/var/mail/cltbld', 03:28:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:28:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:28:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:53 INFO - 'MOZ_NO_REMOTE': '1', 03:28:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:28:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:53 INFO - 'NO_EM_RESTART': '1', 03:28:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:53 INFO - 'PWD': '/builds/slave/test', 03:28:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:28:53 INFO - 'RUST_BACKTRACE': '1', 03:28:53 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:28:53 INFO - 'SHELL': '/bin/bash', 03:28:53 INFO - 'SHLVL': '1', 03:28:53 INFO - 'TERM': 'linux', 03:28:53 INFO - 'TMOUT': '86400', 03:28:53 INFO - 'USER': 'cltbld', 03:28:53 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1501410051.880594-1781886007', 03:28:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:53 INFO - '_': '/tools/buildbot/bin/python'} 03:28:53 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/T-Lx5xutS1q2OwcNrwiKhw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:28:53 INFO - mozversion application_buildid: 20170730091350 03:28:53 INFO - mozversion application_changeset: 6ee53b46474f74c231b1b569e8f2ecd9d0948a8f 03:28:53 INFO - mozversion application_display_name: Nightly 03:28:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:28:53 INFO - mozversion application_name: Firefox 03:28:53 INFO - mozversion application_remotingname: firefox 03:28:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:28:53 INFO - mozversion application_vendor: Mozilla 03:28:53 INFO - mozversion application_version: 56.0a1 03:28:53 INFO - mozversion platform_buildid: 20170730091350 03:28:53 INFO - mozversion platform_changeset: 6ee53b46474f74c231b1b569e8f2ecd9d0948a8f 03:28:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:28:53 INFO - mozversion platform_version: 56.0a1 03:28:53 INFO - using testdate: 1501410533 03:28:53 INFO - actual date: 1501410533 03:28:53 INFO - starting webserver on 'localhost:56373' 03:28:53 INFO - SUITE-START | Running 2 tests 03:28:53 INFO - TEST-START | dromaeo_css 03:28:53 INFO - Initialising browser for dromaeo_css test... 03:28:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56373/getInfo.html -profile /tmp/tmpidmYpu/profile 03:28:53 INFO - TEST-INFO | started process 22266 (/builds/slave/test/build/application/firefox/firefox http://localhost:56373/getInfo.html) 03:28:59 INFO - TEST-INFO | 22266: exit 0 03:28:59 INFO - Browser initialized. 03:28:59 INFO - Running cycle 1/1 for dromaeo_css test... 03:28:59 INFO - TEST-INFO | started process 22473 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpidmYpu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:00 INFO - PID 22473 | 03:29:00 INFO - PID 22473 | (/builds/slave/test/build/application/firefox/firefox:22522): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:29:00 INFO - PID 22473 | 03:29:10 INFO - PID 22473 | RSS: Main: 164818944 03:29:10 INFO - PID 22473 | 03:32:09 INFO - PID 22473 | Cycle 1(1): loaded http://localhost:56373/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56373/tests/dromaeo/cssquery-ext.html) 03:32:10 INFO - PID 22473 | RSS: Main: 167190528 03:32:10 INFO - PID 22473 | 03:35:11 INFO - PID 22473 | Cycle 1(1): loaded http://localhost:56373/tests/dromaeo/cssquery-ext.html (next: http://localhost:56373/tests/dromaeo/cssquery-jquery.html) 03:35:12 INFO - PID 22473 | RSS: Main: 164405248 03:35:12 INFO - PID 22473 | 03:38:13 INFO - PID 22473 | Cycle 1(1): loaded http://localhost:56373/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56373/tests/dromaeo/cssquery-mootools.html) 03:38:14 INFO - PID 22473 | RSS: Main: 166322176 03:38:14 INFO - PID 22473 | 03:41:16 INFO - PID 22473 | Cycle 1(1): loaded http://localhost:56373/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56373/tests/dromaeo/cssquery-prototype.html) 03:41:16 INFO - PID 22473 | RSS: Main: 164646912 03:41:16 INFO - PID 22473 | 03:44:20 INFO - PID 22473 | Cycle 1(1): loaded http://localhost:56373/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56373/tests/dromaeo/cssquery-yui.html) 03:44:21 INFO - PID 22473 | RSS: Main: 165961728 03:44:21 INFO - PID 22473 | 03:47:22 INFO - PID 22473 | Cycle 1(1): loaded http://localhost:56373/tests/dromaeo/cssquery-yui.html (next: http://localhost:56373/tests/dromaeo/cssquery-dojo.html) 03:47:22 INFO - PID 22473 | RSS: Main: 168878080 03:47:22 INFO - PID 22473 | 03:47:22 INFO - PID 22473 | __start_tp_report 03:47:22 INFO - PID 22473 | _x_x_mozilla_page_load 03:47:22 INFO - PID 22473 | _x_x_mozilla_page_load_details 03:47:22 INFO - PID 22473 | |i|pagename|runs| 03:47:22 INFO - PID 22473 | |0;dojo.html;3355.76509644325;3381.526586277921;3382.4926261060837;3413.7098346640532;3441.518187453757;6230.345813689565;6235.095911092894;6237;6252.624842509441;6298.338674439186;6095.420935011178;6163.044728067145;6188.040853667689;6228.377162283769;6305.842353941154;5372.650777699437;5436.619436639437;5464.26232458619;5471.398146203915;5541.168824676311;5350.0904846176045;5352.277442545265;5403.918941215885;5458.6724796512335;5517.172424136372;5335.573154147678;5350.9732451337495;5406.567474602042;5412.891742165154;5471.616986810925;5399.487048730364;5455.945440545584;5469.097598896177;5482.698451585161;5483.945160548423;5350.5987050971335;5377.489138531833;5423.915216956624;5426.972865135688;5439;6023.849403764897;6039.335673075958;6094.299155597118;6136.693165341715;6175.505959523227;6703.229128650219;6716.395524402778;6722.697478613474;6726.327367263235;6747.493937954624;6799.184097908283;6800;6807.047013418125;6824.21521525021;6824.624645644488;6138.0792881067755;6194;6214.9689251553455;6305.833420817117;6314.368563143695;6708.932910670928;6840.110785597841;6914.274001229798;6917.308269173143;6922.723091076301;6463.256725476536;6557.114789503451;6557.737690492422;6562.442192413603;6570.047343135314;6641.568298060611;6651.800445986628;6656.900146497806;6658.667066646745;6685.298043705438;6609;6624.8343791405605;6650.035744816974;6657.46740260778;6661.367170118928;6629.966850165718;6656.567323123982;6674.766383176662;6685.699143538553;6706.329367063255;4890.997345544226;4894.681845680019;4895.412550493964;4900.681455705368;4903.901921961612;4314.827406903752;4342.761148136819;4378.1900348435;4394.12117576486;4394.890127746832;6293.3391993840905;6374.266959299647;6382.36176382358;6462.612243265419;6481.48148148147;6677.666116694146;6678.332166783282;6682.665866706645;6689.063531105649;6690.02994565795;6060.484858787053;6411.935880641134;6463.935360646334;6464.806055818333;6472.093906853044;5443.237946687467;5488.121900495901;5489.313835770528;5489.835304940858;5561.249231353715;7022.859542809218;7038.120234970629;7051.330123638246;7060.576365418091;7073.257307982588;6516.087747715418;6655.101561289164;6665.600063996176;6670.499712521483;6768.627725475146;7139.2503787101605;7144.142702875688;7166;7176.210616832249;7179.066721326194;6479.611223326616;6619.933800661932;6645.003249512612;6719.630420326734;6721.361470660279;6689.46484281266;6689.698963546554;6690.464762818866;6694.531382803157;6727.529072965041;6502.252240992347;6504.252011018793;6506.186726659168;6507.12153859223;6550.050242714684;5980.192673988956;6452.580582262138;6470.611763294218;6484.416402523795;6517.446017088411;6478.935210647834;6492.350764923659;6502.447291980235;6575.901361479486;6592.571482853599;6471.126397936218;6518.608883467007;6603.7688680895935;6607.768728094494;6654.301298363602;6303.180586523723;6320.557560970872;6327.430531252209;6403.103565500741;6406.839829004312 03:47:22 INFO - PID 22473 | |1;ext.html;871.4825703485927;901.8839908117454;915.1351972386094;927.420362273579;938.4979036215626;40452.19095618086;42713;44317.33523997143;44407.3338899916;44617.55382446175;43660.78169609155;44054.33918491225;44069.77965110178;44125.55874441255;44138;7426.331630153285;7476.85046299075;7598.278163574451;7604.809879752995;7605.619719014055;7231.276872312779;7286.672099755498;7304.853902921938;7305.159906610728;7309.853802923938;7287.380572651331;7333.120025596936;7333.156686980986;7333.303336183054;7372.963135184316;7263.201047884729;7307.086614173229;7307.269273072703;7316.670749816244;7367.8894816577795;7281.9271807281775;7287.7449289275155;7289.599072051035;7311.853762924765;7369.373603243677;38828.22343553113;38874.61125388738;39241;39243.60756392428;39253;3442.294329662413;3458.2737625098507;3464.3764122457947;3477.0264325988765;3484.407650699387;30618.693813061807;30707.385852283052;30740;30776.230594235098;30783.076507704805;4893.535114164149;4941.234108713155;4943.209086546171;4956.727379994099;5003.124453220672;199865;200171;200513;200970;201294;50198.49801501938;50379.49620503822;50380.244296335586;50386.24420633693;50610.49389506058;53378;53411.732941335045;53456.19815702768;53523;53584.46415535873;15603.297851596706;15902.204889755465;15933.840661593467;16024.919875400781;16032;11346.829797553044;11532.596359127558;12600;12785.936070319589;12800.35998200105;14891.553253402415;14918.776218356734;14983.550493485212;15058.849411505964;15063.849361506464;5792.536597072224;5920.911186332209;5948.762049517971;6016.097585362143;6121.071862363341;1030.9329893556894;1055.836345366454;1076.3004047369272;1078.3260462211117;1090.051655060087;23530.7646923532;24082.51834963326;24114.638280425806;24448.633270500955;24631.261062168163;1155.96532104037;1186.9465874035689;1190.6309044196328;1191.70803153228;1199.7840388730112;12725.745485090247;13116.409761560753;13153.408096635674;13209;13219;264934;265574;265980;266166;266352;50538.747306263234;53128.73435632797;53838;54193;54556.90886182254;1473.8599833015846;1508.064999700171;1510.6223444139184;1523.7866698662197;1533.9156346401055;28336.57495137616;28489.857550712113;28723.951955134067;29099.563506547842;29563;36035;36075;36159.819200903825;36222;36225.818870905474;228891;231019;231580;231616;231765;33358.99923002314;34767.4784878222;36637.45043824398;36765.08087297732;36890.8155459221;47572.52427475681;48370.03259934852;48474;48492.272615910086;48536.5146348532;33376.33247334991;34200.14499637529;34321.31357372888;34351.31297374088;34765.13087172841;33087.50368744422;34477.310453790284;34487.65512344945;34529.30941381209;34734.65265347415;38827.41758873676;40534.39198412085;41518.58481415268;41538.37692434555;41590.58409415867;32760;34237.48643770296;34341.31317373688;34556;34833.825830870686;25809.354766130997;26528.602070968565;26867.626474704746;27623.171304860887;27831.30421739473 03:47:22 INFO - PID 22473 | |2;jquery.html;569.7265312649928;570.3754388944106;573.131705466219;575.3527281807966;577.4831525784422;22350;23207.999999999978;23249.767502324972;23299.650505242436;24395.512089758195;25890;26682;26697.332566685844;26715.86642066787;26746.598801018;6302.4642905352985;6454.3545645435315;6455.160829092211;6457.773977910774;6471.676416179196;5988.431099045605;6230.7819226326865;6233.376662333776;6233.625982441045;6244.687765611724;6183.165272688197;6185.628862268279;6186.81439556814;6198.566100372976;6198.78304259351;6116.938830611703;6163.383661633868;6167.321594624587;6193.721282542274;6196.132541444202;5650.830475085754;5720.8855822883725;5728.656280623176;5744.253247077895;5769.711514424262;29862.402751945057;30384.54423183654;30776.846115769276;31081.222969425944;31157;2178.5425060737266;2214.169686367612;2218.8446808723397;2221.8222542196745;2222.155580879272;19310;19744.70382944257;19875.60248795016;19913.10391032407;19921;2347.6009078456705;2359.6814430051895;2401.267613377919;2412.975870241293;2472.863992480413;141320.29339853337;143798.2810085943;145059.2747036258;152923;156828.21585892112;14584.708305834036;15386.230688465756;15514.224288785515;15847.128407937444;16106.355745770037;23662.763372366055;24771.628425573632;24805.255842324757;24806.751932480445;24949.750502495106;10415.479226038668;10531.368117912949;10626.46867656614;10801.67594972152;10804.891951080388;9726.70819875405;9732.562034708455;9747.220222382193;9777.266704997011;9881.357711748713;9515.809683806285;9834.950825245827;9888.406695598287;10086.848697269546;10120.937301583375;2815.4509870575043;2897.5074237379695;2942.749866261349;2958.9408211835644;3011.7891747577896;1041.265907535186;1050.3960222871879;1050.5377633841238;1071.137734124022;1073.3720773347522;20264.290749823685;20765.896170519052;21031.789682102983;22055.11779528833;22067;1115.319655010443;1119.1270808769173;1119.7480566872389;1123.5505797680994;1135.1146106037304;11620.302781833117;12038.578649747216;12162.331071790959;12176.025917926545;12192.14654974161;546250;575528;589840;594391;600305;136303;137850;138520;139445;139916.30041849727;1305.895528357729;1323.4110820684703;1344.8924086073287;1356.5794603672894;1359.5853264754344;21663.783362166178;22149.889250553642;22366.217182398537;22633.660495092918;22789.772102278766;64096.35903640904;65654.34345656482;67698.32301676921;67703.32296677167;69946;87041;90775.54612227161;90797;91032.08967910236;91883.08116918746;14159.43362265539;14889.255537223313;14926.179060151795;14979.176145312113;15024.023438476901;23986.160484382963;24073;24281.51436971286;24522.50954980926;24938.251852444457;19586;19676.90161549183;19819.405417837486;19983;20013.59972800565;16539.83460165431;17116.743248851028;17169.055701936515;17497.21262543214;17701.46895593134;19837.801621984174;20121.899390502953;20275;20292.492687682334;20422.795772042682;14540.563783086523;14630.195339256443;14650.19423931694;14787.556373308818;14802.77795833085;19492.61014779668;19752.802471975097;19886.50283742918;19941.501462463555;20001.299954502105 03:47:22 INFO - PID 22473 | |3;mootools.html;1405.775075987842;1459.2557795524278;1463.378064322664;1496.7530357491007;1505.2172870107545;14901.478448254313;15652.452164174241;15683.45107921223;15700.450484233053;15719.449819256328;15819.525414237563;16074.919625401886;16081.83918160818;16093.275802588882;16101.597460063504;2699.2307192450157;2741.821781584191;2742.1773467959633;2742.561190209567;2749.5463248563965;2607.0223666125203;2612.5428050091255;2669.959950600733;2690.461907618484;2723.2783312422225;2729.426820367725;2762.2541913683294;2762.2818067302546;2764.25365151409;2765.267204190881;2704.3509557706207;2712.864356782153;2720.9591856122174;2724.332538528063;2727.318170457386;2567.127176759892;2601.40167761414;2603.622474741152;2614.072004438435;2614.3986883016823;14901;15296.388144474207;15321.46374876874;15334;15363.615909602238;8018.719344822904;8250.752477425627;8283.420160588761;8283.917160828374;8315.95842020792;5236.554892834114;5312.73436328182;5365.436629153961;5465.863353416156;5512.641678290938;1769.5310742653207;1827.8994655293955;1830.3136323878546;1840.8527317814676;1879.6898511745546;26060.218193454228;26381.20856374312;26504.337391565172;26525.999999999807;26559.203223903314;6844.623545705034;6911.965440172767;6931.965340173267;7016.614086225307;7060.470464715167;18009.7298540522;18065.909670451565;18085.36701215451;18091.457256282334;18101;8110.513369197867;8210.876836847452;8211.753647390588;8222.17778222173;8226.835463290701;7447.88828167578;7562.697492100365;7567.772966811004;7652.120006199359;7659.234076592296;5265.894682106336;5350.411454739976;5425.131978883439;5439.129739241703;5456.645318054314;1537.7847101405812;1554.0675594643124;1555.199072477675;1574.7086788944082;1594;863.7063398444434;867.9218870301703;876.4346996187423;893.7006102955582;909.3225546967419;7092.787216383516;7306.050213472215;7347.118345798538;7406.555606663617;7453.590052547053;730.7442395161651;732.5201992694793;736.1093077376328;743.1824992508198;748.195689633646;4225.514065882463;4278.764667943231;4489.9551004490195;4945.9258111128365;5072.416672082684;21183.68224476634;21287.68068478943;22027.449313767283;22279.108835646715;22296;21346.252881149085;21653.566928661337;21655.242066527597;21909.452263693216;21922;10200.897991020143;11862;11969.820452693217;11987.700307492209;12056;8138.593070346341;8323.875141872997;8411;8532.872006919777;8582.442141260799;18239.270429183216;18628.81371186271;18896;19074.80925190786;19361.32235371755;18506;19217.90391048036;19533.12100955432;19766.308179213658;20087;12132.211406258917;12775.936120319338;12781;12786.424610892718;12786.872131278567;14287.785683214968;14359.138451692932;14364.209968451836;14418.567442976728;14437.494687685881;11160.55357785712;11255.7748845021;11300;11321.377324247245;11665.183437159318;10922.945385273022;11123;11248.325100493996;11545.884541154817;11640.825387619361;8984.05667404913;9023.4134781239;9029.82612260402;9090.272778177863;9100.635974561208;6674.532782705164;6889.552179108342;6899.413549848319;7096.7516136934955;7103.360697537247;6424.38968298011;6957.478189135936;7025.367716905503;7102.786916392516;7159.105111861018 03:47:22 INFO - PID 22473 | |4;prototype.html;499.43064906007135;501.26314317952597;526.3499578021145;526.7497938479221;527.4988760677356;5975.551833612475;6091.14723938649;6099.115628233909;6106.381808820655;6116.6941652917285;5819.534437245021;5937.40625937406;5975.432333928281;6006.969965150168;6025.578209525335;4678.111158879819;4700.835470758524;4705.388299521074;4723.83466578669;4730.716157030572;4563.8630841074655;4638.165130276549;4709.317149013391;4723.394046024351;4742.620590352781;4653.557911998355;4662.438083242118;4691.671582989192;4692.7653617319165;4732.266498692691;4645.349651048822;4664.183767840631;4670.439547254317;4673.83641572545;4678.274867395559;4198.580141985807;4216.599423054805;4235.703500754948;4253.787310634456;4258.190943720683;5876.706164691791;5962.672053037081;5965.55258355625;5980.581359304851;5993.190919225893;5622.522085622727;5639.238702775114;5677.886442271173;5686.260786097822;5702.7433765480655;6403.199600049994;6411.198600174978;6430.517711171681;6531.346865313478;6535.15043044406;4818.277258411266;4841.661083724141;4844.66087373884;4858.125537403266;4886.951130488721;6659.734650416405;6717.496187785887;6745.258021617618;6778.254392016875;6796.116504854387;4885.193942999436;4955.727434991038;4976.353074100344;4992.8002879885125;5022.924656130161;5031.77357018935;5053.84838454847;5054.9241761373605;5057.6459647824295;5064.366954130734;5632.605717599728;5642.4075472075665;5702.144678298206;5703.971480142655;5706.457886500776;6457.806265812033;6482.967585162044;6492.35076492347;6499.068063821414;6539.346065393423;1664.1512828457332;1703.65075159592;1721.1652348610914;1737.6350966296966;1759.7857478339904;1240.1009268280604;1251.2429979862234;1255.1653150654713;1256.2588073036952;1258.5783762439503;6206.627602343874;6232.719527621268;6243.96878015607;6258;6277.5605707600025;6346.365363463709;6585.73657053722;6604.339566043357;6621.404073633396;6659.866802664016;6099.817005489843;6129.509639228851;6143.477804386677;6248.50011999039;6311.274203466568;3432.9313413731584;3466.809325487072;3487.843047062888;3519.6480351964597;3539.982300088483;6917.204521479994;6939.271376505495;6943.89584156238;6956.339147780953;6998.965005174941;6763.560368576027;6786.5928044316515;6794.830129246809;6799.388055075067;6809.897851532231;6941.091199919861;6945.791626251221;6983.254186453387;7011.649417529103;7093.184283807325;6578.572392794453;6613.611141660305;6623.635700036351;6668.166479190101;6695.899561506484;6457.257415397289;6511.609303441809;6571.408573228432;6600.141981542369;6622.569532980341;6910.447164226749;6964.547304425196;7039.507234493536;7065.646717664199;7069.399101076466;4910.042541704333;4928.310036594951;4974.303597496281;4981.950180498148;4985.825496107619;6619.933800661932;6644.867102658017;6680.265170831108;6706.497012724163;6712;6350.841228969312;6413.903791443039;6481.189851268591;6493.545451818327;6512.3162067982175;6321.810345689637;6351.714172862325;6364.9632117721885;6382.585131966407;6421.036844473367;6082.969585152223;6387.393197646216;6389.840253993501;6421.486281097595;6480.351964803671;6104.847378815388;6355.523335749745;6500.602370490367;6508.479321654351;6513.772017979348;6245.250569931637;6248.937510624835;6252.468540174136;6255.437010669061;6258.311585725475 03:47:22 INFO - PID 22473 | |5;yui.html;929.5212965322864;942.359195746892;945.1635302757062;949.0604301741279;966.8984756600556;18537.721934170982;19467.513312167186;19484.220631174754;19490.610187796236;21316.253931112413;21057.684134737992;21518.354449366503;21679;21811.67282490764;21842.563148737016;1037.1754455208109;1066.7066556696893;1070.1492313610659;1070.998616293764;1071.7534966957605;1089.0362029603778;1089.667651366337;1089.7112265249716;1090.0407641275706;1092.9398883061428;1078.4338222433207;1125.712943199487;1128.0468004536153;1130.7512347283625;1131.3664347965166;1107.0092267420653;1109.2512554026082;1110.9500072496676;1111.7832022755565;1111.9777604447906;809.0251247247053;814.6049166154411;815.9020917489939;816.5386556595505;818.4966245758875;19988.800111998986;20119.497012574655;20367.18531258748;20382.592348152953;21080.89459552708;18107.275708971625;18227.908860455744;18453.538661533436;18683.15925783343;18702.345417910445;16304.83695163045;16689.08210048447;16855.41006064794;16940.3223871045;16952.152392380332;3593.2274560969518;3614.2410093880317;3617.94573081404;3619.1314084619503;3652;131997.34001330027;133340;134326.32836835852;135008;137069;15513.767293490606;15953.202339882959;16108.919455402647;16118.597035074217;16533.256003479873;30953.69046309508;32060.519092213635;32097.51853722196;32119.51820722691;32781.83609081939;8143.348532117417;8496.575171241413;9255.537223138816;9347.298952578583;9358.485283309483;4084.9795751021056;4216.388623649615;4241.4698162729655;4243.960229743732;4247.702660813713;5451.563874889999;5468.26178465902;5585.329760428694;5601.971990140105;5609.046462101453;1150.4937827355936;1159.0843233845337;1162.8197629367462;1165.248414772467;1168.3924359333269;642.9035644653246;651.837040739815;670.8423520472685;671.2582596231192;681.2812482830661;11729.824052639216;12563.309018004098;14770.26148692561;15118.622034449007;15244.314005869763;636.8662580857979;683.0744341417408;687.3916583823252;687.4981263677544;725.912890453149;5821.912671309934;6015.879682406415;6103.389661033861;6174.753009879644;6328.778492752732;118762.40618797023;118897.40551297188;119465;120638;123209;96076;99348;100268.49865750625;102959;103219.48390258;90710.54644726735;92498.07501925029;93351.53324233336;94328;94800;11952.402379880798;12519.812202816784;12617.328970701881;12692.936535317263;12715.237085774883;42007;44065.898352541444;44262.77868610765;46437.3034404491;46574.76712616415;56948.430515694316;60063;60942.69528652328;61087.38912610995;61121.38878611335;17117.65764684724;17157.227924743165;17183.914080429517;17265.96404215751;17438.128093595016;17917.641647167246;18839;18888.244470221038;18897.71653425227;19242.903785480983;17441.651166976844;17472.30110795554;17501.649967000332;17526.474205773848;17695.46913592594;15905.204739762734;15944.282507286967;16107;16259;16264.268107934935;16597.917010415353;16974.830251697324;17183.7422438661;17280.740788887924;17405.303787848345;11030.834537481784;12029.699257518632;12073.879261207627;12080.75838483243;12219;11814.645560633195;11953.641390758292;12017.4592143352;12373.93813030929;12610.936945315214 03:47:22 INFO - PID 22473 | __end_tp_report 03:47:22 INFO - PID 22473 | __start_cc_report 03:47:22 INFO - PID 22473 | _x_x_mozilla_cycle_collect,355 03:47:22 INFO - PID 22473 | __end_cc_report 03:47:22 INFO - PID 22473 | __startTimestamp1501411642893__endTimestamp 03:47:22 INFO - PID 22473 | 03:47:22 INFO - PID 22473 | ------- Summary: start ------- 03:47:22 INFO - PID 22473 | Number of tests: 6 03:47:22 INFO - PID 22473 | 03:47:22 INFO - PID 22473 | [#0] dojo.html Cycles:165 Average:6150.56 Median:6471.13 stddev:806.16 (12.5%) stddev-sans-first:778.25 03:47:22 INFO - PID 22473 | Values: 3355.8 3381.5 3382.5 3413.7 3441.5 6230.3 6235.1 6237.0 6252.6 6298.3 6095.4 6163.0 6188.0 6228.4 6305.8 5372.7 5436.6 5464.3 5471.4 5541.2 5350.1 5352.3 5403.9 5458.7 5517.2 5335.6 5351.0 5406.6 5412.9 5471.6 5399.5 5455.9 5469.1 5482.7 5483.9 5350.6 5377.5 5423.9 5427.0 5439.0 6023.8 6039.3 6094.3 6136.7 6175.5 6703.2 6716.4 6722.7 6726.3 6747.5 6799.2 6800.0 6807.0 6824.2 6824.6 6138.1 6194.0 6215.0 6305.8 6314.4 6708.9 6840.1 6914.3 6917.3 6922.7 6463.3 6557.1 6557.7 6562.4 6570.0 6641.6 6651.8 6656.9 6658.7 6685.3 6609.0 6624.8 6650.0 6657.5 6661.4 6630.0 6656.6 6674.8 6685.7 6706.3 4891.0 4894.7 4895.4 4900.7 4903.9 4314.8 4342.8 4378.2 4394.1 4394.9 6293.3 6374.3 6382.4 6462.6 6481.5 6677.7 6678.3 6682.7 6689.1 6690.0 6060.5 6411.9 6463.9 6464.8 6472.1 5443.2 5488.1 5489.3 5489.8 5561.2 7022.9 7038.1 7051.3 7060.6 7073.3 6516.1 6655.1 6665.6 6670.5 6768.6 7139.3 7144.1 7166.0 7176.2 7179.1 6479.6 6619.9 6645.0 6719.6 6721.4 6689.5 6689.7 6690.5 6694.5 6727.5 6502.3 6504.3 6506.2 6507.1 6550.1 5980.2 6452.6 6470.6 6484.4 6517.4 6478.9 6492.4 6502.4 6575.9 6592.6 6471.1 6518.6 6603.8 6607.8 6654.3 6303.2 6320.6 6327.4 6403.1 6406.8 03:47:22 INFO - PID 22473 | 03:47:22 INFO - PID 22473 | [#1] ext.html Cycles:180 Average:40751.37 Median:19159.12 stddev:60800.82 (317.3%) stddev-sans-first:60897.65 03:47:22 INFO - PID 22473 | Values: 871.5 901.9 915.1 927.4 938.5 40452.2 42713.0 44317.3 44407.3 44617.6 43660.8 44054.3 44069.8 44125.6 44138.0 7426.3 7476.9 7598.3 7604.8 7605.6 7231.3 7286.7 7304.9 7305.2 7309.9 7287.4 7333.1 7333.2 7333.3 7373.0 7263.2 7307.1 7307.3 7316.7 7367.9 7281.9 7287.7 7289.6 7311.9 7369.4 38828.2 38874.6 39241.0 39243.6 39253.0 3442.3 3458.3 3464.4 3477.0 3484.4 30618.7 30707.4 30740.0 30776.2 30783.1 4893.5 4941.2 4943.2 4956.7 5003.1 199865.0 200171.0 200513.0 200970.0 201294.0 50198.5 50379.5 50380.2 50386.2 50610.5 53378.0 53411.7 53456.2 53523.0 53584.5 15603.3 15902.2 15933.8 16024.9 16032.0 11346.8 11532.6 12600.0 12785.9 12800.4 14891.6 14918.8 14983.6 15058.8 15063.8 5792.5 5920.9 5948.8 6016.1 6121.1 1030.9 1055.8 1076.3 1078.3 1090.1 23530.8 24082.5 24114.6 24448.6 24631.3 1156.0 1186.9 1190.6 1191.7 1199.8 12725.7 13116.4 13153.4 13209.0 13219.0 264934.0 265574.0 265980.0 266166.0 266352.0 50538.7 53128.7 53838.0 54193.0 54556.9 1473.9 1508.1 1510.6 1523.8 1533.9 28336.6 28489.9 28724.0 29099.6 29563.0 36035.0 36075.0 36159.8 36222.0 36225.8 228891.0 231019.0 231580.0 231616.0 231765.0 33359.0 34767.5 36637.5 36765.1 36890.8 47572.5 48370.0 48474.0 48492.3 48536.5 33376.3 34200.1 34321.3 34351.3 34765.1 33087.5 34477.3 34487.7 34529.3 34734.7 38827.4 40534.4 41518.6 41538.4 41590.6 32760.0 34237.5 34341.3 34556.0 34833.8 25809.4 26528.6 26867.6 27623.2 27831.3 03:47:22 INFO - PID 22473 | 03:47:22 INFO - PID 22473 | [#2] jquery.html Cycles:180 Average:39566.65 Median:22499.94 stddev:97908.58 (435.2%) stddev-sans-first:98139.46 03:47:22 INFO - PID 22473 | Values: 569.7 570.4 573.1 575.4 577.5 22350.0 23208.0 23249.8 23299.7 24395.5 25890.0 26682.0 26697.3 26715.9 26746.6 6302.5 6454.4 6455.2 6457.8 6471.7 5988.4 6230.8 6233.4 6233.6 6244.7 6183.2 6185.6 6186.8 6198.6 6198.8 6116.9 6163.4 6167.3 6193.7 6196.1 5650.8 5720.9 5728.7 5744.3 5769.7 29862.4 30384.5 30776.8 31081.2 31157.0 2178.5 2214.2 2218.8 2221.8 2222.2 19310.0 19744.7 19875.6 19913.1 19921.0 2347.6 2359.7 2401.3 2413.0 2472.9 141320.3 143798.3 145059.3 152923.0 156828.2 14584.7 15386.2 15514.2 15847.1 16106.4 23662.8 24771.6 24805.3 24806.8 24949.8 10415.5 10531.4 10626.5 10801.7 10804.9 9726.7 9732.6 9747.2 9777.3 9881.4 9515.8 9835.0 9888.4 10086.8 10120.9 2815.5 2897.5 2942.7 2958.9 3011.8 1041.3 1050.4 1050.5 1071.1 1073.4 20264.3 20765.9 21031.8 22055.1 22067.0 1115.3 1119.1 1119.7 1123.6 1135.1 11620.3 12038.6 12162.3 12176.0 12192.1 546250.0 575528.0 589840.0 594391.0 600305.0 136303.0 137850.0 138520.0 139445.0 139916.3 1305.9 1323.4 1344.9 1356.6 1359.6 21663.8 22149.9 22366.2 22633.7 22789.8 64096.4 65654.3 67698.3 67703.3 69946.0 87041.0 90775.5 90797.0 91032.1 91883.1 14159.4 14889.3 14926.2 14979.2 15024.0 23986.2 24073.0 24281.5 24522.5 24938.3 19586.0 19676.9 19819.4 19983.0 20013.6 16539.8 17116.7 17169.1 17497.2 17701.5 19837.8 20121.9 20275.0 20292.5 20422.8 14540.6 14630.2 14650.2 14787.6 14802.8 19492.6 19752.8 19886.5 19941.5 20001.3 03:47:22 INFO - PID 22473 | 03:47:22 INFO - PID 22473 | [#3] mootools.html Cycles:180 Average:9423.49 Median:26542.60 stddev:6816.90 (25.7%) stddev-sans-first:6809.41 03:47:22 INFO - PID 22473 | Values: 1405.8 1459.3 1463.4 1496.8 1505.2 14901.5 15652.5 15683.5 15700.5 15719.4 15819.5 16074.9 16081.8 16093.3 16101.6 2699.2 2741.8 2742.2 2742.6 2749.5 2607.0 2612.5 2670.0 2690.5 2723.3 2729.4 2762.3 2762.3 2764.3 2765.3 2704.4 2712.9 2721.0 2724.3 2727.3 2567.1 2601.4 2603.6 2614.1 2614.4 14901.0 15296.4 15321.5 15334.0 15363.6 8018.7 8250.8 8283.4 8283.9 8316.0 5236.6 5312.7 5365.4 5465.9 5512.6 1769.5 1827.9 1830.3 1840.9 1879.7 26060.2 26381.2 26504.3 26526.0 26559.2 6844.6 6912.0 6932.0 7016.6 7060.5 18009.7 18065.9 18085.4 18091.5 18101.0 8110.5 8210.9 8211.8 8222.2 8226.8 7447.9 7562.7 7567.8 7652.1 7659.2 5265.9 5350.4 5425.1 5439.1 5456.6 1537.8 1554.1 1555.2 1574.7 1594.0 863.7 867.9 876.4 893.7 909.3 7092.8 7306.1 7347.1 7406.6 7453.6 730.7 732.5 736.1 743.2 748.2 4225.5 4278.8 4490.0 4945.9 5072.4 21183.7 21287.7 22027.4 22279.1 22296.0 21346.3 21653.6 21655.2 21909.5 21922.0 10200.9 11862.0 11969.8 11987.7 12056.0 8138.6 8323.9 8411.0 8532.9 8582.4 18239.3 18628.8 18896.0 19074.8 19361.3 18506.0 19217.9 19533.1 19766.3 20087.0 12132.2 12775.9 12781.0 12786.4 12786.9 14287.8 14359.1 14364.2 14418.6 14437.5 11160.6 11255.8 11300.0 11321.4 11665.2 10922.9 11123.0 11248.3 11545.9 11640.8 8984.1 9023.4 9029.8 9090.3 9100.6 6674.5 6889.6 6899.4 7096.8 7103.4 6424.4 6957.5 7025.4 7102.8 7159.1 03:47:22 INFO - PID 22473 | 03:47:22 INFO - PID 22473 | [#4] prototype.html Cycles:180 Average:5478.24 Median:6105.61 stddev:1576.97 (25.8%) stddev-sans-first:1536.47 03:47:22 INFO - PID 22473 | Values: 499.4 501.3 526.3 526.7 527.5 5975.6 6091.1 6099.1 6106.4 6116.7 5819.5 5937.4 5975.4 6007.0 6025.6 4678.1 4700.8 4705.4 4723.8 4730.7 4563.9 4638.2 4709.3 4723.4 4742.6 4653.6 4662.4 4691.7 4692.8 4732.3 4645.3 4664.2 4670.4 4673.8 4678.3 4198.6 4216.6 4235.7 4253.8 4258.2 5876.7 5962.7 5965.6 5980.6 5993.2 5622.5 5639.2 5677.9 5686.3 5702.7 6403.2 6411.2 6430.5 6531.3 6535.2 4818.3 4841.7 4844.7 4858.1 4887.0 6659.7 6717.5 6745.3 6778.3 6796.1 4885.2 4955.7 4976.4 4992.8 5022.9 5031.8 5053.8 5054.9 5057.6 5064.4 5632.6 5642.4 5702.1 5704.0 5706.5 6457.8 6483.0 6492.4 6499.1 6539.3 1664.2 1703.7 1721.2 1737.6 1759.8 1240.1 1251.2 1255.2 1256.3 1258.6 6206.6 6232.7 6244.0 6258.0 6277.6 6346.4 6585.7 6604.3 6621.4 6659.9 6099.8 6129.5 6143.5 6248.5 6311.3 3432.9 3466.8 3487.8 3519.6 3540.0 6917.2 6939.3 6943.9 6956.3 6999.0 6763.6 6786.6 6794.8 6799.4 6809.9 6941.1 6945.8 6983.3 7011.6 7093.2 6578.6 6613.6 6623.6 6668.2 6695.9 6457.3 6511.6 6571.4 6600.1 6622.6 6910.4 6964.5 7039.5 7065.6 7069.4 4910.0 4928.3 4974.3 4982.0 4985.8 6619.9 6644.9 6680.3 6706.5 6712.0 6350.8 6413.9 6481.2 6493.5 6512.3 6321.8 6351.7 6365.0 6382.6 6421.0 6083.0 6387.4 6389.8 6421.5 6480.4 6104.8 6355.5 6500.6 6508.5 6513.8 6245.3 6248.9 6252.5 6255.4 6258.3 03:47:22 INFO - PID 22473 | 03:47:22 INFO - PID 22473 | [#5] yui.html Cycles:180 Average:24216.00 Median:18340.72 stddev:33948.93 (185.1%) stddev-sans-first:33999.13 03:47:22 INFO - PID 22473 | Values: 929.5 942.4 945.2 949.1 966.9 18537.7 19467.5 19484.2 19490.6 21316.3 21057.7 21518.4 21679.0 21811.7 21842.6 1037.2 1066.7 1070.1 1071.0 1071.8 1089.0 1089.7 1089.7 1090.0 1092.9 1078.4 1125.7 1128.0 1130.8 1131.4 1107.0 1109.3 1111.0 1111.8 1112.0 809.0 814.6 815.9 816.5 818.5 19988.8 20119.5 20367.2 20382.6 21080.9 18107.3 18227.9 18453.5 18683.2 18702.3 16304.8 16689.1 16855.4 16940.3 16952.2 3593.2 3614.2 3617.9 3619.1 3652.0 131997.3 133340.0 134326.3 135008.0 137069.0 15513.8 15953.2 16108.9 16118.6 16533.3 30953.7 32060.5 32097.5 32119.5 32781.8 8143.3 8496.6 9255.5 9347.3 9358.5 4085.0 4216.4 4241.5 4244.0 4247.7 5451.6 5468.3 5585.3 5602.0 5609.0 1150.5 1159.1 1162.8 1165.2 1168.4 642.9 651.8 670.8 671.3 681.3 11729.8 12563.3 14770.3 15118.6 15244.3 636.9 683.1 687.4 687.5 725.9 5821.9 6015.9 6103.4 6174.8 6328.8 118762.4 118897.4 119465.0 120638.0 123209.0 96076.0 99348.0 100268.5 102959.0 103219.5 90710.5 92498.1 93351.5 94328.0 94800.0 11952.4 12519.8 12617.3 12692.9 12715.2 42007.0 44065.9 44262.8 46437.3 46574.8 56948.4 60063.0 60942.7 61087.4 61121.4 17117.7 17157.2 17183.9 17266.0 17438.1 17917.6 18839.0 18888.2 18897.7 19242.9 17441.7 17472.3 17501.6 17526.5 17695.5 15905.2 15944.3 16107.0 16259.0 16264.3 16597.9 16974.8 17183.7 17280.7 17405.3 11030.8 12029.7 12073.9 12080.8 12219.0 11814.6 11953.6 12017.5 12373.9 12610.9 03:47:22 INFO - PID 22473 | -------- Summary: end -------- 03:47:22 INFO - PID 22473 | 03:47:23 INFO - TEST-INFO | 22473: exit 0 03:47:23 INFO - TEST-OK | dromaeo_css | took 1109957ms 03:47:23 INFO - TEST-START | kraken 03:47:23 INFO - Initialising browser for kraken test... 03:47:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56373/getInfo.html -profile /tmp/tmpgz_74X/profile 03:47:23 INFO - TEST-INFO | started process 22840 (/builds/slave/test/build/application/firefox/firefox http://localhost:56373/getInfo.html) 03:47:28 INFO - TEST-INFO | 22840: exit 0 03:47:28 INFO - Browser initialized. 03:47:28 INFO - Running cycle 1/1 for kraken test... 03:47:28 INFO - TEST-INFO | started process 23046 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgz_74X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:47:29 INFO - PID 23046 | 03:47:29 INFO - PID 23046 | (/builds/slave/test/build/application/firefox/firefox:23094): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:47:29 INFO - PID 23046 | 03:47:40 INFO - PID 23046 | RSS: Main: 164585472 03:47:40 INFO - PID 23046 | 03:47:42 INFO - PID 23046 | Cycle 1(1): loaded http://localhost:56373/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56373/tests/kraken/driver.html?testName=audio-beat-detection) 03:47:43 INFO - PID 23046 | RSS: Main: 168890368 03:47:43 INFO - PID 23046 | 03:47:46 INFO - PID 23046 | Cycle 1(1): loaded http://localhost:56373/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56373/tests/kraken/driver.html?testName=audio-dft) 03:47:46 INFO - PID 23046 | RSS: Main: 169635840 03:47:46 INFO - PID 23046 | 03:47:49 INFO - PID 23046 | Cycle 1(1): loaded http://localhost:56373/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56373/tests/kraken/driver.html?testName=audio-fft) 03:47:50 INFO - PID 23046 | RSS: Main: 164114432 03:47:50 INFO - PID 23046 | 03:47:52 INFO - PID 23046 | Cycle 1(1): loaded http://localhost:56373/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56373/tests/kraken/driver.html?testName=audio-oscillator) 03:47:52 INFO - PID 23046 | RSS: Main: 165318656 03:47:52 INFO - PID 23046 | 03:47:55 INFO - PID 23046 | Cycle 1(1): loaded http://localhost:56373/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56373/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:47:55 INFO - PID 23046 | RSS: Main: 165171200 03:47:55 INFO - PID 23046 | 03:47:58 INFO - PID 23046 | Cycle 1(1): loaded http://localhost:56373/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56373/tests/kraken/driver.html?testName=imaging-darkroom) 03:47:59 INFO - PID 23046 | RSS: Main: 167981056 03:47:59 INFO - PID 23046 | 03:48:02 INFO - PID 23046 | Cycle 1(1): loaded http://localhost:56373/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56373/tests/kraken/driver.html?testName=imaging-desaturate) 03:48:03 INFO - PID 23046 | RSS: Main: 169967616 03:48:03 INFO - PID 23046 | 03:48:06 INFO - PID 23046 | Cycle 1(1): loaded http://localhost:56373/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56373/tests/kraken/driver.html?testName=json-parse-financial) 03:48:06 INFO - PID 23046 | RSS: Main: 168902656 03:48:06 INFO - PID 23046 | 03:48:08 INFO - PID 23046 | Cycle 1(1): loaded http://localhost:56373/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56373/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:48:09 INFO - PID 23046 | RSS: Main: 169259008 03:48:09 INFO - PID 23046 | 03:48:10 INFO - PID 23046 | Cycle 1(1): loaded http://localhost:56373/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56373/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:48:11 INFO - PID 23046 | RSS: Main: 168845312 03:48:11 INFO - PID 23046 | 03:48:13 INFO - PID 23046 | Cycle 1(1): loaded http://localhost:56373/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56373/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:48:14 INFO - PID 23046 | RSS: Main: 165908480 03:48:14 INFO - PID 23046 | 03:48:16 INFO - PID 23046 | Cycle 1(1): loaded http://localhost:56373/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56373/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:48:17 INFO - PID 23046 | RSS: Main: 165642240 03:48:17 INFO - PID 23046 | 03:48:20 INFO - PID 23046 | Cycle 1(1): loaded http://localhost:56373/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56373/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:48:21 INFO - PID 23046 | RSS: Main: 166813696 03:48:21 INFO - PID 23046 | 03:48:22 INFO - PID 23046 | Cycle 1(1): loaded http://localhost:56373/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56373/tests/kraken/driver.html?testName=ai-astar) 03:48:22 INFO - PID 23046 | RSS: Main: 167673856 03:48:22 INFO - PID 23046 | 03:48:22 INFO - PID 23046 | __start_tp_report 03:48:22 INFO - PID 23046 | _x_x_mozilla_page_load 03:48:22 INFO - PID 23046 | _x_x_mozilla_page_load_details 03:48:22 INFO - PID 23046 | |i|pagename|runs| 03:48:22 INFO - PID 23046 | |0;ai-astar;98;107;100;106;107;109;108;103;108;108 03:48:22 INFO - PID 23046 | |1;audio-beat-detection;151;116;141;183;114;137;155;116;170;113 03:48:22 INFO - PID 23046 | |2;audio-dft;163;163;162;163;167;163;161;164;171;163 03:48:22 INFO - PID 23046 | |3;audio-fft;74;75;75;167;77;75;74;94;97;75 03:48:22 INFO - PID 23046 | |4;audio-oscillator;78;78;129;78;79;79;136;79;79;124 03:48:22 INFO - PID 23046 | |5;imaging-gaussian-blur;114;114;114;115;115;115;114;113;114;114 03:48:22 INFO - PID 23046 | |6;imaging-darkroom;149;150;148;148;148;148;148;148;148;147 03:48:22 INFO - PID 23046 | |7;imaging-desaturate;94;94;93;99;94;93;94;94;95;95 03:48:22 INFO - PID 23046 | |8;json-parse-financial;49;49;51;54;53;51;50;58;54;52 03:48:22 INFO - PID 23046 | |9;json-stringify-tinderbox;56;55;54;55;54;55;54;55;55;54 03:48:22 INFO - PID 23046 | |10;stanford-crypto-aes;76;79;75;76;76;76;77;77;84;76 03:48:22 INFO - PID 23046 | |11;stanford-crypto-ccm;123;128;124;123;122;151;120;119;121;151 03:48:22 INFO - PID 23046 | |12;stanford-crypto-pbkdf2;168;181;174;175;171;171;170;169;195;179 03:48:22 INFO - PID 23046 | |13;stanford-crypto-sha256-iterative;65;62;63;63;63;73;63;63;64;62 03:48:22 INFO - PID 23046 | __end_tp_report 03:48:23 INFO - PID 23046 | __start_cc_report 03:48:23 INFO - PID 23046 | _x_x_mozilla_cycle_collect,838 03:48:23 INFO - PID 23046 | __end_cc_report 03:48:23 INFO - PID 23046 | __startTimestamp1501411702990__endTimestamp 03:48:23 INFO - PID 23046 | 03:48:23 INFO - PID 23046 | ------- Summary: start ------- 03:48:23 INFO - PID 23046 | Number of tests: 14 03:48:23 INFO - PID 23046 | 03:48:23 INFO - PID 23046 | [#0] ai-astar Cycles:10 Average:105.40 Median:108.00 stddev:3.78 (3.5%) stddev-sans-first:2.91 03:48:23 INFO - PID 23046 | Values: 98.0 107.0 100.0 106.0 107.0 109.0 108.0 103.0 108.0 108.0 03:48:23 INFO - PID 23046 | 03:48:23 INFO - PID 23046 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:146.00 stddev:25.08 (17.2%) stddev-sans-first:26.26 03:48:23 INFO - PID 23046 | Values: 151.0 116.0 141.0 183.0 114.0 137.0 155.0 116.0 170.0 113.0 03:48:23 INFO - PID 23046 | 03:48:23 INFO - PID 23046 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:2.91 (1.8%) stddev-sans-first:3.06 03:48:23 INFO - PID 23046 | Values: 163.0 163.0 162.0 163.0 167.0 163.0 161.0 164.0 171.0 163.0 03:48:23 INFO - PID 23046 | 03:48:23 INFO - PID 23046 | [#3] audio-fft Cycles:10 Average:88.30 Median:75.00 stddev:28.96 (38.6%) stddev-sans-first:30.25 03:48:23 INFO - PID 23046 | Values: 74.0 75.0 75.0 167.0 77.0 75.0 74.0 94.0 97.0 75.0 03:48:23 INFO - PID 23046 | 03:48:23 INFO - PID 23046 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:78.50 stddev:24.85 (31.7%) stddev-sans-first:25.68 03:48:23 INFO - PID 23046 | Values: 78.0 78.0 129.0 78.0 79.0 79.0 136.0 79.0 79.0 124.0 03:48:23 INFO - PID 23046 | 03:48:23 INFO - PID 23046 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 03:48:23 INFO - PID 23046 | Values: 114.0 114.0 114.0 115.0 115.0 115.0 114.0 113.0 114.0 114.0 03:48:23 INFO - PID 23046 | 03:48:23 INFO - PID 23046 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 03:48:23 INFO - PID 23046 | Values: 149.0 150.0 148.0 148.0 148.0 148.0 148.0 148.0 148.0 147.0 03:48:23 INFO - PID 23046 | 03:48:23 INFO - PID 23046 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:1.72 (1.8%) stddev-sans-first:1.81 03:48:23 INFO - PID 23046 | Values: 94.0 94.0 93.0 99.0 94.0 93.0 94.0 94.0 95.0 95.0 03:48:23 INFO - PID 23046 | 03:48:23 INFO - PID 23046 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.50 stddev:2.77 (5.3%) stddev-sans-first:2.70 03:48:23 INFO - PID 23046 | Values: 49.0 49.0 51.0 54.0 53.0 51.0 50.0 58.0 54.0 52.0 03:48:23 INFO - PID 23046 | 03:48:23 INFO - PID 23046 | [#9] json-stringify-tinderbox Cycles:10 Average:54.70 Median:55.00 stddev:0.67 (1.2%) stddev-sans-first:0.53 03:48:23 INFO - PID 23046 | Values: 56.0 55.0 54.0 55.0 54.0 55.0 54.0 55.0 55.0 54.0 03:48:23 INFO - PID 23046 | 03:48:23 INFO - PID 23046 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:76.50 stddev:2.62 (3.4%) stddev-sans-first:2.74 03:48:23 INFO - PID 23046 | Values: 76.0 79.0 75.0 76.0 76.0 76.0 77.0 77.0 84.0 76.0 03:48:23 INFO - PID 23046 | 03:48:23 INFO - PID 23046 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:123.50 stddev:12.26 (9.9%) stddev-sans-first:12.86 03:48:23 INFO - PID 23046 | Values: 123.0 128.0 124.0 123.0 122.0 151.0 120.0 119.0 121.0 151.0 03:48:23 INFO - PID 23046 | 03:48:23 INFO - PID 23046 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:174.50 stddev:8.12 (4.7%) stddev-sans-first:8.18 03:48:23 INFO - PID 23046 | Values: 168.0 181.0 174.0 175.0 171.0 171.0 170.0 169.0 195.0 179.0 03:48:23 INFO - PID 23046 | 03:48:23 INFO - PID 23046 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:63.00 stddev:3.25 (5.2%) stddev-sans-first:3.43 03:48:23 INFO - PID 23046 | Values: 65.0 62.0 63.0 63.0 63.0 73.0 63.0 63.0 64.0 62.0 03:48:23 INFO - PID 23046 | -------- Summary: end -------- 03:48:23 INFO - PID 23046 | 03:48:23 INFO - PID 23046 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:48:23 INFO - TEST-INFO | 23046: exit 0 03:48:23 INFO - TEST-OK | kraken | took 59997ms 03:48:23 INFO - SUITE-END | took 1169s 03:48:23 INFO - Completed test suite (00:19:29) 03:48:23 INFO - javascript benchmark 03:48:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8672.032456232133, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3355.76509644325, 3381.526586277921, 3382.4926261060837, 3413.7098346640532, 3441.518187453757, 6230.345813689565, 6235.095911092894, 6237.0, 6252.624842509441, 6298.338674439186, 6095.420935011178, 6163.044728067145, 6188.040853667689, 6228.377162283769, 6305.842353941154, 5372.650777699437, 5436.619436639437, 5464.26232458619, 5471.398146203915, 5541.168824676311, 5350.0904846176045, 5352.277442545265, 5403.918941215885, 5458.6724796512335, 5517.172424136372, 5335.573154147678, 5350.9732451337495, 5406.567474602042, 5412.891742165154, 5471.616986810925, 5399.487048730364, 5455.945440545584, 5469.097598896177, 5482.698451585161, 5483.945160548423, 5350.5987050971335, 5377.489138531833, 5423.915216956624, 5426.972865135688, 5439.0, 6023.849403764897, 6039.335673075958, 6094.299155597118, 6136.693165341715, 6175.505959523227, 6703.229128650219, 6716.395524402778, 6722.697478613474, 6726.327367263235, 6747.493937954624, 6799.184097908283, 6800.0, 6807.047013418125, 6824.21521525021, 6824.624645644488, 6138.0792881067755, 6194.0, 6214.9689251553455, 6305.833420817117, 6314.368563143695, 6708.932910670928, 6840.110785597841, 6914.274001229798, 6917.308269173143, 6922.723091076301, 6463.256725476536, 6557.114789503451, 6557.737690492422, 6562.442192413603, 6570.047343135314, 6641.568298060611, 6651.800445986628, 6656.900146497806, 6658.667066646745, 6685.298043705438, 6609.0, 6624.8343791405605, 6650.035744816974, 6657.46740260778, 6661.367170118928, 6629.966850165718, 6656.567323123982, 6674.766383176662, 6685.699143538553, 6706.329367063255, 4890.997345544226, 4894.681845680019, 4895.412550493964, 4900.681455705368, 4903.901921961612, 4314.827406903752, 4342.761148136819, 4378.1900348435, 4394.12117576486, 4394.890127746832, 6293.3391993840905, 6374.266959299647, 6382.36176382358, 6462.612243265419, 6481.48148148147, 6677.666116694146, 6678.332166783282, 6682.665866706645, 6689.063531105649, 6690.02994565795, 6060.484858787053, 6411.935880641134, 6463.935360646334, 6464.806055818333, 6472.093906853044, 5443.237946687467, 5488.121900495901, 5489.313835770528, 5489.835304940858, 5561.249231353715, 7022.859542809218, 7038.120234970629, 7051.330123638246, 7060.576365418091, 7073.257307982588, 6516.087747715418, 6655.101561289164, 6665.600063996176, 6670.499712521483, 6768.627725475146, 7139.2503787101605, 7144.142702875688, 7166.0, 7176.210616832249, 7179.066721326194, 6479.611223326616, 6619.933800661932, 6645.003249512612, 6719.630420326734, 6721.361470660279, 6689.46484281266, 6689.698963546554, 6690.464762818866, 6694.531382803157, 6727.529072965041, 6502.252240992347, 6504.252011018793, 6506.186726659168, 6507.12153859223, 6550.050242714684, 5980.192673988956, 6452.580582262138, 6470.611763294218, 6484.416402523795, 6517.446017088411, 6478.935210647834, 6492.350764923659, 6502.447291980235, 6575.901361479486, 6592.571482853599, 6471.126397936218, 6518.608883467007, 6603.7688680895935, 6607.768728094494, 6654.301298363602, 6303.180586523723, 6320.557560970872, 6327.430531252209, 6403.103565500741, 6406.839829004312], "value": 6087.87795284862, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [871.4825703485927, 901.8839908117454, 915.1351972386094, 927.420362273579, 938.4979036215626, 40452.19095618086, 42713.0, 44317.33523997143, 44407.3338899916, 44617.55382446175, 43660.78169609155, 44054.33918491225, 44069.77965110178, 44125.55874441255, 44138.0, 7426.331630153285, 7476.85046299075, 7598.278163574451, 7604.809879752995, 7605.619719014055, 7231.276872312779, 7286.672099755498, 7304.853902921938, 7305.159906610728, 7309.853802923938, 7287.380572651331, 7333.120025596936, 7333.156686980986, 7333.303336183054, 7372.963135184316, 7263.201047884729, 7307.086614173229, 7307.269273072703, 7316.670749816244, 7367.8894816577795, 7281.9271807281775, 7287.7449289275155, 7289.599072051035, 7311.853762924765, 7369.373603243677, 38828.22343553113, 38874.61125388738, 39241.0, 39243.60756392428, 39253.0, 3442.294329662413, 3458.2737625098507, 3464.3764122457947, 3477.0264325988765, 3484.407650699387, 30618.693813061807, 30707.385852283052, 30740.0, 30776.230594235098, 30783.076507704805, 4893.535114164149, 4941.234108713155, 4943.209086546171, 4956.727379994099, 5003.124453220672, 199865.0, 200171.0, 200513.0, 200970.0, 201294.0, 50198.49801501938, 50379.49620503822, 50380.244296335586, 50386.24420633693, 50610.49389506058, 53378.0, 53411.732941335045, 53456.19815702768, 53523.0, 53584.46415535873, 15603.297851596706, 15902.204889755465, 15933.840661593467, 16024.919875400781, 16032.0, 11346.829797553044, 11532.596359127558, 12600.0, 12785.936070319589, 12800.35998200105, 14891.553253402415, 14918.776218356734, 14983.550493485212, 15058.849411505964, 15063.849361506464, 5792.536597072224, 5920.911186332209, 5948.762049517971, 6016.097585362143, 6121.071862363341, 1030.9329893556894, 1055.836345366454, 1076.3004047369272, 1078.3260462211117, 1090.051655060087, 23530.7646923532, 24082.51834963326, 24114.638280425806, 24448.633270500955, 24631.261062168163, 1155.96532104037, 1186.9465874035689, 1190.6309044196328, 1191.70803153228, 1199.7840388730112, 12725.745485090247, 13116.409761560753, 13153.408096635674, 13209.0, 13219.0, 264934.0, 265574.0, 265980.0, 266166.0, 266352.0, 50538.747306263234, 53128.73435632797, 53838.0, 54193.0, 54556.90886182254, 1473.8599833015846, 1508.064999700171, 1510.6223444139184, 1523.7866698662197, 1533.9156346401055, 28336.57495137616, 28489.857550712113, 28723.951955134067, 29099.563506547842, 29563.0, 36035.0, 36075.0, 36159.819200903825, 36222.0, 36225.818870905474, 228891.0, 231019.0, 231580.0, 231616.0, 231765.0, 33358.99923002314, 34767.4784878222, 36637.45043824398, 36765.08087297732, 36890.8155459221, 47572.52427475681, 48370.03259934852, 48474.0, 48492.272615910086, 48536.5146348532, 33376.33247334991, 34200.14499637529, 34321.31357372888, 34351.31297374088, 34765.13087172841, 33087.50368744422, 34477.310453790284, 34487.65512344945, 34529.30941381209, 34734.65265347415, 38827.41758873676, 40534.39198412085, 41518.58481415268, 41538.37692434555, 41590.58409415867, 32760.0, 34237.48643770296, 34341.31317373688, 34556.0, 34833.825830870686, 25809.354766130997, 26528.602070968565, 26867.626474704746, 27623.171304860887, 27831.30421739473], "value": 17842.253840619454, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.7265312649928, 570.3754388944106, 573.131705466219, 575.3527281807966, 577.4831525784422, 22350.0, 23207.999999999978, 23249.767502324972, 23299.650505242436, 24395.512089758195, 25890.0, 26682.0, 26697.332566685844, 26715.86642066787, 26746.598801018, 6302.4642905352985, 6454.3545645435315, 6455.160829092211, 6457.773977910774, 6471.676416179196, 5988.431099045605, 6230.7819226326865, 6233.376662333776, 6233.625982441045, 6244.687765611724, 6183.165272688197, 6185.628862268279, 6186.81439556814, 6198.566100372976, 6198.78304259351, 6116.938830611703, 6163.383661633868, 6167.321594624587, 6193.721282542274, 6196.132541444202, 5650.830475085754, 5720.8855822883725, 5728.656280623176, 5744.253247077895, 5769.711514424262, 29862.402751945057, 30384.54423183654, 30776.846115769276, 31081.222969425944, 31157.0, 2178.5425060737266, 2214.169686367612, 2218.8446808723397, 2221.8222542196745, 2222.155580879272, 19310.0, 19744.70382944257, 19875.60248795016, 19913.10391032407, 19921.0, 2347.6009078456705, 2359.6814430051895, 2401.267613377919, 2412.975870241293, 2472.863992480413, 141320.29339853337, 143798.2810085943, 145059.2747036258, 152923.0, 156828.21585892112, 14584.708305834036, 15386.230688465756, 15514.224288785515, 15847.128407937444, 16106.355745770037, 23662.763372366055, 24771.628425573632, 24805.255842324757, 24806.751932480445, 24949.750502495106, 10415.479226038668, 10531.368117912949, 10626.46867656614, 10801.67594972152, 10804.891951080388, 9726.70819875405, 9732.562034708455, 9747.220222382193, 9777.266704997011, 9881.357711748713, 9515.809683806285, 9834.950825245827, 9888.406695598287, 10086.848697269546, 10120.937301583375, 2815.4509870575043, 2897.5074237379695, 2942.749866261349, 2958.9408211835644, 3011.7891747577896, 1041.265907535186, 1050.3960222871879, 1050.5377633841238, 1071.137734124022, 1073.3720773347522, 20264.290749823685, 20765.896170519052, 21031.789682102983, 22055.11779528833, 22067.0, 1115.319655010443, 1119.1270808769173, 1119.7480566872389, 1123.5505797680994, 1135.1146106037304, 11620.302781833117, 12038.578649747216, 12162.331071790959, 12176.025917926545, 12192.14654974161, 546250.0, 575528.0, 589840.0, 594391.0, 600305.0, 136303.0, 137850.0, 138520.0, 139445.0, 139916.30041849727, 1305.895528357729, 1323.4110820684703, 1344.8924086073287, 1356.5794603672894, 1359.5853264754344, 21663.783362166178, 22149.889250553642, 22366.217182398537, 22633.660495092918, 22789.772102278766, 64096.35903640904, 65654.34345656482, 67698.32301676921, 67703.32296677167, 69946.0, 87041.0, 90775.54612227161, 90797.0, 91032.08967910236, 91883.08116918746, 14159.43362265539, 14889.255537223313, 14926.179060151795, 14979.176145312113, 15024.023438476901, 23986.160484382963, 24073.0, 24281.51436971286, 24522.50954980926, 24938.251852444457, 19586.0, 19676.90161549183, 19819.405417837486, 19983.0, 20013.59972800565, 16539.83460165431, 17116.743248851028, 17169.055701936515, 17497.21262543214, 17701.46895593134, 19837.801621984174, 20121.899390502953, 20275.0, 20292.492687682334, 20422.795772042682, 14540.563783086523, 14630.195339256443, 14650.19423931694, 14787.556373308818, 14802.77795833085, 19492.61014779668, 19752.802471975097, 19886.50283742918, 19941.501462463555, 20001.299954502105], "value": 12694.194984829765, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1405.775075987842, 1459.2557795524278, 1463.378064322664, 1496.7530357491007, 1505.2172870107545, 14901.478448254313, 15652.452164174241, 15683.45107921223, 15700.450484233053, 15719.449819256328, 15819.525414237563, 16074.919625401886, 16081.83918160818, 16093.275802588882, 16101.597460063504, 2699.2307192450157, 2741.821781584191, 2742.1773467959633, 2742.561190209567, 2749.5463248563965, 2607.0223666125203, 2612.5428050091255, 2669.959950600733, 2690.461907618484, 2723.2783312422225, 2729.426820367725, 2762.2541913683294, 2762.2818067302546, 2764.25365151409, 2765.267204190881, 2704.3509557706207, 2712.864356782153, 2720.9591856122174, 2724.332538528063, 2727.318170457386, 2567.127176759892, 2601.40167761414, 2603.622474741152, 2614.072004438435, 2614.3986883016823, 14901.0, 15296.388144474207, 15321.46374876874, 15334.0, 15363.615909602238, 8018.719344822904, 8250.752477425627, 8283.420160588761, 8283.917160828374, 8315.95842020792, 5236.554892834114, 5312.73436328182, 5365.436629153961, 5465.863353416156, 5512.641678290938, 1769.5310742653207, 1827.8994655293955, 1830.3136323878546, 1840.8527317814676, 1879.6898511745546, 26060.218193454228, 26381.20856374312, 26504.337391565172, 26525.999999999807, 26559.203223903314, 6844.623545705034, 6911.965440172767, 6931.965340173267, 7016.614086225307, 7060.470464715167, 18009.7298540522, 18065.909670451565, 18085.36701215451, 18091.457256282334, 18101.0, 8110.513369197867, 8210.876836847452, 8211.753647390588, 8222.17778222173, 8226.835463290701, 7447.88828167578, 7562.697492100365, 7567.772966811004, 7652.120006199359, 7659.234076592296, 5265.894682106336, 5350.411454739976, 5425.131978883439, 5439.129739241703, 5456.645318054314, 1537.7847101405812, 1554.0675594643124, 1555.199072477675, 1574.7086788944082, 1594.0, 863.7063398444434, 867.9218870301703, 876.4346996187423, 893.7006102955582, 909.3225546967419, 7092.787216383516, 7306.050213472215, 7347.118345798538, 7406.555606663617, 7453.590052547053, 730.7442395161651, 732.5201992694793, 736.1093077376328, 743.1824992508198, 748.195689633646, 4225.514065882463, 4278.764667943231, 4489.9551004490195, 4945.9258111128365, 5072.416672082684, 21183.68224476634, 21287.68068478943, 22027.449313767283, 22279.108835646715, 22296.0, 21346.252881149085, 21653.566928661337, 21655.242066527597, 21909.452263693216, 21922.0, 10200.897991020143, 11862.0, 11969.820452693217, 11987.700307492209, 12056.0, 8138.593070346341, 8323.875141872997, 8411.0, 8532.872006919777, 8582.442141260799, 18239.270429183216, 18628.81371186271, 18896.0, 19074.80925190786, 19361.32235371755, 18506.0, 19217.90391048036, 19533.12100955432, 19766.308179213658, 20087.0, 12132.211406258917, 12775.936120319338, 12781.0, 12786.424610892718, 12786.872131278567, 14287.785683214968, 14359.138451692932, 14364.209968451836, 14418.567442976728, 14437.494687685881, 11160.55357785712, 11255.7748845021, 11300.0, 11321.377324247245, 11665.183437159318, 10922.945385273022, 11123.0, 11248.325100493996, 11545.884541154817, 11640.825387619361, 8984.05667404913, 9023.4134781239, 9029.82612260402, 9090.272778177863, 9100.635974561208, 6674.532782705164, 6889.552179108342, 6899.413549848319, 7096.7516136934955, 7103.360697537247, 6424.38968298011, 6957.478189135936, 7025.367716905503, 7102.786916392516, 7159.105111861018], "value": 6649.803686113669, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.43064906007135, 501.26314317952597, 526.3499578021145, 526.7497938479221, 527.4988760677356, 5975.551833612475, 6091.14723938649, 6099.115628233909, 6106.381808820655, 6116.6941652917285, 5819.534437245021, 5937.40625937406, 5975.432333928281, 6006.969965150168, 6025.578209525335, 4678.111158879819, 4700.835470758524, 4705.388299521074, 4723.83466578669, 4730.716157030572, 4563.8630841074655, 4638.165130276549, 4709.317149013391, 4723.394046024351, 4742.620590352781, 4653.557911998355, 4662.438083242118, 4691.671582989192, 4692.7653617319165, 4732.266498692691, 4645.349651048822, 4664.183767840631, 4670.439547254317, 4673.83641572545, 4678.274867395559, 4198.580141985807, 4216.599423054805, 4235.703500754948, 4253.787310634456, 4258.190943720683, 5876.706164691791, 5962.672053037081, 5965.55258355625, 5980.581359304851, 5993.190919225893, 5622.522085622727, 5639.238702775114, 5677.886442271173, 5686.260786097822, 5702.7433765480655, 6403.199600049994, 6411.198600174978, 6430.517711171681, 6531.346865313478, 6535.15043044406, 4818.277258411266, 4841.661083724141, 4844.66087373884, 4858.125537403266, 4886.951130488721, 6659.734650416405, 6717.496187785887, 6745.258021617618, 6778.254392016875, 6796.116504854387, 4885.193942999436, 4955.727434991038, 4976.353074100344, 4992.8002879885125, 5022.924656130161, 5031.77357018935, 5053.84838454847, 5054.9241761373605, 5057.6459647824295, 5064.366954130734, 5632.605717599728, 5642.4075472075665, 5702.144678298206, 5703.971480142655, 5706.457886500776, 6457.806265812033, 6482.967585162044, 6492.35076492347, 6499.068063821414, 6539.346065393423, 1664.1512828457332, 1703.65075159592, 1721.1652348610914, 1737.6350966296966, 1759.7857478339904, 1240.1009268280604, 1251.2429979862234, 1255.1653150654713, 1256.2588073036952, 1258.5783762439503, 6206.627602343874, 6232.719527621268, 6243.96878015607, 6258.0, 6277.5605707600025, 6346.365363463709, 6585.73657053722, 6604.339566043357, 6621.404073633396, 6659.866802664016, 6099.817005489843, 6129.509639228851, 6143.477804386677, 6248.50011999039, 6311.274203466568, 3432.9313413731584, 3466.809325487072, 3487.843047062888, 3519.6480351964597, 3539.982300088483, 6917.204521479994, 6939.271376505495, 6943.89584156238, 6956.339147780953, 6998.965005174941, 6763.560368576027, 6786.5928044316515, 6794.830129246809, 6799.388055075067, 6809.897851532231, 6941.091199919861, 6945.791626251221, 6983.254186453387, 7011.649417529103, 7093.184283807325, 6578.572392794453, 6613.611141660305, 6623.635700036351, 6668.166479190101, 6695.899561506484, 6457.257415397289, 6511.609303441809, 6571.408573228432, 6600.141981542369, 6622.569532980341, 6910.447164226749, 6964.547304425196, 7039.507234493536, 7065.646717664199, 7069.399101076466, 4910.042541704333, 4928.310036594951, 4974.303597496281, 4981.950180498148, 4985.825496107619, 6619.933800661932, 6644.867102658017, 6680.265170831108, 6706.497012724163, 6712.0, 6350.841228969312, 6413.903791443039, 6481.189851268591, 6493.545451818327, 6512.3162067982175, 6321.810345689637, 6351.714172862325, 6364.9632117721885, 6382.585131966407, 6421.036844473367, 6082.969585152223, 6387.393197646216, 6389.840253993501, 6421.486281097595, 6480.351964803671, 6104.847378815388, 6355.523335749745, 6500.602370490367, 6508.479321654351, 6513.772017979348, 6245.250569931637, 6248.937510624835, 6252.468540174136, 6255.437010669061, 6258.311585725475], "value": 5018.464961343547, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [929.5212965322864, 942.359195746892, 945.1635302757062, 949.0604301741279, 966.8984756600556, 18537.721934170982, 19467.513312167186, 19484.220631174754, 19490.610187796236, 21316.253931112413, 21057.684134737992, 21518.354449366503, 21679.0, 21811.67282490764, 21842.563148737016, 1037.1754455208109, 1066.7066556696893, 1070.1492313610659, 1070.998616293764, 1071.7534966957605, 1089.0362029603778, 1089.667651366337, 1089.7112265249716, 1090.0407641275706, 1092.9398883061428, 1078.4338222433207, 1125.712943199487, 1128.0468004536153, 1130.7512347283625, 1131.3664347965166, 1107.0092267420653, 1109.2512554026082, 1110.9500072496676, 1111.7832022755565, 1111.9777604447906, 809.0251247247053, 814.6049166154411, 815.9020917489939, 816.5386556595505, 818.4966245758875, 19988.800111998986, 20119.497012574655, 20367.18531258748, 20382.592348152953, 21080.89459552708, 18107.275708971625, 18227.908860455744, 18453.538661533436, 18683.15925783343, 18702.345417910445, 16304.83695163045, 16689.08210048447, 16855.41006064794, 16940.3223871045, 16952.152392380332, 3593.2274560969518, 3614.2410093880317, 3617.94573081404, 3619.1314084619503, 3652.0, 131997.34001330027, 133340.0, 134326.32836835852, 135008.0, 137069.0, 15513.767293490606, 15953.202339882959, 16108.919455402647, 16118.597035074217, 16533.256003479873, 30953.69046309508, 32060.519092213635, 32097.51853722196, 32119.51820722691, 32781.83609081939, 8143.348532117417, 8496.575171241413, 9255.537223138816, 9347.298952578583, 9358.485283309483, 4084.9795751021056, 4216.388623649615, 4241.4698162729655, 4243.960229743732, 4247.702660813713, 5451.563874889999, 5468.26178465902, 5585.329760428694, 5601.971990140105, 5609.046462101453, 1150.4937827355936, 1159.0843233845337, 1162.8197629367462, 1165.248414772467, 1168.3924359333269, 642.9035644653246, 651.837040739815, 670.8423520472685, 671.2582596231192, 681.2812482830661, 11729.824052639216, 12563.309018004098, 14770.26148692561, 15118.622034449007, 15244.314005869763, 636.8662580857979, 683.0744341417408, 687.3916583823252, 687.4981263677544, 725.912890453149, 5821.912671309934, 6015.879682406415, 6103.389661033861, 6174.753009879644, 6328.778492752732, 118762.40618797023, 118897.40551297188, 119465.0, 120638.0, 123209.0, 96076.0, 99348.0, 100268.49865750625, 102959.0, 103219.48390258, 90710.54644726735, 92498.07501925029, 93351.53324233336, 94328.0, 94800.0, 11952.402379880798, 12519.812202816784, 12617.328970701881, 12692.936535317263, 12715.237085774883, 42007.0, 44065.898352541444, 44262.77868610765, 46437.3034404491, 46574.76712616415, 56948.430515694316, 60063.0, 60942.69528652328, 61087.38912610995, 61121.38878611335, 17117.65764684724, 17157.227924743165, 17183.914080429517, 17265.96404215751, 17438.128093595016, 17917.641647167246, 18839.0, 18888.244470221038, 18897.71653425227, 19242.903785480983, 17441.651166976844, 17472.30110795554, 17501.649967000332, 17526.474205773848, 17695.46913592594, 15905.204739762734, 15944.282507286967, 16107.0, 16259.0, 16264.268107934935, 16597.917010415353, 16974.830251697324, 17183.7422438661, 17280.740788887924, 17405.303787848345, 11030.834537481784, 12029.699257518632, 12073.879261207627, 12080.75838483243, 12219.0, 11814.645560633195, 11953.641390758292, 12017.4592143352, 12373.93813030929, 12610.936945315214], "value": 9242.651753187429, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1499.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 107.0, 100.0, 106.0, 107.0, 109.0, 108.0, 103.0, 108.0, 108.0], "value": 105.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 116.0, 141.0, 183.0, 114.0, 137.0, 155.0, 116.0, 170.0, 113.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 163.0, 167.0, 163.0, 161.0, 164.0, 171.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 167.0, 77.0, 75.0, 74.0, 94.0, 97.0, 75.0], "value": 88.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 129.0, 78.0, 79.0, 79.0, 136.0, 79.0, 79.0, 124.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 115.0, 115.0, 115.0, 114.0, 113.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 99.0, 94.0, 93.0, 94.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 51.0, 54.0, 53.0, 51.0, 50.0, 58.0, 54.0, 52.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 55.0, 54.0, 55.0, 54.0, 55.0, 55.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 75.0, 76.0, 76.0, 76.0, 77.0, 77.0, 84.0, 76.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 128.0, 124.0, 123.0, 122.0, 151.0, 120.0, 119.0, 121.0, 151.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 181.0, 174.0, 175.0, 171.0, 171.0, 170.0, 169.0, 195.0, 179.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 63.0, 63.0, 63.0, 73.0, 63.0, 63.0, 64.0, 62.0], "value": 64.1, "unit": "score"}]}]} 03:48:23 INFO - Return code: 0 03:48:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:48:23 INFO - # TBPL SUCCESS # 03:48:23 INFO - Running post-action listener: _package_coverage_data 03:48:23 INFO - Running post-action listener: _resource_record_post_action 03:48:23 INFO - [mozharness: 2017-07-30 10:48:23.794511Z] Finished run-tests step (success) 03:48:23 INFO - Running post-run listener: _resource_record_post_run 03:48:23 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 428560384; Read time: 0; Write time: 275548 03:48:23 INFO - TinderboxPrint: CPU usage
13.0% 03:48:23 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 03:48:23 INFO - TinderboxPrint: I/O write bytes / time
428,560,384 / 275,548 03:48:23 INFO - TinderboxPrint: CPU idle
8,242.8 (86.9%) 03:48:23 INFO - TinderboxPrint: CPU user
1,190.6 (12.6%) 03:48:23 INFO - TinderboxPrint: Swap in / out
0 / 0 03:48:23 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 0; Write bytes: 109002752; Read time: 0; Write time: 85816 03:48:23 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:48:23 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 319557632; Read time: 0; Write time: 189732 03:48:24 INFO - Running post-run listener: _upload_blobber_files 03:48:24 INFO - Blob upload gear active. 03:48:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:48:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:48:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:48:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:48:24 INFO - (blobuploader) - INFO - Open directory for files ... 03:48:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:48:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:48:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:25 INFO - (blobuploader) - INFO - Done attempting. 03:48:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:48:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:48:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:28 INFO - (blobuploader) - INFO - Done attempting. 03:48:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:48:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:48:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:29 INFO - (blobuploader) - INFO - Done attempting. 03:48:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:48:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:48:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:30 INFO - (blobuploader) - INFO - Done attempting. 03:48:30 INFO - (blobuploader) - INFO - Iteration through files over. 03:48:30 INFO - Return code: 0 03:48:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:48:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:48:30 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f4cdf16c0d6827e56869925f9d01abacf6ae12e6371a8b51904e09b9da50cc11625c8bf2fe20636a5bad84cea75cfe5d945069e8668e3e763a325e6814f2297", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fb9216368432bee1cef0fe6d11baf3ff03a3a9cef2d535b378165974b73b57517fddb899baaec4fe097f6749cf4f45828c681b8a2cb6812a87c5c4599ccf8b2", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f76a18f78feef975d9478d08e2b86f734077b80acd2f00868bdf2f226da366239cb7595ffbe654dd46b27bedb16a25165dc514aa1e38c8dd85d4e5e6f8cf2de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d056e69e1d383da822f9926141c33da9d624e4d52979bebf7535fe564b05ee92b238ee155995fe8cd275c50ff6c8bfd9abf8727e05f6bdbe4283ab2949cd7784"} 03:48:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:48:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:48:30 INFO - Contents: 03:48:30 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f4cdf16c0d6827e56869925f9d01abacf6ae12e6371a8b51904e09b9da50cc11625c8bf2fe20636a5bad84cea75cfe5d945069e8668e3e763a325e6814f2297", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fb9216368432bee1cef0fe6d11baf3ff03a3a9cef2d535b378165974b73b57517fddb899baaec4fe097f6749cf4f45828c681b8a2cb6812a87c5c4599ccf8b2", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f76a18f78feef975d9478d08e2b86f734077b80acd2f00868bdf2f226da366239cb7595ffbe654dd46b27bedb16a25165dc514aa1e38c8dd85d4e5e6f8cf2de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d056e69e1d383da822f9926141c33da9d624e4d52979bebf7535fe564b05ee92b238ee155995fe8cd275c50ff6c8bfd9abf8727e05f6bdbe4283ab2949cd7784"} 03:48:30 INFO - Running post-run listener: copy_logs_to_upload_dir 03:48:30 INFO - Copying logs to upload dir... 03:48:30 INFO - mkdir: /builds/slave/test/build/upload/logs 03:48:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.422420 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-07-30 03:48:30.239973) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-30 03:48:30.247614) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1501410051.880594-1781886007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f4cdf16c0d6827e56869925f9d01abacf6ae12e6371a8b51904e09b9da50cc11625c8bf2fe20636a5bad84cea75cfe5d945069e8668e3e763a325e6814f2297", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fb9216368432bee1cef0fe6d11baf3ff03a3a9cef2d535b378165974b73b57517fddb899baaec4fe097f6749cf4f45828c681b8a2cb6812a87c5c4599ccf8b2", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f76a18f78feef975d9478d08e2b86f734077b80acd2f00868bdf2f226da366239cb7595ffbe654dd46b27bedb16a25165dc514aa1e38c8dd85d4e5e6f8cf2de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d056e69e1d383da822f9926141c33da9d624e4d52979bebf7535fe564b05ee92b238ee155995fe8cd275c50ff6c8bfd9abf8727e05f6bdbe4283ab2949cd7784"} build_url:https://queue.taskcluster.net/v1/task/T-Lx5xutS1q2OwcNrwiKhw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011322 build_url: 'https://queue.taskcluster.net/v1/task/T-Lx5xutS1q2OwcNrwiKhw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f4cdf16c0d6827e56869925f9d01abacf6ae12e6371a8b51904e09b9da50cc11625c8bf2fe20636a5bad84cea75cfe5d945069e8668e3e763a325e6814f2297", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fb9216368432bee1cef0fe6d11baf3ff03a3a9cef2d535b378165974b73b57517fddb899baaec4fe097f6749cf4f45828c681b8a2cb6812a87c5c4599ccf8b2", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f76a18f78feef975d9478d08e2b86f734077b80acd2f00868bdf2f226da366239cb7595ffbe654dd46b27bedb16a25165dc514aa1e38c8dd85d4e5e6f8cf2de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d056e69e1d383da822f9926141c33da9d624e4d52979bebf7535fe564b05ee92b238ee155995fe8cd275c50ff6c8bfd9abf8727e05f6bdbe4283ab2949cd7784"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-30 03:48:30.272025) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:48:30.272364) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1501410051.880594-1781886007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:48:30.361129) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-30 03:48:30.363044) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-30 03:48:30.363465) ========= ========= Total master_lag: 0.28 =========