builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-025 starttime: 1501658070.56 results: success (0) revision: 51ffb9283f0c7c00e08eb8c39b33fbee218c370d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-02 00:14:30.558311) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-02 00:14:30.558693) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-02 00:14:30.558962) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-02 00:14:30.602842) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 00:14:30.603092) ========= 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=232498196343f89f466a4a9a000001c8-1501645543.95757-237912307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-02 00:14:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2017-08-02 00:14:31 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.179450 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 00:14:30.825395) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 00:14:30.825670) ========= 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=232498196343f89f466a4a9a000001c8-1501645543.95757-237912307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022464 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 00:14:30.943274) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-02 00:14:30.943570) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 51ffb9283f0c7c00e08eb8c39b33fbee218c370d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 51ffb9283f0c7c00e08eb8c39b33fbee218c370d --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1501645543.95757-237912307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-02 00:14:31,456 truncating revision to first 12 chars 2017-08-02 00:14:31,457 Setting DEBUG logging. 2017-08-02 00:14:31,457 attempt 1/10 2017-08-02 00:14:31,457 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/51ffb9283f0c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-02 00:14:32,581 unpacking tar archive at: mozilla-central-51ffb9283f0c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.435671 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-02 00:14:32.397859) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-02 00:14:32.398133) ========= script_repo_revision: 51ffb9283f0c7c00e08eb8c39b33fbee218c370d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-02 00:14:32.401574) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-02 00:14:32.401859) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-02 00:14:32.410749) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-02 00:14:32.411017) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=232498196343f89f466a4a9a000001c8-1501645543.95757-237912307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:14:33 INFO - MultiFileLogger online at 20170802 00:14:33 in /builds/slave/test 00:14:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 00:14:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:14:33 INFO - {'append_to_log': False, 00:14:33 INFO - 'base_work_dir': '/builds/slave/test', 00:14:33 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 00:14:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:14:33 INFO - 'branch': 'Firefox-Non-PGO', 00:14:33 INFO - 'buildbot_json_path': 'buildprops.json', 00:14:33 INFO - 'code_coverage': False, 00:14:33 INFO - 'config_files': ('talos/linux_config.py',), 00:14:33 INFO - 'default_actions': ('clobber', 00:14:33 INFO - 'read-buildbot-config', 00:14:33 INFO - 'download-and-extract', 00:14:33 INFO - 'populate-webroot', 00:14:33 INFO - 'create-virtualenv', 00:14:33 INFO - 'install', 00:14:33 INFO - 'setup-mitmproxy', 00:14:33 INFO - 'run-tests'), 00:14:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:14:33 INFO - 'disable_ccov_upload': False, 00:14:33 INFO - 'download_minidump_stackwalk': True, 00:14:33 INFO - 'download_symbols': 'ondemand', 00:14:33 INFO - 'enable_stylo': False, 00:14:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:14:33 INFO - 'tooltool.py': '/tools/tooltool.py', 00:14:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:14:33 INFO - '/tools/misc-python/virtualenv.py')}, 00:14:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:14:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:14:33 INFO - 'gecko_profile': False, 00:14:33 INFO - 'gecko_profile_interval': 0, 00:14:33 INFO - 'installer_path': 'installer.exe', 00:14:33 INFO - 'log_level': 'info', 00:14:33 INFO - 'log_name': 'talos', 00:14:33 INFO - 'log_to_console': True, 00:14:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:14:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:14:33 INFO - 'opt_config_files': (), 00:14:33 INFO - 'pip_index': False, 00:14:33 INFO - 'suite': 'dromaeojs-e10s', 00:14:33 INFO - 'system_bits': '32', 00:14:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:14:33 INFO - 'title': 'talos-linux64-ix-025', 00:14:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:14:33 INFO - 'use_talos_json': True, 00:14:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:14:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:14:33 INFO - 'work_dir': 'build'} 00:14:33 INFO - [mozharness: 2017-08-02 07:14:33.031885Z] Running clobber step. 00:14:33 INFO - Running pre-action listener: _resource_record_pre_action 00:14:33 INFO - Running main action method: clobber 00:14:33 INFO - rmtree: /builds/slave/test/build 00:14:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:14:34 INFO - Running post-action listener: _resource_record_post_action 00:14:34 INFO - [mozharness: 2017-08-02 07:14:34.085350Z] Finished clobber step (success) 00:14:34 INFO - [mozharness: 2017-08-02 07:14:34.085453Z] Running read-buildbot-config step. 00:14:34 INFO - Running pre-action listener: _resource_record_pre_action 00:14:34 INFO - Running main action method: read_buildbot_config 00:14:34 INFO - Using buildbot properties: 00:14:34 INFO - { 00:14:34 INFO - "project": "", 00:14:34 INFO - "product": "firefox", 00:14:34 INFO - "who": "archaeopteryx@coole-files.de", 00:14:34 INFO - "installer_path": "public/build/target.tar.bz2", 00:14:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 00:14:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 00:14:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 00:14:34 INFO - "stage_platform": "linux64", 00:14:34 INFO - "basedir": "/builds/slave/test", 00:14:34 INFO - "buildnumber": 752, 00:14:34 INFO - "platform": "ubuntu64_hw", 00:14:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:14:34 INFO - "slavebuilddir": "test", 00:14:34 INFO - "taskId": "IGWFBgMnTGiHbvikxBnKmg", 00:14:34 INFO - "branch": "mozilla-central", 00:14:34 INFO - "script_repo_revision": "production", 00:14:34 INFO - "revision": "51ffb9283f0c7c00e08eb8c39b33fbee218c370d", 00:14:34 INFO - "slavename": "talos-linux64-ix-025", 00:14:34 INFO - "repo_path": "mozilla-central" 00:14:34 INFO - } 00:14:34 INFO - Finding installer, test and symbols from parent task. 00:14:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IGWFBgMnTGiHbvikxBnKmg'}, attempt #1 00:14:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IGWFBgMnTGiHbvikxBnKmg'}, attempt #1 00:14:34 INFO - Task dependencies: JhuDbI3YQeS1KwM6F3P5lg 00:14:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg'}, attempt #1 00:14:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2 00:14:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.test_packages.json 00:14:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.crashreporter-symbols.zip 00:14:35 INFO - Running post-action listener: _resource_record_post_action 00:14:35 INFO - [mozharness: 2017-08-02 07:14:35.430685Z] Finished read-buildbot-config step (success) 00:14:35 INFO - [mozharness: 2017-08-02 07:14:35.430907Z] Running download-and-extract step. 00:14:35 INFO - Running pre-action listener: _resource_record_pre_action 00:14:35 INFO - Running main action method: download_and_extract 00:14:35 INFO - mkdir: /builds/slave/test/build/tests 00:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:14:35 INFO - trying https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.test_packages.json 00:14:35 INFO - Downloading https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 00:14:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 00:14:35 INFO - Downloaded 989 bytes. 00:14:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 00:14:35 INFO - Using the following test package requirements: 00:14:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 00:14:35 INFO - u'common': [u'target.common.tests.zip'], 00:14:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 00:14:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 00:14:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 00:14:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 00:14:35 INFO - u'mozbase': [u'target.common.tests.zip'], 00:14:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 00:14:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 00:14:35 INFO - u'web-platform': [u'target.common.tests.zip', 00:14:35 INFO - u'target.web-platform.tests.tar.gz'], 00:14:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 00:14:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 00:14:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.common.tests.zip 00:14:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.common.tests.zip'}, attempt #1 00:14:35 INFO - Fetch https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.common.tests.zip into memory 00:14:37 INFO - Content-Length response header: 72390374 00:14:37 INFO - Bytes received: 72390374 00:14:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 00:14:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.common.tests.zip 00:14:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.common.tests.zip'}, attempt #1 00:14:48 INFO - Fetch https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.common.tests.zip into memory 00:14:50 INFO - Content-Length response header: 72390374 00:14:50 INFO - Bytes received: 72390374 00:15:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.talos.tests.zip 00:15:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 00:15:02 INFO - Fetch https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.talos.tests.zip into memory 00:15:03 INFO - Content-Length response header: 14496467 00:15:03 INFO - Bytes received: 14496467 00:15: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')]} 00:15:03 INFO - trying https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2 00:15:03 INFO - Downloading https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 00:15:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 00:15:04 INFO - Downloaded 62292244 bytes. 00:15:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2 00:15:04 INFO - mkdir: /builds/slave/test/properties 00:15:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:15:04 INFO - Writing to file /builds/slave/test/properties/build_url 00:15:04 INFO - Contents: 00:15:04 INFO - build_url:https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2 00:15:04 INFO - Running post-action listener: _resource_record_post_action 00:15:04 INFO - Running post-action listener: set_extra_try_arguments 00:15:04 INFO - [mozharness: 2017-08-02 07:15:04.834907Z] Finished download-and-extract step (success) 00:15:04 INFO - [mozharness: 2017-08-02 07:15:04.835004Z] Running populate-webroot step. 00:15:04 INFO - Running pre-action listener: _resource_record_pre_action 00:15:04 INFO - Running main action method: populate_webroot 00:15:04 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:15:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:15:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 00:15:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:15:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 00:15:04 INFO - 'tests': ['damp', 'tps']}, 00:15:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:15:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 00:15:04 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 00:15:04 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 00:15:04 INFO - 'other-e10s': {'tests': ['a11yr', 00:15:04 INFO - 'ts_paint', 00:15:04 INFO - 'tpaint', 00:15:04 INFO - 'sessionrestore', 00:15:04 INFO - 'sessionrestore_many_windows', 00:15:04 INFO - 'sessionrestore_no_auto_restore', 00:15:04 INFO - 'tabpaint']}, 00:15:04 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 00:15:04 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 00:15:04 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:15:04 INFO - 'talos_options': ['--mitmproxy', 00:15:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:15:04 INFO - '--firstNonBlankPaint'], 00:15:04 INFO - 'tests': ['quantum_pageload_google', 00:15:04 INFO - 'quantum_pageload_youtube', 00:15:04 INFO - 'quantum_pageload_amazon', 00:15:04 INFO - 'quantum_pageload_facebook']}, 00:15:04 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:15:04 INFO - 'talos_options': ['--stylo', 00:15:04 INFO - '--mitmproxy', 00:15:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:15:04 INFO - '--firstNonBlankPaint'], 00:15:04 INFO - 'tests': ['quantum_pageload_google', 00:15:04 INFO - 'quantum_pageload_youtube', 00:15:04 INFO - 'quantum_pageload_amazon', 00:15:04 INFO - 'quantum_pageload_facebook']}, 00:15:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:15:04 INFO - 'tsvgr_opacity', 00:15:04 INFO - 'tart', 00:15:04 INFO - 'tscrollx', 00:15:04 INFO - 'cart', 00:15:04 INFO - 'tsvg_static']}, 00:15:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 00:15:04 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:15:04 INFO - 'talos_options': ['--stylo', 00:15:04 INFO - '--stylo-threads=1', 00:15:04 INFO - '--mitmproxy', 00:15:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:15:04 INFO - '--firstNonBlankPaint'], 00:15:04 INFO - 'tests': ['tp6_google', 00:15:04 INFO - 'tp6_youtube', 00:15:04 INFO - 'tp6_amazon', 00:15:04 INFO - 'tp6_facebook']}, 00:15:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 00:15:04 INFO - 'talos_options': ['--xperf_path', 00:15:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:15:04 INFO - 'tests': ['tp5n']}}} 00:15:04 INFO - Running post-action listener: _resource_record_post_action 00:15:04 INFO - [mozharness: 2017-08-02 07:15:04.843678Z] Finished populate-webroot step (success) 00:15:04 INFO - [mozharness: 2017-08-02 07:15:04.843768Z] Running create-virtualenv step. 00:15:04 INFO - Running pre-action listener: _resource_record_pre_action 00:15:04 INFO - Running main action method: create_virtualenv 00:15:04 INFO - Creating virtualenv /builds/slave/test/build/venv 00:15:04 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 00:15:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:15:04 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 00:15:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:15:04 INFO - Using real prefix '/usr' 00:15:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:15:05 INFO - Installing distribute.............................................................................................................................................................................................done. 00:15:07 INFO - Installing pip.................done. 00:15:07 INFO - Return code: 0 00:15:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:15:07 INFO - Reading from file tmpfile_stdout 00:15:07 INFO - Output received: 00:15:07 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) 00:15:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a95a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c38d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c35eb0>, '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 0x2c36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c37240>, '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': '232498196343f89f466a4a9a000001c8-1501645543.95757-237912307', '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 00:15:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:15:07 INFO - Using env: {'DISPLAY': ':0', 00:15:07 INFO - 'HOME': '/home/cltbld', 00:15:07 INFO - 'LANG': 'en_US.UTF-8', 00:15:07 INFO - 'LANGUAGE': 'en_US:en', 00:15:07 INFO - 'LOGNAME': 'cltbld', 00:15:07 INFO - 'MAIL': '/var/mail/cltbld', 00:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:07 INFO - 'MOZ_NO_REMOTE': '1', 00:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:15:07 INFO - 'NO_EM_RESTART': '1', 00:15:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:07 INFO - 'PWD': '/builds/slave/test', 00:15:07 INFO - 'SHELL': '/bin/bash', 00:15:07 INFO - 'SHLVL': '1', 00:15:07 INFO - 'TERM': 'linux', 00:15:07 INFO - 'TMOUT': '86400', 00:15:07 INFO - 'USER': 'cltbld', 00:15:07 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1501645543.95757-237912307', 00:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:07 INFO - '_': '/tools/buildbot/bin/python'} 00:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:07 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 00:15:07 INFO - Cleaning up... 00:15:07 INFO - Return code: 0 00:15:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a95a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c38d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c35eb0>, '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 0x2c36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c37240>, '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': '232498196343f89f466a4a9a000001c8-1501645543.95757-237912307', '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 00:15:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:15:07 INFO - Using env: {'DISPLAY': ':0', 00:15:07 INFO - 'HOME': '/home/cltbld', 00:15:07 INFO - 'LANG': 'en_US.UTF-8', 00:15:07 INFO - 'LANGUAGE': 'en_US:en', 00:15:07 INFO - 'LOGNAME': 'cltbld', 00:15:07 INFO - 'MAIL': '/var/mail/cltbld', 00:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:07 INFO - 'MOZ_NO_REMOTE': '1', 00:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:15:07 INFO - 'NO_EM_RESTART': '1', 00:15:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:07 INFO - 'PWD': '/builds/slave/test', 00:15:07 INFO - 'SHELL': '/bin/bash', 00:15:07 INFO - 'SHLVL': '1', 00:15:07 INFO - 'TERM': 'linux', 00:15:07 INFO - 'TMOUT': '86400', 00:15:07 INFO - 'USER': 'cltbld', 00:15:07 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1501645543.95757-237912307', 00:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:07 INFO - '_': '/tools/buildbot/bin/python'} 00:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:08 INFO - Downloading/unpacking psutil>=3.1.1 00:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:15:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:15:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:15:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:15:09 INFO - Installing collected packages: psutil 00:15:09 INFO - Running setup.py install for psutil 00:15:09 INFO - building 'psutil._psutil_linux' extension 00:15:09 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 00:15:09 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 00:15:09 INFO - building 'psutil._psutil_posix' extension 00:15:09 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 00:15:09 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 00:15:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:15:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:15:09 INFO - Successfully installed psutil 00:15:09 INFO - Cleaning up... 00:15:09 INFO - Return code: 0 00:15:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:09 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 0x28c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a95a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c38d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c35eb0>, '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 0x2c36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c37240>, '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': '232498196343f89f466a4a9a000001c8-1501645543.95757-237912307', '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 00:15:09 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 00:15:09 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 00:15:09 INFO - Using env: {'DISPLAY': ':0', 00:15:09 INFO - 'HOME': '/home/cltbld', 00:15:09 INFO - 'LANG': 'en_US.UTF-8', 00:15:09 INFO - 'LANGUAGE': 'en_US:en', 00:15:09 INFO - 'LOGNAME': 'cltbld', 00:15:09 INFO - 'MAIL': '/var/mail/cltbld', 00:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:09 INFO - 'MOZ_NO_REMOTE': '1', 00:15:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:15:09 INFO - 'NO_EM_RESTART': '1', 00:15:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:09 INFO - 'PWD': '/builds/slave/test', 00:15:09 INFO - 'SHELL': '/bin/bash', 00:15:09 INFO - 'SHLVL': '1', 00:15:09 INFO - 'TERM': 'linux', 00:15:09 INFO - 'TMOUT': '86400', 00:15:09 INFO - 'USER': 'cltbld', 00:15:09 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1501645543.95757-237912307', 00:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:09 INFO - '_': '/tools/buildbot/bin/python'} 00:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:15:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:15:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:15:11 INFO - Installing collected packages: mozsystemmonitor 00:15:11 INFO - Running setup.py install for mozsystemmonitor 00:15:11 INFO - Successfully installed mozsystemmonitor 00:15:11 INFO - Cleaning up... 00:15:11 INFO - Return code: 0 00:15:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:15:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:11 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 0x28c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a95a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c38d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c35eb0>, '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 0x2c36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c37240>, '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': '232498196343f89f466a4a9a000001c8-1501645543.95757-237912307', '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 00:15:11 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 00:15:11 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 00:15:11 INFO - Using env: {'DISPLAY': ':0', 00:15:11 INFO - 'HOME': '/home/cltbld', 00:15:11 INFO - 'LANG': 'en_US.UTF-8', 00:15:11 INFO - 'LANGUAGE': 'en_US:en', 00:15:11 INFO - 'LOGNAME': 'cltbld', 00:15:11 INFO - 'MAIL': '/var/mail/cltbld', 00:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:11 INFO - 'MOZ_NO_REMOTE': '1', 00:15:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:15:11 INFO - 'NO_EM_RESTART': '1', 00:15:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:11 INFO - 'PWD': '/builds/slave/test', 00:15:11 INFO - 'SHELL': '/bin/bash', 00:15:11 INFO - 'SHLVL': '1', 00:15:11 INFO - 'TERM': 'linux', 00:15:11 INFO - 'TMOUT': '86400', 00:15:11 INFO - 'USER': 'cltbld', 00:15:11 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1501645543.95757-237912307', 00:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:11 INFO - '_': '/tools/buildbot/bin/python'} 00:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:11 INFO - Downloading/unpacking jsonschema==2.5.1 00:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:15:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:15:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:15:12 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 00:15:12 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 00:15:12 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 00:15:12 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 00:15:12 INFO - Downloading functools32-3.2.3-2.tar.gz 00:15:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:15:12 INFO - warning: no files found matching '*.txt' 00:15:12 INFO - no previously-included directories found matching 'build' 00:15:12 INFO - no previously-included directories found matching 'dist' 00:15:12 INFO - no previously-included directories found matching '.git*' 00:15:12 INFO - Installing collected packages: jsonschema, functools32 00:15:12 INFO - Running setup.py install for functools32 00:15:12 INFO - warning: no files found matching '*.txt' 00:15:12 INFO - no previously-included directories found matching 'build' 00:15:12 INFO - no previously-included directories found matching 'dist' 00:15:12 INFO - no previously-included directories found matching '.git*' 00:15:12 INFO - Successfully installed jsonschema functools32 00:15:12 INFO - Cleaning up... 00:15:12 INFO - Return code: 0 00:15:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:12 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 0x28c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a95a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c38d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c35eb0>, '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 0x2c36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c37240>, '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': '232498196343f89f466a4a9a000001c8-1501645543.95757-237912307', '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 00:15:12 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 00:15:12 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 00:15:12 INFO - Using env: {'DISPLAY': ':0', 00:15:12 INFO - 'HOME': '/home/cltbld', 00:15:12 INFO - 'LANG': 'en_US.UTF-8', 00:15:12 INFO - 'LANGUAGE': 'en_US:en', 00:15:12 INFO - 'LOGNAME': 'cltbld', 00:15:12 INFO - 'MAIL': '/var/mail/cltbld', 00:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:12 INFO - 'MOZ_NO_REMOTE': '1', 00:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:15:12 INFO - 'NO_EM_RESTART': '1', 00:15:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:12 INFO - 'PWD': '/builds/slave/test', 00:15:12 INFO - 'SHELL': '/bin/bash', 00:15:12 INFO - 'SHLVL': '1', 00:15:12 INFO - 'TERM': 'linux', 00:15:12 INFO - 'TMOUT': '86400', 00:15:12 INFO - 'USER': 'cltbld', 00:15:12 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1501645543.95757-237912307', 00:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:12 INFO - '_': '/tools/buildbot/bin/python'} 00:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:15:13 INFO - Cleaning up... 00:15:13 INFO - Return code: 0 00:15:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:15: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')]} 00:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15: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')]} 00:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:13 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 0x28c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a95a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c38d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c35eb0>, '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 0x2c36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c37240>, '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': '232498196343f89f466a4a9a000001c8-1501645543.95757-237912307', '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 00:15:13 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 00:15:13 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 00:15:13 INFO - Using env: {'DISPLAY': ':0', 00:15:13 INFO - 'HOME': '/home/cltbld', 00:15:13 INFO - 'LANG': 'en_US.UTF-8', 00:15:13 INFO - 'LANGUAGE': 'en_US:en', 00:15:13 INFO - 'LOGNAME': 'cltbld', 00:15:13 INFO - 'MAIL': '/var/mail/cltbld', 00:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:13 INFO - 'MOZ_NO_REMOTE': '1', 00:15:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:15:13 INFO - 'NO_EM_RESTART': '1', 00:15:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:13 INFO - 'PWD': '/builds/slave/test', 00:15:13 INFO - 'SHELL': '/bin/bash', 00:15:13 INFO - 'SHLVL': '1', 00:15:13 INFO - 'TERM': 'linux', 00:15:13 INFO - 'TMOUT': '86400', 00:15:13 INFO - 'USER': 'cltbld', 00:15:13 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1501645543.95757-237912307', 00:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:13 INFO - '_': '/tools/buildbot/bin/python'} 00:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:13 INFO - Downloading/unpacking blobuploader==1.2.4 00:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:15:14 INFO - Downloading blobuploader-1.2.4.tar.gz 00:15:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:15:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:15:14 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 00:15:14 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 00:15:14 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 00:15:14 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 00:15:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:15:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:15:14 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 00:15:14 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 00:15:14 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 00:15:14 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 00:15:15 INFO - Downloading docopt-0.6.1.tar.gz 00:15:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:15:15 INFO - Installing collected packages: blobuploader, requests, docopt 00:15:15 INFO - Running setup.py install for blobuploader 00:15:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:15:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:15:15 INFO - Running setup.py install for requests 00:15:15 INFO - Running setup.py install for docopt 00:15:15 INFO - Successfully installed blobuploader requests docopt 00:15:15 INFO - Cleaning up... 00:15:15 INFO - Return code: 0 00:15:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:15 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 0x28c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a95a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c38d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c35eb0>, '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 0x2c36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c37240>, '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': '232498196343f89f466a4a9a000001c8-1501645543.95757-237912307', '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 00:15:15 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 00:15:15 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 00:15:15 INFO - Using env: {'DISPLAY': ':0', 00:15:15 INFO - 'HOME': '/home/cltbld', 00:15:15 INFO - 'LANG': 'en_US.UTF-8', 00:15:15 INFO - 'LANGUAGE': 'en_US:en', 00:15:15 INFO - 'LOGNAME': 'cltbld', 00:15:15 INFO - 'MAIL': '/var/mail/cltbld', 00:15:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:15 INFO - 'MOZ_NO_REMOTE': '1', 00:15:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:15:15 INFO - 'NO_EM_RESTART': '1', 00:15:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:15:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:15 INFO - 'PWD': '/builds/slave/test', 00:15:15 INFO - 'SHELL': '/bin/bash', 00:15:15 INFO - 'SHLVL': '1', 00:15:15 INFO - 'TERM': 'linux', 00:15:15 INFO - 'TMOUT': '86400', 00:15:15 INFO - 'USER': 'cltbld', 00:15:15 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1501645543.95757-237912307', 00:15:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:15 INFO - '_': '/tools/buildbot/bin/python'} 00:15:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:15:15 INFO - Running setup.py (path:/tmp/pip-yVhxNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:15:16 INFO - Running setup.py (path:/tmp/pip-MN5utV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:15:16 INFO - Running setup.py (path:/tmp/pip-sVBjtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:15:16 INFO - Running setup.py (path:/tmp/pip-iSPnR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:15:16 INFO - Running setup.py (path:/tmp/pip-q_Vtkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:15:16 INFO - Running setup.py (path:/tmp/pip-e7xqIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:15:16 INFO - Running setup.py (path:/tmp/pip-R5oZ5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:15:16 INFO - Running setup.py (path:/tmp/pip-mfwKN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:15:16 INFO - Running setup.py (path:/tmp/pip-NBUanl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:15:16 INFO - Running setup.py (path:/tmp/pip-f7Ud4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:15:16 INFO - Running setup.py (path:/tmp/pip-Tu4odA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:15:16 INFO - Running setup.py (path:/tmp/pip-djuD92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:15:16 INFO - Running setup.py (path:/tmp/pip-lP1hlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:15:16 INFO - Running setup.py (path:/tmp/pip-5ycrwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:15:16 INFO - Running setup.py (path:/tmp/pip-oyzAb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:15:17 INFO - Running setup.py (path:/tmp/pip-CGzdkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:15:17 INFO - Running setup.py (path:/tmp/pip-O_RmXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:15:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:15:17 INFO - Running setup.py install for manifestparser 00:15:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:15:17 INFO - Running setup.py install for mozcrash 00:15:17 INFO - Running setup.py install for mozdebug 00:15:17 INFO - Running setup.py install for mozdevice 00:15:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:15:17 INFO - Running setup.py install for mozfile 00:15:17 INFO - Running setup.py install for mozhttpd 00:15:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:15:17 INFO - Running setup.py install for mozinfo 00:15:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:15:17 INFO - Running setup.py install for mozInstall 00:15:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:15:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:15:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:15:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:15:17 INFO - Running setup.py install for mozleak 00:15:18 INFO - Running setup.py install for mozlog 00:15:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:15:18 INFO - Running setup.py install for moznetwork 00:15:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:15:18 INFO - Running setup.py install for mozprocess 00:15:18 INFO - Running setup.py install for mozprofile 00:15:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:15:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:15:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:15:18 INFO - Running setup.py install for mozrunner 00:15:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:15:18 INFO - Running setup.py install for mozscreenshot 00:15:18 INFO - Running setup.py install for moztest 00:15:18 INFO - Running setup.py install for mozversion 00:15:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:15:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:15:18 INFO - Cleaning up... 00:15:18 INFO - Return code: 0 00:15:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:15:18 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')]} 00:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:18 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')]} 00:15:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:18 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 0x28c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a95a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c38d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c35eb0>, '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 0x2c36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c37240>, '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': '232498196343f89f466a4a9a000001c8-1501645543.95757-237912307', '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 00:15:18 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 00:15:18 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 00:15:18 INFO - Using env: {'DISPLAY': ':0', 00:15:18 INFO - 'HOME': '/home/cltbld', 00:15:18 INFO - 'LANG': 'en_US.UTF-8', 00:15:18 INFO - 'LANGUAGE': 'en_US:en', 00:15:18 INFO - 'LOGNAME': 'cltbld', 00:15:18 INFO - 'MAIL': '/var/mail/cltbld', 00:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:18 INFO - 'MOZ_NO_REMOTE': '1', 00:15:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:15:18 INFO - 'NO_EM_RESTART': '1', 00:15:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:18 INFO - 'PWD': '/builds/slave/test', 00:15:18 INFO - 'SHELL': '/bin/bash', 00:15:18 INFO - 'SHLVL': '1', 00:15:18 INFO - 'TERM': 'linux', 00:15:18 INFO - 'TMOUT': '86400', 00:15:18 INFO - 'USER': 'cltbld', 00:15:18 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1501645543.95757-237912307', 00:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:18 INFO - '_': '/tools/buildbot/bin/python'} 00:15:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:15:19 INFO - Running setup.py (path:/tmp/pip-Cav3ZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:15:19 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)) 00:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:15:19 INFO - Running setup.py (path:/tmp/pip-dR2DMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:15:19 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)) 00:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:15:19 INFO - Running setup.py (path:/tmp/pip-XB1PEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:15:19 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)) 00:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:15:19 INFO - Running setup.py (path:/tmp/pip-nM8Zpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:15:19 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)) 00:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:15:19 INFO - Running setup.py (path:/tmp/pip-lbysAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:15:19 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)) 00:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:15:19 INFO - Running setup.py (path:/tmp/pip-RoLayo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:15:19 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)) 00:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:15:19 INFO - Running setup.py (path:/tmp/pip-HWpe3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:15:19 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)) 00:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:15:19 INFO - Running setup.py (path:/tmp/pip-BW5sgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:15:19 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)) 00:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:15:19 INFO - Running setup.py (path:/tmp/pip-GWGgXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:15:19 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)) 00:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:15:19 INFO - Running setup.py (path:/tmp/pip-K1GrTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:15:19 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)) 00:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:15:19 INFO - Running setup.py (path:/tmp/pip-0b5OsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:15:19 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)) 00:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:15:20 INFO - Running setup.py (path:/tmp/pip-GnTB3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:15:20 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)) 00:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:15:20 INFO - Running setup.py (path:/tmp/pip-7RhHwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:15:20 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)) 00:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:15:20 INFO - Running setup.py (path:/tmp/pip-yNbTqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:15:20 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)) 00:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:15:20 INFO - Running setup.py (path:/tmp/pip-_hWiNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:15:20 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)) 00:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:15:20 INFO - Running setup.py (path:/tmp/pip-sWJaOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:15:20 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)) 00:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:15:20 INFO - Running setup.py (path:/tmp/pip-sYJYSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:15:20 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)) 00:15:20 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)) 00:15:20 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)) 00:15:20 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)) 00:15:20 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)) 00:15:20 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)) 00:15:20 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)) 00:15:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:15:20 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 00:15:20 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 00:15:20 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 00:15:20 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 00:15:21 INFO - Downloading blessings-1.6.tar.gz 00:15:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:15:21 INFO - Installing collected packages: blessings 00:15:21 INFO - Running setup.py install for blessings 00:15:21 INFO - Successfully installed blessings 00:15:21 INFO - Cleaning up... 00:15:21 INFO - Return code: 0 00:15:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:15:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:15:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:15:21 INFO - Reading from file tmpfile_stdout 00:15:21 INFO - Current package versions: 00:15:21 INFO - argparse == 1.2.1 00:15:21 INFO - blessings == 1.6 00:15:21 INFO - blobuploader == 1.2.4 00:15:21 INFO - docopt == 0.6.1 00:15:21 INFO - functools32 == 3.2.3-2 00:15:21 INFO - jsonschema == 2.5.1 00:15:21 INFO - manifestparser == 1.1 00:15:21 INFO - mozInstall == 1.13 00:15:21 INFO - mozcrash == 1.0 00:15:21 INFO - mozdebug == 0.1 00:15:21 INFO - mozdevice == 0.51 00:15:21 INFO - mozfile == 1.2 00:15:21 INFO - mozhttpd == 0.7 00:15:21 INFO - mozinfo == 0.10 00:15:21 INFO - mozleak == 0.1 00:15:21 INFO - mozlog == 3.5 00:15:21 INFO - moznetwork == 0.27 00:15:21 INFO - mozprocess == 0.25 00:15:21 INFO - mozprofile == 0.28 00:15:21 INFO - mozrunner == 6.13 00:15:21 INFO - mozscreenshot == 0.1 00:15:21 INFO - mozsystemmonitor == 0.3 00:15:21 INFO - moztest == 0.8 00:15:21 INFO - mozversion == 1.4 00:15:21 INFO - psutil == 3.1.1 00:15:21 INFO - requests == 1.2.3 00:15:21 INFO - wsgiref == 0.1.2 00:15:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:15:21 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')]} 00:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:21 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')]} 00:15:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:21 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 0x28c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a95a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c38d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c35eb0>, '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 0x2c36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c37240>, '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': '232498196343f89f466a4a9a000001c8-1501645543.95757-237912307', '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 00:15:21 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 00:15:21 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 00:15:21 INFO - Using env: {'DISPLAY': ':0', 00:15:21 INFO - 'HOME': '/home/cltbld', 00:15:21 INFO - 'LANG': 'en_US.UTF-8', 00:15:21 INFO - 'LANGUAGE': 'en_US:en', 00:15:21 INFO - 'LOGNAME': 'cltbld', 00:15:21 INFO - 'MAIL': '/var/mail/cltbld', 00:15:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:21 INFO - 'MOZ_NO_REMOTE': '1', 00:15:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:15:21 INFO - 'NO_EM_RESTART': '1', 00:15:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:15:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:21 INFO - 'PWD': '/builds/slave/test', 00:15:21 INFO - 'SHELL': '/bin/bash', 00:15:21 INFO - 'SHLVL': '1', 00:15:21 INFO - 'TERM': 'linux', 00:15:21 INFO - 'TMOUT': '86400', 00:15:21 INFO - 'USER': 'cltbld', 00:15:21 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1501645543.95757-237912307', 00:15:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:21 INFO - '_': '/tools/buildbot/bin/python'} 00:15:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:22 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)) 00:15:22 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)) 00:15:22 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)) 00:15:22 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)) 00:15:22 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)) 00:15:22 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)) 00:15:22 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)) 00:15:22 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)) 00:15:22 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)) 00:15:22 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 00:15:22 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 00:15:22 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 00:15:22 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 00:15:22 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 00:15:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 00:15:23 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)) 00:15:23 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)) 00:15:23 INFO - Installing collected packages: simplejson 00:15:23 INFO - Running setup.py install for simplejson 00:15:23 INFO - building 'simplejson._speedups' extension 00:15:23 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 00:15:24 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 00:15:24 INFO - Successfully installed simplejson 00:15:24 INFO - Cleaning up... 00:15:24 INFO - Return code: 0 00:15:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:15:24 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')]} 00:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:24 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')]} 00:15:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:24 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 0x28c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a95a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c38d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c35eb0>, '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 0x2c36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c37240>, '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': '232498196343f89f466a4a9a000001c8-1501645543.95757-237912307', '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 00:15:24 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 00:15:24 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 00:15:24 INFO - Using env: {'DISPLAY': ':0', 00:15:24 INFO - 'HOME': '/home/cltbld', 00:15:24 INFO - 'LANG': 'en_US.UTF-8', 00:15:24 INFO - 'LANGUAGE': 'en_US:en', 00:15:24 INFO - 'LOGNAME': 'cltbld', 00:15:24 INFO - 'MAIL': '/var/mail/cltbld', 00:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:24 INFO - 'MOZ_NO_REMOTE': '1', 00:15:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:15:24 INFO - 'NO_EM_RESTART': '1', 00:15:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:24 INFO - 'PWD': '/builds/slave/test', 00:15:24 INFO - 'SHELL': '/bin/bash', 00:15:24 INFO - 'SHLVL': '1', 00:15:24 INFO - 'TERM': 'linux', 00:15:24 INFO - 'TMOUT': '86400', 00:15:24 INFO - 'USER': 'cltbld', 00:15:24 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1501645543.95757-237912307', 00:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:24 INFO - '_': '/tools/buildbot/bin/python'} 00:15:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:15:24 INFO - Cleaning up... 00:15:24 INFO - Return code: 0 00:15:24 INFO - Running post-action listener: _resource_record_post_action 00:15:24 INFO - Running post-action listener: _start_resource_monitoring 00:15:24 INFO - Starting resource monitoring. 00:15:24 INFO - [mozharness: 2017-08-02 07:15:24.656515Z] Finished create-virtualenv step (success) 00:15:24 INFO - [mozharness: 2017-08-02 07:15:24.657027Z] Running install step. 00:15:24 INFO - Running pre-action listener: _resource_record_pre_action 00:15:24 INFO - Running main action method: install 00:15:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:15:24 INFO - Reading from file tmpfile_stdout 00:15:24 INFO - Detecting whether we're running mozinstall >=1.0... 00:15:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:15:25 INFO - Reading from file tmpfile_stdout 00:15:25 INFO - Output received: 00:15:25 INFO - Usage: mozinstall [options] installer 00:15:25 INFO - Options: 00:15:25 INFO - -h, --help show this help message and exit 00:15:25 INFO - -d DEST, --destination=DEST 00:15:25 INFO - Directory to install application into. [default: 00:15:25 INFO - "/builds/slave/test"] 00:15:25 INFO - --app=APP Application being installed. [default: firefox] 00:15:25 INFO - mkdir: /builds/slave/test/build/application 00:15:25 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'] 00:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 00:15:43 INFO - Reading from file tmpfile_stdout 00:15:43 INFO - Output received: 00:15:43 INFO - /builds/slave/test/build/application/firefox/firefox 00:15:43 INFO - Running post-action listener: _resource_record_post_action 00:15:43 INFO - [mozharness: 2017-08-02 07:15:43.041402Z] Finished install step (success) 00:15:43 INFO - [mozharness: 2017-08-02 07:15:43.041659Z] Running setup-mitmproxy step. 00:15:43 INFO - Running pre-action listener: _resource_record_pre_action 00:15:43 INFO - Running main action method: setup_mitmproxy 00:15:43 INFO - Skipping: mitmproxy is not required 00:15:43 INFO - Running post-action listener: _resource_record_post_action 00:15:43 INFO - [mozharness: 2017-08-02 07:15:43.042789Z] Finished setup-mitmproxy step (success) 00:15:43 INFO - [mozharness: 2017-08-02 07:15:43.043010Z] Running run-tests step. 00:15:43 INFO - Running pre-action listener: _resource_record_pre_action 00:15:43 INFO - Running pre-action listener: _set_gcov_prefix 00:15:43 INFO - Running main action method: run_tests 00:15:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:15:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:15:43 INFO - Python 2.7.3 00:15:43 INFO - Return code: 0 00:15:43 INFO - grabbing minidump binary from tooltool 00:15: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')]} 00:15:43 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 0x2c35eb0>, '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 0x2c36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c37240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:15:43 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 00:15:43 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 00:15:43 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 00:15:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:15:43 INFO - Return code: 0 00:15:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:15:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:15:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:15:43 INFO - ENV: RUST_BACKTRACE is now 1 00:15:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:15:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:15:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 00:15:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 00:15:43 INFO - Using env: {'DISPLAY': ':0', 00:15:43 INFO - 'HOME': '/home/cltbld', 00:15:43 INFO - 'LANG': 'en_US.UTF-8', 00:15:43 INFO - 'LANGUAGE': 'en_US:en', 00:15:43 INFO - 'LOGNAME': 'cltbld', 00:15:43 INFO - 'MAIL': '/var/mail/cltbld', 00:15:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:15:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:43 INFO - 'MOZ_NO_REMOTE': '1', 00:15:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:15:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:15:43 INFO - 'NO_EM_RESTART': '1', 00:15:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:43 INFO - 'PWD': '/builds/slave/test', 00:15:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:15:43 INFO - 'RUST_BACKTRACE': '1', 00:15:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 00:15:43 INFO - 'SHELL': '/bin/bash', 00:15:43 INFO - 'SHLVL': '1', 00:15:43 INFO - 'TERM': 'linux', 00:15:43 INFO - 'TMOUT': '86400', 00:15:43 INFO - 'USER': 'cltbld', 00:15:43 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1501645543.95757-237912307', 00:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:43 INFO - '_': '/tools/buildbot/bin/python'} 00:15:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 00:15:43 INFO - mozversion application_buildid: 20170801092414 00:15:43 INFO - mozversion application_changeset: 51ffb9283f0c7c00e08eb8c39b33fbee218c370d 00:15:43 INFO - mozversion application_display_name: Nightly 00:15:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:15:43 INFO - mozversion application_name: Firefox 00:15:43 INFO - mozversion application_remotingname: firefox 00:15:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 00:15:43 INFO - mozversion application_vendor: Mozilla 00:15:43 INFO - mozversion application_version: 56.0a1 00:15:43 INFO - mozversion platform_buildid: 20170801092414 00:15:43 INFO - mozversion platform_changeset: 51ffb9283f0c7c00e08eb8c39b33fbee218c370d 00:15:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 00:15:43 INFO - mozversion platform_version: 56.0a1 00:15:43 INFO - using testdate: 1501658143 00:15:43 INFO - actual date: 1501658143 00:15:43 INFO - starting webserver on 'localhost:59288' 00:15:43 INFO - SUITE-START | Running 2 tests 00:15:43 INFO - TEST-START | dromaeo_css 00:15:43 INFO - Initialising browser for dromaeo_css test... 00:15:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59288/getInfo.html -profile /tmp/tmpy9MJjE/profile 00:15:43 INFO - TEST-INFO | started process 28083 (/builds/slave/test/build/application/firefox/firefox http://localhost:59288/getInfo.html) 00:15:49 INFO - TEST-INFO | 28083: exit 0 00:15:49 INFO - Browser initialized. 00:15:49 INFO - Running cycle 1/1 for dromaeo_css test... 00:15:49 INFO - TEST-INFO | started process 28289 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy9MJjE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 00:15:50 INFO - PID 28289 | 00:15:50 INFO - PID 28289 | (/builds/slave/test/build/application/firefox/firefox:28337): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 00:15:50 INFO - PID 28289 | 00:16:00 INFO - PID 28289 | RSS: Main: 171712512 00:16:00 INFO - PID 28289 | 00:19:00 INFO - PID 28289 | Cycle 1(1): loaded http://localhost:59288/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59288/tests/dromaeo/cssquery-ext.html) 00:19:01 INFO - PID 28289 | RSS: Main: 173432832 00:19:01 INFO - PID 28289 | 00:22:03 INFO - PID 28289 | Cycle 1(1): loaded http://localhost:59288/tests/dromaeo/cssquery-ext.html (next: http://localhost:59288/tests/dromaeo/cssquery-jquery.html) 00:22:04 INFO - PID 28289 | RSS: Main: 171302912 00:22:04 INFO - PID 28289 | 00:25:06 INFO - PID 28289 | Cycle 1(1): loaded http://localhost:59288/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59288/tests/dromaeo/cssquery-mootools.html) 00:25:06 INFO - PID 28289 | RSS: Main: 173113344 00:25:06 INFO - PID 28289 | 00:28:08 INFO - PID 28289 | Cycle 1(1): loaded http://localhost:59288/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59288/tests/dromaeo/cssquery-prototype.html) 00:28:09 INFO - PID 28289 | RSS: Main: 171687936 00:28:09 INFO - PID 28289 | 00:31:12 INFO - PID 28289 | Cycle 1(1): loaded http://localhost:59288/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59288/tests/dromaeo/cssquery-yui.html) 00:31:13 INFO - PID 28289 | RSS: Main: 174940160 00:31:13 INFO - PID 28289 | 00:34:15 INFO - PID 28289 | Cycle 1(1): loaded http://localhost:59288/tests/dromaeo/cssquery-yui.html (next: http://localhost:59288/tests/dromaeo/cssquery-dojo.html) 00:34:15 INFO - PID 28289 | RSS: Main: 175235072 00:34:15 INFO - PID 28289 | 00:34:15 INFO - PID 28289 | __start_tp_report 00:34:15 INFO - PID 28289 | _x_x_mozilla_page_load 00:34:15 INFO - PID 28289 | _x_x_mozilla_page_load_details 00:34:15 INFO - PID 28289 | |i|pagename|runs| 00:34:15 INFO - PID 28289 | |0;dojo.html;3105.5807465992093;3137.2941088255147;3140.3248301615135;3170.8097514149167;3215.742740580754;6208.19293491846;6236.438720515152;6245.875082498347;6289.559730818844;6320.273168585614;6070.908936365958;6179.814605561829;6201.565890387675;6203.286622038467;6255.249370075598;5595.7481913313895;5684.062129748587;5752.108423194411;5759.942400576004;5815.82552523425;5710.971445142768;5764.51001664859;5787.218725472049;5810.535157187415;5842.824715258549;5443.401225865172;5631.690257035862;5631.887362252773;5676.886462270772;5768;5642.181883626851;5648.293963254593;5713.457221563945;5730.512906402961;5733.369329373765;5548.528375088123;5594.300712410949;5623.887522249573;5700.401457846908;5702.144678298247;6029.306629737593;6090.695465226765;6108.053251745987;6111.388861113897;6188.814335569895;6685.565438246498;6688.83277918051;6710.228323742784;6720.227173875018;6741.764038258686;6652.866942661168;6762.93237067628;6776.186857577073;6779.5593286436715;6797.524173307821;6179.443850053517;6235.906461403038;6298.149749783812;6310.116583678288;6327.936720632827;6606.10817539626;6684.899726504106;6737.8652426951185;6793.66031698423;6872.759453419107;6561.1470508833545;6597.60414375139;6599.802005939733;6601.8349541260895;6608.768693095719;6589.703463344161;6591.143151390384;6592.307807680125;6686.966565167143;6700.597964122168;6464.838379040468;6591.670416479157;6596.934030659632;6652.268250492442;6684.799456016327;6625.635590042594;6704.7988560343265;6705.497087718343;6705.966470167618;6711.798646040626;5400.351957765093;5433;5440.673559586358;5471.781128754885;5476.096444086681;4535.931961020521;4589.655775816827;4645.86062418128;4660.04469083837;4676.158291507493;5580;5683.687397193112;5770.567207459458;5834.095715164156;5857.355690874;6665.833354166185;6675.566088204251;6677.165354330708;6686.297938716365;6690.397864192246;5732.57005724564;5751.712414379264;5755.22304488897;5763.596548241667;5764.077747560454;5676.801311954062;5824.650520968671;5827.3298570664065;5830.3586605473365;5835.299764028344;6440.4847612190915;6529.804105876831;6530.836729081716;6530.934690653127;6535.346465353522;6659.53383263167;6683.699233534406;6755;6760.087388202628;6781.254062053269;6322.209723784527;6408.647524386203;6414.422701956846;6422.9036564450635;6513.413792758674;6557.540972131905;6579.17760279965;6583;6622.966885165543;6626.105475760711;6711.362420570038;6721.260661327348;6735;6735.730570777114;6738.09035780183;6421.614703117828;6499.1876015498065;6509.641969691713;6521.119648847345;6531.314212007861;6370.140031095742;6429.903551446639;6443.130177425987;6465.967670161619;6478.222613286436;6318.8736225274315;6326.810195693953;6331.05034244867;6340.714667839866;6341.492680585634;6374;6432.742690292336;6538.901916471162;6568.376004279586;6617.371349721769;6174.9073763892675;6285.402886725754;6358.237011558643;6370.108184854217;6395.616263024233 00:34:15 INFO - PID 28289 | |1;ext.html;859.70769938221;860.8536548786707;905.4838741917106;908.3641450984312;1161.2277835239565;31802.36395272096;32390.67609323906;41738;42264.36603450943;42424.36363454543;42693.14613707724;43062.354064689054;43081.784591077;43134.13731725371;43190.136197276035;7615.543067415945;7722.691092356299;7728.26581474759;7731.884021739678;7748.2251774822635;7660.502067365604;7737.187595302496;7888.171741967097;7892.486988345768;7900.762977110696;7835.059792824841;7862.528248305091;7871.881921771178;7885;7887.723929662434;7686.500377475446;7830.647620857047;7832.765017049469;7836.098848632423;7838.333741631968;7720.15078341382;7812.257835505675;7816.257455541771;7817.335526480256;7824.256695613964;39989.20021599581;40080;40103.79688609317;40136.799316003235;40287.7985610073;3546.3793836078585;3587.0494319005484;3591.586967498719;3591.6587924147425;3593.317269718745;31613.84193079043;31942.20144496383;31953.84023079893;31992;32116.839415802773;4631.62946964242;4787.784549695272;4812.759362031919;4878.243872199815;4896.2410826321975;184150;185958;186140;186312;186656;50454;50568.747156263984;50589;50807.49192508101;50852.745736271085;51966;52221;52380;52472.21291680628;52542.21186682203;16268.674626507403;16703.081330526693;16723.163841807862;16745;16761.916190419215;13611;13719.382627781773;13805.309734513436;13816.101953372998;13838.4464621414;12924.935375323063;13299.66750831237;14243.21662308583;14312.06971546846;14444.205568693613;5699.401562835926;5751.1085781703905;5806.767729290866;5880.558958078162;5881.558883083786;962.605331813953;987.6641941739699;1005.3766664667953;1013.3463915774431;1021.4841505040056;22120.88939555292;22157.026827467387;22870.542589148456;23291;23373.649395259086;1092.2354351953663;1100.8183649697871;1127.1264769803468;1131.1290306463977;1135.8864113588575;11527.365994870195;12189.085818563643;12198.634040978784;12231.204971676812;12376.257424554555;214062;215562;215776;216181;216348;53739.73130134402;53886.46113538814;54046.45953540493;54244.72877635666;54268.45731542713;1438.978415323771;1465.5749832548443;1475.8524147585156;1479.0386248938062;1507.864292213706;22009;22598.209062683385;22702;23142.768572314733;23169.189078382176;37407.251854963295;37661.246775064894;37731.62268377281;37737.245255095295;37772;192138;192854;193200;193952;193994;30734;31335;33981.320373592884;34253.65746342605;34479;42743.3588496179;45288.77355613201;45729.08541829211;45818.312725309814;46237;30830.383392332475;32293.677063229068;35648;35946;36021.45967810432;34809.30381392409;34868;34978;35523.82238088897;35814.28371432609;41297.587024129374;41298.58701412947;41316.79341603273;41323.1735365297;41678.37482437705;41930.580694192664;42874.78562607167;43395.56604433915;43588.51291896704;43928;25380.11169609055;25623.462592244527;25723.099691511456;26703.19890403291;26828.195154145407 00:34:15 INFO - PID 28289 | |2;jquery.html;575.9164921086442;582.6591444005256;589.3929252869543;594.7947957954505;596.4870211618007;21710.782892171075;22086.779132208674;22718.318450446513;22797;22808.771912280874;24069.759302406972;24526;24545.018199272006;24606.507869842637;24611.507769844593;6473.579217350869;6547.410733034026;6596.835079123012;6634.767783127591;6639.5684280521855;5979.701014949257;6460.547761656662;6548.6725663716625;6549.836254093638;6552.279249282575;6491.740330386802;6494.447971922368;6501.252355979052;6507.251666058417;6514.21829380475;6480.611163330215;6484;6498.480121590262;6499.675016249193;6503.089567460559;6045.78839740607;6060.575759696823;6061.757529698807;6064.02975523914;6080.756769729205;27153.728462715317;28495.430091398055;29145.271368215752;29670.406591868043;29895.40209195804;1874.7281644161656;1903.1816318982833;1905.5236190952262;1924.3649595633547;1925.9903700481548;18574.535636609056;18937.715934260996;19123.948182849937;19129.2348306069;20078.799212007983;2500.9374765630823;2564.051301018635;2569.1650213680628;2572.8199026068182;2579.9613005804927;139923;141203;142527;142808.28595856956;146033;21279.78720212809;22124.02209502849;22460;22509.247225832183;22932.541349172923;44754.55245447504;44784.77607611941;44810.10379792386;44845.103097937856;44855.327170092474;11839.348835814113;12035.879641203652;12193.939030304791;12212.816807747891;12384.690382740504;8055.637496312563;8413.368997325226;10139.594416223415;10195.949020255;10614.681559553072;10603.469826508644;11321.264117832314;11466.770664586662;11768.646940591796;11886.405679716152;4028.9194216115516;4140.23405669946;4205.663546916239;4378.5183629800695;4397.252467080604;917.4311926605548;943.5376665433888;951.1392190068;969.3472629167253;969.4038166527534;19870.304539341054;20036.89981550112;20063.39809805708;20460.283890063776;20485.180592776123;979.5396163803001;1011.6863772230632;1017.6183931025865;1040.354979912444;1041.245097304448;10127.392356458637;10335.74160645975;10395.792084158275;10428.374297542172;10945.109944616377;513245;513454;523758;525042;526023;124286;126952.36523817507;128105;129581;129639.35180324227;1233.660743295583;1249.4689756853302;1280.302235281755;1282.7049778550986;1283.3775618824861;19534;20261.6960745586;20657;20860.269890553758;21224.681629775874;59889.700551496964;60047.39952600593;60321;61322.386776131665;63057.68471157615;74246.62876685582;78977;79098.20901790909;79212.20787792279;80835;16121.435749748702;16996;19751.80248197557;20163.495912601717;20436.38690839277;22613.321600352017;22841.657375139053;23199.88400057989;23331.300060998197;23589.174378896656;17974.82025179784;18108.547286317946;18335.358262461283;18354.082295884884;18620.720689189402;14972.326245319206;15180.620484487534;15397.538073857802;16409.58976025609;16728.916355418143;18280.177392017657;18524.629507409507;18602.44192674222;18687.813121868607;18790.812091878906;19884.801151988875;20001;20023.29918452847;20030.699539506626;20040.89979550093;17922.462326130237;18005.2797888083;18256.81743182551;18282.542936426165;18287.359942402483 00:34:15 INFO - PID 28289 | |3;mootools.html;1322.272749987507;1369.986300136999;1400.8879289656822;1402.6212922510929;1402.9298535073244;13649.31753412329;13962.092463989859;14285.285735713225;14300.928495357508;14342.641433964143;14294.71410571788;14511;14545.563633091024;14555.053921495122;14570.635734106652;2639.3269716222335;2663.2942270298386;2671.19864040787;2680.155750938458;2692.165428717094;2581.3288544978345;2730.931726706828;2745.8764355604044;2746.436980419019;2753.4217814258927;2668.519666460036;2698.7031426543062;2712.905048323309;2714.362124900647;2716.891324347024;2651.376926422289;2656.296081538394;2685.476332115238;2693.878775455109;2710.5256580098403;2608.113241497881;2619.4368210834573;2650.575907854734;2664.3605534671733;2673.0911490093463;13803.102798318178;13896.096753710977;13904.304784760721;13930.164190148522;13930.93034534831;7512.812179695551;7741.800020996755;7759.65081571325;7768.184340644208;7773.766786996399;4889;5036.456589422355;5146.768395422215;5172.431032586413;5192.9740351298005;1552.5652817211087;1580.2888700085007;1620.5786495511134;1629.226117594145;1641.7455294429383;21886;22415.43961400978;22467.662985055238;22469.55060898789;22482.887585561966;6617.602943823386;6639.2406012406755;6730.158730158731;6939.861202775916;7001.964990175016;14664.193469359288;15380.692386152214;15484.148371839658;15572.221388930508;17333.47999560015;7500.549967001997;7714.112877019103;7720.189380115119;7727.072751269883;7730.961345193238;6918.273581273995;7044.577325360495;7062.470314726416;7171.92828071723;7220.241874603091;5180.81867134656;5291.603129765283;5298.602604804655;5306.52241298285;5359.3032905722;1534.2252162657787;1534.6853894951507;1534.8541888520572;1542.8688561472177;1549.2408719727478;811.7077851973285;816.8447994880953;821.3142026407896;846.5301757524633;871.4074429388077;6613.173353330833;6741.696623651947;6826.829329266709;6864.176298844171;6913.446924246048;695.5305169010898;711.6441779110445;729.3399473476512;730.3828265115968;736.6721808795035;4357.281048627005;4419.779011049434;4474.351219073216;4479.753613551221;4610.354550362952;17861.821381786274;18957.336493222672;19000.52498687544;19026.238950442104;19042.523936901413;18293.7255941161;18439;19209.80790192108;19316;19356.61286774285;10081.899181008095;10540;10646.574137034588;10683.771366292976;10746.24776265654;7201.207867134715;7504.887426688495;7686.192949740421;7718.57547834852;7804.492707973964;15970.520884373487;16341.264643090852;16431.096289704183;16617.50147495577;16931.57671058184;15967.44113956006;16470.75293870617;16723;16973.23620437108;17644.117794109985;12765.553205637758;13025.674358141123;13031.739365212832;13041.673958151123;13086.476540938636;13149.408276627384;13266.33668316561;13328.533501327407;13537.1200871943;13665.658358541115;10831.67504974852;10834.187435942493;10840.241183117421;10985.890141098487;11212.775744485229;9883.456409897237;10373.481325933824;10408.063274305348;10451.268411211142;10531.89468105309;8675.34934879874;8798.824023519623;8799.12008799115;8806.383553151474;8809.867851982353;6106.297775755845;6385.169927909342;6500.479961603155;6543.083968244355;6543.803685889431;6325.399087086719;6584.144061272004;6644.468442524683;6773.491988101011;6837.145356830396 00:34:15 INFO - PID 28289 | |4;prototype.html;488.3981498328912;500.34068923670696;514.6397521734787;519.2082074835876;521.0828941063729;6208.1752802474875;6243.157173781538;6254.842079482582;6254.968725156368;6290.465310448606;5903.557233207505;5996.453280715343;6046.7883624073165;6052.6368417894955;6072.8481787955325;4821.601735496711;4916.237983112624;4918.827841025565;4927.310176575283;4931.7040977541465;4796.25658023007;4890.584300334476;4948.653594248404;4950.504949505057;4955.578775804061;4862.07620552094;4898.265260210961;4905.239687848371;4919.606431485473;4941.728204948727;4857.878553036167;4904.190808516591;4906.337644418011;4912.771807048202;4925.679830811004;4434.49003364614;4444.288913773813;4467.128909862578;4478.350639157304;4495.955040449587;6078.355915176868;6105.389461053859;6108.908366374508;6125.418085281891;6128.63228206309;5585.357683866367;5623.063855301305;5708.343540492855;5727.684977326246;5731;6395.392437718409;6463.192100987377;6499.707513161872;6501.642409667466;6502.349765023459;4784.976075119637;4817.253325734517;4818.855434336941;4878.804847806084;4881;6702.463802895757;6773.559718618274;6794.76218332356;6911.3779759821855;6948.861022779567;4829.806807727651;4841.273808928689;4889.633277504201;4904.509549045139;4910.410750709866;4938.333325001079;4986.426560945465;4991.850244492671;4999.3000979862845;5007.549320561167;5588.189712491747;5629.8205650801365;5635.520980716603;5644.193857965493;5659.886802263932;6411.935880641134;6499.375156210947;6524.739010439529;6530.8367290818105;6572.835679107965;1636.533587927435;1695.1608953568063;1708.7180615198602;1721.5265801904577;1743.4595275464646;1186.211169572225;1194.325206258461;1219.6766508338553;1221.5175005872632;1236.1964722930168;5657.51911087554;5674.546036317085;5719.4852463277675;5735.913961290584;5806.854828629233;6361.427471527585;6548.345165483413;6638.402543771083;6684.532082754258;6693.698783554752;5748.798792042258;5759.712014399263;5779.797707080232;5804.477597016289;5815.156802263648;3517.402041652925;3525.7884526928465;3534.593521744981;3541.610422853484;3570.0360902556686;6443.48452123829;6485.902711459332;6488.708008139645;6489.707963141575;6490.902636460457;6777;6783.626900520519;6791.524593278522;6824.590524568542;6925.58446493202;6333.8733225336155;6372.681365931592;6406.423421892052;6423.430627748938;6458.580192287486;6518;6576.473882089325;6617.43751781104;6648.9002664961035;6677.76627818024;6381.808545743449;6490.935090649033;6655.267920528641;6680.198376194888;6708;6513.283538810632;6546.312637173219;6555.147830781968;6563.704633291609;6572.474202063728;4906;4925.285833554043;4935.259711043373;4939.6542242042715;4964.35463389757;6491.870162596627;6678.495564163439;6716.429103526255;6756.662166891538;6780.762673306411;6157.445829875153;6362.427381535684;6444.9033264502;6476;6487.545871789118;6265.592736472115;6473.579217350857;6496.74013039492;6524.869502609827;6561.212654481493;6404.807855764335;6425.8714825704155;6431.5529005973285;6454.451371633464;6475;6478.1578394808375;6493.59736897351;6524.380183882524;6602.8679426410245;6606.43845273138;6307.432331090224;6319.210098737658;6408.198975128109;6410.391012853772;6420.550561460653 00:34:15 INFO - PID 28289 | |5;yui.html;906.0984320601007;922.4511415707653;936.6862101196099;937.4937533731785;949.1599934058358;18093.547661308476;18810.62378752424;18845.71731424028;18900.243990240408;20869.582608347824;20348;21030.789692103073;21171.364859054254;21340.57318853622;21353.35939921801;1005.6128390569628;1051.0908064524208;1054.4991129213602;1055.9260851740382;1056.0337291378419;1002.9899701003006;1046.4558429616595;1059.9576016959352;1061.0768631290787;1061.3101484035362;1073.0503504398625;1080.4975686305866;1081.0810810810788;1081.6052140968568;1081.6754973507955;1068.2041878800344;1071.0307172009343;1073.7798751256014;1073.940933248671;1076.7900259449411;782.4170992610485;787.8424315136996;788.3062904643934;789.0570767932323;789.135896193667;17777.555561110945;17891.1948962297;17983.280668773234;18024.00867952262;19573.412797616093;18361.173747181274;18832.905835470734;19109;19151.23395064196;19238.03809809504;15530.61173470661;15749.291281892343;15922.044677319398;15948.681026379523;15995.440159594475;3425.4348032574594;3442.4147894857933;3447.9310413791836;3454.0156055524308;3467.6358982306747;120857.39571302175;122824;123439;126413;126538.36730816287;15406.845931540765;15493;15688.215589220494;15751;15761.842381576267;29408.558871616944;29418.264543386158;29441.55837662437;29467.231966082105;29644.555331670043;7328.633568321563;8081.878771818428;8215.876761848576;8577;8969.775755606031;3988.720789544704;4159.771212583337;4160.750354978711;4166.041810383568;4166.8749937501925;5056.292119103328;5078.13671675816;5126.282320475137;5195.272661827347;5207.114790485626;1015.8069966706303;1039.719275795546;1059.777446736194;1062.8405739139191;1064.5741703318579;644.1207751419372;667.4060086522999;693.7987983484733;694.9861002779916;702.28016283309;10120.240981926385;13295.93352033253;13394;13722.794158087636;13739.519116830863;676.5703778100941;683.7846078485261;695.5305169010898;706.9823254418578;709.8189961559873;5221.164613661796;5234.398044224963;5430.83707488776;5508.889822203613;5714.2571465710025;95977.5201124004;98406;99409.50295248478;100947;101358;84606;86888;89295.55352223197;93523;95002;79531;82165.58917205376;83250;83354.16645833464;83698.58150709329;11786.351750653796;11851.229670071418;12093.637190884288;12141.575044873387;12340.165825630062;34321.31357372888;34685.82657086799;34996.12509687278;35471.46792798162;37794;41547.79226103971;43304;44140.77929610331;45029;66815.66592167203;18789.34237301688;18881.71677424812;19348.70976935319;19357.322493712654;19719.60560788805;19745.308914187935;20110.39668809938;20204.59590808146;20897.791022089583;20961.89519052395;17574.297028119243;17737.113144342988;18054.729179062586;18234.72647910256;18625.53436164107;17498.650026999643;17589.472315830546;17987.83079099854;18650.253989840254;18896.52758680989;17630.206640700944;17732.822671773116;18007.09964501796;18135.727964080284;18385;12400.75198496043;12698.30159341245;13053.28206948627;13496.190228586316;13713.725725485236;13366.465341386236;13565.796513052115;13599.796003059764;13735.24456154881;13764.242966636932 00:34:15 INFO - PID 28289 | __end_tp_report 00:34:15 INFO - PID 28289 | __start_cc_report 00:34:15 INFO - PID 28289 | _x_x_mozilla_cycle_collect,352 00:34:15 INFO - PID 28289 | __end_cc_report 00:34:15 INFO - PID 28289 | __startTimestamp1501659255404__endTimestamp 00:34:15 INFO - PID 28289 | 00:34:15 INFO - PID 28289 | ------- Summary: start ------- 00:34:15 INFO - PID 28289 | Number of tests: 6 00:34:15 INFO - PID 28289 | 00:34:15 INFO - PID 28289 | [#0] dojo.html Cycles:165 Average:6129.18 Median:6341.49 stddev:722.45 (11.4%) stddev-sans-first:684.63 00:34:15 INFO - PID 28289 | Values: 3105.6 3137.3 3140.3 3170.8 3215.7 6208.2 6236.4 6245.9 6289.6 6320.3 6070.9 6179.8 6201.6 6203.3 6255.2 5595.7 5684.1 5752.1 5759.9 5815.8 5711.0 5764.5 5787.2 5810.5 5842.8 5443.4 5631.7 5631.9 5676.9 5768.0 5642.2 5648.3 5713.5 5730.5 5733.4 5548.5 5594.3 5623.9 5700.4 5702.1 6029.3 6090.7 6108.1 6111.4 6188.8 6685.6 6688.8 6710.2 6720.2 6741.8 6652.9 6762.9 6776.2 6779.6 6797.5 6179.4 6235.9 6298.1 6310.1 6327.9 6606.1 6684.9 6737.9 6793.7 6872.8 6561.1 6597.6 6599.8 6601.8 6608.8 6589.7 6591.1 6592.3 6687.0 6700.6 6464.8 6591.7 6596.9 6652.3 6684.8 6625.6 6704.8 6705.5 6706.0 6711.8 5400.4 5433.0 5440.7 5471.8 5476.1 4535.9 4589.7 4645.9 4660.0 4676.2 5580.0 5683.7 5770.6 5834.1 5857.4 6665.8 6675.6 6677.2 6686.3 6690.4 5732.6 5751.7 5755.2 5763.6 5764.1 5676.8 5824.7 5827.3 5830.4 5835.3 6440.5 6529.8 6530.8 6530.9 6535.3 6659.5 6683.7 6755.0 6760.1 6781.3 6322.2 6408.6 6414.4 6422.9 6513.4 6557.5 6579.2 6583.0 6623.0 6626.1 6711.4 6721.3 6735.0 6735.7 6738.1 6421.6 6499.2 6509.6 6521.1 6531.3 6370.1 6429.9 6443.1 6466.0 6478.2 6318.9 6326.8 6331.1 6340.7 6341.5 6374.0 6432.7 6538.9 6568.4 6617.4 6174.9 6285.4 6358.2 6370.1 6395.6 00:34:15 INFO - PID 28289 | 00:34:15 INFO - PID 28289 | [#1] ext.html Cycles:180 Average:37781.02 Median:36714.36 stddev:51399.16 (140.0%) stddev-sans-first:51468.58 00:34:15 INFO - PID 28289 | Values: 859.7 860.9 905.5 908.4 1161.2 31802.4 32390.7 41738.0 42264.4 42424.4 42693.1 43062.4 43081.8 43134.1 43190.1 7615.5 7722.7 7728.3 7731.9 7748.2 7660.5 7737.2 7888.2 7892.5 7900.8 7835.1 7862.5 7871.9 7885.0 7887.7 7686.5 7830.6 7832.8 7836.1 7838.3 7720.2 7812.3 7816.3 7817.3 7824.3 39989.2 40080.0 40103.8 40136.8 40287.8 3546.4 3587.0 3591.6 3591.7 3593.3 31613.8 31942.2 31953.8 31992.0 32116.8 4631.6 4787.8 4812.8 4878.2 4896.2 184150.0 185958.0 186140.0 186312.0 186656.0 50454.0 50568.7 50589.0 50807.5 50852.7 51966.0 52221.0 52380.0 52472.2 52542.2 16268.7 16703.1 16723.2 16745.0 16761.9 13611.0 13719.4 13805.3 13816.1 13838.4 12924.9 13299.7 14243.2 14312.1 14444.2 5699.4 5751.1 5806.8 5880.6 5881.6 962.6 987.7 1005.4 1013.3 1021.5 22120.9 22157.0 22870.5 23291.0 23373.6 1092.2 1100.8 1127.1 1131.1 1135.9 11527.4 12189.1 12198.6 12231.2 12376.3 214062.0 215562.0 215776.0 216181.0 216348.0 53739.7 53886.5 54046.5 54244.7 54268.5 1439.0 1465.6 1475.9 1479.0 1507.9 22009.0 22598.2 22702.0 23142.8 23169.2 37407.3 37661.2 37731.6 37737.2 37772.0 192138.0 192854.0 193200.0 193952.0 193994.0 30734.0 31335.0 33981.3 34253.7 34479.0 42743.4 45288.8 45729.1 45818.3 46237.0 30830.4 32293.7 35648.0 35946.0 36021.5 34809.3 34868.0 34978.0 35523.8 35814.3 41297.6 41298.6 41316.8 41323.2 41678.4 41930.6 42874.8 43395.6 43588.5 43928.0 25380.1 25623.5 25723.1 26703.2 26828.2 00:34:15 INFO - PID 28289 | 00:34:15 INFO - PID 28289 | [#2] jquery.html Cycles:180 Average:37589.15 Median:22292.01 stddev:87689.20 (393.4%) stddev-sans-first:87891.16 00:34:15 INFO - PID 28289 | Values: 575.9 582.7 589.4 594.8 596.5 21710.8 22086.8 22718.3 22797.0 22808.8 24069.8 24526.0 24545.0 24606.5 24611.5 6473.6 6547.4 6596.8 6634.8 6639.6 5979.7 6460.5 6548.7 6549.8 6552.3 6491.7 6494.4 6501.3 6507.3 6514.2 6480.6 6484.0 6498.5 6499.7 6503.1 6045.8 6060.6 6061.8 6064.0 6080.8 27153.7 28495.4 29145.3 29670.4 29895.4 1874.7 1903.2 1905.5 1924.4 1926.0 18574.5 18937.7 19123.9 19129.2 20078.8 2500.9 2564.1 2569.2 2572.8 2580.0 139923.0 141203.0 142527.0 142808.3 146033.0 21279.8 22124.0 22460.0 22509.2 22932.5 44754.6 44784.8 44810.1 44845.1 44855.3 11839.3 12035.9 12193.9 12212.8 12384.7 8055.6 8413.4 10139.6 10195.9 10614.7 10603.5 11321.3 11466.8 11768.6 11886.4 4028.9 4140.2 4205.7 4378.5 4397.3 917.4 943.5 951.1 969.3 969.4 19870.3 20036.9 20063.4 20460.3 20485.2 979.5 1011.7 1017.6 1040.4 1041.2 10127.4 10335.7 10395.8 10428.4 10945.1 513245.0 513454.0 523758.0 525042.0 526023.0 124286.0 126952.4 128105.0 129581.0 129639.4 1233.7 1249.5 1280.3 1282.7 1283.4 19534.0 20261.7 20657.0 20860.3 21224.7 59889.7 60047.4 60321.0 61322.4 63057.7 74246.6 78977.0 79098.2 79212.2 80835.0 16121.4 16996.0 19751.8 20163.5 20436.4 22613.3 22841.7 23199.9 23331.3 23589.2 17974.8 18108.5 18335.4 18354.1 18620.7 14972.3 15180.6 15397.5 16409.6 16728.9 18280.2 18524.6 18602.4 18687.8 18790.8 19884.8 20001.0 20023.3 20030.7 20040.9 17922.5 18005.3 18256.8 18282.5 18287.4 00:34:15 INFO - PID 28289 | 00:34:15 INFO - PID 28289 | [#3] mootools.html Cycles:180 Average:8595.00 Median:2659.80 stddev:5876.55 (220.9%) stddev-sans-first:5867.63 00:34:15 INFO - PID 28289 | Values: 1322.3 1370.0 1400.9 1402.6 1402.9 13649.3 13962.1 14285.3 14300.9 14342.6 14294.7 14511.0 14545.6 14555.1 14570.6 2639.3 2663.3 2671.2 2680.2 2692.2 2581.3 2730.9 2745.9 2746.4 2753.4 2668.5 2698.7 2712.9 2714.4 2716.9 2651.4 2656.3 2685.5 2693.9 2710.5 2608.1 2619.4 2650.6 2664.4 2673.1 13803.1 13896.1 13904.3 13930.2 13930.9 7512.8 7741.8 7759.7 7768.2 7773.8 4889.0 5036.5 5146.8 5172.4 5193.0 1552.6 1580.3 1620.6 1629.2 1641.7 21886.0 22415.4 22467.7 22469.6 22482.9 6617.6 6639.2 6730.2 6939.9 7002.0 14664.2 15380.7 15484.1 15572.2 17333.5 7500.5 7714.1 7720.2 7727.1 7731.0 6918.3 7044.6 7062.5 7171.9 7220.2 5180.8 5291.6 5298.6 5306.5 5359.3 1534.2 1534.7 1534.9 1542.9 1549.2 811.7 816.8 821.3 846.5 871.4 6613.2 6741.7 6826.8 6864.2 6913.4 695.5 711.6 729.3 730.4 736.7 4357.3 4419.8 4474.4 4479.8 4610.4 17861.8 18957.3 19000.5 19026.2 19042.5 18293.7 18439.0 19209.8 19316.0 19356.6 10081.9 10540.0 10646.6 10683.8 10746.2 7201.2 7504.9 7686.2 7718.6 7804.5 15970.5 16341.3 16431.1 16617.5 16931.6 15967.4 16470.8 16723.0 16973.2 17644.1 12765.6 13025.7 13031.7 13041.7 13086.5 13149.4 13266.3 13328.5 13537.1 13665.7 10831.7 10834.2 10840.2 10985.9 11212.8 9883.5 10373.5 10408.1 10451.3 10531.9 8675.3 8798.8 8799.1 8806.4 8809.9 6106.3 6385.2 6500.5 6543.1 6543.8 6325.4 6584.1 6644.5 6773.5 6837.1 00:34:15 INFO - PID 28289 | 00:34:15 INFO - PID 28289 | [#4] prototype.html Cycles:180 Average:5460.35 Median:6091.87 stddev:1538.05 (25.2%) stddev-sans-first:1496.41 00:34:15 INFO - PID 28289 | Values: 488.4 500.3 514.6 519.2 521.1 6208.2 6243.2 6254.8 6255.0 6290.5 5903.6 5996.5 6046.8 6052.6 6072.8 4821.6 4916.2 4918.8 4927.3 4931.7 4796.3 4890.6 4948.7 4950.5 4955.6 4862.1 4898.3 4905.2 4919.6 4941.7 4857.9 4904.2 4906.3 4912.8 4925.7 4434.5 4444.3 4467.1 4478.4 4496.0 6078.4 6105.4 6108.9 6125.4 6128.6 5585.4 5623.1 5708.3 5727.7 5731.0 6395.4 6463.2 6499.7 6501.6 6502.3 4785.0 4817.3 4818.9 4878.8 4881.0 6702.5 6773.6 6794.8 6911.4 6948.9 4829.8 4841.3 4889.6 4904.5 4910.4 4938.3 4986.4 4991.9 4999.3 5007.5 5588.2 5629.8 5635.5 5644.2 5659.9 6411.9 6499.4 6524.7 6530.8 6572.8 1636.5 1695.2 1708.7 1721.5 1743.5 1186.2 1194.3 1219.7 1221.5 1236.2 5657.5 5674.5 5719.5 5735.9 5806.9 6361.4 6548.3 6638.4 6684.5 6693.7 5748.8 5759.7 5779.8 5804.5 5815.2 3517.4 3525.8 3534.6 3541.6 3570.0 6443.5 6485.9 6488.7 6489.7 6490.9 6777.0 6783.6 6791.5 6824.6 6925.6 6333.9 6372.7 6406.4 6423.4 6458.6 6518.0 6576.5 6617.4 6648.9 6677.8 6381.8 6490.9 6655.3 6680.2 6708.0 6513.3 6546.3 6555.1 6563.7 6572.5 4906.0 4925.3 4935.3 4939.7 4964.4 6491.9 6678.5 6716.4 6756.7 6780.8 6157.4 6362.4 6444.9 6476.0 6487.5 6265.6 6473.6 6496.7 6524.9 6561.2 6404.8 6425.9 6431.6 6454.5 6475.0 6478.2 6493.6 6524.4 6602.9 6606.4 6307.4 6319.2 6408.2 6410.4 6420.6 00:34:15 INFO - PID 28289 | 00:34:15 INFO - PID 28289 | [#5] yui.html Cycles:180 Average:22151.71 Median:19194.64 stddev:29697.84 (154.7%) stddev-sans-first:29738.30 00:34:15 INFO - PID 28289 | Values: 906.1 922.5 936.7 937.5 949.2 18093.5 18810.6 18845.7 18900.2 20869.6 20348.0 21030.8 21171.4 21340.6 21353.4 1005.6 1051.1 1054.5 1055.9 1056.0 1003.0 1046.5 1060.0 1061.1 1061.3 1073.1 1080.5 1081.1 1081.6 1081.7 1068.2 1071.0 1073.8 1073.9 1076.8 782.4 787.8 788.3 789.1 789.1 17777.6 17891.2 17983.3 18024.0 19573.4 18361.2 18832.9 19109.0 19151.2 19238.0 15530.6 15749.3 15922.0 15948.7 15995.4 3425.4 3442.4 3447.9 3454.0 3467.6 120857.4 122824.0 123439.0 126413.0 126538.4 15406.8 15493.0 15688.2 15751.0 15761.8 29408.6 29418.3 29441.6 29467.2 29644.6 7328.6 8081.9 8215.9 8577.0 8969.8 3988.7 4159.8 4160.8 4166.0 4166.9 5056.3 5078.1 5126.3 5195.3 5207.1 1015.8 1039.7 1059.8 1062.8 1064.6 644.1 667.4 693.8 695.0 702.3 10120.2 13295.9 13394.0 13722.8 13739.5 676.6 683.8 695.5 707.0 709.8 5221.2 5234.4 5430.8 5508.9 5714.3 95977.5 98406.0 99409.5 100947.0 101358.0 84606.0 86888.0 89295.6 93523.0 95002.0 79531.0 82165.6 83250.0 83354.2 83698.6 11786.4 11851.2 12093.6 12141.6 12340.2 34321.3 34685.8 34996.1 35471.5 37794.0 41547.8 43304.0 44140.8 45029.0 66815.7 18789.3 18881.7 19348.7 19357.3 19719.6 19745.3 20110.4 20204.6 20897.8 20961.9 17574.3 17737.1 18054.7 18234.7 18625.5 17498.7 17589.5 17987.8 18650.3 18896.5 17630.2 17732.8 18007.1 18135.7 18385.0 12400.8 12698.3 13053.3 13496.2 13713.7 13366.5 13565.8 13599.8 13735.2 13764.2 00:34:15 INFO - PID 28289 | -------- Summary: end -------- 00:34:15 INFO - PID 28289 | 00:34:16 INFO - TEST-INFO | 28289: exit 0 00:34:16 INFO - TEST-OK | dromaeo_css | took 1112668ms 00:34:16 INFO - TEST-START | kraken 00:34:16 INFO - Initialising browser for kraken test... 00:34:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59288/getInfo.html -profile /tmp/tmpEvfyC4/profile 00:34:16 INFO - TEST-INFO | started process 28656 (/builds/slave/test/build/application/firefox/firefox http://localhost:59288/getInfo.html) 00:34:22 INFO - TEST-INFO | 28656: exit 0 00:34:22 INFO - Browser initialized. 00:34:22 INFO - Running cycle 1/1 for kraken test... 00:34:22 INFO - TEST-INFO | started process 28867 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEvfyC4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 00:34:23 INFO - PID 28867 | 00:34:23 INFO - PID 28867 | (/builds/slave/test/build/application/firefox/firefox:28915): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 00:34:23 INFO - PID 28867 | 00:34:33 INFO - PID 28867 | RSS: Main: 171663360 00:34:33 INFO - PID 28867 | 00:34:36 INFO - PID 28867 | Cycle 1(1): loaded http://localhost:59288/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59288/tests/kraken/driver.html?testName=audio-beat-detection) 00:34:37 INFO - PID 28867 | RSS: Main: 177836032 00:34:37 INFO - PID 28867 | 00:34:39 INFO - PID 28867 | Cycle 1(1): loaded http://localhost:59288/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59288/tests/kraken/driver.html?testName=audio-dft) 00:34:40 INFO - PID 28867 | RSS: Main: 178135040 00:34:40 INFO - PID 28867 | 00:34:43 INFO - PID 28867 | Cycle 1(1): loaded http://localhost:59288/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59288/tests/kraken/driver.html?testName=audio-fft) 00:34:43 INFO - PID 28867 | RSS: Main: 171646976 00:34:43 INFO - PID 28867 | 00:34:46 INFO - PID 28867 | Cycle 1(1): loaded http://localhost:59288/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59288/tests/kraken/driver.html?testName=audio-oscillator) 00:34:46 INFO - PID 28867 | RSS: Main: 172400640 00:34:46 INFO - PID 28867 | 00:34:48 INFO - PID 28867 | Cycle 1(1): loaded http://localhost:59288/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59288/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:34:49 INFO - PID 28867 | RSS: Main: 172752896 00:34:49 INFO - PID 28867 | 00:34:52 INFO - PID 28867 | Cycle 1(1): loaded http://localhost:59288/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59288/tests/kraken/driver.html?testName=imaging-darkroom) 00:34:53 INFO - PID 28867 | RSS: Main: 175280128 00:34:53 INFO - PID 28867 | 00:34:56 INFO - PID 28867 | Cycle 1(1): loaded http://localhost:59288/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59288/tests/kraken/driver.html?testName=imaging-desaturate) 00:34:57 INFO - PID 28867 | RSS: Main: 175341568 00:34:57 INFO - PID 28867 | 00:35:00 INFO - PID 28867 | Cycle 1(1): loaded http://localhost:59288/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59288/tests/kraken/driver.html?testName=json-parse-financial) 00:35:00 INFO - PID 28867 | RSS: Main: 175362048 00:35:00 INFO - PID 28867 | 00:35:02 INFO - PID 28867 | Cycle 1(1): loaded http://localhost:59288/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59288/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:35:03 INFO - PID 28867 | RSS: Main: 175464448 00:35:03 INFO - PID 28867 | 00:35:04 INFO - PID 28867 | Cycle 1(1): loaded http://localhost:59288/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59288/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:35:05 INFO - PID 28867 | RSS: Main: 175468544 00:35:05 INFO - PID 28867 | 00:35:07 INFO - PID 28867 | Cycle 1(1): loaded http://localhost:59288/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59288/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:35:08 INFO - PID 28867 | RSS: Main: 172326912 00:35:08 INFO - PID 28867 | 00:35:10 INFO - PID 28867 | Cycle 1(1): loaded http://localhost:59288/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:35:11 INFO - PID 28867 | RSS: Main: 173576192 00:35:11 INFO - PID 28867 | 00:35:14 INFO - PID 28867 | Cycle 1(1): loaded http://localhost:59288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:35:15 INFO - PID 28867 | RSS: Main: 172949504 00:35:15 INFO - PID 28867 | 00:35:17 INFO - PID 28867 | Cycle 1(1): loaded http://localhost:59288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59288/tests/kraken/driver.html?testName=ai-astar) 00:35:17 INFO - PID 28867 | RSS: Main: 174329856 00:35:17 INFO - PID 28867 | 00:35:17 INFO - PID 28867 | __start_tp_report 00:35:17 INFO - PID 28867 | _x_x_mozilla_page_load 00:35:17 INFO - PID 28867 | _x_x_mozilla_page_load_details 00:35:17 INFO - PID 28867 | |i|pagename|runs| 00:35:17 INFO - PID 28867 | |0;ai-astar;100;110;104;108;108;116;107;100;112;110 00:35:17 INFO - PID 28867 | |1;audio-beat-detection;162;123;151;160;118;153;149;119;165;121 00:35:17 INFO - PID 28867 | |2;audio-dft;164;162;164;163;164;163;166;165;177;161 00:35:17 INFO - PID 28867 | |3;audio-fft;75;74;73;171;75;75;75;87;96;75 00:35:17 INFO - PID 28867 | |4;audio-oscillator;78;79;135;80;79;80;129;80;79;123 00:35:17 INFO - PID 28867 | |5;imaging-gaussian-blur;114;114;115;114;113;114;114;114;114;114 00:35:17 INFO - PID 28867 | |6;imaging-darkroom;151;150;153;152;152;150;152;150;152;150 00:35:17 INFO - PID 28867 | |7;imaging-desaturate;95;94;95;94;94;94;95;94;94;94 00:35:17 INFO - PID 28867 | |8;json-parse-financial;58;56;64;64;56;56;55;56;55;56 00:35:17 INFO - PID 28867 | |9;json-stringify-tinderbox;54;55;54;54;54;54;54;55;57;54 00:35:17 INFO - PID 28867 | |10;stanford-crypto-aes;83;81;88;81;79;79;78;80;79;80 00:35:17 INFO - PID 28867 | |11;stanford-crypto-ccm;132;143;127;133;137;135;139;129;140;175 00:35:17 INFO - PID 28867 | |12;stanford-crypto-pbkdf2;186;191;184;186;202;180;193;182;185;181 00:35:17 INFO - PID 28867 | |13;stanford-crypto-sha256-iterative;67;69;66;72;68;69;66;67;66;66 00:35:17 INFO - PID 28867 | __end_tp_report 00:35:17 INFO - PID 28867 | __start_cc_report 00:35:17 INFO - PID 28867 | _x_x_mozilla_cycle_collect,952 00:35:17 INFO - PID 28867 | __end_cc_report 00:35:17 INFO - PID 28867 | __startTimestamp1501659317548__endTimestamp 00:35:17 INFO - PID 28867 | 00:35:17 INFO - PID 28867 | ------- Summary: start ------- 00:35:17 INFO - PID 28867 | Number of tests: 14 00:35:17 INFO - PID 28867 | 00:35:17 INFO - PID 28867 | [#0] ai-astar Cycles:10 Average:107.50 Median:109.00 stddev:5.06 (4.6%) stddev-sans-first:4.58 00:35:17 INFO - PID 28867 | Values: 100.0 110.0 104.0 108.0 108.0 116.0 107.0 100.0 112.0 110.0 00:35:17 INFO - PID 28867 | 00:35:17 INFO - PID 28867 | [#1] audio-beat-detection Cycles:10 Average:142.10 Median:152.00 stddev:19.47 (12.8%) stddev-sans-first:19.27 00:35:17 INFO - PID 28867 | Values: 162.0 123.0 151.0 160.0 118.0 153.0 149.0 119.0 165.0 121.0 00:35:17 INFO - PID 28867 | 00:35:17 INFO - PID 28867 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.00 stddev:4.48 (2.7%) stddev-sans-first:4.74 00:35:17 INFO - PID 28867 | Values: 164.0 162.0 164.0 163.0 164.0 163.0 166.0 165.0 177.0 161.0 00:35:17 INFO - PID 28867 | 00:35:17 INFO - PID 28867 | [#3] audio-fft Cycles:10 Average:87.60 Median:75.00 stddev:30.22 (40.3%) stddev-sans-first:31.71 00:35:17 INFO - PID 28867 | Values: 75.0 74.0 73.0 171.0 75.0 75.0 75.0 87.0 96.0 75.0 00:35:17 INFO - PID 28867 | 00:35:17 INFO - PID 28867 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:79.00 stddev:24.19 (30.6%) stddev-sans-first:24.93 00:35:17 INFO - PID 28867 | Values: 78.0 79.0 135.0 80.0 79.0 80.0 129.0 80.0 79.0 123.0 00:35:17 INFO - PID 28867 | 00:35:17 INFO - PID 28867 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 00:35:17 INFO - PID 28867 | Values: 114.0 114.0 115.0 114.0 113.0 114.0 114.0 114.0 114.0 114.0 00:35:17 INFO - PID 28867 | 00:35:17 INFO - PID 28867 | [#6] imaging-darkroom Cycles:10 Average:151.20 Median:152.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 00:35:17 INFO - PID 28867 | Values: 151.0 150.0 153.0 152.0 152.0 150.0 152.0 150.0 152.0 150.0 00:35:17 INFO - PID 28867 | 00:35:17 INFO - PID 28867 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 00:35:17 INFO - PID 28867 | Values: 95.0 94.0 95.0 94.0 94.0 94.0 95.0 94.0 94.0 94.0 00:35:17 INFO - PID 28867 | 00:35:17 INFO - PID 28867 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:56.00 stddev:3.47 (6.2%) stddev-sans-first:3.68 00:35:17 INFO - PID 28867 | Values: 58.0 56.0 64.0 64.0 56.0 56.0 55.0 56.0 55.0 56.0 00:35:17 INFO - PID 28867 | 00:35:17 INFO - PID 28867 | [#9] json-stringify-tinderbox Cycles:10 Average:54.50 Median:54.00 stddev:0.97 (1.8%) stddev-sans-first:1.01 00:35:17 INFO - PID 28867 | Values: 54.0 55.0 54.0 54.0 54.0 54.0 54.0 55.0 57.0 54.0 00:35:17 INFO - PID 28867 | 00:35:17 INFO - PID 28867 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.50 stddev:2.90 (3.6%) stddev-sans-first:2.96 00:35:17 INFO - PID 28867 | Values: 83.0 81.0 88.0 81.0 79.0 79.0 78.0 80.0 79.0 80.0 00:35:17 INFO - PID 28867 | 00:35:17 INFO - PID 28867 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:138.00 stddev:13.59 (9.8%) stddev-sans-first:14.18 00:35:17 INFO - PID 28867 | Values: 132.0 143.0 127.0 133.0 137.0 135.0 139.0 129.0 140.0 175.0 00:35:17 INFO - PID 28867 | 00:35:17 INFO - PID 28867 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.00 Median:186.00 stddev:6.68 (3.6%) stddev-sans-first:7.08 00:35:17 INFO - PID 28867 | Values: 186.0 191.0 184.0 186.0 202.0 180.0 193.0 182.0 185.0 181.0 00:35:17 INFO - PID 28867 | 00:35:17 INFO - PID 28867 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:1.96 (2.9%) stddev-sans-first:2.06 00:35:17 INFO - PID 28867 | Values: 67.0 69.0 66.0 72.0 68.0 69.0 66.0 67.0 66.0 66.0 00:35:17 INFO - PID 28867 | -------- Summary: end -------- 00:35:17 INFO - PID 28867 | 00:35:17 INFO - PID 28867 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 00:35:18 INFO - TEST-INFO | 28867: exit 0 00:35:18 INFO - TEST-OK | kraken | took 62144ms 00:35:18 INFO - SUITE-END | took 1174s 00:35:18 INFO - Completed test suite (00:19:35) 00:35:18 INFO - javascript benchmark 00:35:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8520.713956508373, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3105.5807465992093, 3137.2941088255147, 3140.3248301615135, 3170.8097514149167, 3215.742740580754, 6208.19293491846, 6236.438720515152, 6245.875082498347, 6289.559730818844, 6320.273168585614, 6070.908936365958, 6179.814605561829, 6201.565890387675, 6203.286622038467, 6255.249370075598, 5595.7481913313895, 5684.062129748587, 5752.108423194411, 5759.942400576004, 5815.82552523425, 5710.971445142768, 5764.51001664859, 5787.218725472049, 5810.535157187415, 5842.824715258549, 5443.401225865172, 5631.690257035862, 5631.887362252773, 5676.886462270772, 5768.0, 5642.181883626851, 5648.293963254593, 5713.457221563945, 5730.512906402961, 5733.369329373765, 5548.528375088123, 5594.300712410949, 5623.887522249573, 5700.401457846908, 5702.144678298247, 6029.306629737593, 6090.695465226765, 6108.053251745987, 6111.388861113897, 6188.814335569895, 6685.565438246498, 6688.83277918051, 6710.228323742784, 6720.227173875018, 6741.764038258686, 6652.866942661168, 6762.93237067628, 6776.186857577073, 6779.5593286436715, 6797.524173307821, 6179.443850053517, 6235.906461403038, 6298.149749783812, 6310.116583678288, 6327.936720632827, 6606.10817539626, 6684.899726504106, 6737.8652426951185, 6793.66031698423, 6872.759453419107, 6561.1470508833545, 6597.60414375139, 6599.802005939733, 6601.8349541260895, 6608.768693095719, 6589.703463344161, 6591.143151390384, 6592.307807680125, 6686.966565167143, 6700.597964122168, 6464.838379040468, 6591.670416479157, 6596.934030659632, 6652.268250492442, 6684.799456016327, 6625.635590042594, 6704.7988560343265, 6705.497087718343, 6705.966470167618, 6711.798646040626, 5400.351957765093, 5433.0, 5440.673559586358, 5471.781128754885, 5476.096444086681, 4535.931961020521, 4589.655775816827, 4645.86062418128, 4660.04469083837, 4676.158291507493, 5580.0, 5683.687397193112, 5770.567207459458, 5834.095715164156, 5857.355690874, 6665.833354166185, 6675.566088204251, 6677.165354330708, 6686.297938716365, 6690.397864192246, 5732.57005724564, 5751.712414379264, 5755.22304488897, 5763.596548241667, 5764.077747560454, 5676.801311954062, 5824.650520968671, 5827.3298570664065, 5830.3586605473365, 5835.299764028344, 6440.4847612190915, 6529.804105876831, 6530.836729081716, 6530.934690653127, 6535.346465353522, 6659.53383263167, 6683.699233534406, 6755.0, 6760.087388202628, 6781.254062053269, 6322.209723784527, 6408.647524386203, 6414.422701956846, 6422.9036564450635, 6513.413792758674, 6557.540972131905, 6579.17760279965, 6583.0, 6622.966885165543, 6626.105475760711, 6711.362420570038, 6721.260661327348, 6735.0, 6735.730570777114, 6738.09035780183, 6421.614703117828, 6499.1876015498065, 6509.641969691713, 6521.119648847345, 6531.314212007861, 6370.140031095742, 6429.903551446639, 6443.130177425987, 6465.967670161619, 6478.222613286436, 6318.8736225274315, 6326.810195693953, 6331.05034244867, 6340.714667839866, 6341.492680585634, 6374.0, 6432.742690292336, 6538.901916471162, 6568.376004279586, 6617.371349721769, 6174.9073763892675, 6285.402886725754, 6358.237011558643, 6370.108184854217, 6395.616263024233], "value": 6075.133923091433, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [859.70769938221, 860.8536548786707, 905.4838741917106, 908.3641450984312, 1161.2277835239565, 31802.36395272096, 32390.67609323906, 41738.0, 42264.36603450943, 42424.36363454543, 42693.14613707724, 43062.354064689054, 43081.784591077, 43134.13731725371, 43190.136197276035, 7615.543067415945, 7722.691092356299, 7728.26581474759, 7731.884021739678, 7748.2251774822635, 7660.502067365604, 7737.187595302496, 7888.171741967097, 7892.486988345768, 7900.762977110696, 7835.059792824841, 7862.528248305091, 7871.881921771178, 7885.0, 7887.723929662434, 7686.500377475446, 7830.647620857047, 7832.765017049469, 7836.098848632423, 7838.333741631968, 7720.15078341382, 7812.257835505675, 7816.257455541771, 7817.335526480256, 7824.256695613964, 39989.20021599581, 40080.0, 40103.79688609317, 40136.799316003235, 40287.7985610073, 3546.3793836078585, 3587.0494319005484, 3591.586967498719, 3591.6587924147425, 3593.317269718745, 31613.84193079043, 31942.20144496383, 31953.84023079893, 31992.0, 32116.839415802773, 4631.62946964242, 4787.784549695272, 4812.759362031919, 4878.243872199815, 4896.2410826321975, 184150.0, 185958.0, 186140.0, 186312.0, 186656.0, 50454.0, 50568.747156263984, 50589.0, 50807.49192508101, 50852.745736271085, 51966.0, 52221.0, 52380.0, 52472.21291680628, 52542.21186682203, 16268.674626507403, 16703.081330526693, 16723.163841807862, 16745.0, 16761.916190419215, 13611.0, 13719.382627781773, 13805.309734513436, 13816.101953372998, 13838.4464621414, 12924.935375323063, 13299.66750831237, 14243.21662308583, 14312.06971546846, 14444.205568693613, 5699.401562835926, 5751.1085781703905, 5806.767729290866, 5880.558958078162, 5881.558883083786, 962.605331813953, 987.6641941739699, 1005.3766664667953, 1013.3463915774431, 1021.4841505040056, 22120.88939555292, 22157.026827467387, 22870.542589148456, 23291.0, 23373.649395259086, 1092.2354351953663, 1100.8183649697871, 1127.1264769803468, 1131.1290306463977, 1135.8864113588575, 11527.365994870195, 12189.085818563643, 12198.634040978784, 12231.204971676812, 12376.257424554555, 214062.0, 215562.0, 215776.0, 216181.0, 216348.0, 53739.73130134402, 53886.46113538814, 54046.45953540493, 54244.72877635666, 54268.45731542713, 1438.978415323771, 1465.5749832548443, 1475.8524147585156, 1479.0386248938062, 1507.864292213706, 22009.0, 22598.209062683385, 22702.0, 23142.768572314733, 23169.189078382176, 37407.251854963295, 37661.246775064894, 37731.62268377281, 37737.245255095295, 37772.0, 192138.0, 192854.0, 193200.0, 193952.0, 193994.0, 30734.0, 31335.0, 33981.320373592884, 34253.65746342605, 34479.0, 42743.3588496179, 45288.77355613201, 45729.08541829211, 45818.312725309814, 46237.0, 30830.383392332475, 32293.677063229068, 35648.0, 35946.0, 36021.45967810432, 34809.30381392409, 34868.0, 34978.0, 35523.82238088897, 35814.28371432609, 41297.587024129374, 41298.58701412947, 41316.79341603273, 41323.1735365297, 41678.37482437705, 41930.580694192664, 42874.78562607167, 43395.56604433915, 43588.51291896704, 43928.0, 25380.11169609055, 25623.462592244527, 25723.099691511456, 26703.19890403291, 26828.195154145407], "value": 17568.546609854053, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.9164921086442, 582.6591444005256, 589.3929252869543, 594.7947957954505, 596.4870211618007, 21710.782892171075, 22086.779132208674, 22718.318450446513, 22797.0, 22808.771912280874, 24069.759302406972, 24526.0, 24545.018199272006, 24606.507869842637, 24611.507769844593, 6473.579217350869, 6547.410733034026, 6596.835079123012, 6634.767783127591, 6639.5684280521855, 5979.701014949257, 6460.547761656662, 6548.6725663716625, 6549.836254093638, 6552.279249282575, 6491.740330386802, 6494.447971922368, 6501.252355979052, 6507.251666058417, 6514.21829380475, 6480.611163330215, 6484.0, 6498.480121590262, 6499.675016249193, 6503.089567460559, 6045.78839740607, 6060.575759696823, 6061.757529698807, 6064.02975523914, 6080.756769729205, 27153.728462715317, 28495.430091398055, 29145.271368215752, 29670.406591868043, 29895.40209195804, 1874.7281644161656, 1903.1816318982833, 1905.5236190952262, 1924.3649595633547, 1925.9903700481548, 18574.535636609056, 18937.715934260996, 19123.948182849937, 19129.2348306069, 20078.799212007983, 2500.9374765630823, 2564.051301018635, 2569.1650213680628, 2572.8199026068182, 2579.9613005804927, 139923.0, 141203.0, 142527.0, 142808.28595856956, 146033.0, 21279.78720212809, 22124.02209502849, 22460.0, 22509.247225832183, 22932.541349172923, 44754.55245447504, 44784.77607611941, 44810.10379792386, 44845.103097937856, 44855.327170092474, 11839.348835814113, 12035.879641203652, 12193.939030304791, 12212.816807747891, 12384.690382740504, 8055.637496312563, 8413.368997325226, 10139.594416223415, 10195.949020255, 10614.681559553072, 10603.469826508644, 11321.264117832314, 11466.770664586662, 11768.646940591796, 11886.405679716152, 4028.9194216115516, 4140.23405669946, 4205.663546916239, 4378.5183629800695, 4397.252467080604, 917.4311926605548, 943.5376665433888, 951.1392190068, 969.3472629167253, 969.4038166527534, 19870.304539341054, 20036.89981550112, 20063.39809805708, 20460.283890063776, 20485.180592776123, 979.5396163803001, 1011.6863772230632, 1017.6183931025865, 1040.354979912444, 1041.245097304448, 10127.392356458637, 10335.74160645975, 10395.792084158275, 10428.374297542172, 10945.109944616377, 513245.0, 513454.0, 523758.0, 525042.0, 526023.0, 124286.0, 126952.36523817507, 128105.0, 129581.0, 129639.35180324227, 1233.660743295583, 1249.4689756853302, 1280.302235281755, 1282.7049778550986, 1283.3775618824861, 19534.0, 20261.6960745586, 20657.0, 20860.269890553758, 21224.681629775874, 59889.700551496964, 60047.39952600593, 60321.0, 61322.386776131665, 63057.68471157615, 74246.62876685582, 78977.0, 79098.20901790909, 79212.20787792279, 80835.0, 16121.435749748702, 16996.0, 19751.80248197557, 20163.495912601717, 20436.38690839277, 22613.321600352017, 22841.657375139053, 23199.88400057989, 23331.300060998197, 23589.174378896656, 17974.82025179784, 18108.547286317946, 18335.358262461283, 18354.082295884884, 18620.720689189402, 14972.326245319206, 15180.620484487534, 15397.538073857802, 16409.58976025609, 16728.916355418143, 18280.177392017657, 18524.629507409507, 18602.44192674222, 18687.813121868607, 18790.812091878906, 19884.801151988875, 20001.0, 20023.29918452847, 20030.699539506626, 20040.89979550093, 17922.462326130237, 18005.2797888083, 18256.81743182551, 18282.542936426165, 18287.359942402483], "value": 12933.76075236758, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1322.272749987507, 1369.986300136999, 1400.8879289656822, 1402.6212922510929, 1402.9298535073244, 13649.31753412329, 13962.092463989859, 14285.285735713225, 14300.928495357508, 14342.641433964143, 14294.71410571788, 14511.0, 14545.563633091024, 14555.053921495122, 14570.635734106652, 2639.3269716222335, 2663.2942270298386, 2671.19864040787, 2680.155750938458, 2692.165428717094, 2581.3288544978345, 2730.931726706828, 2745.8764355604044, 2746.436980419019, 2753.4217814258927, 2668.519666460036, 2698.7031426543062, 2712.905048323309, 2714.362124900647, 2716.891324347024, 2651.376926422289, 2656.296081538394, 2685.476332115238, 2693.878775455109, 2710.5256580098403, 2608.113241497881, 2619.4368210834573, 2650.575907854734, 2664.3605534671733, 2673.0911490093463, 13803.102798318178, 13896.096753710977, 13904.304784760721, 13930.164190148522, 13930.93034534831, 7512.812179695551, 7741.800020996755, 7759.65081571325, 7768.184340644208, 7773.766786996399, 4889.0, 5036.456589422355, 5146.768395422215, 5172.431032586413, 5192.9740351298005, 1552.5652817211087, 1580.2888700085007, 1620.5786495511134, 1629.226117594145, 1641.7455294429383, 21886.0, 22415.43961400978, 22467.662985055238, 22469.55060898789, 22482.887585561966, 6617.602943823386, 6639.2406012406755, 6730.158730158731, 6939.861202775916, 7001.964990175016, 14664.193469359288, 15380.692386152214, 15484.148371839658, 15572.221388930508, 17333.47999560015, 7500.549967001997, 7714.112877019103, 7720.189380115119, 7727.072751269883, 7730.961345193238, 6918.273581273995, 7044.577325360495, 7062.470314726416, 7171.92828071723, 7220.241874603091, 5180.81867134656, 5291.603129765283, 5298.602604804655, 5306.52241298285, 5359.3032905722, 1534.2252162657787, 1534.6853894951507, 1534.8541888520572, 1542.8688561472177, 1549.2408719727478, 811.7077851973285, 816.8447994880953, 821.3142026407896, 846.5301757524633, 871.4074429388077, 6613.173353330833, 6741.696623651947, 6826.829329266709, 6864.176298844171, 6913.446924246048, 695.5305169010898, 711.6441779110445, 729.3399473476512, 730.3828265115968, 736.6721808795035, 4357.281048627005, 4419.779011049434, 4474.351219073216, 4479.753613551221, 4610.354550362952, 17861.821381786274, 18957.336493222672, 19000.52498687544, 19026.238950442104, 19042.523936901413, 18293.7255941161, 18439.0, 19209.80790192108, 19316.0, 19356.61286774285, 10081.899181008095, 10540.0, 10646.574137034588, 10683.771366292976, 10746.24776265654, 7201.207867134715, 7504.887426688495, 7686.192949740421, 7718.57547834852, 7804.492707973964, 15970.520884373487, 16341.264643090852, 16431.096289704183, 16617.50147495577, 16931.57671058184, 15967.44113956006, 16470.75293870617, 16723.0, 16973.23620437108, 17644.117794109985, 12765.553205637758, 13025.674358141123, 13031.739365212832, 13041.673958151123, 13086.476540938636, 13149.408276627384, 13266.33668316561, 13328.533501327407, 13537.1200871943, 13665.658358541115, 10831.67504974852, 10834.187435942493, 10840.241183117421, 10985.890141098487, 11212.775744485229, 9883.456409897237, 10373.481325933824, 10408.063274305348, 10451.268411211142, 10531.89468105309, 8675.34934879874, 8798.824023519623, 8799.12008799115, 8806.383553151474, 8809.867851982353, 6106.297775755845, 6385.169927909342, 6500.479961603155, 6543.083968244355, 6543.803685889431, 6325.399087086719, 6584.144061272004, 6644.468442524683, 6773.491988101011, 6837.145356830396], "value": 6220.736892919025, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [488.3981498328912, 500.34068923670696, 514.6397521734787, 519.2082074835876, 521.0828941063729, 6208.1752802474875, 6243.157173781538, 6254.842079482582, 6254.968725156368, 6290.465310448606, 5903.557233207505, 5996.453280715343, 6046.7883624073165, 6052.6368417894955, 6072.8481787955325, 4821.601735496711, 4916.237983112624, 4918.827841025565, 4927.310176575283, 4931.7040977541465, 4796.25658023007, 4890.584300334476, 4948.653594248404, 4950.504949505057, 4955.578775804061, 4862.07620552094, 4898.265260210961, 4905.239687848371, 4919.606431485473, 4941.728204948727, 4857.878553036167, 4904.190808516591, 4906.337644418011, 4912.771807048202, 4925.679830811004, 4434.49003364614, 4444.288913773813, 4467.128909862578, 4478.350639157304, 4495.955040449587, 6078.355915176868, 6105.389461053859, 6108.908366374508, 6125.418085281891, 6128.63228206309, 5585.357683866367, 5623.063855301305, 5708.343540492855, 5727.684977326246, 5731.0, 6395.392437718409, 6463.192100987377, 6499.707513161872, 6501.642409667466, 6502.349765023459, 4784.976075119637, 4817.253325734517, 4818.855434336941, 4878.804847806084, 4881.0, 6702.463802895757, 6773.559718618274, 6794.76218332356, 6911.3779759821855, 6948.861022779567, 4829.806807727651, 4841.273808928689, 4889.633277504201, 4904.509549045139, 4910.410750709866, 4938.333325001079, 4986.426560945465, 4991.850244492671, 4999.3000979862845, 5007.549320561167, 5588.189712491747, 5629.8205650801365, 5635.520980716603, 5644.193857965493, 5659.886802263932, 6411.935880641134, 6499.375156210947, 6524.739010439529, 6530.8367290818105, 6572.835679107965, 1636.533587927435, 1695.1608953568063, 1708.7180615198602, 1721.5265801904577, 1743.4595275464646, 1186.211169572225, 1194.325206258461, 1219.6766508338553, 1221.5175005872632, 1236.1964722930168, 5657.51911087554, 5674.546036317085, 5719.4852463277675, 5735.913961290584, 5806.854828629233, 6361.427471527585, 6548.345165483413, 6638.402543771083, 6684.532082754258, 6693.698783554752, 5748.798792042258, 5759.712014399263, 5779.797707080232, 5804.477597016289, 5815.156802263648, 3517.402041652925, 3525.7884526928465, 3534.593521744981, 3541.610422853484, 3570.0360902556686, 6443.48452123829, 6485.902711459332, 6488.708008139645, 6489.707963141575, 6490.902636460457, 6777.0, 6783.626900520519, 6791.524593278522, 6824.590524568542, 6925.58446493202, 6333.8733225336155, 6372.681365931592, 6406.423421892052, 6423.430627748938, 6458.580192287486, 6518.0, 6576.473882089325, 6617.43751781104, 6648.9002664961035, 6677.76627818024, 6381.808545743449, 6490.935090649033, 6655.267920528641, 6680.198376194888, 6708.0, 6513.283538810632, 6546.312637173219, 6555.147830781968, 6563.704633291609, 6572.474202063728, 4906.0, 4925.285833554043, 4935.259711043373, 4939.6542242042715, 4964.35463389757, 6491.870162596627, 6678.495564163439, 6716.429103526255, 6756.662166891538, 6780.762673306411, 6157.445829875153, 6362.427381535684, 6444.9033264502, 6476.0, 6487.545871789118, 6265.592736472115, 6473.579217350857, 6496.74013039492, 6524.869502609827, 6561.212654481493, 6404.807855764335, 6425.8714825704155, 6431.5529005973285, 6454.451371633464, 6475.0, 6478.1578394808375, 6493.59736897351, 6524.380183882524, 6602.8679426410245, 6606.43845273138, 6307.432331090224, 6319.210098737658, 6408.198975128109, 6410.391012853772, 6420.550561460653], "value": 5006.673276882667, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [906.0984320601007, 922.4511415707653, 936.6862101196099, 937.4937533731785, 949.1599934058358, 18093.547661308476, 18810.62378752424, 18845.71731424028, 18900.243990240408, 20869.582608347824, 20348.0, 21030.789692103073, 21171.364859054254, 21340.57318853622, 21353.35939921801, 1005.6128390569628, 1051.0908064524208, 1054.4991129213602, 1055.9260851740382, 1056.0337291378419, 1002.9899701003006, 1046.4558429616595, 1059.9576016959352, 1061.0768631290787, 1061.3101484035362, 1073.0503504398625, 1080.4975686305866, 1081.0810810810788, 1081.6052140968568, 1081.6754973507955, 1068.2041878800344, 1071.0307172009343, 1073.7798751256014, 1073.940933248671, 1076.7900259449411, 782.4170992610485, 787.8424315136996, 788.3062904643934, 789.0570767932323, 789.135896193667, 17777.555561110945, 17891.1948962297, 17983.280668773234, 18024.00867952262, 19573.412797616093, 18361.173747181274, 18832.905835470734, 19109.0, 19151.23395064196, 19238.03809809504, 15530.61173470661, 15749.291281892343, 15922.044677319398, 15948.681026379523, 15995.440159594475, 3425.4348032574594, 3442.4147894857933, 3447.9310413791836, 3454.0156055524308, 3467.6358982306747, 120857.39571302175, 122824.0, 123439.0, 126413.0, 126538.36730816287, 15406.845931540765, 15493.0, 15688.215589220494, 15751.0, 15761.842381576267, 29408.558871616944, 29418.264543386158, 29441.55837662437, 29467.231966082105, 29644.555331670043, 7328.633568321563, 8081.878771818428, 8215.876761848576, 8577.0, 8969.775755606031, 3988.720789544704, 4159.771212583337, 4160.750354978711, 4166.041810383568, 4166.8749937501925, 5056.292119103328, 5078.13671675816, 5126.282320475137, 5195.272661827347, 5207.114790485626, 1015.8069966706303, 1039.719275795546, 1059.777446736194, 1062.8405739139191, 1064.5741703318579, 644.1207751419372, 667.4060086522999, 693.7987983484733, 694.9861002779916, 702.28016283309, 10120.240981926385, 13295.93352033253, 13394.0, 13722.794158087636, 13739.519116830863, 676.5703778100941, 683.7846078485261, 695.5305169010898, 706.9823254418578, 709.8189961559873, 5221.164613661796, 5234.398044224963, 5430.83707488776, 5508.889822203613, 5714.2571465710025, 95977.5201124004, 98406.0, 99409.50295248478, 100947.0, 101358.0, 84606.0, 86888.0, 89295.55352223197, 93523.0, 95002.0, 79531.0, 82165.58917205376, 83250.0, 83354.16645833464, 83698.58150709329, 11786.351750653796, 11851.229670071418, 12093.637190884288, 12141.575044873387, 12340.165825630062, 34321.31357372888, 34685.82657086799, 34996.12509687278, 35471.46792798162, 37794.0, 41547.79226103971, 43304.0, 44140.77929610331, 45029.0, 66815.66592167203, 18789.34237301688, 18881.71677424812, 19348.70976935319, 19357.322493712654, 19719.60560788805, 19745.308914187935, 20110.39668809938, 20204.59590808146, 20897.791022089583, 20961.89519052395, 17574.297028119243, 17737.113144342988, 18054.729179062586, 18234.72647910256, 18625.53436164107, 17498.650026999643, 17589.472315830546, 17987.83079099854, 18650.253989840254, 18896.52758680989, 17630.206640700944, 17732.822671773116, 18007.09964501796, 18135.727964080284, 18385.0, 12400.75198496043, 12698.30159341245, 13053.28206948627, 13496.190228586316, 13713.725725485236, 13366.465341386236, 13565.796513052115, 13599.796003059764, 13735.24456154881, 13764.242966636932], "value": 8900.59425643731, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 104.0, 108.0, 108.0, 116.0, 107.0, 100.0, 112.0, 110.0], "value": 107.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 123.0, 151.0, 160.0, 118.0, 153.0, 149.0, 119.0, 165.0, 121.0], "value": 142.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 164.0, 163.0, 164.0, 163.0, 166.0, 165.0, 177.0, 161.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 73.0, 171.0, 75.0, 75.0, 75.0, 87.0, 96.0, 75.0], "value": 87.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 135.0, 80.0, 79.0, 80.0, 129.0, 80.0, 79.0, 123.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 153.0, 152.0, 152.0, 150.0, 152.0, 150.0, 152.0, 150.0], "value": 151.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 64.0, 64.0, 56.0, 56.0, 55.0, 56.0, 55.0, 56.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 54.0, 54.0, 54.0, 54.0, 55.0, 57.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 88.0, 81.0, 79.0, 79.0, 78.0, 80.0, 79.0, 80.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 143.0, 127.0, 133.0, 137.0, 135.0, 139.0, 129.0, 140.0, 175.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 191.0, 184.0, 186.0, 202.0, 180.0, 193.0, 182.0, 185.0, 181.0], "value": 187.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 66.0, 72.0, 68.0, 69.0, 66.0, 67.0, 66.0, 66.0], "value": 67.6, "unit": "score"}]}]} 00:35:18 INFO - Return code: 0 00:35:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:35:18 INFO - # TBPL SUCCESS # 00:35:18 INFO - Running post-action listener: _package_coverage_data 00:35:18 INFO - Running post-action listener: _resource_record_post_action 00:35:18 INFO - [mozharness: 2017-08-02 07:35:18.830037Z] Finished run-tests step (success) 00:35:18 INFO - Running post-run listener: _resource_record_post_run 00:35:18 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 20480; Write bytes: 430456832; Read time: 520; Write time: 305720 00:35:18 INFO - TinderboxPrint: CPU usage
13.1% 00:35:18 INFO - TinderboxPrint: I/O read bytes / time
20,480 / 520 00:35:18 INFO - TinderboxPrint: I/O write bytes / time
430,456,832 / 305,720 00:35:18 INFO - TinderboxPrint: CPU idle
8,269.9 (86.9%) 00:35:18 INFO - TinderboxPrint: CPU user
1,202.3 (12.6%) 00:35:18 INFO - TinderboxPrint: Swap in / out
0 / 0 00:35:18 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 107528192; Read time: 172; Write time: 87636 00:35:18 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 00:35:18 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 12288; Write bytes: 322928640; Read time: 312; Write time: 218084 00:35:19 INFO - Running post-run listener: _upload_blobber_files 00:35:19 INFO - Blob upload gear active. 00:35:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:35:19 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 00:35:19 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:35:19 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:35:19 INFO - (blobuploader) - INFO - Open directory for files ... 00:35:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:35:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:35:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:35:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:35:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:35:26 INFO - (blobuploader) - INFO - Done attempting. 00:35:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:35:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:35:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:35:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:35:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:35:27 INFO - (blobuploader) - INFO - Done attempting. 00:35:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 00:35:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:35:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:35:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 00:35:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:35:28 INFO - (blobuploader) - INFO - Done attempting. 00:35:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:35:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:35:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:35:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:35:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:35:29 INFO - (blobuploader) - INFO - Done attempting. 00:35:29 INFO - (blobuploader) - INFO - Iteration through files over. 00:35:29 INFO - Return code: 0 00:35:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:35:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:35:29 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/773c02882a5e709114063f1c2fc34dceb01493bc50a76d51f00792236c1c7d16670321381320dc2786550452410bee9d172a06ee61c8deb83c775392a82eb7d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/68aecfbcd867d88a7573337638bcc00f42aec8898ce2c77dc22c83ef6439228896534c0fafcaeb3b490f5935f3e790797cc7b42368e82e46b2470b371c18c868", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cb6d51f763089e72a9194d15512fc6338890da4b9398ca29a44ef7560c29cfde42c22cc25c8761f27a1baa240462cefd0fe478e1552494f901f2d9c3fa0160d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ac3fe9cdd438f0aefe188db063e7544548a1011cfbe745e8d0b08f1c52c8707d0538553c5862db320aae89e4d3443f2ff59b8bbe8f4e94b614ae69c36420058"} 00:35:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:35:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:35:29 INFO - Contents: 00:35:29 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/773c02882a5e709114063f1c2fc34dceb01493bc50a76d51f00792236c1c7d16670321381320dc2786550452410bee9d172a06ee61c8deb83c775392a82eb7d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/68aecfbcd867d88a7573337638bcc00f42aec8898ce2c77dc22c83ef6439228896534c0fafcaeb3b490f5935f3e790797cc7b42368e82e46b2470b371c18c868", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cb6d51f763089e72a9194d15512fc6338890da4b9398ca29a44ef7560c29cfde42c22cc25c8761f27a1baa240462cefd0fe478e1552494f901f2d9c3fa0160d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ac3fe9cdd438f0aefe188db063e7544548a1011cfbe745e8d0b08f1c52c8707d0538553c5862db320aae89e4d3443f2ff59b8bbe8f4e94b614ae69c36420058"} 00:35:29 INFO - Running post-run listener: copy_logs_to_upload_dir 00:35:29 INFO - Copying logs to upload dir... 00:35:29 INFO - mkdir: /builds/slave/test/build/upload/logs 00:35:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.244602 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-02 00:35:28.660469) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-02 00:35:28.666745) ========= 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=232498196343f89f466a4a9a000001c8-1501645543.95757-237912307 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-Non-PGO/sha512/773c02882a5e709114063f1c2fc34dceb01493bc50a76d51f00792236c1c7d16670321381320dc2786550452410bee9d172a06ee61c8deb83c775392a82eb7d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/68aecfbcd867d88a7573337638bcc00f42aec8898ce2c77dc22c83ef6439228896534c0fafcaeb3b490f5935f3e790797cc7b42368e82e46b2470b371c18c868", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cb6d51f763089e72a9194d15512fc6338890da4b9398ca29a44ef7560c29cfde42c22cc25c8761f27a1baa240462cefd0fe478e1552494f901f2d9c3fa0160d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ac3fe9cdd438f0aefe188db063e7544548a1011cfbe745e8d0b08f1c52c8707d0538553c5862db320aae89e4d3443f2ff59b8bbe8f4e94b614ae69c36420058"} build_url:https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011269 build_url: 'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/773c02882a5e709114063f1c2fc34dceb01493bc50a76d51f00792236c1c7d16670321381320dc2786550452410bee9d172a06ee61c8deb83c775392a82eb7d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/68aecfbcd867d88a7573337638bcc00f42aec8898ce2c77dc22c83ef6439228896534c0fafcaeb3b490f5935f3e790797cc7b42368e82e46b2470b371c18c868", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cb6d51f763089e72a9194d15512fc6338890da4b9398ca29a44ef7560c29cfde42c22cc25c8761f27a1baa240462cefd0fe478e1552494f901f2d9c3fa0160d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ac3fe9cdd438f0aefe188db063e7544548a1011cfbe745e8d0b08f1c52c8707d0538553c5862db320aae89e4d3443f2ff59b8bbe8f4e94b614ae69c36420058"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-02 00:35:28.701384) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 00:35:28.701723) ========= 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=232498196343f89f466a4a9a000001c8-1501645543.95757-237912307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 00:35:28.756028) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-02 00:35:28.756377) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-02 00:35:28.756661) ========= ========= Total master_lag: 0.23 =========