builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-071 starttime: 1502576699.27 results: success (0) revision: 6062341662fcee683434ee71539bfa10964c022e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-12 15:24:59.271669) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-12 15:24:59.272041) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-12 15:24:59.273167) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-12 15:24:59.315440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-12 15:24:59.315709) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dbb0bb31bf4a4c7db9ba1648000001b6-1502575262.946007-863781298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-12 15:24:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 54.2M=0s 2017-08-12 15:24:59 (54.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113234 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-12 15:24:59.447934) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-12 15:24:59.448218) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dbb0bb31bf4a4c7db9ba1648000001b6-1502575262.946007-863781298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019482 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-12 15:24:59.515880) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-12 15:24:59.516167) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6062341662fcee683434ee71539bfa10964c022e --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 6062341662fcee683434ee71539bfa10964c022e --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dbb0bb31bf4a4c7db9ba1648000001b6-1502575262.946007-863781298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-12 15:25:00,067 truncating revision to first 12 chars 2017-08-12 15:25:00,067 Setting DEBUG logging. 2017-08-12 15:25:00,067 attempt 1/10 2017-08-12 15:25:00,067 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6062341662fc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-12 15:25:00,391 unpacking tar archive at: mozilla-central-6062341662fc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.615887 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-12 15:25:00.153335) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-12 15:25:00.156685) ========= script_repo_revision: 6062341662fcee683434ee71539bfa10964c022e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-12 15:25:00.157344) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-12 15:25:00.157621) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-12 15:25:00.166491) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-08-12 15:25:00.166767) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dbb0bb31bf4a4c7db9ba1648000001b6-1502575262.946007-863781298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:25:00 INFO - MultiFileLogger online at 20170812 15:25:00 in /builds/slave/test 15:25:00 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 15:25:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:25:00 INFO - {'append_to_log': False, 15:25:00 INFO - 'base_work_dir': '/builds/slave/test', 15:25:00 INFO - 'blob_upload_branch': 'Firefox', 15:25:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:25:00 INFO - 'branch': 'Firefox', 15:25:00 INFO - 'buildbot_json_path': 'buildprops.json', 15:25:00 INFO - 'code_coverage': False, 15:25:00 INFO - 'config_files': ('talos/linux_config.py',), 15:25:00 INFO - 'default_actions': ('clobber', 15:25:00 INFO - 'read-buildbot-config', 15:25:00 INFO - 'download-and-extract', 15:25:00 INFO - 'populate-webroot', 15:25:00 INFO - 'create-virtualenv', 15:25:00 INFO - 'install', 15:25:00 INFO - 'setup-mitmproxy', 15:25:00 INFO - 'run-tests'), 15:25:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:25:00 INFO - 'disable_ccov_upload': False, 15:25:00 INFO - 'download_minidump_stackwalk': True, 15:25:00 INFO - 'download_symbols': 'ondemand', 15:25:00 INFO - 'enable_stylo': False, 15:25:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:25:00 INFO - 'tooltool.py': '/tools/tooltool.py', 15:25:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:25:00 INFO - '/tools/misc-python/virtualenv.py')}, 15:25:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:25:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:25:00 INFO - 'gecko_profile': False, 15:25:00 INFO - 'gecko_profile_interval': 0, 15:25:00 INFO - 'installer_path': 'installer.exe', 15:25:00 INFO - 'log_level': 'info', 15:25:00 INFO - 'log_name': 'talos', 15:25:00 INFO - 'log_to_console': True, 15:25:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:25:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:25:00 INFO - 'opt_config_files': (), 15:25:00 INFO - 'pip_index': False, 15:25:00 INFO - 'suite': 'dromaeojs-e10s', 15:25:00 INFO - 'system_bits': '32', 15:25:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:25:00 INFO - 'title': 'talos-linux64-ix-071', 15:25:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:25:00 INFO - 'use_talos_json': True, 15:25:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:25:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:25:00 INFO - 'work_dir': 'build'} 15:25:00 INFO - [mozharness: 2017-08-12 22:25:00.818476Z] Running clobber step. 15:25:00 INFO - Running pre-action listener: _resource_record_pre_action 15:25:00 INFO - Running main action method: clobber 15:25:00 INFO - rmtree: /builds/slave/test/build 15:25:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:25:02 INFO - Running post-action listener: _resource_record_post_action 15:25:02 INFO - [mozharness: 2017-08-12 22:25:02.356426Z] Finished clobber step (success) 15:25:02 INFO - [mozharness: 2017-08-12 22:25:02.356528Z] Running read-buildbot-config step. 15:25:02 INFO - Running pre-action listener: _resource_record_pre_action 15:25:02 INFO - Running main action method: read_buildbot_config 15:25:02 INFO - Using buildbot properties: 15:25:02 INFO - { 15:25:02 INFO - "project": "", 15:25:02 INFO - "product": "firefox", 15:25:02 INFO - "who": "archaeopteryx@coole-files.de", 15:25:02 INFO - "installer_path": "public/build/target.tar.bz2", 15:25:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 15:25:02 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:25:02 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 15:25:02 INFO - "stage_platform": "linux64-stylo", 15:25:02 INFO - "basedir": "/builds/slave/test", 15:25:02 INFO - "buildnumber": 25, 15:25:02 INFO - "platform": "ubuntu64_hw_stylo", 15:25:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:25:02 INFO - "slavebuilddir": "test", 15:25:02 INFO - "taskId": "Aaer_-MFQ7i9wt7KOgl7bg", 15:25:02 INFO - "branch": "mozilla-central", 15:25:02 INFO - "script_repo_revision": "production", 15:25:02 INFO - "revision": "6062341662fcee683434ee71539bfa10964c022e", 15:25:02 INFO - "slavename": "talos-linux64-ix-071", 15:25:02 INFO - "repo_path": "mozilla-central" 15:25:02 INFO - } 15:25:02 INFO - Finding installer, test and symbols from parent task. 15:25:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Aaer_-MFQ7i9wt7KOgl7bg'}, attempt #1 15:25:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Aaer_-MFQ7i9wt7KOgl7bg'}, attempt #1 15:25:03 INFO - Task dependencies: Yx2HVl5oTtyjs-iuTJgx8w 15:25:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yx2HVl5oTtyjs-iuTJgx8w'}, attempt #1 15:25:03 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Yx2HVl5oTtyjs-iuTJgx8w/artifacts/public/build/target.tar.bz2 15:25:03 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Yx2HVl5oTtyjs-iuTJgx8w/artifacts/public/build/target.test_packages.json 15:25:03 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Yx2HVl5oTtyjs-iuTJgx8w/artifacts/public/build/target.crashreporter-symbols.zip 15:25:03 INFO - Running post-action listener: _resource_record_post_action 15:25:03 INFO - [mozharness: 2017-08-12 22:25:03.729827Z] Finished read-buildbot-config step (success) 15:25:03 INFO - [mozharness: 2017-08-12 22:25:03.730049Z] Running download-and-extract step. 15:25:03 INFO - Running pre-action listener: _resource_record_pre_action 15:25:03 INFO - Running main action method: download_and_extract 15:25:03 INFO - mkdir: /builds/slave/test/build/tests 15:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:03 INFO - trying https://queue.taskcluster.net/v1/task/Yx2HVl5oTtyjs-iuTJgx8w/artifacts/public/build/target.test_packages.json 15:25:03 INFO - Downloading https://queue.taskcluster.net/v1/task/Yx2HVl5oTtyjs-iuTJgx8w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:25:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yx2HVl5oTtyjs-iuTJgx8w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:25:04 INFO - Downloaded 989 bytes. 15:25:04 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:25:04 INFO - Using the following test package requirements: 15:25:04 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:25:04 INFO - u'common': [u'target.common.tests.zip'], 15:25:04 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:25:04 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:25:04 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:25:04 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:25:04 INFO - u'mozbase': [u'target.common.tests.zip'], 15:25:04 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:25:04 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:25:04 INFO - u'web-platform': [u'target.common.tests.zip', 15:25:04 INFO - u'target.web-platform.tests.tar.gz'], 15:25:04 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:25:04 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:25:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Yx2HVl5oTtyjs-iuTJgx8w/artifacts/public/build/target.common.tests.zip 15:25:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Yx2HVl5oTtyjs-iuTJgx8w/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:25:04 INFO - Fetch https://queue.taskcluster.net/v1/task/Yx2HVl5oTtyjs-iuTJgx8w/artifacts/public/build/target.common.tests.zip into memory 15:25:06 INFO - Content-Length response header: 54034459 15:25:06 INFO - Bytes received: 54034459 15:25:17 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:25:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Yx2HVl5oTtyjs-iuTJgx8w/artifacts/public/build/target.common.tests.zip 15:25:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Yx2HVl5oTtyjs-iuTJgx8w/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:25:17 INFO - Fetch https://queue.taskcluster.net/v1/task/Yx2HVl5oTtyjs-iuTJgx8w/artifacts/public/build/target.common.tests.zip into memory 15:25:19 INFO - Content-Length response header: 54034459 15:25:19 INFO - Bytes received: 54034459 15:25:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Yx2HVl5oTtyjs-iuTJgx8w/artifacts/public/build/target.talos.tests.zip 15:25:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Yx2HVl5oTtyjs-iuTJgx8w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:25:31 INFO - Fetch https://queue.taskcluster.net/v1/task/Yx2HVl5oTtyjs-iuTJgx8w/artifacts/public/build/target.talos.tests.zip into memory 15:25:32 INFO - Content-Length response header: 14496050 15:25:32 INFO - Bytes received: 14496050 15:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:32 INFO - trying https://queue.taskcluster.net/v1/task/Yx2HVl5oTtyjs-iuTJgx8w/artifacts/public/build/target.tar.bz2 15:25:32 INFO - Downloading https://queue.taskcluster.net/v1/task/Yx2HVl5oTtyjs-iuTJgx8w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:25:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yx2HVl5oTtyjs-iuTJgx8w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:25:35 INFO - Downloaded 61812574 bytes. 15:25:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Yx2HVl5oTtyjs-iuTJgx8w/artifacts/public/build/target.tar.bz2 15:25:35 INFO - mkdir: /builds/slave/test/properties 15:25:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:25:35 INFO - Writing to file /builds/slave/test/properties/build_url 15:25:35 INFO - Contents: 15:25:35 INFO - build_url:https://queue.taskcluster.net/v1/task/Yx2HVl5oTtyjs-iuTJgx8w/artifacts/public/build/target.tar.bz2 15:25:35 INFO - Running post-action listener: _resource_record_post_action 15:25:35 INFO - Running post-action listener: set_extra_try_arguments 15:25:35 INFO - [mozharness: 2017-08-12 22:25:35.570096Z] Finished download-and-extract step (success) 15:25:35 INFO - [mozharness: 2017-08-12 22:25:35.570348Z] Running populate-webroot step. 15:25:35 INFO - Running pre-action listener: _resource_record_pre_action 15:25:35 INFO - Running main action method: populate_webroot 15:25:35 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:25:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:25:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:25:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:25:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:25:35 INFO - 'tests': ['damp', 'tps']}, 15:25:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:25:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:25:35 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:25:35 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:25:35 INFO - 'other-e10s': {'tests': ['a11yr', 15:25:35 INFO - 'ts_paint', 15:25:35 INFO - 'tpaint', 15:25:35 INFO - 'sessionrestore', 15:25:35 INFO - 'sessionrestore_many_windows', 15:25:35 INFO - 'sessionrestore_no_auto_restore', 15:25:35 INFO - 'tabpaint']}, 15:25:35 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:25:35 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:25:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:25:35 INFO - 'tsvgr_opacity', 15:25:35 INFO - 'tart', 15:25:35 INFO - 'tscrollx', 15:25:35 INFO - 'tsvg_static']}, 15:25:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:25:35 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:25:35 INFO - 'talos_options': ['--mitmproxy', 15:25:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:25:35 INFO - '--firstNonBlankPaint'], 15:25:35 INFO - 'tests': ['tp6_google', 15:25:35 INFO - 'tp6_youtube', 15:25:35 INFO - 'tp6_amazon', 15:25:35 INFO - 'tp6_facebook']}, 15:25:35 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:25:35 INFO - 'talos_options': ['--stylo', 15:25:35 INFO - '--mitmproxy', 15:25:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:25:35 INFO - '--firstNonBlankPaint'], 15:25:35 INFO - 'tests': ['tp6_google', 15:25:35 INFO - 'tp6_youtube', 15:25:35 INFO - 'tp6_amazon', 15:25:35 INFO - 'tp6_facebook']}, 15:25:35 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:25:35 INFO - 'talos_options': ['--stylo', 15:25:35 INFO - '--stylo-threads=1', 15:25:35 INFO - '--mitmproxy', 15:25:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:25:35 INFO - '--firstNonBlankPaint'], 15:25:35 INFO - 'tests': ['tp6_google', 15:25:35 INFO - 'tp6_youtube', 15:25:35 INFO - 'tp6_amazon', 15:25:35 INFO - 'tp6_facebook']}, 15:25:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:25:35 INFO - 'talos_options': ['--xperf_path', 15:25:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:25:35 INFO - 'tests': ['tp5n']}}} 15:25:35 INFO - Running post-action listener: _resource_record_post_action 15:25:35 INFO - [mozharness: 2017-08-12 22:25:35.588573Z] Finished populate-webroot step (success) 15:25:35 INFO - [mozharness: 2017-08-12 22:25:35.588663Z] Running create-virtualenv step. 15:25:35 INFO - Running pre-action listener: _resource_record_pre_action 15:25:35 INFO - Running main action method: create_virtualenv 15:25:35 INFO - Creating virtualenv /builds/slave/test/build/venv 15:25:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:25:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:25:35 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:25:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:25:35 INFO - Using real prefix '/usr' 15:25:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:25:36 INFO - Installing distribute.............................................................................................................................................................................................done. 15:25:38 INFO - Installing pip.................done. 15:25:38 INFO - Return code: 0 15:25:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:25:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:25:38 INFO - Reading from file tmpfile_stdout 15:25:38 INFO - Output received: 15:25:38 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:25:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:25: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')]} 15:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25: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')]} 15:25:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbafa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4f8a0>, '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 0xd507a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd50c30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1502575262.946007-863781298', '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 15:25:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:25:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:25:38 INFO - Using env: {'DISPLAY': ':0', 15:25:38 INFO - 'HOME': '/home/cltbld', 15:25:38 INFO - 'LANG': 'en_US.UTF-8', 15:25:38 INFO - 'LANGUAGE': 'en_US:en', 15:25:38 INFO - 'LOGNAME': 'cltbld', 15:25:38 INFO - 'MAIL': '/var/mail/cltbld', 15:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:38 INFO - 'MOZ_NO_REMOTE': '1', 15:25:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:38 INFO - 'NO_EM_RESTART': '1', 15:25:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:38 INFO - 'PWD': '/builds/slave/test', 15:25:38 INFO - 'SHELL': '/bin/bash', 15:25:38 INFO - 'SHLVL': '1', 15:25:38 INFO - 'TERM': 'linux', 15:25:38 INFO - 'TMOUT': '86400', 15:25:38 INFO - 'USER': 'cltbld', 15:25:38 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1502575262.946007-863781298', 15:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:38 INFO - '_': '/tools/buildbot/bin/python'} 15:25:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:25:38 INFO - Cleaning up... 15:25:38 INFO - Return code: 0 15:25:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:25: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')]} 15:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25: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')]} 15:25:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbafa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4f8a0>, '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 0xd507a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd50c30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1502575262.946007-863781298', '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 15:25:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:25:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:25:38 INFO - Using env: {'DISPLAY': ':0', 15:25:38 INFO - 'HOME': '/home/cltbld', 15:25:38 INFO - 'LANG': 'en_US.UTF-8', 15:25:38 INFO - 'LANGUAGE': 'en_US:en', 15:25:38 INFO - 'LOGNAME': 'cltbld', 15:25:38 INFO - 'MAIL': '/var/mail/cltbld', 15:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:38 INFO - 'MOZ_NO_REMOTE': '1', 15:25:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:38 INFO - 'NO_EM_RESTART': '1', 15:25:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:38 INFO - 'PWD': '/builds/slave/test', 15:25:38 INFO - 'SHELL': '/bin/bash', 15:25:38 INFO - 'SHLVL': '1', 15:25:38 INFO - 'TERM': 'linux', 15:25:38 INFO - 'TMOUT': '86400', 15:25:38 INFO - 'USER': 'cltbld', 15:25:38 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1502575262.946007-863781298', 15:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:38 INFO - '_': '/tools/buildbot/bin/python'} 15:25:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:38 INFO - Downloading/unpacking psutil>=3.1.1 15:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:25:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:25:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:25:40 INFO - Installing collected packages: psutil 15:25:40 INFO - Running setup.py install for psutil 15:25:40 INFO - building 'psutil._psutil_linux' extension 15:25:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:25:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:25:40 INFO - building 'psutil._psutil_posix' extension 15:25:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:25:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:25:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:25:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:25:40 INFO - Successfully installed psutil 15:25:40 INFO - Cleaning up... 15:25:40 INFO - Return code: 0 15:25:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbafa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4f8a0>, '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 0xd507a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd50c30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1502575262.946007-863781298', '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 15:25:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:25:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:25:40 INFO - Using env: {'DISPLAY': ':0', 15:25:40 INFO - 'HOME': '/home/cltbld', 15:25:40 INFO - 'LANG': 'en_US.UTF-8', 15:25:40 INFO - 'LANGUAGE': 'en_US:en', 15:25:40 INFO - 'LOGNAME': 'cltbld', 15:25:40 INFO - 'MAIL': '/var/mail/cltbld', 15:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:40 INFO - 'MOZ_NO_REMOTE': '1', 15:25:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:40 INFO - 'NO_EM_RESTART': '1', 15:25:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:40 INFO - 'PWD': '/builds/slave/test', 15:25:40 INFO - 'SHELL': '/bin/bash', 15:25:40 INFO - 'SHLVL': '1', 15:25:40 INFO - 'TERM': 'linux', 15:25:40 INFO - 'TMOUT': '86400', 15:25:40 INFO - 'USER': 'cltbld', 15:25:40 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1502575262.946007-863781298', 15:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:40 INFO - '_': '/tools/buildbot/bin/python'} 15:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:25:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:25:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:25:41 INFO - Installing collected packages: mozsystemmonitor 15:25:41 INFO - Running setup.py install for mozsystemmonitor 15:25:42 INFO - Successfully installed mozsystemmonitor 15:25:42 INFO - Cleaning up... 15:25:42 INFO - Return code: 0 15:25:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbafa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4f8a0>, '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 0xd507a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd50c30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1502575262.946007-863781298', '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 15:25:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:25:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:25:42 INFO - Using env: {'DISPLAY': ':0', 15:25:42 INFO - 'HOME': '/home/cltbld', 15:25:42 INFO - 'LANG': 'en_US.UTF-8', 15:25:42 INFO - 'LANGUAGE': 'en_US:en', 15:25:42 INFO - 'LOGNAME': 'cltbld', 15:25:42 INFO - 'MAIL': '/var/mail/cltbld', 15:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:42 INFO - 'MOZ_NO_REMOTE': '1', 15:25:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:42 INFO - 'NO_EM_RESTART': '1', 15:25:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:42 INFO - 'PWD': '/builds/slave/test', 15:25:42 INFO - 'SHELL': '/bin/bash', 15:25:42 INFO - 'SHLVL': '1', 15:25:42 INFO - 'TERM': 'linux', 15:25:42 INFO - 'TMOUT': '86400', 15:25:42 INFO - 'USER': 'cltbld', 15:25:42 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1502575262.946007-863781298', 15:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:42 INFO - '_': '/tools/buildbot/bin/python'} 15:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:42 INFO - Downloading/unpacking jsonschema==2.5.1 15:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:25:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:43 INFO - Downloading functools32-3.2.3-2.tar.gz 15:25:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:25:43 INFO - warning: no files found matching '*.txt' 15:25:43 INFO - no previously-included directories found matching 'build' 15:25:43 INFO - no previously-included directories found matching 'dist' 15:25:43 INFO - no previously-included directories found matching '.git*' 15:25:43 INFO - Installing collected packages: jsonschema, functools32 15:25:43 INFO - Running setup.py install for functools32 15:25:43 INFO - warning: no files found matching '*.txt' 15:25:43 INFO - no previously-included directories found matching 'build' 15:25:43 INFO - no previously-included directories found matching 'dist' 15:25:43 INFO - no previously-included directories found matching '.git*' 15:25:43 INFO - Successfully installed jsonschema functools32 15:25:43 INFO - Cleaning up... 15:25:43 INFO - Return code: 0 15:25:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbafa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4f8a0>, '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 0xd507a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd50c30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1502575262.946007-863781298', '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 15:25:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:25:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:25:43 INFO - Using env: {'DISPLAY': ':0', 15:25:43 INFO - 'HOME': '/home/cltbld', 15:25:43 INFO - 'LANG': 'en_US.UTF-8', 15:25:43 INFO - 'LANGUAGE': 'en_US:en', 15:25:43 INFO - 'LOGNAME': 'cltbld', 15:25:43 INFO - 'MAIL': '/var/mail/cltbld', 15:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:43 INFO - 'MOZ_NO_REMOTE': '1', 15:25:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:43 INFO - 'NO_EM_RESTART': '1', 15:25:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:43 INFO - 'PWD': '/builds/slave/test', 15:25:43 INFO - 'SHELL': '/bin/bash', 15:25:43 INFO - 'SHLVL': '1', 15:25:43 INFO - 'TERM': 'linux', 15:25:43 INFO - 'TMOUT': '86400', 15:25:43 INFO - 'USER': 'cltbld', 15:25:43 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1502575262.946007-863781298', 15:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:43 INFO - '_': '/tools/buildbot/bin/python'} 15:25:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:25:43 INFO - Cleaning up... 15:25:43 INFO - Return code: 0 15:25:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbafa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4f8a0>, '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 0xd507a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd50c30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1502575262.946007-863781298', '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 15:25:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:25:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:25:43 INFO - Using env: {'DISPLAY': ':0', 15:25:43 INFO - 'HOME': '/home/cltbld', 15:25:43 INFO - 'LANG': 'en_US.UTF-8', 15:25:43 INFO - 'LANGUAGE': 'en_US:en', 15:25:43 INFO - 'LOGNAME': 'cltbld', 15:25:43 INFO - 'MAIL': '/var/mail/cltbld', 15:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:43 INFO - 'MOZ_NO_REMOTE': '1', 15:25:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:43 INFO - 'NO_EM_RESTART': '1', 15:25:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:43 INFO - 'PWD': '/builds/slave/test', 15:25:43 INFO - 'SHELL': '/bin/bash', 15:25:43 INFO - 'SHLVL': '1', 15:25:43 INFO - 'TERM': 'linux', 15:25:43 INFO - 'TMOUT': '86400', 15:25:43 INFO - 'USER': 'cltbld', 15:25:43 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1502575262.946007-863781298', 15:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:43 INFO - '_': '/tools/buildbot/bin/python'} 15:25:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:44 INFO - Downloading/unpacking blobuploader==1.2.4 15:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:45 INFO - Downloading blobuploader-1.2.4.tar.gz 15:25:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:25:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:25:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:45 INFO - Downloading docopt-0.6.1.tar.gz 15:25:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:25:45 INFO - Installing collected packages: blobuploader, requests, docopt 15:25:45 INFO - Running setup.py install for blobuploader 15:25:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:25:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:25:46 INFO - Running setup.py install for requests 15:25:46 INFO - Running setup.py install for docopt 15:25:46 INFO - Successfully installed blobuploader requests docopt 15:25:46 INFO - Cleaning up... 15:25:46 INFO - Return code: 0 15:25:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbafa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4f8a0>, '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 0xd507a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd50c30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1502575262.946007-863781298', '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 15:25:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:25:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:25:46 INFO - Using env: {'DISPLAY': ':0', 15:25:46 INFO - 'HOME': '/home/cltbld', 15:25:46 INFO - 'LANG': 'en_US.UTF-8', 15:25:46 INFO - 'LANGUAGE': 'en_US:en', 15:25:46 INFO - 'LOGNAME': 'cltbld', 15:25:46 INFO - 'MAIL': '/var/mail/cltbld', 15:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:46 INFO - 'MOZ_NO_REMOTE': '1', 15:25:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:46 INFO - 'NO_EM_RESTART': '1', 15:25:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:46 INFO - 'PWD': '/builds/slave/test', 15:25:46 INFO - 'SHELL': '/bin/bash', 15:25:46 INFO - 'SHLVL': '1', 15:25:46 INFO - 'TERM': 'linux', 15:25:46 INFO - 'TMOUT': '86400', 15:25:46 INFO - 'USER': 'cltbld', 15:25:46 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1502575262.946007-863781298', 15:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:46 INFO - '_': '/tools/buildbot/bin/python'} 15:25:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:25:46 INFO - Running setup.py (path:/tmp/pip-hDOdfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:25:46 INFO - Running setup.py (path:/tmp/pip-JUOUQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:25:46 INFO - Running setup.py (path:/tmp/pip-g4zUOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:25:46 INFO - Running setup.py (path:/tmp/pip-tN4QPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:25:47 INFO - Running setup.py (path:/tmp/pip-dBSkFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:25:47 INFO - Running setup.py (path:/tmp/pip-acTenv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:25:47 INFO - Running setup.py (path:/tmp/pip-Xya60b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:25:47 INFO - Running setup.py (path:/tmp/pip-_aHpvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:25:47 INFO - Running setup.py (path:/tmp/pip-ofV4gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:25:47 INFO - Running setup.py (path:/tmp/pip-oQCGke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:25:47 INFO - Running setup.py (path:/tmp/pip-PesKeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:25:47 INFO - Running setup.py (path:/tmp/pip-rwtU50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:25:47 INFO - Running setup.py (path:/tmp/pip-5u818B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:25:47 INFO - Running setup.py (path:/tmp/pip-rHR35w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:47 INFO - Running setup.py (path:/tmp/pip-gBFtlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:25:47 INFO - Running setup.py (path:/tmp/pip-WTQoJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:25:47 INFO - Running setup.py (path:/tmp/pip-eYJZB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:25:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:25:47 INFO - Running setup.py install for manifestparser 15:25:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:25:48 INFO - Running setup.py install for mozcrash 15:25:48 INFO - Running setup.py install for mozdebug 15:25:48 INFO - Running setup.py install for mozdevice 15:25:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:25:48 INFO - Running setup.py install for mozfile 15:25:48 INFO - Running setup.py install for mozhttpd 15:25:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:25:48 INFO - Running setup.py install for mozinfo 15:25:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:25:48 INFO - Running setup.py install for mozInstall 15:25:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:25:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:25:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:25:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:25:48 INFO - Running setup.py install for mozleak 15:25:48 INFO - Running setup.py install for mozlog 15:25:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:25:48 INFO - Running setup.py install for moznetwork 15:25:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:25:49 INFO - Running setup.py install for mozprocess 15:25:49 INFO - Running setup.py install for mozprofile 15:25:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:25:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:25:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:25:49 INFO - Running setup.py install for mozrunner 15:25:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:25:49 INFO - Running setup.py install for mozscreenshot 15:25:49 INFO - Running setup.py install for moztest 15:25:49 INFO - Running setup.py install for mozversion 15:25:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:25:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:25:49 INFO - Cleaning up... 15:25:49 INFO - Return code: 0 15:25:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbafa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4f8a0>, '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 0xd507a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd50c30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1502575262.946007-863781298', '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 15:25:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:25:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:25:49 INFO - Using env: {'DISPLAY': ':0', 15:25:49 INFO - 'HOME': '/home/cltbld', 15:25:49 INFO - 'LANG': 'en_US.UTF-8', 15:25:49 INFO - 'LANGUAGE': 'en_US:en', 15:25:49 INFO - 'LOGNAME': 'cltbld', 15:25:49 INFO - 'MAIL': '/var/mail/cltbld', 15:25:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:49 INFO - 'MOZ_NO_REMOTE': '1', 15:25:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:49 INFO - 'NO_EM_RESTART': '1', 15:25:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:49 INFO - 'PWD': '/builds/slave/test', 15:25:49 INFO - 'SHELL': '/bin/bash', 15:25:49 INFO - 'SHLVL': '1', 15:25:49 INFO - 'TERM': 'linux', 15:25:49 INFO - 'TMOUT': '86400', 15:25:49 INFO - 'USER': 'cltbld', 15:25:49 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1502575262.946007-863781298', 15:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:49 INFO - '_': '/tools/buildbot/bin/python'} 15:25:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:25:49 INFO - Running setup.py (path:/tmp/pip-Jxp8ah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:25:50 INFO - Running setup.py (path:/tmp/pip-yXkTIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:25:50 INFO - Running setup.py (path:/tmp/pip-XoM6XA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:25:50 INFO - Running setup.py (path:/tmp/pip-H3weZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:25:50 INFO - Running setup.py (path:/tmp/pip-envPuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:25:50 INFO - Running setup.py (path:/tmp/pip-IfMV5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:25:50 INFO - Running setup.py (path:/tmp/pip-3uKrLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:25:50 INFO - Running setup.py (path:/tmp/pip-ACNxPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:25:50 INFO - Running setup.py (path:/tmp/pip-tS430g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:25:50 INFO - Running setup.py (path:/tmp/pip-88eBYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:25:50 INFO - Running setup.py (path:/tmp/pip-_pIhw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:25:50 INFO - Running setup.py (path:/tmp/pip-PsCVVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:25:50 INFO - Running setup.py (path:/tmp/pip-wm6xpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:25:50 INFO - Running setup.py (path:/tmp/pip-A6aomM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:50 INFO - Running setup.py (path:/tmp/pip-jxkP4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:25:51 INFO - Running setup.py (path:/tmp/pip-HFiNz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:25:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:25:51 INFO - Running setup.py (path:/tmp/pip-DmvdzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:25:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:25:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:25:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:25:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:25:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:25:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:25:51 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:25:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:52 INFO - Downloading blessings-1.6.tar.gz 15:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:25:52 INFO - Installing collected packages: blessings 15:25:52 INFO - Running setup.py install for blessings 15:25:52 INFO - Successfully installed blessings 15:25:52 INFO - Cleaning up... 15:25:52 INFO - Return code: 0 15:25:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:25:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:25:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:25:52 INFO - Reading from file tmpfile_stdout 15:25:52 INFO - Current package versions: 15:25:52 INFO - argparse == 1.2.1 15:25:52 INFO - blessings == 1.6 15:25:52 INFO - blobuploader == 1.2.4 15:25:52 INFO - docopt == 0.6.1 15:25:52 INFO - functools32 == 3.2.3-2 15:25:52 INFO - jsonschema == 2.5.1 15:25:52 INFO - manifestparser == 1.1 15:25:52 INFO - mozInstall == 1.13 15:25:52 INFO - mozcrash == 1.0 15:25:52 INFO - mozdebug == 0.1 15:25:52 INFO - mozdevice == 0.51 15:25:52 INFO - mozfile == 1.2 15:25:52 INFO - mozhttpd == 0.7 15:25:52 INFO - mozinfo == 0.10 15:25:52 INFO - mozleak == 0.1 15:25:52 INFO - mozlog == 3.5 15:25:52 INFO - moznetwork == 0.27 15:25:52 INFO - mozprocess == 0.25 15:25:52 INFO - mozprofile == 0.28 15:25:52 INFO - mozrunner == 6.13 15:25:52 INFO - mozscreenshot == 0.1 15:25:52 INFO - mozsystemmonitor == 0.3 15:25:52 INFO - moztest == 0.8 15:25:52 INFO - mozversion == 1.4 15:25:52 INFO - psutil == 3.1.1 15:25:52 INFO - requests == 1.2.3 15:25:52 INFO - wsgiref == 0.1.2 15:25:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbafa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4f8a0>, '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 0xd507a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd50c30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1502575262.946007-863781298', '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 15:25:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:25:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:25:52 INFO - Using env: {'DISPLAY': ':0', 15:25:52 INFO - 'HOME': '/home/cltbld', 15:25:52 INFO - 'LANG': 'en_US.UTF-8', 15:25:52 INFO - 'LANGUAGE': 'en_US:en', 15:25:52 INFO - 'LOGNAME': 'cltbld', 15:25:52 INFO - 'MAIL': '/var/mail/cltbld', 15:25:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:52 INFO - 'MOZ_NO_REMOTE': '1', 15:25:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:52 INFO - 'NO_EM_RESTART': '1', 15:25:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:52 INFO - 'PWD': '/builds/slave/test', 15:25:52 INFO - 'SHELL': '/bin/bash', 15:25:52 INFO - 'SHLVL': '1', 15:25:52 INFO - 'TERM': 'linux', 15:25:52 INFO - 'TMOUT': '86400', 15:25:52 INFO - 'USER': 'cltbld', 15:25:52 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1502575262.946007-863781298', 15:25:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:52 INFO - '_': '/tools/buildbot/bin/python'} 15:25:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:25:52 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:25:54 INFO - Installing collected packages: simplejson 15:25:54 INFO - Running setup.py install for simplejson 15:25:54 INFO - building 'simplejson._speedups' extension 15:25:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 15:25:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 15:25:55 INFO - Successfully installed simplejson 15:25:55 INFO - Cleaning up... 15:25:55 INFO - Return code: 0 15:25:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbafa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4f8a0>, '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 0xd507a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd50c30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1502575262.946007-863781298', '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 15:25:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:25:55 INFO - Using env: {'DISPLAY': ':0', 15:25:55 INFO - 'HOME': '/home/cltbld', 15:25:55 INFO - 'LANG': 'en_US.UTF-8', 15:25:55 INFO - 'LANGUAGE': 'en_US:en', 15:25:55 INFO - 'LOGNAME': 'cltbld', 15:25:55 INFO - 'MAIL': '/var/mail/cltbld', 15:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:55 INFO - 'MOZ_NO_REMOTE': '1', 15:25:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:55 INFO - 'NO_EM_RESTART': '1', 15:25:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:55 INFO - 'PWD': '/builds/slave/test', 15:25:55 INFO - 'SHELL': '/bin/bash', 15:25:55 INFO - 'SHLVL': '1', 15:25:55 INFO - 'TERM': 'linux', 15:25:55 INFO - 'TMOUT': '86400', 15:25:55 INFO - 'USER': 'cltbld', 15:25:55 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1502575262.946007-863781298', 15:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:55 INFO - '_': '/tools/buildbot/bin/python'} 15:25:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:25:55 INFO - Cleaning up... 15:25:55 INFO - Return code: 0 15:25:55 INFO - Running post-action listener: _resource_record_post_action 15:25:55 INFO - Running post-action listener: _start_resource_monitoring 15:25:55 INFO - Starting resource monitoring. 15:25:55 INFO - [mozharness: 2017-08-12 22:25:55.450079Z] Finished create-virtualenv step (success) 15:25:55 INFO - [mozharness: 2017-08-12 22:25:55.450665Z] Running install step. 15:25:55 INFO - Running pre-action listener: _resource_record_pre_action 15:25:55 INFO - Running main action method: install 15:25:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:25:55 INFO - Reading from file tmpfile_stdout 15:25:55 INFO - Detecting whether we're running mozinstall >=1.0... 15:25:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:25:55 INFO - Reading from file tmpfile_stdout 15:25:55 INFO - Output received: 15:25:55 INFO - Usage: mozinstall [options] installer 15:25:55 INFO - Options: 15:25:55 INFO - -h, --help show this help message and exit 15:25:55 INFO - -d DEST, --destination=DEST 15:25:55 INFO - Directory to install application into. [default: 15:25:55 INFO - "/builds/slave/test"] 15:25:55 INFO - --app=APP Application being installed. [default: firefox] 15:25:55 INFO - mkdir: /builds/slave/test/build/application 15:25:55 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'] 15:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:26:13 INFO - Reading from file tmpfile_stdout 15:26:13 INFO - Output received: 15:26:13 INFO - /builds/slave/test/build/application/firefox/firefox 15:26:13 INFO - Running post-action listener: _resource_record_post_action 15:26:13 INFO - [mozharness: 2017-08-12 22:26:13.729178Z] Finished install step (success) 15:26:13 INFO - [mozharness: 2017-08-12 22:26:13.729461Z] Running setup-mitmproxy step. 15:26:13 INFO - Running pre-action listener: _resource_record_pre_action 15:26:13 INFO - Running main action method: setup_mitmproxy 15:26:13 INFO - Skipping: mitmproxy is not required 15:26:13 INFO - Running post-action listener: _resource_record_post_action 15:26:13 INFO - [mozharness: 2017-08-12 22:26:13.730701Z] Finished setup-mitmproxy step (success) 15:26:13 INFO - [mozharness: 2017-08-12 22:26:13.730937Z] Running run-tests step. 15:26:13 INFO - Running pre-action listener: _resource_record_pre_action 15:26:13 INFO - Running pre-action listener: _set_gcov_prefix 15:26:13 INFO - Running main action method: run_tests 15:26:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:26:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:26:13 INFO - Python 2.7.3 15:26:13 INFO - Return code: 0 15:26:13 INFO - grabbing minidump binary from tooltool 15:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:26:13 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4f8a0>, '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 0xd507a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd50c30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:26:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:26:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:26:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:26:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:26:13 INFO - Return code: 0 15:26:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:26:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:26:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:26:13 INFO - ENV: RUST_BACKTRACE is now full 15:26:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:26:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:26:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yx2HVl5oTtyjs-iuTJgx8w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:26:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Yx2HVl5oTtyjs-iuTJgx8w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-071 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:26:13 INFO - Using env: {'DISPLAY': ':0', 15:26:13 INFO - 'HOME': '/home/cltbld', 15:26:13 INFO - 'LANG': 'en_US.UTF-8', 15:26:13 INFO - 'LANGUAGE': 'en_US:en', 15:26:13 INFO - 'LOGNAME': 'cltbld', 15:26:13 INFO - 'MAIL': '/var/mail/cltbld', 15:26:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:26:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:26:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:13 INFO - 'MOZ_NO_REMOTE': '1', 15:26:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:26:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:13 INFO - 'NO_EM_RESTART': '1', 15:26:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:13 INFO - 'PWD': '/builds/slave/test', 15:26:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:26:13 INFO - 'RUST_BACKTRACE': 'full', 15:26:13 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:26:13 INFO - 'SHELL': '/bin/bash', 15:26:13 INFO - 'SHLVL': '1', 15:26:13 INFO - 'STYLO_FORCE_ENABLED': '1', 15:26:13 INFO - 'TERM': 'linux', 15:26:13 INFO - 'TMOUT': '86400', 15:26:13 INFO - 'USER': 'cltbld', 15:26:13 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1502575262.946007-863781298', 15:26:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:13 INFO - '_': '/tools/buildbot/bin/python'} 15:26:13 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/Yx2HVl5oTtyjs-iuTJgx8w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:26:14 INFO - mozversion application_buildid: 20170812213510 15:26:14 INFO - mozversion application_changeset: 6062341662fcee683434ee71539bfa10964c022e 15:26:14 INFO - mozversion application_display_name: Nightly 15:26:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:26:14 INFO - mozversion application_name: Firefox 15:26:14 INFO - mozversion application_remotingname: firefox 15:26:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:26:14 INFO - mozversion application_vendor: Mozilla 15:26:14 INFO - mozversion application_version: 57.0a1 15:26:14 INFO - mozversion platform_buildid: 20170812213510 15:26:14 INFO - mozversion platform_changeset: 6062341662fcee683434ee71539bfa10964c022e 15:26:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:26:14 INFO - mozversion platform_version: 57.0a1 15:26:14 INFO - using testdate: 1502576774 15:26:14 INFO - actual date: 1502576774 15:26:14 INFO - starting webserver on 'localhost:40655' 15:26:14 INFO - SUITE-START | Running 2 tests 15:26:14 INFO - TEST-START | dromaeo_css 15:26:14 INFO - Initialising browser for dromaeo_css test... 15:26:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40655/getInfo.html -profile /tmp/tmpqX3ot4/profile 15:26:14 INFO - TEST-INFO | started process 7830 (/builds/slave/test/build/application/firefox/firefox http://localhost:40655/getInfo.html) 15:26:20 INFO - TEST-INFO | 7830: exit 0 15:26:20 INFO - Browser initialized. 15:26:20 INFO - Running cycle 1/1 for dromaeo_css test... 15:26:20 INFO - TEST-INFO | started process 8068 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqX3ot4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:26:21 INFO - PID 8068 | 15:26:21 INFO - PID 8068 | (/builds/slave/test/build/application/firefox/firefox:8123): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:26:21 INFO - PID 8068 | 15:26:32 INFO - PID 8068 | RSS: Main: 171229184 15:26:32 INFO - PID 8068 | 15:29:31 INFO - PID 8068 | Cycle 1(1): loaded http://localhost:40655/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40655/tests/dromaeo/cssquery-ext.html) 15:29:32 INFO - PID 8068 | RSS: Main: 176107520 15:29:32 INFO - PID 8068 | 15:32:34 INFO - PID 8068 | Cycle 1(1): loaded http://localhost:40655/tests/dromaeo/cssquery-ext.html (next: http://localhost:40655/tests/dromaeo/cssquery-jquery.html) 15:32:35 INFO - PID 8068 | RSS: Main: 173551616 15:32:35 INFO - PID 8068 | 15:35:36 INFO - PID 8068 | Cycle 1(1): loaded http://localhost:40655/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40655/tests/dromaeo/cssquery-mootools.html) 15:35:37 INFO - PID 8068 | RSS: Main: 175370240 15:35:37 INFO - PID 8068 | 15:38:39 INFO - PID 8068 | Cycle 1(1): loaded http://localhost:40655/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40655/tests/dromaeo/cssquery-prototype.html) 15:38:40 INFO - PID 8068 | RSS: Main: 173969408 15:38:40 INFO - PID 8068 | 15:41:43 INFO - PID 8068 | Cycle 1(1): loaded http://localhost:40655/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40655/tests/dromaeo/cssquery-yui.html) 15:41:44 INFO - PID 8068 | RSS: Main: 177442816 15:41:44 INFO - PID 8068 | 15:44:45 INFO - PID 8068 | Cycle 1(1): loaded http://localhost:40655/tests/dromaeo/cssquery-yui.html (next: http://localhost:40655/tests/dromaeo/cssquery-dojo.html) 15:44:46 INFO - PID 8068 | RSS: Main: 177815552 15:44:46 INFO - PID 8068 | 15:44:46 INFO - PID 8068 | __start_tp_report 15:44:46 INFO - PID 8068 | _x_x_mozilla_page_load 15:44:46 INFO - PID 8068 | _x_x_mozilla_page_load_details 15:44:46 INFO - PID 8068 | |i|pagename|runs| 15:44:46 INFO - PID 8068 | |0;dojo.html;3113.8131712097274;3152.085895090424;3165.3985742708883;3171.5242713592957;3176.3488484860604;6115.266168059828;6139.631622102677;6214.3474935131835;6227.221597300338;6262.2172228471445;6157.938420615793;6250.28121765997;6286.308506064341;6306.842328941767;6347.047942808581;5500.6424582402215;5629.8592535186535;5705.942940570603;5722.227499287585;5734.627249228787;5634.7182640867995;5747.310322761254;5767.250257466523;5779.07534794433;5781.19063331134;5662.235598194232;5673.744681489343;5748.223989761371;5765.827025189251;5770.711464426762;5575;5637.210790489335;5681.346645135821;5730.4269573042775;5748.913766293509;5601.579881508903;5607.439256074401;5660.264165658479;5665.688387138705;5675.290588676416;6168.383161683841;6184.381561843825;6187.319394866561;6190.102435146923;6216.906746398808;6656.93489041751;6669.266380698119;6680.076902927347;6740.561863478858;6752.459803215731;6554.93445065548;6681.799546013627;6696.397324240842;6710.3289671033;6780.38976492118;6176.197094377747;6205.286392064971;6205.875882482325;6206.689665516707;6210.9068363974575;6817.590944543244;6823.454123670094;6846.041554182419;6878.69045892936;6953.721851126;6528.347165283433;6598.802035938929;6616.636085015274;6629.668516574152;6630.9336906630315;6610.7025183866845;6655.966720166368;6681.064650948871;6732.2931092235585;6759.324067593201;6490.545661803723;6579.276279609239;6586.637734924625;6651.235107962646;6670.599764014175;6633.668316584151;6682.565633233824;6684.331566843277;6701.329867013357;6710.16122984627;5374.865628359323;5439.945600544023;5456.099743542351;5463.863403414946;5474.890502189934;4624.213883639789;4649.930251046237;4660.627149828006;4670.392848929618;4674.182018146811;5604.943950560442;5643.52030077448;5677.034904066319;5708.971455142698;5792.88414231713;6657.267700552935;6665;6666.866662666719;6670.7665231716655;6732.899006514906;5684.147377893267;5689.630174038674;5761;5764.423557644202;5773.278340207474;5822.184894114827;5882.558808089325;5932.79235226765;5940.584159108821;5945.256842894638;6334.429901308904;6338.873222535523;6355.713992870332;6394.616323020634;6480.222373315232;6701.497387696039;6705.631190284581;6749.662516874038;6773.458123350219;6776.966115169393;6408.455281300955;6463.967680161569;6478.449331806849;6503.479721622353;6516.73933042692;6531.542792004514;6543.116679248241;6580.539362244597;6623.867522649423;6631.767888124085;6584.473242140713;6673.899891501728;6710.194776626836;6727.394534491919;6793;6452.419282264619;6514.153160089348;6527;6537.640429776408;6538.117354157128;6513.772017979348;6515.902261465987;6561.934380656132;6593.835154121185;6595.505337099641;6383.616982981036;6450.161479007887;6498.220213574212;6513.348665133449;6523.706433210422;6455.160829092376;6497.220333560003;6515.73937042513;6584.76953306632;6601.174853143357;6250.531210159347;6338.049292606146;6376.489880809431;6414.61512309263;6428.4214420702365 15:44:46 INFO - PID 8068 | |1;ext.html;808.1635507249994;823.8393513264908;848.2704873808525;871.0723079919889;874.7200895713372;41311.79344103279;42322.57677423225;42354.57645423549;42404.57595424045;42484.15031699372;38115.42826857599;38181.23637527248;38205;38527.22945541095;38628.22743545134;6800.149981252343;6921.930780692204;6926.134233220848;6939;6956.304369563054;6751.662416879137;6820.249772525043;6826.795196144124;6830.419414349762;6852.349026842442;7597.582132982684;7744.341730952848;7775.650095745705;7778.183290754474;7784.104827944802;7658.081030276375;7724.227577242287;7726.536407815549;7729.343005844454;7732.1108072571815;7450.254974502561;7561.168271490132;7639.847203055963;7652.655630496641;7654.846903061907;39172.80413597914;39493.80253098745;39630.207395851925;39659.40510892339;39706.20587588261;3514.5431093957623;3560.2167523144867;3564.536610240678;3566.554180727409;3571.5535558055244;31589.526157107663;31665;31691.524627130613;31784.841075794706;31789.36421271585;5102.770375333119;5122.359705036871;5151.459096794858;5153.613478989053;5225.425203227642;180548;182971;188902;192502;196860.01569992202;49820.25269620959;49907.500924991014;49931.25103123456;49945;50077.49922500801;52608;52674.736626316626;52698.20952685713;52708.73645631747;52720.73639631777;15333.769993450107;15500.224988750517;15507.689846203013;15515.922420387826;15643.374265029272;12794;12794.104412691022;12795.232286062866;12805.807912881315;12822.871771282167;14783.630409239855;14884.73479754233;14893.702125957638;14938.103713777207;15146.621334466727;5701.885962280731;5905.970470147622;5922.644641321534;5923.526117910643;5974.641521508724;985.5909797434128;988.0909563201872;1013.1540163963026;1014.1531820929459;1018.6842078955548;23095.307140785804;23164.073437062667;23535;23640.138132023818;23650.7634923652;1111.4553868604487;1111.6553868300853;1116.369251372988;1120.9719757005978;1130.3387518301722;12426;12516.123871329102;16432.507024789276;16482.175891205392;16550;239660;240321;240644;240764;241202;56216;57144.428555714745;57217.42782572204;57277;57395.71302143546;1428.357239242345;1469.9632509187143;1472.4331132513846;1474.6387135151956;1479.496971029855;27748.58377124385;27826.304342391602;28626.570601440577;28663.856680716464;29368;51596.74201628968;52688;52855.73572132115;52895;52949.205761914374;207284;209526;209554;210069;210423;32104.197395065312;32610.836945815117;32739;36980.63019369772;39640.2071958565;48307.27539086846;49057.50942490529;49102.75448622734;49355.50644493653;50236.4929052129;36082;36452.45321320235;36535.45196822103;36724.81637591795;36735.63264367322;35483.822580887965;35794.463083054296;36039.63960360468;36427.635723643485;36646.26707465782;39846.800765995984;39918.600813991485;40196.799016004734;40248.396274055325;40369.1926161481;35454.8227258862;35723.28553428969;36143;36526.817365913;36910.63089369179;25833.483330333664;25943.740562594132;25955.48089038171;26154.346141345857;26607.866960665848 15:44:46 INFO - PID 8068 | |2;jquery.html;562.2550121089557;573.1746285349094;582.4495851420406;584.7748616782537;593.8634114153745;22561.54876902463;23349;23409.297721068375;23487;24188.427752196138;26264;26634.733652663468;26780.19659410216;26783.732162678367;26827;6436.517261205405;6602.042703807945;6603.570767900095;6613.272540020594;6613.735450581971;5907.970460147693;6377.808665740012;6386.1697979262635;6467.191601049869;6532.11816404784;6365;6370.84072898179;6371.203599550056;6371.267304260023;6389.712462939179;6349.52378571609;6372.171617689693;6377.553571250014;6377.904331435032;6383.936160638381;5922.763089476459;5953.732082056318;5956.970215148896;5958.7616495340135;5976.282846058457;29229.26926826825;30258.394832103455;30792;31136.53295200574;31295.687043129506;1941;1977.2189984955862;1979.6238714644317;1979.7921218272018;1986.4437957371958;18157.63684726311;18952.715709264372;20202.696959545618;20216.898915505328;20330.186792528282;2124.245892708082;2170.4139882231866;2216.4348091236793;2222.744384395799;2222.844400891938;138111;142233;145767.2711636435;153537;156084.21957890253;14646.935388204038;15030.774538381933;15065.09609423438;15178.79907413419;15468.303926323342;23452.530949380918;23551.41121471977;23555.93998270082;23564.882175589013;23569.646455303184;9820.4107753535;10102.585638010685;10119.949400252952;10134.493275336205;10221.875593684688;9249.335119678522;9293.860592091123;9340.673076442292;9396.765080873032;9425.811483770287;9222;9236.815263694689;9319.953400232955;9383.906160938439;9600.567974441166;2638.0898589986423;2675.5585328420593;2697.9612849053256;2748.5190091734266;2779.4580056889117;916.170865366844;950.2682934140673;963.9614415423445;965.7151140413595;979.7942432089199;19693.507662308555;19859.60280794376;19986.500337491387;20103.497412564804;20287.898560507103;995.0894931137927;996.257787947969;1010.2473657125341;1011.7369483934083;1020.7652239984845;10951.397673128055;10979;11110.61112861046;11133.165012624086;11197;454431;465016;469985;472458;478072;114652.42673786578;125895;130217;130731;130919;1236.4188831249298;1278.7889998150388;1299.6425982854792;1302.5375991523063;1310.8426988761219;20822.375328740163;20856.791432085483;20918.16327346889;21141.154353825674;21494.462638434165;58671.70664146652;59851;61317;61334.38665613287;62511;77485;78738.6063069681;78861;78971;79110.60444697739;14401.63995900111;14812.703745924806;14824.40702371893;14858.702825943637;14881.925590371979;23793.64309535393;24001.27996160118;24046.63930041016;24156;24299.514009719354;17722.645547088727;17732;17935.282588696307;17967.820321796615;18102.81897181064;16947.491575252763;17009.234584443482;17212.225449854537;17442.563935901704;17684.557886052953;18327.54181145482;19107.90446047761;19219.711704324167;19573.804261957768;19634.705479417535;14580.781288280896;14660.266986650411;14676.119432834064;14705.70588588201;14725.484608038667;18444.723329150343;18591.16339764687;18764.155612997176;18768.62462750765;19018.1441835115 15:44:46 INFO - PID 8068 | |3;mootools.html;1353.972920541589;1410.89418293628;1411.2379315169808;1413.081497026933;1420.964475888103;14190.858091419082;14756.557303280919;14779.630509237275;14831.406743730266;14866.925665371686;13753.724925501483;14421.423143074291;14889;14946.775798363033;15094.245287735597;2564.0769323043687;2634.0780726745584;2636.894524219029;2639.5908634161738;2642.220544939238;2623.317937336297;2640.4059086705433;2668.5997100434897;2713.0775536317647;2713.4437440324687;2709.376843326036;2734.3437574981963;2742.5749008903554;2742.6297449844315;2742.8765705543296;2594.286571192918;2599.636050952868;2611.1122218445726;2613.0723593124358;2617.986910065447;2579.948401031969;2601.3236558494737;2608.1914606472055;2610.5431549478767;2615.803814713885;14207;14469.638259043502;14476.565703028926;14494.637634059127;14514.70970580593;7458;7716.344110750593;7732.961335193344;7755.922440775576;7760.495567788133;5129.512696293883;5214.45248248936;5271.736413179326;5356.464353564651;5383.111786555213;1929.8482192355564;1945.5914258005835;1948.1428171604591;1953.2772874036698;1993.2624928776445;24722.25833225006;24851.875740621363;24863.62704559433;24925.252242432754;24940.501189976098;6637.269900310962;6645.800625981228;6659.9001014984815;6796.72813087471;6814.62519561419;16408;16467.5883102921;16487.422940197037;16495.752563711554;16527.91736041312;7444.255574442513;7565.583892885944;7576.090869095744;7578.166401695809;7608.277213664693;6895.896561551581;6982.685779139951;7062.329078737512;7068.045813815172;7114.964425177841;5098;5189.143791274473;5238.92141617876;5264.394594621591;5355.544778693777;1359.626102821732;1370.390176371505;1475.2181343887758;1550.4263422533734;1561.3286286896516;925.22281283722;940.9717708468756;941.4868896451451;949.2026697573933;950.2445555783169;7789.454738168387;8113.472624279403;8144;8156.5513896735065;8580.141985801494;990.7467054176473;996.9780974501049;1000.0899181744722;1002.9648962286285;1003.8042581696645;4533.5013148553635;4650.883727906829;4686.851721328297;4712.31671407644;4719.504452032487;19730.30943916956;20204.494887627927;20219.696704549442;20277.391678249674;20445.079971401025;19118.52203694891;19912.800871991385;20224.797752022292;20315.492112697302;20341.694874576893;10168.949155254324;10338.379697218192;10383.688489345332;10424.791504169874;10431.843522347019;8624.655013799378;8876.644934202559;8937.508437036025;8975.910240897507;9086.273098152;16922.576935576217;17658.735118972967;17739.46781596554;17966.191521381308;17992.91003544974;17146.914265428593;17460.30158793634;17640.91179544094;17796.021218833088;18032.819671803114;11802.82295765547;11808.76382472363;12071.215371000857;12088.274703517816;12091.334976576372;12656.936715316364;12806.487740490276;12807.359632018548;12811.551595694105;12879.935600322313;10170.135538479311;10249.692509224735;10906.563737450413;10914.126869850234;11121.666350009513;10404.843927340944;10490.160787136858;10676.519556619816;10840.132789376989;11028;9381.812363752822;9397.765055873659;9422.104900034486;9489.383190092622;9498;7483.625818708934;7552.735654252075;7557.8110547234555;7591.62041897914;7597.392208623407;7514.8497030058;7574.848503030019;7623.771286861403;7689.269519395649;7791.532508049535 15:44:46 INFO - PID 8068 | |4;prototype.html;503.6776463063638;507.3505912432087;514.5600511562615;529.8887233680929;531.9468053194681;6286.6228026318395;6314.105768269524;6316.715747791349;6317;6337.904931426032;6125.05997121382;6128.2646082470055;6146.293176284717;6165.784197553086;6194.876102477948;4835.564799168074;4887.315775791392;4899.412070551539;5013.222950442678;5066.74666266687;4907.460179380265;4933.235348520985;4945.851624451272;4948.480409556999;4959.528844759742;4821.855344339676;4838.467768545457;4867.634927380443;4902.411710594733;4917.164082106033;4855.56299933006;4917.09033828741;4938.234573641092;4954.975225123887;4956.628252881048;4417.536158703354;4448.955510444886;4457.799399027019;4470.351798989128;4480.238359478896;6047.425494578008;6111.236095488064;6112.449879510866;6171.197744293258;6182.505399568069;5662.405447428002;5662.575306851962;5690.146478028288;5695.202671625976;5714.71426428681;6565.409113179837;6576.408123268881;6589.472842172662;6629.86740265192;6672.499562532829;4825.469198388175;4848.5151484851585;4850.951490485085;4867.196912509432;4869.172240719086;6628.171478565179;6799.592024478448;6836.350546698105;6908.930910690879;6969.756058537978;4819.084373968934;4885.60915126789;4894.3147959285725;4900.338454308694;4932.802687892444;4911.4106307243355;4965.875853103629;4985.850424487271;4994.2508623706735;5036.571891389273;5560.277163968658;5570.6657600544095;5620.634658747168;5627.212190293362;5636.323641163087;6475.935240647627;6536.346365363425;6553;6602.7689030883685;6651.567648102858;1704.8550873175918;1725.8791884567959;1731.1171302635494;1767.354915455875;1771.7962434320218;1150.4880328253846;1181.4978634080653;1196.2642974570576;1213.8482689663792;1214.8724383939737;5670.177824215466;5689.573282003867;5699.971500142473;5731;5731.512821410227;6639.701213445406;6654.900176497356;6711.798646040626;6776.69504872282;6792.286809884989;5604.41153678866;5633.746481408347;5635.408282130317;5653.773849045992;5697.891780041328;3499.2126771476724;3559.1280136366754;3570.6786389225094;3592.2456284180093;3616.4936908832783;6334.936650633527;6403.455706265019;6416.582922110048;6447.838804029843;6510.414062734377;6869.862602747917;6904.896426553606;6913.861722765617;6933.722651094001;6933.826654333682;6430.48556115519;6433.613983161025;6433.903491447726;6465.903011454832;6467.223933127961;6731.46148308144;6752.966235168793;6757;6764.188297404146;6770.763023294161;6577.177852768404;6663.566868153554;6676.599404035774;6682;6685.8997115044285;6432.710528026157;6439.261399422036;6478.5465017450215;6483.124778155077;6486.286508483969;4369.694121411598;4931.16170251051;4941.24465406301;4952.331435256338;4963.553280204799;6531.836704082436;6676.0987266718375;6685;6814.182298124058;6814.625195614289;6559.6064236145985;6589.374009469093;6589.703463344065;6629.138212032405;6653.637958524654;6555.508336874849;6575.375339342755;6579.506537009648;6584.539082264196;6585.308542603149;6487.950663188294;6506.25178104524;6532.608043517404;6538.574992625654;6557.2131344239;6586.1438013058;6606.423494837113;6633.772752040888;6635.322097921051;6659.4006539411685;6442.2591401989375;6458.128152699325;6464.997925321582;6466.935330646634;6496.967515162394 15:44:46 INFO - PID 8068 | |5;yui.html;893.8525143351347;918.370915922593;929.0384452092086;933.547229593647;947.4741518457256;18886.90556547217;20012;20025.299114530993;20036.29872954447;22660;21606.675899861515;21819.345419637397;22028.77971220287;22034.44913877154;22038.88980555099;1002.0430488883118;1024.1806554756201;1025.6512785652876;1032.2825636182856;1032.8554002439664;957.8658987741721;1028.2956175020097;1031.144150355207;1036.1451802263125;1040.0743338428804;1099.5821587796627;1102.4542851288622;1103.8013157631624;1112.821948488242;1114.4817659788198;1076.0530732955028;1077.9784404311908;1080.4759691549632;1082.9079528240109;1084.4089970965842;803.3011280186275;804.493169303341;805.8549461097;807.4025221336169;808.7007807111347;20301.695474567892;20351.18595256188;20444.977751112387;20533.5893282135;21118.683219751714;21683.566328673496;22067.779322206734;22150.22474213411;22209.888950555145;22747.886260568757;16379.344826206938;16673.91619544726;16915.3233870645;17033.82966170335;17094.572635684082;3488.4244099723514;3489.70337521311;3492.703120234783;3499.3526197653514;3499.965000349989;131005.34497327548;131071;131302;131654;135703;17390.304387824344;17564.38524651631;17846.286148554173;18013.549661258312;18015.909920450576;32344.514832277535;32674.183145421553;32878.67121328804;32967.17582060468;33009.174770630925;7317.231690672509;8094.433389662785;8454.746357609281;8555.743327700178;8846.336524760669;4113.773742444194;4218.156368726267;4221.050263690645;4221.282381995068;4221.767802770877;5283.286756287929;5401.513863752281;5412.945870541323;5422.078246698071;5431.782728690808;1072.0673014477454;1088.4448931045224;1110.9944450277696;1112.4437781109445;1112.7329440934118;616.4390404731762;623.538581449733;626.7900253415157;641.6503005861816;641.8652083062609;11827;11861.46623401949;12423.555212201225;13035.608931732064;13291.069625126149;670.6981858163846;680.1939701453794;681.0431343961742;683.3747121383977;694.9131358580178;5138.97430512845;5245.449227831023;5259.8422047338645;5294.523492885659;6143.723532440961;110582;111649;113269.43365283286;115323.42338288423;120173;99891.50054249828;101545;104700.47649761703;105221.94778052121;107059.46470267755;88322.55838720765;88823.55588222017;89476.10523894808;92859;93197.53401233086;11916.285022898654;12232.510699571918;12268.631941041784;12505.811947864939;12536.623901282976;37680.623193767715;39329.41005884971;39438.80280598579;39556.60443395529;41113.79443102765;70526.94209586758;85254;86233.56883215543;87167;90775;20186.596268074263;20770.79229207749;20882.1647134119;21002.264920727703;21215;22261.88869055709;22427.887860560593;22892.4276893079;23013.539729204986;23394.298171054896;18053.277868885623;19516.707249391555;19675.40973770789;19764.11061502207;19934.601307974048;18588.535286617942;18597.163127659016;18756.249750010393;20501.282455114;20880;18986.52533686669;19121.617567648293;19144.521386965436;19147.234110635418;19304.517387064872;12125.393730313626;12384.318862462651;12425.875741242833;12594.433250503565;12814.103012789388;13811.861881381057;14257.71484570282;14293.499727509903;14331.785023224451;14331.78502322487 15:44:46 INFO - PID 8068 | __end_tp_report 15:44:46 INFO - PID 8068 | __start_cc_report 15:44:46 INFO - PID 8068 | _x_x_mozilla_cycle_collect,386 15:44:46 INFO - PID 8068 | __end_cc_report 15:44:46 INFO - PID 8068 | __startTimestamp1502577886173__endTimestamp 15:44:46 INFO - PID 8068 | 15:44:46 INFO - PID 8068 | ------- Summary: start ------- 15:44:46 INFO - PID 8068 | Number of tests: 6 15:44:46 INFO - PID 8068 | 15:44:46 INFO - PID 8068 | [#0] dojo.html Cycles:165 Average:6141.76 Median:6394.62 stddev:725.32 (11.3%) stddev-sans-first:687.55 15:44:46 INFO - PID 8068 | Values: 3113.8 3152.1 3165.4 3171.5 3176.3 6115.3 6139.6 6214.3 6227.2 6262.2 6157.9 6250.3 6286.3 6306.8 6347.0 5500.6 5629.9 5705.9 5722.2 5734.6 5634.7 5747.3 5767.3 5779.1 5781.2 5662.2 5673.7 5748.2 5765.8 5770.7 5575.0 5637.2 5681.3 5730.4 5748.9 5601.6 5607.4 5660.3 5665.7 5675.3 6168.4 6184.4 6187.3 6190.1 6216.9 6656.9 6669.3 6680.1 6740.6 6752.5 6554.9 6681.8 6696.4 6710.3 6780.4 6176.2 6205.3 6205.9 6206.7 6210.9 6817.6 6823.5 6846.0 6878.7 6953.7 6528.3 6598.8 6616.6 6629.7 6630.9 6610.7 6656.0 6681.1 6732.3 6759.3 6490.5 6579.3 6586.6 6651.2 6670.6 6633.7 6682.6 6684.3 6701.3 6710.2 5374.9 5439.9 5456.1 5463.9 5474.9 4624.2 4649.9 4660.6 4670.4 4674.2 5604.9 5643.5 5677.0 5709.0 5792.9 6657.3 6665.0 6666.9 6670.8 6732.9 5684.1 5689.6 5761.0 5764.4 5773.3 5822.2 5882.6 5932.8 5940.6 5945.3 6334.4 6338.9 6355.7 6394.6 6480.2 6701.5 6705.6 6749.7 6773.5 6777.0 6408.5 6464.0 6478.4 6503.5 6516.7 6531.5 6543.1 6580.5 6623.9 6631.8 6584.5 6673.9 6710.2 6727.4 6793.0 6452.4 6514.2 6527.0 6537.6 6538.1 6513.8 6515.9 6561.9 6593.8 6595.5 6383.6 6450.2 6498.2 6513.3 6523.7 6455.2 6497.2 6515.7 6584.8 6601.2 6250.5 6338.0 6376.5 6414.6 6428.4 15:44:46 INFO - PID 8068 | 15:44:46 INFO - PID 8068 | [#1] ext.html Cycles:180 Average:39638.93 Median:36945.63 stddev:55476.39 (150.2%) stddev-sans-first:55555.39 15:44:46 INFO - PID 8068 | Values: 808.2 823.8 848.3 871.1 874.7 41311.8 42322.6 42354.6 42404.6 42484.2 38115.4 38181.2 38205.0 38527.2 38628.2 6800.1 6921.9 6926.1 6939.0 6956.3 6751.7 6820.2 6826.8 6830.4 6852.3 7597.6 7744.3 7775.7 7778.2 7784.1 7658.1 7724.2 7726.5 7729.3 7732.1 7450.3 7561.2 7639.8 7652.7 7654.8 39172.8 39493.8 39630.2 39659.4 39706.2 3514.5 3560.2 3564.5 3566.6 3571.6 31589.5 31665.0 31691.5 31784.8 31789.4 5102.8 5122.4 5151.5 5153.6 5225.4 180548.0 182971.0 188902.0 192502.0 196860.0 49820.3 49907.5 49931.3 49945.0 50077.5 52608.0 52674.7 52698.2 52708.7 52720.7 15333.8 15500.2 15507.7 15515.9 15643.4 12794.0 12794.1 12795.2 12805.8 12822.9 14783.6 14884.7 14893.7 14938.1 15146.6 5701.9 5906.0 5922.6 5923.5 5974.6 985.6 988.1 1013.2 1014.2 1018.7 23095.3 23164.1 23535.0 23640.1 23650.8 1111.5 1111.7 1116.4 1121.0 1130.3 12426.0 12516.1 16432.5 16482.2 16550.0 239660.0 240321.0 240644.0 240764.0 241202.0 56216.0 57144.4 57217.4 57277.0 57395.7 1428.4 1470.0 1472.4 1474.6 1479.5 27748.6 27826.3 28626.6 28663.9 29368.0 51596.7 52688.0 52855.7 52895.0 52949.2 207284.0 209526.0 209554.0 210069.0 210423.0 32104.2 32610.8 32739.0 36980.6 39640.2 48307.3 49057.5 49102.8 49355.5 50236.5 36082.0 36452.5 36535.5 36724.8 36735.6 35483.8 35794.5 36039.6 36427.6 36646.3 39846.8 39918.6 40196.8 40248.4 40369.2 35454.8 35723.3 36143.0 36526.8 36910.6 25833.5 25943.7 25955.5 26154.3 26607.9 15:44:46 INFO - PID 8068 | 15:44:46 INFO - PID 8068 | [#2] jquery.html Cycles:180 Average:35263.73 Median:23469.77 stddev:79994.54 (340.8%) stddev-sans-first:80176.51 15:44:46 INFO - PID 8068 | Values: 562.3 573.2 582.4 584.8 593.9 22561.5 23349.0 23409.3 23487.0 24188.4 26264.0 26634.7 26780.2 26783.7 26827.0 6436.5 6602.0 6603.6 6613.3 6613.7 5908.0 6377.8 6386.2 6467.2 6532.1 6365.0 6370.8 6371.2 6371.3 6389.7 6349.5 6372.2 6377.6 6377.9 6383.9 5922.8 5953.7 5957.0 5958.8 5976.3 29229.3 30258.4 30792.0 31136.5 31295.7 1941.0 1977.2 1979.6 1979.8 1986.4 18157.6 18952.7 20202.7 20216.9 20330.2 2124.2 2170.4 2216.4 2222.7 2222.8 138111.0 142233.0 145767.3 153537.0 156084.2 14646.9 15030.8 15065.1 15178.8 15468.3 23452.5 23551.4 23555.9 23564.9 23569.6 9820.4 10102.6 10119.9 10134.5 10221.9 9249.3 9293.9 9340.7 9396.8 9425.8 9222.0 9236.8 9320.0 9383.9 9600.6 2638.1 2675.6 2698.0 2748.5 2779.5 916.2 950.3 964.0 965.7 979.8 19693.5 19859.6 19986.5 20103.5 20287.9 995.1 996.3 1010.2 1011.7 1020.8 10951.4 10979.0 11110.6 11133.2 11197.0 454431.0 465016.0 469985.0 472458.0 478072.0 114652.4 125895.0 130217.0 130731.0 130919.0 1236.4 1278.8 1299.6 1302.5 1310.8 20822.4 20856.8 20918.2 21141.2 21494.5 58671.7 59851.0 61317.0 61334.4 62511.0 77485.0 78738.6 78861.0 78971.0 79110.6 14401.6 14812.7 14824.4 14858.7 14881.9 23793.6 24001.3 24046.6 24156.0 24299.5 17722.6 17732.0 17935.3 17967.8 18102.8 16947.5 17009.2 17212.2 17442.6 17684.6 18327.5 19107.9 19219.7 19573.8 19634.7 14580.8 14660.3 14676.1 14705.7 14725.5 18444.7 18591.2 18764.2 18768.6 19018.1 15:44:46 INFO - PID 8068 | 15:44:46 INFO - PID 8068 | [#3] mootools.html Cycles:180 Average:8966.85 Median:2596.96 stddev:6224.57 (239.7%) stddev-sans-first:6215.75 15:44:46 INFO - PID 8068 | Values: 1354.0 1410.9 1411.2 1413.1 1421.0 14190.9 14756.6 14779.6 14831.4 14866.9 13753.7 14421.4 14889.0 14946.8 15094.2 2564.1 2634.1 2636.9 2639.6 2642.2 2623.3 2640.4 2668.6 2713.1 2713.4 2709.4 2734.3 2742.6 2742.6 2742.9 2594.3 2599.6 2611.1 2613.1 2618.0 2579.9 2601.3 2608.2 2610.5 2615.8 14207.0 14469.6 14476.6 14494.6 14514.7 7458.0 7716.3 7733.0 7755.9 7760.5 5129.5 5214.5 5271.7 5356.5 5383.1 1929.8 1945.6 1948.1 1953.3 1993.3 24722.3 24851.9 24863.6 24925.3 24940.5 6637.3 6645.8 6659.9 6796.7 6814.6 16408.0 16467.6 16487.4 16495.8 16527.9 7444.3 7565.6 7576.1 7578.2 7608.3 6895.9 6982.7 7062.3 7068.0 7115.0 5098.0 5189.1 5238.9 5264.4 5355.5 1359.6 1370.4 1475.2 1550.4 1561.3 925.2 941.0 941.5 949.2 950.2 7789.5 8113.5 8144.0 8156.6 8580.1 990.7 997.0 1000.1 1003.0 1003.8 4533.5 4650.9 4686.9 4712.3 4719.5 19730.3 20204.5 20219.7 20277.4 20445.1 19118.5 19912.8 20224.8 20315.5 20341.7 10168.9 10338.4 10383.7 10424.8 10431.8 8624.7 8876.6 8937.5 8975.9 9086.3 16922.6 17658.7 17739.5 17966.2 17992.9 17146.9 17460.3 17640.9 17796.0 18032.8 11802.8 11808.8 12071.2 12088.3 12091.3 12656.9 12806.5 12807.4 12811.6 12879.9 10170.1 10249.7 10906.6 10914.1 11121.7 10404.8 10490.2 10676.5 10840.1 11028.0 9381.8 9397.8 9422.1 9489.4 9498.0 7483.6 7552.7 7557.8 7591.6 7597.4 7514.8 7574.8 7623.8 7689.3 7791.5 15:44:46 INFO - PID 8068 | 15:44:46 INFO - PID 8068 | [#4] prototype.html Cycles:180 Average:5494.25 Median:6156.04 stddev:1560.53 (25.3%) stddev-sans-first:1519.29 15:44:46 INFO - PID 8068 | Values: 503.7 507.4 514.6 529.9 531.9 6286.6 6314.1 6316.7 6317.0 6337.9 6125.1 6128.3 6146.3 6165.8 6194.9 4835.6 4887.3 4899.4 5013.2 5066.7 4907.5 4933.2 4945.9 4948.5 4959.5 4821.9 4838.5 4867.6 4902.4 4917.2 4855.6 4917.1 4938.2 4955.0 4956.6 4417.5 4449.0 4457.8 4470.4 4480.2 6047.4 6111.2 6112.4 6171.2 6182.5 5662.4 5662.6 5690.1 5695.2 5714.7 6565.4 6576.4 6589.5 6629.9 6672.5 4825.5 4848.5 4851.0 4867.2 4869.2 6628.2 6799.6 6836.4 6908.9 6969.8 4819.1 4885.6 4894.3 4900.3 4932.8 4911.4 4965.9 4985.9 4994.3 5036.6 5560.3 5570.7 5620.6 5627.2 5636.3 6475.9 6536.3 6553.0 6602.8 6651.6 1704.9 1725.9 1731.1 1767.4 1771.8 1150.5 1181.5 1196.3 1213.8 1214.9 5670.2 5689.6 5700.0 5731.0 5731.5 6639.7 6654.9 6711.8 6776.7 6792.3 5604.4 5633.7 5635.4 5653.8 5697.9 3499.2 3559.1 3570.7 3592.2 3616.5 6334.9 6403.5 6416.6 6447.8 6510.4 6869.9 6904.9 6913.9 6933.7 6933.8 6430.5 6433.6 6433.9 6465.9 6467.2 6731.5 6753.0 6757.0 6764.2 6770.8 6577.2 6663.6 6676.6 6682.0 6685.9 6432.7 6439.3 6478.5 6483.1 6486.3 4369.7 4931.2 4941.2 4952.3 4963.6 6531.8 6676.1 6685.0 6814.2 6814.6 6559.6 6589.4 6589.7 6629.1 6653.6 6555.5 6575.4 6579.5 6584.5 6585.3 6488.0 6506.3 6532.6 6538.6 6557.2 6586.1 6606.4 6633.8 6635.3 6659.4 6442.3 6458.1 6465.0 6466.9 6497.0 15:44:46 INFO - PID 8068 | 15:44:46 INFO - PID 8068 | [#5] yui.html Cycles:180 Average:25124.31 Median:20652.19 stddev:34169.52 (165.5%) stddev-sans-first:34216.93 15:44:46 INFO - PID 8068 | Values: 893.9 918.4 929.0 933.5 947.5 18886.9 20012.0 20025.3 20036.3 22660.0 21606.7 21819.3 22028.8 22034.4 22038.9 1002.0 1024.2 1025.7 1032.3 1032.9 957.9 1028.3 1031.1 1036.1 1040.1 1099.6 1102.5 1103.8 1112.8 1114.5 1076.1 1078.0 1080.5 1082.9 1084.4 803.3 804.5 805.9 807.4 808.7 20301.7 20351.2 20445.0 20533.6 21118.7 21683.6 22067.8 22150.2 22209.9 22747.9 16379.3 16673.9 16915.3 17033.8 17094.6 3488.4 3489.7 3492.7 3499.4 3500.0 131005.3 131071.0 131302.0 131654.0 135703.0 17390.3 17564.4 17846.3 18013.5 18015.9 32344.5 32674.2 32878.7 32967.2 33009.2 7317.2 8094.4 8454.7 8555.7 8846.3 4113.8 4218.2 4221.1 4221.3 4221.8 5283.3 5401.5 5412.9 5422.1 5431.8 1072.1 1088.4 1111.0 1112.4 1112.7 616.4 623.5 626.8 641.7 641.9 11827.0 11861.5 12423.6 13035.6 13291.1 670.7 680.2 681.0 683.4 694.9 5139.0 5245.4 5259.8 5294.5 6143.7 110582.0 111649.0 113269.4 115323.4 120173.0 99891.5 101545.0 104700.5 105221.9 107059.5 88322.6 88823.6 89476.1 92859.0 93197.5 11916.3 12232.5 12268.6 12505.8 12536.6 37680.6 39329.4 39438.8 39556.6 41113.8 70526.9 85254.0 86233.6 87167.0 90775.0 20186.6 20770.8 20882.2 21002.3 21215.0 22261.9 22427.9 22892.4 23013.5 23394.3 18053.3 19516.7 19675.4 19764.1 19934.6 18588.5 18597.2 18756.2 20501.3 20880.0 18986.5 19121.6 19144.5 19147.2 19304.5 12125.4 12384.3 12425.9 12594.4 12814.1 13811.9 14257.7 14293.5 14331.8 14331.8 15:44:46 INFO - PID 8068 | -------- Summary: end -------- 15:44:46 INFO - PID 8068 | 15:44:46 INFO - TEST-INFO | 8068: exit 0 15:44:46 INFO - TEST-OK | dromaeo_css | took 1112741ms 15:44:46 INFO - TEST-START | kraken 15:44:46 INFO - Initialising browser for kraken test... 15:44:46 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40655/getInfo.html -profile /tmp/tmpmx9xTw/profile 15:44:46 INFO - TEST-INFO | started process 8444 (/builds/slave/test/build/application/firefox/firefox http://localhost:40655/getInfo.html) 15:44:52 INFO - TEST-INFO | 8444: exit 0 15:44:52 INFO - Browser initialized. 15:44:52 INFO - Running cycle 1/1 for kraken test... 15:44:52 INFO - TEST-INFO | started process 8681 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmx9xTw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:44:53 INFO - PID 8681 | 15:44:53 INFO - PID 8681 | (/builds/slave/test/build/application/firefox/firefox:8736): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:44:53 INFO - PID 8681 | 15:45:04 INFO - PID 8681 | RSS: Main: 167555072 15:45:04 INFO - PID 8681 | 15:45:07 INFO - PID 8681 | Cycle 1(1): loaded http://localhost:40655/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40655/tests/kraken/driver.html?testName=audio-beat-detection) 15:45:07 INFO - PID 8681 | RSS: Main: 173944832 15:45:07 INFO - PID 8681 | 15:45:10 INFO - PID 8681 | Cycle 1(1): loaded http://localhost:40655/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40655/tests/kraken/driver.html?testName=audio-dft) 15:45:11 INFO - PID 8681 | RSS: Main: 174845952 15:45:11 INFO - PID 8681 | 15:45:14 INFO - PID 8681 | Cycle 1(1): loaded http://localhost:40655/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40655/tests/kraken/driver.html?testName=audio-fft) 15:45:15 INFO - PID 8681 | RSS: Main: 169807872 15:45:15 INFO - PID 8681 | 15:45:17 INFO - PID 8681 | Cycle 1(1): loaded http://localhost:40655/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40655/tests/kraken/driver.html?testName=audio-oscillator) 15:45:17 INFO - PID 8681 | RSS: Main: 170455040 15:45:17 INFO - PID 8681 | 15:45:20 INFO - PID 8681 | Cycle 1(1): loaded http://localhost:40655/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40655/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:45:20 INFO - PID 8681 | RSS: Main: 170106880 15:45:20 INFO - PID 8681 | 15:45:23 INFO - PID 8681 | Cycle 1(1): loaded http://localhost:40655/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40655/tests/kraken/driver.html?testName=imaging-darkroom) 15:45:24 INFO - PID 8681 | RSS: Main: 172879872 15:45:24 INFO - PID 8681 | 15:45:28 INFO - PID 8681 | Cycle 1(1): loaded http://localhost:40655/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40655/tests/kraken/driver.html?testName=imaging-desaturate) 15:45:28 INFO - PID 8681 | RSS: Main: 171945984 15:45:28 INFO - PID 8681 | 15:45:31 INFO - PID 8681 | Cycle 1(1): loaded http://localhost:40655/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40655/tests/kraken/driver.html?testName=json-parse-financial) 15:45:32 INFO - PID 8681 | RSS: Main: 173637632 15:45:32 INFO - PID 8681 | 15:45:33 INFO - PID 8681 | Cycle 1(1): loaded http://localhost:40655/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40655/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:45:34 INFO - PID 8681 | RSS: Main: 173305856 15:45:34 INFO - PID 8681 | 15:45:36 INFO - PID 8681 | Cycle 1(1): loaded http://localhost:40655/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40655/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:45:37 INFO - PID 8681 | RSS: Main: 173187072 15:45:37 INFO - PID 8681 | 15:45:39 INFO - PID 8681 | Cycle 1(1): loaded http://localhost:40655/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40655/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:45:39 INFO - PID 8681 | RSS: Main: 173555712 15:45:39 INFO - PID 8681 | 15:45:42 INFO - PID 8681 | Cycle 1(1): loaded http://localhost:40655/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40655/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:45:43 INFO - PID 8681 | RSS: Main: 174092288 15:45:43 INFO - PID 8681 | 15:45:46 INFO - PID 8681 | Cycle 1(1): loaded http://localhost:40655/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40655/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:45:47 INFO - PID 8681 | RSS: Main: 174256128 15:45:47 INFO - PID 8681 | 15:45:49 INFO - PID 8681 | Cycle 1(1): loaded http://localhost:40655/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40655/tests/kraken/driver.html?testName=ai-astar) 15:45:49 INFO - PID 8681 | RSS: Main: 175804416 15:45:49 INFO - PID 8681 | 15:45:49 INFO - PID 8681 | __start_tp_report 15:45:49 INFO - PID 8681 | _x_x_mozilla_page_load 15:45:49 INFO - PID 8681 | _x_x_mozilla_page_load_details 15:45:49 INFO - PID 8681 | |i|pagename|runs| 15:45:49 INFO - PID 8681 | |0;ai-astar;99;107;101;110;115;108;110;110;111;111 15:45:49 INFO - PID 8681 | |1;audio-beat-detection;143;117;144;184;119;141;159;133;175;118 15:45:49 INFO - PID 8681 | |2;audio-dft;164;172;172;162;164;171;168;165;168;165 15:45:49 INFO - PID 8681 | |3;audio-fft;76;77;77;176;76;79;76;75;158;76 15:45:49 INFO - PID 8681 | |4;audio-oscillator;80;79;144;78;79;78;135;82;80;126 15:45:49 INFO - PID 8681 | |5;imaging-gaussian-blur;113;118;115;114;118;118;116;115;114;114 15:45:49 INFO - PID 8681 | |6;imaging-darkroom;151;152;149;150;152;150;156;156;149;151 15:45:49 INFO - PID 8681 | |7;imaging-desaturate;94;97;94;96;99;95;94;94;94;94 15:45:49 INFO - PID 8681 | |8;json-parse-financial;54;52;52;52;54;53;54;54;57;53 15:45:49 INFO - PID 8681 | |9;json-stringify-tinderbox;54;54;55;54;55;55;58;55;56;59 15:45:49 INFO - PID 8681 | |10;stanford-crypto-aes;77;78;77;78;83;78;78;77;78;79 15:45:49 INFO - PID 8681 | |11;stanford-crypto-ccm;134;122;136;123;125;133;127;132;122;170 15:45:49 INFO - PID 8681 | |12;stanford-crypto-pbkdf2;187;182;174;180;194;181;193;178;174;181 15:45:49 INFO - PID 8681 | |13;stanford-crypto-sha256-iterative;67;67;70;69;69;77;67;69;66;69 15:45:49 INFO - PID 8681 | __end_tp_report 15:45:49 INFO - PID 8681 | __start_cc_report 15:45:49 INFO - PID 8681 | _x_x_mozilla_cycle_collect,1031 15:45:49 INFO - PID 8681 | __end_cc_report 15:45:49 INFO - PID 8681 | __startTimestamp1502577949291__endTimestamp 15:45:49 INFO - PID 8681 | 15:45:49 INFO - PID 8681 | ------- Summary: start ------- 15:45:49 INFO - PID 8681 | Number of tests: 14 15:45:49 INFO - PID 8681 | 15:45:49 INFO - PID 8681 | [#0] ai-astar Cycles:10 Average:108.20 Median:110.50 stddev:4.83 (4.4%) stddev-sans-first:3.80 15:45:49 INFO - PID 8681 | Values: 99.0 107.0 101.0 110.0 115.0 108.0 110.0 110.0 111.0 111.0 15:45:49 INFO - PID 8681 | 15:45:49 INFO - PID 8681 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:143.50 stddev:23.43 (16.3%) stddev-sans-first:24.85 15:45:49 INFO - PID 8681 | Values: 143.0 117.0 144.0 184.0 119.0 141.0 159.0 133.0 175.0 118.0 15:45:49 INFO - PID 8681 | 15:45:49 INFO - PID 8681 | [#2] audio-dft Cycles:10 Average:167.10 Median:168.00 stddev:3.63 (2.2%) stddev-sans-first:3.68 15:45:49 INFO - PID 8681 | Values: 164.0 172.0 172.0 162.0 164.0 171.0 168.0 165.0 168.0 165.0 15:45:49 INFO - PID 8681 | 15:45:49 INFO - PID 8681 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.00 stddev:38.41 (50.5%) stddev-sans-first:40.14 15:45:49 INFO - PID 8681 | Values: 76.0 77.0 77.0 176.0 76.0 79.0 76.0 75.0 158.0 76.0 15:45:49 INFO - PID 8681 | 15:45:49 INFO - PID 8681 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:79.00 stddev:27.20 (34.4%) stddev-sans-first:28.22 15:45:49 INFO - PID 8681 | Values: 80.0 79.0 144.0 78.0 79.0 78.0 135.0 82.0 80.0 126.0 15:45:49 INFO - PID 8681 | 15:45:49 INFO - PID 8681 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:115.50 stddev:1.90 (1.6%) stddev-sans-first:1.79 15:45:49 INFO - PID 8681 | Values: 113.0 118.0 115.0 114.0 118.0 118.0 116.0 115.0 114.0 114.0 15:45:49 INFO - PID 8681 | 15:45:49 INFO - PID 8681 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:151.50 stddev:2.55 (1.7%) stddev-sans-first:2.69 15:45:49 INFO - PID 8681 | Values: 151.0 152.0 149.0 150.0 152.0 150.0 156.0 156.0 149.0 151.0 15:45:49 INFO - PID 8681 | 15:45:49 INFO - PID 8681 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:94.50 stddev:1.73 (1.8%) stddev-sans-first:1.79 15:45:49 INFO - PID 8681 | Values: 94.0 97.0 94.0 96.0 99.0 95.0 94.0 94.0 94.0 94.0 15:45:49 INFO - PID 8681 | 15:45:49 INFO - PID 8681 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:54.00 stddev:1.51 (2.8%) stddev-sans-first:1.59 15:45:49 INFO - PID 8681 | Values: 54.0 52.0 52.0 52.0 54.0 53.0 54.0 54.0 57.0 53.0 15:45:49 INFO - PID 8681 | 15:45:49 INFO - PID 8681 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:55.00 stddev:1.72 (3.1%) stddev-sans-first:1.73 15:45:49 INFO - PID 8681 | Values: 54.0 54.0 55.0 54.0 55.0 55.0 58.0 55.0 56.0 59.0 15:45:49 INFO - PID 8681 | 15:45:49 INFO - PID 8681 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:78.00 stddev:1.77 (2.3%) stddev-sans-first:1.81 15:45:49 INFO - PID 8681 | Values: 77.0 78.0 77.0 78.0 83.0 78.0 78.0 77.0 78.0 79.0 15:45:49 INFO - PID 8681 | 15:45:49 INFO - PID 8681 | [#11] stanford-crypto-ccm Cycles:10 Average:132.40 Median:132.50 stddev:14.21 (10.7%) stddev-sans-first:15.06 15:45:49 INFO - PID 8681 | Values: 134.0 122.0 136.0 123.0 125.0 133.0 127.0 132.0 122.0 170.0 15:45:49 INFO - PID 8681 | 15:45:49 INFO - PID 8681 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.40 Median:181.50 stddev:6.98 (3.8%) stddev-sans-first:7.20 15:45:49 INFO - PID 8681 | Values: 187.0 182.0 174.0 180.0 194.0 181.0 193.0 178.0 174.0 181.0 15:45:49 INFO - PID 8681 | 15:45:49 INFO - PID 8681 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:3.09 (4.5%) stddev-sans-first:3.19 15:45:49 INFO - PID 8681 | Values: 67.0 67.0 70.0 69.0 69.0 77.0 67.0 69.0 66.0 69.0 15:45:49 INFO - PID 8681 | -------- Summary: end -------- 15:45:49 INFO - PID 8681 | 15:45:49 INFO - PID 8681 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:45:49 INFO - TEST-INFO | 8681: exit 0 15:45:49 INFO - TEST-OK | kraken | took 63095ms 15:45:49 INFO - SUITE-END | took 1175s 15:45:49 INFO - Completed test suite (00:19:35) 15:45:49 INFO - javascript benchmark 15:45:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8620.082500440343, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3113.8131712097274, 3152.085895090424, 3165.3985742708883, 3171.5242713592957, 3176.3488484860604, 6115.266168059828, 6139.631622102677, 6214.3474935131835, 6227.221597300338, 6262.2172228471445, 6157.938420615793, 6250.28121765997, 6286.308506064341, 6306.842328941767, 6347.047942808581, 5500.6424582402215, 5629.8592535186535, 5705.942940570603, 5722.227499287585, 5734.627249228787, 5634.7182640867995, 5747.310322761254, 5767.250257466523, 5779.07534794433, 5781.19063331134, 5662.235598194232, 5673.744681489343, 5748.223989761371, 5765.827025189251, 5770.711464426762, 5575.0, 5637.210790489335, 5681.346645135821, 5730.4269573042775, 5748.913766293509, 5601.579881508903, 5607.439256074401, 5660.264165658479, 5665.688387138705, 5675.290588676416, 6168.383161683841, 6184.381561843825, 6187.319394866561, 6190.102435146923, 6216.906746398808, 6656.93489041751, 6669.266380698119, 6680.076902927347, 6740.561863478858, 6752.459803215731, 6554.93445065548, 6681.799546013627, 6696.397324240842, 6710.3289671033, 6780.38976492118, 6176.197094377747, 6205.286392064971, 6205.875882482325, 6206.689665516707, 6210.9068363974575, 6817.590944543244, 6823.454123670094, 6846.041554182419, 6878.69045892936, 6953.721851126, 6528.347165283433, 6598.802035938929, 6616.636085015274, 6629.668516574152, 6630.9336906630315, 6610.7025183866845, 6655.966720166368, 6681.064650948871, 6732.2931092235585, 6759.324067593201, 6490.545661803723, 6579.276279609239, 6586.637734924625, 6651.235107962646, 6670.599764014175, 6633.668316584151, 6682.565633233824, 6684.331566843277, 6701.329867013357, 6710.16122984627, 5374.865628359323, 5439.945600544023, 5456.099743542351, 5463.863403414946, 5474.890502189934, 4624.213883639789, 4649.930251046237, 4660.627149828006, 4670.392848929618, 4674.182018146811, 5604.943950560442, 5643.52030077448, 5677.034904066319, 5708.971455142698, 5792.88414231713, 6657.267700552935, 6665.0, 6666.866662666719, 6670.7665231716655, 6732.899006514906, 5684.147377893267, 5689.630174038674, 5761.0, 5764.423557644202, 5773.278340207474, 5822.184894114827, 5882.558808089325, 5932.79235226765, 5940.584159108821, 5945.256842894638, 6334.429901308904, 6338.873222535523, 6355.713992870332, 6394.616323020634, 6480.222373315232, 6701.497387696039, 6705.631190284581, 6749.662516874038, 6773.458123350219, 6776.966115169393, 6408.455281300955, 6463.967680161569, 6478.449331806849, 6503.479721622353, 6516.73933042692, 6531.542792004514, 6543.116679248241, 6580.539362244597, 6623.867522649423, 6631.767888124085, 6584.473242140713, 6673.899891501728, 6710.194776626836, 6727.394534491919, 6793.0, 6452.419282264619, 6514.153160089348, 6527.0, 6537.640429776408, 6538.117354157128, 6513.772017979348, 6515.902261465987, 6561.934380656132, 6593.835154121185, 6595.505337099641, 6383.616982981036, 6450.161479007887, 6498.220213574212, 6513.348665133449, 6523.706433210422, 6455.160829092376, 6497.220333560003, 6515.73937042513, 6584.76953306632, 6601.174853143357, 6250.531210159347, 6338.049292606146, 6376.489880809431, 6414.61512309263, 6428.4214420702365], "value": 6087.361884135871, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [808.1635507249994, 823.8393513264908, 848.2704873808525, 871.0723079919889, 874.7200895713372, 41311.79344103279, 42322.57677423225, 42354.57645423549, 42404.57595424045, 42484.15031699372, 38115.42826857599, 38181.23637527248, 38205.0, 38527.22945541095, 38628.22743545134, 6800.149981252343, 6921.930780692204, 6926.134233220848, 6939.0, 6956.304369563054, 6751.662416879137, 6820.249772525043, 6826.795196144124, 6830.419414349762, 6852.349026842442, 7597.582132982684, 7744.341730952848, 7775.650095745705, 7778.183290754474, 7784.104827944802, 7658.081030276375, 7724.227577242287, 7726.536407815549, 7729.343005844454, 7732.1108072571815, 7450.254974502561, 7561.168271490132, 7639.847203055963, 7652.655630496641, 7654.846903061907, 39172.80413597914, 39493.80253098745, 39630.207395851925, 39659.40510892339, 39706.20587588261, 3514.5431093957623, 3560.2167523144867, 3564.536610240678, 3566.554180727409, 3571.5535558055244, 31589.526157107663, 31665.0, 31691.524627130613, 31784.841075794706, 31789.36421271585, 5102.770375333119, 5122.359705036871, 5151.459096794858, 5153.613478989053, 5225.425203227642, 180548.0, 182971.0, 188902.0, 192502.0, 196860.01569992202, 49820.25269620959, 49907.500924991014, 49931.25103123456, 49945.0, 50077.49922500801, 52608.0, 52674.736626316626, 52698.20952685713, 52708.73645631747, 52720.73639631777, 15333.769993450107, 15500.224988750517, 15507.689846203013, 15515.922420387826, 15643.374265029272, 12794.0, 12794.104412691022, 12795.232286062866, 12805.807912881315, 12822.871771282167, 14783.630409239855, 14884.73479754233, 14893.702125957638, 14938.103713777207, 15146.621334466727, 5701.885962280731, 5905.970470147622, 5922.644641321534, 5923.526117910643, 5974.641521508724, 985.5909797434128, 988.0909563201872, 1013.1540163963026, 1014.1531820929459, 1018.6842078955548, 23095.307140785804, 23164.073437062667, 23535.0, 23640.138132023818, 23650.7634923652, 1111.4553868604487, 1111.6553868300853, 1116.369251372988, 1120.9719757005978, 1130.3387518301722, 12426.0, 12516.123871329102, 16432.507024789276, 16482.175891205392, 16550.0, 239660.0, 240321.0, 240644.0, 240764.0, 241202.0, 56216.0, 57144.428555714745, 57217.42782572204, 57277.0, 57395.71302143546, 1428.357239242345, 1469.9632509187143, 1472.4331132513846, 1474.6387135151956, 1479.496971029855, 27748.58377124385, 27826.304342391602, 28626.570601440577, 28663.856680716464, 29368.0, 51596.74201628968, 52688.0, 52855.73572132115, 52895.0, 52949.205761914374, 207284.0, 209526.0, 209554.0, 210069.0, 210423.0, 32104.197395065312, 32610.836945815117, 32739.0, 36980.63019369772, 39640.2071958565, 48307.27539086846, 49057.50942490529, 49102.75448622734, 49355.50644493653, 50236.4929052129, 36082.0, 36452.45321320235, 36535.45196822103, 36724.81637591795, 36735.63264367322, 35483.822580887965, 35794.463083054296, 36039.63960360468, 36427.635723643485, 36646.26707465782, 39846.800765995984, 39918.600813991485, 40196.799016004734, 40248.396274055325, 40369.1926161481, 35454.8227258862, 35723.28553428969, 36143.0, 36526.817365913, 36910.63089369179, 25833.483330333664, 25943.740562594132, 25955.48089038171, 26154.346141345857, 26607.866960665848], "value": 17881.75973614743, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.2550121089557, 573.1746285349094, 582.4495851420406, 584.7748616782537, 593.8634114153745, 22561.54876902463, 23349.0, 23409.297721068375, 23487.0, 24188.427752196138, 26264.0, 26634.733652663468, 26780.19659410216, 26783.732162678367, 26827.0, 6436.517261205405, 6602.042703807945, 6603.570767900095, 6613.272540020594, 6613.735450581971, 5907.970460147693, 6377.808665740012, 6386.1697979262635, 6467.191601049869, 6532.11816404784, 6365.0, 6370.84072898179, 6371.203599550056, 6371.267304260023, 6389.712462939179, 6349.52378571609, 6372.171617689693, 6377.553571250014, 6377.904331435032, 6383.936160638381, 5922.763089476459, 5953.732082056318, 5956.970215148896, 5958.7616495340135, 5976.282846058457, 29229.26926826825, 30258.394832103455, 30792.0, 31136.53295200574, 31295.687043129506, 1941.0, 1977.2189984955862, 1979.6238714644317, 1979.7921218272018, 1986.4437957371958, 18157.63684726311, 18952.715709264372, 20202.696959545618, 20216.898915505328, 20330.186792528282, 2124.245892708082, 2170.4139882231866, 2216.4348091236793, 2222.744384395799, 2222.844400891938, 138111.0, 142233.0, 145767.2711636435, 153537.0, 156084.21957890253, 14646.935388204038, 15030.774538381933, 15065.09609423438, 15178.79907413419, 15468.303926323342, 23452.530949380918, 23551.41121471977, 23555.93998270082, 23564.882175589013, 23569.646455303184, 9820.4107753535, 10102.585638010685, 10119.949400252952, 10134.493275336205, 10221.875593684688, 9249.335119678522, 9293.860592091123, 9340.673076442292, 9396.765080873032, 9425.811483770287, 9222.0, 9236.815263694689, 9319.953400232955, 9383.906160938439, 9600.567974441166, 2638.0898589986423, 2675.5585328420593, 2697.9612849053256, 2748.5190091734266, 2779.4580056889117, 916.170865366844, 950.2682934140673, 963.9614415423445, 965.7151140413595, 979.7942432089199, 19693.507662308555, 19859.60280794376, 19986.500337491387, 20103.497412564804, 20287.898560507103, 995.0894931137927, 996.257787947969, 1010.2473657125341, 1011.7369483934083, 1020.7652239984845, 10951.397673128055, 10979.0, 11110.61112861046, 11133.165012624086, 11197.0, 454431.0, 465016.0, 469985.0, 472458.0, 478072.0, 114652.42673786578, 125895.0, 130217.0, 130731.0, 130919.0, 1236.4188831249298, 1278.7889998150388, 1299.6425982854792, 1302.5375991523063, 1310.8426988761219, 20822.375328740163, 20856.791432085483, 20918.16327346889, 21141.154353825674, 21494.462638434165, 58671.70664146652, 59851.0, 61317.0, 61334.38665613287, 62511.0, 77485.0, 78738.6063069681, 78861.0, 78971.0, 79110.60444697739, 14401.63995900111, 14812.703745924806, 14824.40702371893, 14858.702825943637, 14881.925590371979, 23793.64309535393, 24001.27996160118, 24046.63930041016, 24156.0, 24299.514009719354, 17722.645547088727, 17732.0, 17935.282588696307, 17967.820321796615, 18102.81897181064, 16947.491575252763, 17009.234584443482, 17212.225449854537, 17442.563935901704, 17684.557886052953, 18327.54181145482, 19107.90446047761, 19219.711704324167, 19573.804261957768, 19634.705479417535, 14580.781288280896, 14660.266986650411, 14676.119432834064, 14705.70588588201, 14725.484608038667, 18444.723329150343, 18591.16339764687, 18764.155612997176, 18768.62462750765, 19018.1441835115], "value": 12149.175750737415, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.972920541589, 1410.89418293628, 1411.2379315169808, 1413.081497026933, 1420.964475888103, 14190.858091419082, 14756.557303280919, 14779.630509237275, 14831.406743730266, 14866.925665371686, 13753.724925501483, 14421.423143074291, 14889.0, 14946.775798363033, 15094.245287735597, 2564.0769323043687, 2634.0780726745584, 2636.894524219029, 2639.5908634161738, 2642.220544939238, 2623.317937336297, 2640.4059086705433, 2668.5997100434897, 2713.0775536317647, 2713.4437440324687, 2709.376843326036, 2734.3437574981963, 2742.5749008903554, 2742.6297449844315, 2742.8765705543296, 2594.286571192918, 2599.636050952868, 2611.1122218445726, 2613.0723593124358, 2617.986910065447, 2579.948401031969, 2601.3236558494737, 2608.1914606472055, 2610.5431549478767, 2615.803814713885, 14207.0, 14469.638259043502, 14476.565703028926, 14494.637634059127, 14514.70970580593, 7458.0, 7716.344110750593, 7732.961335193344, 7755.922440775576, 7760.495567788133, 5129.512696293883, 5214.45248248936, 5271.736413179326, 5356.464353564651, 5383.111786555213, 1929.8482192355564, 1945.5914258005835, 1948.1428171604591, 1953.2772874036698, 1993.2624928776445, 24722.25833225006, 24851.875740621363, 24863.62704559433, 24925.252242432754, 24940.501189976098, 6637.269900310962, 6645.800625981228, 6659.9001014984815, 6796.72813087471, 6814.62519561419, 16408.0, 16467.5883102921, 16487.422940197037, 16495.752563711554, 16527.91736041312, 7444.255574442513, 7565.583892885944, 7576.090869095744, 7578.166401695809, 7608.277213664693, 6895.896561551581, 6982.685779139951, 7062.329078737512, 7068.045813815172, 7114.964425177841, 5098.0, 5189.143791274473, 5238.92141617876, 5264.394594621591, 5355.544778693777, 1359.626102821732, 1370.390176371505, 1475.2181343887758, 1550.4263422533734, 1561.3286286896516, 925.22281283722, 940.9717708468756, 941.4868896451451, 949.2026697573933, 950.2445555783169, 7789.454738168387, 8113.472624279403, 8144.0, 8156.5513896735065, 8580.141985801494, 990.7467054176473, 996.9780974501049, 1000.0899181744722, 1002.9648962286285, 1003.8042581696645, 4533.5013148553635, 4650.883727906829, 4686.851721328297, 4712.31671407644, 4719.504452032487, 19730.30943916956, 20204.494887627927, 20219.696704549442, 20277.391678249674, 20445.079971401025, 19118.52203694891, 19912.800871991385, 20224.797752022292, 20315.492112697302, 20341.694874576893, 10168.949155254324, 10338.379697218192, 10383.688489345332, 10424.791504169874, 10431.843522347019, 8624.655013799378, 8876.644934202559, 8937.508437036025, 8975.910240897507, 9086.273098152, 16922.576935576217, 17658.735118972967, 17739.46781596554, 17966.191521381308, 17992.91003544974, 17146.914265428593, 17460.30158793634, 17640.91179544094, 17796.021218833088, 18032.819671803114, 11802.82295765547, 11808.76382472363, 12071.215371000857, 12088.274703517816, 12091.334976576372, 12656.936715316364, 12806.487740490276, 12807.359632018548, 12811.551595694105, 12879.935600322313, 10170.135538479311, 10249.692509224735, 10906.563737450413, 10914.126869850234, 11121.666350009513, 10404.843927340944, 10490.160787136858, 10676.519556619816, 10840.132789376989, 11028.0, 9381.812363752822, 9397.765055873659, 9422.104900034486, 9489.383190092622, 9498.0, 7483.625818708934, 7552.735654252075, 7557.8110547234555, 7591.62041897914, 7597.392208623407, 7514.8497030058, 7574.848503030019, 7623.771286861403, 7689.269519395649, 7791.532508049535], "value": 6512.167161149452, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.6776463063638, 507.3505912432087, 514.5600511562615, 529.8887233680929, 531.9468053194681, 6286.6228026318395, 6314.105768269524, 6316.715747791349, 6317.0, 6337.904931426032, 6125.05997121382, 6128.2646082470055, 6146.293176284717, 6165.784197553086, 6194.876102477948, 4835.564799168074, 4887.315775791392, 4899.412070551539, 5013.222950442678, 5066.74666266687, 4907.460179380265, 4933.235348520985, 4945.851624451272, 4948.480409556999, 4959.528844759742, 4821.855344339676, 4838.467768545457, 4867.634927380443, 4902.411710594733, 4917.164082106033, 4855.56299933006, 4917.09033828741, 4938.234573641092, 4954.975225123887, 4956.628252881048, 4417.536158703354, 4448.955510444886, 4457.799399027019, 4470.351798989128, 4480.238359478896, 6047.425494578008, 6111.236095488064, 6112.449879510866, 6171.197744293258, 6182.505399568069, 5662.405447428002, 5662.575306851962, 5690.146478028288, 5695.202671625976, 5714.71426428681, 6565.409113179837, 6576.408123268881, 6589.472842172662, 6629.86740265192, 6672.499562532829, 4825.469198388175, 4848.5151484851585, 4850.951490485085, 4867.196912509432, 4869.172240719086, 6628.171478565179, 6799.592024478448, 6836.350546698105, 6908.930910690879, 6969.756058537978, 4819.084373968934, 4885.60915126789, 4894.3147959285725, 4900.338454308694, 4932.802687892444, 4911.4106307243355, 4965.875853103629, 4985.850424487271, 4994.2508623706735, 5036.571891389273, 5560.277163968658, 5570.6657600544095, 5620.634658747168, 5627.212190293362, 5636.323641163087, 6475.935240647627, 6536.346365363425, 6553.0, 6602.7689030883685, 6651.567648102858, 1704.8550873175918, 1725.8791884567959, 1731.1171302635494, 1767.354915455875, 1771.7962434320218, 1150.4880328253846, 1181.4978634080653, 1196.2642974570576, 1213.8482689663792, 1214.8724383939737, 5670.177824215466, 5689.573282003867, 5699.971500142473, 5731.0, 5731.512821410227, 6639.701213445406, 6654.900176497356, 6711.798646040626, 6776.69504872282, 6792.286809884989, 5604.41153678866, 5633.746481408347, 5635.408282130317, 5653.773849045992, 5697.891780041328, 3499.2126771476724, 3559.1280136366754, 3570.6786389225094, 3592.2456284180093, 3616.4936908832783, 6334.936650633527, 6403.455706265019, 6416.582922110048, 6447.838804029843, 6510.414062734377, 6869.862602747917, 6904.896426553606, 6913.861722765617, 6933.722651094001, 6933.826654333682, 6430.48556115519, 6433.613983161025, 6433.903491447726, 6465.903011454832, 6467.223933127961, 6731.46148308144, 6752.966235168793, 6757.0, 6764.188297404146, 6770.763023294161, 6577.177852768404, 6663.566868153554, 6676.599404035774, 6682.0, 6685.8997115044285, 6432.710528026157, 6439.261399422036, 6478.5465017450215, 6483.124778155077, 6486.286508483969, 4369.694121411598, 4931.16170251051, 4941.24465406301, 4952.331435256338, 4963.553280204799, 6531.836704082436, 6676.0987266718375, 6685.0, 6814.182298124058, 6814.625195614289, 6559.6064236145985, 6589.374009469093, 6589.703463344065, 6629.138212032405, 6653.637958524654, 6555.508336874849, 6575.375339342755, 6579.506537009648, 6584.539082264196, 6585.308542603149, 6487.950663188294, 6506.25178104524, 6532.608043517404, 6538.574992625654, 6557.2131344239, 6586.1438013058, 6606.423494837113, 6633.772752040888, 6635.322097921051, 6659.4006539411685, 6442.2591401989375, 6458.128152699325, 6464.997925321582, 6466.935330646634, 6496.967515162394], "value": 5035.163578938854, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [893.8525143351347, 918.370915922593, 929.0384452092086, 933.547229593647, 947.4741518457256, 18886.90556547217, 20012.0, 20025.299114530993, 20036.29872954447, 22660.0, 21606.675899861515, 21819.345419637397, 22028.77971220287, 22034.44913877154, 22038.88980555099, 1002.0430488883118, 1024.1806554756201, 1025.6512785652876, 1032.2825636182856, 1032.8554002439664, 957.8658987741721, 1028.2956175020097, 1031.144150355207, 1036.1451802263125, 1040.0743338428804, 1099.5821587796627, 1102.4542851288622, 1103.8013157631624, 1112.821948488242, 1114.4817659788198, 1076.0530732955028, 1077.9784404311908, 1080.4759691549632, 1082.9079528240109, 1084.4089970965842, 803.3011280186275, 804.493169303341, 805.8549461097, 807.4025221336169, 808.7007807111347, 20301.695474567892, 20351.18595256188, 20444.977751112387, 20533.5893282135, 21118.683219751714, 21683.566328673496, 22067.779322206734, 22150.22474213411, 22209.888950555145, 22747.886260568757, 16379.344826206938, 16673.91619544726, 16915.3233870645, 17033.82966170335, 17094.572635684082, 3488.4244099723514, 3489.70337521311, 3492.703120234783, 3499.3526197653514, 3499.965000349989, 131005.34497327548, 131071.0, 131302.0, 131654.0, 135703.0, 17390.304387824344, 17564.38524651631, 17846.286148554173, 18013.549661258312, 18015.909920450576, 32344.514832277535, 32674.183145421553, 32878.67121328804, 32967.17582060468, 33009.174770630925, 7317.231690672509, 8094.433389662785, 8454.746357609281, 8555.743327700178, 8846.336524760669, 4113.773742444194, 4218.156368726267, 4221.050263690645, 4221.282381995068, 4221.767802770877, 5283.286756287929, 5401.513863752281, 5412.945870541323, 5422.078246698071, 5431.782728690808, 1072.0673014477454, 1088.4448931045224, 1110.9944450277696, 1112.4437781109445, 1112.7329440934118, 616.4390404731762, 623.538581449733, 626.7900253415157, 641.6503005861816, 641.8652083062609, 11827.0, 11861.46623401949, 12423.555212201225, 13035.608931732064, 13291.069625126149, 670.6981858163846, 680.1939701453794, 681.0431343961742, 683.3747121383977, 694.9131358580178, 5138.97430512845, 5245.449227831023, 5259.8422047338645, 5294.523492885659, 6143.723532440961, 110582.0, 111649.0, 113269.43365283286, 115323.42338288423, 120173.0, 99891.50054249828, 101545.0, 104700.47649761703, 105221.94778052121, 107059.46470267755, 88322.55838720765, 88823.55588222017, 89476.10523894808, 92859.0, 93197.53401233086, 11916.285022898654, 12232.510699571918, 12268.631941041784, 12505.811947864939, 12536.623901282976, 37680.623193767715, 39329.41005884971, 39438.80280598579, 39556.60443395529, 41113.79443102765, 70526.94209586758, 85254.0, 86233.56883215543, 87167.0, 90775.0, 20186.596268074263, 20770.79229207749, 20882.1647134119, 21002.264920727703, 21215.0, 22261.88869055709, 22427.887860560593, 22892.4276893079, 23013.539729204986, 23394.298171054896, 18053.277868885623, 19516.707249391555, 19675.40973770789, 19764.11061502207, 19934.601307974048, 18588.535286617942, 18597.163127659016, 18756.249750010393, 20501.282455114, 20880.0, 18986.52533686669, 19121.617567648293, 19144.521386965436, 19147.234110635418, 19304.517387064872, 12125.393730313626, 12384.318862462651, 12425.875741242833, 12594.433250503565, 12814.103012789388, 13811.861881381057, 14257.71484570282, 14293.499727509903, 14331.785023224451, 14331.78502322487], "value": 9460.526157675102, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 107.0, 101.0, 110.0, 115.0, 108.0, 110.0, 110.0, 111.0, 111.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 117.0, 144.0, 184.0, 119.0, 141.0, 159.0, 133.0, 175.0, 118.0], "value": 143.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 172.0, 172.0, 162.0, 164.0, 171.0, 168.0, 165.0, 168.0, 165.0], "value": 167.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 176.0, 76.0, 79.0, 76.0, 75.0, 158.0, 76.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 144.0, 78.0, 79.0, 78.0, 135.0, 82.0, 80.0, 126.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 118.0, 115.0, 114.0, 118.0, 118.0, 116.0, 115.0, 114.0, 114.0], "value": 115.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 149.0, 150.0, 152.0, 150.0, 156.0, 156.0, 149.0, 151.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 97.0, 94.0, 96.0, 99.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 52.0, 52.0, 54.0, 53.0, 54.0, 54.0, 57.0, 53.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 54.0, 55.0, 55.0, 58.0, 55.0, 56.0, 59.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 77.0, 78.0, 83.0, 78.0, 78.0, 77.0, 78.0, 79.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 122.0, 136.0, 123.0, 125.0, 133.0, 127.0, 132.0, 122.0, 170.0], "value": 132.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 182.0, 174.0, 180.0, 194.0, 181.0, 193.0, 178.0, 174.0, 181.0], "value": 182.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 70.0, 69.0, 69.0, 77.0, 67.0, 69.0, 66.0, 69.0], "value": 69.0, "unit": "score"}]}]} 15:45:50 INFO - Return code: 0 15:45:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:45:50 INFO - # TBPL SUCCESS # 15:45:50 INFO - Running post-action listener: _package_coverage_data 15:45:50 INFO - Running post-action listener: _resource_record_post_action 15:45:50 INFO - [mozharness: 2017-08-12 22:45:50.063466Z] Finished run-tests step (success) 15:45:50 INFO - Running post-run listener: _resource_record_post_run 15:45:50 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 431276032; Read time: 8; Write time: 257520 15:45:50 INFO - TinderboxPrint: CPU usage
13.1% 15:45:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 15:45:50 INFO - TinderboxPrint: I/O write bytes / time
431,276,032 / 257,520 15:45:50 INFO - TinderboxPrint: CPU idle
8,267.7 (86.8%) 15:45:50 INFO - TinderboxPrint: CPU user
1,202.4 (12.6%) 15:45:50 INFO - TinderboxPrint: Swap in / out
0 / 0 15:45:50 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106696704; Read time: 0; Write time: 57188 15:45:50 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:45:50 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 324579328; Read time: 0; Write time: 200332 15:45:50 INFO - Running post-run listener: _upload_blobber_files 15:45:50 INFO - Blob upload gear active. 15:45:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:45:50 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 15:45:50 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'] 15:45:50 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 15:45:51 INFO - (blobuploader) - INFO - Open directory for files ... 15:45:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:45:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:45:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:45:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:51 INFO - (blobuploader) - INFO - Done attempting. 15:45:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:45:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:45:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:45:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:52 INFO - (blobuploader) - INFO - Done attempting. 15:45:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:45:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:45:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:45:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:59 INFO - (blobuploader) - INFO - Done attempting. 15:45:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:45:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:45:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:45:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:59 INFO - (blobuploader) - INFO - Done attempting. 15:45:59 INFO - (blobuploader) - INFO - Iteration through files over. 15:45:59 INFO - Return code: 0 15:45:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:45:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:45:59 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6431006c132b47fb8d36a1367c05ec2b3617586b651368e9475225c12789f6af6ddc8852136f0d32685f9216f6b2e21e34fd48d4225f7a861fae3ca677700476", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed69bfd860c2ec421aab338085e6e9de41934255db4a50994acca5342d8c42a3acc6b4ade0b35af9f353cdffba24947731558c4c350c2fc07f3cf5f89c1ba6c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2643a22a14532da4a1acf45e0da537b4257c7dfdb1bdba12bbfd0f2a1053f382c6be649ae4513d544c55b022f3b00d86bd3e245da46940f6000d60b8e679b970", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6aa64df2cbec584be7219c52d4d2786326c45e1edffcff9399bff9eb9d4911963b9e3a5f559f54c8f130e641b051809768e7a2cb4d4102c5ae0a9b28b95ac43"} 15:45:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:45:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:45:59 INFO - Contents: 15:45:59 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6431006c132b47fb8d36a1367c05ec2b3617586b651368e9475225c12789f6af6ddc8852136f0d32685f9216f6b2e21e34fd48d4225f7a861fae3ca677700476", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed69bfd860c2ec421aab338085e6e9de41934255db4a50994acca5342d8c42a3acc6b4ade0b35af9f353cdffba24947731558c4c350c2fc07f3cf5f89c1ba6c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2643a22a14532da4a1acf45e0da537b4257c7dfdb1bdba12bbfd0f2a1053f382c6be649ae4513d544c55b022f3b00d86bd3e245da46940f6000d60b8e679b970", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6aa64df2cbec584be7219c52d4d2786326c45e1edffcff9399bff9eb9d4911963b9e3a5f559f54c8f130e641b051809768e7a2cb4d4102c5ae0a9b28b95ac43"} 15:45:59 INFO - Running post-run listener: copy_logs_to_upload_dir 15:45:59 INFO - Copying logs to upload dir... 15:45:59 INFO - mkdir: /builds/slave/test/build/upload/logs 15:45:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.340737 ========= master_lag: -0.27 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-08-12 15:45:59.237199) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-12 15:45:59.245934) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dbb0bb31bf4a4c7db9ba1648000001b6-1502575262.946007-863781298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6431006c132b47fb8d36a1367c05ec2b3617586b651368e9475225c12789f6af6ddc8852136f0d32685f9216f6b2e21e34fd48d4225f7a861fae3ca677700476", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed69bfd860c2ec421aab338085e6e9de41934255db4a50994acca5342d8c42a3acc6b4ade0b35af9f353cdffba24947731558c4c350c2fc07f3cf5f89c1ba6c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2643a22a14532da4a1acf45e0da537b4257c7dfdb1bdba12bbfd0f2a1053f382c6be649ae4513d544c55b022f3b00d86bd3e245da46940f6000d60b8e679b970", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6aa64df2cbec584be7219c52d4d2786326c45e1edffcff9399bff9eb9d4911963b9e3a5f559f54c8f130e641b051809768e7a2cb4d4102c5ae0a9b28b95ac43"} build_url:https://queue.taskcluster.net/v1/task/Yx2HVl5oTtyjs-iuTJgx8w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/Yx2HVl5oTtyjs-iuTJgx8w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6431006c132b47fb8d36a1367c05ec2b3617586b651368e9475225c12789f6af6ddc8852136f0d32685f9216f6b2e21e34fd48d4225f7a861fae3ca677700476", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed69bfd860c2ec421aab338085e6e9de41934255db4a50994acca5342d8c42a3acc6b4ade0b35af9f353cdffba24947731558c4c350c2fc07f3cf5f89c1ba6c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2643a22a14532da4a1acf45e0da537b4257c7dfdb1bdba12bbfd0f2a1053f382c6be649ae4513d544c55b022f3b00d86bd3e245da46940f6000d60b8e679b970", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6aa64df2cbec584be7219c52d4d2786326c45e1edffcff9399bff9eb9d4911963b9e3a5f559f54c8f130e641b051809768e7a2cb4d4102c5ae0a9b28b95ac43"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-12 15:45:59.270132) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-12 15:45:59.270438) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dbb0bb31bf4a4c7db9ba1648000001b6-1502575262.946007-863781298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-12 15:45:59.352229) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-12 15:45:59.356552) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-12 15:45:59.356853) ========= ========= Total master_lag: -0.09 =========