builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-006 starttime: 1501582700.28 results: success (0) revision: 51ffb9283f0c7c00e08eb8c39b33fbee218c370d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:20.284050) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:20.284595) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:20.284905) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:20.365254) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:20.365573) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1501582597.971302-2044522211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-01 03:18:20-- 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% 229M=0s 2017-08-01 03:18:20 (229 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.166989 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:20.577479) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:20.578086) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1501582597.971302-2044522211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014263 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:20.631260) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:20.631853) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 51ffb9283f0c7c00e08eb8c39b33fbee218c370d --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 51ffb9283f0c7c00e08eb8c39b33fbee218c370d --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=e31afd3c0f0de4e86ebe4d94000001b5-1501582597.971302-2044522211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-01 03:18:20,412 truncating revision to first 12 chars 2017-08-01 03:18:20,412 Setting DEBUG logging. 2017-08-01 03:18:20,412 attempt 1/10 2017-08-01 03:18:20,412 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/51ffb9283f0c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-01 03:18:20,728 unpacking tar archive at: mozilla-central-51ffb9283f0c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.618672 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:21.264815) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:21.265115) ========= script_repo_revision: 51ffb9283f0c7c00e08eb8c39b33fbee218c370d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:21.265507) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:21.265776) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-01 03:18:21.275357) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-08-01 03:18:21.275652) ========= /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=e31afd3c0f0de4e86ebe4d94000001b5-1501582597.971302-2044522211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:18:21 INFO - MultiFileLogger online at 20170801 03:18:21 in /builds/slave/test 03:18:21 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:18:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:18:21 INFO - {'append_to_log': False, 03:18:21 INFO - 'base_work_dir': '/builds/slave/test', 03:18:21 INFO - 'blob_upload_branch': 'Firefox', 03:18:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:18:21 INFO - 'branch': 'Firefox', 03:18:21 INFO - 'buildbot_json_path': 'buildprops.json', 03:18:21 INFO - 'code_coverage': False, 03:18:21 INFO - 'config_files': ('talos/linux_config.py',), 03:18:21 INFO - 'default_actions': ('clobber', 03:18:21 INFO - 'read-buildbot-config', 03:18:21 INFO - 'download-and-extract', 03:18:21 INFO - 'populate-webroot', 03:18:21 INFO - 'create-virtualenv', 03:18:21 INFO - 'install', 03:18:21 INFO - 'setup-mitmproxy', 03:18:21 INFO - 'run-tests'), 03:18:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:18:21 INFO - 'disable_ccov_upload': False, 03:18:21 INFO - 'download_minidump_stackwalk': True, 03:18:21 INFO - 'download_symbols': 'ondemand', 03:18:21 INFO - 'enable_stylo': False, 03:18:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:18:21 INFO - 'tooltool.py': '/tools/tooltool.py', 03:18:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:18:21 INFO - '/tools/misc-python/virtualenv.py')}, 03:18:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:18:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:18:21 INFO - 'gecko_profile': False, 03:18:21 INFO - 'gecko_profile_interval': 0, 03:18:21 INFO - 'installer_path': 'installer.exe', 03:18:21 INFO - 'log_level': 'info', 03:18:21 INFO - 'log_name': 'talos', 03:18:21 INFO - 'log_to_console': True, 03:18:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:18:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:18:21 INFO - 'opt_config_files': (), 03:18:21 INFO - 'pip_index': False, 03:18:21 INFO - 'suite': 'dromaeojs-e10s', 03:18:21 INFO - 'system_bits': '32', 03:18:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:18:21 INFO - 'title': 'talos-linux64-ix-006', 03:18:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:18:21 INFO - 'use_talos_json': True, 03:18:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:18:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:18:21 INFO - 'work_dir': 'build'} 03:18:21 INFO - [mozharness: 2017-08-01 10:18:21.265819Z] Running clobber step. 03:18:21 INFO - Running pre-action listener: _resource_record_pre_action 03:18:21 INFO - Running main action method: clobber 03:18:21 INFO - rmtree: /builds/slave/test/build 03:18:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:18:22 INFO - Running post-action listener: _resource_record_post_action 03:18:22 INFO - [mozharness: 2017-08-01 10:18:22.243790Z] Finished clobber step (success) 03:18:22 INFO - [mozharness: 2017-08-01 10:18:22.243894Z] Running read-buildbot-config step. 03:18:22 INFO - Running pre-action listener: _resource_record_pre_action 03:18:22 INFO - Running main action method: read_buildbot_config 03:18:22 INFO - Using buildbot properties: 03:18:22 INFO - { 03:18:22 INFO - "project": "", 03:18:22 INFO - "product": "firefox", 03:18:22 INFO - "who": "archaeopteryx@coole-files.de", 03:18:22 INFO - "installer_path": "public/build/target.tar.bz2", 03:18:22 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 03:18:22 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:18:22 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 03:18:22 INFO - "stage_platform": "linux64-stylosequential", 03:18:22 INFO - "basedir": "/builds/slave/test", 03:18:22 INFO - "buildnumber": 164, 03:18:22 INFO - "platform": "ubuntu64_hw_styloseq", 03:18:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:18:22 INFO - "slavebuilddir": "test", 03:18:22 INFO - "taskId": "YSkLr_7eTNuhsZsJnCZctQ", 03:18:22 INFO - "branch": "mozilla-central", 03:18:22 INFO - "script_repo_revision": "production", 03:18:22 INFO - "revision": "51ffb9283f0c7c00e08eb8c39b33fbee218c370d", 03:18:22 INFO - "slavename": "talos-linux64-ix-006", 03:18:22 INFO - "repo_path": "mozilla-central" 03:18:22 INFO - } 03:18:22 INFO - Finding installer, test and symbols from parent task. 03:18:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YSkLr_7eTNuhsZsJnCZctQ'}, attempt #1 03:18:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YSkLr_7eTNuhsZsJnCZctQ'}, attempt #1 03:18:23 INFO - Task dependencies: JhuDbI3YQeS1KwM6F3P5lg 03:18:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg'}, attempt #1 03:18:23 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2 03:18:23 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.test_packages.json 03:18:23 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.crashreporter-symbols.zip 03:18:23 INFO - Running post-action listener: _resource_record_post_action 03:18:23 INFO - [mozharness: 2017-08-01 10:18:23.639856Z] Finished read-buildbot-config step (success) 03:18:23 INFO - [mozharness: 2017-08-01 10:18:23.640078Z] Running download-and-extract step. 03:18:23 INFO - Running pre-action listener: _resource_record_pre_action 03:18:23 INFO - Running main action method: download_and_extract 03:18:23 INFO - mkdir: /builds/slave/test/build/tests 03:18:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:23 INFO - trying https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.test_packages.json 03:18:23 INFO - Downloading https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:18:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:18:24 INFO - Downloaded 989 bytes. 03:18:24 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:18:24 INFO - Using the following test package requirements: 03:18:24 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:18:24 INFO - u'common': [u'target.common.tests.zip'], 03:18:24 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:18:24 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:18:24 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:18:24 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:18:24 INFO - u'mozbase': [u'target.common.tests.zip'], 03:18:24 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:18:24 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:18:24 INFO - u'web-platform': [u'target.common.tests.zip', 03:18:24 INFO - u'target.web-platform.tests.tar.gz'], 03:18:24 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:18:24 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:18:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.common.tests.zip 03:18:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:18:24 INFO - Fetch https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.common.tests.zip into memory 03:18:26 INFO - Content-Length response header: 72390374 03:18:26 INFO - Bytes received: 72390374 03:18:37 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:18:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.common.tests.zip 03:18:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:18:37 INFO - Fetch https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.common.tests.zip into memory 03:18:38 INFO - Content-Length response header: 72390374 03:18:38 INFO - Bytes received: 72390374 03:18:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.talos.tests.zip 03:18:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:18:52 INFO - Fetch https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.talos.tests.zip into memory 03:18:53 INFO - Content-Length response header: 14496467 03:18:53 INFO - Bytes received: 14496467 03:18: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:18:53 INFO - trying https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2 03:18:53 INFO - Downloading https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:18:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:18:54 INFO - Downloaded 62292244 bytes. 03:18:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2 03:18:54 INFO - mkdir: /builds/slave/test/properties 03:18:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:18:54 INFO - Writing to file /builds/slave/test/properties/build_url 03:18:54 INFO - Contents: 03:18:54 INFO - build_url:https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2 03:18:54 INFO - Running post-action listener: _resource_record_post_action 03:18:54 INFO - Running post-action listener: set_extra_try_arguments 03:18:54 INFO - [mozharness: 2017-08-01 10:18:54.390084Z] Finished download-and-extract step (success) 03:18:54 INFO - [mozharness: 2017-08-01 10:18:54.390182Z] Running populate-webroot step. 03:18:54 INFO - Running pre-action listener: _resource_record_pre_action 03:18:54 INFO - Running main action method: populate_webroot 03:18:54 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:18:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:18:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:18:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:18:54 INFO - 'tests': ['damp', 'tps']}, 03:18:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:18:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:18:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:18:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:18:54 INFO - 'other-e10s': {'tests': ['a11yr', 03:18:54 INFO - 'ts_paint', 03:18:54 INFO - 'tpaint', 03:18:54 INFO - 'sessionrestore', 03:18:54 INFO - 'sessionrestore_many_windows', 03:18:54 INFO - 'sessionrestore_no_auto_restore', 03:18:54 INFO - 'tabpaint']}, 03:18:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:18:54 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:18:54 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:18:54 INFO - 'talos_options': ['--mitmproxy', 03:18:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:18:54 INFO - '--firstNonBlankPaint'], 03:18:54 INFO - 'tests': ['quantum_pageload_google', 03:18:54 INFO - 'quantum_pageload_youtube', 03:18:54 INFO - 'quantum_pageload_amazon', 03:18:54 INFO - 'quantum_pageload_facebook']}, 03:18:54 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:18:54 INFO - 'talos_options': ['--stylo', 03:18:54 INFO - '--mitmproxy', 03:18:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:18:54 INFO - '--firstNonBlankPaint'], 03:18:54 INFO - 'tests': ['quantum_pageload_google', 03:18:54 INFO - 'quantum_pageload_youtube', 03:18:54 INFO - 'quantum_pageload_amazon', 03:18:54 INFO - 'quantum_pageload_facebook']}, 03:18:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:18:54 INFO - 'tsvgr_opacity', 03:18:54 INFO - 'tart', 03:18:54 INFO - 'tscrollx', 03:18:54 INFO - 'cart', 03:18:54 INFO - 'tsvg_static']}, 03:18:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:18:54 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:18:54 INFO - 'talos_options': ['--stylo', 03:18:54 INFO - '--stylo-threads=1', 03:18:54 INFO - '--mitmproxy', 03:18:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:18:54 INFO - '--firstNonBlankPaint'], 03:18:54 INFO - 'tests': ['tp6_google', 03:18:54 INFO - 'tp6_youtube', 03:18:54 INFO - 'tp6_amazon', 03:18:54 INFO - 'tp6_facebook']}, 03:18:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:18:54 INFO - 'talos_options': ['--xperf_path', 03:18:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:54 INFO - 'tests': ['tp5n']}}} 03:18:54 INFO - Running post-action listener: _resource_record_post_action 03:18:54 INFO - [mozharness: 2017-08-01 10:18:54.398886Z] Finished populate-webroot step (success) 03:18:54 INFO - [mozharness: 2017-08-01 10:18:54.398977Z] Running create-virtualenv step. 03:18:54 INFO - Running pre-action listener: _resource_record_pre_action 03:18:54 INFO - Running main action method: create_virtualenv 03:18:54 INFO - Creating virtualenv /builds/slave/test/build/venv 03:18:54 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:18:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:18:54 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:18:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:18:54 INFO - Using real prefix '/usr' 03:18:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:18:55 INFO - Installing distribute.............................................................................................................................................................................................done. 03:18:57 INFO - Installing pip.................done. 03:18:57 INFO - Return code: 0 03:18:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:18:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:18:57 INFO - Reading from file tmpfile_stdout 03:18:57 INFO - Output received: 03:18:57 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:18:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1083d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080eb0>, '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 0x1081db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501582597.971302-2044522211', '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:18:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:18:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:18:57 INFO - Using env: {'DISPLAY': ':0', 03:18:57 INFO - 'HOME': '/home/cltbld', 03:18:57 INFO - 'LANG': 'en_US.UTF-8', 03:18:57 INFO - 'LANGUAGE': 'en_US:en', 03:18:57 INFO - 'LOGNAME': 'cltbld', 03:18:57 INFO - 'MAIL': '/var/mail/cltbld', 03:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:57 INFO - 'MOZ_NO_REMOTE': '1', 03:18:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:57 INFO - 'NO_EM_RESTART': '1', 03:18:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:57 INFO - 'PWD': '/builds/slave/test', 03:18:57 INFO - 'SHELL': '/bin/bash', 03:18:57 INFO - 'SHLVL': '1', 03:18:57 INFO - 'TERM': 'linux', 03:18:57 INFO - 'TMOUT': '86400', 03:18:57 INFO - 'USER': 'cltbld', 03:18:57 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501582597.971302-2044522211', 03:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:57 INFO - '_': '/tools/buildbot/bin/python'} 03:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:57 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:18:57 INFO - Cleaning up... 03:18:57 INFO - Return code: 0 03:18:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1083d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080eb0>, '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 0x1081db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501582597.971302-2044522211', '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:18:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:18:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:18:57 INFO - Using env: {'DISPLAY': ':0', 03:18:57 INFO - 'HOME': '/home/cltbld', 03:18:57 INFO - 'LANG': 'en_US.UTF-8', 03:18:57 INFO - 'LANGUAGE': 'en_US:en', 03:18:57 INFO - 'LOGNAME': 'cltbld', 03:18:57 INFO - 'MAIL': '/var/mail/cltbld', 03:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:57 INFO - 'MOZ_NO_REMOTE': '1', 03:18:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:57 INFO - 'NO_EM_RESTART': '1', 03:18:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:57 INFO - 'PWD': '/builds/slave/test', 03:18:57 INFO - 'SHELL': '/bin/bash', 03:18:57 INFO - 'SHLVL': '1', 03:18:57 INFO - 'TERM': 'linux', 03:18:57 INFO - 'TMOUT': '86400', 03:18:57 INFO - 'USER': 'cltbld', 03:18:57 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501582597.971302-2044522211', 03:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:57 INFO - '_': '/tools/buildbot/bin/python'} 03:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:57 INFO - Downloading/unpacking psutil>=3.1.1 03:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:18:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:59 INFO - Installing collected packages: psutil 03:18:59 INFO - Running setup.py install for psutil 03:18:59 INFO - building 'psutil._psutil_linux' extension 03:18:59 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:19:00 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:19:00 INFO - building 'psutil._psutil_posix' extension 03:19:00 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:19:00 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:19:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:19:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:19:00 INFO - Successfully installed psutil 03:19:00 INFO - Cleaning up... 03:19:00 INFO - Return code: 0 03:19:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:19:00 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:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:00 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:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:00 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 0xd141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1083d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080eb0>, '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 0x1081db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501582597.971302-2044522211', '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:19:00 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:19:00 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:19:00 INFO - Using env: {'DISPLAY': ':0', 03:19:00 INFO - 'HOME': '/home/cltbld', 03:19:00 INFO - 'LANG': 'en_US.UTF-8', 03:19:00 INFO - 'LANGUAGE': 'en_US:en', 03:19:00 INFO - 'LOGNAME': 'cltbld', 03:19:00 INFO - 'MAIL': '/var/mail/cltbld', 03:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:00 INFO - 'MOZ_NO_REMOTE': '1', 03:19:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:00 INFO - 'NO_EM_RESTART': '1', 03:19:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:00 INFO - 'PWD': '/builds/slave/test', 03:19:00 INFO - 'SHELL': '/bin/bash', 03:19:00 INFO - 'SHLVL': '1', 03:19:00 INFO - 'TERM': 'linux', 03:19:00 INFO - 'TMOUT': '86400', 03:19:00 INFO - 'USER': 'cltbld', 03:19:00 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501582597.971302-2044522211', 03:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:00 INFO - '_': '/tools/buildbot/bin/python'} 03:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:19:00 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:19:00 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:19:00 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:19:00 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:19:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:19:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:19:02 INFO - Installing collected packages: mozsystemmonitor 03:19:02 INFO - Running setup.py install for mozsystemmonitor 03:19:02 INFO - Successfully installed mozsystemmonitor 03:19:02 INFO - Cleaning up... 03:19:02 INFO - Return code: 0 03:19:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1083d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080eb0>, '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 0x1081db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501582597.971302-2044522211', '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:19:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:19:02 INFO - Using env: {'DISPLAY': ':0', 03:19:02 INFO - 'HOME': '/home/cltbld', 03:19:02 INFO - 'LANG': 'en_US.UTF-8', 03:19:02 INFO - 'LANGUAGE': 'en_US:en', 03:19:02 INFO - 'LOGNAME': 'cltbld', 03:19:02 INFO - 'MAIL': '/var/mail/cltbld', 03:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:02 INFO - 'MOZ_NO_REMOTE': '1', 03:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:02 INFO - 'NO_EM_RESTART': '1', 03:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:02 INFO - 'PWD': '/builds/slave/test', 03:19:02 INFO - 'SHELL': '/bin/bash', 03:19:02 INFO - 'SHLVL': '1', 03:19:02 INFO - 'TERM': 'linux', 03:19:02 INFO - 'TMOUT': '86400', 03:19:02 INFO - 'USER': 'cltbld', 03:19:02 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501582597.971302-2044522211', 03:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:02 INFO - '_': '/tools/buildbot/bin/python'} 03:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:02 INFO - Downloading/unpacking jsonschema==2.5.1 03:19:02 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:19:02 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:19:02 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:19:02 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:19:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:19:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:03 INFO - Downloading functools32-3.2.3-2.tar.gz 03:19:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:19:03 INFO - warning: no files found matching '*.txt' 03:19:03 INFO - no previously-included directories found matching 'build' 03:19:03 INFO - no previously-included directories found matching 'dist' 03:19:03 INFO - no previously-included directories found matching '.git*' 03:19:03 INFO - Installing collected packages: jsonschema, functools32 03:19:03 INFO - Running setup.py install for functools32 03:19:03 INFO - warning: no files found matching '*.txt' 03:19:03 INFO - no previously-included directories found matching 'build' 03:19:03 INFO - no previously-included directories found matching 'dist' 03:19:03 INFO - no previously-included directories found matching '.git*' 03:19:03 INFO - Successfully installed jsonschema functools32 03:19:03 INFO - Cleaning up... 03:19:03 INFO - Return code: 0 03:19:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1083d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080eb0>, '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 0x1081db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501582597.971302-2044522211', '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:19:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:19:03 INFO - Using env: {'DISPLAY': ':0', 03:19:03 INFO - 'HOME': '/home/cltbld', 03:19:03 INFO - 'LANG': 'en_US.UTF-8', 03:19:03 INFO - 'LANGUAGE': 'en_US:en', 03:19:03 INFO - 'LOGNAME': 'cltbld', 03:19:03 INFO - 'MAIL': '/var/mail/cltbld', 03:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:03 INFO - 'MOZ_NO_REMOTE': '1', 03:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:03 INFO - 'NO_EM_RESTART': '1', 03:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:03 INFO - 'PWD': '/builds/slave/test', 03:19:03 INFO - 'SHELL': '/bin/bash', 03:19:03 INFO - 'SHLVL': '1', 03:19:03 INFO - 'TERM': 'linux', 03:19:03 INFO - 'TMOUT': '86400', 03:19:03 INFO - 'USER': 'cltbld', 03:19:03 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501582597.971302-2044522211', 03:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:03 INFO - '_': '/tools/buildbot/bin/python'} 03:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:19:04 INFO - Cleaning up... 03:19:04 INFO - Return code: 0 03:19:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:19:04 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:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:04 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:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:04 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 0xd141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1083d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080eb0>, '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 0x1081db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501582597.971302-2044522211', '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:19:04 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:19:04 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:19:04 INFO - Using env: {'DISPLAY': ':0', 03:19:04 INFO - 'HOME': '/home/cltbld', 03:19:04 INFO - 'LANG': 'en_US.UTF-8', 03:19:04 INFO - 'LANGUAGE': 'en_US:en', 03:19:04 INFO - 'LOGNAME': 'cltbld', 03:19:04 INFO - 'MAIL': '/var/mail/cltbld', 03:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:04 INFO - 'MOZ_NO_REMOTE': '1', 03:19:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:04 INFO - 'NO_EM_RESTART': '1', 03:19:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:04 INFO - 'PWD': '/builds/slave/test', 03:19:04 INFO - 'SHELL': '/bin/bash', 03:19:04 INFO - 'SHLVL': '1', 03:19:04 INFO - 'TERM': 'linux', 03:19:04 INFO - 'TMOUT': '86400', 03:19:04 INFO - 'USER': 'cltbld', 03:19:04 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501582597.971302-2044522211', 03:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:04 INFO - '_': '/tools/buildbot/bin/python'} 03:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:04 INFO - Downloading/unpacking blobuploader==1.2.4 03:19:04 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:19:04 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:19:04 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:19:04 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:19:05 INFO - Downloading blobuploader-1.2.4.tar.gz 03:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:19:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:19:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:05 INFO - Downloading docopt-0.6.1.tar.gz 03:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:19:05 INFO - Installing collected packages: blobuploader, requests, docopt 03:19:05 INFO - Running setup.py install for blobuploader 03:19:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:19:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:19:06 INFO - Running setup.py install for requests 03:19:06 INFO - Running setup.py install for docopt 03:19:06 INFO - Successfully installed blobuploader requests docopt 03:19:06 INFO - Cleaning up... 03:19:06 INFO - Return code: 0 03:19:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:06 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 0xd141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1083d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080eb0>, '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 0x1081db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501582597.971302-2044522211', '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:19:06 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:19:06 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:19:06 INFO - Using env: {'DISPLAY': ':0', 03:19:06 INFO - 'HOME': '/home/cltbld', 03:19:06 INFO - 'LANG': 'en_US.UTF-8', 03:19:06 INFO - 'LANGUAGE': 'en_US:en', 03:19:06 INFO - 'LOGNAME': 'cltbld', 03:19:06 INFO - 'MAIL': '/var/mail/cltbld', 03:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:06 INFO - 'MOZ_NO_REMOTE': '1', 03:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:06 INFO - 'NO_EM_RESTART': '1', 03:19:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:06 INFO - 'PWD': '/builds/slave/test', 03:19:06 INFO - 'SHELL': '/bin/bash', 03:19:06 INFO - 'SHLVL': '1', 03:19:06 INFO - 'TERM': 'linux', 03:19:06 INFO - 'TMOUT': '86400', 03:19:06 INFO - 'USER': 'cltbld', 03:19:06 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501582597.971302-2044522211', 03:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:06 INFO - '_': '/tools/buildbot/bin/python'} 03:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:19:06 INFO - Running setup.py (path:/tmp/pip-h_pnnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:19:06 INFO - Running setup.py (path:/tmp/pip-vAsDbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:19:06 INFO - Running setup.py (path:/tmp/pip-KbZRM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:19:07 INFO - Running setup.py (path:/tmp/pip-yXipJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:19:07 INFO - Running setup.py (path:/tmp/pip-LSN3DK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:19:07 INFO - Running setup.py (path:/tmp/pip-3CUuu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:19:07 INFO - Running setup.py (path:/tmp/pip-HbtwhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:19:07 INFO - Running setup.py (path:/tmp/pip-myv_TM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:19:07 INFO - Running setup.py (path:/tmp/pip-Ww4tZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:19:07 INFO - Running setup.py (path:/tmp/pip-RqEbcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:19:07 INFO - Running setup.py (path:/tmp/pip-F3efi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:19:07 INFO - Running setup.py (path:/tmp/pip-GlC_K0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:19:07 INFO - Running setup.py (path:/tmp/pip-Yp5SWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:19:07 INFO - Running setup.py (path:/tmp/pip-9kzIjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:07 INFO - Running setup.py (path:/tmp/pip-quvecz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:19:07 INFO - Running setup.py (path:/tmp/pip-1_THAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:19:07 INFO - Running setup.py (path:/tmp/pip-DSuLSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:19:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:19:08 INFO - Running setup.py install for manifestparser 03:19:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:19:08 INFO - Running setup.py install for mozcrash 03:19:08 INFO - Running setup.py install for mozdebug 03:19:08 INFO - Running setup.py install for mozdevice 03:19:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:19:08 INFO - Running setup.py install for mozfile 03:19:08 INFO - Running setup.py install for mozhttpd 03:19:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:19:08 INFO - Running setup.py install for mozinfo 03:19:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:19:08 INFO - Running setup.py install for mozInstall 03:19:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:19:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:19:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:19:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:19:08 INFO - Running setup.py install for mozleak 03:19:08 INFO - Running setup.py install for mozlog 03:19:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:19:09 INFO - Running setup.py install for moznetwork 03:19:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:19:09 INFO - Running setup.py install for mozprocess 03:19:09 INFO - Running setup.py install for mozprofile 03:19:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:19:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:19:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:19:09 INFO - Running setup.py install for mozrunner 03:19:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:19:09 INFO - Running setup.py install for mozscreenshot 03:19:09 INFO - Running setup.py install for moztest 03:19:09 INFO - Running setup.py install for mozversion 03:19:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:19:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:19:09 INFO - Cleaning up... 03:19:09 INFO - Return code: 0 03:19:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19:09 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:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:09 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:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:09 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 0xd141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1083d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080eb0>, '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 0x1081db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501582597.971302-2044522211', '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:19:09 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:19:09 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:19:09 INFO - Using env: {'DISPLAY': ':0', 03:19:09 INFO - 'HOME': '/home/cltbld', 03:19:09 INFO - 'LANG': 'en_US.UTF-8', 03:19:09 INFO - 'LANGUAGE': 'en_US:en', 03:19:09 INFO - 'LOGNAME': 'cltbld', 03:19:09 INFO - 'MAIL': '/var/mail/cltbld', 03:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:09 INFO - 'MOZ_NO_REMOTE': '1', 03:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:09 INFO - 'NO_EM_RESTART': '1', 03:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:09 INFO - 'PWD': '/builds/slave/test', 03:19:09 INFO - 'SHELL': '/bin/bash', 03:19:09 INFO - 'SHLVL': '1', 03:19:09 INFO - 'TERM': 'linux', 03:19:09 INFO - 'TMOUT': '86400', 03:19:09 INFO - 'USER': 'cltbld', 03:19:09 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501582597.971302-2044522211', 03:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:09 INFO - '_': '/tools/buildbot/bin/python'} 03:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:19:10 INFO - Running setup.py (path:/tmp/pip-nQag6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:19:10 INFO - Running setup.py (path:/tmp/pip-6zmSmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:19:10 INFO - Running setup.py (path:/tmp/pip-tTPDAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:19:10 INFO - Running setup.py (path:/tmp/pip-qpCgGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:19:10 INFO - Running setup.py (path:/tmp/pip-hEfube-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:19:10 INFO - Running setup.py (path:/tmp/pip-mMQBeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:19:10 INFO - Running setup.py (path:/tmp/pip-4HUPXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:19:10 INFO - Running setup.py (path:/tmp/pip-AV7jR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:19:10 INFO - Running setup.py (path:/tmp/pip-iqDywZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:19:10 INFO - Running setup.py (path:/tmp/pip-XJRw5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:19:10 INFO - Running setup.py (path:/tmp/pip-HD6vYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:19:10 INFO - Running setup.py (path:/tmp/pip-VwJrZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:19:10 INFO - Running setup.py (path:/tmp/pip-JmnT8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:19:10 INFO - Running setup.py (path:/tmp/pip-Jxpyp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:19:11 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:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:11 INFO - Running setup.py (path:/tmp/pip-7WELpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:11 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:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:19:11 INFO - Running setup.py (path:/tmp/pip-hu6X7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:19:11 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:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:19:11 INFO - Running setup.py (path:/tmp/pip-vkjfBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:19:11 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:19:11 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:19:11 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:19:11 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:19:11 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:19:11 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:19:11 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:19:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:12 INFO - Downloading blessings-1.6.tar.gz 03:19:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:19:12 INFO - Installing collected packages: blessings 03:19:12 INFO - Running setup.py install for blessings 03:19:12 INFO - Successfully installed blessings 03:19:12 INFO - Cleaning up... 03:19:12 INFO - Return code: 0 03:19:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:19:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:19:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:19:12 INFO - Reading from file tmpfile_stdout 03:19:12 INFO - Current package versions: 03:19:12 INFO - argparse == 1.2.1 03:19:12 INFO - blessings == 1.6 03:19:12 INFO - blobuploader == 1.2.4 03:19:12 INFO - docopt == 0.6.1 03:19:12 INFO - functools32 == 3.2.3-2 03:19:12 INFO - jsonschema == 2.5.1 03:19:12 INFO - manifestparser == 1.1 03:19:12 INFO - mozInstall == 1.13 03:19:12 INFO - mozcrash == 1.0 03:19:12 INFO - mozdebug == 0.1 03:19:12 INFO - mozdevice == 0.51 03:19:12 INFO - mozfile == 1.2 03:19:12 INFO - mozhttpd == 0.7 03:19:12 INFO - mozinfo == 0.10 03:19:12 INFO - mozleak == 0.1 03:19:12 INFO - mozlog == 3.5 03:19:12 INFO - moznetwork == 0.27 03:19:12 INFO - mozprocess == 0.25 03:19:12 INFO - mozprofile == 0.28 03:19:12 INFO - mozrunner == 6.13 03:19:12 INFO - mozscreenshot == 0.1 03:19:12 INFO - mozsystemmonitor == 0.3 03:19:12 INFO - moztest == 0.8 03:19:12 INFO - mozversion == 1.4 03:19:12 INFO - psutil == 3.1.1 03:19:12 INFO - requests == 1.2.3 03:19:12 INFO - wsgiref == 0.1.2 03:19:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19: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:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19: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:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:12 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 0xd141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1083d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080eb0>, '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 0x1081db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501582597.971302-2044522211', '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:19:12 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:19:12 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:19:12 INFO - Using env: {'DISPLAY': ':0', 03:19:12 INFO - 'HOME': '/home/cltbld', 03:19:12 INFO - 'LANG': 'en_US.UTF-8', 03:19:12 INFO - 'LANGUAGE': 'en_US:en', 03:19:12 INFO - 'LOGNAME': 'cltbld', 03:19:12 INFO - 'MAIL': '/var/mail/cltbld', 03:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:12 INFO - 'MOZ_NO_REMOTE': '1', 03:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:12 INFO - 'NO_EM_RESTART': '1', 03:19:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:12 INFO - 'PWD': '/builds/slave/test', 03:19:12 INFO - 'SHELL': '/bin/bash', 03:19:12 INFO - 'SHLVL': '1', 03:19:12 INFO - 'TERM': 'linux', 03:19:12 INFO - 'TMOUT': '86400', 03:19:12 INFO - 'USER': 'cltbld', 03:19:12 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501582597.971302-2044522211', 03:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:12 INFO - '_': '/tools/buildbot/bin/python'} 03:19:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:13 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:19:13 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:19:13 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:19:13 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:19:13 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:19:13 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:19:13 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:19:13 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:19:13 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:19:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:19:14 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:19:14 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:19:14 INFO - Installing collected packages: simplejson 03:19:14 INFO - Running setup.py install for simplejson 03:19:14 INFO - building 'simplejson._speedups' extension 03:19:14 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:19:15 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:19:15 INFO - Successfully installed simplejson 03:19:15 INFO - Cleaning up... 03:19:15 INFO - Return code: 0 03:19:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:15 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 0xd141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1083d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080eb0>, '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 0x1081db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501582597.971302-2044522211', '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:19:15 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:19:15 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:19:15 INFO - Using env: {'DISPLAY': ':0', 03:19:15 INFO - 'HOME': '/home/cltbld', 03:19:15 INFO - 'LANG': 'en_US.UTF-8', 03:19:15 INFO - 'LANGUAGE': 'en_US:en', 03:19:15 INFO - 'LOGNAME': 'cltbld', 03:19:15 INFO - 'MAIL': '/var/mail/cltbld', 03:19:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:15 INFO - 'MOZ_NO_REMOTE': '1', 03:19:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:15 INFO - 'NO_EM_RESTART': '1', 03:19:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:15 INFO - 'PWD': '/builds/slave/test', 03:19:15 INFO - 'SHELL': '/bin/bash', 03:19:15 INFO - 'SHLVL': '1', 03:19:15 INFO - 'TERM': 'linux', 03:19:15 INFO - 'TMOUT': '86400', 03:19:15 INFO - 'USER': 'cltbld', 03:19:15 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501582597.971302-2044522211', 03:19:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:15 INFO - '_': '/tools/buildbot/bin/python'} 03:19:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:19:15 INFO - Cleaning up... 03:19:15 INFO - Return code: 0 03:19:15 INFO - Running post-action listener: _resource_record_post_action 03:19:15 INFO - Running post-action listener: _start_resource_monitoring 03:19:15 INFO - Starting resource monitoring. 03:19:15 INFO - [mozharness: 2017-08-01 10:19:15.531132Z] Finished create-virtualenv step (success) 03:19:15 INFO - [mozharness: 2017-08-01 10:19:15.532073Z] Running install step. 03:19:15 INFO - Running pre-action listener: _resource_record_pre_action 03:19:15 INFO - Running main action method: install 03:19:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:19:15 INFO - Reading from file tmpfile_stdout 03:19:15 INFO - Detecting whether we're running mozinstall >=1.0... 03:19:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:19:15 INFO - Reading from file tmpfile_stdout 03:19:15 INFO - Output received: 03:19:15 INFO - Usage: mozinstall [options] installer 03:19:15 INFO - Options: 03:19:15 INFO - -h, --help show this help message and exit 03:19:15 INFO - -d DEST, --destination=DEST 03:19:15 INFO - Directory to install application into. [default: 03:19:15 INFO - "/builds/slave/test"] 03:19:15 INFO - --app=APP Application being installed. [default: firefox] 03:19:15 INFO - mkdir: /builds/slave/test/build/application 03:19:15 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:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:19:33 INFO - Reading from file tmpfile_stdout 03:19:33 INFO - Output received: 03:19:33 INFO - /builds/slave/test/build/application/firefox/firefox 03:19:33 INFO - Running post-action listener: _resource_record_post_action 03:19:33 INFO - [mozharness: 2017-08-01 10:19:33.927219Z] Finished install step (success) 03:19:33 INFO - [mozharness: 2017-08-01 10:19:33.927472Z] Running setup-mitmproxy step. 03:19:33 INFO - Running pre-action listener: _resource_record_pre_action 03:19:33 INFO - Running main action method: setup_mitmproxy 03:19:33 INFO - Skipping: mitmproxy is not required 03:19:33 INFO - Running post-action listener: _resource_record_post_action 03:19:33 INFO - [mozharness: 2017-08-01 10:19:33.928608Z] Finished setup-mitmproxy step (success) 03:19:33 INFO - [mozharness: 2017-08-01 10:19:33.928889Z] Running run-tests step. 03:19:33 INFO - Running pre-action listener: _resource_record_pre_action 03:19:33 INFO - Running pre-action listener: _set_gcov_prefix 03:19:33 INFO - Running main action method: run_tests 03:19:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:19:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:19:33 INFO - Python 2.7.3 03:19:33 INFO - Return code: 0 03:19:33 INFO - grabbing minidump binary from tooltool 03:19:33 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:19:33 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 0x1080eb0>, '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 0x1081db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:19:33 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:19:33 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:19:33 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:19:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:19:34 INFO - Return code: 0 03:19:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:19:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:19:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:19:34 INFO - ENV: RUST_BACKTRACE is now 1 03:19:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:19:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:19:34 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/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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:19:34 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/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-006 --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:19:34 INFO - Using env: {'DISPLAY': ':0', 03:19:34 INFO - 'HOME': '/home/cltbld', 03:19:34 INFO - 'LANG': 'en_US.UTF-8', 03:19:34 INFO - 'LANGUAGE': 'en_US:en', 03:19:34 INFO - 'LOGNAME': 'cltbld', 03:19:34 INFO - 'MAIL': '/var/mail/cltbld', 03:19:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:19:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:34 INFO - 'MOZ_NO_REMOTE': '1', 03:19:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:34 INFO - 'NO_EM_RESTART': '1', 03:19:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:34 INFO - 'PWD': '/builds/slave/test', 03:19:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:19:34 INFO - 'RUST_BACKTRACE': '1', 03:19:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:19:34 INFO - 'SHELL': '/bin/bash', 03:19:34 INFO - 'SHLVL': '1', 03:19:34 INFO - 'STYLO_FORCE_ENABLED': '1', 03:19:34 INFO - 'TERM': 'linux', 03:19:34 INFO - 'TMOUT': '86400', 03:19:34 INFO - 'USER': 'cltbld', 03:19:34 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501582597.971302-2044522211', 03:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:34 INFO - '_': '/tools/buildbot/bin/python'} 03:19:34 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/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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:19:34 INFO - mozversion application_buildid: 20170801092414 03:19:34 INFO - mozversion application_changeset: 51ffb9283f0c7c00e08eb8c39b33fbee218c370d 03:19:34 INFO - mozversion application_display_name: Nightly 03:19:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:19:34 INFO - mozversion application_name: Firefox 03:19:34 INFO - mozversion application_remotingname: firefox 03:19:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:19:34 INFO - mozversion application_vendor: Mozilla 03:19:34 INFO - mozversion application_version: 56.0a1 03:19:34 INFO - mozversion platform_buildid: 20170801092414 03:19:34 INFO - mozversion platform_changeset: 51ffb9283f0c7c00e08eb8c39b33fbee218c370d 03:19:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:19:34 INFO - mozversion platform_version: 56.0a1 03:19:34 INFO - using testdate: 1501582774 03:19:34 INFO - actual date: 1501582774 03:19:34 INFO - starting webserver on 'localhost:51773' 03:19:34 INFO - SUITE-START | Running 2 tests 03:19:34 INFO - TEST-START | dromaeo_css 03:19:34 INFO - Initialising browser for dromaeo_css test... 03:19:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51773/getInfo.html -profile /tmp/tmp33kCNZ/profile 03:19:34 INFO - TEST-INFO | started process 3317 (/builds/slave/test/build/application/firefox/firefox http://localhost:51773/getInfo.html) 03:19:42 INFO - TEST-INFO | 3317: exit 0 03:19:42 INFO - Browser initialized. 03:19:42 INFO - Running cycle 1/1 for dromaeo_css test... 03:19:42 INFO - TEST-INFO | started process 3545 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp33kCNZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:43 INFO - PID 3545 | 03:19:43 INFO - PID 3545 | (/builds/slave/test/build/application/firefox/firefox:3599): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:19:43 INFO - PID 3545 | 03:19:54 INFO - PID 3545 | RSS: Main: 174157824 03:19:54 INFO - PID 3545 | 03:22:54 INFO - PID 3545 | Cycle 1(1): loaded http://localhost:51773/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51773/tests/dromaeo/cssquery-ext.html) 03:22:55 INFO - PID 3545 | RSS: Main: 176259072 03:22:55 INFO - PID 3545 | 03:25:57 INFO - PID 3545 | Cycle 1(1): loaded http://localhost:51773/tests/dromaeo/cssquery-ext.html (next: http://localhost:51773/tests/dromaeo/cssquery-jquery.html) 03:25:58 INFO - PID 3545 | RSS: Main: 173867008 03:25:58 INFO - PID 3545 | 03:29:00 INFO - PID 3545 | Cycle 1(1): loaded http://localhost:51773/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51773/tests/dromaeo/cssquery-mootools.html) 03:29:00 INFO - PID 3545 | RSS: Main: 175517696 03:29:00 INFO - PID 3545 | 03:32:02 INFO - PID 3545 | Cycle 1(1): loaded http://localhost:51773/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51773/tests/dromaeo/cssquery-prototype.html) 03:32:03 INFO - PID 3545 | RSS: Main: 174247936 03:32:03 INFO - PID 3545 | 03:35:07 INFO - PID 3545 | Cycle 1(1): loaded http://localhost:51773/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51773/tests/dromaeo/cssquery-yui.html) 03:35:07 INFO - PID 3545 | RSS: Main: 178061312 03:35:07 INFO - PID 3545 | 03:38:09 INFO - PID 3545 | Cycle 1(1): loaded http://localhost:51773/tests/dromaeo/cssquery-yui.html (next: http://localhost:51773/tests/dromaeo/cssquery-dojo.html) 03:38:09 INFO - PID 3545 | RSS: Main: 178626560 03:38:09 INFO - PID 3545 | 03:38:09 INFO - PID 3545 | __start_tp_report 03:38:09 INFO - PID 3545 | _x_x_mozilla_page_load 03:38:09 INFO - PID 3545 | _x_x_mozilla_page_load_details 03:38:09 INFO - PID 3545 | |i|pagename|runs| 03:38:09 INFO - PID 3545 | |0;dojo.html;3016.125323656141;3130.326979699364;3141.403133404653;3156.6054243219605;3173.3811906678206;6094.725737341825;6240.937590624087;6245.094461303108;6269.905951410727;6298.748050077991;6049.879002419949;6200.34896335885;6208.596441231317;6211.968940155293;6227.314995350508;5622.943770562303;5641.492265696086;5718.799842005531;5768.134779783024;5860.706964651772;5672.290963629546;5735.655860648374;5761;5767;5772.393898640646;5404;5586.469285417878;5588.441155884399;5629.127485239795;5681;5591.46881046304;5599.272094627713;5669.603127781057;5671.149327600851;5692.0323544997445;5498.917516237259;5579.13523403873;5600.635958662674;5617.241672374218;5645.350784659776;6047.455728984412;6086.695665216722;6091.634501929854;6123.357047510036;6123.540734444934;6567.605943643397;6573.671316434159;6589.374009469093;6591.93408065918;6608.107905432753;6638.203415590112;6645.3354664533645;6650.235222949326;6675.399214070709;6679.298673639247;6110.847228819271;6164.167837341946;6166.260048794174;6173.382661733835;6194.690265486708;6788.558743681645;6797.558158719767;6825.590464572141;6831.28271531482;6832.180138383425;6462.32145624712;6465.741370345228;6477.222733272038;6480.416762491398;6508.219013718384;6628.072069910217;6632.403083722488;6645.136132302867;6728.899066514006;6747.898781518281;6509.837254068686;6582.8354291143105;6591.967040164768;6653.600783952978;6669.299723529057;6579.30917253691;6629.801105966829;6683.897156969143;6689.565178263398;6690.431313338323;5372.462753724596;5391.757370918318;5395.81114660985;5402.621816472888;5402.729863506887;4613.607843333354;4652.837150699709;4653.371794807726;4693;4696.694714843524;5671.716414179357;5746.080627099644;5747.827565173052;5797.826065218051;5836.299644042657;6519.641419721961;6625.569337993112;6664.600123992576;6735.831604209934;6755.324467553303;5738.483536481736;5746.712664366765;5772;5787.739551720183;5789.189513468118;4909.189983652657;5831.271091113611;5854.18041474194;5863;5921.171036054956;6428.485721142204;6443.130177426081;6515.446187074152;6517.185351831021;6532.738690452424;6495.642739649365;6566.8358291043105;6617.272100069084;6723.596584204964;6727.8990815138795;6468.8059358219325;6482.546221764431;6505.121808555785;6507.414332710079;6518.2178138621775;6518.445932095636;6628.867422651617;6637.6349300788925;6638.701258443478;6655.500837437115;6656.7670131545165;6734.158230221223;6765.830854228684;6768.424683901923;6775.1531058617675;6432;6445.774397896051;6535.379138981789;6541.182352205974;6541.70562324706;6350.841228969312;6440.4525615321345;6453.128827608213;6453.9354606453335;6460.483161346987;6427.517936154713;6456.225252969673;6472.482201423969;6500.3174666659315;6509.1863517060365;6489.772857949949;6498.0252962056065;6546.574472659262;6577.276499585138;6585.703643336157;6109.602875813058;6223.533235007483;6241.063840423973;6251.562390632612;6276.937230627818 03:38:09 INFO - PID 3545 | |1;ext.html;807.7011505742876;881.2245224202701;903.9276857851372;908.5548081440096;1133.6995696140518;29395.706042939564;29938.1018569443;39971.80014099926;40329;40331.59668403315;40704.38943415844;41154.58845411545;41166.794166029205;41274.38088428676;41321.793391033;6845.965770171142;7274.381677557414;7354.1542722587055;7437.553746775197;7564.054493188351;7353.301436363537;7360.668769905367;7445.7766267012075;7449.068866391701;7452.329290363866;7413.703451861919;7424.9257507425045;7440.218777028415;7464.477486575942;7465.029546158992;7385.519941203805;7476.177620461772;7476.850462990764;7477.588732619676;7483.588402637853;7417.369523590502;7432.777016689508;7462.067241594801;7469.775906722753;7479.139898911641;36903.44644830329;37047.629523704956;37068;37118;37149.95675237861;3452.8100954447495;3493.0568746438576;3501.404761190578;3504.439289713659;3513.7189024878203;30073.248168795737;30400.39199216003;30462.390752185052;30624.846875765477;30640.84679576588;4585.119222039594;4659;4733.9763301183275;4764.833230836939;4831.903361932742;188065;189418;190464;190715.9999999986;191596;46595;46812.7659361701;48115.27827082597;48295.27557086646;48445;48363.758181209574;48370.758146209744;48372;48544.27183592249;48549.51450485521;16064.196790160446;16085.839141608434;16181.838181618268;16229.2696828643;16344.182790860646;10767.3539587625;10797.29817561856;10812.405317707602;13259.469621215236;13438.126521776054;13851.16892986424;14081.366338514792;14209.573712788633;14292.21392823384;14321;5570.6657600544095;5739.253896993364;5799.449052340021;5812.564057695689;5822.505087067647;983.695054533097;984.6356847966298;986.4032260482305;1015.1777060580953;1016.0956748493846;22347.217847375265;22606;22733.43166420853;23067.884660576925;23368.766312337;1083.6965649618119;1095.5234473004268;1109.4230999880178;1116.330201878866;1124.2130508643982;11945.462454189583;12088.032957363566;12139.939300303442;12149.939250303692;12153.08851836098;218506;219911;220909;221057;221816;50716.746416267684;50940.74529627402;51304.69128889209;51474.48525514697;51516.48483515192;1425.1164278147614;1464.4581504843277;1474.3881289264834;1475.254996226877;1477.963050923714;20939.685904711747;21215.68176477323;21571.78428215698;22466.5506689862;22627.43431414228;35435.46846797249;35635;35801.82099089488;35810;35915.28169436649;186322;187300;189013;189714;189811;33016.50475242922;33385.33229335351;34755.30489390148;36289;36527.08682282964;44270.11459770851;44723.10553788971;44733.55266447294;45219.321710175034;45250.77374613106;29404;29790;32024.51963220507;32116;32549.18627034343;30654.846725766227;31461.213469663442;32194.35611287808;32443.513347299337;32570.34859302753;36651.816740916125;36801.26397472089;36802.63197368099;36828;37698.43452348162;30440.543391848696;33206;33261.50107748337;33341.499877501374;33557;24159.396015099763;24489.38776530601;24655.87672061628;25215.991360346114;25243.87378063098 03:38:09 INFO - PID 3545 | |2;jquery.html;571.7455732199173;581.4853854338909;584.6725833533225;595.5235811350918;596.5823923253722;21716.565668686617;22359.10563577457;22444.775552244515;22528.436789080282;22854.428639284026;22613.208537701183;22962.65556016661;22976.425589360275;23164.65253021206;23226.419339516477;6423.293437721847;6555.0495178199135;6584.769533066344;6586.934130658704;6587.769428070019;5742.770289188427;6302.14920985668;6305.684715764216;6316.30520642729;6474.514411419139;6282.465990390822;6329.05064240363;6329.335419780903;6329.873402531946;6330.525210609199;6325.778597749079;6328.588641738273;6329.746810127589;6330.240371155468;6333.809985700436;5865.736041878125;5885.323187833411;5887.970560147171;5902.026165682657;5906.409359064102;28176.436471270667;28934;29486.41027179466;29679.851600742073;30146.397072058655;1874.1285302334343;1877.7840548336842;1879.6052828905947;1901.7622797150357;1904.2858927902037;18428.262869485203;18958.14688339028;19040.809591904042;19048.238070477164;19143.425697229104;2277.2257432472875;2287.7369102553253;2312.560613483433;2313.201945328859;2384.1178763857483;131360.34319828436;135548.32225838807;137311.31344343215;137627;137818;14191.78712319316;14448.494302699355;14604.780928285873;15036.097834129987;15414;23268.06927722906;23405.063797448252;23414.64878026831;23513.529729405316;23553.175638852557;10429.895701042893;10468.63359782404;10526;10540.683779486628;10577.206709496664;9751.31740778153;9802.9019709802;9805.068518490732;9915.851262231072;9975.301728879054;7684.271039016288;8810.86783698245;8937.240334571505;9150.130737579919;9224.953875230582;2595.2992691973063;2609.3998380372623;2648.933776655599;2708.959365609478;2748.958765618517;945.0974319524837;953.7415828404553;956.6203375899373;959.3620242538634;973.3040875773855;19285.61428771417;19668;19753.209871604973;19939.401817945483;20668.06993685258;966.5980039601584;994.6817018554138;994.8408254679216;1020.0921180149672;1029.156092004564;10578.52396642153;10800.729981750363;11022.244438890277;11035.39305338214;11070.944645276722;501860;511765;515312;519669;526464;121339.39330303292;123914.14128787896;125251;126700;131261;1225.1362789233747;1233.648410203088;1256.4785613970282;1258;1265.1902782219388;20978.895105524374;21044;21044.789552104285;21642;22776.886115569316;58269.417305828094;59360.40639593549;62185.37814621796;62413;65309.34690653033;71851.64074179596;71907;72086.63956680182;72315;72535;14184.929075354557;15120.773188402403;15163.241837908281;15218.086914785148;15223.16272604973;22639.660405093608;23069.769302306762;23186.536269274857;23201.187958421375;23408.88295558511;18636.34772782946;18817.811821882155;19006.714899276245;19067.141978610718;19118.52203694863;15528.689426211638;16559.586010349838;16847.663046739242;16959.91520042392;17119.828801711825;18305.359312424534;19327.613447731248;19369.51576210606;19421.805781942567;19452.124654390303;14745.410183592536;14997.400103995718;15025.323860426526;15084.547463576111;15087.39650414015;17578;18410.35563755316;18769.624607508045;18871.716924245873;18929.148188331284 03:38:09 INFO - PID 3545 | |3;mootools.html;1345.381124682646;1365.3241645385535;1373.72525494901;1378.1455497591494;1403.130059363195;13658.248796316198;14084.788728169086;14278.500252491165;14301.713965720679;14306.07010544314;13916.721665566683;14696.926515367435;14716.779248311284;14717.116972981628;14792.852071479281;2667.613196086571;2675.2241849863517;2691.3540750219904;2706.594010898371;2711.769499592537;2548.7960963122905;2633.749793769589;2639.234621959639;2639.498495285899;2652.1778248742853;2729.604207389927;2733.3439974406097;2760.9585856212175;2764.986175069132;2765.5989881467176;2595.104688882342;2619;2632.499825033257;2649.218480548243;2701.1086341507353;2550.0692247329775;2591.948161036769;2595.610658401255;2602.466494368669;2616.973830261711;13706.657333566642;13932.58202253934;13946.51187208453;13950.511732089328;13960.232187229698;7546.471746977713;7832.29509344156;7839.686412543491;7844.411669124782;7853.293203611703;4871.318015477836;5017.573506251973;5137.5633071188995;5146.047981123466;5211.817586384496;1604.7271963766188;1625.9430919917745;1689.4255952976048;1690.0535700008036;1696.8388003139805;23060.42348941273;23395.298141055624;23485.41286467835;23485.530289394115;23490.177843775557;6347.460465860361;6482.513811464159;6519.250286217146;6676.53264271506;6709.93290067093;15765.290561924741;15990.440334588233;15999.920000399923;16000.679986400206;16013.119278439564;7285.307895749896;7419.443541734391;7424.183339832614;7433.479656423999;7439.256074392518;6778.051072849805;6798.558093723892;6843.144606924135;6852.143482064742;6914.239433662293;4983.526564976321;5124.795008199705;5164.406093299243;5180.922286165711;5181.792728290826;1505.6762795998914;1518.096732444194;1520.0651599266594;1552.2859484636967;1555.3778488604423;822.6421506644629;823.472977294532;840.2102024097329;856.1139220906332;870.7126648206076;6631.27056023837;6763.222229443579;6878.931210687829;6965.965170174117;6979;684.4182444921876;694.4028135803306;709.6203531110934;719.5754504842064;727.5052963984541;4678.906421871544;4999.800007999639;5143.948560514422;5164.25118357836;5333.919991200135;18140.727889081674;18227.362042328456;18970.525736856413;18972.525686857938;19089.331873384366;19119.617607647768;19148.329808456914;19187.520311992314;19236.422907312804;20420.0810963507;10815.621453249098;10966.561337546409;10980.945095274472;11252;11255.66233013011;7294.787297782934;7917.970663813898;8038.517688938682;8063.314618257514;8073.959630201812;16895.493135205965;17080.48758537246;17191.742123868404;17214.827851721322;17370.652586948443;16358.100304482892;17099.230534625724;17173.398931037354;17691.469255922344;17757.467275981224;11366;11571.942140289582;11573.768524629628;11607.709807254887;11625.302481851117;13230.272335021666;13334.133281336683;13365;13391.062625616503;13405.329733513481;10161.644342447978;10536.736581585521;10644.095251903365;10740.30188037775;10915.945420272848;10404.635837745642;10704.143668506345;10811.243212975016;10833.945830270799;11135.498902549567;8875.156860098281;8977.685780997634;9033;9098.818023639358;9135.360524763202;6395.872082558416;6427.421532062137;6600;6657.900131497934;6709.329067093252;6251.593646412968;6299.748010079728;6379;6478.870422591616;6569.835754106186 03:38:09 INFO - PID 3545 | |4;prototype.html;486.71924137597375;490.6331481008451;516.6331904347912;519.3741541442562;522.8065615722184;6034.939650603493;6135.545781687328;6159.661218632973;6162.350189418554;6209.9068513972325;5831.367217179186;6009.858126955886;6018.518518518508;6035.305939816923;6042.57701960863;4872.610191184705;4872.683275587093;4891.461939186686;4903.436104847935;4904.092742842586;4726.858194254178;4897.804087836482;4903.239997800329;4910.6317026223;4916.3608730864935;4787.928181077286;4798.664093513456;4801.639877009221;4811.927821082687;4820.783064762094;4808.350872632185;4825.155597770394;4835.758212089381;4843.39457567804;4845.709257444564;4261.552536983634;4308.892277693051;4312.37470566766;4328;4342.956570434319;5952.761889524457;5980.820575382702;5983.880322393571;5998.730057147439;6045.395460453919;5583.804566840141;5600.691961942091;5602.887942241173;5610.410906854803;5672.546196304327;6349.873002539969;6387.297397286295;6424.261209960868;6425.1326070980285;6505.4795616350575;4716.787744551503;4758.452777930548;4783.497732738082;4792.832250871203;4813.903721925577;6741.3258674132685;6825.180978282638;6844.93155068448;6852.177738671341;6894.896576551356;4865.56209941107;4891.144049791273;4908.803647854046;4953.430355509163;4961.5534601886;5019.698818070928;5022.4977502249485;5024.949750502448;5042.722650254272;5071.670341427795;5622.493975542221;5635.380108188096;5645.802396916089;5669.234653321749;5673.461021202979;6410.807675769641;6432.4532414744335;6495.914440640752;6509.511786616023;6513.2509761377105;1644.21077882617;1671.565392997805;1688.9831101688826;1710.6236627941832;1751.1594434671429;1182.7634473105413;1182.8048372018693;1190.2085113399664;1190.8987736042534;1204.4519743516853;5666.518345940559;5685.204071430003;5732.742026608813;5748.02283611787;5752.741126649311;6401.679916004181;6437.3029868566655;6564.179477565304;6591.209054913345;6601.603903765789;5667.291588551431;5679.971600141973;5711.143328500675;5745.712714364265;5762.069706648236;3518.238183026312;3542.0423946005376;3551.94672079919;3566.268914872445;3581.28374325136;6320.62076275425;6386.2975072741965;6448.838779030561;6465.967670161619;6494.512911531654;6735.663216839139;6767.105210541056;6820.897686534706;6823.147106611674;6837.213720422115;6384.009993753996;6429.839254018687;6436.259830119502;6442.226932768098;6458.160439142881;6446.548741588232;6556.573822701509;6571.751367240209;6667.399934005963;6729.798106056826;6401.423871851555;6541.378569035934;6577.638229897401;6593.3736295051895;6601.801945941629;6309.968450157719;6385.904211436925;6413.518986076157;6432.517561182836;6513.381228783258;4903.362562866804;4907.668857292758;4942.20924652054;4943.9505604944925;4958;6608.041833934149;6668.366505182;6685.197776266685;6710.429613482714;6738.460923126237;6426.971684530453;6458.806235812933;6491.448226900767;6500.70746816385;6529.249136349191;6453.838654033687;6463.838404039937;6465.224173099258;6466.967665161644;6498.447631951337;6027.246594175728;6270.184875966095;6299.14175318273;6314.936850631435;6334.326090867378;6219.191505104308;6300.464460520907;6336.493080553637;6376.585521941059;6462.644554549545;6125.785597504066;6168.383161683796;6257.7184026719815;6279.372062793684;6293.842653933688 03:38:09 INFO - PID 3545 | |5;yui.html;886.5655828643962;907.8411278026346;922.8984811670715;923.1045885491073;923.4367036107968;16955.321787128516;17856.73214901776;17895.19471623777;17959.551011224725;20281.898590507062;19244.90377548114;19647.214111435525;19659.803401965975;19672.90163549184;19735.21059157632;1009.3994073526259;1038.7143535527714;1038.8285932821075;1042.296449896317;1043.3479075577764;972.7616733900204;1050.102162650934;1050.6847945616323;1051.6371851711185;1052.8631277933857;1082.8862969388178;1085.3976043295968;1091.7925594137128;1097.742030622803;1098.2751384086505;1032.9328593641426;1033.669225847729;1039.2621238920376;1040.8022475729624;1070.1545778834711;763.6639878453462;764.9120351159577;765.5751058162717;773.97678069658;800.4836880212289;17866.374676886375;18477.81522184788;18897;19095.427137185907;19099.809001910082;19784.30754923585;19824.80175198244;20292;20419.489512762153;20661.070251838704;15052.924735376362;15110.320035598425;15269.847301527065;15335.846641533664;15349.846501535065;3379.7465190110593;3427.7771944823758;3431.107911942913;3441.397755392821;3444.6555344465605;117917.41041294739;118645;123236.38381808033;124808.37595811964;125083;15681.529554113395;15789.36842526309;16043.037417754973;16080.678386432206;16104.516864494084;24787.752122478905;24851.378715531893;24871.87564062168;25738.87130564335;26267.21198364052;7017.403520700797;7835.764927052198;8145.79635509117;8226.547539885243;9046.909530904606;4179.498460184736;4241.681873859473;4242.44848169736;4245.97877010613;4271.487421509377;4970.378702662168;5005.474425185376;5069.721165335868;5102.770375333119;5107.284980102789;1004.2769206171545;1026.348268849271;1035.6841163445072;1040.3341861208833;1042.713253855196;627.190923708411;632.8987362022054;673.579013116802;675.6081472745796;686.1149117638191;10103.19174466041;11235.831462527905;11518.407960199005;11537.88462115385;12041.518339266506;667.6494840208929;676.2257215488238;677.9694913728894;681.5229339462396;698.0018573440029;5268.566183806291;5276.868078297996;5396.9730151348995;5444.3194600674915;5480.369757477862;96622.51688741652;99085.50457247668;100285.49857250814;100696.49651751695;103628.48185759173;80202.59898700585;83304.58347708223;84611;84646;85599.57200214083;71888.64055679688;75547;77340;78155;78485.60757196178;10034.548445319831;10738.73153171177;12046;12159.35634570466;12455.252684838939;33008.33983320368;34602;35249.1187720309;35874.64125358713;36757.71348002807;61682;64127.679361602895;66169.66915165586;66693.33306667065;67882.32117678957;18028.459146225636;18421;18914;19032.52418689544;19265.13306901221;18751.718724218874;19207.847529148297;19357.322493712654;19974.50063748418;20106.195752169748;18233;18392.540186495444;18563.164657590172;18901.43295701131;19194.520136996685;17644.647107058045;17877.821221788137;18035.549111272325;18583.44249672512;18982.905085474486;17463.738043929607;18022.279108836025;18151.546211344823;18708.158132883782;18856.717149242497;12535.686607834878;12586.307753073668;12992.415341309475;13040.478380865039;13186.011049171158;13324.533641322894;13758.036937414685;13848.861511384757;14075.788863167265;14808.333624986686 03:38:09 INFO - PID 3545 | __end_tp_report 03:38:09 INFO - PID 3545 | __start_cc_report 03:38:09 INFO - PID 3545 | _x_x_mozilla_cycle_collect,395 03:38:09 INFO - PID 3545 | __end_cc_report 03:38:09 INFO - PID 3545 | __startTimestamp1501583889874__endTimestamp 03:38:09 INFO - PID 3545 | 03:38:09 INFO - PID 3545 | ------- Summary: start ------- 03:38:09 INFO - PID 3545 | Number of tests: 6 03:38:09 INFO - PID 3545 | 03:38:09 INFO - PID 3545 | [#0] dojo.html Cycles:165 Average:6108.56 Median:6428.49 stddev:728.00 (11.3%) stddev-sans-first:688.63 03:38:09 INFO - PID 3545 | Values: 3016.1 3130.3 3141.4 3156.6 3173.4 6094.7 6240.9 6245.1 6269.9 6298.7 6049.9 6200.3 6208.6 6212.0 6227.3 5622.9 5641.5 5718.8 5768.1 5860.7 5672.3 5735.7 5761.0 5767.0 5772.4 5404.0 5586.5 5588.4 5629.1 5681.0 5591.5 5599.3 5669.6 5671.1 5692.0 5498.9 5579.1 5600.6 5617.2 5645.4 6047.5 6086.7 6091.6 6123.4 6123.5 6567.6 6573.7 6589.4 6591.9 6608.1 6638.2 6645.3 6650.2 6675.4 6679.3 6110.8 6164.2 6166.3 6173.4 6194.7 6788.6 6797.6 6825.6 6831.3 6832.2 6462.3 6465.7 6477.2 6480.4 6508.2 6628.1 6632.4 6645.1 6728.9 6747.9 6509.8 6582.8 6592.0 6653.6 6669.3 6579.3 6629.8 6683.9 6689.6 6690.4 5372.5 5391.8 5395.8 5402.6 5402.7 4613.6 4652.8 4653.4 4693.0 4696.7 5671.7 5746.1 5747.8 5797.8 5836.3 6519.6 6625.6 6664.6 6735.8 6755.3 5738.5 5746.7 5772.0 5787.7 5789.2 4909.2 5831.3 5854.2 5863.0 5921.2 6428.5 6443.1 6515.4 6517.2 6532.7 6495.6 6566.8 6617.3 6723.6 6727.9 6468.8 6482.5 6505.1 6507.4 6518.2 6518.4 6628.9 6637.6 6638.7 6655.5 6656.8 6734.2 6765.8 6768.4 6775.2 6432.0 6445.8 6535.4 6541.2 6541.7 6350.8 6440.5 6453.1 6453.9 6460.5 6427.5 6456.2 6472.5 6500.3 6509.2 6489.8 6498.0 6546.6 6577.3 6585.7 6109.6 6223.5 6241.1 6251.6 6276.9 03:38:09 INFO - PID 3545 | 03:38:09 INFO - PID 3545 | [#1] ext.html Cycles:180 Average:36611.97 Median:3502.92 stddev:51825.76 (1479.5%) stddev-sans-first:51901.41 03:38:09 INFO - PID 3545 | Values: 807.7 881.2 903.9 908.6 1133.7 29395.7 29938.1 39971.8 40329.0 40331.6 40704.4 41154.6 41166.8 41274.4 41321.8 6846.0 7274.4 7354.2 7437.6 7564.1 7353.3 7360.7 7445.8 7449.1 7452.3 7413.7 7424.9 7440.2 7464.5 7465.0 7385.5 7476.2 7476.9 7477.6 7483.6 7417.4 7432.8 7462.1 7469.8 7479.1 36903.4 37047.6 37068.0 37118.0 37150.0 3452.8 3493.1 3501.4 3504.4 3513.7 30073.2 30400.4 30462.4 30624.8 30640.8 4585.1 4659.0 4734.0 4764.8 4831.9 188065.0 189418.0 190464.0 190716.0 191596.0 46595.0 46812.8 48115.3 48295.3 48445.0 48363.8 48370.8 48372.0 48544.3 48549.5 16064.2 16085.8 16181.8 16229.3 16344.2 10767.4 10797.3 10812.4 13259.5 13438.1 13851.2 14081.4 14209.6 14292.2 14321.0 5570.7 5739.3 5799.4 5812.6 5822.5 983.7 984.6 986.4 1015.2 1016.1 22347.2 22606.0 22733.4 23067.9 23368.8 1083.7 1095.5 1109.4 1116.3 1124.2 11945.5 12088.0 12139.9 12149.9 12153.1 218506.0 219911.0 220909.0 221057.0 221816.0 50716.7 50940.7 51304.7 51474.5 51516.5 1425.1 1464.5 1474.4 1475.3 1478.0 20939.7 21215.7 21571.8 22466.6 22627.4 35435.5 35635.0 35801.8 35810.0 35915.3 186322.0 187300.0 189013.0 189714.0 189811.0 33016.5 33385.3 34755.3 36289.0 36527.1 44270.1 44723.1 44733.6 45219.3 45250.8 29404.0 29790.0 32024.5 32116.0 32549.2 30654.8 31461.2 32194.4 32443.5 32570.3 36651.8 36801.3 36802.6 36828.0 37698.4 30440.5 33206.0 33261.5 33341.5 33557.0 24159.4 24489.4 24655.9 25216.0 25243.9 03:38:09 INFO - PID 3545 | 03:38:09 INFO - PID 3545 | [#2] jquery.html Cycles:180 Average:35879.98 Median:12625.20 stddev:86693.68 (686.7%) stddev-sans-first:86896.34 03:38:09 INFO - PID 3545 | Values: 571.7 581.5 584.7 595.5 596.6 21716.6 22359.1 22444.8 22528.4 22854.4 22613.2 22962.7 22976.4 23164.7 23226.4 6423.3 6555.0 6584.8 6586.9 6587.8 5742.8 6302.1 6305.7 6316.3 6474.5 6282.5 6329.1 6329.3 6329.9 6330.5 6325.8 6328.6 6329.7 6330.2 6333.8 5865.7 5885.3 5888.0 5902.0 5906.4 28176.4 28934.0 29486.4 29679.9 30146.4 1874.1 1877.8 1879.6 1901.8 1904.3 18428.3 18958.1 19040.8 19048.2 19143.4 2277.2 2287.7 2312.6 2313.2 2384.1 131360.3 135548.3 137311.3 137627.0 137818.0 14191.8 14448.5 14604.8 15036.1 15414.0 23268.1 23405.1 23414.6 23513.5 23553.2 10429.9 10468.6 10526.0 10540.7 10577.2 9751.3 9802.9 9805.1 9915.9 9975.3 7684.3 8810.9 8937.2 9150.1 9225.0 2595.3 2609.4 2648.9 2709.0 2749.0 945.1 953.7 956.6 959.4 973.3 19285.6 19668.0 19753.2 19939.4 20668.1 966.6 994.7 994.8 1020.1 1029.2 10578.5 10800.7 11022.2 11035.4 11070.9 501860.0 511765.0 515312.0 519669.0 526464.0 121339.4 123914.1 125251.0 126700.0 131261.0 1225.1 1233.6 1256.5 1258.0 1265.2 20978.9 21044.0 21044.8 21642.0 22776.9 58269.4 59360.4 62185.4 62413.0 65309.3 71851.6 71907.0 72086.6 72315.0 72535.0 14184.9 15120.8 15163.2 15218.1 15223.2 22639.7 23069.8 23186.5 23201.2 23408.9 18636.3 18817.8 19006.7 19067.1 19118.5 15528.7 16559.6 16847.7 16959.9 17119.8 18305.4 19327.6 19369.5 19421.8 19452.1 14745.4 14997.4 15025.3 15084.5 15087.4 17578.0 18410.4 18769.6 18871.7 18929.1 03:38:09 INFO - PID 3545 | 03:38:09 INFO - PID 3545 | [#3] mootools.html Cycles:180 Average:8657.51 Median:2609.72 stddev:5999.69 (229.9%) stddev-sans-first:5991.37 03:38:09 INFO - PID 3545 | Values: 1345.4 1365.3 1373.7 1378.1 1403.1 13658.2 14084.8 14278.5 14301.7 14306.1 13916.7 14696.9 14716.8 14717.1 14792.9 2667.6 2675.2 2691.4 2706.6 2711.8 2548.8 2633.7 2639.2 2639.5 2652.2 2729.6 2733.3 2761.0 2765.0 2765.6 2595.1 2619.0 2632.5 2649.2 2701.1 2550.1 2591.9 2595.6 2602.5 2617.0 13706.7 13932.6 13946.5 13950.5 13960.2 7546.5 7832.3 7839.7 7844.4 7853.3 4871.3 5017.6 5137.6 5146.0 5211.8 1604.7 1625.9 1689.4 1690.1 1696.8 23060.4 23395.3 23485.4 23485.5 23490.2 6347.5 6482.5 6519.3 6676.5 6709.9 15765.3 15990.4 15999.9 16000.7 16013.1 7285.3 7419.4 7424.2 7433.5 7439.3 6778.1 6798.6 6843.1 6852.1 6914.2 4983.5 5124.8 5164.4 5180.9 5181.8 1505.7 1518.1 1520.1 1552.3 1555.4 822.6 823.5 840.2 856.1 870.7 6631.3 6763.2 6878.9 6966.0 6979.0 684.4 694.4 709.6 719.6 727.5 4678.9 4999.8 5143.9 5164.3 5333.9 18140.7 18227.4 18970.5 18972.5 19089.3 19119.6 19148.3 19187.5 19236.4 20420.1 10815.6 10966.6 10980.9 11252.0 11255.7 7294.8 7918.0 8038.5 8063.3 8074.0 16895.5 17080.5 17191.7 17214.8 17370.7 16358.1 17099.2 17173.4 17691.5 17757.5 11366.0 11571.9 11573.8 11607.7 11625.3 13230.3 13334.1 13365.0 13391.1 13405.3 10161.6 10536.7 10644.1 10740.3 10915.9 10404.6 10704.1 10811.2 10833.9 11135.5 8875.2 8977.7 9033.0 9098.8 9135.4 6395.9 6427.4 6600.0 6657.9 6709.3 6251.6 6299.7 6379.0 6478.9 6569.8 03:38:09 INFO - PID 3545 | 03:38:09 INFO - PID 3545 | [#4] prototype.html Cycles:180 Average:5416.85 Median:6014.19 stddev:1526.12 (25.4%) stddev-sans-first:1484.86 03:38:09 INFO - PID 3545 | Values: 486.7 490.6 516.6 519.4 522.8 6034.9 6135.5 6159.7 6162.4 6209.9 5831.4 6009.9 6018.5 6035.3 6042.6 4872.6 4872.7 4891.5 4903.4 4904.1 4726.9 4897.8 4903.2 4910.6 4916.4 4787.9 4798.7 4801.6 4811.9 4820.8 4808.4 4825.2 4835.8 4843.4 4845.7 4261.6 4308.9 4312.4 4328.0 4343.0 5952.8 5980.8 5983.9 5998.7 6045.4 5583.8 5600.7 5602.9 5610.4 5672.5 6349.9 6387.3 6424.3 6425.1 6505.5 4716.8 4758.5 4783.5 4792.8 4813.9 6741.3 6825.2 6844.9 6852.2 6894.9 4865.6 4891.1 4908.8 4953.4 4961.6 5019.7 5022.5 5024.9 5042.7 5071.7 5622.5 5635.4 5645.8 5669.2 5673.5 6410.8 6432.5 6495.9 6509.5 6513.3 1644.2 1671.6 1689.0 1710.6 1751.2 1182.8 1182.8 1190.2 1190.9 1204.5 5666.5 5685.2 5732.7 5748.0 5752.7 6401.7 6437.3 6564.2 6591.2 6601.6 5667.3 5680.0 5711.1 5745.7 5762.1 3518.2 3542.0 3551.9 3566.3 3581.3 6320.6 6386.3 6448.8 6466.0 6494.5 6735.7 6767.1 6820.9 6823.1 6837.2 6384.0 6429.8 6436.3 6442.2 6458.2 6446.5 6556.6 6571.8 6667.4 6729.8 6401.4 6541.4 6577.6 6593.4 6601.8 6310.0 6385.9 6413.5 6432.5 6513.4 4903.4 4907.7 4942.2 4944.0 4958.0 6608.0 6668.4 6685.2 6710.4 6738.5 6427.0 6458.8 6491.4 6500.7 6529.2 6453.8 6463.8 6465.2 6467.0 6498.4 6027.2 6270.2 6299.1 6314.9 6334.3 6219.2 6300.5 6336.5 6376.6 6462.6 6125.8 6168.4 6257.7 6279.4 6293.8 03:38:09 INFO - PID 3545 | 03:38:09 INFO - PID 3545 | [#5] yui.html Cycles:180 Average:22023.32 Median:19201.18 stddev:29375.08 (153.0%) stddev-sans-first:29414.61 03:38:09 INFO - PID 3545 | Values: 886.6 907.8 922.9 923.1 923.4 16955.3 17856.7 17895.2 17959.6 20281.9 19244.9 19647.2 19659.8 19672.9 19735.2 1009.4 1038.7 1038.8 1042.3 1043.3 972.8 1050.1 1050.7 1051.6 1052.9 1082.9 1085.4 1091.8 1097.7 1098.3 1032.9 1033.7 1039.3 1040.8 1070.2 763.7 764.9 765.6 774.0 800.5 17866.4 18477.8 18897.0 19095.4 19099.8 19784.3 19824.8 20292.0 20419.5 20661.1 15052.9 15110.3 15269.8 15335.8 15349.8 3379.7 3427.8 3431.1 3441.4 3444.7 117917.4 118645.0 123236.4 124808.4 125083.0 15681.5 15789.4 16043.0 16080.7 16104.5 24787.8 24851.4 24871.9 25738.9 26267.2 7017.4 7835.8 8145.8 8226.5 9046.9 4179.5 4241.7 4242.4 4246.0 4271.5 4970.4 5005.5 5069.7 5102.8 5107.3 1004.3 1026.3 1035.7 1040.3 1042.7 627.2 632.9 673.6 675.6 686.1 10103.2 11235.8 11518.4 11537.9 12041.5 667.6 676.2 678.0 681.5 698.0 5268.6 5276.9 5397.0 5444.3 5480.4 96622.5 99085.5 100285.5 100696.5 103628.5 80202.6 83304.6 84611.0 84646.0 85599.6 71888.6 75547.0 77340.0 78155.0 78485.6 10034.5 10738.7 12046.0 12159.4 12455.3 33008.3 34602.0 35249.1 35874.6 36757.7 61682.0 64127.7 66169.7 66693.3 67882.3 18028.5 18421.0 18914.0 19032.5 19265.1 18751.7 19207.8 19357.3 19974.5 20106.2 18233.0 18392.5 18563.2 18901.4 19194.5 17644.6 17877.8 18035.5 18583.4 18982.9 17463.7 18022.3 18151.5 18708.2 18856.7 12535.7 12586.3 12992.4 13040.5 13186.0 13324.5 13758.0 13848.9 14075.8 14808.3 03:38:09 INFO - PID 3545 | -------- Summary: end -------- 03:38:09 INFO - PID 3545 | 03:38:10 INFO - TEST-INFO | 3545: exit 0 03:38:10 INFO - TEST-OK | dromaeo_css | took 1116243ms 03:38:10 INFO - TEST-START | kraken 03:38:10 INFO - Initialising browser for kraken test... 03:38:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51773/getInfo.html -profile /tmp/tmpLCInqP/profile 03:38:10 INFO - TEST-INFO | started process 3915 (/builds/slave/test/build/application/firefox/firefox http://localhost:51773/getInfo.html) 03:38:16 INFO - TEST-INFO | 3915: exit 0 03:38:17 INFO - Browser initialized. 03:38:17 INFO - Running cycle 1/1 for kraken test... 03:38:17 INFO - TEST-INFO | started process 4139 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLCInqP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:38:18 INFO - PID 4139 | 03:38:18 INFO - PID 4139 | (/builds/slave/test/build/application/firefox/firefox:4193): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:38:18 INFO - PID 4139 | 03:38:28 INFO - PID 4139 | RSS: Main: 174612480 03:38:28 INFO - PID 4139 | 03:38:31 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51773/tests/kraken/driver.html?testName=audio-beat-detection) 03:38:32 INFO - PID 4139 | RSS: Main: 179556352 03:38:32 INFO - PID 4139 | 03:38:34 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51773/tests/kraken/driver.html?testName=audio-dft) 03:38:35 INFO - PID 4139 | RSS: Main: 179834880 03:38:35 INFO - PID 4139 | 03:38:38 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51773/tests/kraken/driver.html?testName=audio-fft) 03:38:39 INFO - PID 4139 | RSS: Main: 174669824 03:38:39 INFO - PID 4139 | 03:38:41 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51773/tests/kraken/driver.html?testName=audio-oscillator) 03:38:42 INFO - PID 4139 | RSS: Main: 174952448 03:38:42 INFO - PID 4139 | 03:38:44 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51773/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:38:44 INFO - PID 4139 | RSS: Main: 175198208 03:38:44 INFO - PID 4139 | 03:38:48 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51773/tests/kraken/driver.html?testName=imaging-darkroom) 03:38:48 INFO - PID 4139 | RSS: Main: 177451008 03:38:48 INFO - PID 4139 | 03:38:52 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51773/tests/kraken/driver.html?testName=imaging-desaturate) 03:38:52 INFO - PID 4139 | RSS: Main: 176906240 03:38:52 INFO - PID 4139 | 03:38:55 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51773/tests/kraken/driver.html?testName=json-parse-financial) 03:38:56 INFO - PID 4139 | RSS: Main: 178409472 03:38:56 INFO - PID 4139 | 03:38:58 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51773/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:38:58 INFO - PID 4139 | RSS: Main: 178208768 03:38:58 INFO - PID 4139 | 03:39:00 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51773/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:39:01 INFO - PID 4139 | RSS: Main: 175226880 03:39:01 INFO - PID 4139 | 03:39:03 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51773/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:39:04 INFO - PID 4139 | RSS: Main: 174911488 03:39:04 INFO - PID 4139 | 03:39:07 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51773/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:39:07 INFO - PID 4139 | RSS: Main: 175558656 03:39:07 INFO - PID 4139 | 03:39:11 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51773/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:39:11 INFO - PID 4139 | RSS: Main: 176099328 03:39:11 INFO - PID 4139 | 03:39:13 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51773/tests/kraken/driver.html?testName=ai-astar) 03:39:13 INFO - PID 4139 | RSS: Main: 177385472 03:39:13 INFO - PID 4139 | 03:39:13 INFO - PID 4139 | __start_tp_report 03:39:13 INFO - PID 4139 | _x_x_mozilla_page_load 03:39:13 INFO - PID 4139 | _x_x_mozilla_page_load_details 03:39:13 INFO - PID 4139 | |i|pagename|runs| 03:39:13 INFO - PID 4139 | |0;ai-astar;100;108;103;109;109;110;112;111;109;109 03:39:13 INFO - PID 4139 | |1;audio-beat-detection;151;124;152;178;124;151;151;120;171;120 03:39:13 INFO - PID 4139 | |2;audio-dft;163;163;164;162;162;170;165;163;169;164 03:39:13 INFO - PID 4139 | |3;audio-fft;75;76;74;173;82;74;74;75;172;78 03:39:13 INFO - PID 4139 | |4;audio-oscillator;81;80;127;79;83;91;129;78;79;127 03:39:13 INFO - PID 4139 | |5;imaging-gaussian-blur;114;114;115;113;116;114;114;117;117;114 03:39:13 INFO - PID 4139 | |6;imaging-darkroom;152;151;154;150;151;151;151;150;150;156 03:39:13 INFO - PID 4139 | |7;imaging-desaturate;94;94;95;94;94;95;94;93;94;94 03:39:13 INFO - PID 4139 | |8;json-parse-financial;59;57;57;56;57;55;61;56;56;56 03:39:13 INFO - PID 4139 | |9;json-stringify-tinderbox;54;59;58;60;54;53;56;54;53;62 03:39:13 INFO - PID 4139 | |10;stanford-crypto-aes;82;87;94;81;87;89;80;80;78;85 03:39:13 INFO - PID 4139 | |11;stanford-crypto-ccm;133;139;138;127;135;137;140;136;131;177 03:39:13 INFO - PID 4139 | |12;stanford-crypto-pbkdf2;188;189;196;183;189;186;188;188;180;186 03:39:13 INFO - PID 4139 | |13;stanford-crypto-sha256-iterative;69;70;69;70;69;68;66;65;68;65 03:39:13 INFO - PID 4139 | __end_tp_report 03:39:13 INFO - PID 4139 | __start_cc_report 03:39:13 INFO - PID 4139 | _x_x_mozilla_cycle_collect,956 03:39:13 INFO - PID 4139 | __end_cc_report 03:39:13 INFO - PID 4139 | __startTimestamp1501583953708__endTimestamp 03:39:13 INFO - PID 4139 | 03:39:13 INFO - PID 4139 | ------- Summary: start ------- 03:39:13 INFO - PID 4139 | Number of tests: 14 03:39:13 INFO - PID 4139 | 03:39:13 INFO - PID 4139 | [#0] ai-astar Cycles:10 Average:108.00 Median:109.00 stddev:3.68 (3.4%) stddev-sans-first:2.52 03:39:13 INFO - PID 4139 | Values: 100.0 108.0 103.0 109.0 109.0 110.0 112.0 111.0 109.0 109.0 03:39:13 INFO - PID 4139 | 03:39:13 INFO - PID 4139 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:151.00 stddev:21.21 (14.0%) stddev-sans-first:22.35 03:39:13 INFO - PID 4139 | Values: 151.0 124.0 152.0 178.0 124.0 151.0 151.0 120.0 171.0 120.0 03:39:13 INFO - PID 4139 | 03:39:13 INFO - PID 4139 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:2.80 (1.7%) stddev-sans-first:2.92 03:39:13 INFO - PID 4139 | Values: 163.0 163.0 164.0 162.0 162.0 170.0 165.0 163.0 169.0 164.0 03:39:13 INFO - PID 4139 | 03:39:13 INFO - PID 4139 | [#3] audio-fft Cycles:10 Average:95.30 Median:75.00 stddev:40.76 (54.3%) stddev-sans-first:42.57 03:39:13 INFO - PID 4139 | Values: 75.0 76.0 74.0 173.0 82.0 74.0 74.0 75.0 172.0 78.0 03:39:13 INFO - PID 4139 | 03:39:13 INFO - PID 4139 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:79.50 stddev:22.57 (28.4%) stddev-sans-first:23.33 03:39:13 INFO - PID 4139 | Values: 81.0 80.0 127.0 79.0 83.0 91.0 129.0 78.0 79.0 127.0 03:39:13 INFO - PID 4139 | 03:39:13 INFO - PID 4139 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:114.50 stddev:1.40 (1.2%) stddev-sans-first:1.45 03:39:13 INFO - PID 4139 | Values: 114.0 114.0 115.0 113.0 116.0 114.0 114.0 117.0 117.0 114.0 03:39:13 INFO - PID 4139 | 03:39:13 INFO - PID 4139 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:151.00 stddev:1.96 (1.3%) stddev-sans-first:2.07 03:39:13 INFO - PID 4139 | Values: 152.0 151.0 154.0 150.0 151.0 151.0 151.0 150.0 150.0 156.0 03:39:13 INFO - PID 4139 | 03:39:13 INFO - PID 4139 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 03:39:13 INFO - PID 4139 | Values: 94.0 94.0 95.0 94.0 94.0 95.0 94.0 93.0 94.0 94.0 03:39:13 INFO - PID 4139 | 03:39:13 INFO - PID 4139 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.00 stddev:1.76 (3.1%) stddev-sans-first:1.72 03:39:13 INFO - PID 4139 | Values: 59.0 57.0 57.0 56.0 57.0 55.0 61.0 56.0 56.0 56.0 03:39:13 INFO - PID 4139 | 03:39:13 INFO - PID 4139 | [#9] json-stringify-tinderbox Cycles:10 Average:56.30 Median:57.00 stddev:3.23 (5.7%) stddev-sans-first:3.32 03:39:13 INFO - PID 4139 | Values: 54.0 59.0 58.0 60.0 54.0 53.0 56.0 54.0 53.0 62.0 03:39:13 INFO - PID 4139 | 03:39:13 INFO - PID 4139 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:86.00 stddev:4.99 (5.8%) stddev-sans-first:5.22 03:39:13 INFO - PID 4139 | Values: 82.0 87.0 94.0 81.0 87.0 89.0 80.0 80.0 78.0 85.0 03:39:13 INFO - PID 4139 | 03:39:13 INFO - PID 4139 | [#11] stanford-crypto-ccm Cycles:10 Average:139.30 Median:137.50 stddev:13.82 (10.0%) stddev-sans-first:14.47 03:39:13 INFO - PID 4139 | Values: 133.0 139.0 138.0 127.0 135.0 137.0 140.0 136.0 131.0 177.0 03:39:13 INFO - PID 4139 | 03:39:13 INFO - PID 4139 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.30 Median:188.00 stddev:4.19 (2.2%) stddev-sans-first:4.44 03:39:13 INFO - PID 4139 | Values: 188.0 189.0 196.0 183.0 189.0 186.0 188.0 188.0 180.0 186.0 03:39:13 INFO - PID 4139 | 03:39:13 INFO - PID 4139 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:69.00 stddev:1.91 (2.8%) stddev-sans-first:1.99 03:39:13 INFO - PID 4139 | Values: 69.0 70.0 69.0 70.0 69.0 68.0 66.0 65.0 68.0 65.0 03:39:13 INFO - PID 4139 | -------- Summary: end -------- 03:39:13 INFO - PID 4139 | 03:39:14 INFO - PID 4139 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:39:14 INFO - TEST-INFO | 4139: exit 0 03:39:14 INFO - TEST-OK | kraken | took 63803ms 03:39:14 INFO - SUITE-END | took 1180s 03:39:14 INFO - Completed test suite (00:19:40) 03:39:14 INFO - javascript benchmark 03:39:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8327.741643238109, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3016.125323656141, 3130.326979699364, 3141.403133404653, 3156.6054243219605, 3173.3811906678206, 6094.725737341825, 6240.937590624087, 6245.094461303108, 6269.905951410727, 6298.748050077991, 6049.879002419949, 6200.34896335885, 6208.596441231317, 6211.968940155293, 6227.314995350508, 5622.943770562303, 5641.492265696086, 5718.799842005531, 5768.134779783024, 5860.706964651772, 5672.290963629546, 5735.655860648374, 5761.0, 5767.0, 5772.393898640646, 5404.0, 5586.469285417878, 5588.441155884399, 5629.127485239795, 5681.0, 5591.46881046304, 5599.272094627713, 5669.603127781057, 5671.149327600851, 5692.0323544997445, 5498.917516237259, 5579.13523403873, 5600.635958662674, 5617.241672374218, 5645.350784659776, 6047.455728984412, 6086.695665216722, 6091.634501929854, 6123.357047510036, 6123.540734444934, 6567.605943643397, 6573.671316434159, 6589.374009469093, 6591.93408065918, 6608.107905432753, 6638.203415590112, 6645.3354664533645, 6650.235222949326, 6675.399214070709, 6679.298673639247, 6110.847228819271, 6164.167837341946, 6166.260048794174, 6173.382661733835, 6194.690265486708, 6788.558743681645, 6797.558158719767, 6825.590464572141, 6831.28271531482, 6832.180138383425, 6462.32145624712, 6465.741370345228, 6477.222733272038, 6480.416762491398, 6508.219013718384, 6628.072069910217, 6632.403083722488, 6645.136132302867, 6728.899066514006, 6747.898781518281, 6509.837254068686, 6582.8354291143105, 6591.967040164768, 6653.600783952978, 6669.299723529057, 6579.30917253691, 6629.801105966829, 6683.897156969143, 6689.565178263398, 6690.431313338323, 5372.462753724596, 5391.757370918318, 5395.81114660985, 5402.621816472888, 5402.729863506887, 4613.607843333354, 4652.837150699709, 4653.371794807726, 4693.0, 4696.694714843524, 5671.716414179357, 5746.080627099644, 5747.827565173052, 5797.826065218051, 5836.299644042657, 6519.641419721961, 6625.569337993112, 6664.600123992576, 6735.831604209934, 6755.324467553303, 5738.483536481736, 5746.712664366765, 5772.0, 5787.739551720183, 5789.189513468118, 4909.189983652657, 5831.271091113611, 5854.18041474194, 5863.0, 5921.171036054956, 6428.485721142204, 6443.130177426081, 6515.446187074152, 6517.185351831021, 6532.738690452424, 6495.642739649365, 6566.8358291043105, 6617.272100069084, 6723.596584204964, 6727.8990815138795, 6468.8059358219325, 6482.546221764431, 6505.121808555785, 6507.414332710079, 6518.2178138621775, 6518.445932095636, 6628.867422651617, 6637.6349300788925, 6638.701258443478, 6655.500837437115, 6656.7670131545165, 6734.158230221223, 6765.830854228684, 6768.424683901923, 6775.1531058617675, 6432.0, 6445.774397896051, 6535.379138981789, 6541.182352205974, 6541.70562324706, 6350.841228969312, 6440.4525615321345, 6453.128827608213, 6453.9354606453335, 6460.483161346987, 6427.517936154713, 6456.225252969673, 6472.482201423969, 6500.3174666659315, 6509.1863517060365, 6489.772857949949, 6498.0252962056065, 6546.574472659262, 6577.276499585138, 6585.703643336157, 6109.602875813058, 6223.533235007483, 6241.063840423973, 6251.562390632612, 6276.937230627818], "value": 6053.918378935221, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.7011505742876, 881.2245224202701, 903.9276857851372, 908.5548081440096, 1133.6995696140518, 29395.706042939564, 29938.1018569443, 39971.80014099926, 40329.0, 40331.59668403315, 40704.38943415844, 41154.58845411545, 41166.794166029205, 41274.38088428676, 41321.793391033, 6845.965770171142, 7274.381677557414, 7354.1542722587055, 7437.553746775197, 7564.054493188351, 7353.301436363537, 7360.668769905367, 7445.7766267012075, 7449.068866391701, 7452.329290363866, 7413.703451861919, 7424.9257507425045, 7440.218777028415, 7464.477486575942, 7465.029546158992, 7385.519941203805, 7476.177620461772, 7476.850462990764, 7477.588732619676, 7483.588402637853, 7417.369523590502, 7432.777016689508, 7462.067241594801, 7469.775906722753, 7479.139898911641, 36903.44644830329, 37047.629523704956, 37068.0, 37118.0, 37149.95675237861, 3452.8100954447495, 3493.0568746438576, 3501.404761190578, 3504.439289713659, 3513.7189024878203, 30073.248168795737, 30400.39199216003, 30462.390752185052, 30624.846875765477, 30640.84679576588, 4585.119222039594, 4659.0, 4733.9763301183275, 4764.833230836939, 4831.903361932742, 188065.0, 189418.0, 190464.0, 190715.9999999986, 191596.0, 46595.0, 46812.7659361701, 48115.27827082597, 48295.27557086646, 48445.0, 48363.758181209574, 48370.758146209744, 48372.0, 48544.27183592249, 48549.51450485521, 16064.196790160446, 16085.839141608434, 16181.838181618268, 16229.2696828643, 16344.182790860646, 10767.3539587625, 10797.29817561856, 10812.405317707602, 13259.469621215236, 13438.126521776054, 13851.16892986424, 14081.366338514792, 14209.573712788633, 14292.21392823384, 14321.0, 5570.6657600544095, 5739.253896993364, 5799.449052340021, 5812.564057695689, 5822.505087067647, 983.695054533097, 984.6356847966298, 986.4032260482305, 1015.1777060580953, 1016.0956748493846, 22347.217847375265, 22606.0, 22733.43166420853, 23067.884660576925, 23368.766312337, 1083.6965649618119, 1095.5234473004268, 1109.4230999880178, 1116.330201878866, 1124.2130508643982, 11945.462454189583, 12088.032957363566, 12139.939300303442, 12149.939250303692, 12153.08851836098, 218506.0, 219911.0, 220909.0, 221057.0, 221816.0, 50716.746416267684, 50940.74529627402, 51304.69128889209, 51474.48525514697, 51516.48483515192, 1425.1164278147614, 1464.4581504843277, 1474.3881289264834, 1475.254996226877, 1477.963050923714, 20939.685904711747, 21215.68176477323, 21571.78428215698, 22466.5506689862, 22627.43431414228, 35435.46846797249, 35635.0, 35801.82099089488, 35810.0, 35915.28169436649, 186322.0, 187300.0, 189013.0, 189714.0, 189811.0, 33016.50475242922, 33385.33229335351, 34755.30489390148, 36289.0, 36527.08682282964, 44270.11459770851, 44723.10553788971, 44733.55266447294, 45219.321710175034, 45250.77374613106, 29404.0, 29790.0, 32024.51963220507, 32116.0, 32549.18627034343, 30654.846725766227, 31461.213469663442, 32194.35611287808, 32443.513347299337, 32570.34859302753, 36651.816740916125, 36801.26397472089, 36802.63197368099, 36828.0, 37698.43452348162, 30440.543391848696, 33206.0, 33261.50107748337, 33341.499877501374, 33557.0, 24159.396015099763, 24489.38776530601, 24655.87672061628, 25215.991360346114, 25243.87378063098], "value": 16815.793431735987, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.7455732199173, 581.4853854338909, 584.6725833533225, 595.5235811350918, 596.5823923253722, 21716.565668686617, 22359.10563577457, 22444.775552244515, 22528.436789080282, 22854.428639284026, 22613.208537701183, 22962.65556016661, 22976.425589360275, 23164.65253021206, 23226.419339516477, 6423.293437721847, 6555.0495178199135, 6584.769533066344, 6586.934130658704, 6587.769428070019, 5742.770289188427, 6302.14920985668, 6305.684715764216, 6316.30520642729, 6474.514411419139, 6282.465990390822, 6329.05064240363, 6329.335419780903, 6329.873402531946, 6330.525210609199, 6325.778597749079, 6328.588641738273, 6329.746810127589, 6330.240371155468, 6333.809985700436, 5865.736041878125, 5885.323187833411, 5887.970560147171, 5902.026165682657, 5906.409359064102, 28176.436471270667, 28934.0, 29486.41027179466, 29679.851600742073, 30146.397072058655, 1874.1285302334343, 1877.7840548336842, 1879.6052828905947, 1901.7622797150357, 1904.2858927902037, 18428.262869485203, 18958.14688339028, 19040.809591904042, 19048.238070477164, 19143.425697229104, 2277.2257432472875, 2287.7369102553253, 2312.560613483433, 2313.201945328859, 2384.1178763857483, 131360.34319828436, 135548.32225838807, 137311.31344343215, 137627.0, 137818.0, 14191.78712319316, 14448.494302699355, 14604.780928285873, 15036.097834129987, 15414.0, 23268.06927722906, 23405.063797448252, 23414.64878026831, 23513.529729405316, 23553.175638852557, 10429.895701042893, 10468.63359782404, 10526.0, 10540.683779486628, 10577.206709496664, 9751.31740778153, 9802.9019709802, 9805.068518490732, 9915.851262231072, 9975.301728879054, 7684.271039016288, 8810.86783698245, 8937.240334571505, 9150.130737579919, 9224.953875230582, 2595.2992691973063, 2609.3998380372623, 2648.933776655599, 2708.959365609478, 2748.958765618517, 945.0974319524837, 953.7415828404553, 956.6203375899373, 959.3620242538634, 973.3040875773855, 19285.61428771417, 19668.0, 19753.209871604973, 19939.401817945483, 20668.06993685258, 966.5980039601584, 994.6817018554138, 994.8408254679216, 1020.0921180149672, 1029.156092004564, 10578.52396642153, 10800.729981750363, 11022.244438890277, 11035.39305338214, 11070.944645276722, 501860.0, 511765.0, 515312.0, 519669.0, 526464.0, 121339.39330303292, 123914.14128787896, 125251.0, 126700.0, 131261.0, 1225.1362789233747, 1233.648410203088, 1256.4785613970282, 1258.0, 1265.1902782219388, 20978.895105524374, 21044.0, 21044.789552104285, 21642.0, 22776.886115569316, 58269.417305828094, 59360.40639593549, 62185.37814621796, 62413.0, 65309.34690653033, 71851.64074179596, 71907.0, 72086.63956680182, 72315.0, 72535.0, 14184.929075354557, 15120.773188402403, 15163.241837908281, 15218.086914785148, 15223.16272604973, 22639.660405093608, 23069.769302306762, 23186.536269274857, 23201.187958421375, 23408.88295558511, 18636.34772782946, 18817.811821882155, 19006.714899276245, 19067.141978610718, 19118.52203694863, 15528.689426211638, 16559.586010349838, 16847.663046739242, 16959.91520042392, 17119.828801711825, 18305.359312424534, 19327.613447731248, 19369.51576210606, 19421.805781942567, 19452.124654390303, 14745.410183592536, 14997.400103995718, 15025.323860426526, 15084.547463576111, 15087.39650414015, 17578.0, 18410.35563755316, 18769.624607508045, 18871.716924245873, 18929.148188331284], "value": 12014.126401466567, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.381124682646, 1365.3241645385535, 1373.72525494901, 1378.1455497591494, 1403.130059363195, 13658.248796316198, 14084.788728169086, 14278.500252491165, 14301.713965720679, 14306.07010544314, 13916.721665566683, 14696.926515367435, 14716.779248311284, 14717.116972981628, 14792.852071479281, 2667.613196086571, 2675.2241849863517, 2691.3540750219904, 2706.594010898371, 2711.769499592537, 2548.7960963122905, 2633.749793769589, 2639.234621959639, 2639.498495285899, 2652.1778248742853, 2729.604207389927, 2733.3439974406097, 2760.9585856212175, 2764.986175069132, 2765.5989881467176, 2595.104688882342, 2619.0, 2632.499825033257, 2649.218480548243, 2701.1086341507353, 2550.0692247329775, 2591.948161036769, 2595.610658401255, 2602.466494368669, 2616.973830261711, 13706.657333566642, 13932.58202253934, 13946.51187208453, 13950.511732089328, 13960.232187229698, 7546.471746977713, 7832.29509344156, 7839.686412543491, 7844.411669124782, 7853.293203611703, 4871.318015477836, 5017.573506251973, 5137.5633071188995, 5146.047981123466, 5211.817586384496, 1604.7271963766188, 1625.9430919917745, 1689.4255952976048, 1690.0535700008036, 1696.8388003139805, 23060.42348941273, 23395.298141055624, 23485.41286467835, 23485.530289394115, 23490.177843775557, 6347.460465860361, 6482.513811464159, 6519.250286217146, 6676.53264271506, 6709.93290067093, 15765.290561924741, 15990.440334588233, 15999.920000399923, 16000.679986400206, 16013.119278439564, 7285.307895749896, 7419.443541734391, 7424.183339832614, 7433.479656423999, 7439.256074392518, 6778.051072849805, 6798.558093723892, 6843.144606924135, 6852.143482064742, 6914.239433662293, 4983.526564976321, 5124.795008199705, 5164.406093299243, 5180.922286165711, 5181.792728290826, 1505.6762795998914, 1518.096732444194, 1520.0651599266594, 1552.2859484636967, 1555.3778488604423, 822.6421506644629, 823.472977294532, 840.2102024097329, 856.1139220906332, 870.7126648206076, 6631.27056023837, 6763.222229443579, 6878.931210687829, 6965.965170174117, 6979.0, 684.4182444921876, 694.4028135803306, 709.6203531110934, 719.5754504842064, 727.5052963984541, 4678.906421871544, 4999.800007999639, 5143.948560514422, 5164.25118357836, 5333.919991200135, 18140.727889081674, 18227.362042328456, 18970.525736856413, 18972.525686857938, 19089.331873384366, 19119.617607647768, 19148.329808456914, 19187.520311992314, 19236.422907312804, 20420.0810963507, 10815.621453249098, 10966.561337546409, 10980.945095274472, 11252.0, 11255.66233013011, 7294.787297782934, 7917.970663813898, 8038.517688938682, 8063.314618257514, 8073.959630201812, 16895.493135205965, 17080.48758537246, 17191.742123868404, 17214.827851721322, 17370.652586948443, 16358.100304482892, 17099.230534625724, 17173.398931037354, 17691.469255922344, 17757.467275981224, 11366.0, 11571.942140289582, 11573.768524629628, 11607.709807254887, 11625.302481851117, 13230.272335021666, 13334.133281336683, 13365.0, 13391.062625616503, 13405.329733513481, 10161.644342447978, 10536.736581585521, 10644.095251903365, 10740.30188037775, 10915.945420272848, 10404.635837745642, 10704.143668506345, 10811.243212975016, 10833.945830270799, 11135.498902549567, 8875.156860098281, 8977.685780997634, 9033.0, 9098.818023639358, 9135.360524763202, 6395.872082558416, 6427.421532062137, 6600.0, 6657.900131497934, 6709.329067093252, 6251.593646412968, 6299.748010079728, 6379.0, 6478.870422591616, 6569.835754106186], "value": 6241.773274557439, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.71924137597375, 490.6331481008451, 516.6331904347912, 519.3741541442562, 522.8065615722184, 6034.939650603493, 6135.545781687328, 6159.661218632973, 6162.350189418554, 6209.9068513972325, 5831.367217179186, 6009.858126955886, 6018.518518518508, 6035.305939816923, 6042.57701960863, 4872.610191184705, 4872.683275587093, 4891.461939186686, 4903.436104847935, 4904.092742842586, 4726.858194254178, 4897.804087836482, 4903.239997800329, 4910.6317026223, 4916.3608730864935, 4787.928181077286, 4798.664093513456, 4801.639877009221, 4811.927821082687, 4820.783064762094, 4808.350872632185, 4825.155597770394, 4835.758212089381, 4843.39457567804, 4845.709257444564, 4261.552536983634, 4308.892277693051, 4312.37470566766, 4328.0, 4342.956570434319, 5952.761889524457, 5980.820575382702, 5983.880322393571, 5998.730057147439, 6045.395460453919, 5583.804566840141, 5600.691961942091, 5602.887942241173, 5610.410906854803, 5672.546196304327, 6349.873002539969, 6387.297397286295, 6424.261209960868, 6425.1326070980285, 6505.4795616350575, 4716.787744551503, 4758.452777930548, 4783.497732738082, 4792.832250871203, 4813.903721925577, 6741.3258674132685, 6825.180978282638, 6844.93155068448, 6852.177738671341, 6894.896576551356, 4865.56209941107, 4891.144049791273, 4908.803647854046, 4953.430355509163, 4961.5534601886, 5019.698818070928, 5022.4977502249485, 5024.949750502448, 5042.722650254272, 5071.670341427795, 5622.493975542221, 5635.380108188096, 5645.802396916089, 5669.234653321749, 5673.461021202979, 6410.807675769641, 6432.4532414744335, 6495.914440640752, 6509.511786616023, 6513.2509761377105, 1644.21077882617, 1671.565392997805, 1688.9831101688826, 1710.6236627941832, 1751.1594434671429, 1182.7634473105413, 1182.8048372018693, 1190.2085113399664, 1190.8987736042534, 1204.4519743516853, 5666.518345940559, 5685.204071430003, 5732.742026608813, 5748.02283611787, 5752.741126649311, 6401.679916004181, 6437.3029868566655, 6564.179477565304, 6591.209054913345, 6601.603903765789, 5667.291588551431, 5679.971600141973, 5711.143328500675, 5745.712714364265, 5762.069706648236, 3518.238183026312, 3542.0423946005376, 3551.94672079919, 3566.268914872445, 3581.28374325136, 6320.62076275425, 6386.2975072741965, 6448.838779030561, 6465.967670161619, 6494.512911531654, 6735.663216839139, 6767.105210541056, 6820.897686534706, 6823.147106611674, 6837.213720422115, 6384.009993753996, 6429.839254018687, 6436.259830119502, 6442.226932768098, 6458.160439142881, 6446.548741588232, 6556.573822701509, 6571.751367240209, 6667.399934005963, 6729.798106056826, 6401.423871851555, 6541.378569035934, 6577.638229897401, 6593.3736295051895, 6601.801945941629, 6309.968450157719, 6385.904211436925, 6413.518986076157, 6432.517561182836, 6513.381228783258, 4903.362562866804, 4907.668857292758, 4942.20924652054, 4943.9505604944925, 4958.0, 6608.041833934149, 6668.366505182, 6685.197776266685, 6710.429613482714, 6738.460923126237, 6426.971684530453, 6458.806235812933, 6491.448226900767, 6500.70746816385, 6529.249136349191, 6453.838654033687, 6463.838404039937, 6465.224173099258, 6466.967665161644, 6498.447631951337, 6027.246594175728, 6270.184875966095, 6299.14175318273, 6314.936850631435, 6334.326090867378, 6219.191505104308, 6300.464460520907, 6336.493080553637, 6376.585521941059, 6462.644554549545, 6125.785597504066, 6168.383161683796, 6257.7184026719815, 6279.372062793684, 6293.842653933688], "value": 4966.771246505738, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [886.5655828643962, 907.8411278026346, 922.8984811670715, 923.1045885491073, 923.4367036107968, 16955.321787128516, 17856.73214901776, 17895.19471623777, 17959.551011224725, 20281.898590507062, 19244.90377548114, 19647.214111435525, 19659.803401965975, 19672.90163549184, 19735.21059157632, 1009.3994073526259, 1038.7143535527714, 1038.8285932821075, 1042.296449896317, 1043.3479075577764, 972.7616733900204, 1050.102162650934, 1050.6847945616323, 1051.6371851711185, 1052.8631277933857, 1082.8862969388178, 1085.3976043295968, 1091.7925594137128, 1097.742030622803, 1098.2751384086505, 1032.9328593641426, 1033.669225847729, 1039.2621238920376, 1040.8022475729624, 1070.1545778834711, 763.6639878453462, 764.9120351159577, 765.5751058162717, 773.97678069658, 800.4836880212289, 17866.374676886375, 18477.81522184788, 18897.0, 19095.427137185907, 19099.809001910082, 19784.30754923585, 19824.80175198244, 20292.0, 20419.489512762153, 20661.070251838704, 15052.924735376362, 15110.320035598425, 15269.847301527065, 15335.846641533664, 15349.846501535065, 3379.7465190110593, 3427.7771944823758, 3431.107911942913, 3441.397755392821, 3444.6555344465605, 117917.41041294739, 118645.0, 123236.38381808033, 124808.37595811964, 125083.0, 15681.529554113395, 15789.36842526309, 16043.037417754973, 16080.678386432206, 16104.516864494084, 24787.752122478905, 24851.378715531893, 24871.87564062168, 25738.87130564335, 26267.21198364052, 7017.403520700797, 7835.764927052198, 8145.79635509117, 8226.547539885243, 9046.909530904606, 4179.498460184736, 4241.681873859473, 4242.44848169736, 4245.97877010613, 4271.487421509377, 4970.378702662168, 5005.474425185376, 5069.721165335868, 5102.770375333119, 5107.284980102789, 1004.2769206171545, 1026.348268849271, 1035.6841163445072, 1040.3341861208833, 1042.713253855196, 627.190923708411, 632.8987362022054, 673.579013116802, 675.6081472745796, 686.1149117638191, 10103.19174466041, 11235.831462527905, 11518.407960199005, 11537.88462115385, 12041.518339266506, 667.6494840208929, 676.2257215488238, 677.9694913728894, 681.5229339462396, 698.0018573440029, 5268.566183806291, 5276.868078297996, 5396.9730151348995, 5444.3194600674915, 5480.369757477862, 96622.51688741652, 99085.50457247668, 100285.49857250814, 100696.49651751695, 103628.48185759173, 80202.59898700585, 83304.58347708223, 84611.0, 84646.0, 85599.57200214083, 71888.64055679688, 75547.0, 77340.0, 78155.0, 78485.60757196178, 10034.548445319831, 10738.73153171177, 12046.0, 12159.35634570466, 12455.252684838939, 33008.33983320368, 34602.0, 35249.1187720309, 35874.64125358713, 36757.71348002807, 61682.0, 64127.679361602895, 66169.66915165586, 66693.33306667065, 67882.32117678957, 18028.459146225636, 18421.0, 18914.0, 19032.52418689544, 19265.13306901221, 18751.718724218874, 19207.847529148297, 19357.322493712654, 19974.50063748418, 20106.195752169748, 18233.0, 18392.540186495444, 18563.164657590172, 18901.43295701131, 19194.520136996685, 17644.647107058045, 17877.821221788137, 18035.549111272325, 18583.44249672512, 18982.905085474486, 17463.738043929607, 18022.279108836025, 18151.546211344823, 18708.158132883782, 18856.717149242497, 12535.686607834878, 12586.307753073668, 12992.415341309475, 13040.478380865039, 13186.011049171158, 13324.533641322894, 13758.036937414685, 13848.861511384757, 14075.788863167265, 14808.333624986686], "value": 8796.46128706079, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1560.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 108.0, 103.0, 109.0, 109.0, 110.0, 112.0, 111.0, 109.0, 109.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 152.0, 178.0, 124.0, 151.0, 151.0, 120.0, 171.0, 120.0], "value": 144.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 162.0, 162.0, 170.0, 165.0, 163.0, 169.0, 164.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 173.0, 82.0, 74.0, 74.0, 75.0, 172.0, 78.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 127.0, 79.0, 83.0, 91.0, 129.0, 78.0, 79.0, 127.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 113.0, 116.0, 114.0, 114.0, 117.0, 117.0, 114.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 154.0, 150.0, 151.0, 151.0, 151.0, 150.0, 150.0, 156.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 93.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 57.0, 56.0, 57.0, 55.0, 61.0, 56.0, 56.0, 56.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 59.0, 58.0, 60.0, 54.0, 53.0, 56.0, 54.0, 53.0, 62.0], "value": 56.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 87.0, 94.0, 81.0, 87.0, 89.0, 80.0, 80.0, 78.0, 85.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 139.0, 138.0, 127.0, 135.0, 137.0, 140.0, 136.0, 131.0, 177.0], "value": 139.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 189.0, 196.0, 183.0, 189.0, 186.0, 188.0, 188.0, 180.0, 186.0], "value": 187.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 70.0, 69.0, 68.0, 66.0, 65.0, 68.0, 65.0], "value": 67.9, "unit": "score"}]}]} 03:39:14 INFO - Return code: 0 03:39:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:39:15 INFO - # TBPL SUCCESS # 03:39:15 INFO - Running post-action listener: _package_coverage_data 03:39:15 INFO - Running post-action listener: _resource_record_post_action 03:39:15 INFO - [mozharness: 2017-08-01 10:39:15.001891Z] Finished run-tests step (success) 03:39:15 INFO - Running post-run listener: _resource_record_post_run 03:39:15 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 6434816; Write bytes: 442789888; Read time: 3220; Write time: 309040 03:39:15 INFO - TinderboxPrint: CPU usage
13.2% 03:39:15 INFO - TinderboxPrint: I/O read bytes / time
6,434,816 / 3,220 03:39:15 INFO - TinderboxPrint: I/O write bytes / time
442,789,888 / 309,040 03:39:15 INFO - TinderboxPrint: CPU idle
8,297.6 (86.8%) 03:39:15 INFO - TinderboxPrint: CPU user
1,205.7 (12.6%) 03:39:15 INFO - TinderboxPrint: Swap in / out
0 / 0 03:39:15 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 119320576; Read time: 0; Write time: 79300 03:39:15 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:39:15 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4063232; Write bytes: 323469312; Read time: 2688; Write time: 229740 03:39:15 INFO - Running post-run listener: _upload_blobber_files 03:39:15 INFO - Blob upload gear active. 03:39:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:39:15 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:39:15 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:39:15 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:39:16 INFO - (blobuploader) - INFO - Open directory for files ... 03:39:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:39:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:39:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:16 INFO - (blobuploader) - INFO - Done attempting. 03:39:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:39:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:39:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:24 INFO - (blobuploader) - INFO - Done attempting. 03:39:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:39:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:25 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:39:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:25 INFO - (blobuploader) - INFO - Done attempting. 03:39:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:39:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:39:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:26 INFO - (blobuploader) - INFO - Done attempting. 03:39:26 INFO - (blobuploader) - INFO - Iteration through files over. 03:39:26 INFO - Return code: 0 03:39:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:39:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:39:26 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/363f17bb3fb4aa5225d16813cb68db1ba9021150af0d70372d6bab9e9b6c435c976b6b3abd277cc7a9b4a498fb16e374dfad5c89e2bf2aca8486f8ca87b4ae31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f5d1420795064aff0d6fa12c8c61fb69fa087bf9a0893e26ec971256c0eeb00fe86276b47254daa9bb671586f564b295b8d4c39cc715b0714cb038ca355cc52", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a61e1dce1269556494175afaeb9210b5846dd726521a49b773690c2ff9eea3f60993fc522d9d412644255f4fa3c61da4e0baa29bd7aad063ba95e8a68bb6e68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25293e48842ec6157e6b9356965dfb0d3a06cdff899baf1ed9d10f1ea88e0478a1c154c6353a1cbc125dd3393c68938fd51ac544cc7e173ca7beb1621f3be635"} 03:39:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:39:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:39:26 INFO - Contents: 03:39:26 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/363f17bb3fb4aa5225d16813cb68db1ba9021150af0d70372d6bab9e9b6c435c976b6b3abd277cc7a9b4a498fb16e374dfad5c89e2bf2aca8486f8ca87b4ae31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f5d1420795064aff0d6fa12c8c61fb69fa087bf9a0893e26ec971256c0eeb00fe86276b47254daa9bb671586f564b295b8d4c39cc715b0714cb038ca355cc52", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a61e1dce1269556494175afaeb9210b5846dd726521a49b773690c2ff9eea3f60993fc522d9d412644255f4fa3c61da4e0baa29bd7aad063ba95e8a68bb6e68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25293e48842ec6157e6b9356965dfb0d3a06cdff899baf1ed9d10f1ea88e0478a1c154c6353a1cbc125dd3393c68938fd51ac544cc7e173ca7beb1621f3be635"} 03:39:26 INFO - Running post-run listener: copy_logs_to_upload_dir 03:39:26 INFO - Copying logs to upload dir... 03:39:26 INFO - mkdir: /builds/slave/test/build/upload/logs 03:39:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.358386 ========= master_lag: -0.29 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-08-01 03:39:26.344531) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-01 03:39:26.347753) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1501582597.971302-2044522211 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/363f17bb3fb4aa5225d16813cb68db1ba9021150af0d70372d6bab9e9b6c435c976b6b3abd277cc7a9b4a498fb16e374dfad5c89e2bf2aca8486f8ca87b4ae31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f5d1420795064aff0d6fa12c8c61fb69fa087bf9a0893e26ec971256c0eeb00fe86276b47254daa9bb671586f564b295b8d4c39cc715b0714cb038ca355cc52", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a61e1dce1269556494175afaeb9210b5846dd726521a49b773690c2ff9eea3f60993fc522d9d412644255f4fa3c61da4e0baa29bd7aad063ba95e8a68bb6e68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25293e48842ec6157e6b9356965dfb0d3a06cdff899baf1ed9d10f1ea88e0478a1c154c6353a1cbc125dd3393c68938fd51ac544cc7e173ca7beb1621f3be635"} build_url:https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/363f17bb3fb4aa5225d16813cb68db1ba9021150af0d70372d6bab9e9b6c435c976b6b3abd277cc7a9b4a498fb16e374dfad5c89e2bf2aca8486f8ca87b4ae31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f5d1420795064aff0d6fa12c8c61fb69fa087bf9a0893e26ec971256c0eeb00fe86276b47254daa9bb671586f564b295b8d4c39cc715b0714cb038ca355cc52", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a61e1dce1269556494175afaeb9210b5846dd726521a49b773690c2ff9eea3f60993fc522d9d412644255f4fa3c61da4e0baa29bd7aad063ba95e8a68bb6e68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25293e48842ec6157e6b9356965dfb0d3a06cdff899baf1ed9d10f1ea88e0478a1c154c6353a1cbc125dd3393c68938fd51ac544cc7e173ca7beb1621f3be635"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-01 03:39:26.371980) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 03:39:26.372279) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1501582597.971302-2044522211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004626 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 03:39:26.457485) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-01 03:39:26.457797) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-01 03:39:26.458084) ========= ========= Total master_lag: -0.10 =========