builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-013 starttime: 1502233252.62 results: success (0) revision: 1d042bcb2632ea6a38fa08dbe21a6e8a0ee46961 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-08 16:00:52.625146) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-08 16:00:52.625613) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-08 16:00:52.625908) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-08 16:00:52.639548) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 16:00:52.639889) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1502233252.44184-551636089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-08 16:00:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223K=0.05s 2017-08-08 16:00:52 (223 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.174247 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 16:00:52.825595) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 16:00:52.825959) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1502233252.44184-551636089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016701 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 16:00:52.875541) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 16:00:52.878898) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1d042bcb2632ea6a38fa08dbe21a6e8a0ee46961 --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 1d042bcb2632ea6a38fa08dbe21a6e8a0ee46961 --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=9c3a94c35cc88655b05d2c08000001b2-1502233252.44184-551636089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-08 16:00:53,055 truncating revision to first 12 chars 2017-08-08 16:00:53,055 Setting DEBUG logging. 2017-08-08 16:00:53,055 attempt 1/10 2017-08-08 16:00:53,055 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1d042bcb2632?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-08 16:00:53,481 unpacking tar archive at: mozilla-central-1d042bcb2632/testing/mozharness/ program finished with exit code 0 elapsedTime=0.858139 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 16:00:53.753022) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-08 16:00:53.753354) ========= script_repo_revision: 1d042bcb2632ea6a38fa08dbe21a6e8a0ee46961 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-08 16:00:53.753785) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-08 16:00:53.754062) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-08 16:00:53.764454) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-08 16:00:53.764812) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1502233252.44184-551636089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:00:54 INFO - MultiFileLogger online at 20170808 16:00:54 in /builds/slave/test 16:00:54 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 16:00:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:00:54 INFO - {'append_to_log': False, 16:00:54 INFO - 'base_work_dir': '/builds/slave/test', 16:00:54 INFO - 'blob_upload_branch': 'Firefox', 16:00:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:00:54 INFO - 'branch': 'Firefox', 16:00:54 INFO - 'buildbot_json_path': 'buildprops.json', 16:00:54 INFO - 'code_coverage': False, 16:00:54 INFO - 'config_files': ('talos/linux_config.py',), 16:00:54 INFO - 'default_actions': ('clobber', 16:00:54 INFO - 'read-buildbot-config', 16:00:54 INFO - 'download-and-extract', 16:00:54 INFO - 'populate-webroot', 16:00:54 INFO - 'create-virtualenv', 16:00:54 INFO - 'install', 16:00:54 INFO - 'setup-mitmproxy', 16:00:54 INFO - 'run-tests'), 16:00:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:00:54 INFO - 'disable_ccov_upload': False, 16:00:54 INFO - 'download_minidump_stackwalk': True, 16:00:54 INFO - 'download_symbols': 'ondemand', 16:00:54 INFO - 'enable_stylo': False, 16:00:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:00:54 INFO - 'tooltool.py': '/tools/tooltool.py', 16:00:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:00:54 INFO - '/tools/misc-python/virtualenv.py')}, 16:00:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:00:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:00:54 INFO - 'gecko_profile': False, 16:00:54 INFO - 'gecko_profile_interval': 0, 16:00:54 INFO - 'installer_path': 'installer.exe', 16:00:54 INFO - 'log_level': 'info', 16:00:54 INFO - 'log_name': 'talos', 16:00:54 INFO - 'log_to_console': True, 16:00:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:00:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:00:54 INFO - 'opt_config_files': (), 16:00:54 INFO - 'pip_index': False, 16:00:54 INFO - 'suite': 'dromaeojs-e10s', 16:00:54 INFO - 'system_bits': '32', 16:00:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:00:54 INFO - 'title': 'talos-linux64-ix-013', 16:00:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:00:54 INFO - 'use_talos_json': True, 16:00:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:00:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:00:54 INFO - 'work_dir': 'build'} 16:00:54 INFO - [mozharness: 2017-08-08 23:00:54.027598Z] Running clobber step. 16:00:54 INFO - Running pre-action listener: _resource_record_pre_action 16:00:54 INFO - Running main action method: clobber 16:00:54 INFO - rmtree: /builds/slave/test/build 16:00:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:00:55 INFO - Running post-action listener: _resource_record_post_action 16:00:55 INFO - [mozharness: 2017-08-08 23:00:55.186231Z] Finished clobber step (success) 16:00:55 INFO - [mozharness: 2017-08-08 23:00:55.186347Z] Running read-buildbot-config step. 16:00:55 INFO - Running pre-action listener: _resource_record_pre_action 16:00:55 INFO - Running main action method: read_buildbot_config 16:00:55 INFO - Using buildbot properties: 16:00:55 INFO - { 16:00:55 INFO - "project": "", 16:00:55 INFO - "product": "firefox", 16:00:55 INFO - "who": "kwierso@gmail.com", 16:00:55 INFO - "installer_path": "public/build/target.tar.bz2", 16:00:55 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 16:00:55 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:00:55 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 16:00:55 INFO - "stage_platform": "linux64-stylo", 16:00:55 INFO - "basedir": "/builds/slave/test", 16:00:55 INFO - "buildnumber": 70, 16:00:55 INFO - "platform": "ubuntu64_hw_stylo", 16:00:55 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:00:55 INFO - "slavebuilddir": "test", 16:00:55 INFO - "taskId": "T5C5PsSgS42w7wlEsn9T0Q", 16:00:55 INFO - "branch": "mozilla-central", 16:00:55 INFO - "script_repo_revision": "production", 16:00:55 INFO - "revision": "1d042bcb2632ea6a38fa08dbe21a6e8a0ee46961", 16:00:55 INFO - "slavename": "talos-linux64-ix-013", 16:00:55 INFO - "repo_path": "mozilla-central" 16:00:55 INFO - } 16:00:55 INFO - Finding installer, test and symbols from parent task. 16:00:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T5C5PsSgS42w7wlEsn9T0Q'}, attempt #1 16:00:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T5C5PsSgS42w7wlEsn9T0Q'}, attempt #1 16:00:56 INFO - Task dependencies: F7NQqaIQR2-2IEUa3S5RaA 16:00:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA'}, attempt #1 16:00:56 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.tar.bz2 16:00:56 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.test_packages.json 16:00:56 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.crashreporter-symbols.zip 16:00:56 INFO - Running post-action listener: _resource_record_post_action 16:00:56 INFO - [mozharness: 2017-08-08 23:00:56.550952Z] Finished read-buildbot-config step (success) 16:00:56 INFO - [mozharness: 2017-08-08 23:00:56.551175Z] Running download-and-extract step. 16:00:56 INFO - Running pre-action listener: _resource_record_pre_action 16:00:56 INFO - Running main action method: download_and_extract 16:00:56 INFO - mkdir: /builds/slave/test/build/tests 16:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:00:56 INFO - trying https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.test_packages.json 16:00:56 INFO - Downloading https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:00:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:00:57 INFO - Downloaded 989 bytes. 16:00:57 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:00:57 INFO - Using the following test package requirements: 16:00:57 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:00:57 INFO - u'common': [u'target.common.tests.zip'], 16:00:57 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:00:57 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:00:57 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:00:57 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:00:57 INFO - u'mozbase': [u'target.common.tests.zip'], 16:00:57 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:00:57 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:00:57 INFO - u'web-platform': [u'target.common.tests.zip', 16:00:57 INFO - u'target.web-platform.tests.tar.gz'], 16:00:57 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:00:57 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:00:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.common.tests.zip 16:00:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:00:57 INFO - Fetch https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.common.tests.zip into memory 16:00:58 INFO - Content-Length response header: 54285203 16:00:58 INFO - Bytes received: 54285203 16:01:09 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:01:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.common.tests.zip 16:01:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:01:09 INFO - Fetch https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.common.tests.zip into memory 16:01:10 INFO - Content-Length response header: 54285203 16:01:10 INFO - Bytes received: 54285203 16:01:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.talos.tests.zip 16:01:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:01:22 INFO - Fetch https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.talos.tests.zip into memory 16:01:23 INFO - Content-Length response header: 14496008 16:01:23 INFO - Bytes received: 14496008 16:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:23 INFO - trying https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.tar.bz2 16:01:23 INFO - Downloading https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:01:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:01:24 INFO - Downloaded 61959679 bytes. 16:01:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.tar.bz2 16:01:24 INFO - mkdir: /builds/slave/test/properties 16:01:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:01:24 INFO - Writing to file /builds/slave/test/properties/build_url 16:01:24 INFO - Contents: 16:01:24 INFO - build_url:https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.tar.bz2 16:01:24 INFO - Running post-action listener: _resource_record_post_action 16:01:24 INFO - Running post-action listener: set_extra_try_arguments 16:01:24 INFO - [mozharness: 2017-08-08 23:01:24.462899Z] Finished download-and-extract step (success) 16:01:24 INFO - [mozharness: 2017-08-08 23:01:24.462997Z] Running populate-webroot step. 16:01:24 INFO - Running pre-action listener: _resource_record_pre_action 16:01:24 INFO - Running main action method: populate_webroot 16:01:24 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:01:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:01:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:01:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:01:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:01:24 INFO - 'tests': ['damp', 'tps']}, 16:01:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:01:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:01:24 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:01:24 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:01:24 INFO - 'other-e10s': {'tests': ['a11yr', 16:01:24 INFO - 'ts_paint', 16:01:24 INFO - 'tpaint', 16:01:24 INFO - 'sessionrestore', 16:01:24 INFO - 'sessionrestore_many_windows', 16:01:24 INFO - 'sessionrestore_no_auto_restore', 16:01:24 INFO - 'tabpaint']}, 16:01:24 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:01:24 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:01:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:01:24 INFO - 'tsvgr_opacity', 16:01:24 INFO - 'tart', 16:01:24 INFO - 'tscrollx', 16:01:24 INFO - 'tsvg_static']}, 16:01:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:01:24 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:01:24 INFO - 'talos_options': ['--mitmproxy', 16:01:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:01:24 INFO - '--firstNonBlankPaint'], 16:01:24 INFO - 'tests': ['tp6_google', 16:01:24 INFO - 'tp6_youtube', 16:01:24 INFO - 'tp6_amazon', 16:01:24 INFO - 'tp6_facebook']}, 16:01:24 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:01:24 INFO - 'talos_options': ['--stylo', 16:01:24 INFO - '--mitmproxy', 16:01:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:01:24 INFO - '--firstNonBlankPaint'], 16:01:24 INFO - 'tests': ['tp6_google', 16:01:24 INFO - 'tp6_youtube', 16:01:24 INFO - 'tp6_amazon', 16:01:24 INFO - 'tp6_facebook']}, 16:01:24 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:01:24 INFO - 'talos_options': ['--stylo', 16:01:24 INFO - '--stylo-threads=1', 16:01:24 INFO - '--mitmproxy', 16:01:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:01:24 INFO - '--firstNonBlankPaint'], 16:01:24 INFO - 'tests': ['tp6_google', 16:01:24 INFO - 'tp6_youtube', 16:01:24 INFO - 'tp6_amazon', 16:01:24 INFO - 'tp6_facebook']}, 16:01:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:01:24 INFO - 'talos_options': ['--xperf_path', 16:01:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:01:24 INFO - 'tests': ['tp5n']}}} 16:01:24 INFO - Running post-action listener: _resource_record_post_action 16:01:24 INFO - [mozharness: 2017-08-08 23:01:24.471467Z] Finished populate-webroot step (success) 16:01:24 INFO - [mozharness: 2017-08-08 23:01:24.471557Z] Running create-virtualenv step. 16:01:24 INFO - Running pre-action listener: _resource_record_pre_action 16:01:24 INFO - Running main action method: create_virtualenv 16:01:24 INFO - Creating virtualenv /builds/slave/test/build/venv 16:01:24 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 16:01:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:01:24 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:01:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:01:24 INFO - Using real prefix '/usr' 16:01:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:01:25 INFO - Installing distribute.............................................................................................................................................................................................done. 16:01:27 INFO - Installing pip.................done. 16:01:27 INFO - Return code: 0 16:01:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:01:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:01:27 INFO - Reading from file tmpfile_stdout 16:01:27 INFO - Output received: 16:01:27 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) 16:01:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:27 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 0x1ca01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200ceb0>, '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 0x200ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200e240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502233252.44184-551636089', '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 16:01:27 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 16:01:27 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 16:01:27 INFO - Using env: {'DISPLAY': ':0', 16:01:27 INFO - 'HOME': '/home/cltbld', 16:01:27 INFO - 'LANG': 'en_US.UTF-8', 16:01:27 INFO - 'LANGUAGE': 'en_US:en', 16:01:27 INFO - 'LOGNAME': 'cltbld', 16:01:27 INFO - 'MAIL': '/var/mail/cltbld', 16:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:27 INFO - 'MOZ_NO_REMOTE': '1', 16:01:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:27 INFO - 'NO_EM_RESTART': '1', 16:01:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:27 INFO - 'PWD': '/builds/slave/test', 16:01:27 INFO - 'SHELL': '/bin/bash', 16:01:27 INFO - 'SHLVL': '1', 16:01:27 INFO - 'TERM': 'linux', 16:01:27 INFO - 'TMOUT': '86400', 16:01:27 INFO - 'USER': 'cltbld', 16:01:27 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502233252.44184-551636089', 16:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:27 INFO - '_': '/tools/buildbot/bin/python'} 16:01:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:27 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 16:01:27 INFO - Cleaning up... 16:01:27 INFO - Return code: 0 16:01:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:27 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 0x1ca01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200ceb0>, '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 0x200ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200e240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502233252.44184-551636089', '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 16:01:27 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 16:01:27 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 16:01:27 INFO - Using env: {'DISPLAY': ':0', 16:01:27 INFO - 'HOME': '/home/cltbld', 16:01:27 INFO - 'LANG': 'en_US.UTF-8', 16:01:27 INFO - 'LANGUAGE': 'en_US:en', 16:01:27 INFO - 'LOGNAME': 'cltbld', 16:01:27 INFO - 'MAIL': '/var/mail/cltbld', 16:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:27 INFO - 'MOZ_NO_REMOTE': '1', 16:01:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:27 INFO - 'NO_EM_RESTART': '1', 16:01:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:27 INFO - 'PWD': '/builds/slave/test', 16:01:27 INFO - 'SHELL': '/bin/bash', 16:01:27 INFO - 'SHLVL': '1', 16:01:27 INFO - 'TERM': 'linux', 16:01:27 INFO - 'TMOUT': '86400', 16:01:27 INFO - 'USER': 'cltbld', 16:01:27 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502233252.44184-551636089', 16:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:27 INFO - '_': '/tools/buildbot/bin/python'} 16:01:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:27 INFO - Downloading/unpacking psutil>=3.1.1 16:01:27 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 16:01:27 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 16:01:27 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 16:01:27 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 16:01:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:01:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:01:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:01:28 INFO - Installing collected packages: psutil 16:01:28 INFO - Running setup.py install for psutil 16:01:29 INFO - building 'psutil._psutil_linux' extension 16:01:29 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 16:01:29 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 16:01:29 INFO - building 'psutil._psutil_posix' extension 16:01:29 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 16:01:29 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 16:01:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:01:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:01:29 INFO - Successfully installed psutil 16:01:29 INFO - Cleaning up... 16:01:29 INFO - Return code: 0 16:01:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:01:29 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')]} 16:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:29 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')]} 16:01:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:29 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 0x1ca01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200ceb0>, '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 0x200ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200e240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502233252.44184-551636089', '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 16:01:29 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 16:01:29 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 16:01:29 INFO - Using env: {'DISPLAY': ':0', 16:01:29 INFO - 'HOME': '/home/cltbld', 16:01:29 INFO - 'LANG': 'en_US.UTF-8', 16:01:29 INFO - 'LANGUAGE': 'en_US:en', 16:01:29 INFO - 'LOGNAME': 'cltbld', 16:01:29 INFO - 'MAIL': '/var/mail/cltbld', 16:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:29 INFO - 'MOZ_NO_REMOTE': '1', 16:01:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:29 INFO - 'NO_EM_RESTART': '1', 16:01:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:29 INFO - 'PWD': '/builds/slave/test', 16:01:29 INFO - 'SHELL': '/bin/bash', 16:01:29 INFO - 'SHLVL': '1', 16:01:29 INFO - 'TERM': 'linux', 16:01:29 INFO - 'TMOUT': '86400', 16:01:29 INFO - 'USER': 'cltbld', 16:01:29 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502233252.44184-551636089', 16:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:29 INFO - '_': '/tools/buildbot/bin/python'} 16:01:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:01:29 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 16:01:29 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 16:01:29 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 16:01:29 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 16:01:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:01:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:01:30 INFO - Installing collected packages: mozsystemmonitor 16:01:30 INFO - Running setup.py install for mozsystemmonitor 16:01:30 INFO - Successfully installed mozsystemmonitor 16:01:30 INFO - Cleaning up... 16:01:30 INFO - Return code: 0 16:01:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:01:30 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')]} 16:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:30 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')]} 16:01:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:30 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 0x1ca01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200ceb0>, '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 0x200ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200e240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502233252.44184-551636089', '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 16:01:30 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 16:01:30 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 16:01:30 INFO - Using env: {'DISPLAY': ':0', 16:01:30 INFO - 'HOME': '/home/cltbld', 16:01:30 INFO - 'LANG': 'en_US.UTF-8', 16:01:30 INFO - 'LANGUAGE': 'en_US:en', 16:01:30 INFO - 'LOGNAME': 'cltbld', 16:01:30 INFO - 'MAIL': '/var/mail/cltbld', 16:01:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:30 INFO - 'MOZ_NO_REMOTE': '1', 16:01:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:30 INFO - 'NO_EM_RESTART': '1', 16:01:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:30 INFO - 'PWD': '/builds/slave/test', 16:01:30 INFO - 'SHELL': '/bin/bash', 16:01:30 INFO - 'SHLVL': '1', 16:01:30 INFO - 'TERM': 'linux', 16:01:30 INFO - 'TMOUT': '86400', 16:01:30 INFO - 'USER': 'cltbld', 16:01:30 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502233252.44184-551636089', 16:01:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:30 INFO - '_': '/tools/buildbot/bin/python'} 16:01:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:31 INFO - Downloading/unpacking jsonschema==2.5.1 16:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:01:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:01:32 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 16:01:32 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 16:01:32 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 16:01:32 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 16:01:32 INFO - Downloading functools32-3.2.3-2.tar.gz 16:01:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:01:32 INFO - warning: no files found matching '*.txt' 16:01:32 INFO - no previously-included directories found matching 'build' 16:01:32 INFO - no previously-included directories found matching 'dist' 16:01:32 INFO - no previously-included directories found matching '.git*' 16:01:32 INFO - Installing collected packages: jsonschema, functools32 16:01:32 INFO - Running setup.py install for functools32 16:01:32 INFO - warning: no files found matching '*.txt' 16:01:32 INFO - no previously-included directories found matching 'build' 16:01:32 INFO - no previously-included directories found matching 'dist' 16:01:32 INFO - no previously-included directories found matching '.git*' 16:01:32 INFO - Successfully installed jsonschema functools32 16:01:32 INFO - Cleaning up... 16:01:32 INFO - Return code: 0 16:01:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:01:32 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')]} 16:01:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:32 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')]} 16:01:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:32 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 0x1ca01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200ceb0>, '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 0x200ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200e240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502233252.44184-551636089', '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 16:01:32 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 16:01:32 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 16:01:32 INFO - Using env: {'DISPLAY': ':0', 16:01:32 INFO - 'HOME': '/home/cltbld', 16:01:32 INFO - 'LANG': 'en_US.UTF-8', 16:01:32 INFO - 'LANGUAGE': 'en_US:en', 16:01:32 INFO - 'LOGNAME': 'cltbld', 16:01:32 INFO - 'MAIL': '/var/mail/cltbld', 16:01:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:32 INFO - 'MOZ_NO_REMOTE': '1', 16:01:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:32 INFO - 'NO_EM_RESTART': '1', 16:01:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:32 INFO - 'PWD': '/builds/slave/test', 16:01:32 INFO - 'SHELL': '/bin/bash', 16:01:32 INFO - 'SHLVL': '1', 16:01:32 INFO - 'TERM': 'linux', 16:01:32 INFO - 'TMOUT': '86400', 16:01:32 INFO - 'USER': 'cltbld', 16:01:32 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502233252.44184-551636089', 16:01:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:32 INFO - '_': '/tools/buildbot/bin/python'} 16:01:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:01:32 INFO - Cleaning up... 16:01:32 INFO - Return code: 0 16:01:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:01:32 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')]} 16:01:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:32 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')]} 16:01:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:32 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 0x1ca01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200ceb0>, '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 0x200ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200e240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502233252.44184-551636089', '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 16:01:32 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 16:01:32 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 16:01:32 INFO - Using env: {'DISPLAY': ':0', 16:01:32 INFO - 'HOME': '/home/cltbld', 16:01:32 INFO - 'LANG': 'en_US.UTF-8', 16:01:32 INFO - 'LANGUAGE': 'en_US:en', 16:01:32 INFO - 'LOGNAME': 'cltbld', 16:01:32 INFO - 'MAIL': '/var/mail/cltbld', 16:01:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:32 INFO - 'MOZ_NO_REMOTE': '1', 16:01:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:32 INFO - 'NO_EM_RESTART': '1', 16:01:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:32 INFO - 'PWD': '/builds/slave/test', 16:01:32 INFO - 'SHELL': '/bin/bash', 16:01:32 INFO - 'SHLVL': '1', 16:01:32 INFO - 'TERM': 'linux', 16:01:32 INFO - 'TMOUT': '86400', 16:01:32 INFO - 'USER': 'cltbld', 16:01:32 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502233252.44184-551636089', 16:01:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:32 INFO - '_': '/tools/buildbot/bin/python'} 16:01:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:33 INFO - Downloading/unpacking blobuploader==1.2.4 16:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:34 INFO - Downloading blobuploader-1.2.4.tar.gz 16:01:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:01:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:01:34 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 16:01:34 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 16:01:34 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 16:01:34 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 16:01:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:01:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:01:34 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 16:01:34 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 16:01:34 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 16:01:34 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 16:01:34 INFO - Downloading docopt-0.6.1.tar.gz 16:01:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:01:34 INFO - Installing collected packages: blobuploader, requests, docopt 16:01:34 INFO - Running setup.py install for blobuploader 16:01:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:01:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:01:34 INFO - Running setup.py install for requests 16:01:35 INFO - Running setup.py install for docopt 16:01:35 INFO - Successfully installed blobuploader requests docopt 16:01:35 INFO - Cleaning up... 16:01:35 INFO - Return code: 0 16:01:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:01:35 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')]} 16:01:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:35 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')]} 16:01:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:35 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 0x1ca01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200ceb0>, '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 0x200ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200e240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502233252.44184-551636089', '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 16:01:35 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 16:01:35 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 16:01:35 INFO - Using env: {'DISPLAY': ':0', 16:01:35 INFO - 'HOME': '/home/cltbld', 16:01:35 INFO - 'LANG': 'en_US.UTF-8', 16:01:35 INFO - 'LANGUAGE': 'en_US:en', 16:01:35 INFO - 'LOGNAME': 'cltbld', 16:01:35 INFO - 'MAIL': '/var/mail/cltbld', 16:01:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:35 INFO - 'MOZ_NO_REMOTE': '1', 16:01:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:35 INFO - 'NO_EM_RESTART': '1', 16:01:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:35 INFO - 'PWD': '/builds/slave/test', 16:01:35 INFO - 'SHELL': '/bin/bash', 16:01:35 INFO - 'SHLVL': '1', 16:01:35 INFO - 'TERM': 'linux', 16:01:35 INFO - 'TMOUT': '86400', 16:01:35 INFO - 'USER': 'cltbld', 16:01:35 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502233252.44184-551636089', 16:01:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:35 INFO - '_': '/tools/buildbot/bin/python'} 16:01:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:01:35 INFO - Running setup.py (path:/tmp/pip-qVyWRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:01:35 INFO - Running setup.py (path:/tmp/pip-UfOh_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:01:35 INFO - Running setup.py (path:/tmp/pip-A9vNKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:01:35 INFO - Running setup.py (path:/tmp/pip-0adtBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:01:35 INFO - Running setup.py (path:/tmp/pip-okFpUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:01:35 INFO - Running setup.py (path:/tmp/pip-MI9tqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:01:36 INFO - Running setup.py (path:/tmp/pip-cUygyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:01:36 INFO - Running setup.py (path:/tmp/pip-c90YPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:01:36 INFO - Running setup.py (path:/tmp/pip-7CNoXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:01:36 INFO - Running setup.py (path:/tmp/pip-wuO_Sr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:01:36 INFO - Running setup.py (path:/tmp/pip-h9zTCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:01:36 INFO - Running setup.py (path:/tmp/pip-UKdqx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:01:36 INFO - Running setup.py (path:/tmp/pip-9QdEYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:01:36 INFO - Running setup.py (path:/tmp/pip-dG0iTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:36 INFO - Running setup.py (path:/tmp/pip-hUSDal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:01:36 INFO - Running setup.py (path:/tmp/pip-1Pze38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:01:36 INFO - Running setup.py (path:/tmp/pip-yycMEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:01:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:01:36 INFO - Running setup.py install for manifestparser 16:01:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:01:36 INFO - Running setup.py install for mozcrash 16:01:37 INFO - Running setup.py install for mozdebug 16:01:37 INFO - Running setup.py install for mozdevice 16:01:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:01:37 INFO - Running setup.py install for mozfile 16:01:37 INFO - Running setup.py install for mozhttpd 16:01:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:01:37 INFO - Running setup.py install for mozinfo 16:01:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:01:37 INFO - Running setup.py install for mozInstall 16:01:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:01:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:01:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:01:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:01:37 INFO - Running setup.py install for mozleak 16:01:37 INFO - Running setup.py install for mozlog 16:01:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:01:37 INFO - Running setup.py install for moznetwork 16:01:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:01:37 INFO - Running setup.py install for mozprocess 16:01:38 INFO - Running setup.py install for mozprofile 16:01:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:01:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:01:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:01:38 INFO - Running setup.py install for mozrunner 16:01:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:01:38 INFO - Running setup.py install for mozscreenshot 16:01:38 INFO - Running setup.py install for moztest 16:01:38 INFO - Running setup.py install for mozversion 16:01:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:01:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:01:38 INFO - Cleaning up... 16:01:38 INFO - Return code: 0 16:01:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:01: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')]} 16:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01: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')]} 16:01:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:38 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 0x1ca01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200ceb0>, '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 0x200ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200e240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502233252.44184-551636089', '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 16:01:38 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 16:01:38 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 16:01:38 INFO - Using env: {'DISPLAY': ':0', 16:01:38 INFO - 'HOME': '/home/cltbld', 16:01:38 INFO - 'LANG': 'en_US.UTF-8', 16:01:38 INFO - 'LANGUAGE': 'en_US:en', 16:01:38 INFO - 'LOGNAME': 'cltbld', 16:01:38 INFO - 'MAIL': '/var/mail/cltbld', 16:01:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:38 INFO - 'MOZ_NO_REMOTE': '1', 16:01:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:38 INFO - 'NO_EM_RESTART': '1', 16:01:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:38 INFO - 'PWD': '/builds/slave/test', 16:01:38 INFO - 'SHELL': '/bin/bash', 16:01:38 INFO - 'SHLVL': '1', 16:01:38 INFO - 'TERM': 'linux', 16:01:38 INFO - 'TMOUT': '86400', 16:01:38 INFO - 'USER': 'cltbld', 16:01:38 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502233252.44184-551636089', 16:01:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:38 INFO - '_': '/tools/buildbot/bin/python'} 16:01:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:01:38 INFO - Running setup.py (path:/tmp/pip-HyVgYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:01:38 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)) 16:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:01:38 INFO - Running setup.py (path:/tmp/pip-UMkePB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:01:38 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)) 16:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:01:38 INFO - Running setup.py (path:/tmp/pip-EPVBxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:01:39 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)) 16:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:01:39 INFO - Running setup.py (path:/tmp/pip-M9L_Ux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:01:39 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)) 16:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:01:39 INFO - Running setup.py (path:/tmp/pip-jiVOoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:01:39 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)) 16:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:01:39 INFO - Running setup.py (path:/tmp/pip-IXEf0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:01:39 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)) 16:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:01:39 INFO - Running setup.py (path:/tmp/pip-OJkXLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:01:39 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)) 16:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:01:39 INFO - Running setup.py (path:/tmp/pip-fCpq2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:01:39 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)) 16:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:01:39 INFO - Running setup.py (path:/tmp/pip-dpUm88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:01:39 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)) 16:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:01:39 INFO - Running setup.py (path:/tmp/pip-WtltDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:01:39 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)) 16:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:01:39 INFO - Running setup.py (path:/tmp/pip-DFJFoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:01:39 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)) 16:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:01:39 INFO - Running setup.py (path:/tmp/pip-YJCEuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:01:39 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)) 16:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:01:39 INFO - Running setup.py (path:/tmp/pip-A9wgo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:01:39 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)) 16:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:01:39 INFO - Running setup.py (path:/tmp/pip-eD7Xoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:01:39 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)) 16:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:39 INFO - Running setup.py (path:/tmp/pip-yeU7Xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:39 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)) 16:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:01:39 INFO - Running setup.py (path:/tmp/pip-_nJVFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:01:39 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)) 16:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:01:39 INFO - Running setup.py (path:/tmp/pip-rOLN9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:01:40 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)) 16:01:40 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)) 16:01:40 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)) 16:01:40 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)) 16:01:40 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)) 16:01:40 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)) 16:01:40 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)) 16:01:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:01: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 16:01: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 16:01: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 16:01: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 16:01:41 INFO - Downloading blessings-1.6.tar.gz 16:01:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:01:41 INFO - Installing collected packages: blessings 16:01:41 INFO - Running setup.py install for blessings 16:01:41 INFO - Successfully installed blessings 16:01:41 INFO - Cleaning up... 16:01:41 INFO - Return code: 0 16:01:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:01:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:01:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:01:41 INFO - Reading from file tmpfile_stdout 16:01:41 INFO - Current package versions: 16:01:41 INFO - argparse == 1.2.1 16:01:41 INFO - blessings == 1.6 16:01:41 INFO - blobuploader == 1.2.4 16:01:41 INFO - docopt == 0.6.1 16:01:41 INFO - functools32 == 3.2.3-2 16:01:41 INFO - jsonschema == 2.5.1 16:01:41 INFO - manifestparser == 1.1 16:01:41 INFO - mozInstall == 1.13 16:01:41 INFO - mozcrash == 1.0 16:01:41 INFO - mozdebug == 0.1 16:01:41 INFO - mozdevice == 0.51 16:01:41 INFO - mozfile == 1.2 16:01:41 INFO - mozhttpd == 0.7 16:01:41 INFO - mozinfo == 0.10 16:01:41 INFO - mozleak == 0.1 16:01:41 INFO - mozlog == 3.5 16:01:41 INFO - moznetwork == 0.27 16:01:41 INFO - mozprocess == 0.25 16:01:41 INFO - mozprofile == 0.28 16:01:41 INFO - mozrunner == 6.13 16:01:41 INFO - mozscreenshot == 0.1 16:01:41 INFO - mozsystemmonitor == 0.3 16:01:41 INFO - moztest == 0.8 16:01:41 INFO - mozversion == 1.4 16:01:41 INFO - psutil == 3.1.1 16:01:41 INFO - requests == 1.2.3 16:01:41 INFO - wsgiref == 0.1.2 16:01:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:01:41 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')]} 16:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:41 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')]} 16:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:41 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 0x1ca01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200ceb0>, '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 0x200ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200e240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502233252.44184-551636089', '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 16:01:41 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 16:01:41 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 16:01:41 INFO - Using env: {'DISPLAY': ':0', 16:01:41 INFO - 'HOME': '/home/cltbld', 16:01:41 INFO - 'LANG': 'en_US.UTF-8', 16:01:41 INFO - 'LANGUAGE': 'en_US:en', 16:01:41 INFO - 'LOGNAME': 'cltbld', 16:01:41 INFO - 'MAIL': '/var/mail/cltbld', 16:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:41 INFO - 'MOZ_NO_REMOTE': '1', 16:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:41 INFO - 'NO_EM_RESTART': '1', 16:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:41 INFO - 'PWD': '/builds/slave/test', 16:01:41 INFO - 'SHELL': '/bin/bash', 16:01:41 INFO - 'SHLVL': '1', 16:01:41 INFO - 'TERM': 'linux', 16:01:41 INFO - 'TMOUT': '86400', 16:01:41 INFO - 'USER': 'cltbld', 16:01:41 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502233252.44184-551636089', 16:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:41 INFO - '_': '/tools/buildbot/bin/python'} 16:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:41 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)) 16:01:41 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)) 16:01:41 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)) 16:01:41 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)) 16:01:41 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)) 16:01:41 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)) 16:01:41 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)) 16:01:41 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)) 16:01:41 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)) 16:01:41 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:01:41 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 16:01:41 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 16:01:41 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 16:01:41 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 16:01:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:01:43 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)) 16:01:43 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)) 16:01:43 INFO - Installing collected packages: simplejson 16:01:43 INFO - Running setup.py install for simplejson 16:01:43 INFO - building 'simplejson._speedups' extension 16:01:43 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 16:01:43 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 16:01:44 INFO - Successfully installed simplejson 16:01:44 INFO - Cleaning up... 16:01:44 INFO - Return code: 0 16:01:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:01:44 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')]} 16:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:44 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')]} 16:01:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:44 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 0x1ca01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200ceb0>, '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 0x200ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200e240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502233252.44184-551636089', '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 16:01:44 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 16:01:44 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 16:01:44 INFO - Using env: {'DISPLAY': ':0', 16:01:44 INFO - 'HOME': '/home/cltbld', 16:01:44 INFO - 'LANG': 'en_US.UTF-8', 16:01:44 INFO - 'LANGUAGE': 'en_US:en', 16:01:44 INFO - 'LOGNAME': 'cltbld', 16:01:44 INFO - 'MAIL': '/var/mail/cltbld', 16:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:44 INFO - 'MOZ_NO_REMOTE': '1', 16:01:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:44 INFO - 'NO_EM_RESTART': '1', 16:01:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:44 INFO - 'PWD': '/builds/slave/test', 16:01:44 INFO - 'SHELL': '/bin/bash', 16:01:44 INFO - 'SHLVL': '1', 16:01:44 INFO - 'TERM': 'linux', 16:01:44 INFO - 'TMOUT': '86400', 16:01:44 INFO - 'USER': 'cltbld', 16:01:44 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502233252.44184-551636089', 16:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:44 INFO - '_': '/tools/buildbot/bin/python'} 16:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:01:44 INFO - Cleaning up... 16:01:44 INFO - Return code: 0 16:01:44 INFO - Running post-action listener: _resource_record_post_action 16:01:44 INFO - Running post-action listener: _start_resource_monitoring 16:01:44 INFO - Starting resource monitoring. 16:01:44 INFO - [mozharness: 2017-08-08 23:01:44.323108Z] Finished create-virtualenv step (success) 16:01:44 INFO - [mozharness: 2017-08-08 23:01:44.323626Z] Running install step. 16:01:44 INFO - Running pre-action listener: _resource_record_pre_action 16:01:44 INFO - Running main action method: install 16:01:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:01:44 INFO - Reading from file tmpfile_stdout 16:01:44 INFO - Detecting whether we're running mozinstall >=1.0... 16:01:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:01:44 INFO - Reading from file tmpfile_stdout 16:01:44 INFO - Output received: 16:01:44 INFO - Usage: mozinstall [options] installer 16:01:44 INFO - Options: 16:01:44 INFO - -h, --help show this help message and exit 16:01:44 INFO - -d DEST, --destination=DEST 16:01:44 INFO - Directory to install application into. [default: 16:01:44 INFO - "/builds/slave/test"] 16:01:44 INFO - --app=APP Application being installed. [default: firefox] 16:01:44 INFO - mkdir: /builds/slave/test/build/application 16:01:44 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'] 16:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:02:02 INFO - Reading from file tmpfile_stdout 16:02:02 INFO - Output received: 16:02:02 INFO - /builds/slave/test/build/application/firefox/firefox 16:02:02 INFO - Running post-action listener: _resource_record_post_action 16:02:02 INFO - [mozharness: 2017-08-08 23:02:02.662437Z] Finished install step (success) 16:02:02 INFO - [mozharness: 2017-08-08 23:02:02.662722Z] Running setup-mitmproxy step. 16:02:02 INFO - Running pre-action listener: _resource_record_pre_action 16:02:02 INFO - Running main action method: setup_mitmproxy 16:02:02 INFO - Skipping: mitmproxy is not required 16:02:02 INFO - Running post-action listener: _resource_record_post_action 16:02:02 INFO - [mozharness: 2017-08-08 23:02:02.663880Z] Finished setup-mitmproxy step (success) 16:02:02 INFO - [mozharness: 2017-08-08 23:02:02.664100Z] Running run-tests step. 16:02:02 INFO - Running pre-action listener: _resource_record_pre_action 16:02:02 INFO - Running pre-action listener: _set_gcov_prefix 16:02:02 INFO - Running main action method: run_tests 16:02:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:02:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:02:02 INFO - Python 2.7.3 16:02:02 INFO - Return code: 0 16:02:02 INFO - grabbing minidump binary from tooltool 16:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:02 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 0x200ceb0>, '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 0x200ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200e240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:02:02 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 16:02:02 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 16:02:02 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 16:02:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:02:02 INFO - Return code: 0 16:02:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:02:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:02:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:02:02 INFO - ENV: RUST_BACKTRACE is now 1 16:02:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:02:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:02:02 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/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 16:02:02 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/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 16:02:02 INFO - Using env: {'DISPLAY': ':0', 16:02:02 INFO - 'HOME': '/home/cltbld', 16:02:02 INFO - 'LANG': 'en_US.UTF-8', 16:02:02 INFO - 'LANGUAGE': 'en_US:en', 16:02:02 INFO - 'LOGNAME': 'cltbld', 16:02:02 INFO - 'MAIL': '/var/mail/cltbld', 16:02:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:02:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:02 INFO - 'MOZ_NO_REMOTE': '1', 16:02:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:02 INFO - 'NO_EM_RESTART': '1', 16:02:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:02 INFO - 'PWD': '/builds/slave/test', 16:02:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:02:02 INFO - 'RUST_BACKTRACE': '1', 16:02:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:02:02 INFO - 'SHELL': '/bin/bash', 16:02:02 INFO - 'SHLVL': '1', 16:02:02 INFO - 'STYLO_FORCE_ENABLED': '1', 16:02:02 INFO - 'TERM': 'linux', 16:02:02 INFO - 'TMOUT': '86400', 16:02:02 INFO - 'USER': 'cltbld', 16:02:02 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502233252.44184-551636089', 16:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:02 INFO - '_': '/tools/buildbot/bin/python'} 16:02:02 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/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 16:02:03 INFO - mozversion application_buildid: 20170808221439 16:02:03 INFO - mozversion application_changeset: 1d042bcb2632ea6a38fa08dbe21a6e8a0ee46961 16:02:03 INFO - mozversion application_display_name: Nightly 16:02:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:02:03 INFO - mozversion application_name: Firefox 16:02:03 INFO - mozversion application_remotingname: firefox 16:02:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:02:03 INFO - mozversion application_vendor: Mozilla 16:02:03 INFO - mozversion application_version: 57.0a1 16:02:03 INFO - mozversion platform_buildid: 20170808221439 16:02:03 INFO - mozversion platform_changeset: 1d042bcb2632ea6a38fa08dbe21a6e8a0ee46961 16:02:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:02:03 INFO - mozversion platform_version: 57.0a1 16:02:03 INFO - using testdate: 1502233323 16:02:03 INFO - actual date: 1502233323 16:02:03 INFO - starting webserver on 'localhost:43281' 16:02:03 INFO - SUITE-START | Running 2 tests 16:02:03 INFO - TEST-START | dromaeo_css 16:02:03 INFO - Initialising browser for dromaeo_css test... 16:02:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43281/getInfo.html -profile /tmp/tmpH9r3OH/profile 16:02:03 INFO - TEST-INFO | started process 4358 (/builds/slave/test/build/application/firefox/firefox http://localhost:43281/getInfo.html) 16:02:09 INFO - TEST-INFO | 4358: exit 0 16:02:09 INFO - Browser initialized. 16:02:09 INFO - Running cycle 1/1 for dromaeo_css test... 16:02:09 INFO - TEST-INFO | started process 4584 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH9r3OH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:02:10 INFO - PID 4584 | 16:02:10 INFO - PID 4584 | (/builds/slave/test/build/application/firefox/firefox:4639): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:02:10 INFO - PID 4584 | 16:02:20 INFO - PID 4584 | RSS: Main: 170795008 16:02:20 INFO - PID 4584 | 16:05:20 INFO - PID 4584 | Cycle 1(1): loaded http://localhost:43281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43281/tests/dromaeo/cssquery-ext.html) 16:05:21 INFO - PID 4584 | RSS: Main: 175329280 16:05:21 INFO - PID 4584 | 16:08:23 INFO - PID 4584 | Cycle 1(1): loaded http://localhost:43281/tests/dromaeo/cssquery-ext.html (next: http://localhost:43281/tests/dromaeo/cssquery-jquery.html) 16:08:24 INFO - PID 4584 | RSS: Main: 172716032 16:08:24 INFO - PID 4584 | 16:11:26 INFO - PID 4584 | Cycle 1(1): loaded http://localhost:43281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43281/tests/dromaeo/cssquery-mootools.html) 16:11:26 INFO - PID 4584 | RSS: Main: 175075328 16:11:26 INFO - PID 4584 | 16:14:28 INFO - PID 4584 | Cycle 1(1): loaded http://localhost:43281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43281/tests/dromaeo/cssquery-prototype.html) 16:14:29 INFO - PID 4584 | RSS: Main: 172675072 16:14:29 INFO - PID 4584 | 16:17:33 INFO - PID 4584 | Cycle 1(1): loaded http://localhost:43281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43281/tests/dromaeo/cssquery-yui.html) 16:17:33 INFO - PID 4584 | RSS: Main: 176308224 16:17:33 INFO - PID 4584 | 16:20:35 INFO - PID 4584 | Cycle 1(1): loaded http://localhost:43281/tests/dromaeo/cssquery-yui.html (next: http://localhost:43281/tests/dromaeo/cssquery-dojo.html) 16:20:35 INFO - PID 4584 | RSS: Main: 175828992 16:20:35 INFO - PID 4584 | 16:20:35 INFO - PID 4584 | __start_tp_report 16:20:35 INFO - PID 4584 | _x_x_mozilla_page_load 16:20:35 INFO - PID 4584 | _x_x_mozilla_page_load_details 16:20:35 INFO - PID 4584 | |i|pagename|runs| 16:20:35 INFO - PID 4584 | |0;dojo.html;3183.3474137801745;3183.395154920565;3205.6634053424395;3206.5510828484003;3237.8866739664118;6271.404216599427;6311.431971122598;6344.873102537952;6388.808335749929;6424.743010279595;6157.353477884825;6261.123442718023;6268.905966410507;6295.15015472911;6316;5719.199312096289;5728.112142617891;5765.538756899459;5769.1346298055205;5850.385709500505;5786.392428794979;5829.8834023319505;5861.970690146543;5885.058390657496;5895.616784908989;5580.888382232373;5752.137179423099;5835.970820145893;5847.473727364536;5852.912206316909;5741.311042674905;5745.942540574582;5758.79844205455;5795.2176456178295;5823.88352232953;5631.2960879890015;5680.8863822723315;5733.713314334308;5768.250127483442;5794.68129252891;6122.8775424491705;6152.969235153795;6193.628382297032;6230.470410015154;6299.0866324382705;6646.833829154261;6692.297308782557;6714.127163468766;6715.731370745164;6720.731170753164;6764.289749576322;6770.458363330971;6773.559718618323;6773.983902414628;6775.22084960226;6209;6275.7175927082935;6275.717592708339;6277.435030847246;6277.968610156966;6900.7929762107215;7007.614581197981;7009.193942696553;7024.929750702529;7025.7189712411955;6614.239362473281;6614.404703576702;6699.5310328276555;6701.363370479797;6717.6977036033495;6634.933650663528;6697.028930805006;6713.798586042427;6785.592864428051;6825.385715285648;6629.668516574152;6650.634215118215;6716.261211266757;6722.764703235461;6744.5278830482375;6744.156980377453;6769.559978601375;6789.117414736152;6814.761483348059;6835.14560679915;5488.588355873326;5546.168074788814;5556.305461817273;5564.638298510584;5572;4574.83988060423;4634.351190833286;4670.276107203389;4671.0891376182;4690.507496712864;5824.5631577631;5834.474897259267;5839.620424672383;5844.1818145459665;5844.707764611752;6769.018492318586;6770.5599136056;6770.796876093725;6788.287229840796;6797.388235058769;5741.19623252745;5762.827115186551;5790.826275211751;5800.419958004166;5811.854703632358;5933.110033495011;6007.759689612367;6055.697215139226;6062.787802426894;6076.453119219292;6443.162388889508;6536.673166341664;6541.47668186544;6605.273419923805;6632.9336706633285;6746.224184218681;6753.831154221184;6762.661866906733;6775.559588626724;6781.050652908695;6543.5419520633095;6551.50863685216;6556.8360790980605;6562.245341785756;6566.244881838458;6618.404343609098;6643.534952553468;6646.634435106115;6648.933510665025;6678.265390806911;6750;6802.523823332319;6806.8638627228165;6877.1747390313485;6884.173899131936;6541;6552.508561857784;6555.6066636002;6653.700583473852;6653.73385064592;6457.61254324742;6546.279909209888;6562.475001999733;6612.966935165294;6649.63427011519;6493.155889734304;6522.673866306571;6558.967205163944;6576.605403675795;6603;6612.636305003271;6622;6673.833154171185;6713.093732346071;6721.260661327348;6312.779052733316;6378.48972082223;6390.712417941297;6398.456131228898;6495.675216239264 16:20:35 INFO - PID 4584 | |1;ext.html;825.7398919340408;866.579708841212;882.122288323119;890.8975467821202;1165.4930105404144;31830.68169318309;32150;42138.157236855244;42687;42909.35635965463;42425.7878710606;42833.57166428335;43136.352954705704;43232.56767432325;43259.13481730371;7827.178146294643;7895.526268423899;8027;8029.759107226763;8087.676492940275;7834.177411371809;7896.565688887137;7950.045994480671;7950.960245198766;7953.363730901514;7946.562939038351;7983.560904150269;8002.0797608274925;8008.799780005517;8013.679452821909;7894.4868583542175;7946.086200086977;7948.721794737156;7950.0857401399;7950.920490795076;7833.569153696544;7877.921220787834;7891.487053341514;7895.881561776578;7900.209979002111;39650.20699586021;39664.60335396638;39885.80057099725;39914.40128398076;40092;3572.696320812734;3615.783053016801;3620.601733809279;3622.3117607654463;3629.0927268182954;32946.3410731784;33059.504107438406;33070.17324566905;33095;33108.3378332432;5097.770600322994;5101.464346243628;5128.435872054071;5151.793928242866;5166.354205724285;197657;197782;197961;198766;199193;50373.49626503761;50438.495615044114;50455.49544504582;50504.979800808294;50574.49425505772;52364.47635523672;52695.47304526982;52727;52821.73589132106;52894.73552632289;13772.10481318731;13901.0964287321;14687.485937992118;15047.699046019019;15054.548363549111;12142.878571214174;12349.19730217533;12350.505979760708;12365.814512782315;12375.071869609816;14635.560933172022;14733.631659208606;14829.703405932038;14864.925675371554;14984.62538436526;5841.853953651108;5965.791197308074;5966.642001479925;6025.4577088061405;6117.724702388403;991.6578780320777;994.5777538120557;1000.5797565022708;1020.3265844542566;1029.902159294866;22839.771602284098;23014;23457.765422345557;23632.29103126909;23782.465917006804;1095.8191898336845;1118.5637601335486;1124.5333186727416;1131.0725205331548;1145.4959817680194;12380.938095309466;16585.83414165867;16618.6676266474;16651.33394664224;17085.914570427067;241487;243524;243974;244164;244312;58986.41013589809;59390.406095939354;59543.70228148918;59683;59811.70094149588;1447.6308541322105;1470.9999999999786;1488.4641529049534;1488.7692407676827;1508.2157278215266;27582.034628787897;27821;27978.860105699343;27991.300217494725;28099.297517562223;38796;38897;39072.2185556293;39090.21819563536;39099;216766;217046;217547;217940;218143;31792.841035794674;32176;32292.192695181868;32369.35261294808;34632.65367346395;38476.80761596174;39218.80390598029;40443.85590148537;44887.77556112198;45564;32043.198920026254;32262.516062259554;32280.19299517437;32574.674253258112;33062.66937330596;32247.35505289928;32249.35501290008;32268.35463290768;32300.515492267165;32916.341673166884;36511;36773.63226367809;36779.44830827593;36823.63176368202;36840.26319473542;31588.684113158575;31636.209094772814;31826.681733182373;31926.68073319237;32185.67814321827;23236.883815580815;23470;23560.88219558891;23707.881460592587;23831.404214894766 16:20:35 INFO - PID 4584 | |2;jquery.html;583.4777873802943;589.8024161905761;593.6052525070828;593.9287285525737;605.1316361021934;22246.998885050172;22963.42591435213;22971.310860674166;22996.88501557492;23306.300810975656;26794.330141746417;27284.04505842291;27395;27436.490992995376;27445.17664470064;6578.572392794465;6748.055272261888;6753.02081198226;6754.763583274586;6757.324267573228;6018.15745795589;6570.605763654172;6609.570377925444;6610.933890661104;6612.537122401433;6563.081168636395;6566;6570.8685826283445;6578.736850525997;6585.407313341822;6544.181977252843;6551.508636852232;6553.508486863504;6568.967155164218;6570.737170513174;6144.201253837017;6145.969270153665;6151.415615516519;6153.846153846145;6156.96921515394;29590.260243494085;29981.201127932392;30248.33634150121;30669.386612267852;31048;1896.2794138227384;1928.8360489358422;1935.2162374238455;1946.1047917957756;1948.3765195137562;18865.434036978775;19481.415557533295;19495.317663881695;19533.609327813505;19547.706784398102;2374.691290132289;2385.0817435287368;2411.6503107049557;2438.6829712137487;2489.95020099597;137367.31316343453;140206;140808;141085;141199.29400352933;13794.310284485735;14866.925665371604;15155.924220379047;15246.847531524765;15827.920860395854;23902;23939.521209575712;23948.161814336414;23966.082713382886;23976;10076.345037572535;10167.084962353423;10179.18566514677;10250.384976901261;10357.585696572203;7795.922040779633;9265.397749146285;9461;9496.240300775922;9747.951260243653;7914.76255712318;9304.581293841793;9309.767255818659;9511.33420660561;9596.808063838684;2767.681716602576;2809.5504719244823;2815.3102489890107;2840.9147725568264;2863.914082577526;949.7910459698855;956.4500412262977;982.4891056650501;988.9159421449114;991.177322822056;19954.20183192685;20146.89926550387;20190;20194.495137621678;20504.69242961357;1039.745262410699;1042.5412818360048;1047.2355180718118;1059.163261023798;1067.2102644043352;10976.286541374786;11261.605843795427;11268.54925802975;11517.078633709283;13356.732865342834;484537;504644;507664;528059;528720;112881.43559282315;115463.42268288604;119542.402287988;121267;121323.39338303253;1302.7199152182327;1324.0533018891538;1334.9532766353132;1340.222670850904;1341.4298922957703;21518.6772198414;21580.352589422342;21591.676124858455;21700.78299217051;21722.565548689254;58129.709351454665;59792.70103649454;60042.39957600368;60089;61470.385296146465;72884;73944.26055739373;74641.6267918657;74908;75961.6201919009;12439.569449513421;14344.56966291013;14605.780913286097;14938.925305373403;15085.924570377078;23782;23803.40491487727;23872;23909.52180956406;24031;18501.44495665132;18924.14841332116;18929.242830286636;19047.14287857022;19059.237630494627;15922.442714504938;17278.913605432394;17516.91241543784;18136.81863181404;18298.72551911749;19716.21135154578;19739.210431582575;19807.405777826687;19823;20067.397978060682;14677.92661036688;14885.404583816526;15039.097654140787;15061.548153555412;15081.622959426102;18782.624347513247;18900.432987010412;18901.338453154072;18943.90528047351;18994.525136871136 16:20:35 INFO - PID 4584 | |3;mootools.html;1346.42103895325;1400.3838311143097;1412.5056230319387;1414.0667159674617;1423.0678905317016;13586.864131358683;14167.92916035421;14170.71658566828;14184.574462766108;14185.78721319181;13771.10487818291;14667.193304368255;14755.48355807547;14759;14780;2591.9740802592014;2618.7904967602544;2626.9474610507777;2628.4217472156097;2631.8552479613613;2589.262060312811;2611.804114691396;2636.3145582148586;2667.493176296507;2667.826591271571;2541.2884392370165;2587.8447293162376;2614.4248265381584;2663.960040599383;2668.106184428219;2558.2325302409295;2582.18661121747;2589.4432696970243;2593.2738833126564;2596.026490066225;2499.125306142854;2522.836015658976;2522.8612426316545;2528.5954247320524;2556.463142740027;13699.794503082361;13967.930160349235;13976;13986.230757308344;14003.229822359766;7536.246375362474;7841.21587841217;7878.72424465141;7885.881711774328;7899.249571290776;4938.777755001033;5078.26365177051;5142.4600416956055;5167.2765812785865;5220.92168617471;1756.332593614431;1789.7404876292865;1797.272104797559;1832.1572076844668;1849.7965223825368;22525.662115068288;22706.432339191488;22744.77255227443;22750.54498910029;22760;6275.278342990523;6291.207006003267;6511.34886511345;6525.543211975116;6546.443552298108;15744.291506882219;15811.525654230392;15892.284847181905;16502;16513.587160320847;7441.144268409203;7684.193159718149;7689.577073260913;7693.653785579662;7704.730334438268;6946.37482626566;6980.895286570705;7001.29987001306;7203.171635261907;7207.855842883113;4906.632002599819;5143.17709166539;5144.511271429208;5146.536811686966;5188.8962220755375;1471.6394483351648;1483.3769816677022;1484.92575371231;1492.6641505661357;1501.2643804535917;870.6952566601639;892.9909202601019;904.5793705926776;915.455304094063;917.0920788419417;7111.715531378791;7149.142102947576;7243.384312333405;7298.306660867209;7309.391933774561;643.5012865029639;667.279338314619;669.9866002680017;988.2143695761887;1036.1658864613908;5215.24378965048;5225.686458812484;5255.3168088148295;5272.340957380327;5286.36563612369;19306.227750890088;19737.703934440993;19836.504087397643;19981.300654477312;19999.800002000084;19167.52081197953;19882.70175947362;19889.801101988796;19914.701279480818;20045;10724.839127413095;10762.784744305227;10804.729881753019;10806.94596527028;10944.23390362683;7446.776596702108;7956.363490920597;8451.577421129043;8461.953157758093;8530.872036919576;17146.228419720894;17219.569510762332;17258.482245532654;17387.130643467524;17956.820431796037;16929.91535042366;17708.645827083645;17996.190171442577;18202.817971820114;18252.269909204013;12836.935815321238;13111.344432778515;13132;13134.40895159701;13150.276734779296;13250.668733281746;13629.86370136286;13688.65778355549;13738.175709457464;13748.450061997408;10786.137109031415;10837.891621084003;10915.890841091488;10994.395308258123;11001.284916480403;10501.159907207253;10532.157427405942;10630.946845265724;10741.979511946352;10876.782464350827;9109.590068446803;9200.861987070066;9262.120098590623;9268.165865071906;9297.256219502287;7226.168990566152;7334.853302934018;7337.926620733938;7403.888941665771;7420.443466739908;7395.7041718330665;7417.072865891763;7472.327490525879;7486.513376630502;7540.057492813398 16:20:35 INFO - PID 4584 | |4;prototype.html;469.32885973058535;501.12553593978515;501.43087595579016;511.7569154651541;526.7892842862855;6231.6572588507615;6290.874182516352;6290.905636415452;6299.748010079591;6372.649504277263;5908.822735317947;6086.939130608693;6109.633421994683;6110.205673262481;6171.352008039158;4923.276853101422;4923.82766603169;4990.3762029746285;5000.4749501302385;5036.244563315496;4957.652964292501;4960.206366981283;4966.230234313669;4985.127602669537;4992.326035985132;4754.191787396151;4875.58557522611;4900.6569540132205;4903.352189817494;4976.303317535548;4897.6326775491625;4903.509649035103;4911.8772030699165;4922.70463772173;4981.999999999982;4425.336199570058;4467.374567560544;4468.173387923244;4475.172093162742;4523.886902827456;5998.520118390518;6062.393760623946;6081.847953801146;6082.1484992100695;6141.293751218623;5634.703698336478;5649.4633009864;5655.717214139277;5747.339056008529;5771.538276937835;6477.0568829351005;6510.511711621647;6545.149130613037;6584.868302633969;6613.93386066138;4853.272009198613;4858.46556878743;4860.222364421676;4880.316755654211;4883.926741098886;6795.082663840319;6846.863062738767;6888.690008949609;6902.24075351716;6967.825804354881;4955.628327875424;4958.603311735053;4982.551570358685;4987.276844857475;5056.064628043824;5083.87290317745;5084.567811736044;5088.643794934319;5088.872778180576;5129.538341549279;5580.888382232332;5617.43825617435;5738.167965644958;5747.568932330092;5762.4525670061275;6441.967790161019;6464.224293084766;6515.7719479818925;6571.3757193066585;6592.143021407186;1672.222416576298;1723.147042214112;1738.1917408405152;1742.6079132195407;1776.9378071767426;1192.677976946237;1217.3000524698157;1225.9701850445667;1227.3495047624594;1239.3679223596032;5705.971470142623;5719.370869204384;5764.855878602984;5770.567207459458;5778.422157784188;6523.445507131852;6545.672716364258;6659.633720145439;6659.767942930574;6684.766033188912;5767.68277744728;5784.219130417424;5794.159846822187;5819.272590926134;5841.1238314253205;3569.5359603251413;3599.6760291573883;3604.6034936157002;3610.6750392464805;3611.8081033258964;6598.73605055802;6648.401643852077;6649.202095748541;6669.366410191024;6692.933070669231;6952.443804495628;6963.1296087989;6999.685014174374;7068.858622827514;7069.82325441868;6477.931141361717;6479.222493300834;6585.242697089896;6586.6377349245295;6615.867682646224;6714.83212919681;6719.563228390139;6748.662566871735;6761.594304341756;6784.525083244125;6592.80221593353;6625.933740662532;6742.831429214309;6763.729450821912;6780.660966951731;6519.696060787766;6534.183227096613;6574.276829548841;6587.386090407881;6653.401193892573;4929.728864912321;4977.203647416396;4980.128477516492;5010.549050585465;5028.2960385546785;6790.388865002174;6824.488163387865;6850.8972365413565;6858.622775747382;6896.379325860697;6517.804465866032;6519.706613202323;6560.40956313934;6579.572327798678;6638.20341559016;6430.042180596978;6490.935090649033;6510.707018184098;6584.209894812653;6600.207975043026;6210.894552723638;6358.77744278948;6373.171487706754;6393.744250229939;6401.167848179707;6462.838429039311;6468;6548.8362790930605;6565.161754708689;6645.202575690948;6311.485243541425;6325.810225693236;6335.3981371769605;6341.49268058545;6424.550281480251 16:20:35 INFO - PID 4584 | |5;yui.html;905.2260317428603;906.7823722306646;917.3303488453424;932.1284598900029;933.7525555727733;19205.807941920575;20244.39266821994;20312.89843550784;20390.592188156246;20419;18112.728309075374;18121.546961325974;22809.657855132187;22945.655815162787;22978;1036.5801850250662;1064.3560645809291;1064.5688496159069;1064.6060957445718;1065.978680426391;1035.7824856780085;1058.1217589400817;1062.6121465665053;1062.9096526795192;1063.4363787192763;1119.7368618374676;1124.2860783402516;1127.5715228213267;1128.4470609401376;1128.9548418063268;1118.2619471149003;1122.78105769375;1122.960696375623;1124.173732306754;1124.6288724720905;815.571824791983;818.3248819723751;819.4837252530926;820.1101804542079;823.9093699693029;19422.611547768967;19492.12285447144;19585.80414195854;19880;21048.684269735968;22214.333569992927;22508.324750257518;22735.886320568457;22927.88536057326;22955.655665165035;17002.82997170025;17085.658286834318;17346.3061477542;17375.826241737548;17390.65218695619;3667.7065834733157;3681.4661874028116;3686.207465394953;3689.575698794646;3708.1285897814264;133506;133758;133822.3308883459;134050;135743.64256357407;16794.832051679572;17089.48731538056;17739.37912173068;17744.822551774316;17769;32517;32808.67191328056;33541.49687754686;33650;33653.495197572054;8828.8675669865;8901.421407608614;8913.108689131164;9124.49815260167;9290.767730806649;4120.587941205916;4207.852725154605;4224.852130175429;4242.087951090531;4248.553901840324;5473.9452605474235;5528.530074943595;5569.637973531708;5622.409646987089;5628.183913332544;1067.8077945969644;1085.5494969587692;1110.4669758515959;1110.8222684370462;1113.0316624536542;698.892255774603;700.9614471204133;728.4609389052064;732.2896790113581;734.988975165373;12175.330356830282;12787.232766034067;13183.604491865259;13328.133671311334;13422.932885335706;698.7100353353302;705.3299365602595;711.2176605733755;713.8429545499981;715.2775696546421;5683.147527870852;5683.232763576947;5735.283089613798;5831.4168583141345;5880.7353669085;105551;106063.46968265109;106983;107368;107912.46043769889;93957.53021234987;95575;96429;98780.99999999856;100053;83038.58480707557;83042.58478707568;86483;88232.11767882368;88684.11315886887;11615;11627.069834413058;11689.590864320047;11836.70408239801;11919.880801192225;36483.81758091193;36883.44674829826;37202;38480.23039539249;39456.80271598738;46861.76569117269;46963.53036469728;47320;47782.231863485664;48748.5125148744;19481.220751169796;19587.314443994394;19924.60150797005;20334.491637708583;20581.38255852327;21282.574348512633;21831.235906743186;22064;22073.227437039626;22515.88742056279;17634.382796602058;17722.822771772633;20126.29557965464;20155.193792248145;20641.793582064587;16898.493045208663;17259.3959211427;17276.395326163525;19240;19334.516637084187;19811.306604268782;19865.602687946448;20336;20391.4902127448;20656.690149647467;11176;12953.870461295266;14113.153210807384;14518.185226846645;14683;14643.92678036603;14659.340329685403;14769.704605908037;14793.630159246104;15109.848901511285 16:20:35 INFO - PID 4584 | __end_tp_report 16:20:35 INFO - PID 4584 | __start_cc_report 16:20:35 INFO - PID 4584 | _x_x_mozilla_cycle_collect,391 16:20:35 INFO - PID 4584 | __end_cc_report 16:20:35 INFO - PID 4584 | __startTimestamp1502234435833__endTimestamp 16:20:35 INFO - PID 4584 | 16:20:35 INFO - PID 4584 | ------- Summary: start ------- 16:20:35 INFO - PID 4584 | Number of tests: 6 16:20:35 INFO - PID 4584 | 16:20:35 INFO - PID 4584 | [#0] dojo.html Cycles:165 Average:6219.47 Median:6495.68 stddev:732.55 (11.3%) stddev-sans-first:695.00 16:20:35 INFO - PID 4584 | Values: 3183.3 3183.4 3205.7 3206.6 3237.9 6271.4 6311.4 6344.9 6388.8 6424.7 6157.4 6261.1 6268.9 6295.2 6316.0 5719.2 5728.1 5765.5 5769.1 5850.4 5786.4 5829.9 5862.0 5885.1 5895.6 5580.9 5752.1 5836.0 5847.5 5852.9 5741.3 5745.9 5758.8 5795.2 5823.9 5631.3 5680.9 5733.7 5768.3 5794.7 6122.9 6153.0 6193.6 6230.5 6299.1 6646.8 6692.3 6714.1 6715.7 6720.7 6764.3 6770.5 6773.6 6774.0 6775.2 6209.0 6275.7 6275.7 6277.4 6278.0 6900.8 7007.6 7009.2 7024.9 7025.7 6614.2 6614.4 6699.5 6701.4 6717.7 6634.9 6697.0 6713.8 6785.6 6825.4 6629.7 6650.6 6716.3 6722.8 6744.5 6744.2 6769.6 6789.1 6814.8 6835.1 5488.6 5546.2 5556.3 5564.6 5572.0 4574.8 4634.4 4670.3 4671.1 4690.5 5824.6 5834.5 5839.6 5844.2 5844.7 6769.0 6770.6 6770.8 6788.3 6797.4 5741.2 5762.8 5790.8 5800.4 5811.9 5933.1 6007.8 6055.7 6062.8 6076.5 6443.2 6536.7 6541.5 6605.3 6632.9 6746.2 6753.8 6762.7 6775.6 6781.1 6543.5 6551.5 6556.8 6562.2 6566.2 6618.4 6643.5 6646.6 6648.9 6678.3 6750.0 6802.5 6806.9 6877.2 6884.2 6541.0 6552.5 6555.6 6653.7 6653.7 6457.6 6546.3 6562.5 6613.0 6649.6 6493.2 6522.7 6559.0 6576.6 6603.0 6612.6 6622.0 6673.8 6713.1 6721.3 6312.8 6378.5 6390.7 6398.5 6495.7 16:20:35 INFO - PID 4584 | 16:20:35 INFO - PID 4584 | [#1] ext.html Cycles:180 Average:39281.96 Median:19102.67 stddev:57205.06 (299.5%) stddev-sans-first:57292.66 16:20:35 INFO - PID 4584 | Values: 825.7 866.6 882.1 890.9 1165.5 31830.7 32150.0 42138.2 42687.0 42909.4 42425.8 42833.6 43136.4 43232.6 43259.1 7827.2 7895.5 8027.0 8029.8 8087.7 7834.2 7896.6 7950.0 7951.0 7953.4 7946.6 7983.6 8002.1 8008.8 8013.7 7894.5 7946.1 7948.7 7950.1 7950.9 7833.6 7877.9 7891.5 7895.9 7900.2 39650.2 39664.6 39885.8 39914.4 40092.0 3572.7 3615.8 3620.6 3622.3 3629.1 32946.3 33059.5 33070.2 33095.0 33108.3 5097.8 5101.5 5128.4 5151.8 5166.4 197657.0 197782.0 197961.0 198766.0 199193.0 50373.5 50438.5 50455.5 50505.0 50574.5 52364.5 52695.5 52727.0 52821.7 52894.7 13772.1 13901.1 14687.5 15047.7 15054.5 12142.9 12349.2 12350.5 12365.8 12375.1 14635.6 14733.6 14829.7 14864.9 14984.6 5841.9 5965.8 5966.6 6025.5 6117.7 991.7 994.6 1000.6 1020.3 1029.9 22839.8 23014.0 23457.8 23632.3 23782.5 1095.8 1118.6 1124.5 1131.1 1145.5 12380.9 16585.8 16618.7 16651.3 17085.9 241487.0 243524.0 243974.0 244164.0 244312.0 58986.4 59390.4 59543.7 59683.0 59811.7 1447.6 1471.0 1488.5 1488.8 1508.2 27582.0 27821.0 27978.9 27991.3 28099.3 38796.0 38897.0 39072.2 39090.2 39099.0 216766.0 217046.0 217547.0 217940.0 218143.0 31792.8 32176.0 32292.2 32369.4 34632.7 38476.8 39218.8 40443.9 44887.8 45564.0 32043.2 32262.5 32280.2 32574.7 33062.7 32247.4 32249.4 32268.4 32300.5 32916.3 36511.0 36773.6 36779.4 36823.6 36840.3 31588.7 31636.2 31826.7 31926.7 32185.7 23236.9 23470.0 23560.9 23707.9 23831.4 16:20:35 INFO - PID 4584 | 16:20:35 INFO - PID 4584 | [#2] jquery.html Cycles:180 Average:35996.27 Median:13078.35 stddev:85953.05 (657.2%) stddev-sans-first:86153.05 16:20:35 INFO - PID 4584 | Values: 583.5 589.8 593.6 593.9 605.1 22247.0 22963.4 22971.3 22996.9 23306.3 26794.3 27284.0 27395.0 27436.5 27445.2 6578.6 6748.1 6753.0 6754.8 6757.3 6018.2 6570.6 6609.6 6610.9 6612.5 6563.1 6566.0 6570.9 6578.7 6585.4 6544.2 6551.5 6553.5 6569.0 6570.7 6144.2 6146.0 6151.4 6153.8 6157.0 29590.3 29981.2 30248.3 30669.4 31048.0 1896.3 1928.8 1935.2 1946.1 1948.4 18865.4 19481.4 19495.3 19533.6 19547.7 2374.7 2385.1 2411.7 2438.7 2490.0 137367.3 140206.0 140808.0 141085.0 141199.3 13794.3 14866.9 15155.9 15246.8 15827.9 23902.0 23939.5 23948.2 23966.1 23976.0 10076.3 10167.1 10179.2 10250.4 10357.6 7795.9 9265.4 9461.0 9496.2 9748.0 7914.8 9304.6 9309.8 9511.3 9596.8 2767.7 2809.6 2815.3 2840.9 2863.9 949.8 956.5 982.5 988.9 991.2 19954.2 20146.9 20190.0 20194.5 20504.7 1039.7 1042.5 1047.2 1059.2 1067.2 10976.3 11261.6 11268.5 11517.1 13356.7 484537.0 504644.0 507664.0 528059.0 528720.0 112881.4 115463.4 119542.4 121267.0 121323.4 1302.7 1324.1 1335.0 1340.2 1341.4 21518.7 21580.4 21591.7 21700.8 21722.6 58129.7 59792.7 60042.4 60089.0 61470.4 72884.0 73944.3 74641.6 74908.0 75961.6 12439.6 14344.6 14605.8 14938.9 15085.9 23782.0 23803.4 23872.0 23909.5 24031.0 18501.4 18924.1 18929.2 19047.1 19059.2 15922.4 17278.9 17516.9 18136.8 18298.7 19716.2 19739.2 19807.4 19823.0 20067.4 14677.9 14885.4 15039.1 15061.5 15081.6 18782.6 18900.4 18901.3 18943.9 18994.5 16:20:35 INFO - PID 4584 | 16:20:35 INFO - PID 4584 | [#3] mootools.html Cycles:180 Average:8843.23 Median:2548.88 stddev:6066.90 (238.0%) stddev-sans-first:6057.77 16:20:35 INFO - PID 4584 | Values: 1346.4 1400.4 1412.5 1414.1 1423.1 13586.9 14167.9 14170.7 14184.6 14185.8 13771.1 14667.2 14755.5 14759.0 14780.0 2592.0 2618.8 2626.9 2628.4 2631.9 2589.3 2611.8 2636.3 2667.5 2667.8 2541.3 2587.8 2614.4 2664.0 2668.1 2558.2 2582.2 2589.4 2593.3 2596.0 2499.1 2522.8 2522.9 2528.6 2556.5 13699.8 13967.9 13976.0 13986.2 14003.2 7536.2 7841.2 7878.7 7885.9 7899.2 4938.8 5078.3 5142.5 5167.3 5220.9 1756.3 1789.7 1797.3 1832.2 1849.8 22525.7 22706.4 22744.8 22750.5 22760.0 6275.3 6291.2 6511.3 6525.5 6546.4 15744.3 15811.5 15892.3 16502.0 16513.6 7441.1 7684.2 7689.6 7693.7 7704.7 6946.4 6980.9 7001.3 7203.2 7207.9 4906.6 5143.2 5144.5 5146.5 5188.9 1471.6 1483.4 1484.9 1492.7 1501.3 870.7 893.0 904.6 915.5 917.1 7111.7 7149.1 7243.4 7298.3 7309.4 643.5 667.3 670.0 988.2 1036.2 5215.2 5225.7 5255.3 5272.3 5286.4 19306.2 19737.7 19836.5 19981.3 19999.8 19167.5 19882.7 19889.8 19914.7 20045.0 10724.8 10762.8 10804.7 10806.9 10944.2 7446.8 7956.4 8451.6 8462.0 8530.9 17146.2 17219.6 17258.5 17387.1 17956.8 16929.9 17708.6 17996.2 18202.8 18252.3 12836.9 13111.3 13132.0 13134.4 13150.3 13250.7 13629.9 13688.7 13738.2 13748.5 10786.1 10837.9 10915.9 10994.4 11001.3 10501.2 10532.2 10630.9 10742.0 10876.8 9109.6 9200.9 9262.1 9268.2 9297.3 7226.2 7334.9 7337.9 7403.9 7420.4 7395.7 7417.1 7472.3 7486.5 7540.1 16:20:35 INFO - PID 4584 | 16:20:35 INFO - PID 4584 | [#4] prototype.html Cycles:180 Average:5515.14 Median:6098.29 stddev:1556.76 (25.5%) stddev-sans-first:1514.36 16:20:35 INFO - PID 4584 | Values: 469.3 501.1 501.4 511.8 526.8 6231.7 6290.9 6290.9 6299.7 6372.6 5908.8 6086.9 6109.6 6110.2 6171.4 4923.3 4923.8 4990.4 5000.5 5036.2 4957.7 4960.2 4966.2 4985.1 4992.3 4754.2 4875.6 4900.7 4903.4 4976.3 4897.6 4903.5 4911.9 4922.7 4982.0 4425.3 4467.4 4468.2 4475.2 4523.9 5998.5 6062.4 6081.8 6082.1 6141.3 5634.7 5649.5 5655.7 5747.3 5771.5 6477.1 6510.5 6545.1 6584.9 6613.9 4853.3 4858.5 4860.2 4880.3 4883.9 6795.1 6846.9 6888.7 6902.2 6967.8 4955.6 4958.6 4982.6 4987.3 5056.1 5083.9 5084.6 5088.6 5088.9 5129.5 5580.9 5617.4 5738.2 5747.6 5762.5 6442.0 6464.2 6515.8 6571.4 6592.1 1672.2 1723.1 1738.2 1742.6 1776.9 1192.7 1217.3 1226.0 1227.3 1239.4 5706.0 5719.4 5764.9 5770.6 5778.4 6523.4 6545.7 6659.6 6659.8 6684.8 5767.7 5784.2 5794.2 5819.3 5841.1 3569.5 3599.7 3604.6 3610.7 3611.8 6598.7 6648.4 6649.2 6669.4 6692.9 6952.4 6963.1 6999.7 7068.9 7069.8 6477.9 6479.2 6585.2 6586.6 6615.9 6714.8 6719.6 6748.7 6761.6 6784.5 6592.8 6625.9 6742.8 6763.7 6780.7 6519.7 6534.2 6574.3 6587.4 6653.4 4929.7 4977.2 4980.1 5010.5 5028.3 6790.4 6824.5 6850.9 6858.6 6896.4 6517.8 6519.7 6560.4 6579.6 6638.2 6430.0 6490.9 6510.7 6584.2 6600.2 6210.9 6358.8 6373.2 6393.7 6401.2 6462.8 6468.0 6548.8 6565.2 6645.2 6311.5 6325.8 6335.4 6341.5 6424.6 16:20:35 INFO - PID 4584 | 16:20:35 INFO - PID 4584 | [#5] yui.html Cycles:180 Average:23607.68 Median:20363.30 stddev:31782.91 (156.1%) stddev-sans-first:31826.35 16:20:35 INFO - PID 4584 | Values: 905.2 906.8 917.3 932.1 933.8 19205.8 20244.4 20312.9 20390.6 20419.0 18112.7 18121.5 22809.7 22945.7 22978.0 1036.6 1064.4 1064.6 1064.6 1066.0 1035.8 1058.1 1062.6 1062.9 1063.4 1119.7 1124.3 1127.6 1128.4 1129.0 1118.3 1122.8 1123.0 1124.2 1124.6 815.6 818.3 819.5 820.1 823.9 19422.6 19492.1 19585.8 19880.0 21048.7 22214.3 22508.3 22735.9 22927.9 22955.7 17002.8 17085.7 17346.3 17375.8 17390.7 3667.7 3681.5 3686.2 3689.6 3708.1 133506.0 133758.0 133822.3 134050.0 135743.6 16794.8 17089.5 17739.4 17744.8 17769.0 32517.0 32808.7 33541.5 33650.0 33653.5 8828.9 8901.4 8913.1 9124.5 9290.8 4120.6 4207.9 4224.9 4242.1 4248.6 5473.9 5528.5 5569.6 5622.4 5628.2 1067.8 1085.5 1110.5 1110.8 1113.0 698.9 701.0 728.5 732.3 735.0 12175.3 12787.2 13183.6 13328.1 13422.9 698.7 705.3 711.2 713.8 715.3 5683.1 5683.2 5735.3 5831.4 5880.7 105551.0 106063.5 106983.0 107368.0 107912.5 93957.5 95575.0 96429.0 98781.0 100053.0 83038.6 83042.6 86483.0 88232.1 88684.1 11615.0 11627.1 11689.6 11836.7 11919.9 36483.8 36883.4 37202.0 38480.2 39456.8 46861.8 46963.5 47320.0 47782.2 48748.5 19481.2 19587.3 19924.6 20334.5 20581.4 21282.6 21831.2 22064.0 22073.2 22515.9 17634.4 17722.8 20126.3 20155.2 20641.8 16898.5 17259.4 17276.4 19240.0 19334.5 19811.3 19865.6 20336.0 20391.5 20656.7 11176.0 12953.9 14113.2 14518.2 14683.0 14643.9 14659.3 14769.7 14793.6 15109.8 16:20:35 INFO - PID 4584 | -------- Summary: end -------- 16:20:35 INFO - PID 4584 | 16:20:36 INFO - TEST-INFO | 4584: exit 0 16:20:36 INFO - TEST-OK | dromaeo_css | took 1113527ms 16:20:36 INFO - TEST-START | kraken 16:20:36 INFO - Initialising browser for kraken test... 16:20:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43281/getInfo.html -profile /tmp/tmpPO3c70/profile 16:20:36 INFO - TEST-INFO | started process 4953 (/builds/slave/test/build/application/firefox/firefox http://localhost:43281/getInfo.html) 16:20:42 INFO - TEST-INFO | 4953: exit 0 16:20:42 INFO - Browser initialized. 16:20:42 INFO - Running cycle 1/1 for kraken test... 16:20:42 INFO - TEST-INFO | started process 5181 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPO3c70/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:20:43 INFO - PID 5181 | 16:20:43 INFO - PID 5181 | (/builds/slave/test/build/application/firefox/firefox:5236): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:20:43 INFO - PID 5181 | 16:20:53 INFO - PID 5181 | RSS: Main: 174043136 16:20:53 INFO - PID 5181 | 16:20:56 INFO - PID 5181 | Cycle 1(1): loaded http://localhost:43281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43281/tests/kraken/driver.html?testName=audio-beat-detection) 16:20:57 INFO - PID 5181 | RSS: Main: 179163136 16:20:57 INFO - PID 5181 | 16:21:00 INFO - PID 5181 | Cycle 1(1): loaded http://localhost:43281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43281/tests/kraken/driver.html?testName=audio-dft) 16:21:00 INFO - PID 5181 | RSS: Main: 179458048 16:21:00 INFO - PID 5181 | 16:21:03 INFO - PID 5181 | Cycle 1(1): loaded http://localhost:43281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43281/tests/kraken/driver.html?testName=audio-fft) 16:21:04 INFO - PID 5181 | RSS: Main: 174645248 16:21:04 INFO - PID 5181 | 16:21:06 INFO - PID 5181 | Cycle 1(1): loaded http://localhost:43281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43281/tests/kraken/driver.html?testName=audio-oscillator) 16:21:07 INFO - PID 5181 | RSS: Main: 174915584 16:21:07 INFO - PID 5181 | 16:21:09 INFO - PID 5181 | Cycle 1(1): loaded http://localhost:43281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:21:10 INFO - PID 5181 | RSS: Main: 175120384 16:21:10 INFO - PID 5181 | 16:21:13 INFO - PID 5181 | Cycle 1(1): loaded http://localhost:43281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43281/tests/kraken/driver.html?testName=imaging-darkroom) 16:21:13 INFO - PID 5181 | RSS: Main: 177721344 16:21:13 INFO - PID 5181 | 16:21:17 INFO - PID 5181 | Cycle 1(1): loaded http://localhost:43281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43281/tests/kraken/driver.html?testName=imaging-desaturate) 16:21:17 INFO - PID 5181 | RSS: Main: 177352704 16:21:17 INFO - PID 5181 | 16:21:20 INFO - PID 5181 | Cycle 1(1): loaded http://localhost:43281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43281/tests/kraken/driver.html?testName=json-parse-financial) 16:21:21 INFO - PID 5181 | RSS: Main: 177987584 16:21:21 INFO - PID 5181 | 16:21:23 INFO - PID 5181 | Cycle 1(1): loaded http://localhost:43281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:21:23 INFO - PID 5181 | RSS: Main: 177782784 16:21:23 INFO - PID 5181 | 16:21:25 INFO - PID 5181 | Cycle 1(1): loaded http://localhost:43281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43281/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:21:26 INFO - PID 5181 | RSS: Main: 175161344 16:21:26 INFO - PID 5181 | 16:21:28 INFO - PID 5181 | Cycle 1(1): loaded http://localhost:43281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:21:29 INFO - PID 5181 | RSS: Main: 175542272 16:21:29 INFO - PID 5181 | 16:21:32 INFO - PID 5181 | Cycle 1(1): loaded http://localhost:43281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:21:32 INFO - PID 5181 | RSS: Main: 175763456 16:21:32 INFO - PID 5181 | 16:21:35 INFO - PID 5181 | Cycle 1(1): loaded http://localhost:43281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:21:36 INFO - PID 5181 | RSS: Main: 175468544 16:21:36 INFO - PID 5181 | 16:21:38 INFO - PID 5181 | Cycle 1(1): loaded http://localhost:43281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43281/tests/kraken/driver.html?testName=ai-astar) 16:21:38 INFO - PID 5181 | RSS: Main: 177156096 16:21:38 INFO - PID 5181 | 16:21:38 INFO - PID 5181 | __start_tp_report 16:21:38 INFO - PID 5181 | _x_x_mozilla_page_load 16:21:38 INFO - PID 5181 | _x_x_mozilla_page_load_details 16:21:38 INFO - PID 5181 | |i|pagename|runs| 16:21:38 INFO - PID 5181 | |0;ai-astar;104;109;95;108;113;107;110;107;115;111 16:21:38 INFO - PID 5181 | |1;audio-beat-detection;149;120;146;176;117;153;141;117;177;117 16:21:38 INFO - PID 5181 | |2;audio-dft;162;163;163;164;166;162;177;170;161;165 16:21:38 INFO - PID 5181 | |3;audio-fft;74;74;75;165;81;74;91;88;98;74 16:21:38 INFO - PID 5181 | |4;audio-oscillator;78;82;133;78;79;78;126;83;78;134 16:21:38 INFO - PID 5181 | |5;imaging-gaussian-blur;114;114;114;120;117;114;114;114;117;119 16:21:38 INFO - PID 5181 | |6;imaging-darkroom;152;151;150;151;151;155;151;152;155;151 16:21:38 INFO - PID 5181 | |7;imaging-desaturate;94;93;97;93;95;94;94;98;98;94 16:21:38 INFO - PID 5181 | |8;json-parse-financial;55;54;54;58;54;57;59;54;57;54 16:21:38 INFO - PID 5181 | |9;json-stringify-tinderbox;55;54;54;53;55;53;54;54;53;53 16:21:38 INFO - PID 5181 | |10;stanford-crypto-aes;80;78;78;88;102;78;78;79;96;77 16:21:38 INFO - PID 5181 | |11;stanford-crypto-ccm;129;128;145;148;135;125;129;144;144;169 16:21:38 INFO - PID 5181 | |12;stanford-crypto-pbkdf2;190;184;173;176;184;177;171;188;174;171 16:21:38 INFO - PID 5181 | |13;stanford-crypto-sha256-iterative;69;68;73;70;70;72;68;68;68;67 16:21:38 INFO - PID 5181 | __end_tp_report 16:21:38 INFO - PID 5181 | __start_cc_report 16:21:38 INFO - PID 5181 | _x_x_mozilla_cycle_collect,941 16:21:38 INFO - PID 5181 | __end_cc_report 16:21:38 INFO - PID 5181 | __startTimestamp1502234498691__endTimestamp 16:21:38 INFO - PID 5181 | 16:21:38 INFO - PID 5181 | ------- Summary: start ------- 16:21:38 INFO - PID 5181 | Number of tests: 14 16:21:38 INFO - PID 5181 | 16:21:38 INFO - PID 5181 | [#0] ai-astar Cycles:10 Average:107.90 Median:110.50 stddev:5.53 (5.0%) stddev-sans-first:5.68 16:21:38 INFO - PID 5181 | Values: 104.0 109.0 95.0 108.0 113.0 107.0 110.0 107.0 115.0 111.0 16:21:38 INFO - PID 5181 | 16:21:38 INFO - PID 5181 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:147.50 stddev:23.39 (15.9%) stddev-sans-first:24.64 16:21:38 INFO - PID 5181 | Values: 149.0 120.0 146.0 176.0 117.0 153.0 141.0 117.0 177.0 117.0 16:21:38 INFO - PID 5181 | 16:21:38 INFO - PID 5181 | [#2] audio-dft Cycles:10 Average:165.30 Median:164.50 stddev:4.85 (3.0%) stddev-sans-first:5.00 16:21:38 INFO - PID 5181 | Values: 162.0 163.0 163.0 164.0 166.0 162.0 177.0 170.0 161.0 165.0 16:21:38 INFO - PID 5181 | 16:21:38 INFO - PID 5181 | [#3] audio-fft Cycles:10 Average:89.40 Median:78.00 stddev:27.93 (35.8%) stddev-sans-first:29.06 16:21:38 INFO - PID 5181 | Values: 74.0 74.0 75.0 165.0 81.0 74.0 91.0 88.0 98.0 74.0 16:21:38 INFO - PID 5181 | 16:21:38 INFO - PID 5181 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:78.00 stddev:25.06 (32.1%) stddev-sans-first:25.82 16:21:38 INFO - PID 5181 | Values: 78.0 82.0 133.0 78.0 79.0 78.0 126.0 83.0 78.0 134.0 16:21:38 INFO - PID 5181 | 16:21:38 INFO - PID 5181 | [#5] imaging-gaussian-blur Cycles:10 Average:115.70 Median:115.50 stddev:2.36 (2.0%) stddev-sans-first:2.42 16:21:38 INFO - PID 5181 | Values: 114.0 114.0 114.0 120.0 117.0 114.0 114.0 114.0 117.0 119.0 16:21:38 INFO - PID 5181 | 16:21:38 INFO - PID 5181 | [#6] imaging-darkroom Cycles:10 Average:151.90 Median:151.50 stddev:1.73 (1.1%) stddev-sans-first:1.83 16:21:38 INFO - PID 5181 | Values: 152.0 151.0 150.0 151.0 151.0 155.0 151.0 152.0 155.0 151.0 16:21:38 INFO - PID 5181 | 16:21:38 INFO - PID 5181 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:94.50 stddev:1.94 (2.1%) stddev-sans-first:2.03 16:21:38 INFO - PID 5181 | Values: 94.0 93.0 97.0 93.0 95.0 94.0 94.0 98.0 98.0 94.0 16:21:38 INFO - PID 5181 | 16:21:38 INFO - PID 5181 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.96 (3.5%) stddev-sans-first:2.06 16:21:38 INFO - PID 5181 | Values: 55.0 54.0 54.0 58.0 54.0 57.0 59.0 54.0 57.0 54.0 16:21:38 INFO - PID 5181 | 16:21:38 INFO - PID 5181 | [#9] json-stringify-tinderbox Cycles:10 Average:53.80 Median:54.00 stddev:0.79 (1.5%) stddev-sans-first:0.71 16:21:38 INFO - PID 5181 | Values: 55.0 54.0 54.0 53.0 55.0 53.0 54.0 54.0 53.0 53.0 16:21:38 INFO - PID 5181 | 16:21:38 INFO - PID 5181 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:78.50 stddev:8.91 (11.3%) stddev-sans-first:9.36 16:21:38 INFO - PID 5181 | Values: 80.0 78.0 78.0 88.0 102.0 78.0 78.0 79.0 96.0 77.0 16:21:38 INFO - PID 5181 | 16:21:38 INFO - PID 5181 | [#11] stanford-crypto-ccm Cycles:10 Average:139.60 Median:144.00 stddev:13.32 (9.2%) stddev-sans-first:13.56 16:21:38 INFO - PID 5181 | Values: 129.0 128.0 145.0 148.0 135.0 125.0 129.0 144.0 144.0 169.0 16:21:38 INFO - PID 5181 | 16:21:38 INFO - PID 5181 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.80 Median:180.50 stddev:7.10 (3.9%) stddev-sans-first:6.27 16:21:38 INFO - PID 5181 | Values: 190.0 184.0 173.0 176.0 184.0 177.0 171.0 188.0 174.0 171.0 16:21:38 INFO - PID 5181 | 16:21:38 INFO - PID 5181 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:1.95 (2.8%) stddev-sans-first:2.06 16:21:38 INFO - PID 5181 | Values: 69.0 68.0 73.0 70.0 70.0 72.0 68.0 68.0 68.0 67.0 16:21:38 INFO - PID 5181 | -------- Summary: end -------- 16:21:38 INFO - PID 5181 | 16:21:39 INFO - PID 5181 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:21:39 INFO - TEST-INFO | 5181: exit 0 16:21:39 INFO - TEST-OK | kraken | took 62885ms 16:21:39 INFO - SUITE-END | took 1176s 16:21:39 INFO - Completed test suite (00:19:36) 16:21:39 INFO - javascript benchmark 16:21:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8606.130257214782, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3183.3474137801745, 3183.395154920565, 3205.6634053424395, 3206.5510828484003, 3237.8866739664118, 6271.404216599427, 6311.431971122598, 6344.873102537952, 6388.808335749929, 6424.743010279595, 6157.353477884825, 6261.123442718023, 6268.905966410507, 6295.15015472911, 6316.0, 5719.199312096289, 5728.112142617891, 5765.538756899459, 5769.1346298055205, 5850.385709500505, 5786.392428794979, 5829.8834023319505, 5861.970690146543, 5885.058390657496, 5895.616784908989, 5580.888382232373, 5752.137179423099, 5835.970820145893, 5847.473727364536, 5852.912206316909, 5741.311042674905, 5745.942540574582, 5758.79844205455, 5795.2176456178295, 5823.88352232953, 5631.2960879890015, 5680.8863822723315, 5733.713314334308, 5768.250127483442, 5794.68129252891, 6122.8775424491705, 6152.969235153795, 6193.628382297032, 6230.470410015154, 6299.0866324382705, 6646.833829154261, 6692.297308782557, 6714.127163468766, 6715.731370745164, 6720.731170753164, 6764.289749576322, 6770.458363330971, 6773.559718618323, 6773.983902414628, 6775.22084960226, 6209.0, 6275.7175927082935, 6275.717592708339, 6277.435030847246, 6277.968610156966, 6900.7929762107215, 7007.614581197981, 7009.193942696553, 7024.929750702529, 7025.7189712411955, 6614.239362473281, 6614.404703576702, 6699.5310328276555, 6701.363370479797, 6717.6977036033495, 6634.933650663528, 6697.028930805006, 6713.798586042427, 6785.592864428051, 6825.385715285648, 6629.668516574152, 6650.634215118215, 6716.261211266757, 6722.764703235461, 6744.5278830482375, 6744.156980377453, 6769.559978601375, 6789.117414736152, 6814.761483348059, 6835.14560679915, 5488.588355873326, 5546.168074788814, 5556.305461817273, 5564.638298510584, 5572.0, 4574.83988060423, 4634.351190833286, 4670.276107203389, 4671.0891376182, 4690.507496712864, 5824.5631577631, 5834.474897259267, 5839.620424672383, 5844.1818145459665, 5844.707764611752, 6769.018492318586, 6770.5599136056, 6770.796876093725, 6788.287229840796, 6797.388235058769, 5741.19623252745, 5762.827115186551, 5790.826275211751, 5800.419958004166, 5811.854703632358, 5933.110033495011, 6007.759689612367, 6055.697215139226, 6062.787802426894, 6076.453119219292, 6443.162388889508, 6536.673166341664, 6541.47668186544, 6605.273419923805, 6632.9336706633285, 6746.224184218681, 6753.831154221184, 6762.661866906733, 6775.559588626724, 6781.050652908695, 6543.5419520633095, 6551.50863685216, 6556.8360790980605, 6562.245341785756, 6566.244881838458, 6618.404343609098, 6643.534952553468, 6646.634435106115, 6648.933510665025, 6678.265390806911, 6750.0, 6802.523823332319, 6806.8638627228165, 6877.1747390313485, 6884.173899131936, 6541.0, 6552.508561857784, 6555.6066636002, 6653.700583473852, 6653.73385064592, 6457.61254324742, 6546.279909209888, 6562.475001999733, 6612.966935165294, 6649.63427011519, 6493.155889734304, 6522.673866306571, 6558.967205163944, 6576.605403675795, 6603.0, 6612.636305003271, 6622.0, 6673.833154171185, 6713.093732346071, 6721.260661327348, 6312.779052733316, 6378.48972082223, 6390.712417941297, 6398.456131228898, 6495.675216239264], "value": 6164.56044040266, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [825.7398919340408, 866.579708841212, 882.122288323119, 890.8975467821202, 1165.4930105404144, 31830.68169318309, 32150.0, 42138.157236855244, 42687.0, 42909.35635965463, 42425.7878710606, 42833.57166428335, 43136.352954705704, 43232.56767432325, 43259.13481730371, 7827.178146294643, 7895.526268423899, 8027.0, 8029.759107226763, 8087.676492940275, 7834.177411371809, 7896.565688887137, 7950.045994480671, 7950.960245198766, 7953.363730901514, 7946.562939038351, 7983.560904150269, 8002.0797608274925, 8008.799780005517, 8013.679452821909, 7894.4868583542175, 7946.086200086977, 7948.721794737156, 7950.0857401399, 7950.920490795076, 7833.569153696544, 7877.921220787834, 7891.487053341514, 7895.881561776578, 7900.209979002111, 39650.20699586021, 39664.60335396638, 39885.80057099725, 39914.40128398076, 40092.0, 3572.696320812734, 3615.783053016801, 3620.601733809279, 3622.3117607654463, 3629.0927268182954, 32946.3410731784, 33059.504107438406, 33070.17324566905, 33095.0, 33108.3378332432, 5097.770600322994, 5101.464346243628, 5128.435872054071, 5151.793928242866, 5166.354205724285, 197657.0, 197782.0, 197961.0, 198766.0, 199193.0, 50373.49626503761, 50438.495615044114, 50455.49544504582, 50504.979800808294, 50574.49425505772, 52364.47635523672, 52695.47304526982, 52727.0, 52821.73589132106, 52894.73552632289, 13772.10481318731, 13901.0964287321, 14687.485937992118, 15047.699046019019, 15054.548363549111, 12142.878571214174, 12349.19730217533, 12350.505979760708, 12365.814512782315, 12375.071869609816, 14635.560933172022, 14733.631659208606, 14829.703405932038, 14864.925675371554, 14984.62538436526, 5841.853953651108, 5965.791197308074, 5966.642001479925, 6025.4577088061405, 6117.724702388403, 991.6578780320777, 994.5777538120557, 1000.5797565022708, 1020.3265844542566, 1029.902159294866, 22839.771602284098, 23014.0, 23457.765422345557, 23632.29103126909, 23782.465917006804, 1095.8191898336845, 1118.5637601335486, 1124.5333186727416, 1131.0725205331548, 1145.4959817680194, 12380.938095309466, 16585.83414165867, 16618.6676266474, 16651.33394664224, 17085.914570427067, 241487.0, 243524.0, 243974.0, 244164.0, 244312.0, 58986.41013589809, 59390.406095939354, 59543.70228148918, 59683.0, 59811.70094149588, 1447.6308541322105, 1470.9999999999786, 1488.4641529049534, 1488.7692407676827, 1508.2157278215266, 27582.034628787897, 27821.0, 27978.860105699343, 27991.300217494725, 28099.297517562223, 38796.0, 38897.0, 39072.2185556293, 39090.21819563536, 39099.0, 216766.0, 217046.0, 217547.0, 217940.0, 218143.0, 31792.841035794674, 32176.0, 32292.192695181868, 32369.35261294808, 34632.65367346395, 38476.80761596174, 39218.80390598029, 40443.85590148537, 44887.77556112198, 45564.0, 32043.198920026254, 32262.516062259554, 32280.19299517437, 32574.674253258112, 33062.66937330596, 32247.35505289928, 32249.35501290008, 32268.35463290768, 32300.515492267165, 32916.341673166884, 36511.0, 36773.63226367809, 36779.44830827593, 36823.63176368202, 36840.26319473542, 31588.684113158575, 31636.209094772814, 31826.681733182373, 31926.68073319237, 32185.67814321827, 23236.883815580815, 23470.0, 23560.88219558891, 23707.881460592587, 23831.404214894766], "value": 17688.16654253906, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.4777873802943, 589.8024161905761, 593.6052525070828, 593.9287285525737, 605.1316361021934, 22246.998885050172, 22963.42591435213, 22971.310860674166, 22996.88501557492, 23306.300810975656, 26794.330141746417, 27284.04505842291, 27395.0, 27436.490992995376, 27445.17664470064, 6578.572392794465, 6748.055272261888, 6753.02081198226, 6754.763583274586, 6757.324267573228, 6018.15745795589, 6570.605763654172, 6609.570377925444, 6610.933890661104, 6612.537122401433, 6563.081168636395, 6566.0, 6570.8685826283445, 6578.736850525997, 6585.407313341822, 6544.181977252843, 6551.508636852232, 6553.508486863504, 6568.967155164218, 6570.737170513174, 6144.201253837017, 6145.969270153665, 6151.415615516519, 6153.846153846145, 6156.96921515394, 29590.260243494085, 29981.201127932392, 30248.33634150121, 30669.386612267852, 31048.0, 1896.2794138227384, 1928.8360489358422, 1935.2162374238455, 1946.1047917957756, 1948.3765195137562, 18865.434036978775, 19481.415557533295, 19495.317663881695, 19533.609327813505, 19547.706784398102, 2374.691290132289, 2385.0817435287368, 2411.6503107049557, 2438.6829712137487, 2489.95020099597, 137367.31316343453, 140206.0, 140808.0, 141085.0, 141199.29400352933, 13794.310284485735, 14866.925665371604, 15155.924220379047, 15246.847531524765, 15827.920860395854, 23902.0, 23939.521209575712, 23948.161814336414, 23966.082713382886, 23976.0, 10076.345037572535, 10167.084962353423, 10179.18566514677, 10250.384976901261, 10357.585696572203, 7795.922040779633, 9265.397749146285, 9461.0, 9496.240300775922, 9747.951260243653, 7914.76255712318, 9304.581293841793, 9309.767255818659, 9511.33420660561, 9596.808063838684, 2767.681716602576, 2809.5504719244823, 2815.3102489890107, 2840.9147725568264, 2863.914082577526, 949.7910459698855, 956.4500412262977, 982.4891056650501, 988.9159421449114, 991.177322822056, 19954.20183192685, 20146.89926550387, 20190.0, 20194.495137621678, 20504.69242961357, 1039.745262410699, 1042.5412818360048, 1047.2355180718118, 1059.163261023798, 1067.2102644043352, 10976.286541374786, 11261.605843795427, 11268.54925802975, 11517.078633709283, 13356.732865342834, 484537.0, 504644.0, 507664.0, 528059.0, 528720.0, 112881.43559282315, 115463.42268288604, 119542.402287988, 121267.0, 121323.39338303253, 1302.7199152182327, 1324.0533018891538, 1334.9532766353132, 1340.222670850904, 1341.4298922957703, 21518.6772198414, 21580.352589422342, 21591.676124858455, 21700.78299217051, 21722.565548689254, 58129.709351454665, 59792.70103649454, 60042.39957600368, 60089.0, 61470.385296146465, 72884.0, 73944.26055739373, 74641.6267918657, 74908.0, 75961.6201919009, 12439.569449513421, 14344.56966291013, 14605.780913286097, 14938.925305373403, 15085.924570377078, 23782.0, 23803.40491487727, 23872.0, 23909.52180956406, 24031.0, 18501.44495665132, 18924.14841332116, 18929.242830286636, 19047.14287857022, 19059.237630494627, 15922.442714504938, 17278.913605432394, 17516.91241543784, 18136.81863181404, 18298.72551911749, 19716.21135154578, 19739.210431582575, 19807.405777826687, 19823.0, 20067.397978060682, 14677.92661036688, 14885.404583816526, 15039.097654140787, 15061.548153555412, 15081.622959426102, 18782.624347513247, 18900.432987010412, 18901.338453154072, 18943.90528047351, 18994.525136871136], "value": 12290.078233246646, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.42103895325, 1400.3838311143097, 1412.5056230319387, 1414.0667159674617, 1423.0678905317016, 13586.864131358683, 14167.92916035421, 14170.71658566828, 14184.574462766108, 14185.78721319181, 13771.10487818291, 14667.193304368255, 14755.48355807547, 14759.0, 14780.0, 2591.9740802592014, 2618.7904967602544, 2626.9474610507777, 2628.4217472156097, 2631.8552479613613, 2589.262060312811, 2611.804114691396, 2636.3145582148586, 2667.493176296507, 2667.826591271571, 2541.2884392370165, 2587.8447293162376, 2614.4248265381584, 2663.960040599383, 2668.106184428219, 2558.2325302409295, 2582.18661121747, 2589.4432696970243, 2593.2738833126564, 2596.026490066225, 2499.125306142854, 2522.836015658976, 2522.8612426316545, 2528.5954247320524, 2556.463142740027, 13699.794503082361, 13967.930160349235, 13976.0, 13986.230757308344, 14003.229822359766, 7536.246375362474, 7841.21587841217, 7878.72424465141, 7885.881711774328, 7899.249571290776, 4938.777755001033, 5078.26365177051, 5142.4600416956055, 5167.2765812785865, 5220.92168617471, 1756.332593614431, 1789.7404876292865, 1797.272104797559, 1832.1572076844668, 1849.7965223825368, 22525.662115068288, 22706.432339191488, 22744.77255227443, 22750.54498910029, 22760.0, 6275.278342990523, 6291.207006003267, 6511.34886511345, 6525.543211975116, 6546.443552298108, 15744.291506882219, 15811.525654230392, 15892.284847181905, 16502.0, 16513.587160320847, 7441.144268409203, 7684.193159718149, 7689.577073260913, 7693.653785579662, 7704.730334438268, 6946.37482626566, 6980.895286570705, 7001.29987001306, 7203.171635261907, 7207.855842883113, 4906.632002599819, 5143.17709166539, 5144.511271429208, 5146.536811686966, 5188.8962220755375, 1471.6394483351648, 1483.3769816677022, 1484.92575371231, 1492.6641505661357, 1501.2643804535917, 870.6952566601639, 892.9909202601019, 904.5793705926776, 915.455304094063, 917.0920788419417, 7111.715531378791, 7149.142102947576, 7243.384312333405, 7298.306660867209, 7309.391933774561, 643.5012865029639, 667.279338314619, 669.9866002680017, 988.2143695761887, 1036.1658864613908, 5215.24378965048, 5225.686458812484, 5255.3168088148295, 5272.340957380327, 5286.36563612369, 19306.227750890088, 19737.703934440993, 19836.504087397643, 19981.300654477312, 19999.800002000084, 19167.52081197953, 19882.70175947362, 19889.801101988796, 19914.701279480818, 20045.0, 10724.839127413095, 10762.784744305227, 10804.729881753019, 10806.94596527028, 10944.23390362683, 7446.776596702108, 7956.363490920597, 8451.577421129043, 8461.953157758093, 8530.872036919576, 17146.228419720894, 17219.569510762332, 17258.482245532654, 17387.130643467524, 17956.820431796037, 16929.91535042366, 17708.645827083645, 17996.190171442577, 18202.817971820114, 18252.269909204013, 12836.935815321238, 13111.344432778515, 13132.0, 13134.40895159701, 13150.276734779296, 13250.668733281746, 13629.86370136286, 13688.65778355549, 13738.175709457464, 13748.450061997408, 10786.137109031415, 10837.891621084003, 10915.890841091488, 10994.395308258123, 11001.284916480403, 10501.159907207253, 10532.157427405942, 10630.946845265724, 10741.979511946352, 10876.782464350827, 9109.590068446803, 9200.861987070066, 9262.120098590623, 9268.165865071906, 9297.256219502287, 7226.168990566152, 7334.853302934018, 7337.926620733938, 7403.888941665771, 7420.443466739908, 7395.7041718330665, 7417.072865891763, 7472.327490525879, 7486.513376630502, 7540.057492813398], "value": 6390.834971289083, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [469.32885973058535, 501.12553593978515, 501.43087595579016, 511.7569154651541, 526.7892842862855, 6231.6572588507615, 6290.874182516352, 6290.905636415452, 6299.748010079591, 6372.649504277263, 5908.822735317947, 6086.939130608693, 6109.633421994683, 6110.205673262481, 6171.352008039158, 4923.276853101422, 4923.82766603169, 4990.3762029746285, 5000.4749501302385, 5036.244563315496, 4957.652964292501, 4960.206366981283, 4966.230234313669, 4985.127602669537, 4992.326035985132, 4754.191787396151, 4875.58557522611, 4900.6569540132205, 4903.352189817494, 4976.303317535548, 4897.6326775491625, 4903.509649035103, 4911.8772030699165, 4922.70463772173, 4981.999999999982, 4425.336199570058, 4467.374567560544, 4468.173387923244, 4475.172093162742, 4523.886902827456, 5998.520118390518, 6062.393760623946, 6081.847953801146, 6082.1484992100695, 6141.293751218623, 5634.703698336478, 5649.4633009864, 5655.717214139277, 5747.339056008529, 5771.538276937835, 6477.0568829351005, 6510.511711621647, 6545.149130613037, 6584.868302633969, 6613.93386066138, 4853.272009198613, 4858.46556878743, 4860.222364421676, 4880.316755654211, 4883.926741098886, 6795.082663840319, 6846.863062738767, 6888.690008949609, 6902.24075351716, 6967.825804354881, 4955.628327875424, 4958.603311735053, 4982.551570358685, 4987.276844857475, 5056.064628043824, 5083.87290317745, 5084.567811736044, 5088.643794934319, 5088.872778180576, 5129.538341549279, 5580.888382232332, 5617.43825617435, 5738.167965644958, 5747.568932330092, 5762.4525670061275, 6441.967790161019, 6464.224293084766, 6515.7719479818925, 6571.3757193066585, 6592.143021407186, 1672.222416576298, 1723.147042214112, 1738.1917408405152, 1742.6079132195407, 1776.9378071767426, 1192.677976946237, 1217.3000524698157, 1225.9701850445667, 1227.3495047624594, 1239.3679223596032, 5705.971470142623, 5719.370869204384, 5764.855878602984, 5770.567207459458, 5778.422157784188, 6523.445507131852, 6545.672716364258, 6659.633720145439, 6659.767942930574, 6684.766033188912, 5767.68277744728, 5784.219130417424, 5794.159846822187, 5819.272590926134, 5841.1238314253205, 3569.5359603251413, 3599.6760291573883, 3604.6034936157002, 3610.6750392464805, 3611.8081033258964, 6598.73605055802, 6648.401643852077, 6649.202095748541, 6669.366410191024, 6692.933070669231, 6952.443804495628, 6963.1296087989, 6999.685014174374, 7068.858622827514, 7069.82325441868, 6477.931141361717, 6479.222493300834, 6585.242697089896, 6586.6377349245295, 6615.867682646224, 6714.83212919681, 6719.563228390139, 6748.662566871735, 6761.594304341756, 6784.525083244125, 6592.80221593353, 6625.933740662532, 6742.831429214309, 6763.729450821912, 6780.660966951731, 6519.696060787766, 6534.183227096613, 6574.276829548841, 6587.386090407881, 6653.401193892573, 4929.728864912321, 4977.203647416396, 4980.128477516492, 5010.549050585465, 5028.2960385546785, 6790.388865002174, 6824.488163387865, 6850.8972365413565, 6858.622775747382, 6896.379325860697, 6517.804465866032, 6519.706613202323, 6560.40956313934, 6579.572327798678, 6638.20341559016, 6430.042180596978, 6490.935090649033, 6510.707018184098, 6584.209894812653, 6600.207975043026, 6210.894552723638, 6358.77744278948, 6373.171487706754, 6393.744250229939, 6401.167848179707, 6462.838429039311, 6468.0, 6548.8362790930605, 6565.161754708689, 6645.202575690948, 6311.485243541425, 6325.810225693236, 6335.3981371769605, 6341.49268058545, 6424.550281480251], "value": 5053.906471992865, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [905.2260317428603, 906.7823722306646, 917.3303488453424, 932.1284598900029, 933.7525555727733, 19205.807941920575, 20244.39266821994, 20312.89843550784, 20390.592188156246, 20419.0, 18112.728309075374, 18121.546961325974, 22809.657855132187, 22945.655815162787, 22978.0, 1036.5801850250662, 1064.3560645809291, 1064.5688496159069, 1064.6060957445718, 1065.978680426391, 1035.7824856780085, 1058.1217589400817, 1062.6121465665053, 1062.9096526795192, 1063.4363787192763, 1119.7368618374676, 1124.2860783402516, 1127.5715228213267, 1128.4470609401376, 1128.9548418063268, 1118.2619471149003, 1122.78105769375, 1122.960696375623, 1124.173732306754, 1124.6288724720905, 815.571824791983, 818.3248819723751, 819.4837252530926, 820.1101804542079, 823.9093699693029, 19422.611547768967, 19492.12285447144, 19585.80414195854, 19880.0, 21048.684269735968, 22214.333569992927, 22508.324750257518, 22735.886320568457, 22927.88536057326, 22955.655665165035, 17002.82997170025, 17085.658286834318, 17346.3061477542, 17375.826241737548, 17390.65218695619, 3667.7065834733157, 3681.4661874028116, 3686.207465394953, 3689.575698794646, 3708.1285897814264, 133506.0, 133758.0, 133822.3308883459, 134050.0, 135743.64256357407, 16794.832051679572, 17089.48731538056, 17739.37912173068, 17744.822551774316, 17769.0, 32517.0, 32808.67191328056, 33541.49687754686, 33650.0, 33653.495197572054, 8828.8675669865, 8901.421407608614, 8913.108689131164, 9124.49815260167, 9290.767730806649, 4120.587941205916, 4207.852725154605, 4224.852130175429, 4242.087951090531, 4248.553901840324, 5473.9452605474235, 5528.530074943595, 5569.637973531708, 5622.409646987089, 5628.183913332544, 1067.8077945969644, 1085.5494969587692, 1110.4669758515959, 1110.8222684370462, 1113.0316624536542, 698.892255774603, 700.9614471204133, 728.4609389052064, 732.2896790113581, 734.988975165373, 12175.330356830282, 12787.232766034067, 13183.604491865259, 13328.133671311334, 13422.932885335706, 698.7100353353302, 705.3299365602595, 711.2176605733755, 713.8429545499981, 715.2775696546421, 5683.147527870852, 5683.232763576947, 5735.283089613798, 5831.4168583141345, 5880.7353669085, 105551.0, 106063.46968265109, 106983.0, 107368.0, 107912.46043769889, 93957.53021234987, 95575.0, 96429.0, 98780.99999999856, 100053.0, 83038.58480707557, 83042.58478707568, 86483.0, 88232.11767882368, 88684.11315886887, 11615.0, 11627.069834413058, 11689.590864320047, 11836.70408239801, 11919.880801192225, 36483.81758091193, 36883.44674829826, 37202.0, 38480.23039539249, 39456.80271598738, 46861.76569117269, 46963.53036469728, 47320.0, 47782.231863485664, 48748.5125148744, 19481.220751169796, 19587.314443994394, 19924.60150797005, 20334.491637708583, 20581.38255852327, 21282.574348512633, 21831.235906743186, 22064.0, 22073.227437039626, 22515.88742056279, 17634.382796602058, 17722.822771772633, 20126.29557965464, 20155.193792248145, 20641.793582064587, 16898.493045208663, 17259.3959211427, 17276.395326163525, 19240.0, 19334.516637084187, 19811.306604268782, 19865.602687946448, 20336.0, 20391.4902127448, 20656.690149647467, 11176.0, 12953.870461295266, 14113.153210807384, 14518.185226846645, 14683.0, 14643.92678036603, 14659.340329685403, 14769.704605908037, 14793.630159246104, 15109.848901511285], "value": 9386.320841926921, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 109.0, 95.0, 108.0, 113.0, 107.0, 110.0, 107.0, 115.0, 111.0], "value": 107.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 120.0, 146.0, 176.0, 117.0, 153.0, 141.0, 117.0, 177.0, 117.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 164.0, 166.0, 162.0, 177.0, 170.0, 161.0, 165.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 165.0, 81.0, 74.0, 91.0, 88.0, 98.0, 74.0], "value": 89.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 82.0, 133.0, 78.0, 79.0, 78.0, 126.0, 83.0, 78.0, 134.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 120.0, 117.0, 114.0, 114.0, 114.0, 117.0, 119.0], "value": 115.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 150.0, 151.0, 151.0, 155.0, 151.0, 152.0, 155.0, 151.0], "value": 151.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 97.0, 93.0, 95.0, 94.0, 94.0, 98.0, 98.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 58.0, 54.0, 57.0, 59.0, 54.0, 57.0, 54.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 53.0, 55.0, 53.0, 54.0, 54.0, 53.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 78.0, 88.0, 102.0, 78.0, 78.0, 79.0, 96.0, 77.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 128.0, 145.0, 148.0, 135.0, 125.0, 129.0, 144.0, 144.0, 169.0], "value": 139.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 184.0, 173.0, 176.0, 184.0, 177.0, 171.0, 188.0, 174.0, 171.0], "value": 178.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 73.0, 70.0, 70.0, 72.0, 68.0, 68.0, 68.0, 67.0], "value": 69.3, "unit": "score"}]}]} 16:21:39 INFO - Return code: 0 16:21:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:21:39 INFO - # TBPL SUCCESS # 16:21:39 INFO - Running post-action listener: _package_coverage_data 16:21:39 INFO - Running post-action listener: _resource_record_post_action 16:21:39 INFO - [mozharness: 2017-08-08 23:21:39.988757Z] Finished run-tests step (success) 16:21:39 INFO - Running post-run listener: _resource_record_post_run 16:21:40 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 442331136; Read time: 8; Write time: 431348 16:21:40 INFO - TinderboxPrint: CPU usage
13.2% 16:21:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 16:21:40 INFO - TinderboxPrint: I/O write bytes / time
442,331,136 / 431,348 16:21:40 INFO - TinderboxPrint: CPU idle
8,271.9 (86.8%) 16:21:40 INFO - TinderboxPrint: CPU user
1,205.4 (12.7%) 16:21:40 INFO - TinderboxPrint: Swap in / out
0 / 0 16:21:40 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 115982336; Read time: 0; Write time: 117604 16:21:40 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:21:40 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 325226496; Read time: 0; Write time: 313664 16:21:40 INFO - Running post-run listener: _upload_blobber_files 16:21:40 INFO - Blob upload gear active. 16:21:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:21:40 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 16:21:40 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'] 16:21:40 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 16:21:41 INFO - (blobuploader) - INFO - Open directory for files ... 16:21:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:21:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:21:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:21:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:21:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:21:41 INFO - (blobuploader) - INFO - Done attempting. 16:21:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:21:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:21:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:21:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:21:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:21:42 INFO - (blobuploader) - INFO - Done attempting. 16:21:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:21:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:21:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:21:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:21:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:21:49 INFO - (blobuploader) - INFO - Done attempting. 16:21:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:21:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:21:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:21:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:21:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:21:50 INFO - (blobuploader) - INFO - Done attempting. 16:21:50 INFO - (blobuploader) - INFO - Iteration through files over. 16:21:50 INFO - Return code: 0 16:21:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:21:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:21:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea8eb9f23ae4f189a4a7b42ec671a2a0ee380b5800d8bf424f08501da8f191282359a798fd6e834460393d5b071939664206fd77d587bb65c5b51dac4bbdb21c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2f1854ad1b96eb39f1a062f19c29a927d6ebcca24c4dd91e61ed7e08ba691e9d2452ea36e59de40da02309c9c23ec6f764b61ed8a84f0854e21ddc666a34293", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a01872ee53a390868a25e26758003e0a2dcbbff89db69def62065675c5c3212a9d5372cfd54a414810f35227a43e9c5e3384a64efe553b1a4fff4eed21ad1365", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9533fe37f078af136a4cd059297e53a41d58bd078b889c9b99ff287fb77d6c98b137c8dab7442737651978f8e95bc005eb7e32cd5420f5d96ce21d9a93192bcb"} 16:21:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:21:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:21:50 INFO - Contents: 16:21:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea8eb9f23ae4f189a4a7b42ec671a2a0ee380b5800d8bf424f08501da8f191282359a798fd6e834460393d5b071939664206fd77d587bb65c5b51dac4bbdb21c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2f1854ad1b96eb39f1a062f19c29a927d6ebcca24c4dd91e61ed7e08ba691e9d2452ea36e59de40da02309c9c23ec6f764b61ed8a84f0854e21ddc666a34293", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a01872ee53a390868a25e26758003e0a2dcbbff89db69def62065675c5c3212a9d5372cfd54a414810f35227a43e9c5e3384a64efe553b1a4fff4eed21ad1365", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9533fe37f078af136a4cd059297e53a41d58bd078b889c9b99ff287fb77d6c98b137c8dab7442737651978f8e95bc005eb7e32cd5420f5d96ce21d9a93192bcb"} 16:21:50 INFO - Running post-run listener: copy_logs_to_upload_dir 16:21:50 INFO - Copying logs to upload dir... 16:21:50 INFO - mkdir: /builds/slave/test/build/upload/logs 16:21:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.213437 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-08 16:21:50.009972) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-08 16:21:50.017001) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1502233252.44184-551636089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea8eb9f23ae4f189a4a7b42ec671a2a0ee380b5800d8bf424f08501da8f191282359a798fd6e834460393d5b071939664206fd77d587bb65c5b51dac4bbdb21c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2f1854ad1b96eb39f1a062f19c29a927d6ebcca24c4dd91e61ed7e08ba691e9d2452ea36e59de40da02309c9c23ec6f764b61ed8a84f0854e21ddc666a34293", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a01872ee53a390868a25e26758003e0a2dcbbff89db69def62065675c5c3212a9d5372cfd54a414810f35227a43e9c5e3384a64efe553b1a4fff4eed21ad1365", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9533fe37f078af136a4cd059297e53a41d58bd078b889c9b99ff287fb77d6c98b137c8dab7442737651978f8e95bc005eb7e32cd5420f5d96ce21d9a93192bcb"} build_url:https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011189 build_url: 'https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea8eb9f23ae4f189a4a7b42ec671a2a0ee380b5800d8bf424f08501da8f191282359a798fd6e834460393d5b071939664206fd77d587bb65c5b51dac4bbdb21c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2f1854ad1b96eb39f1a062f19c29a927d6ebcca24c4dd91e61ed7e08ba691e9d2452ea36e59de40da02309c9c23ec6f764b61ed8a84f0854e21ddc666a34293", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a01872ee53a390868a25e26758003e0a2dcbbff89db69def62065675c5c3212a9d5372cfd54a414810f35227a43e9c5e3384a64efe553b1a4fff4eed21ad1365", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9533fe37f078af136a4cd059297e53a41d58bd078b889c9b99ff287fb77d6c98b137c8dab7442737651978f8e95bc005eb7e32cd5420f5d96ce21d9a93192bcb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-08 16:21:50.044168) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 16:21:50.044472) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1502233252.44184-551636089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 16:21:50.123472) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-08 16:21:50.123916) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-08 16:21:50.124205) ========= ========= Total master_lag: 0.18 =========