builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-071 starttime: 1500744720.54 results: success (0) revision: c22502562670e5e53bea543a3ee25c81f1a7b624 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-22 10:32:00.544412) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-22 10:32:00.544789) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-22 10:32:00.545069) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-22 10:32:00.568134) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 10:32:00.568395) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1500738916.67619-496437824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-22 10:32:01-- 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% 37.8M=0s 2017-07-22 10:32:01 (37.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130856 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 10:32:00.712205) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 10:32:00.712494) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1500738916.67619-496437824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018839 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 10:32:00.764510) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 10:32:00.764829) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c22502562670e5e53bea543a3ee25c81f1a7b624 --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 c22502562670e5e53bea543a3ee25c81f1a7b624 --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=dbb0bb31bf4a4c7db9ba1648000001b6-1500738916.67619-496437824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-22 10:32:01,994 truncating revision to first 12 chars 2017-07-22 10:32:01,994 Setting DEBUG logging. 2017-07-22 10:32:01,994 attempt 1/10 2017-07-22 10:32:01,994 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c22502562670?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-22 10:32:02,544 unpacking tar archive at: mozilla-central-c22502562670/testing/mozharness/ program finished with exit code 0 elapsedTime=0.867679 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 10:32:01.648003) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-22 10:32:01.648307) ========= script_repo_revision: c22502562670e5e53bea543a3ee25c81f1a7b624 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-22 10:32:01.648669) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-22 10:32:01.648949) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-22 10:32:01.658933) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-07-22 10:32:01.659200) ========= /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=dbb0bb31bf4a4c7db9ba1648000001b6-1500738916.67619-496437824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:32:02 INFO - MultiFileLogger online at 20170722 10:32:02 in /builds/slave/test 10:32:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:32:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:32:02 INFO - {'append_to_log': False, 10:32:02 INFO - 'base_work_dir': '/builds/slave/test', 10:32:02 INFO - 'blob_upload_branch': 'Firefox', 10:32:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:32:02 INFO - 'branch': 'Firefox', 10:32:02 INFO - 'buildbot_json_path': 'buildprops.json', 10:32:02 INFO - 'code_coverage': False, 10:32:02 INFO - 'config_files': ('talos/linux_config.py',), 10:32:02 INFO - 'default_actions': ('clobber', 10:32:02 INFO - 'read-buildbot-config', 10:32:02 INFO - 'download-and-extract', 10:32:02 INFO - 'populate-webroot', 10:32:02 INFO - 'create-virtualenv', 10:32:02 INFO - 'install', 10:32:02 INFO - 'setup-mitmproxy', 10:32:02 INFO - 'run-tests'), 10:32:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:32:02 INFO - 'disable_ccov_upload': False, 10:32:02 INFO - 'download_minidump_stackwalk': True, 10:32:02 INFO - 'download_symbols': 'ondemand', 10:32:02 INFO - 'enable_stylo': False, 10:32:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:32:02 INFO - 'tooltool.py': '/tools/tooltool.py', 10:32:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:32:02 INFO - '/tools/misc-python/virtualenv.py')}, 10:32:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:32:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:32:02 INFO - 'gecko_profile': False, 10:32:02 INFO - 'gecko_profile_interval': 0, 10:32:02 INFO - 'installer_path': 'installer.exe', 10:32:02 INFO - 'log_level': 'info', 10:32:02 INFO - 'log_name': 'talos', 10:32:02 INFO - 'log_to_console': True, 10:32:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:32:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:32:02 INFO - 'opt_config_files': (), 10:32:02 INFO - 'pip_index': False, 10:32:02 INFO - 'suite': 'dromaeojs-e10s', 10:32:02 INFO - 'system_bits': '32', 10:32:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:32:02 INFO - 'title': 'talos-linux64-ix-071', 10:32:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:32:02 INFO - 'use_talos_json': True, 10:32:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:32:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:32:02 INFO - 'work_dir': 'build'} 10:32:02 INFO - [mozharness: 2017-07-22 17:32:02.986475Z] Running clobber step. 10:32:02 INFO - Running pre-action listener: _resource_record_pre_action 10:32:02 INFO - Running main action method: clobber 10:32:02 INFO - rmtree: /builds/slave/test/build 10:32:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:32:04 INFO - Running post-action listener: _resource_record_post_action 10:32:04 INFO - [mozharness: 2017-07-22 17:32:04.527130Z] Finished clobber step (success) 10:32:04 INFO - [mozharness: 2017-07-22 17:32:04.527231Z] Running read-buildbot-config step. 10:32:04 INFO - Running pre-action listener: _resource_record_pre_action 10:32:04 INFO - Running main action method: read_buildbot_config 10:32:04 INFO - Using buildbot properties: 10:32:04 INFO - { 10:32:04 INFO - "project": "", 10:32:04 INFO - "product": "firefox", 10:32:04 INFO - "who": "ffxbld@noreply.mozilla.org", 10:32:04 INFO - "installer_path": "public/build/target.tar.bz2", 10:32:04 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:32:04 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 10:32:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 10:32:04 INFO - "stage_platform": "linux64-pgo", 10:32:04 INFO - "basedir": "/builds/slave/test", 10:32:04 INFO - "buildnumber": 80, 10:32:04 INFO - "platform": "ubuntu64_hw", 10:32:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:32:04 INFO - "slavebuilddir": "test", 10:32:04 INFO - "taskId": "VC2nqwHRQTmufX0Mz5zHqg", 10:32:04 INFO - "branch": "mozilla-central", 10:32:04 INFO - "script_repo_revision": "production", 10:32:04 INFO - "revision": "c22502562670e5e53bea543a3ee25c81f1a7b624", 10:32:04 INFO - "slavename": "talos-linux64-ix-071", 10:32:04 INFO - "repo_path": "mozilla-central" 10:32:04 INFO - } 10:32:04 INFO - Finding installer, test and symbols from parent task. 10:32:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VC2nqwHRQTmufX0Mz5zHqg'}, attempt #1 10:32:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VC2nqwHRQTmufX0Mz5zHqg'}, attempt #1 10:32:05 INFO - Task dependencies: S8_BmWORTH2DSgQ8Y2MOGg 10:32:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S8_BmWORTH2DSgQ8Y2MOGg'}, attempt #1 10:32:05 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/S8_BmWORTH2DSgQ8Y2MOGg/artifacts/public/build/target.tar.bz2 10:32:05 INFO - Set test_url: https://queue.taskcluster.net/v1/task/S8_BmWORTH2DSgQ8Y2MOGg/artifacts/public/build/test_packages.json 10:32:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/S8_BmWORTH2DSgQ8Y2MOGg/artifacts/public/build/target.crashreporter-symbols.zip 10:32:05 INFO - Running post-action listener: _resource_record_post_action 10:32:05 INFO - [mozharness: 2017-07-22 17:32:05.958286Z] Finished read-buildbot-config step (success) 10:32:05 INFO - [mozharness: 2017-07-22 17:32:05.958506Z] Running download-and-extract step. 10:32:05 INFO - Running pre-action listener: _resource_record_pre_action 10:32:05 INFO - Running main action method: download_and_extract 10:32:05 INFO - mkdir: /builds/slave/test/build/tests 10:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:05 INFO - trying https://queue.taskcluster.net/v1/task/S8_BmWORTH2DSgQ8Y2MOGg/artifacts/public/build/target.test_packages.json 10:32:05 INFO - Downloading https://queue.taskcluster.net/v1/task/S8_BmWORTH2DSgQ8Y2MOGg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:32:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S8_BmWORTH2DSgQ8Y2MOGg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:32:06 INFO - Downloaded 989 bytes. 10:32:06 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:32:06 INFO - Using the following test package requirements: 10:32:06 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:32:06 INFO - u'common': [u'target.common.tests.zip'], 10:32:06 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:32:06 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:32:06 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:32:06 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:32:06 INFO - u'mozbase': [u'target.common.tests.zip'], 10:32:06 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:32:06 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:32:06 INFO - u'web-platform': [u'target.common.tests.zip', 10:32:06 INFO - u'target.web-platform.tests.tar.gz'], 10:32:06 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:32:06 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:32:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S8_BmWORTH2DSgQ8Y2MOGg/artifacts/public/build/target.common.tests.zip 10:32:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S8_BmWORTH2DSgQ8Y2MOGg/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:32:06 INFO - Fetch https://queue.taskcluster.net/v1/task/S8_BmWORTH2DSgQ8Y2MOGg/artifacts/public/build/target.common.tests.zip into memory 10:32:08 INFO - Content-Length response header: 73377694 10:32:08 INFO - Bytes received: 73377694 10:32:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:32:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S8_BmWORTH2DSgQ8Y2MOGg/artifacts/public/build/target.common.tests.zip 10:32:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S8_BmWORTH2DSgQ8Y2MOGg/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:32:19 INFO - Fetch https://queue.taskcluster.net/v1/task/S8_BmWORTH2DSgQ8Y2MOGg/artifacts/public/build/target.common.tests.zip into memory 10:32:20 INFO - Content-Length response header: 73377694 10:32:20 INFO - Bytes received: 73377694 10:32:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S8_BmWORTH2DSgQ8Y2MOGg/artifacts/public/build/target.talos.tests.zip 10:32:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S8_BmWORTH2DSgQ8Y2MOGg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:32:33 INFO - Fetch https://queue.taskcluster.net/v1/task/S8_BmWORTH2DSgQ8Y2MOGg/artifacts/public/build/target.talos.tests.zip into memory 10:32:33 INFO - Content-Length response header: 14498826 10:32:33 INFO - Bytes received: 14498826 10:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:34 INFO - trying https://queue.taskcluster.net/v1/task/S8_BmWORTH2DSgQ8Y2MOGg/artifacts/public/build/target.tar.bz2 10:32:34 INFO - Downloading https://queue.taskcluster.net/v1/task/S8_BmWORTH2DSgQ8Y2MOGg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:32:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S8_BmWORTH2DSgQ8Y2MOGg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:32:35 INFO - Downloaded 62950304 bytes. 10:32:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S8_BmWORTH2DSgQ8Y2MOGg/artifacts/public/build/target.tar.bz2 10:32:35 INFO - mkdir: /builds/slave/test/properties 10:32:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:32:35 INFO - Writing to file /builds/slave/test/properties/build_url 10:32:35 INFO - Contents: 10:32:35 INFO - build_url:https://queue.taskcluster.net/v1/task/S8_BmWORTH2DSgQ8Y2MOGg/artifacts/public/build/target.tar.bz2 10:32:35 INFO - Running post-action listener: _resource_record_post_action 10:32:35 INFO - Running post-action listener: set_extra_try_arguments 10:32:35 INFO - [mozharness: 2017-07-22 17:32:35.648838Z] Finished download-and-extract step (success) 10:32:35 INFO - [mozharness: 2017-07-22 17:32:35.648947Z] Running populate-webroot step. 10:32:35 INFO - Running pre-action listener: _resource_record_pre_action 10:32:35 INFO - Running main action method: populate_webroot 10:32:35 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:32:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:32:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:32:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:32:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:32:35 INFO - 'tests': ['damp', 'tps']}, 10:32:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:32:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:32:35 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:32:35 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:32:35 INFO - 'other-e10s': {'tests': ['a11yr', 10:32:35 INFO - 'ts_paint', 10:32:35 INFO - 'tpaint', 10:32:35 INFO - 'sessionrestore', 10:32:35 INFO - 'sessionrestore_many_windows', 10:32:35 INFO - 'sessionrestore_no_auto_restore', 10:32:35 INFO - 'tabpaint']}, 10:32:35 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:32:35 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:32:35 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:32:35 INFO - 'talos_options': ['--mitmproxy', 10:32:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:32:35 INFO - '--firstNonBlankPaint'], 10:32:35 INFO - 'tests': ['quantum_pageload_google', 10:32:35 INFO - 'quantum_pageload_youtube', 10:32:35 INFO - 'quantum_pageload_amazon', 10:32:35 INFO - 'quantum_pageload_facebook']}, 10:32:35 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:32:35 INFO - 'talos_options': ['--stylo', 10:32:35 INFO - '--mitmproxy', 10:32:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:32:35 INFO - '--firstNonBlankPaint'], 10:32:35 INFO - 'tests': ['quantum_pageload_google', 10:32:35 INFO - 'quantum_pageload_youtube', 10:32:35 INFO - 'quantum_pageload_amazon', 10:32:35 INFO - 'quantum_pageload_facebook']}, 10:32:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:32:35 INFO - 'tsvgr_opacity', 10:32:35 INFO - 'tart', 10:32:35 INFO - 'tscrollx', 10:32:35 INFO - 'cart', 10:32:35 INFO - 'tsvg_static']}, 10:32:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:32:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:32:35 INFO - 'talos_options': ['--xperf_path', 10:32:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:32:35 INFO - 'tests': ['tp5n']}}} 10:32:35 INFO - Running post-action listener: _resource_record_post_action 10:32:35 INFO - [mozharness: 2017-07-22 17:32:35.656205Z] Finished populate-webroot step (success) 10:32:35 INFO - [mozharness: 2017-07-22 17:32:35.656295Z] Running create-virtualenv step. 10:32:35 INFO - Running pre-action listener: _resource_record_pre_action 10:32:35 INFO - Running main action method: create_virtualenv 10:32:35 INFO - Creating virtualenv /builds/slave/test/build/venv 10:32:35 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 10:32:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:32:35 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:32:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:32:35 INFO - Using real prefix '/usr' 10:32:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:32:36 INFO - Installing distribute.............................................................................................................................................................................................done. 10:32:38 INFO - Installing pip.................done. 10:32:38 INFO - Return code: 0 10:32:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:32:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:32:38 INFO - Reading from file tmpfile_stdout 10:32:38 INFO - Output received: 10:32:38 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) 10:32:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:38 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 0x1fb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231ceb0>, '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 0x231ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500738916.67619-496437824', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:32:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:32:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:32:38 INFO - Using env: {'DISPLAY': ':0', 10:32:38 INFO - 'HOME': '/home/cltbld', 10:32:38 INFO - 'LANG': 'en_US.UTF-8', 10:32:38 INFO - 'LANGUAGE': 'en_US:en', 10:32:38 INFO - 'LOGNAME': 'cltbld', 10:32:38 INFO - 'MAIL': '/var/mail/cltbld', 10:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:38 INFO - 'MOZ_NO_REMOTE': '1', 10:32:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:38 INFO - 'NO_EM_RESTART': '1', 10:32:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:38 INFO - 'PWD': '/builds/slave/test', 10:32:38 INFO - 'SHELL': '/bin/bash', 10:32:38 INFO - 'SHLVL': '1', 10:32:38 INFO - 'TERM': 'linux', 10:32:38 INFO - 'TMOUT': '86400', 10:32:38 INFO - 'USER': 'cltbld', 10:32:38 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500738916.67619-496437824', 10:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:38 INFO - '_': '/tools/buildbot/bin/python'} 10:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:38 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 10:32:38 INFO - Cleaning up... 10:32:38 INFO - Return code: 0 10:32:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:38 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 0x1fb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231ceb0>, '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 0x231ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500738916.67619-496437824', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:32:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:32:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:32:38 INFO - Using env: {'DISPLAY': ':0', 10:32:38 INFO - 'HOME': '/home/cltbld', 10:32:38 INFO - 'LANG': 'en_US.UTF-8', 10:32:38 INFO - 'LANGUAGE': 'en_US:en', 10:32:38 INFO - 'LOGNAME': 'cltbld', 10:32:38 INFO - 'MAIL': '/var/mail/cltbld', 10:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:38 INFO - 'MOZ_NO_REMOTE': '1', 10:32:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:38 INFO - 'NO_EM_RESTART': '1', 10:32:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:38 INFO - 'PWD': '/builds/slave/test', 10:32:38 INFO - 'SHELL': '/bin/bash', 10:32:38 INFO - 'SHLVL': '1', 10:32:38 INFO - 'TERM': 'linux', 10:32:38 INFO - 'TMOUT': '86400', 10:32:38 INFO - 'USER': 'cltbld', 10:32:38 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500738916.67619-496437824', 10:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:38 INFO - '_': '/tools/buildbot/bin/python'} 10:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:38 INFO - Downloading/unpacking psutil>=3.1.1 10:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:32:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:32:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:32:40 INFO - Installing collected packages: psutil 10:32:40 INFO - Running setup.py install for psutil 10:32:40 INFO - building 'psutil._psutil_linux' extension 10:32:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:32:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:32:40 INFO - building 'psutil._psutil_posix' extension 10:32:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:32:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:32:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:32:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:32:40 INFO - Successfully installed psutil 10:32:40 INFO - Cleaning up... 10:32:40 INFO - Return code: 0 10:32:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:40 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 0x1fb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231ceb0>, '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 0x231ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500738916.67619-496437824', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:32:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:32:40 INFO - Using env: {'DISPLAY': ':0', 10:32:40 INFO - 'HOME': '/home/cltbld', 10:32:40 INFO - 'LANG': 'en_US.UTF-8', 10:32:40 INFO - 'LANGUAGE': 'en_US:en', 10:32:40 INFO - 'LOGNAME': 'cltbld', 10:32:40 INFO - 'MAIL': '/var/mail/cltbld', 10:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:40 INFO - 'MOZ_NO_REMOTE': '1', 10:32:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:40 INFO - 'NO_EM_RESTART': '1', 10:32:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:40 INFO - 'PWD': '/builds/slave/test', 10:32:40 INFO - 'SHELL': '/bin/bash', 10:32:40 INFO - 'SHLVL': '1', 10:32:40 INFO - 'TERM': 'linux', 10:32:40 INFO - 'TMOUT': '86400', 10:32:40 INFO - 'USER': 'cltbld', 10:32:40 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500738916.67619-496437824', 10:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:40 INFO - '_': '/tools/buildbot/bin/python'} 10:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:32:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:32:41 INFO - Installing collected packages: mozsystemmonitor 10:32:41 INFO - Running setup.py install for mozsystemmonitor 10:32:42 INFO - Successfully installed mozsystemmonitor 10:32:42 INFO - Cleaning up... 10:32:42 INFO - Return code: 0 10:32:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:42 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 0x1fb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231ceb0>, '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 0x231ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500738916.67619-496437824', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:32:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:32:42 INFO - Using env: {'DISPLAY': ':0', 10:32:42 INFO - 'HOME': '/home/cltbld', 10:32:42 INFO - 'LANG': 'en_US.UTF-8', 10:32:42 INFO - 'LANGUAGE': 'en_US:en', 10:32:42 INFO - 'LOGNAME': 'cltbld', 10:32:42 INFO - 'MAIL': '/var/mail/cltbld', 10:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:42 INFO - 'MOZ_NO_REMOTE': '1', 10:32:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:42 INFO - 'NO_EM_RESTART': '1', 10:32:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:42 INFO - 'PWD': '/builds/slave/test', 10:32:42 INFO - 'SHELL': '/bin/bash', 10:32:42 INFO - 'SHLVL': '1', 10:32:42 INFO - 'TERM': 'linux', 10:32:42 INFO - 'TMOUT': '86400', 10:32:42 INFO - 'USER': 'cltbld', 10:32:42 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500738916.67619-496437824', 10:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:42 INFO - '_': '/tools/buildbot/bin/python'} 10:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:42 INFO - Downloading/unpacking jsonschema==2.5.1 10:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:32:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:43 INFO - Downloading functools32-3.2.3-2.tar.gz 10:32:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:32:43 INFO - warning: no files found matching '*.txt' 10:32:43 INFO - no previously-included directories found matching 'build' 10:32:43 INFO - no previously-included directories found matching 'dist' 10:32:43 INFO - no previously-included directories found matching '.git*' 10:32:43 INFO - Installing collected packages: jsonschema, functools32 10:32:43 INFO - Running setup.py install for functools32 10:32:43 INFO - warning: no files found matching '*.txt' 10:32:43 INFO - no previously-included directories found matching 'build' 10:32:43 INFO - no previously-included directories found matching 'dist' 10:32:43 INFO - no previously-included directories found matching '.git*' 10:32:43 INFO - Successfully installed jsonschema functools32 10:32:43 INFO - Cleaning up... 10:32:43 INFO - Return code: 0 10:32:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:43 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 0x1fb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231ceb0>, '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 0x231ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500738916.67619-496437824', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:32:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:32:43 INFO - Using env: {'DISPLAY': ':0', 10:32:43 INFO - 'HOME': '/home/cltbld', 10:32:43 INFO - 'LANG': 'en_US.UTF-8', 10:32:43 INFO - 'LANGUAGE': 'en_US:en', 10:32:43 INFO - 'LOGNAME': 'cltbld', 10:32:43 INFO - 'MAIL': '/var/mail/cltbld', 10:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:43 INFO - 'MOZ_NO_REMOTE': '1', 10:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:43 INFO - 'NO_EM_RESTART': '1', 10:32:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:43 INFO - 'PWD': '/builds/slave/test', 10:32:43 INFO - 'SHELL': '/bin/bash', 10:32:43 INFO - 'SHLVL': '1', 10:32:43 INFO - 'TERM': 'linux', 10:32:43 INFO - 'TMOUT': '86400', 10:32:43 INFO - 'USER': 'cltbld', 10:32:43 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500738916.67619-496437824', 10:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:43 INFO - '_': '/tools/buildbot/bin/python'} 10:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:32:43 INFO - Cleaning up... 10:32:43 INFO - Return code: 0 10:32:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:43 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 0x1fb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231ceb0>, '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 0x231ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500738916.67619-496437824', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:32:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:32:43 INFO - Using env: {'DISPLAY': ':0', 10:32:43 INFO - 'HOME': '/home/cltbld', 10:32:43 INFO - 'LANG': 'en_US.UTF-8', 10:32:43 INFO - 'LANGUAGE': 'en_US:en', 10:32:43 INFO - 'LOGNAME': 'cltbld', 10:32:43 INFO - 'MAIL': '/var/mail/cltbld', 10:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:43 INFO - 'MOZ_NO_REMOTE': '1', 10:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:43 INFO - 'NO_EM_RESTART': '1', 10:32:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:43 INFO - 'PWD': '/builds/slave/test', 10:32:43 INFO - 'SHELL': '/bin/bash', 10:32:43 INFO - 'SHLVL': '1', 10:32:43 INFO - 'TERM': 'linux', 10:32:43 INFO - 'TMOUT': '86400', 10:32:43 INFO - 'USER': 'cltbld', 10:32:43 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500738916.67619-496437824', 10:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:43 INFO - '_': '/tools/buildbot/bin/python'} 10:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:44 INFO - Downloading/unpacking blobuploader==1.2.4 10:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:45 INFO - Downloading blobuploader-1.2.4.tar.gz 10:32:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:32:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:32:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:45 INFO - Downloading docopt-0.6.1.tar.gz 10:32:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:32:45 INFO - Installing collected packages: blobuploader, requests, docopt 10:32:45 INFO - Running setup.py install for blobuploader 10:32:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:32:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:32:45 INFO - Running setup.py install for requests 10:32:46 INFO - Running setup.py install for docopt 10:32:46 INFO - Successfully installed blobuploader requests docopt 10:32:46 INFO - Cleaning up... 10:32:46 INFO - Return code: 0 10:32:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:46 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 0x1fb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231ceb0>, '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 0x231ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500738916.67619-496437824', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:32:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:32:46 INFO - Using env: {'DISPLAY': ':0', 10:32:46 INFO - 'HOME': '/home/cltbld', 10:32:46 INFO - 'LANG': 'en_US.UTF-8', 10:32:46 INFO - 'LANGUAGE': 'en_US:en', 10:32:46 INFO - 'LOGNAME': 'cltbld', 10:32:46 INFO - 'MAIL': '/var/mail/cltbld', 10:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:46 INFO - 'MOZ_NO_REMOTE': '1', 10:32:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:46 INFO - 'NO_EM_RESTART': '1', 10:32:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:46 INFO - 'PWD': '/builds/slave/test', 10:32:46 INFO - 'SHELL': '/bin/bash', 10:32:46 INFO - 'SHLVL': '1', 10:32:46 INFO - 'TERM': 'linux', 10:32:46 INFO - 'TMOUT': '86400', 10:32:46 INFO - 'USER': 'cltbld', 10:32:46 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500738916.67619-496437824', 10:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:46 INFO - '_': '/tools/buildbot/bin/python'} 10:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:32:46 INFO - Running setup.py (path:/tmp/pip-fa45mx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:32:46 INFO - Running setup.py (path:/tmp/pip-Vu6Ir1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:32:46 INFO - Running setup.py (path:/tmp/pip-pb2v2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:32:46 INFO - Running setup.py (path:/tmp/pip-Dr1AS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:32:46 INFO - Running setup.py (path:/tmp/pip-VxuGmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:32:47 INFO - Running setup.py (path:/tmp/pip-MdhRzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:32:47 INFO - Running setup.py (path:/tmp/pip-CoCJF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:32:47 INFO - Running setup.py (path:/tmp/pip-_hMlQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:32:47 INFO - Running setup.py (path:/tmp/pip-YBcUgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:32:47 INFO - Running setup.py (path:/tmp/pip-j536Xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:32:47 INFO - Running setup.py (path:/tmp/pip-Af_hBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:32:47 INFO - Running setup.py (path:/tmp/pip-L93vqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:32:47 INFO - Running setup.py (path:/tmp/pip-fElF8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:32:47 INFO - Running setup.py (path:/tmp/pip-9B68KQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:32:47 INFO - Running setup.py (path:/tmp/pip-0ATqlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:32:47 INFO - Running setup.py (path:/tmp/pip-qqnXJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:32:47 INFO - Running setup.py (path:/tmp/pip-DM9csq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:32:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:32:47 INFO - Running setup.py install for manifestparser 10:32:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:32:48 INFO - Running setup.py install for mozcrash 10:32:48 INFO - Running setup.py install for mozdebug 10:32:48 INFO - Running setup.py install for mozdevice 10:32:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:32:48 INFO - Running setup.py install for mozfile 10:32:48 INFO - Running setup.py install for mozhttpd 10:32:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:32:48 INFO - Running setup.py install for mozinfo 10:32:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:32:48 INFO - Running setup.py install for mozInstall 10:32:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:32:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:32:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:32:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:32:48 INFO - Running setup.py install for mozleak 10:32:48 INFO - Running setup.py install for mozlog 10:32:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:32:48 INFO - Running setup.py install for moznetwork 10:32:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:32:49 INFO - Running setup.py install for mozprocess 10:32:49 INFO - Running setup.py install for mozprofile 10:32:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:32:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:32:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:32:49 INFO - Running setup.py install for mozrunner 10:32:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:32:49 INFO - Running setup.py install for mozscreenshot 10:32:49 INFO - Running setup.py install for moztest 10:32:49 INFO - Running setup.py install for mozversion 10:32:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:32:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:32:49 INFO - Cleaning up... 10:32:49 INFO - Return code: 0 10:32:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:49 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 0x1fb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231ceb0>, '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 0x231ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500738916.67619-496437824', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:32:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:32:49 INFO - Using env: {'DISPLAY': ':0', 10:32:49 INFO - 'HOME': '/home/cltbld', 10:32:49 INFO - 'LANG': 'en_US.UTF-8', 10:32:49 INFO - 'LANGUAGE': 'en_US:en', 10:32:49 INFO - 'LOGNAME': 'cltbld', 10:32:49 INFO - 'MAIL': '/var/mail/cltbld', 10:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:49 INFO - 'MOZ_NO_REMOTE': '1', 10:32:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:49 INFO - 'NO_EM_RESTART': '1', 10:32:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:49 INFO - 'PWD': '/builds/slave/test', 10:32:49 INFO - 'SHELL': '/bin/bash', 10:32:49 INFO - 'SHLVL': '1', 10:32:49 INFO - 'TERM': 'linux', 10:32:49 INFO - 'TMOUT': '86400', 10:32:49 INFO - 'USER': 'cltbld', 10:32:49 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500738916.67619-496437824', 10:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:49 INFO - '_': '/tools/buildbot/bin/python'} 10:32:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:32:49 INFO - Running setup.py (path:/tmp/pip-TI4Q0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:32:50 INFO - Running setup.py (path:/tmp/pip-zg0PnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:32:50 INFO - Running setup.py (path:/tmp/pip-HMMMkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:32:50 INFO - Running setup.py (path:/tmp/pip-R0Xkq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:32:50 INFO - Running setup.py (path:/tmp/pip-xJyoBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:32:50 INFO - Running setup.py (path:/tmp/pip-psh7HV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:32:50 INFO - Running setup.py (path:/tmp/pip-hcJhv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:32:50 INFO - Running setup.py (path:/tmp/pip-ua9XwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:32:50 INFO - Running setup.py (path:/tmp/pip-wpbf5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:32:50 INFO - Running setup.py (path:/tmp/pip-8CVKIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:32:50 INFO - Running setup.py (path:/tmp/pip-zLyIab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:32:50 INFO - Running setup.py (path:/tmp/pip-WI12n1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:32:50 INFO - Running setup.py (path:/tmp/pip-o5WwhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:32:50 INFO - Running setup.py (path:/tmp/pip-8X7p4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:32:50 INFO - Running setup.py (path:/tmp/pip-b9rgPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:32:51 INFO - Running setup.py (path:/tmp/pip-mLH8dP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:32:51 INFO - Running setup.py (path:/tmp/pip-UGIRX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:32:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:52 INFO - Downloading blessings-1.6.tar.gz 10:32:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:32:52 INFO - Installing collected packages: blessings 10:32:52 INFO - Running setup.py install for blessings 10:32:52 INFO - Successfully installed blessings 10:32:52 INFO - Cleaning up... 10:32:52 INFO - Return code: 0 10:32:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:32:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:32:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:32:52 INFO - Reading from file tmpfile_stdout 10:32:52 INFO - Current package versions: 10:32:52 INFO - argparse == 1.2.1 10:32:52 INFO - blessings == 1.6 10:32:52 INFO - blobuploader == 1.2.4 10:32:52 INFO - docopt == 0.6.1 10:32:52 INFO - functools32 == 3.2.3-2 10:32:52 INFO - jsonschema == 2.5.1 10:32:52 INFO - manifestparser == 1.1 10:32:52 INFO - mozInstall == 1.13 10:32:52 INFO - mozcrash == 1.0 10:32:52 INFO - mozdebug == 0.1 10:32:52 INFO - mozdevice == 0.51 10:32:52 INFO - mozfile == 1.2 10:32:52 INFO - mozhttpd == 0.7 10:32:52 INFO - mozinfo == 0.10 10:32:52 INFO - mozleak == 0.1 10:32:52 INFO - mozlog == 3.5 10:32:52 INFO - moznetwork == 0.27 10:32:52 INFO - mozprocess == 0.25 10:32:52 INFO - mozprofile == 0.28 10:32:52 INFO - mozrunner == 6.13 10:32:52 INFO - mozscreenshot == 0.1 10:32:52 INFO - mozsystemmonitor == 0.3 10:32:52 INFO - moztest == 0.8 10:32:52 INFO - mozversion == 1.4 10:32:52 INFO - psutil == 3.1.1 10:32:52 INFO - requests == 1.2.3 10:32:52 INFO - wsgiref == 0.1.2 10:32:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:52 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 0x1fb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231ceb0>, '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 0x231ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500738916.67619-496437824', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:32:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:32:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:32:52 INFO - Using env: {'DISPLAY': ':0', 10:32:52 INFO - 'HOME': '/home/cltbld', 10:32:52 INFO - 'LANG': 'en_US.UTF-8', 10:32:52 INFO - 'LANGUAGE': 'en_US:en', 10:32:52 INFO - 'LOGNAME': 'cltbld', 10:32:52 INFO - 'MAIL': '/var/mail/cltbld', 10:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:52 INFO - 'MOZ_NO_REMOTE': '1', 10:32:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:52 INFO - 'NO_EM_RESTART': '1', 10:32:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:52 INFO - 'PWD': '/builds/slave/test', 10:32:52 INFO - 'SHELL': '/bin/bash', 10:32:52 INFO - 'SHLVL': '1', 10:32:52 INFO - 'TERM': 'linux', 10:32:52 INFO - 'TMOUT': '86400', 10:32:52 INFO - 'USER': 'cltbld', 10:32:52 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500738916.67619-496437824', 10:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:52 INFO - '_': '/tools/buildbot/bin/python'} 10:32:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:32:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:32:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:32:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:32:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:32:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:32:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:32:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:32:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:32:52 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:53 INFO - Downloading marionette_driver-1.4.0.tar.gz 10:32:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 10:32:54 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 10:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:32:54 INFO - Installing collected packages: marionette-driver, simplejson 10:32:54 INFO - Running setup.py install for marionette-driver 10:32:54 INFO - Running setup.py install for simplejson 10:32:54 INFO - building 'simplejson._speedups' extension 10:32:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 10:32:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 10:32:55 INFO - Successfully installed marionette-driver simplejson 10:32:55 INFO - Cleaning up... 10:32:55 INFO - Return code: 0 10:32:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:55 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 0x1fb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231ceb0>, '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 0x231ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500738916.67619-496437824', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:32:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:32:55 INFO - Using env: {'DISPLAY': ':0', 10:32:55 INFO - 'HOME': '/home/cltbld', 10:32:55 INFO - 'LANG': 'en_US.UTF-8', 10:32:55 INFO - 'LANGUAGE': 'en_US:en', 10:32:55 INFO - 'LOGNAME': 'cltbld', 10:32:55 INFO - 'MAIL': '/var/mail/cltbld', 10:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:55 INFO - 'MOZ_NO_REMOTE': '1', 10:32:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:55 INFO - 'NO_EM_RESTART': '1', 10:32:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:55 INFO - 'PWD': '/builds/slave/test', 10:32:55 INFO - 'SHELL': '/bin/bash', 10:32:55 INFO - 'SHLVL': '1', 10:32:55 INFO - 'TERM': 'linux', 10:32:55 INFO - 'TMOUT': '86400', 10:32:55 INFO - 'USER': 'cltbld', 10:32:55 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500738916.67619-496437824', 10:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:55 INFO - '_': '/tools/buildbot/bin/python'} 10:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:32:55 INFO - Cleaning up... 10:32:55 INFO - Return code: 0 10:32:55 INFO - Running post-action listener: _resource_record_post_action 10:32:55 INFO - Running post-action listener: _start_resource_monitoring 10:32:55 INFO - Starting resource monitoring. 10:32:55 INFO - [mozharness: 2017-07-22 17:32:55.718178Z] Finished create-virtualenv step (success) 10:32:55 INFO - [mozharness: 2017-07-22 17:32:55.718696Z] Running install step. 10:32:55 INFO - Running pre-action listener: _resource_record_pre_action 10:32:55 INFO - Running main action method: install 10:32:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:32:55 INFO - Reading from file tmpfile_stdout 10:32:55 INFO - Detecting whether we're running mozinstall >=1.0... 10:32:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:32:56 INFO - Reading from file tmpfile_stdout 10:32:56 INFO - Output received: 10:32:56 INFO - Usage: mozinstall [options] installer 10:32:56 INFO - Options: 10:32:56 INFO - -h, --help show this help message and exit 10:32:56 INFO - -d DEST, --destination=DEST 10:32:56 INFO - Directory to install application into. [default: 10:32:56 INFO - "/builds/slave/test"] 10:32:56 INFO - --app=APP Application being installed. [default: firefox] 10:32:56 INFO - mkdir: /builds/slave/test/build/application 10:32:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:33:13 INFO - Reading from file tmpfile_stdout 10:33:13 INFO - Output received: 10:33:13 INFO - /builds/slave/test/build/application/firefox/firefox 10:33:13 INFO - Running post-action listener: _resource_record_post_action 10:33:13 INFO - [mozharness: 2017-07-22 17:33:13.864621Z] Finished install step (success) 10:33:13 INFO - [mozharness: 2017-07-22 17:33:13.864946Z] Running setup-mitmproxy step. 10:33:13 INFO - Running pre-action listener: _resource_record_pre_action 10:33:13 INFO - Running main action method: setup_mitmproxy 10:33:13 INFO - Skipping: mitmproxy is not required 10:33:13 INFO - Running post-action listener: _resource_record_post_action 10:33:13 INFO - [mozharness: 2017-07-22 17:33:13.866096Z] Finished setup-mitmproxy step (success) 10:33:13 INFO - [mozharness: 2017-07-22 17:33:13.866319Z] Running run-tests step. 10:33:13 INFO - Running pre-action listener: _resource_record_pre_action 10:33:13 INFO - Running pre-action listener: _set_gcov_prefix 10:33:13 INFO - Running main action method: run_tests 10:33:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:33:13 INFO - Python 2.7.3 10:33:13 INFO - Return code: 0 10:33:13 INFO - grabbing minidump binary from tooltool 10:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:13 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 0x231ceb0>, '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 0x231ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:33:13 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 10:33:13 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 10:33:13 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 10:33:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:33:13 INFO - Return code: 0 10:33:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:33:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:33:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:33:13 INFO - ENV: RUST_BACKTRACE is now 1 10:33:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:33:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:33:13 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/S8_BmWORTH2DSgQ8Y2MOGg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:33:13 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/S8_BmWORTH2DSgQ8Y2MOGg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-071 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:33:14 INFO - Using env: {'DISPLAY': ':0', 10:33:14 INFO - 'HOME': '/home/cltbld', 10:33:14 INFO - 'LANG': 'en_US.UTF-8', 10:33:14 INFO - 'LANGUAGE': 'en_US:en', 10:33:14 INFO - 'LOGNAME': 'cltbld', 10:33:14 INFO - 'MAIL': '/var/mail/cltbld', 10:33:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:33:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:33:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:14 INFO - 'MOZ_NO_REMOTE': '1', 10:33:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:33:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:14 INFO - 'NO_EM_RESTART': '1', 10:33:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:14 INFO - 'PWD': '/builds/slave/test', 10:33:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:33:14 INFO - 'RUST_BACKTRACE': '1', 10:33:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:33:14 INFO - 'SHELL': '/bin/bash', 10:33:14 INFO - 'SHLVL': '1', 10:33:14 INFO - 'TERM': 'linux', 10:33:14 INFO - 'TMOUT': '86400', 10:33:14 INFO - 'USER': 'cltbld', 10:33:14 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500738916.67619-496437824', 10:33:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:14 INFO - '_': '/tools/buildbot/bin/python'} 10:33:14 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/S8_BmWORTH2DSgQ8Y2MOGg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:33:14 INFO - mozversion application_buildid: 20170722162434 10:33:14 INFO - mozversion application_changeset: c22502562670e5e53bea543a3ee25c81f1a7b624 10:33:14 INFO - mozversion application_display_name: Nightly 10:33:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:33:14 INFO - mozversion application_name: Firefox 10:33:14 INFO - mozversion application_remotingname: firefox 10:33:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:33:14 INFO - mozversion application_vendor: Mozilla 10:33:14 INFO - mozversion application_version: 56.0a1 10:33:14 INFO - mozversion platform_buildid: 20170722162434 10:33:14 INFO - mozversion platform_changeset: c22502562670e5e53bea543a3ee25c81f1a7b624 10:33:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:33:14 INFO - mozversion platform_version: 56.0a1 10:33:14 INFO - using testdate: 1500744794 10:33:14 INFO - actual date: 1500744794 10:33:14 INFO - starting webserver on 'localhost:55957' 10:33:14 INFO - SUITE-START | Running 2 tests 10:33:14 INFO - TEST-START | dromaeo_css 10:33:14 INFO - Initialising browser for dromaeo_css test... 10:33:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55957/getInfo.html -profile /tmp/tmpvlmTeF/profile 10:33:14 INFO - TEST-INFO | started process 12963 (/builds/slave/test/build/application/firefox/firefox http://localhost:55957/getInfo.html) 10:33:20 INFO - TEST-INFO | 12963: exit 0 10:33:21 INFO - Browser initialized. 10:33:21 INFO - Running cycle 1/1 for dromaeo_css test... 10:33:21 INFO - TEST-INFO | started process 13182 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvlmTeF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:33:32 INFO - PID 13182 | RSS: Main: 167247872 10:33:32 INFO - PID 13182 | 10:36:30 INFO - PID 13182 | Cycle 1(1): loaded http://localhost:55957/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55957/tests/dromaeo/cssquery-ext.html) 10:36:32 INFO - PID 13182 | RSS: Main: 173436928 10:36:32 INFO - PID 13182 | 10:39:33 INFO - PID 13182 | Cycle 1(1): loaded http://localhost:55957/tests/dromaeo/cssquery-ext.html (next: http://localhost:55957/tests/dromaeo/cssquery-jquery.html) 10:39:34 INFO - PID 13182 | RSS: Main: 170614784 10:39:34 INFO - PID 13182 | 10:42:35 INFO - PID 13182 | Cycle 1(1): loaded http://localhost:55957/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55957/tests/dromaeo/cssquery-mootools.html) 10:42:36 INFO - PID 13182 | RSS: Main: 172298240 10:42:36 INFO - PID 13182 | 10:45:38 INFO - PID 13182 | Cycle 1(1): loaded http://localhost:55957/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55957/tests/dromaeo/cssquery-prototype.html) 10:45:38 INFO - PID 13182 | RSS: Main: 171749376 10:45:38 INFO - PID 13182 | 10:48:41 INFO - PID 13182 | Cycle 1(1): loaded http://localhost:55957/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55957/tests/dromaeo/cssquery-yui.html) 10:48:42 INFO - PID 13182 | RSS: Main: 173105152 10:48:42 INFO - PID 13182 | 10:51:44 INFO - PID 13182 | Cycle 1(1): loaded http://localhost:55957/tests/dromaeo/cssquery-yui.html (next: http://localhost:55957/tests/dromaeo/cssquery-dojo.html) 10:51:44 INFO - PID 13182 | RSS: Main: 175382528 10:51:44 INFO - PID 13182 | 10:51:44 INFO - PID 13182 | __start_tp_report 10:51:44 INFO - PID 13182 | _x_x_mozilla_page_load 10:51:44 INFO - PID 13182 | _x_x_mozilla_page_load_details 10:51:44 INFO - PID 13182 | |i|pagename|runs| 10:51:44 INFO - PID 13182 | |0;dojo.html;3339.749518786092;3382.934375671663;3384.526166336712;3387.424137896557;3403.4044042292608;6043.30501992271;6139.6316221026655;6151.907721384177;6152.077188421739;6173;5979.611325263855;6058.878822423549;6088.634681919088;6089.147519347284;6151.384861513847;5314.309139811839;5346.438623944478;5354.705491197982;5356.4107948125675;5380.0046991306735;5180.611454140936;5193.376794784631;5294;5460.208269800896;5479.890402191973;5324.946750532484;5398.8920221595545;5400.783968641289;5419.918701219485;5419.972900135514;5282.920756188621;5316.175992721134;5343.171808369709;5401.918971215435;5406.351237851483;5314.468553144655;5346.705931173784;5383.75773090208;5394.109971854639;5396.9730151348995;6041.72812223451;6050.576459647827;6115.113308570232;6129.693515324216;6167.629942203482;6439.5170362223025;6543.574667646635;6569.244536878273;6625.801225963229;6631.900521492182;6621.271660117383;6637.800865974028;6670.866582668368;6687.966560167217;6690.83272918181;6099.969500152471;6139.693015349215;6172.537059720539;6199.287081985584;6211.751529938797;6595.175603049619;6679.165104361955;6691.5315927884585;6753.561018533779;6785.8642827143185;6444.742210311535;6497.5126865484335;6528.1187039749975;6542.443892269211;6543.1821022372205;6552.737890484327;6568.737250510022;6591.868162636721;6642.302558231413;6679.632620205935;6405.231372235362;6492.09110724499;6511.73953041873;6513.5114866384265;6599.373059559334;6534.150560427114;6547.672616369257;6568.67156642166;6576.44100251484;6610.338966103352;4817.0365926814775;4861.805527778849;4865.513448655106;4867.123917694849;4875.19559272716;4295.72077814941;4300.892477688083;4340.587644173798;4347.456567929009;4348.065165989265;6106.78626248088;6166.414190651881;6171.814845554641;6216.658083805434;6255.43701066897;6590.9670451647435;6626;6666.633335166613;6685.0640910272605;6688.030235615808;6175.228096487939;6246.063090536456;6309.558330916791;6310.5267104967315;6336.52476064297;5317.867053323698;5346.759395827197;5405.70268635221;5436.864078398072;5494.148406996922;6898.551594146365;6921.134858142732;6955.478339124586;6962.1297337832775;6989.685464154125;6591.143151390289;6600.60396376219;6677.03183038447;6681.09805176295;6685.331466853276;6729.327067293231;6804.387605115563;6881.690323935335;6970.616616086164;6977.755778547727;6447.194100737408;6480.449161821298;6491.156149700509;6505;6515.804525864231;6661;6676.899846502403;6701.798946031627;6713.026611141455;6718.025886246369;6303.558750887394;6360.268569114426;6387.169667943138;6396.264429590657;6498.610083395011;6384.042393640991;6454.19322584677;6460.353964603502;6465.321141280097;6476.5466417350335;6413;6413.230412350548;6484.448821850196;6490.415862572391;6493.902591461037;6457.483401327976;6469.320721324193;6502.967485162544;6517.315681853527;6557.770478033246;6169.9691501544;6207.751689932352;6277.874442511215;6290.716917738621;6325.177726895474 10:51:44 INFO - PID 13182 | |1;ext.html;820.733261689951;861.0227391910182;880.6477409036387;884.9115088491155;1188.6731148934036;32963;42080.158396832085;42765.78617106918;42775.3583696244;42802;42537.57462425375;43072.56927430725;43183;43441.34837977425;43472.78263608678;7180.712771489134;7328.963355183217;7344.375728063121;7350.448716346295;7368;7291.197968223491;7366.484346095775;7372.520786148883;7377.077865266841;7377.926220737804;7329.926700732978;7405.81485462865;7435.479516433852;7437.144728356254;7442.553446793183;7379.114506259257;7421.183669796318;7422.369098626623;7424.777256682308;7425.034745483106;7172.605506697182;7176.138863336381;7192.712291508334;7214.242504537001;7221.783346499614;38837.22325553473;38845;38922.61077389218;38951;39054;3468.2890007548644;3507.2634746703225;3512.367773800715;3515.5078289039557;3521;31168.8441557793;31284.53073203904;31416.685833141604;31436.685633143832;31478.527822082688;4756.595689366408;4840.298156767249;4842.539958703917;4878;4882.584980276681;204145;204876;206186;206203;206488.9999999985;50079.74960125176;50127.74936125296;50145.74927125341;50205;50250;52533.47466525362;52573.7371313141;53099;53124.46875531272;53205.46794532082;14878.404863805326;16142.35430582787;16441;16445.58886027859;16531.090790006423;12196.51213951432;13127.409266583027;13347.532836350681;13434.529791457253;13501.459941602423;15334.079955202724;15381.692366152614;15392.615184620474;15393.692126157413;15517.37930482768;6147.96926015376;6253.218347706536;6269.0909818076125;6277.96861015692;6315.715792789336;1073.7208325835338;1076.3918386111823;1079.9244052916379;1086.538221255963;1087.5106202208879;24130.51738965211;24295.514089718108;24598.754012460005;24669.753302466746;24710.258692239262;1181.9940900295614;1185.9051275897907;1190.2025642819333;1194.235689158939;1213.6783752305646;12708.618741437771;13180.868191318155;13189.340532973312;13339.733205335839;13412.262325572186;271933;272182;272570;272698;274481;53871.73064134733;54154.18768718473;54246.45753542414;54293;54648;1479.578320178744;1530.1431198528637;1559.9532014039596;1562.8046494188227;1565.1861032263387;24441.51116977686;29212.26969325784;29327.413451731274;29956.700432995392;30190;53740.19389709236;54324.45675543352;54370.72814635901;54380.456195439125;54393.45606543884;241036;241825;242927;243108;244650;33783.83108084444;34204.48693269653;36950.8152459236;37088.6291137096;37489;48435.27347089726;48697;48879.75560122177;48972.265416018075;49194.50805492042;33523.329533409684;34978.47532287068;35007.47488787619;35798.46302305415;35939.28121437504;34338.48492272568;34819.12952176115;34840.82579587086;35151.29697406089;35914;41073.794631026656;41379.79310103551;41484.17031659289;41731.165376691686;41919.37120943127;31932.88234911767;33890.66109338875;34746.826265868505;34900.301993960486;35010.29979400449;25898.870505647352;26502.734972650796;26729.866350668122;27063.323416914736;27875.860620696767 10:51:44 INFO - PID 13182 | |2;jquery.html;555.1755642870337;556.5186114011376;565.9462351076646;591.2697818194529;596.3618927747311;22628.8868555657;23061.769382306193;23788.5242295154;23796.76203237965;23813.166539171132;27365.726342736616;27834.443311133764;27954.580681289797;28018.579721304144;28019.439611207814;6358.237011558608;6456.160699109109;6509.316521765218;6511.967440162793;6512.413882750551;5762.625429347079;6282.308946015934;6290.528210384216;6305.873882522347;6330.6834658267135;6227.688615569226;6262.718177682015;6266.154069200645;6268.467180289658;6269.529785266101;6255.186825712651;6262.373762623747;6263.812085637438;6264.279607845065;6270.31026587075;5844.88310233793;5854.385289544579;5855.2973643163095;5857.179994800731;5859;29472.557911631342;30936.535951960737;31204.687953120407;31324.216894577818;31537.21156971071;2213.0926320208796;2266.5126997695575;2267.9773202268098;2268.8298377621745;2277.840551161419;19679.704804427944;20093.79906200934;20156.193752249892;20187.495312617157;20209.090590923443;2330.673705681206;2371.9051237950634;2412.6260429633257;2421.128393778238;2448.9142879999113;143811;146508;146647.2667636655;147467.26266368706;147531;14505.637359065897;15667.843321566867;15699.764503532457;15972.201389930457;16146.677066458606;24150.637740433907;24158.87920560386;24160.87919560391;24170.75829241685;24172.758272417403;10545;10632.149428045737;10690.465476726133;10724.624638137628;10730.73173170677;8400.621972011275;9809.950950245346;9878.555465004092;9954.253430992705;10084.092431681183;8487;9654.855177172349;9767.386067155197;9953.651622193189;10099.293049486465;2668.7197844226466;2740.3149212696826;2741.451709658076;2852.61489698888;2875.597416361711;1046.26238501856;1048.7011201807447;1058.4707646176912;1069.1286601419974;1072.286929192094;21144.894275528524;21620.675689864664;21880.781192187875;22047.66928496074;22410.32769016932;1110.3726394587034;1114.7714718482691;1115.676453828397;1130.254032338669;1133.2916926920675;11965.940170299093;12127.211731237441;12149.542054953463;12214.877851221374;12270.75458490843;508677;518311;523349;533096;535107;125296;130141.34929325293;130650.34674826566;131096;131231;1255.6986323282347;1273.866244044362;1279.0726723125845;1284.5118854835102;1286.6718986658343;18499.352522661644;19132.23471061142;19140.330088446837;19182.808171918103;19787.802121978595;58928;59238.703806482416;59338.70330648319;60691;61480.385196147465;76485.470290595;76868.23131768835;77467.61266193633;77563;78281;14834.332455039765;15028.474003409829;15293.082415055133;15758.606034849221;15938.442154525;23652.172173973828;23818.047278108683;24124.638130427706;24135.396615084763;24142;18797.684162108522;19335.323263686267;19444.611107777484;19497.805021950167;19521.804781952;15963.281652325906;16758.32966681319;16831.41090061842;16857.15714214309;17032.403865864635;20333.186672532935;20832;21147.25984590532;21221.575568488854;21298.041588128883;14786.186759728318;15579.143147127017;15604.375824966874;15615.219239037775;15620.765688514908;19132.808671913102;20447.591048178656;20531.4867128323;20551.280705175246;20586.691199631718 10:51:44 INFO - PID 13182 | |3;mootools.html;1414.0879132959242;1476.2544914818016;1482.784996175554;1492.3060776738819;1502.8497150284973;15068.246587670614;15742.606434839136;15771.132587707685;15780.132092734924;15878.52364429066;15932;16260.51218463448;16262;16263.430779922704;16276.674466510663;2419.286310538391;2448.6694296270043;2471.752824717532;2472.159465781634;2472.3819045238693;2432.391902024494;2467.8766061696933;2478.913238036669;2504.0484615845953;2504.2987963370197;2548.3374322676145;2549.0950712496983;2564.6281289213052;2570.2032369965373;2570.473053024135;2478.7397323281066;2497.912573059943;2505.962410563843;2509.535735888848;2510.1089113364765;2439.8048156147465;2459.4343301040863;2472.196536125766;2475.8885850136785;2479.7396273391396;14964.251787410585;15286.388544458208;15292.541223763194;15300.923495382563;15301.770473442908;7979.8404031919035;8277.917220827774;8282;8284.25441710249;8301.128381519975;5008.974955125201;5038.345015148007;5076.52364033887;5186.559142472895;5237.869053273698;1899.5536049028467;1913.3016448996016;1916.7795703493998;1956.814102660245;1966.9409917702492;26853.73146268532;27089.729102709116;27121.59317610218;27143.864280678667;27146.185614431797;6594.835129121714;6714.731410743516;6773.72905083801;6973.721051157999;6985.406240469515;17354.39259625907;17728.91135544314;17733.11334433273;18042.819571804375;18070.36753713614;8089.47418417801;8299.377546683902;8306.127856574973;8326.209010144026;8326.333893288522;7546.358559522392;7614.238576142341;7672.923270767333;7727.304542591194;7737.729179478692;5239.187925871496;5379.731013449312;5405.270288511079;5415.593830462731;5468.535174510132;1539.5304432148303;1544.783730277762;1548.612846788303;1550.0544667752663;1578.3449868304754;901.6844104563351;915.8946721127155;917.3945196170496;947.7535840681472;954.5370495309769;7476.738314159087;7501.849963000709;7618.69525218985;7632.8473430532185;7652.196519365387;713.4755954373531;734.5115498193642;767.808047988003;773.5977291808229;779.8713212319904;4498.5501449854755;5554.333641255734;5767.798127065533;5943.197668314722;5969.820905372846;21695;22298.442538936655;22377.216797412013;22508.099676013102;22572.435689107904;21255.256066037615;21427.46431339229;21490.892545537172;21727.34817955464;21895.890520547295;11726.803481036195;12272.140950133406;12331.75336493265;12373.93813030929;12391.380430978415;8098.994369869903;8655.17775811297;8785.385023048326;8880.378373513791;8939.59771810283;18475.630487390445;18802.717959230897;19187.520311992314;19855.503612409804;19998.90000549988;19528.31650892212;19611.48101044873;19813.50466238298;19854.602907941473;20109.89945050324;12458.688532786753;12883.162594431333;13020.869791301966;13020.934895325463;13025.153365031243;12902.419391127234;14195.219262940638;14207.431702731776;14345;14367.928160359132;11209.15931305139;11881.405929703653;12106.455209515769;12123.151379403356;12135.271883687006;10610.52252648648;11088.279261847954;11131;11192.38441885704;11284.717882053013;10084.495775211357;10109.443980580845;10179.236557258087;10181.745456363355;10236.692899213036;7241.4206863449745;7392.815179620553;7696.307332340116;7720.227977202235;7744.651490683045;7045.189803172496;7477.887831682638;7494.100707915085;7546.886796698163;7591.164971852982 10:51:44 INFO - PID 13182 | |4;prototype.html;511.09281026178553;519.9818006369776;522.6550476685386;525.2593842681817;534.5937087813262;6153.661548614825;6172.197614310139;6199.969000154999;6207.193064901568;6218.595791273564;6038.8490287742825;6065.423784740443;6085.361037091108;6090.269167699882;6095.085737139431;4864.173090574602;4871.610271178297;4876.634252431082;4908.631852611068;4913.680610760289;4585;4740.360051393052;4810.855674329776;4852;4887.266909963499;4650.7442090685;4712.209360443044;4720.457147428056;4721.527847215285;4754.6434017448655;4689.671722979393;4718.551737584924;4755.833545825914;4774.259989701602;4788.473267940523;4191.245575796355;4250.08623146022;4271.8718438446585;4292.935605965913;4332.263515202391;5878.766068893836;5899.646021238696;5901.498372638331;5912.3496415394275;5964.761409543613;5702.258706368187;5711.200431939532;5718.370979192286;5720.570957178186;5739.913901291484;6535.26815393921;6544.280129185786;6561.93438065618;6582.275949645536;6584.440322572587;4834.830780922651;4839.467658557556;4856.271559266138;4859.58693511052;4917.918058027229;6586.081281637418;6610.93389066108;6776.288489708608;6781.932180678229;6786.558873673195;4972.7513624318635;4985.476524964899;4999.350084489066;5005.599552035901;5060.51925067118;5057.266696329085;5063.291139240509;5067.771950262247;5073.467285934998;5164.25118357836;5662.773489060474;5684.8010319638615;5688.772449102073;5703.572232082611;5732.398098199712;6567.474602031922;6577.276499585042;6586.341365863375;6604.14146160996;6613.503987200979;1729.6800091983023;1739.2868923741205;1758.268105915672;1762.6562820250185;1805.4222648752273;1155.8728539860608;1210.8304837322783;1224.8530176378893;1258.6979125010114;1260.8928241099609;6176.69116544171;6209.565330426917;6275.905861412082;6278.4035516625845;6324.33594472583;6543.803685889431;6572.319501079411;6574.441172500391;6620.139381880421;6632.533280052007;6146.784862529879;6167.290761562388;6199.721012554446;6238.75044998195;6255.624662520172;3485.3900567400606;3515.209077957439;3517.1910460593695;3559.5728512578658;3564.536610240704;6866.862662746717;6896.862062758717;6905.516613837083;6941.548799328028;6943.305669433016;6840.110785597841;6845.733539295246;6871.175458944958;6880.4839637026425;6894.482913781487;6912.481563882729;6928.515003949675;6955.513114082067;6981.476389270723;7007;6130.417610327012;6530.8040758777315;6556.246031706415;6566.0301909427935;6693.899591506034;6500.902486462802;6550.246721626883;6585.967070164618;6596.90104648421;6637.303083176197;6824.385805277549;6827.795166145023;6874.793756187322;6964.79105626832;6968.512204145661;5026.723530205873;5039.874003149951;5042.873928151679;5069.797208111634;5087.465816089258;6418.19772528434;6531.281559028598;6574.112494813139;6695.163104611924;6758.797236082925;6337.746490140527;6397.392247736458;6456.289808121197;6513.902291465726;6528.575642583407;6431.389018043278;6437.163168788027;6439.8068057958335;6472.546921715623;6495.9025614614875;6436.9034464484;6437.7103030362805;6446.516511261768;6519.185101862267;6564.376384243489;6450.580712253689;6528.640924749185;6573.901391479036;6574.8356291093105;6587.374199451045;6187.938120618736;6215.395070858981;6356.968215158895;6375.904361434489;6416.48668106541 10:51:44 INFO - PID 13182 | |5;yui.html;856.6873091321669;867.6442658510013;918.4489306416147;922.7185708358948;964.5225613321406;18293.908530457345;19453.902730486363;19465.902670486663;19477.123529441174;21650.783492165072;20101;20553.38339849803;20844.583108337825;20851.895740521315;20870.165193392248;1003.5849452272297;1088.5101704233086;1089.803835309644;1093.4478088565263;1094.5949998500566;1049.9842502362471;1067.0236733388979;1087.5486673030723;1087.7171935296801;1087.9728006799814;1127.1658972360476;1135.5798354608805;1138.8747237803834;1139;1139.145640769423;1125.2685754259714;1125.797356475834;1133.3823066428815;1134.8127558952763;1142.6000899685127;824.6742536698031;832.5837081459271;833.5998720614078;834.9206825351582;840.9789755256106;17586.384476543386;17691.29234830605;17706.734398984026;18004.279828806833;19967.900160499248;21131.683024754642;21276.255331063494;21579.136834526602;21683.67474487884;21693.240736574146;15524.844751552566;15831.208439577975;15955.680886382323;15970.600734981603;16110.355585776555;3513.5959364673135;3571.2143328467696;3572.374834403969;3573.4997100405963;3576.499290099388;128998.35500822529;131161;133153;136500.6349936498;137068;14355.282235888164;14522.636934076521;14720.411183552753;14810.481633142788;14859.554213373616;28451;28894.133176004754;28993.85503072471;29013.854930725633;29025.41949161005;8221.17788221173;8297.668093276201;8398.832023359499;8451.704190353308;8645.438046526955;4247.893802654897;4407.537208593051;4446.399736035593;4451.77741112943;4457;4980.975095124501;5029.396472423259;5089.211172268304;5111.46329635383;5981.940180598225;1116.983245251322;1129.9096072314196;1141.1498433666804;1144.8339990701468;1148.2134737704698;642.3290892549012;670.1489108831756;678.25053316086;708.387245033053;727.0366764037672;12306.261624302571;12342.75314493705;13938.094023888414;15306.770398444032;15359.92320038415;642.3801032004138;685.6960612342525;703.4161645833946;736.4108713029663;746.7386414754792;5797.855053623609;6207.844803879939;6223.782167624111;6395.264544577433;6538.509611779135;125333.37333313457;125348;129349.35325323313;132287;134760;110707.89292106975;112301;115154.42422788;116973.4151329255;119009.40495297642;92848;96012;97925.51037244768;98567.50716246373;100321.99678003126;12101.69745756363;13149.145305555108;13453.730925381633;13541;13603;45466.31800523061;48034.27948580704;48150.518494814605;50010;50980.74509627428;57188;59371.40628593831;60057.69971150116;60218;61749;16958.660826783642;18146.818531815043;18560.257589696263;18971.14629841688;19343.51641208981;22253.33240002738;22300.330990070324;22318.888405557867;22489.43776405603;22526.21158259453;20076.498087547927;20290.797092029483;20396.184152633727;20508.17967281292;20735.8963205183;19964.201431942558;20480.180792768122;20817;20854.165833366496;20863.37409877706;17139.228734707216;17355.392561260294;17478.650426991644;17588.82411175923;17673.20470578853;13183.340832958505;13353.86646133565;13506.864931350561;14164.78752818688;14584.635384115481;14764.040337378035;14853.554393368217;15186.392544298104;15353.6161595961;15406.38374465009 10:51:44 INFO - PID 13182 | __end_tp_report 10:51:44 INFO - PID 13182 | __start_cc_report 10:51:44 INFO - PID 13182 | _x_x_mozilla_cycle_collect,340 10:51:44 INFO - PID 13182 | __end_cc_report 10:51:44 INFO - PID 13182 | __startTimestamp1500745904384__endTimestamp 10:51:44 INFO - PID 13182 | 10:51:44 INFO - PID 13182 | ------- Summary: start ------- 10:51:44 INFO - PID 13182 | Number of tests: 6 10:51:44 INFO - PID 13182 | 10:51:44 INFO - PID 13182 | [#0] dojo.html Cycles:165 Average:6064.88 Median:6384.04 stddev:782.24 (12.3%) stddev-sans-first:754.86 10:51:44 INFO - PID 13182 | Values: 3339.7 3382.9 3384.5 3387.4 3403.4 6043.3 6139.6 6151.9 6152.1 6173.0 5979.6 6058.9 6088.6 6089.1 6151.4 5314.3 5346.4 5354.7 5356.4 5380.0 5180.6 5193.4 5294.0 5460.2 5479.9 5324.9 5398.9 5400.8 5419.9 5420.0 5282.9 5316.2 5343.2 5401.9 5406.4 5314.5 5346.7 5383.8 5394.1 5397.0 6041.7 6050.6 6115.1 6129.7 6167.6 6439.5 6543.6 6569.2 6625.8 6631.9 6621.3 6637.8 6670.9 6688.0 6690.8 6100.0 6139.7 6172.5 6199.3 6211.8 6595.2 6679.2 6691.5 6753.6 6785.9 6444.7 6497.5 6528.1 6542.4 6543.2 6552.7 6568.7 6591.9 6642.3 6679.6 6405.2 6492.1 6511.7 6513.5 6599.4 6534.2 6547.7 6568.7 6576.4 6610.3 4817.0 4861.8 4865.5 4867.1 4875.2 4295.7 4300.9 4340.6 4347.5 4348.1 6106.8 6166.4 6171.8 6216.7 6255.4 6591.0 6626.0 6666.6 6685.1 6688.0 6175.2 6246.1 6309.6 6310.5 6336.5 5317.9 5346.8 5405.7 5436.9 5494.1 6898.6 6921.1 6955.5 6962.1 6989.7 6591.1 6600.6 6677.0 6681.1 6685.3 6729.3 6804.4 6881.7 6970.6 6977.8 6447.2 6480.4 6491.2 6505.0 6515.8 6661.0 6676.9 6701.8 6713.0 6718.0 6303.6 6360.3 6387.2 6396.3 6498.6 6384.0 6454.2 6460.4 6465.3 6476.5 6413.0 6413.2 6484.4 6490.4 6493.9 6457.5 6469.3 6503.0 6517.3 6557.8 6170.0 6207.8 6277.9 6290.7 6325.2 10:51:44 INFO - PID 13182 | 10:51:44 INFO - PID 13182 | [#1] ext.html Cycles:180 Average:41968.28 Median:19659.73 stddev:62925.53 (320.1%) stddev-sans-first:63026.21 10:51:44 INFO - PID 13182 | Values: 820.7 861.0 880.6 884.9 1188.7 32963.0 42080.2 42765.8 42775.4 42802.0 42537.6 43072.6 43183.0 43441.3 43472.8 7180.7 7329.0 7344.4 7350.4 7368.0 7291.2 7366.5 7372.5 7377.1 7377.9 7329.9 7405.8 7435.5 7437.1 7442.6 7379.1 7421.2 7422.4 7424.8 7425.0 7172.6 7176.1 7192.7 7214.2 7221.8 38837.2 38845.0 38922.6 38951.0 39054.0 3468.3 3507.3 3512.4 3515.5 3521.0 31168.8 31284.5 31416.7 31436.7 31478.5 4756.6 4840.3 4842.5 4878.0 4882.6 204145.0 204876.0 206186.0 206203.0 206489.0 50079.7 50127.7 50145.7 50205.0 50250.0 52533.5 52573.7 53099.0 53124.5 53205.5 14878.4 16142.4 16441.0 16445.6 16531.1 12196.5 13127.4 13347.5 13434.5 13501.5 15334.1 15381.7 15392.6 15393.7 15517.4 6148.0 6253.2 6269.1 6278.0 6315.7 1073.7 1076.4 1079.9 1086.5 1087.5 24130.5 24295.5 24598.8 24669.8 24710.3 1182.0 1185.9 1190.2 1194.2 1213.7 12708.6 13180.9 13189.3 13339.7 13412.3 271933.0 272182.0 272570.0 272698.0 274481.0 53871.7 54154.2 54246.5 54293.0 54648.0 1479.6 1530.1 1560.0 1562.8 1565.2 24441.5 29212.3 29327.4 29956.7 30190.0 53740.2 54324.5 54370.7 54380.5 54393.5 241036.0 241825.0 242927.0 243108.0 244650.0 33783.8 34204.5 36950.8 37088.6 37489.0 48435.3 48697.0 48879.8 48972.3 49194.5 33523.3 34978.5 35007.5 35798.5 35939.3 34338.5 34819.1 34840.8 35151.3 35914.0 41073.8 41379.8 41484.2 41731.2 41919.4 31932.9 33890.7 34746.8 34900.3 35010.3 25898.9 26502.7 26729.9 27063.3 27875.9 10:51:44 INFO - PID 13182 | 10:51:44 INFO - PID 13182 | [#2] jquery.html Cycles:180 Average:37126.08 Median:2268.40 stddev:88459.81 (3899.7%) stddev-sans-first:88665.35 10:51:44 INFO - PID 13182 | Values: 555.2 556.5 565.9 591.3 596.4 22628.9 23061.8 23788.5 23796.8 23813.2 27365.7 27834.4 27954.6 28018.6 28019.4 6358.2 6456.2 6509.3 6512.0 6512.4 5762.6 6282.3 6290.5 6305.9 6330.7 6227.7 6262.7 6266.2 6268.5 6269.5 6255.2 6262.4 6263.8 6264.3 6270.3 5844.9 5854.4 5855.3 5857.2 5859.0 29472.6 30936.5 31204.7 31324.2 31537.2 2213.1 2266.5 2268.0 2268.8 2277.8 19679.7 20093.8 20156.2 20187.5 20209.1 2330.7 2371.9 2412.6 2421.1 2448.9 143811.0 146508.0 146647.3 147467.3 147531.0 14505.6 15667.8 15699.8 15972.2 16146.7 24150.6 24158.9 24160.9 24170.8 24172.8 10545.0 10632.1 10690.5 10724.6 10730.7 8400.6 9810.0 9878.6 9954.3 10084.1 8487.0 9654.9 9767.4 9953.7 10099.3 2668.7 2740.3 2741.5 2852.6 2875.6 1046.3 1048.7 1058.5 1069.1 1072.3 21144.9 21620.7 21880.8 22047.7 22410.3 1110.4 1114.8 1115.7 1130.3 1133.3 11965.9 12127.2 12149.5 12214.9 12270.8 508677.0 518311.0 523349.0 533096.0 535107.0 125296.0 130141.3 130650.3 131096.0 131231.0 1255.7 1273.9 1279.1 1284.5 1286.7 18499.4 19132.2 19140.3 19182.8 19787.8 58928.0 59238.7 59338.7 60691.0 61480.4 76485.5 76868.2 77467.6 77563.0 78281.0 14834.3 15028.5 15293.1 15758.6 15938.4 23652.2 23818.0 24124.6 24135.4 24142.0 18797.7 19335.3 19444.6 19497.8 19521.8 15963.3 16758.3 16831.4 16857.2 17032.4 20333.2 20832.0 21147.3 21221.6 21298.0 14786.2 15579.1 15604.4 15615.2 15620.8 19132.8 20447.6 20531.5 20551.3 20586.7 10:51:44 INFO - PID 13182 | 10:51:44 INFO - PID 13182 | [#3] mootools.html Cycles:180 Average:9566.21 Median:2469.81 stddev:6913.11 (279.9%) stddev-sans-first:6905.37 10:51:44 INFO - PID 13182 | Values: 1414.1 1476.3 1482.8 1492.3 1502.8 15068.2 15742.6 15771.1 15780.1 15878.5 15932.0 16260.5 16262.0 16263.4 16276.7 2419.3 2448.7 2471.8 2472.2 2472.4 2432.4 2467.9 2478.9 2504.0 2504.3 2548.3 2549.1 2564.6 2570.2 2570.5 2478.7 2497.9 2506.0 2509.5 2510.1 2439.8 2459.4 2472.2 2475.9 2479.7 14964.3 15286.4 15292.5 15300.9 15301.8 7979.8 8277.9 8282.0 8284.3 8301.1 5009.0 5038.3 5076.5 5186.6 5237.9 1899.6 1913.3 1916.8 1956.8 1966.9 26853.7 27089.7 27121.6 27143.9 27146.2 6594.8 6714.7 6773.7 6973.7 6985.4 17354.4 17728.9 17733.1 18042.8 18070.4 8089.5 8299.4 8306.1 8326.2 8326.3 7546.4 7614.2 7672.9 7727.3 7737.7 5239.2 5379.7 5405.3 5415.6 5468.5 1539.5 1544.8 1548.6 1550.1 1578.3 901.7 915.9 917.4 947.8 954.5 7476.7 7501.8 7618.7 7632.8 7652.2 713.5 734.5 767.8 773.6 779.9 4498.6 5554.3 5767.8 5943.2 5969.8 21695.0 22298.4 22377.2 22508.1 22572.4 21255.3 21427.5 21490.9 21727.3 21895.9 11726.8 12272.1 12331.8 12373.9 12391.4 8099.0 8655.2 8785.4 8880.4 8939.6 18475.6 18802.7 19187.5 19855.5 19998.9 19528.3 19611.5 19813.5 19854.6 20109.9 12458.7 12883.2 13020.9 13020.9 13025.2 12902.4 14195.2 14207.4 14345.0 14367.9 11209.2 11881.4 12106.5 12123.2 12135.3 10610.5 11088.3 11131.0 11192.4 11284.7 10084.5 10109.4 10179.2 10181.7 10236.7 7241.4 7392.8 7696.3 7720.2 7744.7 7045.2 7477.9 7494.1 7546.9 7591.2 10:51:44 INFO - PID 13182 | 10:51:44 INFO - PID 13182 | [#4] prototype.html Cycles:180 Average:5512.37 Median:6182.31 stddev:1572.85 (25.4%) stddev-sans-first:1531.81 10:51:44 INFO - PID 13182 | Values: 511.1 520.0 522.7 525.3 534.6 6153.7 6172.2 6200.0 6207.2 6218.6 6038.8 6065.4 6085.4 6090.3 6095.1 4864.2 4871.6 4876.6 4908.6 4913.7 4585.0 4740.4 4810.9 4852.0 4887.3 4650.7 4712.2 4720.5 4721.5 4754.6 4689.7 4718.6 4755.8 4774.3 4788.5 4191.2 4250.1 4271.9 4292.9 4332.3 5878.8 5899.6 5901.5 5912.3 5964.8 5702.3 5711.2 5718.4 5720.6 5739.9 6535.3 6544.3 6561.9 6582.3 6584.4 4834.8 4839.5 4856.3 4859.6 4917.9 6586.1 6610.9 6776.3 6781.9 6786.6 4972.8 4985.5 4999.4 5005.6 5060.5 5057.3 5063.3 5067.8 5073.5 5164.3 5662.8 5684.8 5688.8 5703.6 5732.4 6567.5 6577.3 6586.3 6604.1 6613.5 1729.7 1739.3 1758.3 1762.7 1805.4 1155.9 1210.8 1224.9 1258.7 1260.9 6176.7 6209.6 6275.9 6278.4 6324.3 6543.8 6572.3 6574.4 6620.1 6632.5 6146.8 6167.3 6199.7 6238.8 6255.6 3485.4 3515.2 3517.2 3559.6 3564.5 6866.9 6896.9 6905.5 6941.5 6943.3 6840.1 6845.7 6871.2 6880.5 6894.5 6912.5 6928.5 6955.5 6981.5 7007.0 6130.4 6530.8 6556.2 6566.0 6693.9 6500.9 6550.2 6586.0 6596.9 6637.3 6824.4 6827.8 6874.8 6964.8 6968.5 5026.7 5039.9 5042.9 5069.8 5087.5 6418.2 6531.3 6574.1 6695.2 6758.8 6337.7 6397.4 6456.3 6513.9 6528.6 6431.4 6437.2 6439.8 6472.5 6495.9 6436.9 6437.7 6446.5 6519.2 6564.4 6450.6 6528.6 6573.9 6574.8 6587.4 6187.9 6215.4 6357.0 6375.9 6416.5 10:51:44 INFO - PID 13182 | 10:51:44 INFO - PID 13182 | [#5] yui.html Cycles:180 Average:25389.32 Median:20022.20 stddev:35757.74 (178.6%) stddev-sans-first:35810.60 10:51:44 INFO - PID 13182 | Values: 856.7 867.6 918.4 922.7 964.5 18293.9 19453.9 19465.9 19477.1 21650.8 20101.0 20553.4 20844.6 20851.9 20870.2 1003.6 1088.5 1089.8 1093.4 1094.6 1050.0 1067.0 1087.5 1087.7 1088.0 1127.2 1135.6 1138.9 1139.0 1139.1 1125.3 1125.8 1133.4 1134.8 1142.6 824.7 832.6 833.6 834.9 841.0 17586.4 17691.3 17706.7 18004.3 19967.9 21131.7 21276.3 21579.1 21683.7 21693.2 15524.8 15831.2 15955.7 15970.6 16110.4 3513.6 3571.2 3572.4 3573.5 3576.5 128998.4 131161.0 133153.0 136500.6 137068.0 14355.3 14522.6 14720.4 14810.5 14859.6 28451.0 28894.1 28993.9 29013.9 29025.4 8221.2 8297.7 8398.8 8451.7 8645.4 4247.9 4407.5 4446.4 4451.8 4457.0 4981.0 5029.4 5089.2 5111.5 5981.9 1117.0 1129.9 1141.1 1144.8 1148.2 642.3 670.1 678.3 708.4 727.0 12306.3 12342.8 13938.1 15306.8 15359.9 642.4 685.7 703.4 736.4 746.7 5797.9 6207.8 6223.8 6395.3 6538.5 125333.4 125348.0 129349.4 132287.0 134760.0 110707.9 112301.0 115154.4 116973.4 119009.4 92848.0 96012.0 97925.5 98567.5 100322.0 12101.7 13149.1 13453.7 13541.0 13603.0 45466.3 48034.3 48150.5 50010.0 50980.7 57188.0 59371.4 60057.7 60218.0 61749.0 16958.7 18146.8 18560.3 18971.1 19343.5 22253.3 22300.3 22318.9 22489.4 22526.2 20076.5 20290.8 20396.2 20508.2 20735.9 19964.2 20480.2 20817.0 20854.2 20863.4 17139.2 17355.4 17478.7 17588.8 17673.2 13183.3 13353.9 13506.9 14164.8 14584.6 14764.0 14853.6 15186.4 15353.6 15406.4 10:51:44 INFO - PID 13182 | -------- Summary: end -------- 10:51:44 INFO - PID 13182 | 10:51:45 INFO - TEST-INFO | 13182: exit 0 10:51:45 INFO - TEST-OK | dromaeo_css | took 1110803ms 10:51:45 INFO - TEST-START | kraken 10:51:45 INFO - Initialising browser for kraken test... 10:51:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55957/getInfo.html -profile /tmp/tmpLAEtKR/profile 10:51:45 INFO - TEST-INFO | started process 13542 (/builds/slave/test/build/application/firefox/firefox http://localhost:55957/getInfo.html) 10:51:50 INFO - TEST-INFO | 13542: exit 0 10:51:50 INFO - Browser initialized. 10:51:50 INFO - Running cycle 1/1 for kraken test... 10:51:50 INFO - TEST-INFO | started process 13761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLAEtKR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:52:02 INFO - PID 13761 | RSS: Main: 170770432 10:52:02 INFO - PID 13761 | 10:52:04 INFO - PID 13761 | Cycle 1(1): loaded http://localhost:55957/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55957/tests/kraken/driver.html?testName=audio-beat-detection) 10:52:05 INFO - PID 13761 | RSS: Main: 174944256 10:52:05 INFO - PID 13761 | 10:52:08 INFO - PID 13761 | Cycle 1(1): loaded http://localhost:55957/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55957/tests/kraken/driver.html?testName=audio-dft) 10:52:08 INFO - PID 13761 | RSS: Main: 175423488 10:52:08 INFO - PID 13761 | 10:52:11 INFO - PID 13761 | Cycle 1(1): loaded http://localhost:55957/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55957/tests/kraken/driver.html?testName=audio-fft) 10:52:12 INFO - PID 13761 | RSS: Main: 169312256 10:52:12 INFO - PID 13761 | 10:52:14 INFO - PID 13761 | Cycle 1(1): loaded http://localhost:55957/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55957/tests/kraken/driver.html?testName=audio-oscillator) 10:52:15 INFO - PID 13761 | RSS: Main: 170930176 10:52:15 INFO - PID 13761 | 10:52:17 INFO - PID 13761 | Cycle 1(1): loaded http://localhost:55957/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55957/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:52:17 INFO - PID 13761 | RSS: Main: 170827776 10:52:17 INFO - PID 13761 | 10:52:20 INFO - PID 13761 | Cycle 1(1): loaded http://localhost:55957/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55957/tests/kraken/driver.html?testName=imaging-darkroom) 10:52:21 INFO - PID 13761 | RSS: Main: 174415872 10:52:21 INFO - PID 13761 | 10:52:24 INFO - PID 13761 | Cycle 1(1): loaded http://localhost:55957/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55957/tests/kraken/driver.html?testName=imaging-desaturate) 10:52:25 INFO - PID 13761 | RSS: Main: 175407104 10:52:25 INFO - PID 13761 | 10:52:28 INFO - PID 13761 | Cycle 1(1): loaded http://localhost:55957/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55957/tests/kraken/driver.html?testName=json-parse-financial) 10:52:28 INFO - PID 13761 | RSS: Main: 173912064 10:52:28 INFO - PID 13761 | 10:52:30 INFO - PID 13761 | Cycle 1(1): loaded http://localhost:55957/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55957/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:52:31 INFO - PID 13761 | RSS: Main: 173875200 10:52:31 INFO - PID 13761 | 10:52:32 INFO - PID 13761 | Cycle 1(1): loaded http://localhost:55957/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55957/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:52:33 INFO - PID 13761 | RSS: Main: 173793280 10:52:33 INFO - PID 13761 | 10:52:35 INFO - PID 13761 | Cycle 1(1): loaded http://localhost:55957/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55957/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:52:36 INFO - PID 13761 | RSS: Main: 170930176 10:52:36 INFO - PID 13761 | 10:52:38 INFO - PID 13761 | Cycle 1(1): loaded http://localhost:55957/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55957/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:52:39 INFO - PID 13761 | RSS: Main: 170827776 10:52:39 INFO - PID 13761 | 10:52:42 INFO - PID 13761 | Cycle 1(1): loaded http://localhost:55957/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55957/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:52:43 INFO - PID 13761 | RSS: Main: 171036672 10:52:43 INFO - PID 13761 | 10:52:44 INFO - PID 13761 | Cycle 1(1): loaded http://localhost:55957/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55957/tests/kraken/driver.html?testName=ai-astar) 10:52:44 INFO - PID 13761 | RSS: Main: 172773376 10:52:44 INFO - PID 13761 | 10:52:44 INFO - PID 13761 | __start_tp_report 10:52:44 INFO - PID 13761 | _x_x_mozilla_page_load 10:52:44 INFO - PID 13761 | _x_x_mozilla_page_load_details 10:52:44 INFO - PID 13761 | |i|pagename|runs| 10:52:44 INFO - PID 13761 | |0;ai-astar;103;107;95;107;107;115;111;109;109;110 10:52:44 INFO - PID 13761 | |1;audio-beat-detection;142;113;135;169;116;149;138;122;168;115 10:52:44 INFO - PID 13761 | |2;audio-dft;165;163;162;163;162;163;164;163;173;166 10:52:44 INFO - PID 13761 | |3;audio-fft;75;76;74;173;76;75;75;76;172;75 10:52:44 INFO - PID 13761 | |4;audio-oscillator;82;81;132;80;81;81;136;79;80;140 10:52:44 INFO - PID 13761 | |5;imaging-gaussian-blur;115;113;113;114;114;114;115;113;116;121 10:52:44 INFO - PID 13761 | |6;imaging-darkroom;151;155;148;151;150;152;148;149;149;150 10:52:44 INFO - PID 13761 | |7;imaging-desaturate;94;94;94;94;94;94;94;95;94;99 10:52:44 INFO - PID 13761 | |8;json-parse-financial;52;49;49;49;49;50;50;50;50;49 10:52:44 INFO - PID 13761 | |9;json-stringify-tinderbox;55;55;55;55;56;55;55;58;55;55 10:52:44 INFO - PID 13761 | |10;stanford-crypto-aes;75;82;73;76;77;75;81;75;75;74 10:52:44 INFO - PID 13761 | |11;stanford-crypto-ccm;126;131;123;125;120;121;132;119;125;157 10:52:44 INFO - PID 13761 | |12;stanford-crypto-pbkdf2;169;187;167;182;169;166;165;165;160;163 10:52:44 INFO - PID 13761 | |13;stanford-crypto-sha256-iterative;64;64;64;63;64;62;64;65;64;60 10:52:44 INFO - PID 13761 | __end_tp_report 10:52:44 INFO - PID 13761 | __start_cc_report 10:52:44 INFO - PID 13761 | _x_x_mozilla_cycle_collect,889 10:52:44 INFO - PID 13761 | __end_cc_report 10:52:44 INFO - PID 13761 | __startTimestamp1500745964963__endTimestamp 10:52:44 INFO - PID 13761 | 10:52:44 INFO - PID 13761 | ------- Summary: start ------- 10:52:44 INFO - PID 13761 | Number of tests: 14 10:52:44 INFO - PID 13761 | 10:52:44 INFO - PID 13761 | [#0] ai-astar Cycles:10 Average:107.30 Median:109.50 stddev:5.33 (4.9%) stddev-sans-first:5.43 10:52:44 INFO - PID 13761 | Values: 103.0 107.0 95.0 107.0 107.0 115.0 111.0 109.0 109.0 110.0 10:52:44 INFO - PID 13761 | 10:52:44 INFO - PID 13761 | [#1] audio-beat-detection Cycles:10 Average:136.70 Median:140.00 stddev:20.77 (14.8%) stddev-sans-first:21.95 10:52:44 INFO - PID 13761 | Values: 142.0 113.0 135.0 169.0 116.0 149.0 138.0 122.0 168.0 115.0 10:52:44 INFO - PID 13761 | 10:52:44 INFO - PID 13761 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.50 stddev:3.27 (2.0%) stddev-sans-first:3.46 10:52:44 INFO - PID 13761 | Values: 165.0 163.0 162.0 163.0 162.0 163.0 164.0 163.0 173.0 166.0 10:52:44 INFO - PID 13761 | 10:52:44 INFO - PID 13761 | [#3] audio-fft Cycles:10 Average:94.70 Median:75.00 stddev:41.01 (54.7%) stddev-sans-first:42.87 10:52:44 INFO - PID 13761 | Values: 75.0 76.0 74.0 173.0 76.0 75.0 75.0 76.0 172.0 75.0 10:52:44 INFO - PID 13761 | 10:52:44 INFO - PID 13761 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:80.50 stddev:26.85 (33.4%) stddev-sans-first:27.91 10:52:44 INFO - PID 13761 | Values: 82.0 81.0 132.0 80.0 81.0 81.0 136.0 79.0 80.0 140.0 10:52:44 INFO - PID 13761 | 10:52:44 INFO - PID 13761 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:114.50 stddev:2.39 (2.1%) stddev-sans-first:2.54 10:52:44 INFO - PID 13761 | Values: 115.0 113.0 113.0 114.0 114.0 114.0 115.0 113.0 116.0 121.0 10:52:44 INFO - PID 13761 | 10:52:44 INFO - PID 13761 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.50 stddev:2.11 (1.4%) stddev-sans-first:2.22 10:52:44 INFO - PID 13761 | Values: 151.0 155.0 148.0 151.0 150.0 152.0 148.0 149.0 149.0 150.0 10:52:44 INFO - PID 13761 | 10:52:44 INFO - PID 13761 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.00 stddev:1.58 (1.7%) stddev-sans-first:1.66 10:52:44 INFO - PID 13761 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 99.0 10:52:44 INFO - PID 13761 | 10:52:44 INFO - PID 13761 | [#8] json-parse-financial Cycles:10 Average:49.70 Median:50.00 stddev:0.95 (1.9%) stddev-sans-first:0.53 10:52:44 INFO - PID 13761 | Values: 52.0 49.0 49.0 49.0 49.0 50.0 50.0 50.0 50.0 49.0 10:52:44 INFO - PID 13761 | 10:52:44 INFO - PID 13761 | [#9] json-stringify-tinderbox Cycles:10 Average:55.40 Median:55.00 stddev:0.97 (1.8%) stddev-sans-first:1.01 10:52:44 INFO - PID 13761 | Values: 55.0 55.0 55.0 55.0 56.0 55.0 55.0 58.0 55.0 55.0 10:52:44 INFO - PID 13761 | 10:52:44 INFO - PID 13761 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:75.50 stddev:2.95 (3.9%) stddev-sans-first:3.09 10:52:44 INFO - PID 13761 | Values: 75.0 82.0 73.0 76.0 77.0 75.0 81.0 75.0 75.0 74.0 10:52:44 INFO - PID 13761 | 10:52:44 INFO - PID 13761 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:125.50 stddev:11.09 (8.8%) stddev-sans-first:11.74 10:52:44 INFO - PID 13761 | Values: 126.0 131.0 123.0 125.0 120.0 121.0 132.0 119.0 125.0 157.0 10:52:44 INFO - PID 13761 | 10:52:44 INFO - PID 13761 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:168.00 stddev:8.53 (5.1%) stddev-sans-first:9.04 10:52:44 INFO - PID 13761 | Values: 169.0 187.0 167.0 182.0 169.0 166.0 165.0 165.0 160.0 163.0 10:52:44 INFO - PID 13761 | 10:52:44 INFO - PID 13761 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:64.00 stddev:1.43 (2.2%) stddev-sans-first:1.50 10:52:44 INFO - PID 13761 | Values: 64.0 64.0 64.0 63.0 64.0 62.0 64.0 65.0 64.0 60.0 10:52:44 INFO - PID 13761 | -------- Summary: end -------- 10:52:44 INFO - PID 13761 | 10:52:45 INFO - PID 13761 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 10:52:45 INFO - TEST-INFO | 13761: exit 0 10:52:45 INFO - TEST-OK | kraken | took 60857ms 10:52:45 INFO - SUITE-END | took 1171s 10:52:46 INFO - Completed test suite (00:19:31) 10:52:46 INFO - javascript benchmark 10:52:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8731.094849481111, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3339.749518786092, 3382.934375671663, 3384.526166336712, 3387.424137896557, 3403.4044042292608, 6043.30501992271, 6139.6316221026655, 6151.907721384177, 6152.077188421739, 6173.0, 5979.611325263855, 6058.878822423549, 6088.634681919088, 6089.147519347284, 6151.384861513847, 5314.309139811839, 5346.438623944478, 5354.705491197982, 5356.4107948125675, 5380.0046991306735, 5180.611454140936, 5193.376794784631, 5294.0, 5460.208269800896, 5479.890402191973, 5324.946750532484, 5398.8920221595545, 5400.783968641289, 5419.918701219485, 5419.972900135514, 5282.920756188621, 5316.175992721134, 5343.171808369709, 5401.918971215435, 5406.351237851483, 5314.468553144655, 5346.705931173784, 5383.75773090208, 5394.109971854639, 5396.9730151348995, 6041.72812223451, 6050.576459647827, 6115.113308570232, 6129.693515324216, 6167.629942203482, 6439.5170362223025, 6543.574667646635, 6569.244536878273, 6625.801225963229, 6631.900521492182, 6621.271660117383, 6637.800865974028, 6670.866582668368, 6687.966560167217, 6690.83272918181, 6099.969500152471, 6139.693015349215, 6172.537059720539, 6199.287081985584, 6211.751529938797, 6595.175603049619, 6679.165104361955, 6691.5315927884585, 6753.561018533779, 6785.8642827143185, 6444.742210311535, 6497.5126865484335, 6528.1187039749975, 6542.443892269211, 6543.1821022372205, 6552.737890484327, 6568.737250510022, 6591.868162636721, 6642.302558231413, 6679.632620205935, 6405.231372235362, 6492.09110724499, 6511.73953041873, 6513.5114866384265, 6599.373059559334, 6534.150560427114, 6547.672616369257, 6568.67156642166, 6576.44100251484, 6610.338966103352, 4817.0365926814775, 4861.805527778849, 4865.513448655106, 4867.123917694849, 4875.19559272716, 4295.72077814941, 4300.892477688083, 4340.587644173798, 4347.456567929009, 4348.065165989265, 6106.78626248088, 6166.414190651881, 6171.814845554641, 6216.658083805434, 6255.43701066897, 6590.9670451647435, 6626.0, 6666.633335166613, 6685.0640910272605, 6688.030235615808, 6175.228096487939, 6246.063090536456, 6309.558330916791, 6310.5267104967315, 6336.52476064297, 5317.867053323698, 5346.759395827197, 5405.70268635221, 5436.864078398072, 5494.148406996922, 6898.551594146365, 6921.134858142732, 6955.478339124586, 6962.1297337832775, 6989.685464154125, 6591.143151390289, 6600.60396376219, 6677.03183038447, 6681.09805176295, 6685.331466853276, 6729.327067293231, 6804.387605115563, 6881.690323935335, 6970.616616086164, 6977.755778547727, 6447.194100737408, 6480.449161821298, 6491.156149700509, 6505.0, 6515.804525864231, 6661.0, 6676.899846502403, 6701.798946031627, 6713.026611141455, 6718.025886246369, 6303.558750887394, 6360.268569114426, 6387.169667943138, 6396.264429590657, 6498.610083395011, 6384.042393640991, 6454.19322584677, 6460.353964603502, 6465.321141280097, 6476.5466417350335, 6413.0, 6413.230412350548, 6484.448821850196, 6490.415862572391, 6493.902591461037, 6457.483401327976, 6469.320721324193, 6502.967485162544, 6517.315681853527, 6557.770478033246, 6169.9691501544, 6207.751689932352, 6277.874442511215, 6290.716917738621, 6325.177726895474], "value": 6004.965582964609, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [820.733261689951, 861.0227391910182, 880.6477409036387, 884.9115088491155, 1188.6731148934036, 32963.0, 42080.158396832085, 42765.78617106918, 42775.3583696244, 42802.0, 42537.57462425375, 43072.56927430725, 43183.0, 43441.34837977425, 43472.78263608678, 7180.712771489134, 7328.963355183217, 7344.375728063121, 7350.448716346295, 7368.0, 7291.197968223491, 7366.484346095775, 7372.520786148883, 7377.077865266841, 7377.926220737804, 7329.926700732978, 7405.81485462865, 7435.479516433852, 7437.144728356254, 7442.553446793183, 7379.114506259257, 7421.183669796318, 7422.369098626623, 7424.777256682308, 7425.034745483106, 7172.605506697182, 7176.138863336381, 7192.712291508334, 7214.242504537001, 7221.783346499614, 38837.22325553473, 38845.0, 38922.61077389218, 38951.0, 39054.0, 3468.2890007548644, 3507.2634746703225, 3512.367773800715, 3515.5078289039557, 3521.0, 31168.8441557793, 31284.53073203904, 31416.685833141604, 31436.685633143832, 31478.527822082688, 4756.595689366408, 4840.298156767249, 4842.539958703917, 4878.0, 4882.584980276681, 204145.0, 204876.0, 206186.0, 206203.0, 206488.9999999985, 50079.74960125176, 50127.74936125296, 50145.74927125341, 50205.0, 50250.0, 52533.47466525362, 52573.7371313141, 53099.0, 53124.46875531272, 53205.46794532082, 14878.404863805326, 16142.35430582787, 16441.0, 16445.58886027859, 16531.090790006423, 12196.51213951432, 13127.409266583027, 13347.532836350681, 13434.529791457253, 13501.459941602423, 15334.079955202724, 15381.692366152614, 15392.615184620474, 15393.692126157413, 15517.37930482768, 6147.96926015376, 6253.218347706536, 6269.0909818076125, 6277.96861015692, 6315.715792789336, 1073.7208325835338, 1076.3918386111823, 1079.9244052916379, 1086.538221255963, 1087.5106202208879, 24130.51738965211, 24295.514089718108, 24598.754012460005, 24669.753302466746, 24710.258692239262, 1181.9940900295614, 1185.9051275897907, 1190.2025642819333, 1194.235689158939, 1213.6783752305646, 12708.618741437771, 13180.868191318155, 13189.340532973312, 13339.733205335839, 13412.262325572186, 271933.0, 272182.0, 272570.0, 272698.0, 274481.0, 53871.73064134733, 54154.18768718473, 54246.45753542414, 54293.0, 54648.0, 1479.578320178744, 1530.1431198528637, 1559.9532014039596, 1562.8046494188227, 1565.1861032263387, 24441.51116977686, 29212.26969325784, 29327.413451731274, 29956.700432995392, 30190.0, 53740.19389709236, 54324.45675543352, 54370.72814635901, 54380.456195439125, 54393.45606543884, 241036.0, 241825.0, 242927.0, 243108.0, 244650.0, 33783.83108084444, 34204.48693269653, 36950.8152459236, 37088.6291137096, 37489.0, 48435.27347089726, 48697.0, 48879.75560122177, 48972.265416018075, 49194.50805492042, 33523.329533409684, 34978.47532287068, 35007.47488787619, 35798.46302305415, 35939.28121437504, 34338.48492272568, 34819.12952176115, 34840.82579587086, 35151.29697406089, 35914.0, 41073.794631026656, 41379.79310103551, 41484.17031659289, 41731.165376691686, 41919.37120943127, 31932.88234911767, 33890.66109338875, 34746.826265868505, 34900.301993960486, 35010.29979400449, 25898.870505647352, 26502.734972650796, 26729.866350668122, 27063.323416914736, 27875.860620696767], "value": 18204.55020948354, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.1755642870337, 556.5186114011376, 565.9462351076646, 591.2697818194529, 596.3618927747311, 22628.8868555657, 23061.769382306193, 23788.5242295154, 23796.76203237965, 23813.166539171132, 27365.726342736616, 27834.443311133764, 27954.580681289797, 28018.579721304144, 28019.439611207814, 6358.237011558608, 6456.160699109109, 6509.316521765218, 6511.967440162793, 6512.413882750551, 5762.625429347079, 6282.308946015934, 6290.528210384216, 6305.873882522347, 6330.6834658267135, 6227.688615569226, 6262.718177682015, 6266.154069200645, 6268.467180289658, 6269.529785266101, 6255.186825712651, 6262.373762623747, 6263.812085637438, 6264.279607845065, 6270.31026587075, 5844.88310233793, 5854.385289544579, 5855.2973643163095, 5857.179994800731, 5859.0, 29472.557911631342, 30936.535951960737, 31204.687953120407, 31324.216894577818, 31537.21156971071, 2213.0926320208796, 2266.5126997695575, 2267.9773202268098, 2268.8298377621745, 2277.840551161419, 19679.704804427944, 20093.79906200934, 20156.193752249892, 20187.495312617157, 20209.090590923443, 2330.673705681206, 2371.9051237950634, 2412.6260429633257, 2421.128393778238, 2448.9142879999113, 143811.0, 146508.0, 146647.2667636655, 147467.26266368706, 147531.0, 14505.637359065897, 15667.843321566867, 15699.764503532457, 15972.201389930457, 16146.677066458606, 24150.637740433907, 24158.87920560386, 24160.87919560391, 24170.75829241685, 24172.758272417403, 10545.0, 10632.149428045737, 10690.465476726133, 10724.624638137628, 10730.73173170677, 8400.621972011275, 9809.950950245346, 9878.555465004092, 9954.253430992705, 10084.092431681183, 8487.0, 9654.855177172349, 9767.386067155197, 9953.651622193189, 10099.293049486465, 2668.7197844226466, 2740.3149212696826, 2741.451709658076, 2852.61489698888, 2875.597416361711, 1046.26238501856, 1048.7011201807447, 1058.4707646176912, 1069.1286601419974, 1072.286929192094, 21144.894275528524, 21620.675689864664, 21880.781192187875, 22047.66928496074, 22410.32769016932, 1110.3726394587034, 1114.7714718482691, 1115.676453828397, 1130.254032338669, 1133.2916926920675, 11965.940170299093, 12127.211731237441, 12149.542054953463, 12214.877851221374, 12270.75458490843, 508677.0, 518311.0, 523349.0, 533096.0, 535107.0, 125296.0, 130141.34929325293, 130650.34674826566, 131096.0, 131231.0, 1255.6986323282347, 1273.866244044362, 1279.0726723125845, 1284.5118854835102, 1286.6718986658343, 18499.352522661644, 19132.23471061142, 19140.330088446837, 19182.808171918103, 19787.802121978595, 58928.0, 59238.703806482416, 59338.70330648319, 60691.0, 61480.385196147465, 76485.470290595, 76868.23131768835, 77467.61266193633, 77563.0, 78281.0, 14834.332455039765, 15028.474003409829, 15293.082415055133, 15758.606034849221, 15938.442154525, 23652.172173973828, 23818.047278108683, 24124.638130427706, 24135.396615084763, 24142.0, 18797.684162108522, 19335.323263686267, 19444.611107777484, 19497.805021950167, 19521.804781952, 15963.281652325906, 16758.32966681319, 16831.41090061842, 16857.15714214309, 17032.403865864635, 20333.186672532935, 20832.0, 21147.25984590532, 21221.575568488854, 21298.041588128883, 14786.186759728318, 15579.143147127017, 15604.375824966874, 15615.219239037775, 15620.765688514908, 19132.808671913102, 20447.591048178656, 20531.4867128323, 20551.280705175246, 20586.691199631718], "value": 12523.07038165676, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1414.0879132959242, 1476.2544914818016, 1482.784996175554, 1492.3060776738819, 1502.8497150284973, 15068.246587670614, 15742.606434839136, 15771.132587707685, 15780.132092734924, 15878.52364429066, 15932.0, 16260.51218463448, 16262.0, 16263.430779922704, 16276.674466510663, 2419.286310538391, 2448.6694296270043, 2471.752824717532, 2472.159465781634, 2472.3819045238693, 2432.391902024494, 2467.8766061696933, 2478.913238036669, 2504.0484615845953, 2504.2987963370197, 2548.3374322676145, 2549.0950712496983, 2564.6281289213052, 2570.2032369965373, 2570.473053024135, 2478.7397323281066, 2497.912573059943, 2505.962410563843, 2509.535735888848, 2510.1089113364765, 2439.8048156147465, 2459.4343301040863, 2472.196536125766, 2475.8885850136785, 2479.7396273391396, 14964.251787410585, 15286.388544458208, 15292.541223763194, 15300.923495382563, 15301.770473442908, 7979.8404031919035, 8277.917220827774, 8282.0, 8284.25441710249, 8301.128381519975, 5008.974955125201, 5038.345015148007, 5076.52364033887, 5186.559142472895, 5237.869053273698, 1899.5536049028467, 1913.3016448996016, 1916.7795703493998, 1956.814102660245, 1966.9409917702492, 26853.73146268532, 27089.729102709116, 27121.59317610218, 27143.864280678667, 27146.185614431797, 6594.835129121714, 6714.731410743516, 6773.72905083801, 6973.721051157999, 6985.406240469515, 17354.39259625907, 17728.91135544314, 17733.11334433273, 18042.819571804375, 18070.36753713614, 8089.47418417801, 8299.377546683902, 8306.127856574973, 8326.209010144026, 8326.333893288522, 7546.358559522392, 7614.238576142341, 7672.923270767333, 7727.304542591194, 7737.729179478692, 5239.187925871496, 5379.731013449312, 5405.270288511079, 5415.593830462731, 5468.535174510132, 1539.5304432148303, 1544.783730277762, 1548.612846788303, 1550.0544667752663, 1578.3449868304754, 901.6844104563351, 915.8946721127155, 917.3945196170496, 947.7535840681472, 954.5370495309769, 7476.738314159087, 7501.849963000709, 7618.69525218985, 7632.8473430532185, 7652.196519365387, 713.4755954373531, 734.5115498193642, 767.808047988003, 773.5977291808229, 779.8713212319904, 4498.5501449854755, 5554.333641255734, 5767.798127065533, 5943.197668314722, 5969.820905372846, 21695.0, 22298.442538936655, 22377.216797412013, 22508.099676013102, 22572.435689107904, 21255.256066037615, 21427.46431339229, 21490.892545537172, 21727.34817955464, 21895.890520547295, 11726.803481036195, 12272.140950133406, 12331.75336493265, 12373.93813030929, 12391.380430978415, 8098.994369869903, 8655.17775811297, 8785.385023048326, 8880.378373513791, 8939.59771810283, 18475.630487390445, 18802.717959230897, 19187.520311992314, 19855.503612409804, 19998.90000549988, 19528.31650892212, 19611.48101044873, 19813.50466238298, 19854.602907941473, 20109.89945050324, 12458.688532786753, 12883.162594431333, 13020.869791301966, 13020.934895325463, 13025.153365031243, 12902.419391127234, 14195.219262940638, 14207.431702731776, 14345.0, 14367.928160359132, 11209.15931305139, 11881.405929703653, 12106.455209515769, 12123.151379403356, 12135.271883687006, 10610.52252648648, 11088.279261847954, 11131.0, 11192.38441885704, 11284.717882053013, 10084.495775211357, 10109.443980580845, 10179.236557258087, 10181.745456363355, 10236.692899213036, 7241.4206863449745, 7392.815179620553, 7696.307332340116, 7720.227977202235, 7744.651490683045, 7045.189803172496, 7477.887831682638, 7494.100707915085, 7546.886796698163, 7591.164971852982], "value": 6715.6785232199845, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [511.09281026178553, 519.9818006369776, 522.6550476685386, 525.2593842681817, 534.5937087813262, 6153.661548614825, 6172.197614310139, 6199.969000154999, 6207.193064901568, 6218.595791273564, 6038.8490287742825, 6065.423784740443, 6085.361037091108, 6090.269167699882, 6095.085737139431, 4864.173090574602, 4871.610271178297, 4876.634252431082, 4908.631852611068, 4913.680610760289, 4585.0, 4740.360051393052, 4810.855674329776, 4852.0, 4887.266909963499, 4650.7442090685, 4712.209360443044, 4720.457147428056, 4721.527847215285, 4754.6434017448655, 4689.671722979393, 4718.551737584924, 4755.833545825914, 4774.259989701602, 4788.473267940523, 4191.245575796355, 4250.08623146022, 4271.8718438446585, 4292.935605965913, 4332.263515202391, 5878.766068893836, 5899.646021238696, 5901.498372638331, 5912.3496415394275, 5964.761409543613, 5702.258706368187, 5711.200431939532, 5718.370979192286, 5720.570957178186, 5739.913901291484, 6535.26815393921, 6544.280129185786, 6561.93438065618, 6582.275949645536, 6584.440322572587, 4834.830780922651, 4839.467658557556, 4856.271559266138, 4859.58693511052, 4917.918058027229, 6586.081281637418, 6610.93389066108, 6776.288489708608, 6781.932180678229, 6786.558873673195, 4972.7513624318635, 4985.476524964899, 4999.350084489066, 5005.599552035901, 5060.51925067118, 5057.266696329085, 5063.291139240509, 5067.771950262247, 5073.467285934998, 5164.25118357836, 5662.773489060474, 5684.8010319638615, 5688.772449102073, 5703.572232082611, 5732.398098199712, 6567.474602031922, 6577.276499585042, 6586.341365863375, 6604.14146160996, 6613.503987200979, 1729.6800091983023, 1739.2868923741205, 1758.268105915672, 1762.6562820250185, 1805.4222648752273, 1155.8728539860608, 1210.8304837322783, 1224.8530176378893, 1258.6979125010114, 1260.8928241099609, 6176.69116544171, 6209.565330426917, 6275.905861412082, 6278.4035516625845, 6324.33594472583, 6543.803685889431, 6572.319501079411, 6574.441172500391, 6620.139381880421, 6632.533280052007, 6146.784862529879, 6167.290761562388, 6199.721012554446, 6238.75044998195, 6255.624662520172, 3485.3900567400606, 3515.209077957439, 3517.1910460593695, 3559.5728512578658, 3564.536610240704, 6866.862662746717, 6896.862062758717, 6905.516613837083, 6941.548799328028, 6943.305669433016, 6840.110785597841, 6845.733539295246, 6871.175458944958, 6880.4839637026425, 6894.482913781487, 6912.481563882729, 6928.515003949675, 6955.513114082067, 6981.476389270723, 7007.0, 6130.417610327012, 6530.8040758777315, 6556.246031706415, 6566.0301909427935, 6693.899591506034, 6500.902486462802, 6550.246721626883, 6585.967070164618, 6596.90104648421, 6637.303083176197, 6824.385805277549, 6827.795166145023, 6874.793756187322, 6964.79105626832, 6968.512204145661, 5026.723530205873, 5039.874003149951, 5042.873928151679, 5069.797208111634, 5087.465816089258, 6418.19772528434, 6531.281559028598, 6574.112494813139, 6695.163104611924, 6758.797236082925, 6337.746490140527, 6397.392247736458, 6456.289808121197, 6513.902291465726, 6528.575642583407, 6431.389018043278, 6437.163168788027, 6439.8068057958335, 6472.546921715623, 6495.9025614614875, 6436.9034464484, 6437.7103030362805, 6446.516511261768, 6519.185101862267, 6564.376384243489, 6450.580712253689, 6528.640924749185, 6573.901391479036, 6574.8356291093105, 6587.374199451045, 6187.938120618736, 6215.395070858981, 6356.968215158895, 6375.904361434489, 6416.48668106541], "value": 5052.390308381889, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [856.6873091321669, 867.6442658510013, 918.4489306416147, 922.7185708358948, 964.5225613321406, 18293.908530457345, 19453.902730486363, 19465.902670486663, 19477.123529441174, 21650.783492165072, 20101.0, 20553.38339849803, 20844.583108337825, 20851.895740521315, 20870.165193392248, 1003.5849452272297, 1088.5101704233086, 1089.803835309644, 1093.4478088565263, 1094.5949998500566, 1049.9842502362471, 1067.0236733388979, 1087.5486673030723, 1087.7171935296801, 1087.9728006799814, 1127.1658972360476, 1135.5798354608805, 1138.8747237803834, 1139.0, 1139.145640769423, 1125.2685754259714, 1125.797356475834, 1133.3823066428815, 1134.8127558952763, 1142.6000899685127, 824.6742536698031, 832.5837081459271, 833.5998720614078, 834.9206825351582, 840.9789755256106, 17586.384476543386, 17691.29234830605, 17706.734398984026, 18004.279828806833, 19967.900160499248, 21131.683024754642, 21276.255331063494, 21579.136834526602, 21683.67474487884, 21693.240736574146, 15524.844751552566, 15831.208439577975, 15955.680886382323, 15970.600734981603, 16110.355585776555, 3513.5959364673135, 3571.2143328467696, 3572.374834403969, 3573.4997100405963, 3576.499290099388, 128998.35500822529, 131161.0, 133153.0, 136500.6349936498, 137068.0, 14355.282235888164, 14522.636934076521, 14720.411183552753, 14810.481633142788, 14859.554213373616, 28451.0, 28894.133176004754, 28993.85503072471, 29013.854930725633, 29025.41949161005, 8221.17788221173, 8297.668093276201, 8398.832023359499, 8451.704190353308, 8645.438046526955, 4247.893802654897, 4407.537208593051, 4446.399736035593, 4451.77741112943, 4457.0, 4980.975095124501, 5029.396472423259, 5089.211172268304, 5111.46329635383, 5981.940180598225, 1116.983245251322, 1129.9096072314196, 1141.1498433666804, 1144.8339990701468, 1148.2134737704698, 642.3290892549012, 670.1489108831756, 678.25053316086, 708.387245033053, 727.0366764037672, 12306.261624302571, 12342.75314493705, 13938.094023888414, 15306.770398444032, 15359.92320038415, 642.3801032004138, 685.6960612342525, 703.4161645833946, 736.4108713029663, 746.7386414754792, 5797.855053623609, 6207.844803879939, 6223.782167624111, 6395.264544577433, 6538.509611779135, 125333.37333313457, 125348.0, 129349.35325323313, 132287.0, 134760.0, 110707.89292106975, 112301.0, 115154.42422788, 116973.4151329255, 119009.40495297642, 92848.0, 96012.0, 97925.51037244768, 98567.50716246373, 100321.99678003126, 12101.69745756363, 13149.145305555108, 13453.730925381633, 13541.0, 13603.0, 45466.31800523061, 48034.27948580704, 48150.518494814605, 50010.0, 50980.74509627428, 57188.0, 59371.40628593831, 60057.69971150116, 60218.0, 61749.0, 16958.660826783642, 18146.818531815043, 18560.257589696263, 18971.14629841688, 19343.51641208981, 22253.33240002738, 22300.330990070324, 22318.888405557867, 22489.43776405603, 22526.21158259453, 20076.498087547927, 20290.797092029483, 20396.184152633727, 20508.17967281292, 20735.8963205183, 19964.201431942558, 20480.180792768122, 20817.0, 20854.165833366496, 20863.37409877706, 17139.228734707216, 17355.392561260294, 17478.650426991644, 17588.82411175923, 17673.20470578853, 13183.340832958505, 13353.86646133565, 13506.864931350561, 14164.78752818688, 14584.635384115481, 14764.040337378035, 14853.554393368217, 15186.392544298104, 15353.6161595961, 15406.38374465009], "value": 9536.644124453667, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1502.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 107.0, 95.0, 107.0, 107.0, 115.0, 111.0, 109.0, 109.0, 110.0], "value": 107.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 113.0, 135.0, 169.0, 116.0, 149.0, 138.0, 122.0, 168.0, 115.0], "value": 136.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 162.0, 163.0, 162.0, 163.0, 164.0, 163.0, 173.0, 166.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 173.0, 76.0, 75.0, 75.0, 76.0, 172.0, 75.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 132.0, 80.0, 81.0, 81.0, 136.0, 79.0, 80.0, 140.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 113.0, 114.0, 114.0, 114.0, 115.0, 113.0, 116.0, 121.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 155.0, 148.0, 151.0, 150.0, 152.0, 148.0, 149.0, 149.0, 150.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 99.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 49.0, 49.0, 49.0, 49.0, 50.0, 50.0, 50.0, 50.0, 49.0], "value": 49.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 56.0, 55.0, 55.0, 58.0, 55.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 82.0, 73.0, 76.0, 77.0, 75.0, 81.0, 75.0, 75.0, 74.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 131.0, 123.0, 125.0, 120.0, 121.0, 132.0, 119.0, 125.0, 157.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 187.0, 167.0, 182.0, 169.0, 166.0, 165.0, 165.0, 160.0, 163.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 63.0, 64.0, 62.0, 64.0, 65.0, 64.0, 60.0], "value": 63.4, "unit": "score"}]}]} 10:52:46 INFO - Return code: 0 10:52:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:52:46 INFO - # TBPL SUCCESS # 10:52:46 INFO - Running post-action listener: _package_coverage_data 10:52:46 INFO - Running post-action listener: _resource_record_post_action 10:52:46 INFO - [mozharness: 2017-07-22 17:52:46.232276Z] Finished run-tests step (success) 10:52:46 INFO - Running post-run listener: _resource_record_post_run 10:52:46 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 12288; Write bytes: 435433472; Read time: 492; Write time: 357520 10:52:46 INFO - TinderboxPrint: CPU usage
13.1% 10:52:46 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 492 10:52:46 INFO - TinderboxPrint: I/O write bytes / time
435,433,472 / 357,520 10:52:46 INFO - TinderboxPrint: CPU idle
8,247.2 (86.9%) 10:52:46 INFO - TinderboxPrint: CPU user
1,190.4 (12.5%) 10:52:46 INFO - TinderboxPrint: Swap in / out
0 / 0 10:52:46 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 108273664; Read time: 228; Write time: 113232 10:52:46 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:52:46 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 327159808; Read time: 248; Write time: 244288 10:52:46 INFO - Running post-run listener: _upload_blobber_files 10:52:46 INFO - Blob upload gear active. 10:52:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:52:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:52:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:52:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:52:47 INFO - (blobuploader) - INFO - Open directory for files ... 10:52:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:52:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:52:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:52:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:52:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:52:48 INFO - (blobuploader) - INFO - Done attempting. 10:52:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:52:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:52:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:52:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:52:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:52:49 INFO - (blobuploader) - INFO - Done attempting. 10:52:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:52:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:52:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:52:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:52:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:52:55 INFO - (blobuploader) - INFO - Done attempting. 10:52:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:52:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:52:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:52:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:52:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:52:56 INFO - (blobuploader) - INFO - Done attempting. 10:52:56 INFO - (blobuploader) - INFO - Iteration through files over. 10:52:56 INFO - Return code: 0 10:52:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:52:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:52:56 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af9ca5a1041c6d6d1ac69b6506b2b0e3f679d0e041faeefc85f5657867cf3c0c1276bc9bc27f930ed1f98ecb1146db0ae1dc0bce039e50aa3a83f0ee37ef13f7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42db292ec004ccc8032e8329bb77504866753da9e143344761ff695ed169a33f936f72a80306080f10983eadd9b13c7b4cc3ccb549cc07bdc9b22826d8fe8230", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03a29f8550c2870387de48923d26ce34cecad1814cd546352d9c76ebbef4cb39e94602700245456f69ba3a2986cfebe78d817e8e5af4f7bee242184e41e133fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d2a2519e49e3ff2a644e6a605aecb55d61e68d565464d506b948a0db009f3451efbaa7cedf8187bb08434b21a5dd94f9a9e0e6525773a57edb69140350f9489"} 10:52:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:52:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:52:56 INFO - Contents: 10:52:56 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af9ca5a1041c6d6d1ac69b6506b2b0e3f679d0e041faeefc85f5657867cf3c0c1276bc9bc27f930ed1f98ecb1146db0ae1dc0bce039e50aa3a83f0ee37ef13f7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42db292ec004ccc8032e8329bb77504866753da9e143344761ff695ed169a33f936f72a80306080f10983eadd9b13c7b4cc3ccb549cc07bdc9b22826d8fe8230", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03a29f8550c2870387de48923d26ce34cecad1814cd546352d9c76ebbef4cb39e94602700245456f69ba3a2986cfebe78d817e8e5af4f7bee242184e41e133fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d2a2519e49e3ff2a644e6a605aecb55d61e68d565464d506b948a0db009f3451efbaa7cedf8187bb08434b21a5dd94f9a9e0e6525773a57edb69140350f9489"} 10:52:56 INFO - Running post-run listener: copy_logs_to_upload_dir 10:52:56 INFO - Copying logs to upload dir... 10:52:56 INFO - mkdir: /builds/slave/test/build/upload/logs 10:52:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.440798 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-07-22 10:52:55.109191) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-22 10:52:55.116380) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1500738916.67619-496437824 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/af9ca5a1041c6d6d1ac69b6506b2b0e3f679d0e041faeefc85f5657867cf3c0c1276bc9bc27f930ed1f98ecb1146db0ae1dc0bce039e50aa3a83f0ee37ef13f7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42db292ec004ccc8032e8329bb77504866753da9e143344761ff695ed169a33f936f72a80306080f10983eadd9b13c7b4cc3ccb549cc07bdc9b22826d8fe8230", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03a29f8550c2870387de48923d26ce34cecad1814cd546352d9c76ebbef4cb39e94602700245456f69ba3a2986cfebe78d817e8e5af4f7bee242184e41e133fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d2a2519e49e3ff2a644e6a605aecb55d61e68d565464d506b948a0db009f3451efbaa7cedf8187bb08434b21a5dd94f9a9e0e6525773a57edb69140350f9489"} build_url:https://queue.taskcluster.net/v1/task/S8_BmWORTH2DSgQ8Y2MOGg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011127 build_url: 'https://queue.taskcluster.net/v1/task/S8_BmWORTH2DSgQ8Y2MOGg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af9ca5a1041c6d6d1ac69b6506b2b0e3f679d0e041faeefc85f5657867cf3c0c1276bc9bc27f930ed1f98ecb1146db0ae1dc0bce039e50aa3a83f0ee37ef13f7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42db292ec004ccc8032e8329bb77504866753da9e143344761ff695ed169a33f936f72a80306080f10983eadd9b13c7b4cc3ccb549cc07bdc9b22826d8fe8230", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03a29f8550c2870387de48923d26ce34cecad1814cd546352d9c76ebbef4cb39e94602700245456f69ba3a2986cfebe78d817e8e5af4f7bee242184e41e133fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d2a2519e49e3ff2a644e6a605aecb55d61e68d565464d506b948a0db009f3451efbaa7cedf8187bb08434b21a5dd94f9a9e0e6525773a57edb69140350f9489"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-22 10:52:55.143570) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 10:52:55.143934) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1500738916.67619-496437824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 10:52:55.222709) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-22 10:52:55.226026) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-22 10:52:55.226339) ========= ========= Total master_lag: 0.16 =========