builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-028 starttime: 1505382735.11 results: success (0) revision: dd6b788f149763c4014c27f2fe1a1d13228bda82 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:15.110034) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:15.110551) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:15.113211) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:15.544972) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:15.545440) ========= 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=836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-14 02:52:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-09-14 02:52:15 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092676 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:15.743951) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:15.744269) ========= 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=836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019317 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:15.804433) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:15.804764) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dd6b788f149763c4014c27f2fe1a1d13228bda82 --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 dd6b788f149763c4014c27f2fe1a1d13228bda82 --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=836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-14 02:52:16,014 truncating revision to first 12 chars 2017-09-14 02:52:16,014 Setting DEBUG logging. 2017-09-14 02:52:16,014 attempt 1/10 2017-09-14 02:52:16,014 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dd6b788f1497?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-14 02:52:16,252 unpacking tar archive at: mozilla-central-dd6b788f1497/testing/mozharness/ program finished with exit code 0 elapsedTime=0.555085 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:16.399467) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:16.399739) ========= script_repo_revision: dd6b788f149763c4014c27f2fe1a1d13228bda82 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:16.405140) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:16.405412) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:16.422426) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-14 02:52:16.422698) ========= /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=836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:52:16 INFO - MultiFileLogger online at 20170914 02:52:16 in /builds/slave/test 02:52:16 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 02:52:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:52:16 INFO - {'append_to_log': False, 02:52:16 INFO - 'base_work_dir': '/builds/slave/test', 02:52:16 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:52:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:52:16 INFO - 'branch': 'Firefox-Non-PGO', 02:52:16 INFO - 'buildbot_json_path': 'buildprops.json', 02:52:16 INFO - 'code_coverage': False, 02:52:16 INFO - 'config_files': ('talos/linux_config.py',), 02:52:16 INFO - 'default_actions': ('clobber', 02:52:16 INFO - 'read-buildbot-config', 02:52:16 INFO - 'download-and-extract', 02:52:16 INFO - 'populate-webroot', 02:52:16 INFO - 'create-virtualenv', 02:52:16 INFO - 'install', 02:52:16 INFO - 'setup-mitmproxy', 02:52:16 INFO - 'run-tests'), 02:52:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:52:16 INFO - 'disable_ccov_upload': False, 02:52:16 INFO - 'disable_stylo': False, 02:52:16 INFO - 'download_minidump_stackwalk': True, 02:52:16 INFO - 'download_symbols': 'ondemand', 02:52:16 INFO - 'enable_stylo': False, 02:52:16 INFO - 'enable_webrender': False, 02:52:16 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:52:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:52:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:52:16 INFO - 'gecko_profile': False, 02:52:16 INFO - 'gecko_profile_interval': 0, 02:52:16 INFO - 'installer_path': 'installer.exe', 02:52:16 INFO - 'log_level': 'info', 02:52:16 INFO - 'log_name': 'talos', 02:52:16 INFO - 'log_to_console': True, 02:52:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:52:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:52:16 INFO - 'opt_config_files': (), 02:52:16 INFO - 'pip_index': False, 02:52:16 INFO - 'suite': 'dromaeojs-e10s', 02:52:16 INFO - 'system_bits': '32', 02:52:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:52:16 INFO - 'title': 'talos-linux64-ix-028', 02:52:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:52:16 INFO - 'use_talos_json': True, 02:52:16 INFO - 'verify': 'False', 02:52:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:52:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:52:16 INFO - 'work_dir': 'build'} 02:52:16 INFO - [mozharness: 2017-09-14 09:52:16.757875Z] Running clobber step. 02:52:16 INFO - Running pre-action listener: _resource_record_pre_action 02:52:16 INFO - Running main action method: clobber 02:52:16 INFO - rmtree: /builds/slave/test/build 02:52:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:52:17 INFO - Running post-action listener: _resource_record_post_action 02:52:17 INFO - [mozharness: 2017-09-14 09:52:17.765577Z] Finished clobber step (success) 02:52:17 INFO - [mozharness: 2017-09-14 09:52:17.765674Z] Running read-buildbot-config step. 02:52:17 INFO - Running pre-action listener: _resource_record_pre_action 02:52:17 INFO - Running main action method: read_buildbot_config 02:52:17 INFO - Using buildbot properties: 02:52:17 INFO - { 02:52:17 INFO - "project": "", 02:52:17 INFO - "product": "firefox", 02:52:17 INFO - "who": "archaeopteryx@coole-files.de", 02:52:17 INFO - "installer_path": "public/build/target.tar.bz2", 02:52:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 02:52:17 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:52:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 02:52:17 INFO - "stage_platform": "linux64", 02:52:17 INFO - "basedir": "/builds/slave/test", 02:52:17 INFO - "buildnumber": 824, 02:52:17 INFO - "platform": "ubuntu64_hw", 02:52:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:52:17 INFO - "slavebuilddir": "test", 02:52:17 INFO - "taskId": "EaVwkTQPTomD1ClCUBw9zA", 02:52:17 INFO - "branch": "mozilla-central", 02:52:17 INFO - "script_repo_revision": "production", 02:52:17 INFO - "revision": "dd6b788f149763c4014c27f2fe1a1d13228bda82", 02:52:17 INFO - "slavename": "talos-linux64-ix-028", 02:52:17 INFO - "repo_path": "mozilla-central" 02:52:17 INFO - } 02:52:17 INFO - Finding installer, test and symbols from parent task. 02:52:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EaVwkTQPTomD1ClCUBw9zA'}, attempt #1 02:52:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EaVwkTQPTomD1ClCUBw9zA'}, attempt #1 02:52:18 INFO - Task dependencies: GD7UpAmZSbaM79RoUDeOdw 02:52:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw'}, attempt #1 02:52:19 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.tar.bz2 02:52:19 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.test_packages.json 02:52:19 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.crashreporter-symbols.zip 02:52:19 INFO - Running post-action listener: _resource_record_post_action 02:52:19 INFO - [mozharness: 2017-09-14 09:52:19.189939Z] Finished read-buildbot-config step (success) 02:52:19 INFO - [mozharness: 2017-09-14 09:52:19.190155Z] Running download-and-extract step. 02:52:19 INFO - Running pre-action listener: _resource_record_pre_action 02:52:19 INFO - Running main action method: download_and_extract 02:52:19 INFO - mkdir: /builds/slave/test/build/tests 02:52:19 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')]} 02:52:19 INFO - trying https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.test_packages.json 02:52:19 INFO - Downloading https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:52:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:52:19 INFO - Downloaded 989 bytes. 02:52:19 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:52:19 INFO - Using the following test package requirements: 02:52:19 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:52:19 INFO - u'common': [u'target.common.tests.zip'], 02:52:19 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:52:19 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:52:19 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:52:19 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:52:19 INFO - u'mozbase': [u'target.common.tests.zip'], 02:52:19 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:52:19 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:52:19 INFO - u'web-platform': [u'target.common.tests.zip', 02:52:19 INFO - u'target.web-platform.tests.tar.gz'], 02:52:19 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:52:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 02:52:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.common.tests.zip 02:52:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:52:19 INFO - Fetch https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.common.tests.zip into memory 02:52:21 INFO - Content-Length response header: 54593713 02:52:21 INFO - Bytes received: 54593713 02:52:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.talos.tests.zip 02:52:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:52:32 INFO - Fetch https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.talos.tests.zip into memory 02:52:33 INFO - Content-Length response header: 14500356 02:52:33 INFO - Bytes received: 14500356 02:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:34 INFO - trying https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.tar.bz2 02:52:34 INFO - Downloading https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:52:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:52:37 INFO - Downloaded 61364985 bytes. 02:52:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.tar.bz2 02:52:38 INFO - mkdir: /builds/slave/test/properties 02:52:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:52:38 INFO - Writing to file /builds/slave/test/properties/build_url 02:52:38 INFO - Contents: 02:52:38 INFO - build_url:https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.tar.bz2 02:52:38 INFO - Running post-action listener: _resource_record_post_action 02:52:38 INFO - Running post-action listener: find_tests_for_verification 02:52:38 INFO - Running post-action listener: set_extra_try_arguments 02:52:38 INFO - [mozharness: 2017-09-14 09:52:38.061962Z] Finished download-and-extract step (success) 02:52:38 INFO - [mozharness: 2017-09-14 09:52:38.062194Z] Running populate-webroot step. 02:52:38 INFO - Running pre-action listener: _resource_record_pre_action 02:52:38 INFO - Running main action method: populate_webroot 02:52:38 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:52:38 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:52:38 INFO - 'tests': ['tresize', 02:52:38 INFO - 'tcanvasmark']}, 02:52:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:52:38 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:52:38 INFO - 'tests': ['dromaeo_css', 02:52:38 INFO - 'kraken']}, 02:52:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:52:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:52:38 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:52:38 INFO - 'talos_options': ['--disable-stylo'], 02:52:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:52:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:52:38 INFO - 'tests': ['damp', 'tps']}, 02:52:38 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:52:38 INFO - 'talos_options': ['--disable-stylo'], 02:52:38 INFO - 'tests': ['damp', 'tps']}, 02:52:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:52:38 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:52:38 INFO - 'tests': ['dromaeo_dom']}, 02:52:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:52:38 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:52:38 INFO - 'tests': ['basic_compositor_video', 02:52:38 INFO - 'glvideo']}, 02:52:38 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:52:38 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:52:38 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:52:38 INFO - 'talos_options': ['--disable-stylo'], 02:52:38 INFO - 'tests': ['ts_paint_webext', 02:52:38 INFO - 'tp5o_webext']}, 02:52:38 INFO - 'other-e10s': {'tests': ['a11yr', 02:52:38 INFO - 'ts_paint', 02:52:38 INFO - 'tpaint', 02:52:38 INFO - 'sessionrestore', 02:52:38 INFO - 'sessionrestore_many_windows', 02:52:38 INFO - 'sessionrestore_no_auto_restore', 02:52:38 INFO - 'tabpaint']}, 02:52:38 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:52:38 INFO - 'tests': ['a11yr', 02:52:38 INFO - 'ts_paint', 02:52:38 INFO - 'tpaint', 02:52:38 INFO - 'sessionrestore', 02:52:38 INFO - 'sessionrestore_many_windows', 02:52:38 INFO - 'sessionrestore_no_auto_restore', 02:52:38 INFO - 'tabpaint']}, 02:52:38 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:52:38 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:52:38 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:52:38 INFO - 'tests': ['bloom_basic_singleton']}, 02:52:38 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:52:38 INFO - 'tests': ['bloom_basic']}, 02:52:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:52:38 INFO - 'tsvgr_opacity', 02:52:38 INFO - 'tart', 02:52:38 INFO - 'tscrollx', 02:52:38 INFO - 'tsvg_static']}, 02:52:38 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:52:38 INFO - 'tests': ['tsvgx', 02:52:38 INFO - 'tsvgr_opacity', 02:52:38 INFO - 'tart', 02:52:38 INFO - 'tscrollx', 02:52:38 INFO - 'tsvg_static']}, 02:52:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:52:38 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:52:38 INFO - 'talos_options': ['--disable-stylo'], 02:52:38 INFO - 'tests': ['tp5o']}, 02:52:38 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:52:38 INFO - 'talos_options': ['--mitmproxy', 02:52:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:52:38 INFO - '--firstNonBlankPaint'], 02:52:38 INFO - 'tests': ['tp6_google', 02:52:38 INFO - 'tp6_youtube', 02:52:38 INFO - 'tp6_amazon', 02:52:38 INFO - 'tp6_facebook']}, 02:52:38 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:52:38 INFO - 'talos_options': ['--disable-stylo', 02:52:38 INFO - '--mitmproxy', 02:52:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:52:38 INFO - '--firstNonBlankPaint'], 02:52:38 INFO - 'tests': ['tp6_google', 02:52:38 INFO - 'tp6_youtube', 02:52:38 INFO - 'tp6_amazon', 02:52:38 INFO - 'tp6_facebook']}, 02:52:38 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:52:38 INFO - 'talos_options': ['--stylo-threads=1', 02:52:38 INFO - '--mitmproxy', 02:52:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:52:38 INFO - '--firstNonBlankPaint'], 02:52:38 INFO - 'tests': ['tp6_google', 02:52:38 INFO - 'tp6_youtube', 02:52:38 INFO - 'tp6_amazon', 02:52:38 INFO - 'tp6_facebook']}, 02:52:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:52:38 INFO - 'talos_options': ['--xperf_path', 02:52:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:52:38 INFO - 'tests': ['tp5n']}, 02:52:38 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:52:38 INFO - 'talos_options': ['--disable-stylo', 02:52:38 INFO - '--xperf_path', 02:52:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:52:38 INFO - 'tests': ['tp5n']}}} 02:52:38 INFO - Running post-action listener: _resource_record_post_action 02:52:38 INFO - [mozharness: 2017-09-14 09:52:38.084551Z] Finished populate-webroot step (success) 02:52:38 INFO - [mozharness: 2017-09-14 09:52:38.084658Z] Running create-virtualenv step. 02:52:38 INFO - Running pre-action listener: _resource_record_pre_action 02:52:38 INFO - Running main action method: create_virtualenv 02:52:38 INFO - Creating virtualenv /builds/slave/test/build/venv 02:52:38 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:52:38 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:52:38 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:52:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:52:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:52:40 INFO - Installing distribute.............................................................................................................................................................................................done. 02:52:40 INFO - Installing pip...............done. 02:52:40 INFO - Return code: 0 02:52:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:52:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:52:40 INFO - Reading from file tmpfile_stdout 02:52:40 INFO - Output received: 02:52:40 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 02:52:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288c090>, '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 0x288cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2886f90>, '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': '836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467', '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 02:52:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:52:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:52:40 INFO - Using env: {'DISPLAY': ':0', 02:52:40 INFO - 'HOME': '/home/cltbld', 02:52:40 INFO - 'LANG': 'en_US.UTF-8', 02:52:40 INFO - 'LANGUAGE': 'en_US:en', 02:52:40 INFO - 'LOGNAME': 'cltbld', 02:52:40 INFO - 'MAIL': '/var/mail/cltbld', 02:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:40 INFO - 'MOZ_NO_REMOTE': '1', 02:52:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:40 INFO - 'NO_EM_RESTART': '1', 02:52:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:40 INFO - 'PWD': '/builds/slave/test', 02:52:40 INFO - 'SHELL': '/bin/bash', 02:52:40 INFO - 'SHLVL': '1', 02:52:40 INFO - 'TERM': 'linux', 02:52:40 INFO - 'TMOUT': '86400', 02:52:40 INFO - 'USER': 'cltbld', 02:52:40 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467', 02:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:40 INFO - '_': '/tools/buildbot/bin/python'} 02:52:41 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:52:41 INFO - Downloading/unpacking pip>=1.5 02:52:41 INFO - Running setup.py egg_info for package pip 02:52:41 INFO - warning: no files found matching 'pip/cacert.pem' 02:52:41 INFO - warning: no files found matching '*.html' under directory 'docs' 02:52:41 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:52:41 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:52:41 INFO - Installing collected packages: pip 02:52:41 INFO - Found existing installation: pip 1.1 02:52:41 INFO - Uninstalling pip: 02:52:41 INFO - Successfully uninstalled pip 02:52:41 INFO - Running setup.py install for pip 02:52:41 INFO - warning: no files found matching 'pip/cacert.pem' 02:52:41 INFO - warning: no files found matching '*.html' under directory 'docs' 02:52:41 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:52:41 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:52:41 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:52:41 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:52:41 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:52:41 INFO - Successfully installed pip 02:52:41 INFO - Cleaning up... 02:52:41 INFO - Return code: 0 02:52:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:41 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 0x251c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288c090>, '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 0x288cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2886f90>, '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': '836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467', '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 02:52:41 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 02:52:41 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 02:52:41 INFO - Using env: {'DISPLAY': ':0', 02:52:41 INFO - 'HOME': '/home/cltbld', 02:52:41 INFO - 'LANG': 'en_US.UTF-8', 02:52:41 INFO - 'LANGUAGE': 'en_US:en', 02:52:41 INFO - 'LOGNAME': 'cltbld', 02:52:41 INFO - 'MAIL': '/var/mail/cltbld', 02:52:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:41 INFO - 'MOZ_NO_REMOTE': '1', 02:52:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:41 INFO - 'NO_EM_RESTART': '1', 02:52:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:41 INFO - 'PWD': '/builds/slave/test', 02:52:41 INFO - 'SHELL': '/bin/bash', 02:52:41 INFO - 'SHLVL': '1', 02:52:41 INFO - 'TERM': 'linux', 02:52:41 INFO - 'TMOUT': '86400', 02:52:41 INFO - 'USER': 'cltbld', 02:52:41 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467', 02:52:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:41 INFO - '_': '/tools/buildbot/bin/python'} 02:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:42 INFO - Downloading/unpacking psutil>=3.1.1 02:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:52:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:52:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:52:43 INFO - Installing collected packages: psutil 02:52:43 INFO - Running setup.py install for psutil 02:52:43 INFO - building 'psutil._psutil_linux' extension 02:52:43 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 02:52:43 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 02:52:43 INFO - building 'psutil._psutil_posix' extension 02:52:43 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 02:52:43 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 02:52:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:52:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:52:43 INFO - Successfully installed psutil 02:52:43 INFO - Cleaning up... 02:52:43 INFO - Return code: 0 02:52:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:52: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')]} 02:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52: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')]} 02:52:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288c090>, '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 0x288cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2886f90>, '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': '836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467', '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 02:52:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:52:43 INFO - Using env: {'DISPLAY': ':0', 02:52:43 INFO - 'HOME': '/home/cltbld', 02:52:43 INFO - 'LANG': 'en_US.UTF-8', 02:52:43 INFO - 'LANGUAGE': 'en_US:en', 02:52:43 INFO - 'LOGNAME': 'cltbld', 02:52:43 INFO - 'MAIL': '/var/mail/cltbld', 02:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:43 INFO - 'MOZ_NO_REMOTE': '1', 02:52:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:43 INFO - 'NO_EM_RESTART': '1', 02:52:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:43 INFO - 'PWD': '/builds/slave/test', 02:52:43 INFO - 'SHELL': '/bin/bash', 02:52:43 INFO - 'SHLVL': '1', 02:52:43 INFO - 'TERM': 'linux', 02:52:43 INFO - 'TMOUT': '86400', 02:52:43 INFO - 'USER': 'cltbld', 02:52:43 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467', 02:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:43 INFO - '_': '/tools/buildbot/bin/python'} 02:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:52:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:52:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:52:45 INFO - Installing collected packages: mozsystemmonitor 02:52:45 INFO - Running setup.py install for mozsystemmonitor 02:52:45 INFO - Successfully installed mozsystemmonitor 02:52:45 INFO - Cleaning up... 02:52:45 INFO - Return code: 0 02:52:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:52:45 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')]} 02:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:45 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')]} 02:52:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:45 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 0x251c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288c090>, '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 0x288cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2886f90>, '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': '836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467', '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 02:52:45 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 02:52:45 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 02:52:45 INFO - Using env: {'DISPLAY': ':0', 02:52:45 INFO - 'HOME': '/home/cltbld', 02:52:45 INFO - 'LANG': 'en_US.UTF-8', 02:52:45 INFO - 'LANGUAGE': 'en_US:en', 02:52:45 INFO - 'LOGNAME': 'cltbld', 02:52:45 INFO - 'MAIL': '/var/mail/cltbld', 02:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:45 INFO - 'MOZ_NO_REMOTE': '1', 02:52:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:45 INFO - 'NO_EM_RESTART': '1', 02:52:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:45 INFO - 'PWD': '/builds/slave/test', 02:52:45 INFO - 'SHELL': '/bin/bash', 02:52:45 INFO - 'SHLVL': '1', 02:52:45 INFO - 'TERM': 'linux', 02:52:45 INFO - 'TMOUT': '86400', 02:52:45 INFO - 'USER': 'cltbld', 02:52:45 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467', 02:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:45 INFO - '_': '/tools/buildbot/bin/python'} 02:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:45 INFO - Downloading/unpacking jsonschema==2.5.1 02:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:52:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:52:46 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 02:52:46 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 02:52:46 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 02:52:46 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 02:52:46 INFO - Downloading functools32-3.2.3-2.tar.gz 02:52:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:52:46 INFO - warning: no files found matching '*.txt' 02:52:46 INFO - no previously-included directories found matching 'build' 02:52:46 INFO - no previously-included directories found matching 'dist' 02:52:46 INFO - no previously-included directories found matching '.git*' 02:52:46 INFO - Installing collected packages: jsonschema, functools32 02:52:46 INFO - Running setup.py install for functools32 02:52:47 INFO - warning: no files found matching '*.txt' 02:52:47 INFO - no previously-included directories found matching 'build' 02:52:47 INFO - no previously-included directories found matching 'dist' 02:52:47 INFO - no previously-included directories found matching '.git*' 02:52:47 INFO - Successfully installed jsonschema functools32 02:52:47 INFO - Cleaning up... 02:52:47 INFO - Return code: 0 02:52:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:52:47 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')]} 02:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:47 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')]} 02:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:47 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 0x251c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288c090>, '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 0x288cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2886f90>, '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': '836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467', '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 02:52:47 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 02:52:47 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 02:52:47 INFO - Using env: {'DISPLAY': ':0', 02:52:47 INFO - 'HOME': '/home/cltbld', 02:52:47 INFO - 'LANG': 'en_US.UTF-8', 02:52:47 INFO - 'LANGUAGE': 'en_US:en', 02:52:47 INFO - 'LOGNAME': 'cltbld', 02:52:47 INFO - 'MAIL': '/var/mail/cltbld', 02:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:47 INFO - 'MOZ_NO_REMOTE': '1', 02:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:47 INFO - 'NO_EM_RESTART': '1', 02:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:47 INFO - 'PWD': '/builds/slave/test', 02:52:47 INFO - 'SHELL': '/bin/bash', 02:52:47 INFO - 'SHLVL': '1', 02:52:47 INFO - 'TERM': 'linux', 02:52:47 INFO - 'TMOUT': '86400', 02:52:47 INFO - 'USER': 'cltbld', 02:52:47 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467', 02:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:47 INFO - '_': '/tools/buildbot/bin/python'} 02:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:52:47 INFO - Cleaning up... 02:52:47 INFO - Return code: 0 02:52:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:52:47 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')]} 02:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:47 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')]} 02:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:47 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 0x251c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288c090>, '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 0x288cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2886f90>, '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': '836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467', '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 02:52:47 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 02:52:47 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 02:52:47 INFO - Using env: {'DISPLAY': ':0', 02:52:47 INFO - 'HOME': '/home/cltbld', 02:52:47 INFO - 'LANG': 'en_US.UTF-8', 02:52:47 INFO - 'LANGUAGE': 'en_US:en', 02:52:47 INFO - 'LOGNAME': 'cltbld', 02:52:47 INFO - 'MAIL': '/var/mail/cltbld', 02:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:47 INFO - 'MOZ_NO_REMOTE': '1', 02:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:47 INFO - 'NO_EM_RESTART': '1', 02:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:47 INFO - 'PWD': '/builds/slave/test', 02:52:47 INFO - 'SHELL': '/bin/bash', 02:52:47 INFO - 'SHLVL': '1', 02:52:47 INFO - 'TERM': 'linux', 02:52:47 INFO - 'TMOUT': '86400', 02:52:47 INFO - 'USER': 'cltbld', 02:52:47 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467', 02:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:47 INFO - '_': '/tools/buildbot/bin/python'} 02:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:47 INFO - Downloading/unpacking blobuploader==1.2.4 02:52:47 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 02:52:47 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 02:52:47 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 02:52:47 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 02:52:48 INFO - Downloading blobuploader-1.2.4.tar.gz 02:52:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:52:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:52:48 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 02:52:48 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 02:52:48 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 02:52:48 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 02:52:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:52:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:52:49 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 02:52:49 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 02:52:49 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 02:52:49 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 02:52:49 INFO - Downloading docopt-0.6.1.tar.gz 02:52:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:52:49 INFO - Installing collected packages: blobuploader, requests, docopt 02:52:49 INFO - Running setup.py install for blobuploader 02:52:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:52:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:52:49 INFO - Running setup.py install for requests 02:52:49 INFO - Running setup.py install for docopt 02:52:49 INFO - Successfully installed blobuploader requests docopt 02:52:49 INFO - Cleaning up... 02:52:49 INFO - Return code: 0 02:52:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:49 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 0x251c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288c090>, '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 0x288cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2886f90>, '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': '836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467', '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 02:52:49 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 02:52:49 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 02:52:49 INFO - Using env: {'DISPLAY': ':0', 02:52:49 INFO - 'HOME': '/home/cltbld', 02:52:49 INFO - 'LANG': 'en_US.UTF-8', 02:52:49 INFO - 'LANGUAGE': 'en_US:en', 02:52:49 INFO - 'LOGNAME': 'cltbld', 02:52:49 INFO - 'MAIL': '/var/mail/cltbld', 02:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:49 INFO - 'MOZ_NO_REMOTE': '1', 02:52:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:49 INFO - 'NO_EM_RESTART': '1', 02:52:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:49 INFO - 'PWD': '/builds/slave/test', 02:52:49 INFO - 'SHELL': '/bin/bash', 02:52:49 INFO - 'SHLVL': '1', 02:52:49 INFO - 'TERM': 'linux', 02:52:49 INFO - 'TMOUT': '86400', 02:52:49 INFO - 'USER': 'cltbld', 02:52:49 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467', 02:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:49 INFO - '_': '/tools/buildbot/bin/python'} 02:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:52:50 INFO - Running setup.py (path:/tmp/pip-e6Y4Ia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:52:50 INFO - Running setup.py (path:/tmp/pip-Ukg_99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:52:50 INFO - Running setup.py (path:/tmp/pip-BcNbED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:52:50 INFO - Running setup.py (path:/tmp/pip-42lp5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:52:50 INFO - Running setup.py (path:/tmp/pip-wLMB73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:52:50 INFO - Running setup.py (path:/tmp/pip-HUgDPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:52:50 INFO - Running setup.py (path:/tmp/pip-srx4hH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:52:50 INFO - Running setup.py (path:/tmp/pip-zNDPfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:52:50 INFO - Running setup.py (path:/tmp/pip-Ra35Nv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:52:50 INFO - Running setup.py (path:/tmp/pip-HEjIVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:52:50 INFO - Running setup.py (path:/tmp/pip-Q9JGyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:52:50 INFO - Running setup.py (path:/tmp/pip-fQkGFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:52:50 INFO - Running setup.py (path:/tmp/pip-jUTcxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:52:50 INFO - Running setup.py (path:/tmp/pip-0MZCQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:51 INFO - Running setup.py (path:/tmp/pip-zFxWpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:52:51 INFO - Running setup.py (path:/tmp/pip-ow2yZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:52:51 INFO - Running setup.py (path:/tmp/pip-f0VU60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:52:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:52:51 INFO - Running setup.py install for manifestparser 02:52:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:52:51 INFO - Running setup.py install for mozcrash 02:52:51 INFO - Running setup.py install for mozdebug 02:52:51 INFO - Running setup.py install for mozdevice 02:52:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:52:51 INFO - Running setup.py install for mozfile 02:52:51 INFO - Running setup.py install for mozhttpd 02:52:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:52:51 INFO - Running setup.py install for mozinfo 02:52:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:52:51 INFO - Running setup.py install for mozInstall 02:52:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:52:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:52:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:52:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:52:52 INFO - Running setup.py install for mozleak 02:52:52 INFO - Running setup.py install for mozlog 02:52:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:52:52 INFO - Running setup.py install for moznetwork 02:52:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:52:52 INFO - Running setup.py install for mozprocess 02:52:52 INFO - Running setup.py install for mozprofile 02:52:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:52:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:52:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:52:52 INFO - Running setup.py install for mozrunner 02:52:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:52:52 INFO - Running setup.py install for mozscreenshot 02:52:52 INFO - Running setup.py install for moztest 02:52:52 INFO - Running setup.py install for mozversion 02:52:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:52:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:52:52 INFO - Cleaning up... 02:52:52 INFO - Return code: 0 02:52:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52:53 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')]} 02:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:53 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')]} 02:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:53 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 0x251c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288c090>, '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 0x288cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2886f90>, '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': '836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467', '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 02:52:53 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 02:52:53 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 02:52:53 INFO - Using env: {'DISPLAY': ':0', 02:52:53 INFO - 'HOME': '/home/cltbld', 02:52:53 INFO - 'LANG': 'en_US.UTF-8', 02:52:53 INFO - 'LANGUAGE': 'en_US:en', 02:52:53 INFO - 'LOGNAME': 'cltbld', 02:52:53 INFO - 'MAIL': '/var/mail/cltbld', 02:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:53 INFO - 'MOZ_NO_REMOTE': '1', 02:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:53 INFO - 'NO_EM_RESTART': '1', 02:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:53 INFO - 'PWD': '/builds/slave/test', 02:52:53 INFO - 'SHELL': '/bin/bash', 02:52:53 INFO - 'SHLVL': '1', 02:52:53 INFO - 'TERM': 'linux', 02:52:53 INFO - 'TMOUT': '86400', 02:52:53 INFO - 'USER': 'cltbld', 02:52:53 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467', 02:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:53 INFO - '_': '/tools/buildbot/bin/python'} 02:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:52:53 INFO - Running setup.py (path:/tmp/pip-d3n0st-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:52:53 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)) 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:52:53 INFO - Running setup.py (path:/tmp/pip-ICk68Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:52:53 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)) 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:52:53 INFO - Running setup.py (path:/tmp/pip-pn7PP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:52:53 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)) 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:52:53 INFO - Running setup.py (path:/tmp/pip-PlpAb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:52:53 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)) 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:52:53 INFO - Running setup.py (path:/tmp/pip-BUrav3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:52:53 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)) 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:52:53 INFO - Running setup.py (path:/tmp/pip-9Uam36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:52:53 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)) 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:52:53 INFO - Running setup.py (path:/tmp/pip-ydYMAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:52:53 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)) 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:52:53 INFO - Running setup.py (path:/tmp/pip-H2vX5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:52:53 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)) 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:52:53 INFO - Running setup.py (path:/tmp/pip-5PCizP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:52:53 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)) 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:52:53 INFO - Running setup.py (path:/tmp/pip-TPLXp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:52:53 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)) 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:52:53 INFO - Running setup.py (path:/tmp/pip-k9gzX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:52:54 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)) 02:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:52:54 INFO - Running setup.py (path:/tmp/pip-xv_2g2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:52:54 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)) 02:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:52:54 INFO - Running setup.py (path:/tmp/pip-5fSb01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:52:54 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)) 02:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:52:54 INFO - Running setup.py (path:/tmp/pip-Vs7QH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:52:54 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)) 02:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:54 INFO - Running setup.py (path:/tmp/pip-otawa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:54 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)) 02:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:52:54 INFO - Running setup.py (path:/tmp/pip-91jDKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:52:54 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)) 02:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:52:54 INFO - Running setup.py (path:/tmp/pip-Bq7Gpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:52:54 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)) 02:52:54 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)) 02:52:54 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)) 02:52:54 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)) 02:52:54 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)) 02:52:54 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)) 02:52:54 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)) 02:52:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:55 INFO - Downloading blessings-1.6.tar.gz 02:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:52:55 INFO - Installing collected packages: blessings 02:52:55 INFO - Running setup.py install for blessings 02:52:55 INFO - Successfully installed blessings 02:52:55 INFO - Cleaning up... 02:52:55 INFO - Return code: 0 02:52:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:52:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:52:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:52:55 INFO - Reading from file tmpfile_stdout 02:52:55 INFO - Current package versions: 02:52:55 INFO - argparse == 1.2.1 02:52:55 INFO - blessings == 1.6 02:52:55 INFO - blobuploader == 1.2.4 02:52:55 INFO - docopt == 0.6.1 02:52:55 INFO - functools32 == 3.2.3-2 02:52:55 INFO - jsonschema == 2.5.1 02:52:55 INFO - manifestparser == 1.1 02:52:55 INFO - mozInstall == 1.13 02:52:55 INFO - mozcrash == 1.0 02:52:56 INFO - mozdebug == 0.1 02:52:56 INFO - mozdevice == 0.51 02:52:56 INFO - mozfile == 1.2 02:52:56 INFO - mozhttpd == 0.7 02:52:56 INFO - mozinfo == 0.10 02:52:56 INFO - mozleak == 0.1 02:52:56 INFO - mozlog == 3.5 02:52:56 INFO - moznetwork == 0.27 02:52:56 INFO - mozprocess == 0.25 02:52:56 INFO - mozprofile == 0.28 02:52:56 INFO - mozrunner == 6.13 02:52:56 INFO - mozscreenshot == 0.1 02:52:56 INFO - mozsystemmonitor == 0.3 02:52:56 INFO - moztest == 0.8 02:52:56 INFO - mozversion == 1.4 02:52:56 INFO - psutil == 3.1.1 02:52:56 INFO - requests == 1.2.3 02:52:56 INFO - wsgiref == 0.1.2 02:52:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:56 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 0x251c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288c090>, '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 0x288cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2886f90>, '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': '836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467', '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 02:52:56 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 02:52:56 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 02:52:56 INFO - Using env: {'DISPLAY': ':0', 02:52:56 INFO - 'HOME': '/home/cltbld', 02:52:56 INFO - 'LANG': 'en_US.UTF-8', 02:52:56 INFO - 'LANGUAGE': 'en_US:en', 02:52:56 INFO - 'LOGNAME': 'cltbld', 02:52:56 INFO - 'MAIL': '/var/mail/cltbld', 02:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:56 INFO - 'MOZ_NO_REMOTE': '1', 02:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:56 INFO - 'NO_EM_RESTART': '1', 02:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:56 INFO - 'PWD': '/builds/slave/test', 02:52:56 INFO - 'SHELL': '/bin/bash', 02:52:56 INFO - 'SHLVL': '1', 02:52:56 INFO - 'TERM': 'linux', 02:52:56 INFO - 'TMOUT': '86400', 02:52:56 INFO - 'USER': 'cltbld', 02:52:56 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467', 02:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:56 INFO - '_': '/tools/buildbot/bin/python'} 02:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:56 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)) 02:52:56 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)) 02:52:56 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)) 02:52:56 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)) 02:52:56 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)) 02:52:56 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)) 02:52:56 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)) 02:52:56 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)) 02:52:56 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)) 02:52:56 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:52:56 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 02:52:56 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 02:52:56 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 02:52:56 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 02:52:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:52:57 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)) 02:52:57 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)) 02:52:57 INFO - Installing collected packages: simplejson 02:52:57 INFO - Running setup.py install for simplejson 02:52:57 INFO - building 'simplejson._speedups' extension 02:52:57 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 02:52:58 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 02:52:58 INFO - Successfully installed simplejson 02:52:58 INFO - Cleaning up... 02:52:58 INFO - Return code: 0 02:52:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:58 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 0x251c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288c090>, '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 0x288cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2886f90>, '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': '836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467', '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 02:52:58 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 02:52:58 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 02:52:58 INFO - Using env: {'DISPLAY': ':0', 02:52:58 INFO - 'HOME': '/home/cltbld', 02:52:58 INFO - 'LANG': 'en_US.UTF-8', 02:52:58 INFO - 'LANGUAGE': 'en_US:en', 02:52:58 INFO - 'LOGNAME': 'cltbld', 02:52:58 INFO - 'MAIL': '/var/mail/cltbld', 02:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:58 INFO - 'MOZ_NO_REMOTE': '1', 02:52:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:58 INFO - 'NO_EM_RESTART': '1', 02:52:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:58 INFO - 'PWD': '/builds/slave/test', 02:52:58 INFO - 'SHELL': '/bin/bash', 02:52:58 INFO - 'SHLVL': '1', 02:52:58 INFO - 'TERM': 'linux', 02:52:58 INFO - 'TMOUT': '86400', 02:52:58 INFO - 'USER': 'cltbld', 02:52:58 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467', 02:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:58 INFO - '_': '/tools/buildbot/bin/python'} 02:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:52:58 INFO - Cleaning up... 02:52:58 INFO - Return code: 0 02:52:58 INFO - Running post-action listener: _resource_record_post_action 02:52:58 INFO - Running post-action listener: _start_resource_monitoring 02:52:58 INFO - Starting resource monitoring. 02:52:58 INFO - [mozharness: 2017-09-14 09:52:58.726795Z] Finished create-virtualenv step (success) 02:52:58 INFO - [mozharness: 2017-09-14 09:52:58.727261Z] Running install step. 02:52:58 INFO - Running pre-action listener: _resource_record_pre_action 02:52:58 INFO - Running main action method: install 02:52:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:52:58 INFO - Reading from file tmpfile_stdout 02:52:58 INFO - Detecting whether we're running mozinstall >=1.0... 02:52:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:52:59 INFO - Reading from file tmpfile_stdout 02:52:59 INFO - Output received: 02:52:59 INFO - Usage: mozinstall [options] installer 02:52:59 INFO - Options: 02:52:59 INFO - -h, --help show this help message and exit 02:52:59 INFO - -d DEST, --destination=DEST 02:52:59 INFO - Directory to install application into. [default: 02:52:59 INFO - "/builds/slave/test"] 02:52:59 INFO - --app=APP Application being installed. [default: firefox] 02:52:59 INFO - mkdir: /builds/slave/test/build/application 02:52:59 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'] 02:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:53:16 INFO - Reading from file tmpfile_stdout 02:53:16 INFO - Output received: 02:53:16 INFO - /builds/slave/test/build/application/firefox/firefox 02:53:16 INFO - Running post-action listener: _resource_record_post_action 02:53:16 INFO - [mozharness: 2017-09-14 09:53:16.803400Z] Finished install step (success) 02:53:16 INFO - [mozharness: 2017-09-14 09:53:16.803545Z] Running setup-mitmproxy step. 02:53:16 INFO - Running pre-action listener: _resource_record_pre_action 02:53:16 INFO - Running main action method: setup_mitmproxy 02:53:16 INFO - Skipping: mitmproxy is not required 02:53:16 INFO - Running post-action listener: _resource_record_post_action 02:53:16 INFO - [mozharness: 2017-09-14 09:53:16.804075Z] Finished setup-mitmproxy step (success) 02:53:16 INFO - [mozharness: 2017-09-14 09:53:16.804284Z] Running run-tests step. 02:53:16 INFO - Running pre-action listener: _resource_record_pre_action 02:53:16 INFO - Running pre-action listener: _set_gcov_prefix 02:53:16 INFO - Running main action method: run_tests 02:53:16 WARNING - Try message not found. 02:53:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:53:16 INFO - Python 2.7.3 02:53:16 INFO - Return code: 0 02:53:16 INFO - grabbing minidump binary from tooltool 02:53:16 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')]} 02:53:16 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x288c090>, '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 0x288cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2886f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:53:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 02:53:16 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:53:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 02:53:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:53:16 INFO - Return code: 0 02:53:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:53:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:53:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:53:16 INFO - ENV: RUST_BACKTRACE is now full 02:53:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:53:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:53:16 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/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 02:53:16 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/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 02:53:16 INFO - Using env: {'DISPLAY': ':0', 02:53:16 INFO - 'HOME': '/home/cltbld', 02:53:16 INFO - 'LANG': 'en_US.UTF-8', 02:53:16 INFO - 'LANGUAGE': 'en_US:en', 02:53:16 INFO - 'LOGNAME': 'cltbld', 02:53:16 INFO - 'MAIL': '/var/mail/cltbld', 02:53:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:53:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:16 INFO - 'MOZ_NO_REMOTE': '1', 02:53:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:53:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:16 INFO - 'NO_EM_RESTART': '1', 02:53:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:16 INFO - 'PWD': '/builds/slave/test', 02:53:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:53:16 INFO - 'RUST_BACKTRACE': 'full', 02:53:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:53:16 INFO - 'SHELL': '/bin/bash', 02:53:16 INFO - 'SHLVL': '1', 02:53:16 INFO - 'TERM': 'linux', 02:53:16 INFO - 'TMOUT': '86400', 02:53:16 INFO - 'USER': 'cltbld', 02:53:16 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467', 02:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:16 INFO - '_': '/tools/buildbot/bin/python'} 02:53:16 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/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 02:53:17 INFO - mozversion application_buildid: 20170914090430 02:53:17 INFO - mozversion application_changeset: dd6b788f149763c4014c27f2fe1a1d13228bda82 02:53:17 INFO - mozversion application_display_name: Nightly 02:53:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:53:17 INFO - mozversion application_name: Firefox 02:53:17 INFO - mozversion application_remotingname: firefox 02:53:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:53:17 INFO - mozversion application_vendor: Mozilla 02:53:17 INFO - mozversion application_version: 57.0a1 02:53:17 INFO - mozversion platform_buildid: 20170914090430 02:53:17 INFO - mozversion platform_changeset: dd6b788f149763c4014c27f2fe1a1d13228bda82 02:53:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:53:17 INFO - mozversion platform_version: 57.0a1 02:53:17 INFO - using testdate: 1505382797 02:53:17 INFO - actual date: 1505382797 02:53:17 INFO - starting webserver on 'localhost:55522' 02:53:17 INFO - SUITE-START | Running 2 tests 02:53:17 INFO - TEST-START | dromaeo_css 02:53:17 INFO - Initialising browser for dromaeo_css test... 02:53:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55522/getInfo.html -profile /tmp/tmpa1BJmB/profile 02:53:17 INFO - TEST-INFO | started process 11570 (/builds/slave/test/build/application/firefox/firefox http://localhost:55522/getInfo.html) 02:53:23 INFO - TEST-INFO | 11570: exit 0 02:53:23 INFO - Browser initialized. 02:53:23 INFO - Running cycle 1/1 for dromaeo_css test... 02:53:23 INFO - Using env: {'DISPLAY': ':0', 02:53:23 INFO - 'HOME': '/home/cltbld', 02:53:23 INFO - 'JSGC_DISABLE_POISONING': '1', 02:53:23 INFO - 'LANG': 'en_US.UTF-8', 02:53:23 INFO - 'LANGUAGE': 'en_US:en', 02:53:23 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:53:23 INFO - 'LOGNAME': 'cltbld', 02:53:23 INFO - 'MAIL': '/var/mail/cltbld', 02:53:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:53:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:53:23 INFO - 'MOZ_CRASHREPORTER': '1', 02:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:23 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:53:23 INFO - 'MOZ_NO_REMOTE': '1', 02:53:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:53:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:23 INFO - 'NO_EM_RESTART': '1', 02:53:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:23 INFO - 'PWD': '/builds/slave/test', 02:53:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:53:23 INFO - 'RUST_BACKTRACE': 'full', 02:53:23 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:53:23 INFO - 'SHELL': '/bin/bash', 02:53:23 INFO - 'SHLVL': '1', 02:53:23 INFO - 'TERM': 'linux', 02:53:23 INFO - 'TMOUT': '86400', 02:53:23 INFO - 'USER': 'cltbld', 02:53:23 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467', 02:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:23 INFO - '_': '/tools/buildbot/bin/python'} 02:53:23 INFO - TEST-INFO | started process 11801 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa1BJmB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:53:24 INFO - PID 11801 | 02:53:24 INFO - PID 11801 | (/builds/slave/test/build/application/firefox/firefox:11850): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:53:24 INFO - PID 11801 | 02:53:34 INFO - PID 11801 | RSS: Main: 172326912 02:53:34 INFO - PID 11801 | 02:56:32 INFO - PID 11801 | Cycle 1(1): loaded http://localhost:55522/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55522/tests/dromaeo/cssquery-ext.html) 02:56:33 INFO - PID 11801 | RSS: Main: 175915008 02:56:33 INFO - PID 11801 | 02:59:34 INFO - PID 11801 | Cycle 1(1): loaded http://localhost:55522/tests/dromaeo/cssquery-ext.html (next: http://localhost:55522/tests/dromaeo/cssquery-jquery.html) 02:59:35 INFO - PID 11801 | RSS: Main: 172220416 02:59:35 INFO - PID 11801 | 03:02:37 INFO - PID 11801 | Cycle 1(1): loaded http://localhost:55522/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55522/tests/dromaeo/cssquery-mootools.html) 03:02:37 INFO - PID 11801 | RSS: Main: 174501888 03:02:37 INFO - PID 11801 | 03:05:39 INFO - PID 11801 | Cycle 1(1): loaded http://localhost:55522/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55522/tests/dromaeo/cssquery-prototype.html) 03:05:40 INFO - PID 11801 | RSS: Main: 172392448 03:05:40 INFO - PID 11801 | 03:08:43 INFO - PID 11801 | Cycle 1(1): loaded http://localhost:55522/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55522/tests/dromaeo/cssquery-yui.html) 03:08:43 INFO - PID 11801 | RSS: Main: 174329856 03:08:43 INFO - PID 11801 | 03:11:45 INFO - PID 11801 | Cycle 1(1): loaded http://localhost:55522/tests/dromaeo/cssquery-yui.html (next: http://localhost:55522/tests/dromaeo/cssquery-dojo.html) 03:11:45 INFO - PID 11801 | RSS: Main: 176766976 03:11:45 INFO - PID 11801 | 03:11:45 INFO - PID 11801 | __start_tp_report 03:11:45 INFO - PID 11801 | _x_x_mozilla_page_load 03:11:45 INFO - PID 11801 | _x_x_mozilla_page_load_details 03:11:45 INFO - PID 11801 | |i|pagename|runs| 03:11:45 INFO - PID 11801 | |0;dojo.html;3120.4071226466967;3186.4264432402174;3190.5214217867315;3202.263479399738;3209.438348289049;6319.652419116958;6456.225252969644;6462.903056454151;6511.38141876521;6565.244996825367;6369.840753981152;6404.295527491972;6412.583182093173;6461.321561236073;6461.579997300172;5898.026825573786;5898.941010589903;5925.20009798676;5926.288845338566;5954.583179177459;5938.257717785277;5983.6409815411;5995.370486098962;6019.879602407949;6048.727807248662;5940.910886336686;5990.9101363479585;6031.969840150793;6042.969785151068;6044.304904935944;5738.626989245686;6015.909761353583;6062.9090563641585;6071.0589858571775;6078.878422431527;5714.371419143891;5813.157092221646;5823.854403639901;5845.298564172326;5992;6416.582922110095;6462.25684046336;6473.093766872642;6555.508336874754;6559.836004099888;6692.966535167342;6852;6926.722931082751;6936.514443988923;7030.964845175741;6869.862602747917;6915.585064896122;6932.272111428278;6936.445084393236;6941.375276225113;6285.779997700059;6365.745370185187;6373.42639162473;6375.330590287999;6391;7141.428685705131;7179.066721326299;7257.49197556166;7264.34620884123;7267.854642907112;6797.4901882358035;6815.761448349284;6839;6888.896666550006;6910.136232970879;6810.557313774589;6859.9314006859295;6893.7931862044215;6950.965245173742;7035.6482175891;6912.032315475837;6922.5154239203775;6927.238003819576;6932.826679332956;6938.202106757787;6997.895031574531;7006.229314775371;7020.368166865007;7026.1217347831525;7026.613536255452;5213.661112027706;5221.269022336875;5282.841514754564;5291.735413229323;5309.973450132725;4489.483709373399;4523.705959112647;4574.794134263966;4578.88552786183;4613.169629466728;5902.940970590239;5928.347881733006;5931.08068249422;5933.406659334032;5959.612625179349;6835.58986460814;6994.475414343945;7015.438764898898;7016.473764467685;7020.719171233196;5851.005329094064;5864.589478736448;5936.881262374728;5937.52499800015;5937.614055086406;5581.581381396411;5665;5668.744906479218;5674.432556744375;5676.205331253628;6587.143671322698;6587.604743715392;6592.604443733391;6612.07430959666;6646.036324732887;6941.375276225164;6987.161540615159;7003.019577259188;7011.754588589579;7053.647317633995;6622.668866556556;6643.036759669917;6709.832254193684;6711.395974362135;6755.290694477206;6602.900956485752;6793.626350550767;6807.455403567604;6826.829329266808;6905.723771049102;6862.107925969592;6875.1749790025515;6931.2375638678695;6957.339052789976;6972.7210911565;6652.434543063894;6767.289434609492;6781.593104413751;6828.760993365408;6828.9658551706925;6751;6753.864922701617;6818;6836;6844.691988860413;6439.484841212786;6641.50188735837;6645.202575690948;6754.0881980931945;6754.18949726036;6635.535512514078;6686.465082793462;6706.128203333536;6765.188177418741;6850.143732033496;6364.013577895434;6499.28507864144;6499.3175716549085;6570.211574610886;6594.505412094208 03:11:45 INFO - PID 11801 | |1;ext.html;822.2681813186261;833.9666413343466;859.0593300336132;879.3492815316667;882.4484697064335;41240.58759412405;41714.7914260429;41874.162516749726;42245.78877105614;42259.78870105649;41923.37114943271;42849.7857510712;42879;42905;42933;7726.111497177841;7836.02049743782;7851.528908265523;7852.21477852216;7855;7775.8056048598955;7855.096663883669;7873.409494287923;7899.881501777478;7900.723474678387;7875.96062019692;7894.092179399357;7896.368290536772;7908.960455197716;7909.327707144899;7825.25660062296;7877.094134174557;7886.763397098096;7894.842103157905;7911.802204944865;7734;7803.453758236926;7804.3756499479905;7805.9609701951695;7810.960945195237;38112.42831357532;38497;38524.807375963224;38544.614553854386;38609.22781544353;3479.7564170508076;3512.525809015776;3515.34966031285;3515.84178711956;3518.36669399508;31553.52669709956;31574.210644733837;31639.84180079108;31681.207969800707;31713.365732685448;5118.564921981636;5264.341957255343;5275.155975044013;5306.495882891119;5348.171033489815;173805;174930;175206;175372.24627753688;175834;46539.534604654196;46695.5330446698;46738;46917;48329;50472.49527504678;50833.74583127061;51082.74458627683;51101.23348149781;51131.48868511267;16336.75494867578;16366;16496.34014639425;16519.174041298127;16618.418355357506;13483.325833708275;13590.524331648345;13604.251766152956;13614;13629.591112266648;14873;14912.105273683614;14926.70146597062;14996.550103496913;15091.773623395658;5884.588078834526;5975.25309336333;5996.67018313997;6018.428249316308;6023.06642470409;1000.2398177385094;1011.3426272922512;1021.9693409197736;1022.6983040003217;1031.886492485826;23394.06423743065;23672.28983130509;23728.644070338614;23969.161079362486;23989.640155397683;1103.773726386089;1117.4636174636057;1121.058311018748;1121.6915348279126;1123.646051493777;12785.936070319774;12832.743345133045;12909.166932144048;12947.5468358607;12990.740185196242;225930;230186;230205;230277;230468;52506.73746631242;54130;55658.72170639121;58233.4176658228;58263.75626193663;1440.2870579063222;1465.377214683755;1466.7286551987916;1471.1099784630144;1474.4913005013252;27050.594241086004;27268;27491;27701.584476233274;27793.722062779114;39256;39651.60348396595;39690.40464393094;39708.205835883695;39713.40429893496;206542;206936;207450;207481;207510;34924.47613285854;35706.64293357033;36051.63948360483;36188.4571731419;36519.08702282464;44058;44207.33688994732;44426.333604996595;44576.33135503035;44676;32266.35467290688;32451.35097298088;32836;32854.507182391804;32868.50697239496;31737.841310793297;32094.83952580222;32216.83891580527;32290.83854580806;32451.18872028218;34717.65282347144;36200;36709.44935826018;36801.447978279815;36810.263794724495;31499.212519687193;31531.684683152875;31682;31897.840510797298;32346.514802278456;22893.88553057224;22951.737654429166;23118.537629246985;23152.652710209022;23496.41258968471 03:11:45 INFO - PID 11801 | |2;jquery.html;560.1094260126398;560.6944215402605;561.9719014049297;566.1394680086269;580.0747807247441;22052.669209961845;22876.771232287672;22883.771162288373;22901.656475152886;22929.312120636365;23517.529649407003;24095.87952060237;24469.75530244697;24478.510429791393;24621.630675539836;6532.836679083025;6763.797086087426;6777.491688123386;6780.7965761027;6784.762533311335;6640;6704.2625311215725;6712.362325579086;6717.227518835348;6743.797686069426;6323.9051414228825;6639.402453779159;6650.634215118166;6653.567518111331;6683.331666833326;6583.242927063401;6632.1709786276715;6639.170103737033;6640.634765087918;6646.036324732935;5957.344692083867;6120.724567394478;6142.385761423822;6146.815595532141;6159.630422174684;27251;27853.721462785314;27898.442031159466;27900.16299511018;27904;2001.1495114576246;2017.505711100775;2018.535736780534;2018.7678416982087;2021.5047313408309;17809.376671816553;18265.178066987017;18490.63018739618;18552.53618659531;18561.535961600934;2448.755124487555;2458.963115553268;2499.52509023285;2506.1604362538574;2512.0203120782908;113169.43415282953;116885.41557292244;117949;123881;124391.3780431101;14036.228007459484;14281.357338919774;14316.713665726835;14551.92724036373;14775.70448591022;22125.225617103646;22178.889105554368;22182.559918408962;22203;22205.111795528323;9940.403575785476;10093.798124037477;10152.086312231935;10213.234007449471;10303;9503.66737164196;9579.13787759105;9594.568244429018;9632.518374081408;9726.17327527154;8751.431156974777;8813.867791983126;8857.955710221408;8867.113288671211;9027.548622568846;2587.197968629731;2628.8332992207565;2642.312998620334;2669.4927963686837;2745.1078399520234;952.9857052144223;974.4056125763278;977.3305285879195;994.2642444591095;997.6907158780801;18684.692071554862;18703.438896833115;19028;19135.8086419134;19209.135588898534;1000.4147573669339;1031.1544533482472;1037.972407316751;1042.0725554256717;1045.3571053801857;9929.652462163935;10401.791964160675;10514.3691378516;10832.458377081115;10915.617953371593;406057;422886;433111;434029;438468;101239.49380253052;103007;104079.4796026015;104546;104642;1143.891330323618;1160.4023927677422;1170.2334970594275;1181.2499063094997;1181.6632259805915;16690.24893879754;16791.908525945775;17170.914145429193;17381.391651292142;17461;50781;51200;51212.74393628008;51965.7401712989;52258.73870630623;64266;64491.67754161199;64742.67628661827;64813.351866480734;66075.6696216535;13917.886569074248;13983.720325593635;14199.077059991068;14214.431422742975;14351.138931664134;22028.449288767908;22145.667814982466;22286.219982300543;22321.10715571359;22339.553208936057;17623.911880440515;17928.103594820466;17977.561795056627;18002.909985449987;18020.09899505046;15708.528744137695;16085.195740212708;16283.918580407022;16330.101844398672;16914;18439.446816595522;18463.261469541605;18476.260949561867;18583.72124418162;18590.628187436447;13519.391627376595;13981.161130332213;14055.648608784863;14067.718645627236;14157.221352825694;18258.17838197258;18362.540936476697;18382.632347353247;18419.447416577525;18421.355252566096 03:11:45 INFO - PID 11801 | |3;mootools.html;1314.6056183145056;1373.7664597018506;1385.3419625677811;1394.9930250348746;1398.9860101398986;14720.77918831217;15323.080615163084;15340.156291403968;15341.616459588517;15393.769093463607;15211.315490802912;15268.694626107499;15269.389224431037;15364.61588460289;15378.461753838617;2766.7648249898784;2785.0670025541417;2839.148255523345;2840.7727381809405;2841.872115754796;2741.643586333784;2763.198672385006;2774.4867199568143;2780.3605170810624;2785.3454438207104;2710.715374885638;2732.221316924677;2848.743613074823;2850.9287267818368;2852.1871266689;2715.8642067896526;2743.82165159266;2755.600437936498;2773.1126039667415;2785.261905595019;2573.189445324717;2749.6975332713387;2763.3367991681853;2763.571646394812;2765.7096004919395;15524.379024838992;15636.296366663528;15684.921575392164;15690.76463853043;15694.529164125095;8134.837303253902;8388.8741668875;8390.874136887951;8396.664133434655;8465.746027619181;5349.786008559653;5502.339719233678;5562.471565201299;5571.832845014656;5620.887582248373;1880.8119188081218;1888.376835644234;1893.469828448023;1940.3014914630721;1941.7572803399576;25560.616590751153;25775.35561610956;25809;25825.870870645525;25840.483190336276;6659.433948114464;6848.212455567674;6938;7003.8599228015155;7022.438204943593;17121;17126.914365428092;17138.571535711708;17155.742663860052;17257.309707611807;7846.136924938252;7933.286004259528;7952.085510166405;7969.322607578305;8016.599170041474;7259.673314700851;7266.672999715025;7321.597312147776;7481.326680598772;7485.737999170003;5073.695578265316;5201.895962080737;5235.345581802275;5244.790208391698;5264.6051546134195;1577.7948866647262;1579.9052056876624;1580.905145691239;1586.643005323793;1600.2638786158498;882.8013696918271;896.7982204004047;901.8376692195468;908.5321059654283;909.2180724576858;7526.285002924714;7530.962345188349;7540.0951885772965;7559.886601700979;8340.165983401612;696.7805141380449;704.3590332797232;711.6228398948566;715.1025463043951;720.8954701568348;5055.115354812893;5265.341832270966;5366;5382.381026181961;5453.4273901240595;20531;21903.233386831384;21907.890460547915;21913;21916;20599.588008239753;21536.892315538324;21537.67693484599;21548.35354939354;21658.783412165678;10816.56733730642;10965.671029869116;11027.338359698604;11035.227534072537;11054.557817687364;8773.736787896374;8785.736427907173;8787.648494060166;8806.031336553102;8810.823783524165;18160.091995399915;18179.636407272046;18257.360992365204;18275.45173644793;18379;18817.341393051178;18835.434936951915;18871.245150193838;19209.423717288504;19443.319483818563;10976.451177441255;11196;11210.159238057342;11214.046806021579;11216.55133794639;13784.241866697428;13961.092528985584;14006.649833754238;14169.36237869319;14236.64408389757;11000.22998390105;11036.5033573491;11352.375619341015;11391.772164556496;11441.141914356624;10353.74115647115;10410.583576656849;10426.27016108865;10428.374297542172;10631.362118272928;9721.076497732704;9938.254630902567;9979.351342162736;9984.450855202744;9985.1512621428;7588.696452141852;7650.846983060419;7683.500572462772;7689.961855149483;7695.4997925134685;7670.578118203553;7753.10839253493;7792.805179870548;7845.843083138191;7925.960370198112 03:11:45 INFO - PID 11801 | |4;prototype.html;481.4775968074639;517.4075683342572;519.1071357265507;524.2555571089054;526.7445289034819;6365.840853978653;6415.550911436196;6425.293217746044;6436.356364363562;6458.612483251009;6180.9911778671885;6243.375662433755;6304.486923138448;6329.873402531946;6356.745730170799;5125.359330083739;5148.2535032420465;5151.845444636649;5204.063268611649;5211.45279745627;5120.185461830941;5128.5640720538795;5156.510131537498;5163.767630456619;5206.557442617382;4905.215165573509;5022.17134172861;5114.3095682083;5123.692578445287;5170.819021334254;5021.422536408323;5041.294218809351;5076.461769115443;5082.23766435034;5086.008228395464;4483.3947417098925;4487.461504619467;4494.16857881293;4508.61676757476;4523.615492683126;6040.909386359164;6086.969565152146;6183.536234782409;6192.81421557354;6234.719437625317;5786.508146807527;5807.535397168216;5817.127430885359;5817.912731309034;5845.298564172284;6647.507184805698;6682.465402767767;6718.966405167943;6723.083921082468;6733.663316834188;4877.365942427497;4904.988954528626;4915.434725006634;4943;4955;6689.8662026759675;6706.631135287557;6717.56335838169;6823.863522729517;6909.27452617478;5052.646314757932;5055.545000949932;5067.6452648315;5080.898382032338;5083.652831999523;5076.36545431821;5115.053715062725;5131.692098474104;5142.254373115952;5153.273653326178;5710.2576665033275;5710.400407957188;5747.655140691572;5749.8275051748515;5755.1367294906095;6687.130673012574;6707.865842683216;6708.6981085850275;6721.361470660279;6739.191297044288;1768.2926829268395;1768.8142745011846;1772.97340539892;1778.34201345503;1787.2314904590892;1162.924409913353;1220.9389530523615;1228.3673907937418;1237.6101528018646;1237.672016915518;5724.25584673998;5725.828225153252;5744.396838331999;5771.797987070432;5774.88450230993;6738.494612903954;6749.763758268437;6752.932470675329;6814.386705196556;6822.644224283913;5681.630694004876;5721.284839395075;5730.6819431530985;5767.279090113736;5775.065353106672;3575.106223444139;3578.946315805265;3582.928341433209;3618.1958981789326;3633.1280492682095;6586.967065164644;6592.307807680125;6606.405423511907;6615.768448104293;6622.8344291393105;6461.935380646133;6608.7026083825385;6705;6970.860582788316;7017.964790210782;6426.550141490051;6472.773452929219;6475.676216189266;6514.511411644051;6519.608823470607;6759.966200168968;6783.21992970795;6786.574819288005;6812.863742725019;6816.7614133505085;6602.8349291268105;6630.867382652416;6692.899606506004;6706;6771.864562708817;6496.401439424268;6524.902126468011;6573.474122070127;6600.339966003361;6632.4694024478895;5052.368453943257;5064.898702026013;5068.59451243907;5079.187330027178;5090.796368145381;6459.418652321314;6674.16572928384;6700.430463410665;6799.524033317818;6800.455963522807;6389.8722025560155;6613.834654133685;6619.205695316593;6620.2386725527185;6632.2372927114;6567;6605.834854128685;6611.867762644816;6639.435647969976;6642.634655094016;6465.709043093166;6514.185726784152;6554;6556;6569.901451478136;6615.305392933865;6631.413748638131;6644.136262285871;6649.867002660017;6649.900251496135;6389.584676995981;6394.520410969103;6399;6439.842652711207;6464.191976003 03:11:45 INFO - PID 11801 | |5;yui.html;898.5148020069163;913.7167478081795;923.113810741688;927.8793756811614;930.9022552631974;19643.607127857453;21768;23627.527449451;24339.878300608518;24492.87753561234;21350.252741154025;21674;21828.45428864279;21940.232091876787;22104.668429973564;962.9181519570827;967.4533888353058;972.1445128287097;973.3624475968217;975.9658411955583;938.7090002099337;976.7558110472382;978.9706308810747;980.2060331131806;980.4117529482289;1006.8741407324085;1013.1034034879111;1013.4324778124274;1014.2342531388791;1014.2646581228587;1005.4671024357102;1010.7473131717071;1011.0142610954334;1013.6198925402974;1023.8515415264782;744.6611791634847;747.6299231880254;748.7978245873638;750.6321902267904;752.5033477904557;19378.418647440598;19793.10931008108;19874.503137421536;19889;20213.393598192077;21267.14931402742;21377;21838.89080554603;21862.672059919114;21912.561748764936;17844.732329015074;17845.286188552443;17908;18248.543786405313;18303.176357063963;3719.7396182267253;3829.1193025604266;3843.26977874203;3854.5374555053295;3856.8650097246464;137574;140972.77081687463;143142;144380;146239;16258.593535161479;16690.915090519076;16772.916135419488;16813.243404046847;16816.32734690623;30362.54456183159;31592.210194744857;31768.364632707217;31769;31884;7428.814279643052;8063.475874068166;9064.912210534647;9157.679481218125;9194.81610367789;4314.417553630283;4402.581754733359;4413.7351758894565;4422.447194100738;4426.84506042287;5188.688678679291;5201.739913004335;5266.868328291824;5300.946990530122;5327.520523152934;1093.6336327330434;1093.7156339351825;1102.2064113838023;1105.4362275239685;1105.4969988655143;677.8169894128557;707.4623286302344;709.5955305475829;715.6672147451357;721.2931327299276;11261.099112071015;11361.886381136248;11606.419679016015;11810.704732381759;12139.817902731465;648.1476857931899;666.247140730971;668.0880597983718;668.8963210702349;684.3703792510803;5017.724025178577;5039.949600504021;5137.897242055213;5147.382314122329;5165.173572228426;120859;123286;124508;128688;129210;104195;105050.47474762578;105140;106308.46845765722;106602.46698766612;93620.53189734007;95287;95953;97582.51208744053;97795.51102244444;9548.474833884204;9570.61717531291;9577.281703872099;9684.225261979165;9699.030096990527;41718.374224386054;41882;42781.66728255161;43381;44060;53202.73398632982;53433;53943.46056539384;54616.726916365165;55406.72296638491;14239.216843073731;14433.92783036078;14479.131252124906;14519.564413067625;14736.115833050051;15239.238038098272;15244.542663720105;15498.767518487457;15565.299561519532;15806.76289855676;14475;14582.635434114232;14623.561293161221;14644.560663180122;14737.11577305365;15127.470538531099;15261;15469.458568950484;15557;15698.921505392856;15112.848871511584;15200.771988420403;15323.846761532242;15501.767473487682;15527.068375897483;10612.257142000295;10846.349219046882;11025.779484410426;11107.555697771999;11115.166362522681;11391.715207119556;11515.424228788359;11535.134864885;11597.82603260935;11829.349385783864 03:11:45 INFO - PID 11801 | __end_tp_report 03:11:45 INFO - PID 11801 | __start_cc_report 03:11:45 INFO - PID 11801 | _x_x_mozilla_cycle_collect,378 03:11:45 INFO - PID 11801 | __end_cc_report 03:11:45 INFO - PID 11801 | __startTimestamp1505383905870__endTimestamp 03:11:45 INFO - PID 11801 | 03:11:45 INFO - PID 11801 | ------- Summary: start ------- 03:11:45 INFO - PID 11801 | Number of tests: 6 03:11:45 INFO - PID 11801 | 03:11:45 INFO - PID 11801 | [#0] dojo.html Cycles:165 Average:6337.85 Median:6592.60 stddev:802.54 (12.2%) stddev-sans-first:764.28 03:11:45 INFO - PID 11801 | Values: 3120.4 3186.4 3190.5 3202.3 3209.4 6319.7 6456.2 6462.9 6511.4 6565.2 6369.8 6404.3 6412.6 6461.3 6461.6 5898.0 5898.9 5925.2 5926.3 5954.6 5938.3 5983.6 5995.4 6019.9 6048.7 5940.9 5990.9 6032.0 6043.0 6044.3 5738.6 6015.9 6062.9 6071.1 6078.9 5714.4 5813.2 5823.9 5845.3 5992.0 6416.6 6462.3 6473.1 6555.5 6559.8 6693.0 6852.0 6926.7 6936.5 7031.0 6869.9 6915.6 6932.3 6936.4 6941.4 6285.8 6365.7 6373.4 6375.3 6391.0 7141.4 7179.1 7257.5 7264.3 7267.9 6797.5 6815.8 6839.0 6888.9 6910.1 6810.6 6859.9 6893.8 6951.0 7035.6 6912.0 6922.5 6927.2 6932.8 6938.2 6997.9 7006.2 7020.4 7026.1 7026.6 5213.7 5221.3 5282.8 5291.7 5310.0 4489.5 4523.7 4574.8 4578.9 4613.2 5902.9 5928.3 5931.1 5933.4 5959.6 6835.6 6994.5 7015.4 7016.5 7020.7 5851.0 5864.6 5936.9 5937.5 5937.6 5581.6 5665.0 5668.7 5674.4 5676.2 6587.1 6587.6 6592.6 6612.1 6646.0 6941.4 6987.2 7003.0 7011.8 7053.6 6622.7 6643.0 6709.8 6711.4 6755.3 6602.9 6793.6 6807.5 6826.8 6905.7 6862.1 6875.2 6931.2 6957.3 6972.7 6652.4 6767.3 6781.6 6828.8 6829.0 6751.0 6753.9 6818.0 6836.0 6844.7 6439.5 6641.5 6645.2 6754.1 6754.2 6635.5 6686.5 6706.1 6765.2 6850.1 6364.0 6499.3 6499.3 6570.2 6594.5 03:11:45 INFO - PID 11801 | 03:11:45 INFO - PID 11801 | [#1] ext.html Cycles:180 Average:37873.02 Median:3517.10 stddev:53082.26 (1509.3%) stddev-sans-first:53158.26 03:11:45 INFO - PID 11801 | Values: 822.3 834.0 859.1 879.3 882.4 41240.6 41714.8 41874.2 42245.8 42259.8 41923.4 42849.8 42879.0 42905.0 42933.0 7726.1 7836.0 7851.5 7852.2 7855.0 7775.8 7855.1 7873.4 7899.9 7900.7 7876.0 7894.1 7896.4 7909.0 7909.3 7825.3 7877.1 7886.8 7894.8 7911.8 7734.0 7803.5 7804.4 7806.0 7811.0 38112.4 38497.0 38524.8 38544.6 38609.2 3479.8 3512.5 3515.3 3515.8 3518.4 31553.5 31574.2 31639.8 31681.2 31713.4 5118.6 5264.3 5275.2 5306.5 5348.2 173805.0 174930.0 175206.0 175372.2 175834.0 46539.5 46695.5 46738.0 46917.0 48329.0 50472.5 50833.7 51082.7 51101.2 51131.5 16336.8 16366.0 16496.3 16519.2 16618.4 13483.3 13590.5 13604.3 13614.0 13629.6 14873.0 14912.1 14926.7 14996.6 15091.8 5884.6 5975.3 5996.7 6018.4 6023.1 1000.2 1011.3 1022.0 1022.7 1031.9 23394.1 23672.3 23728.6 23969.2 23989.6 1103.8 1117.5 1121.1 1121.7 1123.6 12785.9 12832.7 12909.2 12947.5 12990.7 225930.0 230186.0 230205.0 230277.0 230468.0 52506.7 54130.0 55658.7 58233.4 58263.8 1440.3 1465.4 1466.7 1471.1 1474.5 27050.6 27268.0 27491.0 27701.6 27793.7 39256.0 39651.6 39690.4 39708.2 39713.4 206542.0 206936.0 207450.0 207481.0 207510.0 34924.5 35706.6 36051.6 36188.5 36519.1 44058.0 44207.3 44426.3 44576.3 44676.0 32266.4 32451.4 32836.0 32854.5 32868.5 31737.8 32094.8 32216.8 32290.8 32451.2 34717.7 36200.0 36709.4 36801.4 36810.3 31499.2 31531.7 31682.0 31897.8 32346.5 22893.9 22951.7 23118.5 23152.7 23496.4 03:11:45 INFO - PID 11801 | 03:11:45 INFO - PID 11801 | [#2] jquery.html Cycles:180 Average:31551.88 Median:22245.67 stddev:71827.69 (322.9%) stddev-sans-first:71991.50 03:11:45 INFO - PID 11801 | Values: 560.1 560.7 562.0 566.1 580.1 22052.7 22876.8 22883.8 22901.7 22929.3 23517.5 24095.9 24469.8 24478.5 24621.6 6532.8 6763.8 6777.5 6780.8 6784.8 6640.0 6704.3 6712.4 6717.2 6743.8 6323.9 6639.4 6650.6 6653.6 6683.3 6583.2 6632.2 6639.2 6640.6 6646.0 5957.3 6120.7 6142.4 6146.8 6159.6 27251.0 27853.7 27898.4 27900.2 27904.0 2001.1 2017.5 2018.5 2018.8 2021.5 17809.4 18265.2 18490.6 18552.5 18561.5 2448.8 2459.0 2499.5 2506.2 2512.0 113169.4 116885.4 117949.0 123881.0 124391.4 14036.2 14281.4 14316.7 14551.9 14775.7 22125.2 22178.9 22182.6 22203.0 22205.1 9940.4 10093.8 10152.1 10213.2 10303.0 9503.7 9579.1 9594.6 9632.5 9726.2 8751.4 8813.9 8858.0 8867.1 9027.5 2587.2 2628.8 2642.3 2669.5 2745.1 953.0 974.4 977.3 994.3 997.7 18684.7 18703.4 19028.0 19135.8 19209.1 1000.4 1031.2 1038.0 1042.1 1045.4 9929.7 10401.8 10514.4 10832.5 10915.6 406057.0 422886.0 433111.0 434029.0 438468.0 101239.5 103007.0 104079.5 104546.0 104642.0 1143.9 1160.4 1170.2 1181.2 1181.7 16690.2 16791.9 17170.9 17381.4 17461.0 50781.0 51200.0 51212.7 51965.7 52258.7 64266.0 64491.7 64742.7 64813.4 66075.7 13917.9 13983.7 14199.1 14214.4 14351.1 22028.4 22145.7 22286.2 22321.1 22339.6 17623.9 17928.1 17977.6 18002.9 18020.1 15708.5 16085.2 16283.9 16330.1 16914.0 18439.4 18463.3 18476.3 18583.7 18590.6 13519.4 13981.2 14055.6 14067.7 14157.2 18258.2 18362.5 18382.6 18419.4 18421.4 03:11:45 INFO - PID 11801 | 03:11:45 INFO - PID 11801 | [#3] mootools.html Cycles:180 Average:9334.80 Median:2746.76 stddev:6587.35 (239.8%) stddev-sans-first:6578.26 03:11:45 INFO - PID 11801 | Values: 1314.6 1373.8 1385.3 1395.0 1399.0 14720.8 15323.1 15340.2 15341.6 15393.8 15211.3 15268.7 15269.4 15364.6 15378.5 2766.8 2785.1 2839.1 2840.8 2841.9 2741.6 2763.2 2774.5 2780.4 2785.3 2710.7 2732.2 2848.7 2850.9 2852.2 2715.9 2743.8 2755.6 2773.1 2785.3 2573.2 2749.7 2763.3 2763.6 2765.7 15524.4 15636.3 15684.9 15690.8 15694.5 8134.8 8388.9 8390.9 8396.7 8465.7 5349.8 5502.3 5562.5 5571.8 5620.9 1880.8 1888.4 1893.5 1940.3 1941.8 25560.6 25775.4 25809.0 25825.9 25840.5 6659.4 6848.2 6938.0 7003.9 7022.4 17121.0 17126.9 17138.6 17155.7 17257.3 7846.1 7933.3 7952.1 7969.3 8016.6 7259.7 7266.7 7321.6 7481.3 7485.7 5073.7 5201.9 5235.3 5244.8 5264.6 1577.8 1579.9 1580.9 1586.6 1600.3 882.8 896.8 901.8 908.5 909.2 7526.3 7531.0 7540.1 7559.9 8340.2 696.8 704.4 711.6 715.1 720.9 5055.1 5265.3 5366.0 5382.4 5453.4 20531.0 21903.2 21907.9 21913.0 21916.0 20599.6 21536.9 21537.7 21548.4 21658.8 10816.6 10965.7 11027.3 11035.2 11054.6 8773.7 8785.7 8787.6 8806.0 8810.8 18160.1 18179.6 18257.4 18275.5 18379.0 18817.3 18835.4 18871.2 19209.4 19443.3 10976.5 11196.0 11210.2 11214.0 11216.6 13784.2 13961.1 14006.6 14169.4 14236.6 11000.2 11036.5 11352.4 11391.8 11441.1 10353.7 10410.6 10426.3 10428.4 10631.4 9721.1 9938.3 9979.4 9984.5 9985.2 7588.7 7650.8 7683.5 7690.0 7695.5 7670.6 7753.1 7792.8 7845.8 7926.0 03:11:45 INFO - PID 11801 | 03:11:45 INFO - PID 11801 | [#4] prototype.html Cycles:180 Average:5567.27 Median:6239.05 stddev:1553.26 (24.9%) stddev-sans-first:1509.99 03:11:45 INFO - PID 11801 | Values: 481.5 517.4 519.1 524.3 526.7 6365.8 6415.6 6425.3 6436.4 6458.6 6181.0 6243.4 6304.5 6329.9 6356.7 5125.4 5148.3 5151.8 5204.1 5211.5 5120.2 5128.6 5156.5 5163.8 5206.6 4905.2 5022.2 5114.3 5123.7 5170.8 5021.4 5041.3 5076.5 5082.2 5086.0 4483.4 4487.5 4494.2 4508.6 4523.6 6040.9 6087.0 6183.5 6192.8 6234.7 5786.5 5807.5 5817.1 5817.9 5845.3 6647.5 6682.5 6719.0 6723.1 6733.7 4877.4 4905.0 4915.4 4943.0 4955.0 6689.9 6706.6 6717.6 6823.9 6909.3 5052.6 5055.5 5067.6 5080.9 5083.7 5076.4 5115.1 5131.7 5142.3 5153.3 5710.3 5710.4 5747.7 5749.8 5755.1 6687.1 6707.9 6708.7 6721.4 6739.2 1768.3 1768.8 1773.0 1778.3 1787.2 1162.9 1220.9 1228.4 1237.6 1237.7 5724.3 5725.8 5744.4 5771.8 5774.9 6738.5 6749.8 6752.9 6814.4 6822.6 5681.6 5721.3 5730.7 5767.3 5775.1 3575.1 3578.9 3582.9 3618.2 3633.1 6587.0 6592.3 6606.4 6615.8 6622.8 6461.9 6608.7 6705.0 6970.9 7018.0 6426.6 6472.8 6475.7 6514.5 6519.6 6760.0 6783.2 6786.6 6812.9 6816.8 6602.8 6630.9 6692.9 6706.0 6771.9 6496.4 6524.9 6573.5 6600.3 6632.5 5052.4 5064.9 5068.6 5079.2 5090.8 6459.4 6674.2 6700.4 6799.5 6800.5 6389.9 6613.8 6619.2 6620.2 6632.2 6567.0 6605.8 6611.9 6639.4 6642.6 6465.7 6514.2 6554.0 6556.0 6569.9 6615.3 6631.4 6644.1 6649.9 6649.9 6389.6 6394.5 6399.0 6439.8 6464.2 03:11:45 INFO - PID 11801 | 03:11:45 INFO - PID 11801 | [#5] yui.html Cycles:180 Average:24242.46 Median:21798.23 stddev:35536.05 (163.0%) stddev-sans-first:35592.50 03:11:45 INFO - PID 11801 | Values: 898.5 913.7 923.1 927.9 930.9 19643.6 21768.0 23627.5 24339.9 24492.9 21350.3 21674.0 21828.5 21940.2 22104.7 962.9 967.5 972.1 973.4 976.0 938.7 976.8 979.0 980.2 980.4 1006.9 1013.1 1013.4 1014.2 1014.3 1005.5 1010.7 1011.0 1013.6 1023.9 744.7 747.6 748.8 750.6 752.5 19378.4 19793.1 19874.5 19889.0 20213.4 21267.1 21377.0 21838.9 21862.7 21912.6 17844.7 17845.3 17908.0 18248.5 18303.2 3719.7 3829.1 3843.3 3854.5 3856.9 137574.0 140972.8 143142.0 144380.0 146239.0 16258.6 16690.9 16772.9 16813.2 16816.3 30362.5 31592.2 31768.4 31769.0 31884.0 7428.8 8063.5 9064.9 9157.7 9194.8 4314.4 4402.6 4413.7 4422.4 4426.8 5188.7 5201.7 5266.9 5300.9 5327.5 1093.6 1093.7 1102.2 1105.4 1105.5 677.8 707.5 709.6 715.7 721.3 11261.1 11361.9 11606.4 11810.7 12139.8 648.1 666.2 668.1 668.9 684.4 5017.7 5039.9 5137.9 5147.4 5165.2 120859.0 123286.0 124508.0 128688.0 129210.0 104195.0 105050.5 105140.0 106308.5 106602.5 93620.5 95287.0 95953.0 97582.5 97795.5 9548.5 9570.6 9577.3 9684.2 9699.0 41718.4 41882.0 42781.7 43381.0 44060.0 53202.7 53433.0 53943.5 54616.7 55406.7 14239.2 14433.9 14479.1 14519.6 14736.1 15239.2 15244.5 15498.8 15565.3 15806.8 14475.0 14582.6 14623.6 14644.6 14737.1 15127.5 15261.0 15469.5 15557.0 15698.9 15112.8 15200.8 15323.8 15501.8 15527.1 10612.3 10846.3 11025.8 11107.6 11115.2 11391.7 11515.4 11535.1 11597.8 11829.3 03:11:45 INFO - PID 11801 | -------- Summary: end -------- 03:11:45 INFO - PID 11801 | 03:11:46 INFO - TEST-INFO | 11801: exit 0 03:11:46 INFO - TEST-OK | dromaeo_css | took 1109450ms 03:11:46 INFO - TEST-START | kraken 03:11:46 INFO - Initialising browser for kraken test... 03:11:46 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55522/getInfo.html -profile /tmp/tmpxKkQ9p/profile 03:11:46 INFO - TEST-INFO | started process 12174 (/builds/slave/test/build/application/firefox/firefox http://localhost:55522/getInfo.html) 03:11:52 INFO - TEST-INFO | 12174: exit 0 03:11:52 INFO - Browser initialized. 03:11:52 INFO - Running cycle 1/1 for kraken test... 03:11:52 INFO - Using env: {'DISPLAY': ':0', 03:11:52 INFO - 'HOME': '/home/cltbld', 03:11:52 INFO - 'JSGC_DISABLE_POISONING': '1', 03:11:52 INFO - 'LANG': 'en_US.UTF-8', 03:11:52 INFO - 'LANGUAGE': 'en_US:en', 03:11:52 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:11:52 INFO - 'LOGNAME': 'cltbld', 03:11:52 INFO - 'MAIL': '/var/mail/cltbld', 03:11:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:11:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:11:52 INFO - 'MOZ_CRASHREPORTER': '1', 03:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:52 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:11:52 INFO - 'MOZ_NO_REMOTE': '1', 03:11:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:52 INFO - 'NO_EM_RESTART': '1', 03:11:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:52 INFO - 'PWD': '/builds/slave/test', 03:11:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:11:52 INFO - 'RUST_BACKTRACE': 'full', 03:11:52 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:11:52 INFO - 'SHELL': '/bin/bash', 03:11:52 INFO - 'SHLVL': '1', 03:11:52 INFO - 'TERM': 'linux', 03:11:52 INFO - 'TMOUT': '86400', 03:11:52 INFO - 'USER': 'cltbld', 03:11:52 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467', 03:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:52 INFO - '_': '/tools/buildbot/bin/python'} 03:11:52 INFO - TEST-INFO | started process 12406 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxKkQ9p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:11:53 INFO - PID 12406 | 03:11:53 INFO - PID 12406 | (/builds/slave/test/build/application/firefox/firefox:12455): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:11:53 INFO - PID 12406 | 03:12:03 INFO - PID 12406 | RSS: Main: 172883968 03:12:03 INFO - PID 12406 | 03:12:06 INFO - PID 12406 | Cycle 1(1): loaded http://localhost:55522/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55522/tests/kraken/driver.html?testName=audio-beat-detection) 03:12:07 INFO - PID 12406 | RSS: Main: 177451008 03:12:07 INFO - PID 12406 | 03:12:09 INFO - PID 12406 | Cycle 1(1): loaded http://localhost:55522/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55522/tests/kraken/driver.html?testName=audio-dft) 03:12:10 INFO - PID 12406 | RSS: Main: 177917952 03:12:10 INFO - PID 12406 | 03:12:13 INFO - PID 12406 | Cycle 1(1): loaded http://localhost:55522/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55522/tests/kraken/driver.html?testName=audio-fft) 03:12:14 INFO - PID 12406 | RSS: Main: 174006272 03:12:14 INFO - PID 12406 | 03:12:16 INFO - PID 12406 | Cycle 1(1): loaded http://localhost:55522/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55522/tests/kraken/driver.html?testName=audio-oscillator) 03:12:16 INFO - PID 12406 | RSS: Main: 174510080 03:12:16 INFO - PID 12406 | 03:12:18 INFO - PID 12406 | Cycle 1(1): loaded http://localhost:55522/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55522/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:12:19 INFO - PID 12406 | RSS: Main: 175288320 03:12:19 INFO - PID 12406 | 03:12:22 INFO - PID 12406 | Cycle 1(1): loaded http://localhost:55522/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55522/tests/kraken/driver.html?testName=imaging-darkroom) 03:12:23 INFO - PID 12406 | RSS: Main: 177516544 03:12:23 INFO - PID 12406 | 03:12:27 INFO - PID 12406 | Cycle 1(1): loaded http://localhost:55522/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55522/tests/kraken/driver.html?testName=imaging-desaturate) 03:12:27 INFO - PID 12406 | RSS: Main: 177315840 03:12:27 INFO - PID 12406 | 03:12:30 INFO - PID 12406 | Cycle 1(1): loaded http://localhost:55522/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55522/tests/kraken/driver.html?testName=json-parse-financial) 03:12:31 INFO - PID 12406 | RSS: Main: 177565696 03:12:31 INFO - PID 12406 | 03:12:32 INFO - PID 12406 | Cycle 1(1): loaded http://localhost:55522/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55522/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:12:33 INFO - PID 12406 | RSS: Main: 177819648 03:12:33 INFO - PID 12406 | 03:12:35 INFO - PID 12406 | Cycle 1(1): loaded http://localhost:55522/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55522/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:12:35 INFO - PID 12406 | RSS: Main: 178020352 03:12:35 INFO - PID 12406 | 03:12:38 INFO - PID 12406 | Cycle 1(1): loaded http://localhost:55522/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55522/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:12:38 INFO - PID 12406 | RSS: Main: 175521792 03:12:38 INFO - PID 12406 | 03:12:41 INFO - PID 12406 | Cycle 1(1): loaded http://localhost:55522/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55522/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:12:41 INFO - PID 12406 | RSS: Main: 175140864 03:12:41 INFO - PID 12406 | 03:12:44 INFO - PID 12406 | Cycle 1(1): loaded http://localhost:55522/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55522/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:12:45 INFO - PID 12406 | RSS: Main: 175370240 03:12:45 INFO - PID 12406 | 03:12:47 INFO - PID 12406 | Cycle 1(1): loaded http://localhost:55522/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55522/tests/kraken/driver.html?testName=ai-astar) 03:12:47 INFO - PID 12406 | RSS: Main: 176476160 03:12:47 INFO - PID 12406 | 03:12:47 INFO - PID 12406 | __start_tp_report 03:12:47 INFO - PID 12406 | _x_x_mozilla_page_load 03:12:47 INFO - PID 12406 | _x_x_mozilla_page_load_details 03:12:47 INFO - PID 12406 | |i|pagename|runs| 03:12:47 INFO - PID 12406 | |0;ai-astar;109;108;106;108;107;107;109;107;106;110 03:12:47 INFO - PID 12406 | |1;audio-beat-detection;121;121;125;115;115;127;119;113;116;116 03:12:47 INFO - PID 12406 | |2;audio-dft;163;161;162;164;162;163;165;163;165;162 03:12:47 INFO - PID 12406 | |3;audio-fft;73;75;74;75;83;75;73;74;103;74 03:12:47 INFO - PID 12406 | |4;audio-oscillator;79;81;79;79;79;78;79;79;80;80 03:12:47 INFO - PID 12406 | |5;imaging-gaussian-blur;114;114;114;114;113;111;113;114;114;117 03:12:47 INFO - PID 12406 | |6;imaging-darkroom;147;150;148;148;150;148;147;148;150;148 03:12:47 INFO - PID 12406 | |7;imaging-desaturate;94;94;94;94;94;94;94;93;94;94 03:12:47 INFO - PID 12406 | |8;json-parse-financial;53;53;55;58;56;55;56;57;53;54 03:12:47 INFO - PID 12406 | |9;json-stringify-tinderbox;38;38;38;38;39;38;40;41;38;38 03:12:47 INFO - PID 12406 | |10;stanford-crypto-aes;79;77;74;75;76;75;73;75;73;75 03:12:47 INFO - PID 12406 | |11;stanford-crypto-ccm;118;115;117;115;115;114;116;119;114;119 03:12:47 INFO - PID 12406 | |12;stanford-crypto-pbkdf2;170;172;169;170;172;167;172;178;166;167 03:12:47 INFO - PID 12406 | |13;stanford-crypto-sha256-iterative;71;69;74;65;65;64;66;63;63;65 03:12:47 INFO - PID 12406 | __end_tp_report 03:12:47 INFO - PID 12406 | __start_cc_report 03:12:47 INFO - PID 12406 | _x_x_mozilla_cycle_collect,933 03:12:47 INFO - PID 12406 | __end_cc_report 03:12:47 INFO - PID 12406 | __startTimestamp1505383967589__endTimestamp 03:12:47 INFO - PID 12406 | 03:12:47 INFO - PID 12406 | ------- Summary: start ------- 03:12:47 INFO - PID 12406 | Number of tests: 14 03:12:47 INFO - PID 12406 | 03:12:47 INFO - PID 12406 | [#0] ai-astar Cycles:10 Average:107.70 Median:108.00 stddev:1.34 (1.2%) stddev-sans-first:1.33 03:12:47 INFO - PID 12406 | Values: 109.0 108.0 106.0 108.0 107.0 107.0 109.0 107.0 106.0 110.0 03:12:47 INFO - PID 12406 | 03:12:47 INFO - PID 12406 | [#1] audio-beat-detection Cycles:10 Average:118.80 Median:120.00 stddev:4.64 (3.9%) stddev-sans-first:4.85 03:12:47 INFO - PID 12406 | Values: 121.0 121.0 125.0 115.0 115.0 127.0 119.0 113.0 116.0 116.0 03:12:47 INFO - PID 12406 | 03:12:47 INFO - PID 12406 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.33 (0.8%) stddev-sans-first:1.41 03:12:47 INFO - PID 12406 | Values: 163.0 161.0 162.0 164.0 162.0 163.0 165.0 163.0 165.0 162.0 03:12:47 INFO - PID 12406 | 03:12:47 INFO - PID 12406 | [#3] audio-fft Cycles:10 Average:77.90 Median:74.50 stddev:9.28 (12.5%) stddev-sans-first:9.67 03:12:47 INFO - PID 12406 | Values: 73.0 75.0 74.0 75.0 83.0 75.0 73.0 74.0 103.0 74.0 03:12:47 INFO - PID 12406 | 03:12:47 INFO - PID 12406 | [#4] audio-oscillator Cycles:10 Average:79.30 Median:79.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 03:12:47 INFO - PID 12406 | Values: 79.0 81.0 79.0 79.0 79.0 78.0 79.0 79.0 80.0 80.0 03:12:47 INFO - PID 12406 | 03:12:47 INFO - PID 12406 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:1.48 (1.3%) stddev-sans-first:1.56 03:12:47 INFO - PID 12406 | Values: 114.0 114.0 114.0 114.0 113.0 111.0 113.0 114.0 114.0 117.0 03:12:47 INFO - PID 12406 | 03:12:47 INFO - PID 12406 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.00 stddev:1.17 (0.8%) stddev-sans-first:1.13 03:12:47 INFO - PID 12406 | Values: 147.0 150.0 148.0 148.0 150.0 148.0 147.0 148.0 150.0 148.0 03:12:47 INFO - PID 12406 | 03:12:47 INFO - PID 12406 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:12:47 INFO - PID 12406 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 93.0 94.0 94.0 03:12:47 INFO - PID 12406 | 03:12:47 INFO - PID 12406 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.50 stddev:1.76 (3.2%) stddev-sans-first:1.72 03:12:47 INFO - PID 12406 | Values: 53.0 53.0 55.0 58.0 56.0 55.0 56.0 57.0 53.0 54.0 03:12:47 INFO - PID 12406 | 03:12:47 INFO - PID 12406 | [#9] json-stringify-tinderbox Cycles:10 Average:38.60 Median:38.00 stddev:1.07 (2.8%) stddev-sans-first:1.12 03:12:47 INFO - PID 12406 | Values: 38.0 38.0 38.0 38.0 39.0 38.0 40.0 41.0 38.0 38.0 03:12:47 INFO - PID 12406 | 03:12:47 INFO - PID 12406 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:75.00 stddev:1.81 (2.4%) stddev-sans-first:1.30 03:12:47 INFO - PID 12406 | Values: 79.0 77.0 74.0 75.0 76.0 75.0 73.0 75.0 73.0 75.0 03:12:47 INFO - PID 12406 | 03:12:47 INFO - PID 12406 | [#11] stanford-crypto-ccm Cycles:10 Average:116.20 Median:116.50 stddev:1.93 (1.7%) stddev-sans-first:1.94 03:12:47 INFO - PID 12406 | Values: 118.0 115.0 117.0 115.0 115.0 114.0 116.0 119.0 114.0 119.0 03:12:47 INFO - PID 12406 | 03:12:47 INFO - PID 12406 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.30 Median:171.00 stddev:3.50 (2.0%) stddev-sans-first:3.71 03:12:47 INFO - PID 12406 | Values: 170.0 172.0 169.0 170.0 172.0 167.0 172.0 178.0 166.0 167.0 03:12:47 INFO - PID 12406 | 03:12:47 INFO - PID 12406 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:65.50 stddev:3.66 (5.6%) stddev-sans-first:3.50 03:12:47 INFO - PID 12406 | Values: 71.0 69.0 74.0 65.0 65.0 64.0 66.0 63.0 63.0 65.0 03:12:47 INFO - PID 12406 | -------- Summary: end -------- 03:12:47 INFO - PID 12406 | 03:12:47 INFO - PID 12406 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:12:48 INFO - TEST-INFO | 12406: exit 0 03:12:48 INFO - TEST-OK | kraken | took 61692ms 03:12:48 INFO - SUITE-END | took 1171s 03:12:48 INFO - Completed test suite (00:19:31) 03:12:48 INFO - javascript benchmark 03:12:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8527.567405873524, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3120.4071226466967, 3186.4264432402174, 3190.5214217867315, 3202.263479399738, 3209.438348289049, 6319.652419116958, 6456.225252969644, 6462.903056454151, 6511.38141876521, 6565.244996825367, 6369.840753981152, 6404.295527491972, 6412.583182093173, 6461.321561236073, 6461.579997300172, 5898.026825573786, 5898.941010589903, 5925.20009798676, 5926.288845338566, 5954.583179177459, 5938.257717785277, 5983.6409815411, 5995.370486098962, 6019.879602407949, 6048.727807248662, 5940.910886336686, 5990.9101363479585, 6031.969840150793, 6042.969785151068, 6044.304904935944, 5738.626989245686, 6015.909761353583, 6062.9090563641585, 6071.0589858571775, 6078.878422431527, 5714.371419143891, 5813.157092221646, 5823.854403639901, 5845.298564172326, 5992.0, 6416.582922110095, 6462.25684046336, 6473.093766872642, 6555.508336874754, 6559.836004099888, 6692.966535167342, 6852.0, 6926.722931082751, 6936.514443988923, 7030.964845175741, 6869.862602747917, 6915.585064896122, 6932.272111428278, 6936.445084393236, 6941.375276225113, 6285.779997700059, 6365.745370185187, 6373.42639162473, 6375.330590287999, 6391.0, 7141.428685705131, 7179.066721326299, 7257.49197556166, 7264.34620884123, 7267.854642907112, 6797.4901882358035, 6815.761448349284, 6839.0, 6888.896666550006, 6910.136232970879, 6810.557313774589, 6859.9314006859295, 6893.7931862044215, 6950.965245173742, 7035.6482175891, 6912.032315475837, 6922.5154239203775, 6927.238003819576, 6932.826679332956, 6938.202106757787, 6997.895031574531, 7006.229314775371, 7020.368166865007, 7026.1217347831525, 7026.613536255452, 5213.661112027706, 5221.269022336875, 5282.841514754564, 5291.735413229323, 5309.973450132725, 4489.483709373399, 4523.705959112647, 4574.794134263966, 4578.88552786183, 4613.169629466728, 5902.940970590239, 5928.347881733006, 5931.08068249422, 5933.406659334032, 5959.612625179349, 6835.58986460814, 6994.475414343945, 7015.438764898898, 7016.473764467685, 7020.719171233196, 5851.005329094064, 5864.589478736448, 5936.881262374728, 5937.52499800015, 5937.614055086406, 5581.581381396411, 5665.0, 5668.744906479218, 5674.432556744375, 5676.205331253628, 6587.143671322698, 6587.604743715392, 6592.604443733391, 6612.07430959666, 6646.036324732887, 6941.375276225164, 6987.161540615159, 7003.019577259188, 7011.754588589579, 7053.647317633995, 6622.668866556556, 6643.036759669917, 6709.832254193684, 6711.395974362135, 6755.290694477206, 6602.900956485752, 6793.626350550767, 6807.455403567604, 6826.829329266808, 6905.723771049102, 6862.107925969592, 6875.1749790025515, 6931.2375638678695, 6957.339052789976, 6972.7210911565, 6652.434543063894, 6767.289434609492, 6781.593104413751, 6828.760993365408, 6828.9658551706925, 6751.0, 6753.864922701617, 6818.0, 6836.0, 6844.691988860413, 6439.484841212786, 6641.50188735837, 6645.202575690948, 6754.0881980931945, 6754.18949726036, 6635.535512514078, 6686.465082793462, 6706.128203333536, 6765.188177418741, 6850.143732033496, 6364.013577895434, 6499.28507864144, 6499.3175716549085, 6570.211574610886, 6594.505412094208], "value": 6273.430119747179, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [822.2681813186261, 833.9666413343466, 859.0593300336132, 879.3492815316667, 882.4484697064335, 41240.58759412405, 41714.7914260429, 41874.162516749726, 42245.78877105614, 42259.78870105649, 41923.37114943271, 42849.7857510712, 42879.0, 42905.0, 42933.0, 7726.111497177841, 7836.02049743782, 7851.528908265523, 7852.21477852216, 7855.0, 7775.8056048598955, 7855.096663883669, 7873.409494287923, 7899.881501777478, 7900.723474678387, 7875.96062019692, 7894.092179399357, 7896.368290536772, 7908.960455197716, 7909.327707144899, 7825.25660062296, 7877.094134174557, 7886.763397098096, 7894.842103157905, 7911.802204944865, 7734.0, 7803.453758236926, 7804.3756499479905, 7805.9609701951695, 7810.960945195237, 38112.42831357532, 38497.0, 38524.807375963224, 38544.614553854386, 38609.22781544353, 3479.7564170508076, 3512.525809015776, 3515.34966031285, 3515.84178711956, 3518.36669399508, 31553.52669709956, 31574.210644733837, 31639.84180079108, 31681.207969800707, 31713.365732685448, 5118.564921981636, 5264.341957255343, 5275.155975044013, 5306.495882891119, 5348.171033489815, 173805.0, 174930.0, 175206.0, 175372.24627753688, 175834.0, 46539.534604654196, 46695.5330446698, 46738.0, 46917.0, 48329.0, 50472.49527504678, 50833.74583127061, 51082.74458627683, 51101.23348149781, 51131.48868511267, 16336.75494867578, 16366.0, 16496.34014639425, 16519.174041298127, 16618.418355357506, 13483.325833708275, 13590.524331648345, 13604.251766152956, 13614.0, 13629.591112266648, 14873.0, 14912.105273683614, 14926.70146597062, 14996.550103496913, 15091.773623395658, 5884.588078834526, 5975.25309336333, 5996.67018313997, 6018.428249316308, 6023.06642470409, 1000.2398177385094, 1011.3426272922512, 1021.9693409197736, 1022.6983040003217, 1031.886492485826, 23394.06423743065, 23672.28983130509, 23728.644070338614, 23969.161079362486, 23989.640155397683, 1103.773726386089, 1117.4636174636057, 1121.058311018748, 1121.6915348279126, 1123.646051493777, 12785.936070319774, 12832.743345133045, 12909.166932144048, 12947.5468358607, 12990.740185196242, 225930.0, 230186.0, 230205.0, 230277.0, 230468.0, 52506.73746631242, 54130.0, 55658.72170639121, 58233.4176658228, 58263.75626193663, 1440.2870579063222, 1465.377214683755, 1466.7286551987916, 1471.1099784630144, 1474.4913005013252, 27050.594241086004, 27268.0, 27491.0, 27701.584476233274, 27793.722062779114, 39256.0, 39651.60348396595, 39690.40464393094, 39708.205835883695, 39713.40429893496, 206542.0, 206936.0, 207450.0, 207481.0, 207510.0, 34924.47613285854, 35706.64293357033, 36051.63948360483, 36188.4571731419, 36519.08702282464, 44058.0, 44207.33688994732, 44426.333604996595, 44576.33135503035, 44676.0, 32266.35467290688, 32451.35097298088, 32836.0, 32854.507182391804, 32868.50697239496, 31737.841310793297, 32094.83952580222, 32216.83891580527, 32290.83854580806, 32451.18872028218, 34717.65282347144, 36200.0, 36709.44935826018, 36801.447978279815, 36810.263794724495, 31499.212519687193, 31531.684683152875, 31682.0, 31897.840510797298, 32346.514802278456, 22893.88553057224, 22951.737654429166, 23118.537629246985, 23152.652710209022, 23496.41258968471], "value": 17502.7354929098, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.1094260126398, 560.6944215402605, 561.9719014049297, 566.1394680086269, 580.0747807247441, 22052.669209961845, 22876.771232287672, 22883.771162288373, 22901.656475152886, 22929.312120636365, 23517.529649407003, 24095.87952060237, 24469.75530244697, 24478.510429791393, 24621.630675539836, 6532.836679083025, 6763.797086087426, 6777.491688123386, 6780.7965761027, 6784.762533311335, 6640.0, 6704.2625311215725, 6712.362325579086, 6717.227518835348, 6743.797686069426, 6323.9051414228825, 6639.402453779159, 6650.634215118166, 6653.567518111331, 6683.331666833326, 6583.242927063401, 6632.1709786276715, 6639.170103737033, 6640.634765087918, 6646.036324732935, 5957.344692083867, 6120.724567394478, 6142.385761423822, 6146.815595532141, 6159.630422174684, 27251.0, 27853.721462785314, 27898.442031159466, 27900.16299511018, 27904.0, 2001.1495114576246, 2017.505711100775, 2018.535736780534, 2018.7678416982087, 2021.5047313408309, 17809.376671816553, 18265.178066987017, 18490.63018739618, 18552.53618659531, 18561.535961600934, 2448.755124487555, 2458.963115553268, 2499.52509023285, 2506.1604362538574, 2512.0203120782908, 113169.43415282953, 116885.41557292244, 117949.0, 123881.0, 124391.3780431101, 14036.228007459484, 14281.357338919774, 14316.713665726835, 14551.92724036373, 14775.70448591022, 22125.225617103646, 22178.889105554368, 22182.559918408962, 22203.0, 22205.111795528323, 9940.403575785476, 10093.798124037477, 10152.086312231935, 10213.234007449471, 10303.0, 9503.66737164196, 9579.13787759105, 9594.568244429018, 9632.518374081408, 9726.17327527154, 8751.431156974777, 8813.867791983126, 8857.955710221408, 8867.113288671211, 9027.548622568846, 2587.197968629731, 2628.8332992207565, 2642.312998620334, 2669.4927963686837, 2745.1078399520234, 952.9857052144223, 974.4056125763278, 977.3305285879195, 994.2642444591095, 997.6907158780801, 18684.692071554862, 18703.438896833115, 19028.0, 19135.8086419134, 19209.135588898534, 1000.4147573669339, 1031.1544533482472, 1037.972407316751, 1042.0725554256717, 1045.3571053801857, 9929.652462163935, 10401.791964160675, 10514.3691378516, 10832.458377081115, 10915.617953371593, 406057.0, 422886.0, 433111.0, 434029.0, 438468.0, 101239.49380253052, 103007.0, 104079.4796026015, 104546.0, 104642.0, 1143.891330323618, 1160.4023927677422, 1170.2334970594275, 1181.2499063094997, 1181.6632259805915, 16690.24893879754, 16791.908525945775, 17170.914145429193, 17381.391651292142, 17461.0, 50781.0, 51200.0, 51212.74393628008, 51965.7401712989, 52258.73870630623, 64266.0, 64491.67754161199, 64742.67628661827, 64813.351866480734, 66075.6696216535, 13917.886569074248, 13983.720325593635, 14199.077059991068, 14214.431422742975, 14351.138931664134, 22028.449288767908, 22145.667814982466, 22286.219982300543, 22321.10715571359, 22339.553208936057, 17623.911880440515, 17928.103594820466, 17977.561795056627, 18002.909985449987, 18020.09899505046, 15708.528744137695, 16085.195740212708, 16283.918580407022, 16330.101844398672, 16914.0, 18439.446816595522, 18463.261469541605, 18476.260949561867, 18583.72124418162, 18590.628187436447, 13519.391627376595, 13981.161130332213, 14055.648608784863, 14067.718645627236, 14157.221352825694, 18258.17838197258, 18362.540936476697, 18382.632347353247, 18419.447416577525, 18421.355252566096], "value": 11610.200544171172, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.6056183145056, 1373.7664597018506, 1385.3419625677811, 1394.9930250348746, 1398.9860101398986, 14720.77918831217, 15323.080615163084, 15340.156291403968, 15341.616459588517, 15393.769093463607, 15211.315490802912, 15268.694626107499, 15269.389224431037, 15364.61588460289, 15378.461753838617, 2766.7648249898784, 2785.0670025541417, 2839.148255523345, 2840.7727381809405, 2841.872115754796, 2741.643586333784, 2763.198672385006, 2774.4867199568143, 2780.3605170810624, 2785.3454438207104, 2710.715374885638, 2732.221316924677, 2848.743613074823, 2850.9287267818368, 2852.1871266689, 2715.8642067896526, 2743.82165159266, 2755.600437936498, 2773.1126039667415, 2785.261905595019, 2573.189445324717, 2749.6975332713387, 2763.3367991681853, 2763.571646394812, 2765.7096004919395, 15524.379024838992, 15636.296366663528, 15684.921575392164, 15690.76463853043, 15694.529164125095, 8134.837303253902, 8388.8741668875, 8390.874136887951, 8396.664133434655, 8465.746027619181, 5349.786008559653, 5502.339719233678, 5562.471565201299, 5571.832845014656, 5620.887582248373, 1880.8119188081218, 1888.376835644234, 1893.469828448023, 1940.3014914630721, 1941.7572803399576, 25560.616590751153, 25775.35561610956, 25809.0, 25825.870870645525, 25840.483190336276, 6659.433948114464, 6848.212455567674, 6938.0, 7003.8599228015155, 7022.438204943593, 17121.0, 17126.914365428092, 17138.571535711708, 17155.742663860052, 17257.309707611807, 7846.136924938252, 7933.286004259528, 7952.085510166405, 7969.322607578305, 8016.599170041474, 7259.673314700851, 7266.672999715025, 7321.597312147776, 7481.326680598772, 7485.737999170003, 5073.695578265316, 5201.895962080737, 5235.345581802275, 5244.790208391698, 5264.6051546134195, 1577.7948866647262, 1579.9052056876624, 1580.905145691239, 1586.643005323793, 1600.2638786158498, 882.8013696918271, 896.7982204004047, 901.8376692195468, 908.5321059654283, 909.2180724576858, 7526.285002924714, 7530.962345188349, 7540.0951885772965, 7559.886601700979, 8340.165983401612, 696.7805141380449, 704.3590332797232, 711.6228398948566, 715.1025463043951, 720.8954701568348, 5055.115354812893, 5265.341832270966, 5366.0, 5382.381026181961, 5453.4273901240595, 20531.0, 21903.233386831384, 21907.890460547915, 21913.0, 21916.0, 20599.588008239753, 21536.892315538324, 21537.67693484599, 21548.35354939354, 21658.783412165678, 10816.56733730642, 10965.671029869116, 11027.338359698604, 11035.227534072537, 11054.557817687364, 8773.736787896374, 8785.736427907173, 8787.648494060166, 8806.031336553102, 8810.823783524165, 18160.091995399915, 18179.636407272046, 18257.360992365204, 18275.45173644793, 18379.0, 18817.341393051178, 18835.434936951915, 18871.245150193838, 19209.423717288504, 19443.319483818563, 10976.451177441255, 11196.0, 11210.159238057342, 11214.046806021579, 11216.55133794639, 13784.241866697428, 13961.092528985584, 14006.649833754238, 14169.36237869319, 14236.64408389757, 11000.22998390105, 11036.5033573491, 11352.375619341015, 11391.772164556496, 11441.141914356624, 10353.74115647115, 10410.583576656849, 10426.27016108865, 10428.374297542172, 10631.362118272928, 9721.076497732704, 9938.254630902567, 9979.351342162736, 9984.450855202744, 9985.1512621428, 7588.696452141852, 7650.846983060419, 7683.500572462772, 7689.961855149483, 7695.4997925134685, 7670.578118203553, 7753.10839253493, 7792.805179870548, 7845.843083138191, 7925.960370198112], "value": 6671.434419778822, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [481.4775968074639, 517.4075683342572, 519.1071357265507, 524.2555571089054, 526.7445289034819, 6365.840853978653, 6415.550911436196, 6425.293217746044, 6436.356364363562, 6458.612483251009, 6180.9911778671885, 6243.375662433755, 6304.486923138448, 6329.873402531946, 6356.745730170799, 5125.359330083739, 5148.2535032420465, 5151.845444636649, 5204.063268611649, 5211.45279745627, 5120.185461830941, 5128.5640720538795, 5156.510131537498, 5163.767630456619, 5206.557442617382, 4905.215165573509, 5022.17134172861, 5114.3095682083, 5123.692578445287, 5170.819021334254, 5021.422536408323, 5041.294218809351, 5076.461769115443, 5082.23766435034, 5086.008228395464, 4483.3947417098925, 4487.461504619467, 4494.16857881293, 4508.61676757476, 4523.615492683126, 6040.909386359164, 6086.969565152146, 6183.536234782409, 6192.81421557354, 6234.719437625317, 5786.508146807527, 5807.535397168216, 5817.127430885359, 5817.912731309034, 5845.298564172284, 6647.507184805698, 6682.465402767767, 6718.966405167943, 6723.083921082468, 6733.663316834188, 4877.365942427497, 4904.988954528626, 4915.434725006634, 4943.0, 4955.0, 6689.8662026759675, 6706.631135287557, 6717.56335838169, 6823.863522729517, 6909.27452617478, 5052.646314757932, 5055.545000949932, 5067.6452648315, 5080.898382032338, 5083.652831999523, 5076.36545431821, 5115.053715062725, 5131.692098474104, 5142.254373115952, 5153.273653326178, 5710.2576665033275, 5710.400407957188, 5747.655140691572, 5749.8275051748515, 5755.1367294906095, 6687.130673012574, 6707.865842683216, 6708.6981085850275, 6721.361470660279, 6739.191297044288, 1768.2926829268395, 1768.8142745011846, 1772.97340539892, 1778.34201345503, 1787.2314904590892, 1162.924409913353, 1220.9389530523615, 1228.3673907937418, 1237.6101528018646, 1237.672016915518, 5724.25584673998, 5725.828225153252, 5744.396838331999, 5771.797987070432, 5774.88450230993, 6738.494612903954, 6749.763758268437, 6752.932470675329, 6814.386705196556, 6822.644224283913, 5681.630694004876, 5721.284839395075, 5730.6819431530985, 5767.279090113736, 5775.065353106672, 3575.106223444139, 3578.946315805265, 3582.928341433209, 3618.1958981789326, 3633.1280492682095, 6586.967065164644, 6592.307807680125, 6606.405423511907, 6615.768448104293, 6622.8344291393105, 6461.935380646133, 6608.7026083825385, 6705.0, 6970.860582788316, 7017.964790210782, 6426.550141490051, 6472.773452929219, 6475.676216189266, 6514.511411644051, 6519.608823470607, 6759.966200168968, 6783.21992970795, 6786.574819288005, 6812.863742725019, 6816.7614133505085, 6602.8349291268105, 6630.867382652416, 6692.899606506004, 6706.0, 6771.864562708817, 6496.401439424268, 6524.902126468011, 6573.474122070127, 6600.339966003361, 6632.4694024478895, 5052.368453943257, 5064.898702026013, 5068.59451243907, 5079.187330027178, 5090.796368145381, 6459.418652321314, 6674.16572928384, 6700.430463410665, 6799.524033317818, 6800.455963522807, 6389.8722025560155, 6613.834654133685, 6619.205695316593, 6620.2386725527185, 6632.2372927114, 6567.0, 6605.834854128685, 6611.867762644816, 6639.435647969976, 6642.634655094016, 6465.709043093166, 6514.185726784152, 6554.0, 6556.0, 6569.901451478136, 6615.305392933865, 6631.413748638131, 6644.136262285871, 6649.867002660017, 6649.900251496135, 6389.584676995981, 6394.520410969103, 6399.0, 6439.842652711207, 6464.191976003], "value": 5107.2846641577935, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [898.5148020069163, 913.7167478081795, 923.113810741688, 927.8793756811614, 930.9022552631974, 19643.607127857453, 21768.0, 23627.527449451, 24339.878300608518, 24492.87753561234, 21350.252741154025, 21674.0, 21828.45428864279, 21940.232091876787, 22104.668429973564, 962.9181519570827, 967.4533888353058, 972.1445128287097, 973.3624475968217, 975.9658411955583, 938.7090002099337, 976.7558110472382, 978.9706308810747, 980.2060331131806, 980.4117529482289, 1006.8741407324085, 1013.1034034879111, 1013.4324778124274, 1014.2342531388791, 1014.2646581228587, 1005.4671024357102, 1010.7473131717071, 1011.0142610954334, 1013.6198925402974, 1023.8515415264782, 744.6611791634847, 747.6299231880254, 748.7978245873638, 750.6321902267904, 752.5033477904557, 19378.418647440598, 19793.10931008108, 19874.503137421536, 19889.0, 20213.393598192077, 21267.14931402742, 21377.0, 21838.89080554603, 21862.672059919114, 21912.561748764936, 17844.732329015074, 17845.286188552443, 17908.0, 18248.543786405313, 18303.176357063963, 3719.7396182267253, 3829.1193025604266, 3843.26977874203, 3854.5374555053295, 3856.8650097246464, 137574.0, 140972.77081687463, 143142.0, 144380.0, 146239.0, 16258.593535161479, 16690.915090519076, 16772.916135419488, 16813.243404046847, 16816.32734690623, 30362.54456183159, 31592.210194744857, 31768.364632707217, 31769.0, 31884.0, 7428.814279643052, 8063.475874068166, 9064.912210534647, 9157.679481218125, 9194.81610367789, 4314.417553630283, 4402.581754733359, 4413.7351758894565, 4422.447194100738, 4426.84506042287, 5188.688678679291, 5201.739913004335, 5266.868328291824, 5300.946990530122, 5327.520523152934, 1093.6336327330434, 1093.7156339351825, 1102.2064113838023, 1105.4362275239685, 1105.4969988655143, 677.8169894128557, 707.4623286302344, 709.5955305475829, 715.6672147451357, 721.2931327299276, 11261.099112071015, 11361.886381136248, 11606.419679016015, 11810.704732381759, 12139.817902731465, 648.1476857931899, 666.247140730971, 668.0880597983718, 668.8963210702349, 684.3703792510803, 5017.724025178577, 5039.949600504021, 5137.897242055213, 5147.382314122329, 5165.173572228426, 120859.0, 123286.0, 124508.0, 128688.0, 129210.0, 104195.0, 105050.47474762578, 105140.0, 106308.46845765722, 106602.46698766612, 93620.53189734007, 95287.0, 95953.0, 97582.51208744053, 97795.51102244444, 9548.474833884204, 9570.61717531291, 9577.281703872099, 9684.225261979165, 9699.030096990527, 41718.374224386054, 41882.0, 42781.66728255161, 43381.0, 44060.0, 53202.73398632982, 53433.0, 53943.46056539384, 54616.726916365165, 55406.72296638491, 14239.216843073731, 14433.92783036078, 14479.131252124906, 14519.564413067625, 14736.115833050051, 15239.238038098272, 15244.542663720105, 15498.767518487457, 15565.299561519532, 15806.76289855676, 14475.0, 14582.635434114232, 14623.561293161221, 14644.560663180122, 14737.11577305365, 15127.470538531099, 15261.0, 15469.458568950484, 15557.0, 15698.921505392856, 15112.848871511584, 15200.771988420403, 15323.846761532242, 15501.767473487682, 15527.068375897483, 10612.257142000295, 10846.349219046882, 11025.779484410426, 11107.555697771999, 11115.166362522681, 11391.715207119556, 11515.424228788359, 11535.134864885, 11597.82603260935, 11829.349385783864], "value": 8852.49931668969, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1424.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 108.0, 106.0, 108.0, 107.0, 107.0, 109.0, 107.0, 106.0, 110.0], "value": 107.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 121.0, 125.0, 115.0, 115.0, 127.0, 119.0, 113.0, 116.0, 116.0], "value": 118.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 164.0, 162.0, 163.0, 165.0, 163.0, 165.0, 162.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 74.0, 75.0, 83.0, 75.0, 73.0, 74.0, 103.0, 74.0], "value": 77.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 79.0, 79.0, 79.0, 78.0, 79.0, 79.0, 80.0, 80.0], "value": 79.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 111.0, 113.0, 114.0, 114.0, 117.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 150.0, 148.0, 148.0, 150.0, 148.0, 147.0, 148.0, 150.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 55.0, 58.0, 56.0, 55.0, 56.0, 57.0, 53.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 39.0, 38.0, 40.0, 41.0, 38.0, 38.0], "value": 38.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 74.0, 75.0, 76.0, 75.0, 73.0, 75.0, 73.0, 75.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 115.0, 117.0, 115.0, 115.0, 114.0, 116.0, 119.0, 114.0, 119.0], "value": 116.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 172.0, 169.0, 170.0, 172.0, 167.0, 172.0, 178.0, 166.0, 167.0], "value": 170.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 74.0, 65.0, 65.0, 64.0, 66.0, 63.0, 63.0, 65.0], "value": 66.5, "unit": "score"}]}]} 03:12:48 INFO - Return code: 0 03:12:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:12:48 INFO - # TBPL SUCCESS # 03:12:48 INFO - Running post-action listener: _package_coverage_data 03:12:48 INFO - Running post-action listener: _resource_record_post_action 03:12:48 INFO - [mozharness: 2017-09-14 10:12:48.891973Z] Finished run-tests step (success) 03:12:48 INFO - Running post-run listener: _resource_record_post_run 03:12:48 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 925696; Write bytes: 397344768; Read time: 976; Write time: 465680 03:12:48 INFO - TinderboxPrint: CPU usage
13.1% 03:12:48 INFO - TinderboxPrint: I/O read bytes / time
925,696 / 976 03:12:48 INFO - TinderboxPrint: I/O write bytes / time
397,344,768 / 465,680 03:12:48 INFO - TinderboxPrint: CPU idle
8,241.6 (86.9%) 03:12:48 INFO - TinderboxPrint: CPU user
1,193.9 (12.6%) 03:12:48 INFO - TinderboxPrint: Swap in / out
0 / 0 03:12:48 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 74383360; Read time: 352; Write time: 73400 03:12:48 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:12:48 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 917504; Write bytes: 322961408; Read time: 608; Write time: 392280 03:12:49 INFO - Running post-run listener: _upload_blobber_files 03:12:49 INFO - Blob upload gear active. 03:12:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:12:49 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 03:12:49 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'] 03:12:49 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 03:12:49 INFO - (blobuploader) - INFO - Open directory for files ... 03:12:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:12:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:12:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:12:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:12:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:12:51 INFO - (blobuploader) - INFO - Done attempting. 03:12:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:12:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:12:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:12:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:12:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:12:52 INFO - (blobuploader) - INFO - Done attempting. 03:12:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:12:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:12:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:12:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:12:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:12:57 INFO - (blobuploader) - INFO - Done attempting. 03:12:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:12:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:12:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:12:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:12:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:12:58 INFO - (blobuploader) - INFO - Done attempting. 03:12:58 INFO - (blobuploader) - INFO - Iteration through files over. 03:12:59 INFO - Return code: 0 03:12:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:12:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:12:59 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/91764819d3195a6f229b448c3996d0efe5cc663f739cb589bf31cf0ab8b950c7839bb2a449f6b390f0172f146dc8cc6ec2620b47b89e08204df70073e21aaf38", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/73745d3dc043abd3db63bf24497b8af0e62526a4a5a6acaabaa571378756318bd5a00331dc2ee52c82173c0200ea0549d59c37e1f384db295e813c3d6a0ef612", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/39e06f0f5c189146d6b6f46a886c0f23aca1c31b7261a7c575075b9ba1d087745542d0af0a781d8a763cb08cc0768ab11d39a80154fc9a1d0fe2b7f6b4f8f99f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d53a843929e0d478fbfd410ebc40b7190d832ef04e05a00a7d5408cd7985cdfd1370741744e53bdfca7214fc868f70869746fdb8b8abad820c3be035c4dd9483"} 03:12:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:12:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:12:59 INFO - Contents: 03:12:59 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/91764819d3195a6f229b448c3996d0efe5cc663f739cb589bf31cf0ab8b950c7839bb2a449f6b390f0172f146dc8cc6ec2620b47b89e08204df70073e21aaf38", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/73745d3dc043abd3db63bf24497b8af0e62526a4a5a6acaabaa571378756318bd5a00331dc2ee52c82173c0200ea0549d59c37e1f384db295e813c3d6a0ef612", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/39e06f0f5c189146d6b6f46a886c0f23aca1c31b7261a7c575075b9ba1d087745542d0af0a781d8a763cb08cc0768ab11d39a80154fc9a1d0fe2b7f6b4f8f99f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d53a843929e0d478fbfd410ebc40b7190d832ef04e05a00a7d5408cd7985cdfd1370741744e53bdfca7214fc868f70869746fdb8b8abad820c3be035c4dd9483"} 03:12:59 INFO - Running post-run listener: copy_logs_to_upload_dir 03:12:59 INFO - Copying logs to upload dir... 03:12:59 INFO - mkdir: /builds/slave/test/build/upload/logs 03:12:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.458771 ========= master_lag: 0.23 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-14 03:12:59.110410) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 03:12:59.118679) ========= 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=836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/91764819d3195a6f229b448c3996d0efe5cc663f739cb589bf31cf0ab8b950c7839bb2a449f6b390f0172f146dc8cc6ec2620b47b89e08204df70073e21aaf38", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/73745d3dc043abd3db63bf24497b8af0e62526a4a5a6acaabaa571378756318bd5a00331dc2ee52c82173c0200ea0549d59c37e1f384db295e813c3d6a0ef612", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/39e06f0f5c189146d6b6f46a886c0f23aca1c31b7261a7c575075b9ba1d087745542d0af0a781d8a763cb08cc0768ab11d39a80154fc9a1d0fe2b7f6b4f8f99f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d53a843929e0d478fbfd410ebc40b7190d832ef04e05a00a7d5408cd7985cdfd1370741744e53bdfca7214fc868f70869746fdb8b8abad820c3be035c4dd9483"} build_url:https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011381 build_url: 'https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/91764819d3195a6f229b448c3996d0efe5cc663f739cb589bf31cf0ab8b950c7839bb2a449f6b390f0172f146dc8cc6ec2620b47b89e08204df70073e21aaf38", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/73745d3dc043abd3db63bf24497b8af0e62526a4a5a6acaabaa571378756318bd5a00331dc2ee52c82173c0200ea0549d59c37e1f384db295e813c3d6a0ef612", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/39e06f0f5c189146d6b6f46a886c0f23aca1c31b7261a7c575075b9ba1d087745542d0af0a781d8a763cb08cc0768ab11d39a80154fc9a1d0fe2b7f6b4f8f99f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d53a843929e0d478fbfd410ebc40b7190d832ef04e05a00a7d5408cd7985cdfd1370741744e53bdfca7214fc868f70869746fdb8b8abad820c3be035c4dd9483"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 03:12:59.146707) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 03:12:59.147054) ========= 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=836cfdc75598d54cb747368e000001a9-1505381751.933681-476886467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004564 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 03:12:59.233261) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 03:12:59.233588) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 03:12:59.233975) ========= ========= Total master_lag: 0.51 =========