builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-049 starttime: 1501878147.04 results: success (0) revision: 4cfb674227051e22bab651e5759f3de503a50560 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:27.040529) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:27.041198) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:27.041473) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:27.084303) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:27.084601) ========= 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=db7e7c15f3ca076d53731445000001ba-1501877348.455069-1832511922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-04 13:22:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.2M=0s 2017-08-04 13:22:26 (36.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.171555 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:27.336010) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:27.336315) ========= 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=db7e7c15f3ca076d53731445000001ba-1501877348.455069-1832511922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020193 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:27.391985) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:27.392311) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4cfb674227051e22bab651e5759f3de503a50560 --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 4cfb674227051e22bab651e5759f3de503a50560 --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=db7e7c15f3ca076d53731445000001ba-1501877348.455069-1832511922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-04 13:22:26,694 truncating revision to first 12 chars 2017-08-04 13:22:26,694 Setting DEBUG logging. 2017-08-04 13:22:26,694 attempt 1/10 2017-08-04 13:22:26,694 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4cfb67422705?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-04 13:22:27,001 unpacking tar archive at: mozilla-central-4cfb67422705/testing/mozharness/ program finished with exit code 0 elapsedTime=0.607523 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:28.018868) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:28.019178) ========= script_repo_revision: 4cfb674227051e22bab651e5759f3de503a50560 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:28.019578) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:28.019834) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:28.046232) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-04 13:22:28.046580) ========= /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=db7e7c15f3ca076d53731445000001ba-1501877348.455069-1832511922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:22:27 INFO - MultiFileLogger online at 20170804 13:22:27 in /builds/slave/test 13:22:27 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 13:22:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:22:27 INFO - {'append_to_log': False, 13:22:27 INFO - 'base_work_dir': '/builds/slave/test', 13:22:27 INFO - 'blob_upload_branch': 'Firefox', 13:22:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:22:27 INFO - 'branch': 'Firefox', 13:22:27 INFO - 'buildbot_json_path': 'buildprops.json', 13:22:27 INFO - 'code_coverage': False, 13:22:27 INFO - 'config_files': ('talos/linux_config.py',), 13:22:27 INFO - 'default_actions': ('clobber', 13:22:27 INFO - 'read-buildbot-config', 13:22:27 INFO - 'download-and-extract', 13:22:27 INFO - 'populate-webroot', 13:22:27 INFO - 'create-virtualenv', 13:22:27 INFO - 'install', 13:22:27 INFO - 'setup-mitmproxy', 13:22:27 INFO - 'run-tests'), 13:22:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:22:27 INFO - 'disable_ccov_upload': False, 13:22:27 INFO - 'download_minidump_stackwalk': True, 13:22:27 INFO - 'download_symbols': 'ondemand', 13:22:27 INFO - 'enable_stylo': False, 13:22:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:22:27 INFO - 'tooltool.py': '/tools/tooltool.py', 13:22:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:22:27 INFO - '/tools/misc-python/virtualenv.py')}, 13:22:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:22:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:22:27 INFO - 'gecko_profile': False, 13:22:27 INFO - 'gecko_profile_interval': 0, 13:22:27 INFO - 'installer_path': 'installer.exe', 13:22:27 INFO - 'log_level': 'info', 13:22:27 INFO - 'log_name': 'talos', 13:22:27 INFO - 'log_to_console': True, 13:22:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:22:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:22:27 INFO - 'opt_config_files': (), 13:22:27 INFO - 'pip_index': False, 13:22:27 INFO - 'suite': 'dromaeojs-e10s', 13:22:27 INFO - 'system_bits': '32', 13:22:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:22:27 INFO - 'title': 'talos-linux64-ix-049', 13:22:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:22:27 INFO - 'use_talos_json': True, 13:22:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:22:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:22:27 INFO - 'work_dir': 'build'} 13:22:27 INFO - [mozharness: 2017-08-04 20:22:27.563076Z] Running clobber step. 13:22:27 INFO - Running pre-action listener: _resource_record_pre_action 13:22:27 INFO - Running main action method: clobber 13:22:27 INFO - rmtree: /builds/slave/test/build 13:22:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:22:28 INFO - Running post-action listener: _resource_record_post_action 13:22:28 INFO - [mozharness: 2017-08-04 20:22:28.563640Z] Finished clobber step (success) 13:22:28 INFO - [mozharness: 2017-08-04 20:22:28.563742Z] Running read-buildbot-config step. 13:22:28 INFO - Running pre-action listener: _resource_record_pre_action 13:22:28 INFO - Running main action method: read_buildbot_config 13:22:28 INFO - Using buildbot properties: 13:22:28 INFO - { 13:22:28 INFO - "project": "", 13:22:28 INFO - "product": "firefox", 13:22:28 INFO - "who": "ryanvm@gmail.com", 13:22:28 INFO - "installer_path": "public/build/target.tar.bz2", 13:22:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 13:22:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 13:22:28 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 13:22:28 INFO - "stage_platform": "linux64-stylosequential", 13:22:28 INFO - "basedir": "/builds/slave/test", 13:22:28 INFO - "buildnumber": 19, 13:22:28 INFO - "platform": "ubuntu64_hw_styloseq", 13:22:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:22:28 INFO - "slavebuilddir": "test", 13:22:28 INFO - "taskId": "fmOc-DofTferuQEVgKBT9Q", 13:22:28 INFO - "branch": "mozilla-central", 13:22:28 INFO - "script_repo_revision": "production", 13:22:28 INFO - "revision": "4cfb674227051e22bab651e5759f3de503a50560", 13:22:28 INFO - "slavename": "talos-linux64-ix-049", 13:22:28 INFO - "repo_path": "mozilla-central" 13:22:28 INFO - } 13:22:28 INFO - Finding installer, test and symbols from parent task. 13:22:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fmOc-DofTferuQEVgKBT9Q'}, attempt #1 13:22:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fmOc-DofTferuQEVgKBT9Q'}, attempt #1 13:22:29 INFO - Task dependencies: fr-KaQa9SOOeGyxNTNR3Ww 13:22:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww'}, attempt #1 13:22:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.tar.bz2 13:22:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.test_packages.json 13:22:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.crashreporter-symbols.zip 13:22:29 INFO - Running post-action listener: _resource_record_post_action 13:22:29 INFO - [mozharness: 2017-08-04 20:22:29.900708Z] Finished read-buildbot-config step (success) 13:22:29 INFO - [mozharness: 2017-08-04 20:22:29.900930Z] Running download-and-extract step. 13:22:29 INFO - Running pre-action listener: _resource_record_pre_action 13:22:29 INFO - Running main action method: download_and_extract 13:22:29 INFO - mkdir: /builds/slave/test/build/tests 13:22: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')]} 13:22:29 INFO - trying https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.test_packages.json 13:22:29 INFO - Downloading https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:22:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:22:30 INFO - Downloaded 989 bytes. 13:22:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:22:30 INFO - Using the following test package requirements: 13:22:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:22:30 INFO - u'common': [u'target.common.tests.zip'], 13:22:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:22:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:22:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:22:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:22:30 INFO - u'mozbase': [u'target.common.tests.zip'], 13:22:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:22:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:22:30 INFO - u'web-platform': [u'target.common.tests.zip', 13:22:30 INFO - u'target.web-platform.tests.tar.gz'], 13:22:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:22:30 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 13:22:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.common.tests.zip 13:22:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:22:30 INFO - Fetch https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.common.tests.zip into memory 13:22:31 INFO - Content-Length response header: 54282413 13:22:31 INFO - Bytes received: 54282413 13:22:43 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 13:22:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.common.tests.zip 13:22:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:22:43 INFO - Fetch https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.common.tests.zip into memory 13:22:44 INFO - Content-Length response header: 54282413 13:22:44 INFO - Bytes received: 54282413 13:22:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.talos.tests.zip 13:22:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:22:57 INFO - Fetch https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.talos.tests.zip into memory 13:22:58 INFO - Content-Length response header: 14496008 13:22:58 INFO - Bytes received: 14496008 13:22:58 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')]} 13:22:58 INFO - trying https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.tar.bz2 13:22:58 INFO - Downloading https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:22:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:22:59 INFO - Downloaded 61895863 bytes. 13:22:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.tar.bz2 13:22:59 INFO - mkdir: /builds/slave/test/properties 13:22:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:22:59 INFO - Writing to file /builds/slave/test/properties/build_url 13:22:59 INFO - Contents: 13:22:59 INFO - build_url:https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.tar.bz2 13:22:59 INFO - Running post-action listener: _resource_record_post_action 13:22:59 INFO - Running post-action listener: set_extra_try_arguments 13:22:59 INFO - [mozharness: 2017-08-04 20:22:59.373638Z] Finished download-and-extract step (success) 13:22:59 INFO - [mozharness: 2017-08-04 20:22:59.373739Z] Running populate-webroot step. 13:22:59 INFO - Running pre-action listener: _resource_record_pre_action 13:22:59 INFO - Running main action method: populate_webroot 13:22:59 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:22:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:22:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:22:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:22:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:22:59 INFO - 'tests': ['damp', 'tps']}, 13:22:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:22:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:22:59 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 13:22:59 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:22:59 INFO - 'other-e10s': {'tests': ['a11yr', 13:22:59 INFO - 'ts_paint', 13:22:59 INFO - 'tpaint', 13:22:59 INFO - 'sessionrestore', 13:22:59 INFO - 'sessionrestore_many_windows', 13:22:59 INFO - 'sessionrestore_no_auto_restore', 13:22:59 INFO - 'tabpaint']}, 13:22:59 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 13:22:59 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 13:22:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:22:59 INFO - 'tsvgr_opacity', 13:22:59 INFO - 'tart', 13:22:59 INFO - 'tscrollx', 13:22:59 INFO - 'tsvg_static']}, 13:22:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:22:59 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:22:59 INFO - 'talos_options': ['--mitmproxy', 13:22:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:22:59 INFO - '--firstNonBlankPaint'], 13:22:59 INFO - 'tests': ['tp6_google', 13:22:59 INFO - 'tp6_youtube', 13:22:59 INFO - 'tp6_amazon', 13:22:59 INFO - 'tp6_facebook']}, 13:22:59 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:22:59 INFO - 'talos_options': ['--stylo', 13:22:59 INFO - '--mitmproxy', 13:22:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:22:59 INFO - '--firstNonBlankPaint'], 13:22:59 INFO - 'tests': ['tp6_google', 13:22:59 INFO - 'tp6_youtube', 13:22:59 INFO - 'tp6_amazon', 13:22:59 INFO - 'tp6_facebook']}, 13:22:59 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:22:59 INFO - 'talos_options': ['--stylo', 13:22:59 INFO - '--stylo-threads=1', 13:22:59 INFO - '--mitmproxy', 13:22:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:22:59 INFO - '--firstNonBlankPaint'], 13:22:59 INFO - 'tests': ['tp6_google', 13:22:59 INFO - 'tp6_youtube', 13:22:59 INFO - 'tp6_amazon', 13:22:59 INFO - 'tp6_facebook']}, 13:22:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:22:59 INFO - 'talos_options': ['--xperf_path', 13:22:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:22:59 INFO - 'tests': ['tp5n']}}} 13:22:59 INFO - Running post-action listener: _resource_record_post_action 13:22:59 INFO - [mozharness: 2017-08-04 20:22:59.382172Z] Finished populate-webroot step (success) 13:22:59 INFO - [mozharness: 2017-08-04 20:22:59.382260Z] Running create-virtualenv step. 13:22:59 INFO - Running pre-action listener: _resource_record_pre_action 13:22:59 INFO - Running main action method: create_virtualenv 13:22:59 INFO - Creating virtualenv /builds/slave/test/build/venv 13:22:59 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 13:22:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:22:59 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 13:22:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:22:59 INFO - Using real prefix '/usr' 13:22:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:23:00 INFO - Installing distribute.............................................................................................................................................................................................done. 13:23:02 INFO - Installing pip.................done. 13:23:02 INFO - Return code: 0 13:23:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:23:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:23:02 INFO - Reading from file tmpfile_stdout 13:23:02 INFO - Output received: 13:23:02 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) 13:23:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:23: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')]} 13:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23: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')]} 13:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f17eb0>, '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 0x1f18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f19240>, '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': 'db7e7c15f3ca076d53731445000001ba-1501877348.455069-1832511922', '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 13:23:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:23:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:23:02 INFO - Using env: {'DISPLAY': ':0', 13:23:02 INFO - 'HOME': '/home/cltbld', 13:23:02 INFO - 'LANG': 'en_US.UTF-8', 13:23:02 INFO - 'LANGUAGE': 'en_US:en', 13:23:02 INFO - 'LOGNAME': 'cltbld', 13:23:02 INFO - 'MAIL': '/var/mail/cltbld', 13:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:02 INFO - 'MOZ_NO_REMOTE': '1', 13:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:02 INFO - 'NO_EM_RESTART': '1', 13:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:02 INFO - 'PWD': '/builds/slave/test', 13:23:02 INFO - 'SHELL': '/bin/bash', 13:23:02 INFO - 'SHLVL': '1', 13:23:02 INFO - 'TERM': 'linux', 13:23:02 INFO - 'TMOUT': '86400', 13:23:02 INFO - 'USER': 'cltbld', 13:23:02 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1501877348.455069-1832511922', 13:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:02 INFO - '_': '/tools/buildbot/bin/python'} 13:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:02 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 13:23:02 INFO - Cleaning up... 13:23:02 INFO - Return code: 0 13:23:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:23: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')]} 13:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23: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')]} 13:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1bab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f17eb0>, '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 0x1f18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f19240>, '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': 'db7e7c15f3ca076d53731445000001ba-1501877348.455069-1832511922', '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 13:23:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:23:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:23:02 INFO - Using env: {'DISPLAY': ':0', 13:23:02 INFO - 'HOME': '/home/cltbld', 13:23:02 INFO - 'LANG': 'en_US.UTF-8', 13:23:02 INFO - 'LANGUAGE': 'en_US:en', 13:23:02 INFO - 'LOGNAME': 'cltbld', 13:23:02 INFO - 'MAIL': '/var/mail/cltbld', 13:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:02 INFO - 'MOZ_NO_REMOTE': '1', 13:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:02 INFO - 'NO_EM_RESTART': '1', 13:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:02 INFO - 'PWD': '/builds/slave/test', 13:23:02 INFO - 'SHELL': '/bin/bash', 13:23:02 INFO - 'SHLVL': '1', 13:23:02 INFO - 'TERM': 'linux', 13:23:02 INFO - 'TMOUT': '86400', 13:23:02 INFO - 'USER': 'cltbld', 13:23:02 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1501877348.455069-1832511922', 13:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:02 INFO - '_': '/tools/buildbot/bin/python'} 13:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:02 INFO - Downloading/unpacking psutil>=3.1.1 13:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:23:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:23:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:23:04 INFO - Installing collected packages: psutil 13:23:04 INFO - Running setup.py install for psutil 13:23:04 INFO - building 'psutil._psutil_linux' extension 13:23:04 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 13:23:05 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 13:23:05 INFO - building 'psutil._psutil_posix' extension 13:23:05 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 13:23:05 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 13:23:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:23:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:23:05 INFO - Successfully installed psutil 13:23:05 INFO - Cleaning up... 13:23:05 INFO - Return code: 0 13:23:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:05 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 0x1bab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f17eb0>, '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 0x1f18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f19240>, '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': 'db7e7c15f3ca076d53731445000001ba-1501877348.455069-1832511922', '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 13:23:05 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 13:23:05 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 13:23:05 INFO - Using env: {'DISPLAY': ':0', 13:23:05 INFO - 'HOME': '/home/cltbld', 13:23:05 INFO - 'LANG': 'en_US.UTF-8', 13:23:05 INFO - 'LANGUAGE': 'en_US:en', 13:23:05 INFO - 'LOGNAME': 'cltbld', 13:23:05 INFO - 'MAIL': '/var/mail/cltbld', 13:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:05 INFO - 'MOZ_NO_REMOTE': '1', 13:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:05 INFO - 'NO_EM_RESTART': '1', 13:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:05 INFO - 'PWD': '/builds/slave/test', 13:23:05 INFO - 'SHELL': '/bin/bash', 13:23:05 INFO - 'SHLVL': '1', 13:23:05 INFO - 'TERM': 'linux', 13:23:05 INFO - 'TMOUT': '86400', 13:23:05 INFO - 'USER': 'cltbld', 13:23:05 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1501877348.455069-1832511922', 13:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:05 INFO - '_': '/tools/buildbot/bin/python'} 13:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:23:06 INFO - Installing collected packages: mozsystemmonitor 13:23:06 INFO - Running setup.py install for mozsystemmonitor 13:23:07 INFO - Successfully installed mozsystemmonitor 13:23:07 INFO - Cleaning up... 13:23:07 INFO - Return code: 0 13:23:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:23:07 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')]} 13:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:07 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')]} 13:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:07 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 0x1bab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f17eb0>, '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 0x1f18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f19240>, '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': 'db7e7c15f3ca076d53731445000001ba-1501877348.455069-1832511922', '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 13:23:07 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 13:23:07 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 13:23:07 INFO - Using env: {'DISPLAY': ':0', 13:23:07 INFO - 'HOME': '/home/cltbld', 13:23:07 INFO - 'LANG': 'en_US.UTF-8', 13:23:07 INFO - 'LANGUAGE': 'en_US:en', 13:23:07 INFO - 'LOGNAME': 'cltbld', 13:23:07 INFO - 'MAIL': '/var/mail/cltbld', 13:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:07 INFO - 'MOZ_NO_REMOTE': '1', 13:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:07 INFO - 'NO_EM_RESTART': '1', 13:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:07 INFO - 'PWD': '/builds/slave/test', 13:23:07 INFO - 'SHELL': '/bin/bash', 13:23:07 INFO - 'SHLVL': '1', 13:23:07 INFO - 'TERM': 'linux', 13:23:07 INFO - 'TMOUT': '86400', 13:23:07 INFO - 'USER': 'cltbld', 13:23:07 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1501877348.455069-1832511922', 13:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:07 INFO - '_': '/tools/buildbot/bin/python'} 13:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:07 INFO - Downloading/unpacking jsonschema==2.5.1 13:23:07 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 13:23:07 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 13:23:07 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 13:23:07 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 13:23:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:23:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:08 INFO - Downloading functools32-3.2.3-2.tar.gz 13:23:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:23:08 INFO - warning: no files found matching '*.txt' 13:23:08 INFO - no previously-included directories found matching 'build' 13:23:08 INFO - no previously-included directories found matching 'dist' 13:23:08 INFO - no previously-included directories found matching '.git*' 13:23:08 INFO - Installing collected packages: jsonschema, functools32 13:23:08 INFO - Running setup.py install for functools32 13:23:08 INFO - warning: no files found matching '*.txt' 13:23:08 INFO - no previously-included directories found matching 'build' 13:23:08 INFO - no previously-included directories found matching 'dist' 13:23:08 INFO - no previously-included directories found matching '.git*' 13:23:08 INFO - Successfully installed jsonschema functools32 13:23:08 INFO - Cleaning up... 13:23:08 INFO - Return code: 0 13:23:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:08 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 0x1bab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f17eb0>, '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 0x1f18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f19240>, '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': 'db7e7c15f3ca076d53731445000001ba-1501877348.455069-1832511922', '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 13:23:08 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 13:23:08 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 13:23:08 INFO - Using env: {'DISPLAY': ':0', 13:23:08 INFO - 'HOME': '/home/cltbld', 13:23:08 INFO - 'LANG': 'en_US.UTF-8', 13:23:08 INFO - 'LANGUAGE': 'en_US:en', 13:23:08 INFO - 'LOGNAME': 'cltbld', 13:23:08 INFO - 'MAIL': '/var/mail/cltbld', 13:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:08 INFO - 'MOZ_NO_REMOTE': '1', 13:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:08 INFO - 'NO_EM_RESTART': '1', 13:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:08 INFO - 'PWD': '/builds/slave/test', 13:23:08 INFO - 'SHELL': '/bin/bash', 13:23:08 INFO - 'SHLVL': '1', 13:23:08 INFO - 'TERM': 'linux', 13:23:08 INFO - 'TMOUT': '86400', 13:23:08 INFO - 'USER': 'cltbld', 13:23:08 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1501877348.455069-1832511922', 13:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:08 INFO - '_': '/tools/buildbot/bin/python'} 13:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:23:08 INFO - Cleaning up... 13:23:08 INFO - Return code: 0 13:23:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:08 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 0x1bab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f17eb0>, '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 0x1f18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f19240>, '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': 'db7e7c15f3ca076d53731445000001ba-1501877348.455069-1832511922', '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 13:23:08 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 13:23:08 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 13:23:08 INFO - Using env: {'DISPLAY': ':0', 13:23:08 INFO - 'HOME': '/home/cltbld', 13:23:08 INFO - 'LANG': 'en_US.UTF-8', 13:23:08 INFO - 'LANGUAGE': 'en_US:en', 13:23:08 INFO - 'LOGNAME': 'cltbld', 13:23:08 INFO - 'MAIL': '/var/mail/cltbld', 13:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:08 INFO - 'MOZ_NO_REMOTE': '1', 13:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:08 INFO - 'NO_EM_RESTART': '1', 13:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:08 INFO - 'PWD': '/builds/slave/test', 13:23:08 INFO - 'SHELL': '/bin/bash', 13:23:08 INFO - 'SHLVL': '1', 13:23:08 INFO - 'TERM': 'linux', 13:23:08 INFO - 'TMOUT': '86400', 13:23:08 INFO - 'USER': 'cltbld', 13:23:08 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1501877348.455069-1832511922', 13:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:08 INFO - '_': '/tools/buildbot/bin/python'} 13:23:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:09 INFO - Downloading/unpacking blobuploader==1.2.4 13:23:09 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 13:23:09 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 13:23:09 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 13:23:09 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 13:23:10 INFO - Downloading blobuploader-1.2.4.tar.gz 13:23:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:23:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:23:10 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 13:23:10 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 13:23:10 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 13:23:10 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 13:23:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:23:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:23:10 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 13:23:10 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 13:23:10 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 13:23:10 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 13:23:10 INFO - Downloading docopt-0.6.1.tar.gz 13:23:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:23:11 INFO - Installing collected packages: blobuploader, requests, docopt 13:23:11 INFO - Running setup.py install for blobuploader 13:23:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:23:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:23:11 INFO - Running setup.py install for requests 13:23:11 INFO - Running setup.py install for docopt 13:23:11 INFO - Successfully installed blobuploader requests docopt 13:23:11 INFO - Cleaning up... 13:23:11 INFO - Return code: 0 13:23:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:23:11 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')]} 13:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:11 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')]} 13:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:11 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 0x1bab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f17eb0>, '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 0x1f18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f19240>, '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': 'db7e7c15f3ca076d53731445000001ba-1501877348.455069-1832511922', '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 13:23:11 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 13:23:11 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 13:23:11 INFO - Using env: {'DISPLAY': ':0', 13:23:11 INFO - 'HOME': '/home/cltbld', 13:23:11 INFO - 'LANG': 'en_US.UTF-8', 13:23:11 INFO - 'LANGUAGE': 'en_US:en', 13:23:11 INFO - 'LOGNAME': 'cltbld', 13:23:11 INFO - 'MAIL': '/var/mail/cltbld', 13:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:11 INFO - 'MOZ_NO_REMOTE': '1', 13:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:11 INFO - 'NO_EM_RESTART': '1', 13:23:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:11 INFO - 'PWD': '/builds/slave/test', 13:23:11 INFO - 'SHELL': '/bin/bash', 13:23:11 INFO - 'SHLVL': '1', 13:23:11 INFO - 'TERM': 'linux', 13:23:11 INFO - 'TMOUT': '86400', 13:23:11 INFO - 'USER': 'cltbld', 13:23:11 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1501877348.455069-1832511922', 13:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:11 INFO - '_': '/tools/buildbot/bin/python'} 13:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:23:11 INFO - Running setup.py (path:/tmp/pip-8Hphb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:23:11 INFO - Running setup.py (path:/tmp/pip-YdyA5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:23:12 INFO - Running setup.py (path:/tmp/pip-6AOrvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:23:12 INFO - Running setup.py (path:/tmp/pip-NnAXWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:23:12 INFO - Running setup.py (path:/tmp/pip-jyh8J8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:23:12 INFO - Running setup.py (path:/tmp/pip-iLdEpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:23:12 INFO - Running setup.py (path:/tmp/pip-hGtu6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:23:12 INFO - Running setup.py (path:/tmp/pip-AAIdnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:23:12 INFO - Running setup.py (path:/tmp/pip-_mpJiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:23:12 INFO - Running setup.py (path:/tmp/pip-jJyjvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:23:12 INFO - Running setup.py (path:/tmp/pip-oA0l_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:23:12 INFO - Running setup.py (path:/tmp/pip-EPSnCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:23:12 INFO - Running setup.py (path:/tmp/pip-L0rtw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:23:12 INFO - Running setup.py (path:/tmp/pip-Y7ZNqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:12 INFO - Running setup.py (path:/tmp/pip-tdnnqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:23:12 INFO - Running setup.py (path:/tmp/pip-b1m9n7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:23:13 INFO - Running setup.py (path:/tmp/pip-h0FUfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:23:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:23:13 INFO - Running setup.py install for manifestparser 13:23:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:23:13 INFO - Running setup.py install for mozcrash 13:23:13 INFO - Running setup.py install for mozdebug 13:23:13 INFO - Running setup.py install for mozdevice 13:23:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:23:13 INFO - Running setup.py install for mozfile 13:23:13 INFO - Running setup.py install for mozhttpd 13:23:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:23:13 INFO - Running setup.py install for mozinfo 13:23:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:23:13 INFO - Running setup.py install for mozInstall 13:23:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:23:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:23:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:23:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:23:13 INFO - Running setup.py install for mozleak 13:23:13 INFO - Running setup.py install for mozlog 13:23:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:23:14 INFO - Running setup.py install for moznetwork 13:23:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:23:14 INFO - Running setup.py install for mozprocess 13:23:14 INFO - Running setup.py install for mozprofile 13:23:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:23:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:23:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:23:14 INFO - Running setup.py install for mozrunner 13:23:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:23:14 INFO - Running setup.py install for mozscreenshot 13:23:14 INFO - Running setup.py install for moztest 13:23:14 INFO - Running setup.py install for mozversion 13:23:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:23:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:23:14 INFO - Cleaning up... 13:23:14 INFO - Return code: 0 13:23:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:23:14 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')]} 13:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:14 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')]} 13:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:14 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 0x1bab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f17eb0>, '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 0x1f18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f19240>, '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': 'db7e7c15f3ca076d53731445000001ba-1501877348.455069-1832511922', '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 13:23:14 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 13:23:14 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 13:23:14 INFO - Using env: {'DISPLAY': ':0', 13:23:14 INFO - 'HOME': '/home/cltbld', 13:23:14 INFO - 'LANG': 'en_US.UTF-8', 13:23:14 INFO - 'LANGUAGE': 'en_US:en', 13:23:14 INFO - 'LOGNAME': 'cltbld', 13:23:14 INFO - 'MAIL': '/var/mail/cltbld', 13:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:14 INFO - 'MOZ_NO_REMOTE': '1', 13:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:14 INFO - 'NO_EM_RESTART': '1', 13:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:14 INFO - 'PWD': '/builds/slave/test', 13:23:14 INFO - 'SHELL': '/bin/bash', 13:23:14 INFO - 'SHLVL': '1', 13:23:14 INFO - 'TERM': 'linux', 13:23:14 INFO - 'TMOUT': '86400', 13:23:14 INFO - 'USER': 'cltbld', 13:23:14 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1501877348.455069-1832511922', 13:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:14 INFO - '_': '/tools/buildbot/bin/python'} 13:23:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:23:15 INFO - Running setup.py (path:/tmp/pip-PN3dBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:23:15 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)) 13:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:23:15 INFO - Running setup.py (path:/tmp/pip-eDacrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:23:15 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)) 13:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:23:15 INFO - Running setup.py (path:/tmp/pip-TvXFCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:23:15 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)) 13:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:23:15 INFO - Running setup.py (path:/tmp/pip-87io3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:23:15 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)) 13:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:23:15 INFO - Running setup.py (path:/tmp/pip-bBUUNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:23:15 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)) 13:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:23:15 INFO - Running setup.py (path:/tmp/pip-TUgdSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:23:15 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)) 13:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:23:15 INFO - Running setup.py (path:/tmp/pip-mnu1BC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:23:15 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)) 13:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:23:15 INFO - Running setup.py (path:/tmp/pip-K5IEPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:23:15 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)) 13:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:23:15 INFO - Running setup.py (path:/tmp/pip-WFGhbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:23:15 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)) 13:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:23:15 INFO - Running setup.py (path:/tmp/pip-Fyls5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:23:15 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)) 13:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:23:15 INFO - Running setup.py (path:/tmp/pip-RjvTcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:23:15 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)) 13:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:23:15 INFO - Running setup.py (path:/tmp/pip-ZRdvrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:23:15 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)) 13:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:23:15 INFO - Running setup.py (path:/tmp/pip-UX0fMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:23:16 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)) 13:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:23:16 INFO - Running setup.py (path:/tmp/pip-O_Lqek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:23:16 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)) 13:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:16 INFO - Running setup.py (path:/tmp/pip-G4hdvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:16 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)) 13:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:23:16 INFO - Running setup.py (path:/tmp/pip-lCUdZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:23:16 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)) 13:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:23:16 INFO - Running setup.py (path:/tmp/pip-OPDjxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:23:16 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)) 13:23:16 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)) 13:23:16 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)) 13:23:16 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)) 13:23:16 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)) 13:23:16 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)) 13:23:16 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)) 13:23:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:23:16 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 13:23:16 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 13:23:16 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 13:23:16 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 13:23:17 INFO - Downloading blessings-1.6.tar.gz 13:23:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:23:17 INFO - Installing collected packages: blessings 13:23:17 INFO - Running setup.py install for blessings 13:23:17 INFO - Successfully installed blessings 13:23:17 INFO - Cleaning up... 13:23:17 INFO - Return code: 0 13:23:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:23:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:23:17 INFO - Reading from file tmpfile_stdout 13:23:17 INFO - Current package versions: 13:23:17 INFO - argparse == 1.2.1 13:23:17 INFO - blessings == 1.6 13:23:17 INFO - blobuploader == 1.2.4 13:23:17 INFO - docopt == 0.6.1 13:23:17 INFO - functools32 == 3.2.3-2 13:23:17 INFO - jsonschema == 2.5.1 13:23:17 INFO - manifestparser == 1.1 13:23:17 INFO - mozInstall == 1.13 13:23:17 INFO - mozcrash == 1.0 13:23:17 INFO - mozdebug == 0.1 13:23:17 INFO - mozdevice == 0.51 13:23:17 INFO - mozfile == 1.2 13:23:17 INFO - mozhttpd == 0.7 13:23:17 INFO - mozinfo == 0.10 13:23:17 INFO - mozleak == 0.1 13:23:17 INFO - mozlog == 3.5 13:23:17 INFO - moznetwork == 0.27 13:23:17 INFO - mozprocess == 0.25 13:23:17 INFO - mozprofile == 0.28 13:23:17 INFO - mozrunner == 6.13 13:23:17 INFO - mozscreenshot == 0.1 13:23:17 INFO - mozsystemmonitor == 0.3 13:23:17 INFO - moztest == 0.8 13:23:17 INFO - mozversion == 1.4 13:23:17 INFO - psutil == 3.1.1 13:23:17 INFO - requests == 1.2.3 13:23:17 INFO - wsgiref == 0.1.2 13:23:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:17 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 0x1bab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f17eb0>, '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 0x1f18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f19240>, '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': 'db7e7c15f3ca076d53731445000001ba-1501877348.455069-1832511922', '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 13:23:17 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 13:23:17 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 13:23:17 INFO - Using env: {'DISPLAY': ':0', 13:23:17 INFO - 'HOME': '/home/cltbld', 13:23:17 INFO - 'LANG': 'en_US.UTF-8', 13:23:17 INFO - 'LANGUAGE': 'en_US:en', 13:23:17 INFO - 'LOGNAME': 'cltbld', 13:23:17 INFO - 'MAIL': '/var/mail/cltbld', 13:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:17 INFO - 'MOZ_NO_REMOTE': '1', 13:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:17 INFO - 'NO_EM_RESTART': '1', 13:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:17 INFO - 'PWD': '/builds/slave/test', 13:23:17 INFO - 'SHELL': '/bin/bash', 13:23:17 INFO - 'SHLVL': '1', 13:23:17 INFO - 'TERM': 'linux', 13:23:17 INFO - 'TMOUT': '86400', 13:23:17 INFO - 'USER': 'cltbld', 13:23:17 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1501877348.455069-1832511922', 13:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:17 INFO - '_': '/tools/buildbot/bin/python'} 13:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:18 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)) 13:23:18 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)) 13:23:18 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)) 13:23:18 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)) 13:23:18 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)) 13:23:18 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)) 13:23:18 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)) 13:23:18 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)) 13:23:18 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)) 13:23:18 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:23:18 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 13:23:18 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 13:23:18 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 13:23:18 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 13:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 13:23:19 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)) 13:23:19 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)) 13:23:19 INFO - Installing collected packages: simplejson 13:23:19 INFO - Running setup.py install for simplejson 13:23:19 INFO - building 'simplejson._speedups' extension 13:23:19 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 13:23:20 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 13:23:20 INFO - Successfully installed simplejson 13:23:20 INFO - Cleaning up... 13:23:20 INFO - Return code: 0 13:23:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f17eb0>, '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 0x1f18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f19240>, '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': 'db7e7c15f3ca076d53731445000001ba-1501877348.455069-1832511922', '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 13:23:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:23:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:23:20 INFO - Using env: {'DISPLAY': ':0', 13:23:20 INFO - 'HOME': '/home/cltbld', 13:23:20 INFO - 'LANG': 'en_US.UTF-8', 13:23:20 INFO - 'LANGUAGE': 'en_US:en', 13:23:20 INFO - 'LOGNAME': 'cltbld', 13:23:20 INFO - 'MAIL': '/var/mail/cltbld', 13:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:20 INFO - 'MOZ_NO_REMOTE': '1', 13:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:20 INFO - 'NO_EM_RESTART': '1', 13:23:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:20 INFO - 'PWD': '/builds/slave/test', 13:23:20 INFO - 'SHELL': '/bin/bash', 13:23:20 INFO - 'SHLVL': '1', 13:23:20 INFO - 'TERM': 'linux', 13:23:20 INFO - 'TMOUT': '86400', 13:23:20 INFO - 'USER': 'cltbld', 13:23:20 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1501877348.455069-1832511922', 13:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:20 INFO - '_': '/tools/buildbot/bin/python'} 13:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:23:20 INFO - Cleaning up... 13:23:20 INFO - Return code: 0 13:23:20 INFO - Running post-action listener: _resource_record_post_action 13:23:20 INFO - Running post-action listener: _start_resource_monitoring 13:23:20 INFO - Starting resource monitoring. 13:23:20 INFO - [mozharness: 2017-08-04 20:23:20.597146Z] Finished create-virtualenv step (success) 13:23:20 INFO - [mozharness: 2017-08-04 20:23:20.598233Z] Running install step. 13:23:20 INFO - Running pre-action listener: _resource_record_pre_action 13:23:20 INFO - Running main action method: install 13:23:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:23:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:23:20 INFO - Reading from file tmpfile_stdout 13:23:20 INFO - Detecting whether we're running mozinstall >=1.0... 13:23:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:23:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:23:20 INFO - Reading from file tmpfile_stdout 13:23:20 INFO - Output received: 13:23:20 INFO - Usage: mozinstall [options] installer 13:23:20 INFO - Options: 13:23:20 INFO - -h, --help show this help message and exit 13:23:20 INFO - -d DEST, --destination=DEST 13:23:20 INFO - Directory to install application into. [default: 13:23:20 INFO - "/builds/slave/test"] 13:23:20 INFO - --app=APP Application being installed. [default: firefox] 13:23:20 INFO - mkdir: /builds/slave/test/build/application 13:23:20 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'] 13:23:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:23:38 INFO - Reading from file tmpfile_stdout 13:23:38 INFO - Output received: 13:23:38 INFO - /builds/slave/test/build/application/firefox/firefox 13:23:38 INFO - Running post-action listener: _resource_record_post_action 13:23:38 INFO - [mozharness: 2017-08-04 20:23:38.901613Z] Finished install step (success) 13:23:38 INFO - [mozharness: 2017-08-04 20:23:38.901866Z] Running setup-mitmproxy step. 13:23:38 INFO - Running pre-action listener: _resource_record_pre_action 13:23:38 INFO - Running main action method: setup_mitmproxy 13:23:38 INFO - Skipping: mitmproxy is not required 13:23:38 INFO - Running post-action listener: _resource_record_post_action 13:23:38 INFO - [mozharness: 2017-08-04 20:23:38.903011Z] Finished setup-mitmproxy step (success) 13:23:38 INFO - [mozharness: 2017-08-04 20:23:38.903233Z] Running run-tests step. 13:23:38 INFO - Running pre-action listener: _resource_record_pre_action 13:23:38 INFO - Running pre-action listener: _set_gcov_prefix 13:23:38 INFO - Running main action method: run_tests 13:23:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:23:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:23:38 INFO - Python 2.7.3 13:23:38 INFO - Return code: 0 13:23:38 INFO - grabbing minidump binary from tooltool 13:23: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')]} 13:23:38 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 0x1f17eb0>, '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 0x1f18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f19240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:23:38 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 13:23:38 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 13:23:38 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 13:23:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:23:39 INFO - Return code: 0 13:23:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:23:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:23:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:23:39 INFO - ENV: RUST_BACKTRACE is now 1 13:23:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:23:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:23:39 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/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 13:23:39 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/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 13:23:39 INFO - Using env: {'DISPLAY': ':0', 13:23:39 INFO - 'HOME': '/home/cltbld', 13:23:39 INFO - 'LANG': 'en_US.UTF-8', 13:23:39 INFO - 'LANGUAGE': 'en_US:en', 13:23:39 INFO - 'LOGNAME': 'cltbld', 13:23:39 INFO - 'MAIL': '/var/mail/cltbld', 13:23:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:23:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:23:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:39 INFO - 'MOZ_NO_REMOTE': '1', 13:23:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:23:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:39 INFO - 'NO_EM_RESTART': '1', 13:23:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:39 INFO - 'PWD': '/builds/slave/test', 13:23:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:23:39 INFO - 'RUST_BACKTRACE': '1', 13:23:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:23:39 INFO - 'SHELL': '/bin/bash', 13:23:39 INFO - 'SHLVL': '1', 13:23:39 INFO - 'STYLO_FORCE_ENABLED': '1', 13:23:39 INFO - 'TERM': 'linux', 13:23:39 INFO - 'TMOUT': '86400', 13:23:39 INFO - 'USER': 'cltbld', 13:23:39 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1501877348.455069-1832511922', 13:23:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:39 INFO - '_': '/tools/buildbot/bin/python'} 13:23:39 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/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 13:23:39 INFO - mozversion application_buildid: 20170804193407 13:23:39 INFO - mozversion application_changeset: 4cfb674227051e22bab651e5759f3de503a50560 13:23:39 INFO - mozversion application_display_name: Nightly 13:23:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:23:39 INFO - mozversion application_name: Firefox 13:23:39 INFO - mozversion application_remotingname: firefox 13:23:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:23:39 INFO - mozversion application_vendor: Mozilla 13:23:39 INFO - mozversion application_version: 57.0a1 13:23:39 INFO - mozversion platform_buildid: 20170804193407 13:23:39 INFO - mozversion platform_changeset: 4cfb674227051e22bab651e5759f3de503a50560 13:23:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:23:39 INFO - mozversion platform_version: 57.0a1 13:23:39 INFO - using testdate: 1501878219 13:23:39 INFO - actual date: 1501878219 13:23:39 INFO - starting webserver on 'localhost:48478' 13:23:39 INFO - SUITE-START | Running 2 tests 13:23:39 INFO - TEST-START | dromaeo_css 13:23:39 INFO - Initialising browser for dromaeo_css test... 13:23:39 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48478/getInfo.html -profile /tmp/tmpsVNDQp/profile 13:23:39 INFO - TEST-INFO | started process 3339 (/builds/slave/test/build/application/firefox/firefox http://localhost:48478/getInfo.html) 13:23:47 INFO - TEST-INFO | 3339: exit 0 13:23:47 INFO - Browser initialized. 13:23:47 INFO - Running cycle 1/1 for dromaeo_css test... 13:23:47 INFO - TEST-INFO | started process 3566 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsVNDQp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:23:48 INFO - PID 3566 | 13:23:48 INFO - PID 3566 | (/builds/slave/test/build/application/firefox/firefox:3620): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:23:48 INFO - PID 3566 | 13:23:59 INFO - PID 3566 | RSS: Main: 173248512 13:23:59 INFO - PID 3566 | 13:26:58 INFO - PID 3566 | Cycle 1(1): loaded http://localhost:48478/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48478/tests/dromaeo/cssquery-ext.html) 13:26:59 INFO - PID 3566 | RSS: Main: 175243264 13:26:59 INFO - PID 3566 | 13:30:01 INFO - PID 3566 | Cycle 1(1): loaded http://localhost:48478/tests/dromaeo/cssquery-ext.html (next: http://localhost:48478/tests/dromaeo/cssquery-jquery.html) 13:30:02 INFO - PID 3566 | RSS: Main: 172503040 13:30:02 INFO - PID 3566 | 13:33:04 INFO - PID 3566 | Cycle 1(1): loaded http://localhost:48478/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48478/tests/dromaeo/cssquery-mootools.html) 13:33:04 INFO - PID 3566 | RSS: Main: 174485504 13:33:04 INFO - PID 3566 | 13:36:06 INFO - PID 3566 | Cycle 1(1): loaded http://localhost:48478/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48478/tests/dromaeo/cssquery-prototype.html) 13:36:07 INFO - PID 3566 | RSS: Main: 173416448 13:36:07 INFO - PID 3566 | 13:39:10 INFO - PID 3566 | Cycle 1(1): loaded http://localhost:48478/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48478/tests/dromaeo/cssquery-yui.html) 13:39:11 INFO - PID 3566 | RSS: Main: 176459776 13:39:11 INFO - PID 3566 | 13:42:13 INFO - PID 3566 | Cycle 1(1): loaded http://localhost:48478/tests/dromaeo/cssquery-yui.html (next: http://localhost:48478/tests/dromaeo/cssquery-dojo.html) 13:42:13 INFO - PID 3566 | RSS: Main: 177291264 13:42:13 INFO - PID 3566 | 13:42:13 INFO - PID 3566 | __start_tp_report 13:42:13 INFO - PID 3566 | _x_x_mozilla_page_load 13:42:13 INFO - PID 3566 | _x_x_mozilla_page_load_details 13:42:13 INFO - PID 3566 | |i|pagename|runs| 13:42:13 INFO - PID 3566 | |0;dojo.html;3132.8276944768045;3161.588993430854;3179.7615178861593;3184.5064015077664;3240.384326977874;6095.420935011172;6262.0919966604815;6267.43593076623;6299;6324.083007963848;6109.847253818657;6226.595271307373;6238.84402889928;6240.781572644958;6250.093736408218;5657.830265092054;5666.065099258628;5694.402087780785;5708.400617935119;5710.714464276791;5687.2606561146995;5719.056355701305;5729.140628905677;5734.455226753452;5748.655080695151;5666.886662266752;5675.602707810455;5707.3721890592005;5711.086226203808;5719.28508936383;5698.886022279573;5720.141978703207;5720.599558030939;5726.856828579277;5727.885442291173;5619.269494965669;5657.915131273035;5681.431856814327;5707.14392841073;5791;5891.116332550109;6074.5747797654185;6092.390760923917;6100.206973093469;6216.129741836146;6586.473082153416;6616.603003819786;6636.834079148011;6648.235452922928;6653.600783952978;6673.366030227121;6673.833154171136;6693.531452798306;6697.430718388943;6732.29310922351;6235.127082208494;6277.18396608438;6309.179806625155;6312.779052733178;6327.4938004959495;6886.758963436356;6923.515353925177;6930.688119034656;6992.965035174791;7031.683574239171;6489.772857949949;6565.868682626321;6575.013747937752;6587.50593705474;6590.439812615886;6573.638449885302;6604.273529911706;6671;6692.564983276169;6694.464442844561;6251.718672659741;6641.833954151089;6721.6975236114495;6734.326567343324;6758.864822703518;6713.26154123046;6726.730930762813;6781.25406205317;6793.490488213404;6815.591064536144;5390.865228369322;5485.369182543979;5486.094794358886;5548.195511650788;5554.944450555524;4604.861854144381;4707.529247075265;4714.457837348748;4766.142094422968;4766.523347665206;5903.970480147657;5924.703764811742;5930;5942.346341902387;5947.078202878474;6704.865902681919;6729.293424190488;6732;6830.521863469509;6863.897041544381;5676.205331253628;5871.530277577784;5939.2575928009;5943.8216853493595;5948.494377977834;5927.051671732588;5953.464188223081;5989.041753319448;6001.789937352259;6011.3086994995265;6142.692865356715;6532.118164047888;6532.771353002717;6541.28045914949;6550.868982620416;6707.631080290435;6718.798436046731;6811.284815094542;6823.351781580742;6831.146106736658;6474.514411419256;6485.319041500763;6555.311692272243;6570.342965703391;6583.045458408408;6416.615003099829;6547.083408322744;6567.540272180901;6582.341765823379;6642.5018123641885;6693.364130407604;6743.426808721314;6773.830654233683;6774.153230846145;6775.89836152468;6523.543351965507;6525.249596296487;6536.509761767791;6561.934380656323;6562.573432726857;6405.839854003687;6425.228972523327;6521.576097553644;6548.0832683425315;6573.868522629617;6177.289611694712;6334.809955701337;6342.4291813735135;6430.48556115519;6472.546921715435;6363;6535.281119076993;6583.868322633616;6618.569792963634;6620.3710647488415;6195.101710252078;6310.432061114522;6354.745810167541;6378.872422551616;6408.647524386203 13:42:13 INFO - PID 3566 | |1;ext.html;857.352698712472;883.8099808541162;897.3045889435691;908.5502676175292;1190.3572071081617;32139.19652008698;32807.83596082019;43540.91147721305;44105.55894441055;44259.77870110645;45230.7738461308;45296.32055519162;45416.3187552187;45633.543664563345;45880.3117953231;7426.740064097758;7873.291403773659;8006.359491240716;8029.2773650371455;8050.919490805076;7898.210178982114;8020.959895200545;8022.759317220492;8025.799355016113;8027;7978.880316795253;8046.718364857231;8053.4765240259485;8066.314363279128;8067.475614085095;8014;8042.839143217103;8050.27547520726;8052.194780521931;8054.7180848670305;7884.211578842127;7928.127905930343;7928.603569821544;7962.681492740284;7966;41570.79214603938;41627.58372416267;41743;41837.1632567347;42023.1595368094;3580.838862251179;3601.3157500074904;3602.0994751312173;3610.584782749991;3618.9457158142386;27237.319067023484;27257;27307.317317067034;27354.45291094187;27603.171904842886;5049.747512624354;5050.696958182521;5068.113080210986;5086.720230387327;5088.6946783193125;188392;188731;188815.99999999863;188890;189080;50635.24047139296;50702;50781.492185078416;50855.23717144246;51105.488945110075;53414.73292633512;53799.73100134474;53801;53861.730691347075;54079;16926.06906620148;17275;17304.307827686753;17320.220590073477;17342.826571734375;11563.88436115645;11636.88363116375;13999.720005599831;14194.787078193835;14267.357968891425;15206.16366099853;15234.238288085551;15273.923630381776;15280.541583752283;15350.923245383701;5892.381299963527;6025.638461692312;6031.366706495843;6057.818265452043;6112.821332906864;1010.2019404670375;1017.9796404071877;1027.732789474727;1029.1818004686143;1029.2229366828146;23409;23940.92265848041;24182.274531763724;29157.854210728812;30254.697453025627;1091.372460835023;1108.3405373802575;1110.9888901111046;1120.462178154474;1127.4700890581414;12845.550405735754;12893.93553032229;16385.83614163867;16615.6676866462;16905.15474226284;236307;236569;236732;238068;239050;59568.702156488944;59875.70062149662;59896.70051649801;60011;60287.39712602906;1483.2954346685453;1488.665050363681;1494.9551513454614;1496.0500082447725;1529.2659523428817;27919;28229.576556352084;28692.282692932007;28776.424471510032;29111;39006;39024.80487597544;39061.804690976365;39102;39105.80447097746;213095;213963;214183;214398;214482;34153;40466.39300410437;42710.93222669458;43190.56809431865;43199.56800431955;51265;53049.734751325996;53276.73361633167;53358.199627006405;53386.73306633442;37951.81024094972;38179.23641527209;38307.2338553233;38434.61565384422;38529.2294154121;38413;38472.6152738469;38561.614383855805;38919.22161556697;39214.607853922236;40580.39129413002;41908;42240;42262.57737422586;42547;36657.816710916275;36695.63304366922;37055.814720926224;37082.443763343035;37366;26440.73559264383;26624.733752662225;26682.46635067249;26918.192454226406;26947.86526067357 13:42:13 INFO - PID 3566 | |2;jquery.html;575.2389815992833;576.1530550091364;584.1850618387349;598.8532809461681;601.2004034633932;22390.55218895621;22696.54606907861;23124.42188945275;23133;23205.883970580122;25799.0970316039;27784.861075694644;27805.86097069517;27808.30479238015;27875.72124278762;6736.865262694743;6902.7238910443775;6902.75840345588;6911.205211400678;6912.101426814507;6355.968220158916;6619.867602647944;6621.933780662204;6747.932520674804;6812.489063320246;6587.670616469181;6598.274189839114;6605.966970165143;6611.173603299588;6619.536632435731;6502.057201705727;6515.185601799775;6565.803025909207;6574.474042076647;6575.802725918183;6068.484178844804;6074.3621919698235;6097.512199024111;6097.756089756404;6100.48145907594;27598.5860212097;30402.69597304021;31128.844355778303;31211.37577248465;31323.373532529222;1916.6645836978473;1948.6395016921915;1956.0219890054973;1957.3149397710688;1964.4008577383893;20293.492662683402;20717.89641051785;20757.5848483031;20784.688229676565;20791.376258712262;2417.7944874685672;2472.7156377016513;2505.223380751973;2528.7850532704742;2545.7581529754643;137237.3138134303;140555.99999999898;140616;140792.29603851915;141149;14390.928045359915;15634.218289085728;15660.37358505647;15717.528474145794;15758.448454304043;23921.16275930334;24552;24567.38581535476;24582.631260531107;24896.12863549767;10385.961403859554;10458.581656733646;10659.4137322448;10670.946645266724;10837;9854.063863932915;9984.550695218733;9988.500574971367;10082.59669613222;10117.696469105938;9658.227341812639;9665.420074795395;9696.95151524238;9766.511674416251;10035.34770239932;2890.118513853295;2909.636295463067;2927.2828157101644;2968.495355789521;2973.3161372884356;969.4280374579032;979.8138353712772;989.0850962859327;992.925530585209;994.4828689081637;19680.311189108314;19766.604667906562;19944.800551994584;20063.498412539804;20439.795602044087;1031.83490641497;1035.7876635289747;1048.7797562511805;1053.562771449855;1062.516554967488;11209.607663731731;13049.28228947417;14000.369983350774;14033.649158771112;14053.578392648236;485525;488273;490244;498918;502644;120714.39642801906;121840;123136;126107;126276;1270.866559011309;1284.4797856867983;1310.967225819343;1320.6368248731676;1326;21495.57008859845;21528.461788455414;21854;21855.890720546933;21987.120515179213;56749.71625142013;57726.4227357721;58947;59045;59161.70419148049;69927.30072699208;70026.29973700197;70261;70929.64535177291;71923;14986.250687465801;15323;15406.152661603719;15431.537053888402;15432.84567154314;23811.761882380953;23824.523509529365;24056;24234.15180468675;24300.87849560741;18949.71575426342;19126.521836954187;19128.904355478135;19197.136128874514;19259.51851203731;17208.13959302055;17490.212940417965;17565.385211517536;17836.643267134325;17899.105044747972;19136;19137.425877223704;19260.8073919259;19387.4183774487;19676.704849427555;14986.175760333286;15204.467843625862;15231.771523426936;15233.771493427828;15258.542243732705;18116.27534898589;18628.534286642942;18679;18973.051347432298;19073.904630476758 13:42:13 INFO - PID 3566 | |3;mootools.html;1369.8424681161666;1405.2973513243378;1433.4767809749444;1434.6915413186164;1444.7399468095741;13147.605571832837;13563.796543051862;13693.452261909537;13694.10988285762;13732.382042808073;13885.305734713274;14046.719065618681;14134.929325353385;14167;14183.43266269348;2291.9656205156894;2340.3564019894493;2341.9765802342013;2342.3441436397834;2343.9765602344014;2296.437372843647;2385.8807059647033;2387.152560840894;2388.3551441110976;2388.9522209555885;2279.225063478417;2279.8176145908287;2298.9310320690406;2304.135949019118;2305.2392710405525;2311.884405779713;2317.5133222023396;2338.5206032763244;2351.000824649534;2353.082297903819;2167.0898222746328;2180.8255339572956;2192.8793916334594;2232.1071571371417;2234.832387570939;13434.86565134346;13436.596902092953;13530.526431574946;13537;13558;7319.707211711525;7434.479586428952;7529.585872776995;7554.320111189964;7596.65815038319;4705.670603057787;4888.2178851383605;5026.6983980960895;5031.723255220962;5035.84892453227;1917.9616407671767;1941.6505029094758;1946.4841816918529;2005.809448102428;2008.789077146893;22006.229781957554;22315.888420557792;22544.774552254432;22785.886070569708;22817.31548053561;5943.910841337383;6132.540059495466;6159.353267906895;6275.937240627627;6308.148399966038;15427.074375537504;15548.76676849848;15592.92203538975;15622.453214137451;15664.843351566566;7024.754133605402;7298.270172982766;7305.5981920994855;7310.671019804122;7314.268573142643;6530.673466326664;6572.112764776694;6657.267700552935;6706.899396509057;6760.594364338155;4710.740909250024;4714.66997310185;4756.881077973078;4778.211595086772;4784.952150478521;1323.1201251168059;1355.864413558656;1366.0983750724474;1376.5388594820647;1378.9448422063006;852.6078004118051;879.938404311692;890.8797312362877;891.233539156325;907.3739120007174;7129.607871567114;7142.4286057115305;8098.878516822252;8353.66585336592;8383.496990180609;993.5380048277441;1000.1648623399398;1013.6857574152036;1016.1667432705259;1018.3126389686931;4816.8554943351755;4929.87675308113;5021.4978502150225;5076.111680455905;5153.175491921274;18114.728279075825;18405.263789448272;18792.81207187938;18830;18918.148683309286;18763.624727505372;18814.81185188158;18881.716774248398;19038.238470461303;19043.714344284846;10146.13757830578;10460.320079194827;10528.420936848546;10781.245312828027;10815.837762433412;7800.648970796215;7825.334846538108;8085.353171746128;8274.958625206835;8301.792455188668;16135.515934521984;16468.0942548161;16562.254698538836;16815.91592042032;17122.914385427994;15949.681006379575;16527.256273467483;16586.83413165853;16615.3353865844;16754.497365079067;10916.7270818227;11346.092312615136;11454.770904581696;11468.483918223534;11475.48360323804;12817.743645126859;12881.420336084711;12904.225746455242;12927.806082908575;12934.676633084247;10743.086837618577;10747.516361763895;10871.184661150288;10993.560257589606;11122.221444498808;10268.537915793659;10365.63720269787;10440.112590429899;10476.476176191007;10680.679579612624;8891.333150013645;9078.636854525745;9079.90920090817;9088.04575519561;9093.590788414405;6849.486288528281;6915.377616014583;6916.481263905127;6920.9653951729915;6937.861242775217;6871.896921546081;7010.509264351446;7108.715651373887;7130;7225.1329840419485 13:42:13 INFO - PID 3566 | |4;prototype.html;496.7243180035079;509.28954109017934;529.2881074954187;532.3345817727837;534.3907944942766;6148.231471066117;6175.691215439232;6223.724136552001;6239.188905442286;6321.7155228014735;6013.879722405561;6191.721372538235;6216.129741836146;6221.377862213776;6240.563160578761;5096.770645320951;5109.6678715883445;5127.154019586764;5133.845984620449;5164.870878228036;4784.210605250129;5051.67164134332;5110.872228194287;5121.667091639031;5159.097157997354;4860.7326597037145;4907.926381104268;4941.456439791638;4981.352424184869;4981.875453113683;4883.145449546333;4949.678270912379;4959.975200123977;4988.975055124737;4995.100881841267;4316.935245971313;4467.6597020893605;4483.932741008887;4484.484284307314;4523;5920.881582368328;5927.644341339534;5941.762329506814;5999.6700181490005;6035.581638314992;5610.69141197234;5612.831615051555;5613.494785469286;5616.606837521375;5620.213170156181;6430.742770289183;6517.087607734921;6538.1827271591055;6578.177727784027;6591;4769.308450274725;4786.976065119687;4817.9036419271415;4848.5636292733825;4863.756812159378;6615.9083751181;6764;6793.218779840332;6916.308369163094;7011.298870112999;4916.311716359713;4927.236278376858;4945.653804233669;4946.653734238641;4981.427135879348;4980.526849949249;4983.526564976321;5017.673851199734;5037.949620503748;5039.622028347889;5586.329640443091;5647.124695672177;5657.547396208293;5672.602917795714;5697.658140511582;6598.3401659833635;6654.334566543307;6659.86680266392;6671.966640166768;6689.397954184147;1761.2778760708047;1773.689604319239;1792.4712209898112;1797.128392729525;1798.6672465593906;1171.7949358862165;1201.5193922431097;1213.6662417835166;1223.9020878329711;1239.7024714068739;5779.24869766936;5800.6809625471005;5800.9129863052085;5822.369736473795;5835.5915085944425;6538.346165383424;6542.214934207926;6630.336966303427;6696.5647232929705;6820.658967051628;5760.308762948473;5775;5786.971065144731;5798.333191682926;5854.2096816930025;3524.3479956208184;3588.2644057968055;3604.4773507841214;3615.186583018852;3618.203995121069;6372.553921225563;6458.806235812933;6509.381608747161;6515.7719479818925;6541.149650545399;6795.7961261162245;6896.896346673721;6914.688839002257;6940.154536640054;6967.895481567781;6482.740690372332;6503.772367967098;6536.215654121535;6539.444147247347;6542.672866356663;6725.293844146294;6748.460123190232;6754.628495432602;6800.829979250559;6834.9316506836285;6113.388661133851;6647.634380109141;6685;6700.966495167493;6754.189497260164;6493.642849643315;6514.902276465951;6519.250286217146;6545.410913017851;6560.704768285534;4899.681520701143;5013.548780609763;5027.522385373383;5044.621653376085;5045.142325804695;6428.260750013808;6607.47140228771;6661.233958094881;6671;6714.093597364488;6384.425401713868;6455.903161452488;6458.8685733706825;6507.707153178213;6543.509236807164;6388.968055159695;6429.7428102875365;6466.741330346922;6473;6559.836004099936;6361.8727625448155;6412.294647588668;6418.711157997995;6459;6535.607863528014;6514.3811337922825;6539.967300163468;6549.869002619826;6590.670466476753;6641.804475194512;6241.96879015602;6372.74509019634;6387.329330420239;6417.0107266747455;6463.935360646521 13:42:13 INFO - PID 3566 | |5;yui.html;891.8751374807532;909.5861383070701;917.3395155488046;921.1479381572046;927.4620719982411;18774.718379224305;19828.603427931434;19835.50411239718;19847.10688019039;21649.891750541225;21810.563788724256;22305;22354.88822555885;22408.77591224087;22457.32628021158;1036.5024788101696;1062.3201151263197;1062.9627963021296;1063.8191507443714;1066.9359838409682;1018.3838777539593;1045.5974449836829;1052.8894466081028;1057.2229411382627;1059.2214722179192;1107.545906178463;1109.3066833229232;1110.272771334777;1110.5890820396464;1111.149970272742;1104.8674159100879;1104.9723756906062;1105.8285965675334;1108.4070022537985;1108.844761733358;807.7011505742854;814.9348052155814;816.9754907352789;817.1746535998684;817.2603793566832;19836.305729299405;20255.696164557397;20260.696089558667;20452.69320960172;20515.281965131147;22242.666360004612;22337.10651573935;22503;22813.657795133087;22831.77168228313;16914.915425422794;17198;17381.652366952716;17436.128193590397;17466.91266543659;3609.2240168363664;3619.402798538238;3625.9274814503824;3635.5092062571744;3637.217998130415;124979;133865;135540;136377;138161;16904.746428803577;17495;17881.552961175814;18006.819931800776;18096.819031809515;31433.685663143533;32026.519602205986;32233.194170145463;32348.83825580857;32364;7681.155072941972;7954.880676789853;8374.330053595697;8652.221300083023;9005.324600654845;4225.471816022997;4311.892202694895;4312.611864932172;4335.176316499855;4359.978200108979;5270.367555893241;5294.602904782157;5312.840614781563;5353.304070470814;5364.758585863646;985.4333758089127;987.3582171588381;1010.5907107621279;1011.6712068577742;1014.0974532665933;653.8986457099157;670.6747227594612;677.1400321591551;679.2087218390519;690.9516333856683;12011.459484323226;12607.243565386107;13217.669558260928;13405.932970335281;13454.26001569923;665.4476784269045;708.4509505133562;713.864365770502;721.9061522002106;727.8980942668031;5219.855608276357;5449.455054494519;5470.316210473691;5559.444055594408;5672.319321681424;104010;105968;106184;108923.45538272258;109555.45222273997;91874.54062729777;92057.539712301;92150.07849921416;96823.0317696814;96833;81307;85030;86838.56580717055;88740.11259887448;91307.54346228359;11184.328940263611;11346.978771910568;11388.715282118013;11735.354555499529;11868.821967670665;36776.26447471089;37586.624133759404;37715.81142094382;37992.810035949646;39018;47934;48632.756836215594;48671.75664121657;49955.50044499509;50293.74853125711;16382.180890955166;16847.326106956076;17131.743023854404;17161.74257386165;17385.47843564695;16127.274272657993;16295.918520407322;16410.589735256715;21078.367648970554;21710.565788684453;18735.250589976247;18736.250549978395;18878.15048322856;19245.03774811282;19586.8041319585;19018.619627607648;19471.4158575243;20459.283925063148;20573.79426205719;20793.272235471686;17693.203805829027;18181.09094545294;18205.726914096565;18275.36036238725;18321.175547100145;13080.672983175496;13206.27365494907;13362.933185334012;13765.036447448583;13951.302434878013;14286.28568571588;14856.257187140383;14939;14991.950563460889;15390.769138462709 13:42:13 INFO - PID 3566 | __end_tp_report 13:42:13 INFO - PID 3566 | __start_cc_report 13:42:13 INFO - PID 3566 | _x_x_mozilla_cycle_collect,381 13:42:13 INFO - PID 3566 | __end_cc_report 13:42:13 INFO - PID 3566 | __startTimestamp1501879333760__endTimestamp 13:42:13 INFO - PID 3566 | 13:42:13 INFO - PID 3566 | ------- Summary: start ------- 13:42:13 INFO - PID 3566 | Number of tests: 6 13:42:13 INFO - PID 3566 | 13:42:13 INFO - PID 3566 | [#0] dojo.html Cycles:165 Average:6166.56 Median:6354.75 stddev:717.89 (11.3%) stddev-sans-first:679.50 13:42:13 INFO - PID 3566 | Values: 3132.8 3161.6 3179.8 3184.5 3240.4 6095.4 6262.1 6267.4 6299.0 6324.1 6109.8 6226.6 6238.8 6240.8 6250.1 5657.8 5666.1 5694.4 5708.4 5710.7 5687.3 5719.1 5729.1 5734.5 5748.7 5666.9 5675.6 5707.4 5711.1 5719.3 5698.9 5720.1 5720.6 5726.9 5727.9 5619.3 5657.9 5681.4 5707.1 5791.0 5891.1 6074.6 6092.4 6100.2 6216.1 6586.5 6616.6 6636.8 6648.2 6653.6 6673.4 6673.8 6693.5 6697.4 6732.3 6235.1 6277.2 6309.2 6312.8 6327.5 6886.8 6923.5 6930.7 6993.0 7031.7 6489.8 6565.9 6575.0 6587.5 6590.4 6573.6 6604.3 6671.0 6692.6 6694.5 6251.7 6641.8 6721.7 6734.3 6758.9 6713.3 6726.7 6781.3 6793.5 6815.6 5390.9 5485.4 5486.1 5548.2 5554.9 4604.9 4707.5 4714.5 4766.1 4766.5 5904.0 5924.7 5930.0 5942.3 5947.1 6704.9 6729.3 6732.0 6830.5 6863.9 5676.2 5871.5 5939.3 5943.8 5948.5 5927.1 5953.5 5989.0 6001.8 6011.3 6142.7 6532.1 6532.8 6541.3 6550.9 6707.6 6718.8 6811.3 6823.4 6831.1 6474.5 6485.3 6555.3 6570.3 6583.0 6416.6 6547.1 6567.5 6582.3 6642.5 6693.4 6743.4 6773.8 6774.2 6775.9 6523.5 6525.2 6536.5 6561.9 6562.6 6405.8 6425.2 6521.6 6548.1 6573.9 6177.3 6334.8 6342.4 6430.5 6472.5 6363.0 6535.3 6583.9 6618.6 6620.4 6195.1 6310.4 6354.7 6378.9 6408.6 13:42:13 INFO - PID 3566 | 13:42:13 INFO - PID 3566 | [#1] ext.html Cycles:180 Average:40238.93 Median:38545.42 stddev:55516.84 (144.0%) stddev-sans-first:55593.82 13:42:13 INFO - PID 3566 | Values: 857.4 883.8 897.3 908.6 1190.4 32139.2 32807.8 43540.9 44105.6 44259.8 45230.8 45296.3 45416.3 45633.5 45880.3 7426.7 7873.3 8006.4 8029.3 8050.9 7898.2 8021.0 8022.8 8025.8 8027.0 7978.9 8046.7 8053.5 8066.3 8067.5 8014.0 8042.8 8050.3 8052.2 8054.7 7884.2 7928.1 7928.6 7962.7 7966.0 41570.8 41627.6 41743.0 41837.2 42023.2 3580.8 3601.3 3602.1 3610.6 3618.9 27237.3 27257.0 27307.3 27354.5 27603.2 5049.7 5050.7 5068.1 5086.7 5088.7 188392.0 188731.0 188816.0 188890.0 189080.0 50635.2 50702.0 50781.5 50855.2 51105.5 53414.7 53799.7 53801.0 53861.7 54079.0 16926.1 17275.0 17304.3 17320.2 17342.8 11563.9 11636.9 13999.7 14194.8 14267.4 15206.2 15234.2 15273.9 15280.5 15350.9 5892.4 6025.6 6031.4 6057.8 6112.8 1010.2 1018.0 1027.7 1029.2 1029.2 23409.0 23940.9 24182.3 29157.9 30254.7 1091.4 1108.3 1111.0 1120.5 1127.5 12845.6 12893.9 16385.8 16615.7 16905.2 236307.0 236569.0 236732.0 238068.0 239050.0 59568.7 59875.7 59896.7 60011.0 60287.4 1483.3 1488.7 1495.0 1496.1 1529.3 27919.0 28229.6 28692.3 28776.4 29111.0 39006.0 39024.8 39061.8 39102.0 39105.8 213095.0 213963.0 214183.0 214398.0 214482.0 34153.0 40466.4 42710.9 43190.6 43199.6 51265.0 53049.7 53276.7 53358.2 53386.7 37951.8 38179.2 38307.2 38434.6 38529.2 38413.0 38472.6 38561.6 38919.2 39214.6 40580.4 41908.0 42240.0 42262.6 42547.0 36657.8 36695.6 37055.8 37082.4 37366.0 26440.7 26624.7 26682.5 26918.2 26947.9 13:42:13 INFO - PID 3566 | 13:42:13 INFO - PID 3566 | [#2] jquery.html Cycles:180 Average:35714.02 Median:23128.71 stddev:83246.37 (359.9%) stddev-sans-first:83438.09 13:42:13 INFO - PID 3566 | Values: 575.2 576.2 584.2 598.9 601.2 22390.6 22696.5 23124.4 23133.0 23205.9 25799.1 27784.9 27805.9 27808.3 27875.7 6736.9 6902.7 6902.8 6911.2 6912.1 6356.0 6619.9 6621.9 6747.9 6812.5 6587.7 6598.3 6606.0 6611.2 6619.5 6502.1 6515.2 6565.8 6574.5 6575.8 6068.5 6074.4 6097.5 6097.8 6100.5 27598.6 30402.7 31128.8 31211.4 31323.4 1916.7 1948.6 1956.0 1957.3 1964.4 20293.5 20717.9 20757.6 20784.7 20791.4 2417.8 2472.7 2505.2 2528.8 2545.8 137237.3 140556.0 140616.0 140792.3 141149.0 14390.9 15634.2 15660.4 15717.5 15758.4 23921.2 24552.0 24567.4 24582.6 24896.1 10386.0 10458.6 10659.4 10670.9 10837.0 9854.1 9984.6 9988.5 10082.6 10117.7 9658.2 9665.4 9697.0 9766.5 10035.3 2890.1 2909.6 2927.3 2968.5 2973.3 969.4 979.8 989.1 992.9 994.5 19680.3 19766.6 19944.8 20063.5 20439.8 1031.8 1035.8 1048.8 1053.6 1062.5 11209.6 13049.3 14000.4 14033.6 14053.6 485525.0 488273.0 490244.0 498918.0 502644.0 120714.4 121840.0 123136.0 126107.0 126276.0 1270.9 1284.5 1311.0 1320.6 1326.0 21495.6 21528.5 21854.0 21855.9 21987.1 56749.7 57726.4 58947.0 59045.0 59161.7 69927.3 70026.3 70261.0 70929.6 71923.0 14986.3 15323.0 15406.2 15431.5 15432.8 23811.8 23824.5 24056.0 24234.2 24300.9 18949.7 19126.5 19128.9 19197.1 19259.5 17208.1 17490.2 17565.4 17836.6 17899.1 19136.0 19137.4 19260.8 19387.4 19676.7 14986.2 15204.5 15231.8 15233.8 15258.5 18116.3 18628.5 18679.0 18973.1 19073.9 13:42:13 INFO - PID 3566 | 13:42:13 INFO - PID 3566 | [#3] mootools.html Cycles:180 Average:8479.39 Median:12389.80 stddev:5827.93 (47.0%) stddev-sans-first:5819.80 13:42:13 INFO - PID 3566 | Values: 1369.8 1405.3 1433.5 1434.7 1444.7 13147.6 13563.8 13693.5 13694.1 13732.4 13885.3 14046.7 14134.9 14167.0 14183.4 2292.0 2340.4 2342.0 2342.3 2344.0 2296.4 2385.9 2387.2 2388.4 2389.0 2279.2 2279.8 2298.9 2304.1 2305.2 2311.9 2317.5 2338.5 2351.0 2353.1 2167.1 2180.8 2192.9 2232.1 2234.8 13434.9 13436.6 13530.5 13537.0 13558.0 7319.7 7434.5 7529.6 7554.3 7596.7 4705.7 4888.2 5026.7 5031.7 5035.8 1918.0 1941.7 1946.5 2005.8 2008.8 22006.2 22315.9 22544.8 22785.9 22817.3 5943.9 6132.5 6159.4 6275.9 6308.1 15427.1 15548.8 15592.9 15622.5 15664.8 7024.8 7298.3 7305.6 7310.7 7314.3 6530.7 6572.1 6657.3 6706.9 6760.6 4710.7 4714.7 4756.9 4778.2 4785.0 1323.1 1355.9 1366.1 1376.5 1378.9 852.6 879.9 890.9 891.2 907.4 7129.6 7142.4 8098.9 8353.7 8383.5 993.5 1000.2 1013.7 1016.2 1018.3 4816.9 4929.9 5021.5 5076.1 5153.2 18114.7 18405.3 18792.8 18830.0 18918.1 18763.6 18814.8 18881.7 19038.2 19043.7 10146.1 10460.3 10528.4 10781.2 10815.8 7800.6 7825.3 8085.4 8275.0 8301.8 16135.5 16468.1 16562.3 16815.9 17122.9 15949.7 16527.3 16586.8 16615.3 16754.5 10916.7 11346.1 11454.8 11468.5 11475.5 12817.7 12881.4 12904.2 12927.8 12934.7 10743.1 10747.5 10871.2 10993.6 11122.2 10268.5 10365.6 10440.1 10476.5 10680.7 8891.3 9078.6 9079.9 9088.0 9093.6 6849.5 6915.4 6916.5 6921.0 6937.9 6871.9 7010.5 7108.7 7130.0 7225.1 13:42:13 INFO - PID 3566 | 13:42:13 INFO - PID 3566 | [#4] prototype.html Cycles:180 Average:5500.03 Median:6074.49 stddev:1538.33 (25.3%) stddev-sans-first:1496.10 13:42:13 INFO - PID 3566 | Values: 496.7 509.3 529.3 532.3 534.4 6148.2 6175.7 6223.7 6239.2 6321.7 6013.9 6191.7 6216.1 6221.4 6240.6 5096.8 5109.7 5127.2 5133.8 5164.9 4784.2 5051.7 5110.9 5121.7 5159.1 4860.7 4907.9 4941.5 4981.4 4981.9 4883.1 4949.7 4960.0 4989.0 4995.1 4316.9 4467.7 4483.9 4484.5 4523.0 5920.9 5927.6 5941.8 5999.7 6035.6 5610.7 5612.8 5613.5 5616.6 5620.2 6430.7 6517.1 6538.2 6578.2 6591.0 4769.3 4787.0 4817.9 4848.6 4863.8 6615.9 6764.0 6793.2 6916.3 7011.3 4916.3 4927.2 4945.7 4946.7 4981.4 4980.5 4983.5 5017.7 5037.9 5039.6 5586.3 5647.1 5657.5 5672.6 5697.7 6598.3 6654.3 6659.9 6672.0 6689.4 1761.3 1773.7 1792.5 1797.1 1798.7 1171.8 1201.5 1213.7 1223.9 1239.7 5779.2 5800.7 5800.9 5822.4 5835.6 6538.3 6542.2 6630.3 6696.6 6820.7 5760.3 5775.0 5787.0 5798.3 5854.2 3524.3 3588.3 3604.5 3615.2 3618.2 6372.6 6458.8 6509.4 6515.8 6541.1 6795.8 6896.9 6914.7 6940.2 6967.9 6482.7 6503.8 6536.2 6539.4 6542.7 6725.3 6748.5 6754.6 6800.8 6834.9 6113.4 6647.6 6685.0 6701.0 6754.2 6493.6 6514.9 6519.3 6545.4 6560.7 4899.7 5013.5 5027.5 5044.6 5045.1 6428.3 6607.5 6661.2 6671.0 6714.1 6384.4 6455.9 6458.9 6507.7 6543.5 6389.0 6429.7 6466.7 6473.0 6559.8 6361.9 6412.3 6418.7 6459.0 6535.6 6514.4 6540.0 6549.9 6590.7 6641.8 6242.0 6372.7 6387.3 6417.0 6463.9 13:42:13 INFO - PID 3566 | 13:42:13 INFO - PID 3566 | [#5] yui.html Cycles:180 Average:23365.80 Median:20455.99 stddev:31687.99 (154.9%) stddev-sans-first:31731.95 13:42:13 INFO - PID 3566 | Values: 891.9 909.6 917.3 921.1 927.5 18774.7 19828.6 19835.5 19847.1 21649.9 21810.6 22305.0 22354.9 22408.8 22457.3 1036.5 1062.3 1063.0 1063.8 1066.9 1018.4 1045.6 1052.9 1057.2 1059.2 1107.5 1109.3 1110.3 1110.6 1111.1 1104.9 1105.0 1105.8 1108.4 1108.8 807.7 814.9 817.0 817.2 817.3 19836.3 20255.7 20260.7 20452.7 20515.3 22242.7 22337.1 22503.0 22813.7 22831.8 16914.9 17198.0 17381.7 17436.1 17466.9 3609.2 3619.4 3625.9 3635.5 3637.2 124979.0 133865.0 135540.0 136377.0 138161.0 16904.7 17495.0 17881.6 18006.8 18096.8 31433.7 32026.5 32233.2 32348.8 32364.0 7681.2 7954.9 8374.3 8652.2 9005.3 4225.5 4311.9 4312.6 4335.2 4360.0 5270.4 5294.6 5312.8 5353.3 5364.8 985.4 987.4 1010.6 1011.7 1014.1 653.9 670.7 677.1 679.2 691.0 12011.5 12607.2 13217.7 13405.9 13454.3 665.4 708.5 713.9 721.9 727.9 5219.9 5449.5 5470.3 5559.4 5672.3 104010.0 105968.0 106184.0 108923.5 109555.5 91874.5 92057.5 92150.1 96823.0 96833.0 81307.0 85030.0 86838.6 88740.1 91307.5 11184.3 11347.0 11388.7 11735.4 11868.8 36776.3 37586.6 37715.8 37992.8 39018.0 47934.0 48632.8 48671.8 49955.5 50293.7 16382.2 16847.3 17131.7 17161.7 17385.5 16127.3 16295.9 16410.6 21078.4 21710.6 18735.3 18736.3 18878.2 19245.0 19586.8 19018.6 19471.4 20459.3 20573.8 20793.3 17693.2 18181.1 18205.7 18275.4 18321.2 13080.7 13206.3 13362.9 13765.0 13951.3 14286.3 14856.3 14939.0 14992.0 15390.8 13:42:13 INFO - PID 3566 | -------- Summary: end -------- 13:42:13 INFO - PID 3566 | 13:42:14 INFO - TEST-INFO | 3566: exit 0 13:42:14 INFO - TEST-OK | dromaeo_css | took 1115047ms 13:42:14 INFO - TEST-START | kraken 13:42:14 INFO - Initialising browser for kraken test... 13:42:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48478/getInfo.html -profile /tmp/tmpqmR7ug/profile 13:42:14 INFO - TEST-INFO | started process 3942 (/builds/slave/test/build/application/firefox/firefox http://localhost:48478/getInfo.html) 13:42:19 INFO - TEST-INFO | 3942: exit 0 13:42:19 INFO - Browser initialized. 13:42:19 INFO - Running cycle 1/1 for kraken test... 13:42:19 INFO - TEST-INFO | started process 4167 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqmR7ug/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:42:20 INFO - PID 4167 | 13:42:20 INFO - PID 4167 | (/builds/slave/test/build/application/firefox/firefox:4221): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:42:20 INFO - PID 4167 | 13:42:31 INFO - PID 4167 | RSS: Main: 173662208 13:42:31 INFO - PID 4167 | 13:42:33 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:48478/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48478/tests/kraken/driver.html?testName=audio-beat-detection) 13:42:34 INFO - PID 4167 | RSS: Main: 178565120 13:42:34 INFO - PID 4167 | 13:42:37 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:48478/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48478/tests/kraken/driver.html?testName=audio-dft) 13:42:38 INFO - PID 4167 | RSS: Main: 179052544 13:42:38 INFO - PID 4167 | 13:42:41 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:48478/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48478/tests/kraken/driver.html?testName=audio-fft) 13:42:41 INFO - PID 4167 | RSS: Main: 173838336 13:42:41 INFO - PID 4167 | 13:42:44 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:48478/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48478/tests/kraken/driver.html?testName=audio-oscillator) 13:42:44 INFO - PID 4167 | RSS: Main: 174206976 13:42:44 INFO - PID 4167 | 13:42:47 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:48478/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48478/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:42:47 INFO - PID 4167 | RSS: Main: 175153152 13:42:47 INFO - PID 4167 | 13:42:50 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:48478/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48478/tests/kraken/driver.html?testName=imaging-darkroom) 13:42:51 INFO - PID 4167 | RSS: Main: 177033216 13:42:51 INFO - PID 4167 | 13:42:55 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:48478/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48478/tests/kraken/driver.html?testName=imaging-desaturate) 13:42:55 INFO - PID 4167 | RSS: Main: 176279552 13:42:55 INFO - PID 4167 | 13:42:58 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:48478/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48478/tests/kraken/driver.html?testName=json-parse-financial) 13:42:59 INFO - PID 4167 | RSS: Main: 177422336 13:42:59 INFO - PID 4167 | 13:43:00 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:48478/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48478/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:43:01 INFO - PID 4167 | RSS: Main: 177381376 13:43:01 INFO - PID 4167 | 13:43:03 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:48478/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48478/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:43:04 INFO - PID 4167 | RSS: Main: 174657536 13:43:04 INFO - PID 4167 | 13:43:06 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:48478/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48478/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:43:06 INFO - PID 4167 | RSS: Main: 174653440 13:43:06 INFO - PID 4167 | 13:43:09 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:48478/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48478/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:43:10 INFO - PID 4167 | RSS: Main: 175067136 13:43:10 INFO - PID 4167 | 13:43:13 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:48478/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48478/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:43:14 INFO - PID 4167 | RSS: Main: 175190016 13:43:14 INFO - PID 4167 | 13:43:16 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:48478/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48478/tests/kraken/driver.html?testName=ai-astar) 13:43:16 INFO - PID 4167 | RSS: Main: 176590848 13:43:16 INFO - PID 4167 | 13:43:16 INFO - PID 4167 | __start_tp_report 13:43:16 INFO - PID 4167 | _x_x_mozilla_page_load 13:43:16 INFO - PID 4167 | _x_x_mozilla_page_load_details 13:43:16 INFO - PID 4167 | |i|pagename|runs| 13:43:16 INFO - PID 4167 | |0;ai-astar;99;117;100;112;115;107;108;100;108;108 13:43:16 INFO - PID 4167 | |1;audio-beat-detection;153;122;143;176;125;150;150;120;172;120 13:43:16 INFO - PID 4167 | |2;audio-dft;163;163;163;161;163;176;166;164;170;164 13:43:16 INFO - PID 4167 | |3;audio-fft;76;76;80;171;78;75;89;75;156;76 13:43:16 INFO - PID 4167 | |4;audio-oscillator;78;85;137;79;81;78;138;79;79;137 13:43:16 INFO - PID 4167 | |5;imaging-gaussian-blur;114;114;115;121;122;114;118;119;119;114 13:43:16 INFO - PID 4167 | |6;imaging-darkroom;152;161;150;155;151;154;152;152;150;152 13:43:16 INFO - PID 4167 | |7;imaging-desaturate;94;94;94;94;94;99;96;100;94;94 13:43:16 INFO - PID 4167 | |8;json-parse-financial;56;64;60;61;56;57;58;54;56;59 13:43:16 INFO - PID 4167 | |9;json-stringify-tinderbox;54;61;54;54;54;53;54;60;55;54 13:43:16 INFO - PID 4167 | |10;stanford-crypto-aes;79;98;77;80;85;88;77;78;79;94 13:43:16 INFO - PID 4167 | |11;stanford-crypto-ccm;127;134;125;146;129;124;135;138;125;173 13:43:16 INFO - PID 4167 | |12;stanford-crypto-pbkdf2;174;170;175;179;178;172;171;176;177;184 13:43:16 INFO - PID 4167 | |13;stanford-crypto-sha256-iterative;67;67;66;65;63;64;71;67;63;64 13:43:16 INFO - PID 4167 | __end_tp_report 13:43:16 INFO - PID 4167 | __start_cc_report 13:43:16 INFO - PID 4167 | _x_x_mozilla_cycle_collect,958 13:43:16 INFO - PID 4167 | __end_cc_report 13:43:16 INFO - PID 4167 | __startTimestamp1501879396291__endTimestamp 13:43:16 INFO - PID 4167 | 13:43:16 INFO - PID 4167 | ------- Summary: start ------- 13:43:16 INFO - PID 4167 | Number of tests: 14 13:43:16 INFO - PID 4167 | 13:43:16 INFO - PID 4167 | [#0] ai-astar Cycles:10 Average:107.40 Median:110.00 stddev:6.26 (5.7%) stddev-sans-first:5.85 13:43:16 INFO - PID 4167 | Values: 99.0 117.0 100.0 112.0 115.0 107.0 108.0 100.0 108.0 108.0 13:43:16 INFO - PID 4167 | 13:43:16 INFO - PID 4167 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:150.00 stddev:20.95 (14.0%) stddev-sans-first:21.91 13:43:16 INFO - PID 4167 | Values: 153.0 122.0 143.0 176.0 125.0 150.0 150.0 120.0 172.0 120.0 13:43:16 INFO - PID 4167 | 13:43:16 INFO - PID 4167 | [#2] audio-dft Cycles:10 Average:165.30 Median:164.00 stddev:4.47 (2.7%) stddev-sans-first:4.67 13:43:16 INFO - PID 4167 | Values: 163.0 163.0 163.0 161.0 163.0 176.0 166.0 164.0 170.0 164.0 13:43:16 INFO - PID 4167 | 13:43:16 INFO - PID 4167 | [#3] audio-fft Cycles:10 Average:95.20 Median:76.00 stddev:36.41 (47.9%) stddev-sans-first:37.95 13:43:16 INFO - PID 4167 | Values: 76.0 76.0 80.0 171.0 78.0 75.0 89.0 75.0 156.0 76.0 13:43:16 INFO - PID 4167 | 13:43:16 INFO - PID 4167 | [#4] audio-oscillator Cycles:10 Average:97.10 Median:79.00 stddev:27.84 (35.2%) stddev-sans-first:28.66 13:43:16 INFO - PID 4167 | Values: 78.0 85.0 137.0 79.0 81.0 78.0 138.0 79.0 79.0 137.0 13:43:16 INFO - PID 4167 | 13:43:16 INFO - PID 4167 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:118.50 stddev:3.16 (2.7%) stddev-sans-first:3.16 13:43:16 INFO - PID 4167 | Values: 114.0 114.0 115.0 121.0 122.0 114.0 118.0 119.0 119.0 114.0 13:43:16 INFO - PID 4167 | 13:43:16 INFO - PID 4167 | [#6] imaging-darkroom Cycles:10 Average:152.90 Median:152.00 stddev:3.25 (2.1%) stddev-sans-first:3.43 13:43:16 INFO - PID 4167 | Values: 152.0 161.0 150.0 155.0 151.0 154.0 152.0 152.0 150.0 152.0 13:43:16 INFO - PID 4167 | 13:43:16 INFO - PID 4167 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:94.00 stddev:2.31 (2.5%) stddev-sans-first:2.40 13:43:16 INFO - PID 4167 | Values: 94.0 94.0 94.0 94.0 94.0 99.0 96.0 100.0 94.0 94.0 13:43:16 INFO - PID 4167 | 13:43:16 INFO - PID 4167 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.50 stddev:2.96 (5.1%) stddev-sans-first:3.04 13:43:16 INFO - PID 4167 | Values: 56.0 64.0 60.0 61.0 56.0 57.0 58.0 54.0 56.0 59.0 13:43:16 INFO - PID 4167 | 13:43:16 INFO - PID 4167 | [#9] json-stringify-tinderbox Cycles:10 Average:55.30 Median:54.00 stddev:2.79 (5.2%) stddev-sans-first:2.92 13:43:16 INFO - PID 4167 | Values: 54.0 61.0 54.0 54.0 54.0 53.0 54.0 60.0 55.0 54.0 13:43:16 INFO - PID 4167 | 13:43:16 INFO - PID 4167 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:82.50 stddev:7.53 (9.1%) stddev-sans-first:7.81 13:43:16 INFO - PID 4167 | Values: 79.0 98.0 77.0 80.0 85.0 88.0 77.0 78.0 79.0 94.0 13:43:16 INFO - PID 4167 | 13:43:16 INFO - PID 4167 | [#11] stanford-crypto-ccm Cycles:10 Average:135.60 Median:134.50 stddev:14.88 (11.1%) stddev-sans-first:15.45 13:43:16 INFO - PID 4167 | Values: 127.0 134.0 125.0 146.0 129.0 124.0 135.0 138.0 125.0 173.0 13:43:16 INFO - PID 4167 | 13:43:16 INFO - PID 4167 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.60 Median:176.50 stddev:4.20 (2.4%) stddev-sans-first:4.41 13:43:16 INFO - PID 4167 | Values: 174.0 170.0 175.0 179.0 178.0 172.0 171.0 176.0 177.0 184.0 13:43:16 INFO - PID 4167 | 13:43:16 INFO - PID 4167 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.50 stddev:2.45 (3.7%) stddev-sans-first:2.55 13:43:16 INFO - PID 4167 | Values: 67.0 67.0 66.0 65.0 63.0 64.0 71.0 67.0 63.0 64.0 13:43:16 INFO - PID 4167 | -------- Summary: end -------- 13:43:16 INFO - PID 4167 | 13:43:16 INFO - PID 4167 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 13:43:17 INFO - TEST-INFO | 4167: exit 0 13:43:17 INFO - TEST-OK | kraken | took 62692ms 13:43:17 INFO - SUITE-END | took 1177s 13:43:17 INFO - Completed test suite (00:19:38) 13:43:17 INFO - javascript benchmark 13:43:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8591.279534115543, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3132.8276944768045, 3161.588993430854, 3179.7615178861593, 3184.5064015077664, 3240.384326977874, 6095.420935011172, 6262.0919966604815, 6267.43593076623, 6299.0, 6324.083007963848, 6109.847253818657, 6226.595271307373, 6238.84402889928, 6240.781572644958, 6250.093736408218, 5657.830265092054, 5666.065099258628, 5694.402087780785, 5708.400617935119, 5710.714464276791, 5687.2606561146995, 5719.056355701305, 5729.140628905677, 5734.455226753452, 5748.655080695151, 5666.886662266752, 5675.602707810455, 5707.3721890592005, 5711.086226203808, 5719.28508936383, 5698.886022279573, 5720.141978703207, 5720.599558030939, 5726.856828579277, 5727.885442291173, 5619.269494965669, 5657.915131273035, 5681.431856814327, 5707.14392841073, 5791.0, 5891.116332550109, 6074.5747797654185, 6092.390760923917, 6100.206973093469, 6216.129741836146, 6586.473082153416, 6616.603003819786, 6636.834079148011, 6648.235452922928, 6653.600783952978, 6673.366030227121, 6673.833154171136, 6693.531452798306, 6697.430718388943, 6732.29310922351, 6235.127082208494, 6277.18396608438, 6309.179806625155, 6312.779052733178, 6327.4938004959495, 6886.758963436356, 6923.515353925177, 6930.688119034656, 6992.965035174791, 7031.683574239171, 6489.772857949949, 6565.868682626321, 6575.013747937752, 6587.50593705474, 6590.439812615886, 6573.638449885302, 6604.273529911706, 6671.0, 6692.564983276169, 6694.464442844561, 6251.718672659741, 6641.833954151089, 6721.6975236114495, 6734.326567343324, 6758.864822703518, 6713.26154123046, 6726.730930762813, 6781.25406205317, 6793.490488213404, 6815.591064536144, 5390.865228369322, 5485.369182543979, 5486.094794358886, 5548.195511650788, 5554.944450555524, 4604.861854144381, 4707.529247075265, 4714.457837348748, 4766.142094422968, 4766.523347665206, 5903.970480147657, 5924.703764811742, 5930.0, 5942.346341902387, 5947.078202878474, 6704.865902681919, 6729.293424190488, 6732.0, 6830.521863469509, 6863.897041544381, 5676.205331253628, 5871.530277577784, 5939.2575928009, 5943.8216853493595, 5948.494377977834, 5927.051671732588, 5953.464188223081, 5989.041753319448, 6001.789937352259, 6011.3086994995265, 6142.692865356715, 6532.118164047888, 6532.771353002717, 6541.28045914949, 6550.868982620416, 6707.631080290435, 6718.798436046731, 6811.284815094542, 6823.351781580742, 6831.146106736658, 6474.514411419256, 6485.319041500763, 6555.311692272243, 6570.342965703391, 6583.045458408408, 6416.615003099829, 6547.083408322744, 6567.540272180901, 6582.341765823379, 6642.5018123641885, 6693.364130407604, 6743.426808721314, 6773.830654233683, 6774.153230846145, 6775.89836152468, 6523.543351965507, 6525.249596296487, 6536.509761767791, 6561.934380656323, 6562.573432726857, 6405.839854003687, 6425.228972523327, 6521.576097553644, 6548.0832683425315, 6573.868522629617, 6177.289611694712, 6334.809955701337, 6342.4291813735135, 6430.48556115519, 6472.546921715435, 6363.0, 6535.281119076993, 6583.868322633616, 6618.569792963634, 6620.3710647488415, 6195.101710252078, 6310.432061114522, 6354.745810167541, 6378.872422551616, 6408.647524386203], "value": 6113.617315060341, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [857.352698712472, 883.8099808541162, 897.3045889435691, 908.5502676175292, 1190.3572071081617, 32139.19652008698, 32807.83596082019, 43540.91147721305, 44105.55894441055, 44259.77870110645, 45230.7738461308, 45296.32055519162, 45416.3187552187, 45633.543664563345, 45880.3117953231, 7426.740064097758, 7873.291403773659, 8006.359491240716, 8029.2773650371455, 8050.919490805076, 7898.210178982114, 8020.959895200545, 8022.759317220492, 8025.799355016113, 8027.0, 7978.880316795253, 8046.718364857231, 8053.4765240259485, 8066.314363279128, 8067.475614085095, 8014.0, 8042.839143217103, 8050.27547520726, 8052.194780521931, 8054.7180848670305, 7884.211578842127, 7928.127905930343, 7928.603569821544, 7962.681492740284, 7966.0, 41570.79214603938, 41627.58372416267, 41743.0, 41837.1632567347, 42023.1595368094, 3580.838862251179, 3601.3157500074904, 3602.0994751312173, 3610.584782749991, 3618.9457158142386, 27237.319067023484, 27257.0, 27307.317317067034, 27354.45291094187, 27603.171904842886, 5049.747512624354, 5050.696958182521, 5068.113080210986, 5086.720230387327, 5088.6946783193125, 188392.0, 188731.0, 188815.99999999863, 188890.0, 189080.0, 50635.24047139296, 50702.0, 50781.492185078416, 50855.23717144246, 51105.488945110075, 53414.73292633512, 53799.73100134474, 53801.0, 53861.730691347075, 54079.0, 16926.06906620148, 17275.0, 17304.307827686753, 17320.220590073477, 17342.826571734375, 11563.88436115645, 11636.88363116375, 13999.720005599831, 14194.787078193835, 14267.357968891425, 15206.16366099853, 15234.238288085551, 15273.923630381776, 15280.541583752283, 15350.923245383701, 5892.381299963527, 6025.638461692312, 6031.366706495843, 6057.818265452043, 6112.821332906864, 1010.2019404670375, 1017.9796404071877, 1027.732789474727, 1029.1818004686143, 1029.2229366828146, 23409.0, 23940.92265848041, 24182.274531763724, 29157.854210728812, 30254.697453025627, 1091.372460835023, 1108.3405373802575, 1110.9888901111046, 1120.462178154474, 1127.4700890581414, 12845.550405735754, 12893.93553032229, 16385.83614163867, 16615.6676866462, 16905.15474226284, 236307.0, 236569.0, 236732.0, 238068.0, 239050.0, 59568.702156488944, 59875.70062149662, 59896.70051649801, 60011.0, 60287.39712602906, 1483.2954346685453, 1488.665050363681, 1494.9551513454614, 1496.0500082447725, 1529.2659523428817, 27919.0, 28229.576556352084, 28692.282692932007, 28776.424471510032, 29111.0, 39006.0, 39024.80487597544, 39061.804690976365, 39102.0, 39105.80447097746, 213095.0, 213963.0, 214183.0, 214398.0, 214482.0, 34153.0, 40466.39300410437, 42710.93222669458, 43190.56809431865, 43199.56800431955, 51265.0, 53049.734751325996, 53276.73361633167, 53358.199627006405, 53386.73306633442, 37951.81024094972, 38179.23641527209, 38307.2338553233, 38434.61565384422, 38529.2294154121, 38413.0, 38472.6152738469, 38561.614383855805, 38919.22161556697, 39214.607853922236, 40580.39129413002, 41908.0, 42240.0, 42262.57737422586, 42547.0, 36657.816710916275, 36695.63304366922, 37055.814720926224, 37082.443763343035, 37366.0, 26440.73559264383, 26624.733752662225, 26682.46635067249, 26918.192454226406, 26947.86526067357], "value": 18446.191995566314, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.2389815992833, 576.1530550091364, 584.1850618387349, 598.8532809461681, 601.2004034633932, 22390.55218895621, 22696.54606907861, 23124.42188945275, 23133.0, 23205.883970580122, 25799.0970316039, 27784.861075694644, 27805.86097069517, 27808.30479238015, 27875.72124278762, 6736.865262694743, 6902.7238910443775, 6902.75840345588, 6911.205211400678, 6912.101426814507, 6355.968220158916, 6619.867602647944, 6621.933780662204, 6747.932520674804, 6812.489063320246, 6587.670616469181, 6598.274189839114, 6605.966970165143, 6611.173603299588, 6619.536632435731, 6502.057201705727, 6515.185601799775, 6565.803025909207, 6574.474042076647, 6575.802725918183, 6068.484178844804, 6074.3621919698235, 6097.512199024111, 6097.756089756404, 6100.48145907594, 27598.5860212097, 30402.69597304021, 31128.844355778303, 31211.37577248465, 31323.373532529222, 1916.6645836978473, 1948.6395016921915, 1956.0219890054973, 1957.3149397710688, 1964.4008577383893, 20293.492662683402, 20717.89641051785, 20757.5848483031, 20784.688229676565, 20791.376258712262, 2417.7944874685672, 2472.7156377016513, 2505.223380751973, 2528.7850532704742, 2545.7581529754643, 137237.3138134303, 140555.99999999898, 140616.0, 140792.29603851915, 141149.0, 14390.928045359915, 15634.218289085728, 15660.37358505647, 15717.528474145794, 15758.448454304043, 23921.16275930334, 24552.0, 24567.38581535476, 24582.631260531107, 24896.12863549767, 10385.961403859554, 10458.581656733646, 10659.4137322448, 10670.946645266724, 10837.0, 9854.063863932915, 9984.550695218733, 9988.500574971367, 10082.59669613222, 10117.696469105938, 9658.227341812639, 9665.420074795395, 9696.95151524238, 9766.511674416251, 10035.34770239932, 2890.118513853295, 2909.636295463067, 2927.2828157101644, 2968.495355789521, 2973.3161372884356, 969.4280374579032, 979.8138353712772, 989.0850962859327, 992.925530585209, 994.4828689081637, 19680.311189108314, 19766.604667906562, 19944.800551994584, 20063.498412539804, 20439.795602044087, 1031.83490641497, 1035.7876635289747, 1048.7797562511805, 1053.562771449855, 1062.516554967488, 11209.607663731731, 13049.28228947417, 14000.369983350774, 14033.649158771112, 14053.578392648236, 485525.0, 488273.0, 490244.0, 498918.0, 502644.0, 120714.39642801906, 121840.0, 123136.0, 126107.0, 126276.0, 1270.866559011309, 1284.4797856867983, 1310.967225819343, 1320.6368248731676, 1326.0, 21495.57008859845, 21528.461788455414, 21854.0, 21855.890720546933, 21987.120515179213, 56749.71625142013, 57726.4227357721, 58947.0, 59045.0, 59161.70419148049, 69927.30072699208, 70026.29973700197, 70261.0, 70929.64535177291, 71923.0, 14986.250687465801, 15323.0, 15406.152661603719, 15431.537053888402, 15432.84567154314, 23811.761882380953, 23824.523509529365, 24056.0, 24234.15180468675, 24300.87849560741, 18949.71575426342, 19126.521836954187, 19128.904355478135, 19197.136128874514, 19259.51851203731, 17208.13959302055, 17490.212940417965, 17565.385211517536, 17836.643267134325, 17899.105044747972, 19136.0, 19137.425877223704, 19260.8073919259, 19387.4183774487, 19676.704849427555, 14986.175760333286, 15204.467843625862, 15231.771523426936, 15233.771493427828, 15258.542243732705, 18116.27534898589, 18628.534286642942, 18679.0, 18973.051347432298, 19073.904630476758], "value": 12476.699455104554, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1369.8424681161666, 1405.2973513243378, 1433.4767809749444, 1434.6915413186164, 1444.7399468095741, 13147.605571832837, 13563.796543051862, 13693.452261909537, 13694.10988285762, 13732.382042808073, 13885.305734713274, 14046.719065618681, 14134.929325353385, 14167.0, 14183.43266269348, 2291.9656205156894, 2340.3564019894493, 2341.9765802342013, 2342.3441436397834, 2343.9765602344014, 2296.437372843647, 2385.8807059647033, 2387.152560840894, 2388.3551441110976, 2388.9522209555885, 2279.225063478417, 2279.8176145908287, 2298.9310320690406, 2304.135949019118, 2305.2392710405525, 2311.884405779713, 2317.5133222023396, 2338.5206032763244, 2351.000824649534, 2353.082297903819, 2167.0898222746328, 2180.8255339572956, 2192.8793916334594, 2232.1071571371417, 2234.832387570939, 13434.86565134346, 13436.596902092953, 13530.526431574946, 13537.0, 13558.0, 7319.707211711525, 7434.479586428952, 7529.585872776995, 7554.320111189964, 7596.65815038319, 4705.670603057787, 4888.2178851383605, 5026.6983980960895, 5031.723255220962, 5035.84892453227, 1917.9616407671767, 1941.6505029094758, 1946.4841816918529, 2005.809448102428, 2008.789077146893, 22006.229781957554, 22315.888420557792, 22544.774552254432, 22785.886070569708, 22817.31548053561, 5943.910841337383, 6132.540059495466, 6159.353267906895, 6275.937240627627, 6308.148399966038, 15427.074375537504, 15548.76676849848, 15592.92203538975, 15622.453214137451, 15664.843351566566, 7024.754133605402, 7298.270172982766, 7305.5981920994855, 7310.671019804122, 7314.268573142643, 6530.673466326664, 6572.112764776694, 6657.267700552935, 6706.899396509057, 6760.594364338155, 4710.740909250024, 4714.66997310185, 4756.881077973078, 4778.211595086772, 4784.952150478521, 1323.1201251168059, 1355.864413558656, 1366.0983750724474, 1376.5388594820647, 1378.9448422063006, 852.6078004118051, 879.938404311692, 890.8797312362877, 891.233539156325, 907.3739120007174, 7129.607871567114, 7142.4286057115305, 8098.878516822252, 8353.66585336592, 8383.496990180609, 993.5380048277441, 1000.1648623399398, 1013.6857574152036, 1016.1667432705259, 1018.3126389686931, 4816.8554943351755, 4929.87675308113, 5021.4978502150225, 5076.111680455905, 5153.175491921274, 18114.728279075825, 18405.263789448272, 18792.81207187938, 18830.0, 18918.148683309286, 18763.624727505372, 18814.81185188158, 18881.716774248398, 19038.238470461303, 19043.714344284846, 10146.13757830578, 10460.320079194827, 10528.420936848546, 10781.245312828027, 10815.837762433412, 7800.648970796215, 7825.334846538108, 8085.353171746128, 8274.958625206835, 8301.792455188668, 16135.515934521984, 16468.0942548161, 16562.254698538836, 16815.91592042032, 17122.914385427994, 15949.681006379575, 16527.256273467483, 16586.83413165853, 16615.3353865844, 16754.497365079067, 10916.7270818227, 11346.092312615136, 11454.770904581696, 11468.483918223534, 11475.48360323804, 12817.743645126859, 12881.420336084711, 12904.225746455242, 12927.806082908575, 12934.676633084247, 10743.086837618577, 10747.516361763895, 10871.184661150288, 10993.560257589606, 11122.221444498808, 10268.537915793659, 10365.63720269787, 10440.112590429899, 10476.476176191007, 10680.679579612624, 8891.333150013645, 9078.636854525745, 9079.90920090817, 9088.04575519561, 9093.590788414405, 6849.486288528281, 6915.377616014583, 6916.481263905127, 6920.9653951729915, 6937.861242775217, 6871.896921546081, 7010.509264351446, 7108.715651373887, 7130.0, 7225.1329840419485], "value": 6145.7518935154485, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.7243180035079, 509.28954109017934, 529.2881074954187, 532.3345817727837, 534.3907944942766, 6148.231471066117, 6175.691215439232, 6223.724136552001, 6239.188905442286, 6321.7155228014735, 6013.879722405561, 6191.721372538235, 6216.129741836146, 6221.377862213776, 6240.563160578761, 5096.770645320951, 5109.6678715883445, 5127.154019586764, 5133.845984620449, 5164.870878228036, 4784.210605250129, 5051.67164134332, 5110.872228194287, 5121.667091639031, 5159.097157997354, 4860.7326597037145, 4907.926381104268, 4941.456439791638, 4981.352424184869, 4981.875453113683, 4883.145449546333, 4949.678270912379, 4959.975200123977, 4988.975055124737, 4995.100881841267, 4316.935245971313, 4467.6597020893605, 4483.932741008887, 4484.484284307314, 4523.0, 5920.881582368328, 5927.644341339534, 5941.762329506814, 5999.6700181490005, 6035.581638314992, 5610.69141197234, 5612.831615051555, 5613.494785469286, 5616.606837521375, 5620.213170156181, 6430.742770289183, 6517.087607734921, 6538.1827271591055, 6578.177727784027, 6591.0, 4769.308450274725, 4786.976065119687, 4817.9036419271415, 4848.5636292733825, 4863.756812159378, 6615.9083751181, 6764.0, 6793.218779840332, 6916.308369163094, 7011.298870112999, 4916.311716359713, 4927.236278376858, 4945.653804233669, 4946.653734238641, 4981.427135879348, 4980.526849949249, 4983.526564976321, 5017.673851199734, 5037.949620503748, 5039.622028347889, 5586.329640443091, 5647.124695672177, 5657.547396208293, 5672.602917795714, 5697.658140511582, 6598.3401659833635, 6654.334566543307, 6659.86680266392, 6671.966640166768, 6689.397954184147, 1761.2778760708047, 1773.689604319239, 1792.4712209898112, 1797.128392729525, 1798.6672465593906, 1171.7949358862165, 1201.5193922431097, 1213.6662417835166, 1223.9020878329711, 1239.7024714068739, 5779.24869766936, 5800.6809625471005, 5800.9129863052085, 5822.369736473795, 5835.5915085944425, 6538.346165383424, 6542.214934207926, 6630.336966303427, 6696.5647232929705, 6820.658967051628, 5760.308762948473, 5775.0, 5786.971065144731, 5798.333191682926, 5854.2096816930025, 3524.3479956208184, 3588.2644057968055, 3604.4773507841214, 3615.186583018852, 3618.203995121069, 6372.553921225563, 6458.806235812933, 6509.381608747161, 6515.7719479818925, 6541.149650545399, 6795.7961261162245, 6896.896346673721, 6914.688839002257, 6940.154536640054, 6967.895481567781, 6482.740690372332, 6503.772367967098, 6536.215654121535, 6539.444147247347, 6542.672866356663, 6725.293844146294, 6748.460123190232, 6754.628495432602, 6800.829979250559, 6834.9316506836285, 6113.388661133851, 6647.634380109141, 6685.0, 6700.966495167493, 6754.189497260164, 6493.642849643315, 6514.902276465951, 6519.250286217146, 6545.410913017851, 6560.704768285534, 4899.681520701143, 5013.548780609763, 5027.522385373383, 5044.621653376085, 5045.142325804695, 6428.260750013808, 6607.47140228771, 6661.233958094881, 6671.0, 6714.093597364488, 6384.425401713868, 6455.903161452488, 6458.8685733706825, 6507.707153178213, 6543.509236807164, 6388.968055159695, 6429.7428102875365, 6466.741330346922, 6473.0, 6559.836004099936, 6361.8727625448155, 6412.294647588668, 6418.711157997995, 6459.0, 6535.607863528014, 6514.3811337922825, 6539.967300163468, 6549.869002619826, 6590.670466476753, 6641.804475194512, 6241.96879015602, 6372.74509019634, 6387.329330420239, 6417.0107266747455, 6463.935360646521], "value": 5049.704573712779, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [891.8751374807532, 909.5861383070701, 917.3395155488046, 921.1479381572046, 927.4620719982411, 18774.718379224305, 19828.603427931434, 19835.50411239718, 19847.10688019039, 21649.891750541225, 21810.563788724256, 22305.0, 22354.88822555885, 22408.77591224087, 22457.32628021158, 1036.5024788101696, 1062.3201151263197, 1062.9627963021296, 1063.8191507443714, 1066.9359838409682, 1018.3838777539593, 1045.5974449836829, 1052.8894466081028, 1057.2229411382627, 1059.2214722179192, 1107.545906178463, 1109.3066833229232, 1110.272771334777, 1110.5890820396464, 1111.149970272742, 1104.8674159100879, 1104.9723756906062, 1105.8285965675334, 1108.4070022537985, 1108.844761733358, 807.7011505742854, 814.9348052155814, 816.9754907352789, 817.1746535998684, 817.2603793566832, 19836.305729299405, 20255.696164557397, 20260.696089558667, 20452.69320960172, 20515.281965131147, 22242.666360004612, 22337.10651573935, 22503.0, 22813.657795133087, 22831.77168228313, 16914.915425422794, 17198.0, 17381.652366952716, 17436.128193590397, 17466.91266543659, 3609.2240168363664, 3619.402798538238, 3625.9274814503824, 3635.5092062571744, 3637.217998130415, 124979.0, 133865.0, 135540.0, 136377.0, 138161.0, 16904.746428803577, 17495.0, 17881.552961175814, 18006.819931800776, 18096.819031809515, 31433.685663143533, 32026.519602205986, 32233.194170145463, 32348.83825580857, 32364.0, 7681.155072941972, 7954.880676789853, 8374.330053595697, 8652.221300083023, 9005.324600654845, 4225.471816022997, 4311.892202694895, 4312.611864932172, 4335.176316499855, 4359.978200108979, 5270.367555893241, 5294.602904782157, 5312.840614781563, 5353.304070470814, 5364.758585863646, 985.4333758089127, 987.3582171588381, 1010.5907107621279, 1011.6712068577742, 1014.0974532665933, 653.8986457099157, 670.6747227594612, 677.1400321591551, 679.2087218390519, 690.9516333856683, 12011.459484323226, 12607.243565386107, 13217.669558260928, 13405.932970335281, 13454.26001569923, 665.4476784269045, 708.4509505133562, 713.864365770502, 721.9061522002106, 727.8980942668031, 5219.855608276357, 5449.455054494519, 5470.316210473691, 5559.444055594408, 5672.319321681424, 104010.0, 105968.0, 106184.0, 108923.45538272258, 109555.45222273997, 91874.54062729777, 92057.539712301, 92150.07849921416, 96823.0317696814, 96833.0, 81307.0, 85030.0, 86838.56580717055, 88740.11259887448, 91307.54346228359, 11184.328940263611, 11346.978771910568, 11388.715282118013, 11735.354555499529, 11868.821967670665, 36776.26447471089, 37586.624133759404, 37715.81142094382, 37992.810035949646, 39018.0, 47934.0, 48632.756836215594, 48671.75664121657, 49955.50044499509, 50293.74853125711, 16382.180890955166, 16847.326106956076, 17131.743023854404, 17161.74257386165, 17385.47843564695, 16127.274272657993, 16295.918520407322, 16410.589735256715, 21078.367648970554, 21710.565788684453, 18735.250589976247, 18736.250549978395, 18878.15048322856, 19245.03774811282, 19586.8041319585, 19018.619627607648, 19471.4158575243, 20459.283925063148, 20573.79426205719, 20793.272235471686, 17693.203805829027, 18181.09094545294, 18205.726914096565, 18275.36036238725, 18321.175547100145, 13080.672983175496, 13206.27365494907, 13362.933185334012, 13765.036447448583, 13951.302434878013, 14286.28568571588, 14856.257187140383, 14939.0, 14991.950563460889, 15390.769138462709], "value": 9208.131296191312, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 117.0, 100.0, 112.0, 115.0, 107.0, 108.0, 100.0, 108.0, 108.0], "value": 107.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 122.0, 143.0, 176.0, 125.0, 150.0, 150.0, 120.0, 172.0, 120.0], "value": 143.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 161.0, 163.0, 176.0, 166.0, 164.0, 170.0, 164.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 80.0, 171.0, 78.0, 75.0, 89.0, 75.0, 156.0, 76.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 85.0, 137.0, 79.0, 81.0, 78.0, 138.0, 79.0, 79.0, 137.0], "value": 97.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 121.0, 122.0, 114.0, 118.0, 119.0, 119.0, 114.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 161.0, 150.0, 155.0, 151.0, 154.0, 152.0, 152.0, 150.0, 152.0], "value": 152.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 99.0, 96.0, 100.0, 94.0, 94.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 64.0, 60.0, 61.0, 56.0, 57.0, 58.0, 54.0, 56.0, 59.0], "value": 58.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 61.0, 54.0, 54.0, 54.0, 53.0, 54.0, 60.0, 55.0, 54.0], "value": 55.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 98.0, 77.0, 80.0, 85.0, 88.0, 77.0, 78.0, 79.0, 94.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 134.0, 125.0, 146.0, 129.0, 124.0, 135.0, 138.0, 125.0, 173.0], "value": 135.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 170.0, 175.0, 179.0, 178.0, 172.0, 171.0, 176.0, 177.0, 184.0], "value": 175.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 65.0, 63.0, 64.0, 71.0, 67.0, 63.0, 64.0], "value": 65.7, "unit": "score"}]}]} 13:43:17 INFO - Return code: 0 13:43:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:43:17 INFO - # TBPL SUCCESS # 13:43:17 INFO - Running post-action listener: _package_coverage_data 13:43:17 INFO - Running post-action listener: _resource_record_post_action 13:43:17 INFO - [mozharness: 2017-08-04 20:43:17.585035Z] Finished run-tests step (success) 13:43:17 INFO - Running post-run listener: _resource_record_post_run 13:43:17 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 5087232; Write bytes: 441192448; Read time: 1844; Write time: 349960 13:43:17 INFO - TinderboxPrint: CPU usage
13.2% 13:43:17 INFO - TinderboxPrint: I/O read bytes / time
5,087,232 / 1,844 13:43:17 INFO - TinderboxPrint: I/O write bytes / time
441,192,448 / 349,960 13:43:17 INFO - TinderboxPrint: CPU idle
8,277.9 (86.8%) 13:43:17 INFO - TinderboxPrint: CPU user
1,205.9 (12.6%) 13:43:17 INFO - TinderboxPrint: Swap in / out
0 / 0 13:43:17 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 164528128; Read time: 124; Write time: 149624 13:43:17 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 13:43:17 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 2719744; Write bytes: 276664320; Read time: 1144; Write time: 200336 13:43:18 INFO - Running post-run listener: _upload_blobber_files 13:43:18 INFO - Blob upload gear active. 13:43:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:43:18 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 13:43:18 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'] 13:43:18 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 13:43:18 INFO - (blobuploader) - INFO - Open directory for files ... 13:43:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:43:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:43:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:43:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:43:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:43:20 INFO - (blobuploader) - INFO - Done attempting. 13:43:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:43:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:43:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:43:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:43:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:43:20 INFO - (blobuploader) - INFO - Done attempting. 13:43:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:43:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:43:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:43:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:43:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:43:21 INFO - (blobuploader) - INFO - Done attempting. 13:43:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:43:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:43:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:43:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:43:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:43:25 INFO - (blobuploader) - INFO - Done attempting. 13:43:25 INFO - (blobuploader) - INFO - Iteration through files over. 13:43:25 INFO - Return code: 0 13:43:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:43:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:43:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d90dc19057706323ad8849906a588c671ab147e3d36fc750dae00f7691c970338734364bfb2a99a88d7189721dd1d5c9866e12acb5e55280cb29e981988e9f02", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cb96eb276837e4896e53e59e974d0cfb2ef5f78cd6094546432e180f2a3963b3c21aaba74d1a806c414f8b7696cd61bb0717736de2d683ebf5d6dfca1998b51", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7e1300b3b3606b2df911c593d48a5aec03cf0fdafcd5ac9fbe70391607f0bd15b90eba30a722fd386d4fe111eef2f592e55dc5fe3501a023e7b5739e3855e22", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/212e08c163c97bdcb5acede4514d333e03819f5e449d8e9b0314862ffdf6add8729eefb9928209b317f5fd350030ae7a298eef3f439719babb05befefac412fa"} 13:43:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:43:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:43:25 INFO - Contents: 13:43:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d90dc19057706323ad8849906a588c671ab147e3d36fc750dae00f7691c970338734364bfb2a99a88d7189721dd1d5c9866e12acb5e55280cb29e981988e9f02", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cb96eb276837e4896e53e59e974d0cfb2ef5f78cd6094546432e180f2a3963b3c21aaba74d1a806c414f8b7696cd61bb0717736de2d683ebf5d6dfca1998b51", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7e1300b3b3606b2df911c593d48a5aec03cf0fdafcd5ac9fbe70391607f0bd15b90eba30a722fd386d4fe111eef2f592e55dc5fe3501a023e7b5739e3855e22", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/212e08c163c97bdcb5acede4514d333e03819f5e449d8e9b0314862ffdf6add8729eefb9928209b317f5fd350030ae7a298eef3f439719babb05befefac412fa"} 13:43:25 INFO - Running post-run listener: copy_logs_to_upload_dir 13:43:25 INFO - Copying logs to upload dir... 13:43:25 INFO - mkdir: /builds/slave/test/build/upload/logs 13:43:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.182001 ========= master_lag: 0.40 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-04 13:43:26.625968) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-04 13:43:26.632945) ========= 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=db7e7c15f3ca076d53731445000001ba-1501877348.455069-1832511922 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/d90dc19057706323ad8849906a588c671ab147e3d36fc750dae00f7691c970338734364bfb2a99a88d7189721dd1d5c9866e12acb5e55280cb29e981988e9f02", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cb96eb276837e4896e53e59e974d0cfb2ef5f78cd6094546432e180f2a3963b3c21aaba74d1a806c414f8b7696cd61bb0717736de2d683ebf5d6dfca1998b51", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7e1300b3b3606b2df911c593d48a5aec03cf0fdafcd5ac9fbe70391607f0bd15b90eba30a722fd386d4fe111eef2f592e55dc5fe3501a023e7b5739e3855e22", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/212e08c163c97bdcb5acede4514d333e03819f5e449d8e9b0314862ffdf6add8729eefb9928209b317f5fd350030ae7a298eef3f439719babb05befefac412fa"} build_url:https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011192 build_url: 'https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d90dc19057706323ad8849906a588c671ab147e3d36fc750dae00f7691c970338734364bfb2a99a88d7189721dd1d5c9866e12acb5e55280cb29e981988e9f02", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cb96eb276837e4896e53e59e974d0cfb2ef5f78cd6094546432e180f2a3963b3c21aaba74d1a806c414f8b7696cd61bb0717736de2d683ebf5d6dfca1998b51", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7e1300b3b3606b2df911c593d48a5aec03cf0fdafcd5ac9fbe70391607f0bd15b90eba30a722fd386d4fe111eef2f592e55dc5fe3501a023e7b5739e3855e22", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/212e08c163c97bdcb5acede4514d333e03819f5e449d8e9b0314862ffdf6add8729eefb9928209b317f5fd350030ae7a298eef3f439719babb05befefac412fa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-04 13:43:26.661016) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 13:43:26.661373) ========= 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=db7e7c15f3ca076d53731445000001ba-1501877348.455069-1832511922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004406 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 13:43:26.746085) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-04 13:43:26.746585) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-04 13:43:26.747229) ========= ========= Total master_lag: 0.63 =========