builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-058 starttime: 1505126510.78 results: success (0) revision: 1f1893590a1df0ecf2d4f9e2dfdc3223991a942f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-11 03:41:50.778802) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-11 03:41:50.779261) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-11 03:41:50.779538) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-11 03:41:50.797387) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 03:41:50.797714) ========= 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=0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-11 03:41:50-- 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% 214M=0s 2017-09-11 03:41:50 (214 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131621 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 03:41:50.946663) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 03:41:50.947043) ========= 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=0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018372 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 03:41:50.997094) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 03:41:50.997435) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1f1893590a1df0ecf2d4f9e2dfdc3223991a942f --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 1f1893590a1df0ecf2d4f9e2dfdc3223991a942f --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=0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-11 03:41:51,052 truncating revision to first 12 chars 2017-09-11 03:41:51,052 Setting DEBUG logging. 2017-09-11 03:41:51,052 attempt 1/10 2017-09-11 03:41:51,052 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1f1893590a1d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-11 03:41:51,414 unpacking tar archive at: mozilla-central-1f1893590a1d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.645137 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 03:41:51.658688) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-11 03:41:51.659002) ========= script_repo_revision: 1f1893590a1df0ecf2d4f9e2dfdc3223991a942f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-11 03:41:51.659411) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-11 03:41:51.659697) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-11 03:41:51.673516) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-09-11 03:41:51.674024) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:41:51 INFO - MultiFileLogger online at 20170911 03:41:51 in /builds/slave/test 03:41:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:41:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:41:51 INFO - {'append_to_log': False, 03:41:51 INFO - 'base_work_dir': '/builds/slave/test', 03:41:51 INFO - 'blob_upload_branch': 'Firefox', 03:41:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:41:51 INFO - 'branch': 'Firefox', 03:41:51 INFO - 'buildbot_json_path': 'buildprops.json', 03:41:51 INFO - 'code_coverage': False, 03:41:51 INFO - 'config_files': ('talos/linux_config.py',), 03:41:51 INFO - 'default_actions': ('clobber', 03:41:51 INFO - 'read-buildbot-config', 03:41:51 INFO - 'download-and-extract', 03:41:51 INFO - 'populate-webroot', 03:41:51 INFO - 'create-virtualenv', 03:41:51 INFO - 'install', 03:41:51 INFO - 'setup-mitmproxy', 03:41:51 INFO - 'run-tests'), 03:41:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:41:51 INFO - 'disable_ccov_upload': False, 03:41:51 INFO - 'disable_stylo': False, 03:41:51 INFO - 'download_minidump_stackwalk': True, 03:41:51 INFO - 'download_symbols': 'ondemand', 03:41:51 INFO - 'enable_stylo': False, 03:41:51 INFO - 'enable_webrender': False, 03:41:51 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:41:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:41:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:41:51 INFO - 'gecko_profile': False, 03:41:51 INFO - 'gecko_profile_interval': 0, 03:41:51 INFO - 'installer_path': 'installer.exe', 03:41:51 INFO - 'log_level': 'info', 03:41:51 INFO - 'log_name': 'talos', 03:41:51 INFO - 'log_to_console': True, 03:41:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:41:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:41:51 INFO - 'opt_config_files': (), 03:41:51 INFO - 'pip_index': False, 03:41:51 INFO - 'suite': 'dromaeojs-e10s', 03:41:51 INFO - 'system_bits': '32', 03:41:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:41:51 INFO - 'title': 'talos-linux64-ix-058', 03:41:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:41:51 INFO - 'use_talos_json': True, 03:41:51 INFO - 'verify': 'False', 03:41:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:41:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:41:51 INFO - 'work_dir': 'build'} 03:41:51 INFO - [mozharness: 2017-09-11 10:41:51.866891Z] Running clobber step. 03:41:51 INFO - Running pre-action listener: _resource_record_pre_action 03:41:51 INFO - Running main action method: clobber 03:41:51 INFO - rmtree: /builds/slave/test/build 03:41:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:41:53 INFO - Running post-action listener: _resource_record_post_action 03:41:53 INFO - [mozharness: 2017-09-11 10:41:53.520673Z] Finished clobber step (success) 03:41:53 INFO - [mozharness: 2017-09-11 10:41:53.520769Z] Running read-buildbot-config step. 03:41:53 INFO - Running pre-action listener: _resource_record_pre_action 03:41:53 INFO - Running main action method: read_buildbot_config 03:41:53 INFO - Using buildbot properties: 03:41:53 INFO - { 03:41:53 INFO - "project": "", 03:41:53 INFO - "product": "firefox", 03:41:53 INFO - "who": "archaeopteryx@coole-files.de", 03:41:53 INFO - "installer_path": "public/build/target.tar.bz2", 03:41:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:41:53 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:41:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 03:41:53 INFO - "stage_platform": "linux64-pgo", 03:41:53 INFO - "basedir": "/builds/slave/test", 03:41:53 INFO - "buildnumber": 175, 03:41:53 INFO - "platform": "ubuntu64_hw", 03:41:53 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:41:53 INFO - "slavebuilddir": "test", 03:41:53 INFO - "taskId": "Tlkc_6HhRDaUAiIh9TVt_w", 03:41:53 INFO - "branch": "mozilla-central", 03:41:53 INFO - "script_repo_revision": "production", 03:41:53 INFO - "revision": "1f1893590a1df0ecf2d4f9e2dfdc3223991a942f", 03:41:53 INFO - "slavename": "talos-linux64-ix-058", 03:41:53 INFO - "repo_path": "mozilla-central" 03:41:53 INFO - } 03:41:53 INFO - Finding installer, test and symbols from parent task. 03:41:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tlkc_6HhRDaUAiIh9TVt_w'}, attempt #1 03:41:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tlkc_6HhRDaUAiIh9TVt_w'}, attempt #1 03:41:54 INFO - Task dependencies: dUR9X3TfT1GYB9I681YwgQ 03:41:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dUR9X3TfT1GYB9I681YwgQ'}, attempt #1 03:41:54 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dUR9X3TfT1GYB9I681YwgQ/artifacts/public/build/target.tar.bz2 03:41:54 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/dUR9X3TfT1GYB9I681YwgQ/artifacts/public/build/target.test_packages.json 03:41:54 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dUR9X3TfT1GYB9I681YwgQ/artifacts/public/build/target.crashreporter-symbols.zip 03:41:54 INFO - Running post-action listener: _resource_record_post_action 03:41:54 INFO - [mozharness: 2017-09-11 10:41:54.927923Z] Finished read-buildbot-config step (success) 03:41:54 INFO - [mozharness: 2017-09-11 10:41:54.928141Z] Running download-and-extract step. 03:41:54 INFO - Running pre-action listener: _resource_record_pre_action 03:41:54 INFO - Running main action method: download_and_extract 03:41:54 INFO - mkdir: /builds/slave/test/build/tests 03:41:54 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')]} 03:41:54 INFO - trying https://queue.taskcluster.net/v1/task/dUR9X3TfT1GYB9I681YwgQ/artifacts/public/build/target.test_packages.json 03:41:54 INFO - Downloading https://queue.taskcluster.net/v1/task/dUR9X3TfT1GYB9I681YwgQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:41:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dUR9X3TfT1GYB9I681YwgQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:41:55 INFO - Downloaded 989 bytes. 03:41:55 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:41:55 INFO - Using the following test package requirements: 03:41:55 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:41:55 INFO - u'common': [u'target.common.tests.zip'], 03:41:55 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:41:55 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:41:55 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:41:55 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:41:55 INFO - u'mozbase': [u'target.common.tests.zip'], 03:41:55 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:41:55 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:41:55 INFO - u'web-platform': [u'target.common.tests.zip', 03:41:55 INFO - u'target.web-platform.tests.tar.gz'], 03:41:55 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:41:55 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:41:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dUR9X3TfT1GYB9I681YwgQ/artifacts/public/build/target.common.tests.zip 03:41:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dUR9X3TfT1GYB9I681YwgQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:41:55 INFO - Fetch https://queue.taskcluster.net/v1/task/dUR9X3TfT1GYB9I681YwgQ/artifacts/public/build/target.common.tests.zip into memory 03:41:56 INFO - Content-Length response header: 55697900 03:41:56 INFO - Bytes received: 55697900 03:42:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dUR9X3TfT1GYB9I681YwgQ/artifacts/public/build/target.talos.tests.zip 03:42:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dUR9X3TfT1GYB9I681YwgQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:42:07 INFO - Fetch https://queue.taskcluster.net/v1/task/dUR9X3TfT1GYB9I681YwgQ/artifacts/public/build/target.talos.tests.zip into memory 03:42:08 INFO - Content-Length response header: 14497963 03:42:08 INFO - Bytes received: 14497963 03:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:08 INFO - trying https://queue.taskcluster.net/v1/task/dUR9X3TfT1GYB9I681YwgQ/artifacts/public/build/target.tar.bz2 03:42:08 INFO - Downloading https://queue.taskcluster.net/v1/task/dUR9X3TfT1GYB9I681YwgQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:42:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dUR9X3TfT1GYB9I681YwgQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:42:09 INFO - Downloaded 63548322 bytes. 03:42:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dUR9X3TfT1GYB9I681YwgQ/artifacts/public/build/target.tar.bz2 03:42:09 INFO - mkdir: /builds/slave/test/properties 03:42:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:42:09 INFO - Writing to file /builds/slave/test/properties/build_url 03:42:09 INFO - Contents: 03:42:09 INFO - build_url:https://queue.taskcluster.net/v1/task/dUR9X3TfT1GYB9I681YwgQ/artifacts/public/build/target.tar.bz2 03:42:09 INFO - Running post-action listener: _resource_record_post_action 03:42:09 INFO - Running post-action listener: find_tests_for_verification 03:42:09 INFO - Running post-action listener: set_extra_try_arguments 03:42:09 INFO - [mozharness: 2017-09-11 10:42:09.931329Z] Finished download-and-extract step (success) 03:42:09 INFO - [mozharness: 2017-09-11 10:42:09.931610Z] Running populate-webroot step. 03:42:09 INFO - Running pre-action listener: _resource_record_pre_action 03:42:09 INFO - Running main action method: populate_webroot 03:42:09 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:42:09 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:42:09 INFO - 'tests': ['tresize', 03:42:09 INFO - 'tcanvasmark']}, 03:42:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:42:09 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:42:09 INFO - 'tests': ['dromaeo_css', 03:42:09 INFO - 'kraken']}, 03:42:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:42:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:42:09 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:42:09 INFO - 'talos_options': ['--disable-stylo'], 03:42:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:42:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:42:09 INFO - 'tests': ['damp', 'tps']}, 03:42:09 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:42:09 INFO - 'talos_options': ['--disable-stylo'], 03:42:09 INFO - 'tests': ['damp', 'tps']}, 03:42:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:42:09 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:42:09 INFO - 'tests': ['dromaeo_dom']}, 03:42:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:42:09 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:42:09 INFO - 'tests': ['basic_compositor_video', 03:42:09 INFO - 'glvideo']}, 03:42:09 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:42:09 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:42:09 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:42:09 INFO - 'talos_options': ['--disable-stylo'], 03:42:09 INFO - 'tests': ['ts_paint_webext', 03:42:09 INFO - 'tp5o_webext']}, 03:42:09 INFO - 'other-e10s': {'tests': ['a11yr', 03:42:09 INFO - 'ts_paint', 03:42:09 INFO - 'tpaint', 03:42:09 INFO - 'sessionrestore', 03:42:09 INFO - 'sessionrestore_many_windows', 03:42:09 INFO - 'sessionrestore_no_auto_restore', 03:42:09 INFO - 'tabpaint']}, 03:42:09 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:42:09 INFO - 'tests': ['a11yr', 03:42:09 INFO - 'ts_paint', 03:42:09 INFO - 'tpaint', 03:42:09 INFO - 'sessionrestore', 03:42:09 INFO - 'sessionrestore_many_windows', 03:42:09 INFO - 'sessionrestore_no_auto_restore', 03:42:09 INFO - 'tabpaint']}, 03:42:09 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:42:09 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:42:09 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:42:09 INFO - 'tests': ['bloom_basic_singleton']}, 03:42:09 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:42:09 INFO - 'tests': ['bloom_basic']}, 03:42:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:42:09 INFO - 'tsvgr_opacity', 03:42:09 INFO - 'tart', 03:42:09 INFO - 'tscrollx', 03:42:09 INFO - 'tsvg_static']}, 03:42:09 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:42:09 INFO - 'tests': ['tsvgx', 03:42:09 INFO - 'tsvgr_opacity', 03:42:09 INFO - 'tart', 03:42:09 INFO - 'tscrollx', 03:42:09 INFO - 'tsvg_static']}, 03:42:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:42:09 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:42:09 INFO - 'talos_options': ['--disable-stylo'], 03:42:09 INFO - 'tests': ['tp5o']}, 03:42:09 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:42:09 INFO - 'talos_options': ['--mitmproxy', 03:42:09 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:42:09 INFO - '--firstNonBlankPaint'], 03:42:09 INFO - 'tests': ['tp6_google', 03:42:09 INFO - 'tp6_youtube', 03:42:09 INFO - 'tp6_amazon', 03:42:09 INFO - 'tp6_facebook']}, 03:42:09 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:42:09 INFO - 'talos_options': ['--disable-stylo', 03:42:09 INFO - '--mitmproxy', 03:42:09 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:42:09 INFO - '--firstNonBlankPaint'], 03:42:09 INFO - 'tests': ['tp6_google', 03:42:09 INFO - 'tp6_youtube', 03:42:09 INFO - 'tp6_amazon', 03:42:09 INFO - 'tp6_facebook']}, 03:42:09 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:42:09 INFO - 'talos_options': ['--stylo-threads=1', 03:42:09 INFO - '--mitmproxy', 03:42:09 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:42:09 INFO - '--firstNonBlankPaint'], 03:42:09 INFO - 'tests': ['tp6_google', 03:42:09 INFO - 'tp6_youtube', 03:42:09 INFO - 'tp6_amazon', 03:42:09 INFO - 'tp6_facebook']}, 03:42:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:42:09 INFO - 'talos_options': ['--xperf_path', 03:42:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:42:09 INFO - 'tests': ['tp5n']}, 03:42:09 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:42:09 INFO - 'talos_options': ['--disable-stylo', 03:42:09 INFO - '--xperf_path', 03:42:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:42:09 INFO - 'tests': ['tp5n']}}} 03:42:09 INFO - Running post-action listener: _resource_record_post_action 03:42:09 INFO - [mozharness: 2017-09-11 10:42:09.954263Z] Finished populate-webroot step (success) 03:42:09 INFO - [mozharness: 2017-09-11 10:42:09.954353Z] Running create-virtualenv step. 03:42:09 INFO - Running pre-action listener: _resource_record_pre_action 03:42:09 INFO - Running main action method: create_virtualenv 03:42:09 INFO - Creating virtualenv /builds/slave/test/build/venv 03:42:09 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:42:09 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:42:09 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:42:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:42:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:42:10 INFO - Installing distribute.............................................................................................................................................................................................done. 03:42:10 INFO - Installing pip...............done. 03:42:10 INFO - Return code: 0 03:42:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:42:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:42:10 INFO - Reading from file tmpfile_stdout 03:42:10 INFO - Output received: 03:42:10 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:42:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:42:10 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')]} 03:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:10 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')]} 03:42:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:10 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 0x13171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1683a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1687090>, '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 0x1687d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1681f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332', '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 03:42:10 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 03:42:10 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 03:42:10 INFO - Using env: {'DISPLAY': ':0', 03:42:10 INFO - 'HOME': '/home/cltbld', 03:42:10 INFO - 'LANG': 'en_US.UTF-8', 03:42:10 INFO - 'LANGUAGE': 'en_US:en', 03:42:10 INFO - 'LOGNAME': 'cltbld', 03:42:10 INFO - 'MAIL': '/var/mail/cltbld', 03:42:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:10 INFO - 'MOZ_NO_REMOTE': '1', 03:42:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:10 INFO - 'NO_EM_RESTART': '1', 03:42:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:10 INFO - 'PWD': '/builds/slave/test', 03:42:10 INFO - 'SHELL': '/bin/bash', 03:42:10 INFO - 'SHLVL': '1', 03:42:10 INFO - 'TERM': 'linux', 03:42:10 INFO - 'TMOUT': '86400', 03:42:10 INFO - 'USER': 'cltbld', 03:42:10 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332', 03:42:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:10 INFO - '_': '/tools/buildbot/bin/python'} 03:42:12 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:42:12 INFO - Downloading/unpacking pip>=1.5 03:42:12 INFO - Running setup.py egg_info for package pip 03:42:12 INFO - warning: no files found matching 'pip/cacert.pem' 03:42:12 INFO - warning: no files found matching '*.html' under directory 'docs' 03:42:12 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:42:12 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:42:12 INFO - Installing collected packages: pip 03:42:12 INFO - Found existing installation: pip 1.1 03:42:12 INFO - Uninstalling pip: 03:42:12 INFO - Successfully uninstalled pip 03:42:12 INFO - Running setup.py install for pip 03:42:12 INFO - warning: no files found matching 'pip/cacert.pem' 03:42:12 INFO - warning: no files found matching '*.html' under directory 'docs' 03:42:12 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:42:12 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:42:12 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:42:12 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:42:12 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:42:12 INFO - Successfully installed pip 03:42:12 INFO - Cleaning up... 03:42:12 INFO - Return code: 0 03:42:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1683a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1687090>, '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 0x1687d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1681f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332', '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 03:42:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:42:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:42:12 INFO - Using env: {'DISPLAY': ':0', 03:42:12 INFO - 'HOME': '/home/cltbld', 03:42:12 INFO - 'LANG': 'en_US.UTF-8', 03:42:12 INFO - 'LANGUAGE': 'en_US:en', 03:42:12 INFO - 'LOGNAME': 'cltbld', 03:42:12 INFO - 'MAIL': '/var/mail/cltbld', 03:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:12 INFO - 'MOZ_NO_REMOTE': '1', 03:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:12 INFO - 'NO_EM_RESTART': '1', 03:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:12 INFO - 'PWD': '/builds/slave/test', 03:42:12 INFO - 'SHELL': '/bin/bash', 03:42:12 INFO - 'SHLVL': '1', 03:42:12 INFO - 'TERM': 'linux', 03:42:12 INFO - 'TMOUT': '86400', 03:42:12 INFO - 'USER': 'cltbld', 03:42:12 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332', 03:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:12 INFO - '_': '/tools/buildbot/bin/python'} 03:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:12 INFO - Downloading/unpacking psutil>=3.1.1 03:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:42:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:42:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:42:13 INFO - Installing collected packages: psutil 03:42:13 INFO - Running setup.py install for psutil 03:42:13 INFO - building 'psutil._psutil_linux' extension 03:42:13 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 03:42:13 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 03:42:13 INFO - building 'psutil._psutil_posix' extension 03:42:13 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 03:42:14 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 03:42:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:42:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:42:14 INFO - Successfully installed psutil 03:42:14 INFO - Cleaning up... 03:42:14 INFO - Return code: 0 03:42:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:14 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 0x13171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1683a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1687090>, '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 0x1687d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1681f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332', '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 03:42:14 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 03:42:14 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 03:42:14 INFO - Using env: {'DISPLAY': ':0', 03:42:14 INFO - 'HOME': '/home/cltbld', 03:42:14 INFO - 'LANG': 'en_US.UTF-8', 03:42:14 INFO - 'LANGUAGE': 'en_US:en', 03:42:14 INFO - 'LOGNAME': 'cltbld', 03:42:14 INFO - 'MAIL': '/var/mail/cltbld', 03:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:14 INFO - 'MOZ_NO_REMOTE': '1', 03:42:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:14 INFO - 'NO_EM_RESTART': '1', 03:42:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:14 INFO - 'PWD': '/builds/slave/test', 03:42:14 INFO - 'SHELL': '/bin/bash', 03:42:14 INFO - 'SHLVL': '1', 03:42:14 INFO - 'TERM': 'linux', 03:42:14 INFO - 'TMOUT': '86400', 03:42:14 INFO - 'USER': 'cltbld', 03:42:14 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332', 03:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:14 INFO - '_': '/tools/buildbot/bin/python'} 03:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:42:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:42:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:42:15 INFO - Installing collected packages: mozsystemmonitor 03:42:15 INFO - Running setup.py install for mozsystemmonitor 03:42:15 INFO - Successfully installed mozsystemmonitor 03:42:15 INFO - Cleaning up... 03:42:16 INFO - Return code: 0 03:42:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:42: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')]} 03:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42: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')]} 03:42:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:16 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 0x13171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1683a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1687090>, '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 0x1687d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1681f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332', '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 03:42:16 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 03:42:16 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 03:42:16 INFO - Using env: {'DISPLAY': ':0', 03:42:16 INFO - 'HOME': '/home/cltbld', 03:42:16 INFO - 'LANG': 'en_US.UTF-8', 03:42:16 INFO - 'LANGUAGE': 'en_US:en', 03:42:16 INFO - 'LOGNAME': 'cltbld', 03:42:16 INFO - 'MAIL': '/var/mail/cltbld', 03:42:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:16 INFO - 'MOZ_NO_REMOTE': '1', 03:42:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:16 INFO - 'NO_EM_RESTART': '1', 03:42:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:16 INFO - 'PWD': '/builds/slave/test', 03:42:16 INFO - 'SHELL': '/bin/bash', 03:42:16 INFO - 'SHLVL': '1', 03:42:16 INFO - 'TERM': 'linux', 03:42:16 INFO - 'TMOUT': '86400', 03:42:16 INFO - 'USER': 'cltbld', 03:42:16 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332', 03:42:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:16 INFO - '_': '/tools/buildbot/bin/python'} 03:42:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:16 INFO - Downloading/unpacking jsonschema==2.5.1 03:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:42:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:42:17 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 03:42:17 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 03:42:17 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 03:42:17 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 03:42:17 INFO - Downloading functools32-3.2.3-2.tar.gz 03:42:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:42:17 INFO - warning: no files found matching '*.txt' 03:42:17 INFO - no previously-included directories found matching 'build' 03:42:17 INFO - no previously-included directories found matching 'dist' 03:42:17 INFO - no previously-included directories found matching '.git*' 03:42:17 INFO - Installing collected packages: jsonschema, functools32 03:42:17 INFO - Running setup.py install for functools32 03:42:18 INFO - warning: no files found matching '*.txt' 03:42:18 INFO - no previously-included directories found matching 'build' 03:42:18 INFO - no previously-included directories found matching 'dist' 03:42:18 INFO - no previously-included directories found matching '.git*' 03:42:18 INFO - Successfully installed jsonschema functools32 03:42:18 INFO - Cleaning up... 03:42:18 INFO - Return code: 0 03:42:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:18 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 0x13171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1683a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1687090>, '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 0x1687d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1681f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332', '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 03:42:18 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 03:42:18 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 03:42:18 INFO - Using env: {'DISPLAY': ':0', 03:42:18 INFO - 'HOME': '/home/cltbld', 03:42:18 INFO - 'LANG': 'en_US.UTF-8', 03:42:18 INFO - 'LANGUAGE': 'en_US:en', 03:42:18 INFO - 'LOGNAME': 'cltbld', 03:42:18 INFO - 'MAIL': '/var/mail/cltbld', 03:42:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:18 INFO - 'MOZ_NO_REMOTE': '1', 03:42:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:18 INFO - 'NO_EM_RESTART': '1', 03:42:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:18 INFO - 'PWD': '/builds/slave/test', 03:42:18 INFO - 'SHELL': '/bin/bash', 03:42:18 INFO - 'SHLVL': '1', 03:42:18 INFO - 'TERM': 'linux', 03:42:18 INFO - 'TMOUT': '86400', 03:42:18 INFO - 'USER': 'cltbld', 03:42:18 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332', 03:42:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:18 INFO - '_': '/tools/buildbot/bin/python'} 03:42:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:42:18 INFO - Cleaning up... 03:42:18 INFO - Return code: 0 03:42:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:18 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 0x13171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1683a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1687090>, '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 0x1687d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1681f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332', '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 03:42:18 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 03:42:18 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 03:42:19 INFO - Using env: {'DISPLAY': ':0', 03:42:19 INFO - 'HOME': '/home/cltbld', 03:42:19 INFO - 'LANG': 'en_US.UTF-8', 03:42:19 INFO - 'LANGUAGE': 'en_US:en', 03:42:19 INFO - 'LOGNAME': 'cltbld', 03:42:19 INFO - 'MAIL': '/var/mail/cltbld', 03:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:19 INFO - 'MOZ_NO_REMOTE': '1', 03:42:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:19 INFO - 'NO_EM_RESTART': '1', 03:42:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:19 INFO - 'PWD': '/builds/slave/test', 03:42:19 INFO - 'SHELL': '/bin/bash', 03:42:19 INFO - 'SHLVL': '1', 03:42:19 INFO - 'TERM': 'linux', 03:42:19 INFO - 'TMOUT': '86400', 03:42:19 INFO - 'USER': 'cltbld', 03:42:19 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332', 03:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:19 INFO - '_': '/tools/buildbot/bin/python'} 03:42:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:19 INFO - Downloading/unpacking blobuploader==1.2.4 03:42:19 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 03:42:19 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 03:42:19 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 03:42:19 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 03:42:20 INFO - Downloading blobuploader-1.2.4.tar.gz 03:42:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:42:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:42:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:20 INFO - Downloading docopt-0.6.1.tar.gz 03:42:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:42:20 INFO - Installing collected packages: blobuploader, requests, docopt 03:42:20 INFO - Running setup.py install for blobuploader 03:42:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:42:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:42:20 INFO - Running setup.py install for requests 03:42:21 INFO - Running setup.py install for docopt 03:42:21 INFO - Successfully installed blobuploader requests docopt 03:42:21 INFO - Cleaning up... 03:42:21 INFO - Return code: 0 03:42:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:21 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 0x13171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1683a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1687090>, '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 0x1687d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1681f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332', '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 03:42:21 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 03:42:21 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 03:42:21 INFO - Using env: {'DISPLAY': ':0', 03:42:21 INFO - 'HOME': '/home/cltbld', 03:42:21 INFO - 'LANG': 'en_US.UTF-8', 03:42:21 INFO - 'LANGUAGE': 'en_US:en', 03:42:21 INFO - 'LOGNAME': 'cltbld', 03:42:21 INFO - 'MAIL': '/var/mail/cltbld', 03:42:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:21 INFO - 'MOZ_NO_REMOTE': '1', 03:42:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:21 INFO - 'NO_EM_RESTART': '1', 03:42:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:21 INFO - 'PWD': '/builds/slave/test', 03:42:21 INFO - 'SHELL': '/bin/bash', 03:42:21 INFO - 'SHLVL': '1', 03:42:21 INFO - 'TERM': 'linux', 03:42:21 INFO - 'TMOUT': '86400', 03:42:21 INFO - 'USER': 'cltbld', 03:42:21 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332', 03:42:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:21 INFO - '_': '/tools/buildbot/bin/python'} 03:42:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:42:21 INFO - Running setup.py (path:/tmp/pip-u1c7Ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:42:21 INFO - Running setup.py (path:/tmp/pip-I_jq22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:42:21 INFO - Running setup.py (path:/tmp/pip-11npuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:42:21 INFO - Running setup.py (path:/tmp/pip-h3np6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:42:22 INFO - Running setup.py (path:/tmp/pip-cXXjFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:42:22 INFO - Running setup.py (path:/tmp/pip-GK4XSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:42:22 INFO - Running setup.py (path:/tmp/pip-V0NtEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:42:22 INFO - Running setup.py (path:/tmp/pip-WvnuLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:42:22 INFO - Running setup.py (path:/tmp/pip-TFxroe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:42:22 INFO - Running setup.py (path:/tmp/pip-eeddaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:42:22 INFO - Running setup.py (path:/tmp/pip-rO9ZxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:42:22 INFO - Running setup.py (path:/tmp/pip-Iuwcff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:42:22 INFO - Running setup.py (path:/tmp/pip-CHvy4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:42:22 INFO - Running setup.py (path:/tmp/pip-kWSrq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:22 INFO - Running setup.py (path:/tmp/pip-_KPvg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:42:22 INFO - Running setup.py (path:/tmp/pip-n4j8sk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:42:22 INFO - Running setup.py (path:/tmp/pip-OMLmBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:42:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:42:22 INFO - Running setup.py install for manifestparser 03:42:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:42:23 INFO - Running setup.py install for mozcrash 03:42:23 INFO - Running setup.py install for mozdebug 03:42:23 INFO - Running setup.py install for mozdevice 03:42:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:42:23 INFO - Running setup.py install for mozfile 03:42:23 INFO - Running setup.py install for mozhttpd 03:42:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:42:23 INFO - Running setup.py install for mozinfo 03:42:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:42:23 INFO - Running setup.py install for mozInstall 03:42:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:42:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:42:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:42:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:42:23 INFO - Running setup.py install for mozleak 03:42:23 INFO - Running setup.py install for mozlog 03:42:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:42:23 INFO - Running setup.py install for moznetwork 03:42:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:42:24 INFO - Running setup.py install for mozprocess 03:42:24 INFO - Running setup.py install for mozprofile 03:42:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:42:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:42:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:42:24 INFO - Running setup.py install for mozrunner 03:42:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:42:24 INFO - Running setup.py install for mozscreenshot 03:42:24 INFO - Running setup.py install for moztest 03:42:24 INFO - Running setup.py install for mozversion 03:42:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:42:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:42:24 INFO - Cleaning up... 03:42:24 INFO - Return code: 0 03:42:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:24 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 0x13171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1683a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1687090>, '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 0x1687d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1681f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332', '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 03:42:24 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 03:42:24 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 03:42:24 INFO - Using env: {'DISPLAY': ':0', 03:42:24 INFO - 'HOME': '/home/cltbld', 03:42:24 INFO - 'LANG': 'en_US.UTF-8', 03:42:24 INFO - 'LANGUAGE': 'en_US:en', 03:42:24 INFO - 'LOGNAME': 'cltbld', 03:42:24 INFO - 'MAIL': '/var/mail/cltbld', 03:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:24 INFO - 'MOZ_NO_REMOTE': '1', 03:42:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:24 INFO - 'NO_EM_RESTART': '1', 03:42:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:24 INFO - 'PWD': '/builds/slave/test', 03:42:24 INFO - 'SHELL': '/bin/bash', 03:42:24 INFO - 'SHLVL': '1', 03:42:24 INFO - 'TERM': 'linux', 03:42:24 INFO - 'TMOUT': '86400', 03:42:24 INFO - 'USER': 'cltbld', 03:42:24 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332', 03:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:24 INFO - '_': '/tools/buildbot/bin/python'} 03:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:42:24 INFO - Running setup.py (path:/tmp/pip-g2cONp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:42:24 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)) 03:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:42:24 INFO - Running setup.py (path:/tmp/pip-6pt__v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:42:25 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)) 03:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:42:25 INFO - Running setup.py (path:/tmp/pip-dENiVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:42:25 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)) 03:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:42:25 INFO - Running setup.py (path:/tmp/pip-NxePTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:42:25 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)) 03:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:42:25 INFO - Running setup.py (path:/tmp/pip-PyMtQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:42:25 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)) 03:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:42:25 INFO - Running setup.py (path:/tmp/pip-QfdkCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:42:25 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)) 03:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:42:25 INFO - Running setup.py (path:/tmp/pip-Bt8nek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:42:25 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)) 03:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:42:25 INFO - Running setup.py (path:/tmp/pip-t5ylwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:42:25 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)) 03:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:42:25 INFO - Running setup.py (path:/tmp/pip-nXtYvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:42:25 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)) 03:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:42:25 INFO - Running setup.py (path:/tmp/pip-F26fvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:42:25 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)) 03:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:42:25 INFO - Running setup.py (path:/tmp/pip-z09rM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:42:25 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)) 03:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:42:25 INFO - Running setup.py (path:/tmp/pip-7IrbnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:42:25 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)) 03:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:42:25 INFO - Running setup.py (path:/tmp/pip-_3VqBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:42:25 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)) 03:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:42:25 INFO - Running setup.py (path:/tmp/pip-b6qXxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:42:25 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)) 03:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:25 INFO - Running setup.py (path:/tmp/pip-AiCYjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:25 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)) 03:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:42:25 INFO - Running setup.py (path:/tmp/pip-r_Fx11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:42:26 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)) 03:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:42:26 INFO - Running setup.py (path:/tmp/pip-gRM6r9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:42:26 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)) 03:42:26 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)) 03:42:26 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)) 03:42:26 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)) 03:42:26 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)) 03:42:26 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)) 03:42:26 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)) 03:42:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:42:26 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 03:42:26 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 03:42:26 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 03:42:26 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 03:42:27 INFO - Downloading blessings-1.6.tar.gz 03:42:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:42:27 INFO - Installing collected packages: blessings 03:42:27 INFO - Running setup.py install for blessings 03:42:27 INFO - Successfully installed blessings 03:42:27 INFO - Cleaning up... 03:42:27 INFO - Return code: 0 03:42:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:42:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:42:27 INFO - Reading from file tmpfile_stdout 03:42:27 INFO - Current package versions: 03:42:27 INFO - argparse == 1.2.1 03:42:27 INFO - blessings == 1.6 03:42:27 INFO - blobuploader == 1.2.4 03:42:27 INFO - docopt == 0.6.1 03:42:27 INFO - functools32 == 3.2.3-2 03:42:27 INFO - jsonschema == 2.5.1 03:42:27 INFO - manifestparser == 1.1 03:42:27 INFO - mozInstall == 1.13 03:42:27 INFO - mozcrash == 1.0 03:42:27 INFO - mozdebug == 0.1 03:42:27 INFO - mozdevice == 0.51 03:42:27 INFO - mozfile == 1.2 03:42:27 INFO - mozhttpd == 0.7 03:42:27 INFO - mozinfo == 0.10 03:42:27 INFO - mozleak == 0.1 03:42:27 INFO - mozlog == 3.5 03:42:27 INFO - moznetwork == 0.27 03:42:27 INFO - mozprocess == 0.25 03:42:27 INFO - mozprofile == 0.28 03:42:27 INFO - mozrunner == 6.13 03:42:27 INFO - mozscreenshot == 0.1 03:42:27 INFO - mozsystemmonitor == 0.3 03:42:27 INFO - moztest == 0.8 03:42:27 INFO - mozversion == 1.4 03:42:27 INFO - psutil == 3.1.1 03:42:27 INFO - requests == 1.2.3 03:42:27 INFO - wsgiref == 0.1.2 03:42:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:27 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 0x13171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1683a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1687090>, '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 0x1687d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1681f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332', '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 03:42:27 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 03:42:27 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 03:42:27 INFO - Using env: {'DISPLAY': ':0', 03:42:27 INFO - 'HOME': '/home/cltbld', 03:42:27 INFO - 'LANG': 'en_US.UTF-8', 03:42:27 INFO - 'LANGUAGE': 'en_US:en', 03:42:27 INFO - 'LOGNAME': 'cltbld', 03:42:27 INFO - 'MAIL': '/var/mail/cltbld', 03:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:27 INFO - 'MOZ_NO_REMOTE': '1', 03:42:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:27 INFO - 'NO_EM_RESTART': '1', 03:42:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:27 INFO - 'PWD': '/builds/slave/test', 03:42:27 INFO - 'SHELL': '/bin/bash', 03:42:27 INFO - 'SHLVL': '1', 03:42:27 INFO - 'TERM': 'linux', 03:42:27 INFO - 'TMOUT': '86400', 03:42:27 INFO - 'USER': 'cltbld', 03:42:27 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332', 03:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:27 INFO - '_': '/tools/buildbot/bin/python'} 03:42:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:27 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)) 03:42:27 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)) 03:42:27 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)) 03:42:27 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)) 03:42:27 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)) 03:42:27 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)) 03:42:27 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)) 03:42:27 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)) 03:42:27 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)) 03:42:27 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:42:29 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)) 03:42:29 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)) 03:42:29 INFO - Installing collected packages: simplejson 03:42:29 INFO - Running setup.py install for simplejson 03:42:29 INFO - building 'simplejson._speedups' extension 03:42:29 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 03:42:29 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 03:42:30 INFO - Successfully installed simplejson 03:42:30 INFO - Cleaning up... 03:42:30 INFO - Return code: 0 03:42:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1683a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1687090>, '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 0x1687d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1681f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332', '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 03:42:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:42:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:42:30 INFO - Using env: {'DISPLAY': ':0', 03:42:30 INFO - 'HOME': '/home/cltbld', 03:42:30 INFO - 'LANG': 'en_US.UTF-8', 03:42:30 INFO - 'LANGUAGE': 'en_US:en', 03:42:30 INFO - 'LOGNAME': 'cltbld', 03:42:30 INFO - 'MAIL': '/var/mail/cltbld', 03:42:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:30 INFO - 'MOZ_NO_REMOTE': '1', 03:42:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:30 INFO - 'NO_EM_RESTART': '1', 03:42:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:30 INFO - 'PWD': '/builds/slave/test', 03:42:30 INFO - 'SHELL': '/bin/bash', 03:42:30 INFO - 'SHLVL': '1', 03:42:30 INFO - 'TERM': 'linux', 03:42:30 INFO - 'TMOUT': '86400', 03:42:30 INFO - 'USER': 'cltbld', 03:42:30 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332', 03:42:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:30 INFO - '_': '/tools/buildbot/bin/python'} 03:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:42:30 INFO - Cleaning up... 03:42:30 INFO - Return code: 0 03:42:30 INFO - Running post-action listener: _resource_record_post_action 03:42:30 INFO - Running post-action listener: _start_resource_monitoring 03:42:30 INFO - Starting resource monitoring. 03:42:30 INFO - [mozharness: 2017-09-11 10:42:30.358591Z] Finished create-virtualenv step (success) 03:42:30 INFO - [mozharness: 2017-09-11 10:42:30.359057Z] Running install step. 03:42:30 INFO - Running pre-action listener: _resource_record_pre_action 03:42:30 INFO - Running main action method: install 03:42:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:42:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:42:30 INFO - Reading from file tmpfile_stdout 03:42:30 INFO - Detecting whether we're running mozinstall >=1.0... 03:42:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:42:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:42:30 INFO - Reading from file tmpfile_stdout 03:42:30 INFO - Output received: 03:42:30 INFO - Usage: mozinstall [options] installer 03:42:30 INFO - Options: 03:42:30 INFO - -h, --help show this help message and exit 03:42:30 INFO - -d DEST, --destination=DEST 03:42:30 INFO - Directory to install application into. [default: 03:42:30 INFO - "/builds/slave/test"] 03:42:30 INFO - --app=APP Application being installed. [default: firefox] 03:42:30 INFO - mkdir: /builds/slave/test/build/application 03:42:30 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'] 03:42:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:42:47 INFO - Reading from file tmpfile_stdout 03:42:47 INFO - Output received: 03:42:47 INFO - /builds/slave/test/build/application/firefox/firefox 03:42:47 INFO - Running post-action listener: _resource_record_post_action 03:42:47 INFO - [mozharness: 2017-09-11 10:42:47.132868Z] Finished install step (success) 03:42:47 INFO - [mozharness: 2017-09-11 10:42:47.133120Z] Running setup-mitmproxy step. 03:42:47 INFO - Running pre-action listener: _resource_record_pre_action 03:42:47 INFO - Running main action method: setup_mitmproxy 03:42:47 INFO - Skipping: mitmproxy is not required 03:42:47 INFO - Running post-action listener: _resource_record_post_action 03:42:47 INFO - [mozharness: 2017-09-11 10:42:47.134246Z] Finished setup-mitmproxy step (success) 03:42:47 INFO - [mozharness: 2017-09-11 10:42:47.134466Z] Running run-tests step. 03:42:47 INFO - Running pre-action listener: _resource_record_pre_action 03:42:47 INFO - Running pre-action listener: _set_gcov_prefix 03:42:47 INFO - Running main action method: run_tests 03:42:47 WARNING - Try message not found. 03:42:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:42:47 INFO - Python 2.7.3 03:42:47 INFO - Return code: 0 03:42:47 INFO - grabbing minidump binary from tooltool 03:42: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')]} 03:42:47 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 0x1687090>, '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 0x1687d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1681f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:42:47 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 03:42:47 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 03:42:47 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 03:42:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:42:47 INFO - Return code: 0 03:42:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:42:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:42:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:42:47 INFO - ENV: RUST_BACKTRACE is now full 03:42:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:42:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:42:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dUR9X3TfT1GYB9I681YwgQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 03:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dUR9X3TfT1GYB9I681YwgQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 03:42:47 INFO - Using env: {'DISPLAY': ':0', 03:42:47 INFO - 'HOME': '/home/cltbld', 03:42:47 INFO - 'LANG': 'en_US.UTF-8', 03:42:47 INFO - 'LANGUAGE': 'en_US:en', 03:42:47 INFO - 'LOGNAME': 'cltbld', 03:42:47 INFO - 'MAIL': '/var/mail/cltbld', 03:42:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:42:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:47 INFO - 'MOZ_NO_REMOTE': '1', 03:42:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:42:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:47 INFO - 'NO_EM_RESTART': '1', 03:42:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:47 INFO - 'PWD': '/builds/slave/test', 03:42:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:42:47 INFO - 'RUST_BACKTRACE': 'full', 03:42:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:42:47 INFO - 'SHELL': '/bin/bash', 03:42:47 INFO - 'SHLVL': '1', 03:42:47 INFO - 'TERM': 'linux', 03:42:47 INFO - 'TMOUT': '86400', 03:42:47 INFO - 'USER': 'cltbld', 03:42:47 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332', 03:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:47 INFO - '_': '/tools/buildbot/bin/python'} 03:42:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dUR9X3TfT1GYB9I681YwgQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 03:42:47 INFO - mozversion application_buildid: 20170911091655 03:42:47 INFO - mozversion application_changeset: 1f1893590a1df0ecf2d4f9e2dfdc3223991a942f 03:42:47 INFO - mozversion application_display_name: Nightly 03:42:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:42:47 INFO - mozversion application_name: Firefox 03:42:47 INFO - mozversion application_remotingname: firefox 03:42:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:42:47 INFO - mozversion application_vendor: Mozilla 03:42:47 INFO - mozversion application_version: 57.0a1 03:42:47 INFO - mozversion platform_buildid: 20170911091655 03:42:47 INFO - mozversion platform_changeset: 1f1893590a1df0ecf2d4f9e2dfdc3223991a942f 03:42:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:42:47 INFO - mozversion platform_version: 57.0a1 03:42:47 INFO - using testdate: 1505126567 03:42:47 INFO - actual date: 1505126567 03:42:47 INFO - starting webserver on 'localhost:46750' 03:42:47 INFO - SUITE-START | Running 2 tests 03:42:47 INFO - TEST-START | dromaeo_css 03:42:47 INFO - Initialising browser for dromaeo_css test... 03:42:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46750/getInfo.html -profile /tmp/tmpsHMrRY/profile 03:42:47 INFO - TEST-INFO | started process 9934 (/builds/slave/test/build/application/firefox/firefox http://localhost:46750/getInfo.html) 03:42:53 INFO - TEST-INFO | 9934: exit 0 03:42:53 INFO - Browser initialized. 03:42:53 INFO - Running cycle 1/1 for dromaeo_css test... 03:42:53 INFO - Using env: {'DISPLAY': ':0', 03:42:53 INFO - 'HOME': '/home/cltbld', 03:42:53 INFO - 'JSGC_DISABLE_POISONING': '1', 03:42:53 INFO - 'LANG': 'en_US.UTF-8', 03:42:53 INFO - 'LANGUAGE': 'en_US:en', 03:42:53 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:42:53 INFO - 'LOGNAME': 'cltbld', 03:42:53 INFO - 'MAIL': '/var/mail/cltbld', 03:42:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:42:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:42:53 INFO - 'MOZ_CRASHREPORTER': '1', 03:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:53 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:42:53 INFO - 'MOZ_NO_REMOTE': '1', 03:42:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:42:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:53 INFO - 'NO_EM_RESTART': '1', 03:42:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:53 INFO - 'PWD': '/builds/slave/test', 03:42:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:42:53 INFO - 'RUST_BACKTRACE': 'full', 03:42:53 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:42:53 INFO - 'SHELL': '/bin/bash', 03:42:53 INFO - 'SHLVL': '1', 03:42:53 INFO - 'TERM': 'linux', 03:42:53 INFO - 'TMOUT': '86400', 03:42:53 INFO - 'USER': 'cltbld', 03:42:53 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332', 03:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:53 INFO - '_': '/tools/buildbot/bin/python'} 03:42:53 INFO - TEST-INFO | started process 10133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsHMrRY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:42:54 INFO - PID 10133 | 03:42:54 INFO - PID 10133 | (/builds/slave/test/build/application/firefox/firefox:10184): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:42:54 INFO - PID 10133 | 03:43:04 INFO - PID 10133 | RSS: Main: 164290560 03:43:04 INFO - PID 10133 | 03:46:02 INFO - PID 10133 | Cycle 1(1): loaded http://localhost:46750/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46750/tests/dromaeo/cssquery-ext.html) 03:46:03 INFO - PID 10133 | RSS: Main: 165425152 03:46:03 INFO - PID 10133 | 03:49:05 INFO - PID 10133 | Cycle 1(1): loaded http://localhost:46750/tests/dromaeo/cssquery-ext.html (next: http://localhost:46750/tests/dromaeo/cssquery-jquery.html) 03:49:05 INFO - PID 10133 | RSS: Main: 163704832 03:49:05 INFO - PID 10133 | 03:52:07 INFO - PID 10133 | Cycle 1(1): loaded http://localhost:46750/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46750/tests/dromaeo/cssquery-mootools.html) 03:52:07 INFO - PID 10133 | RSS: Main: 166248448 03:52:07 INFO - PID 10133 | 03:55:09 INFO - PID 10133 | Cycle 1(1): loaded http://localhost:46750/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46750/tests/dromaeo/cssquery-prototype.html) 03:55:10 INFO - PID 10133 | RSS: Main: 165187584 03:55:10 INFO - PID 10133 | 03:58:13 INFO - PID 10133 | Cycle 1(1): loaded http://localhost:46750/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46750/tests/dromaeo/cssquery-yui.html) 03:58:13 INFO - PID 10133 | RSS: Main: 166072320 03:58:13 INFO - PID 10133 | 04:01:15 INFO - PID 10133 | Cycle 1(1): loaded http://localhost:46750/tests/dromaeo/cssquery-yui.html (next: http://localhost:46750/tests/dromaeo/cssquery-dojo.html) 04:01:15 INFO - PID 10133 | RSS: Main: 169070592 04:01:15 INFO - PID 10133 | 04:01:15 INFO - PID 10133 | __start_tp_report 04:01:15 INFO - PID 10133 | _x_x_mozilla_page_load 04:01:15 INFO - PID 10133 | _x_x_mozilla_page_load_details 04:01:15 INFO - PID 10133 | |i|pagename|runs| 04:01:15 INFO - PID 10133 | |0;dojo.html;3858.7491813032143;3863.7681739095647;3868.149007218413;3884.10665546924;3936.6457018868296;6245.906311405332;6273.717682704278;6344.397282258178;6359.364063593638;6425.967870160648;6311.589746666464;6355.364463553642;6369.681515924197;6378.808635740924;6392.968035159829;5569.916451253234;5573.247611572447;5613.607047506686;5623;5664.943350566483;5666.914996275039;5704.172894930232;5707.286589176353;5741.885162296772;5770.2210201622665;5712;5770.134479828017;5792.942070579283;5812.767489300423;5825.126231065353;5553.8333849984565;5618.775248990036;5692.743826527775;5709.457601527848;5785.190073389729;5569.582281328876;5637;5652.858678533028;5688.744006519716;5703.657780533182;6269.749210031593;6281.089242059876;6354.618722876642;6370.904436433457;6387.712552935082;6758.459323254128;6857.405538289358;6873.621950792704;6948.6525673716615;6974.197967233782;6806.251312355637;6907.516473846833;6988.720451181946;6999.055127557765;7035.261297563785;6367.363263673688;6380.266269378988;6452.354764523557;6456.031595260749;6456.548041637087;7023.754168604074;7036.226015138331;7058.647067646597;7123.43012558994;7123.679434425463;6706.731730730814;6714.362135597111;6770.932290677129;6782.898256526156;6824.4199243064895;6900.896486552706;6944.166699996033;6956.373926346653;6976;6987.475939304572;6820.181578210647;6846.726130954806;6856.520043597;6927.618980956096;6952.130983627047;6800.217974932847;6865.931340686529;6878.55289406187;6891.173059232924;6896.069030680794;4999.475055119233;5057.266696329012;5069.695818250917;5071.670341427795;5081.136206844845;4554.793843965482;4568.451785785727;4585.403897493371;4595.195840727859;4604.217283061887;6223.066540019034;6287.49700023997;6324.08300796382;6351.2696039956;6352.36476352361;6732.899006514906;6752.257251702309;6837.35045170708;6840.863182736317;6844.178698556205;6211.844703882349;6215.96892015537;6287.088372186099;6311.621302721851;6317.4946004319545;5443.618946673774;5494.230807686927;5530.889382212334;5542.473465020817;5566.443355664401;7116.608586527687;7126.821829454305;7131.322524360177;7133.500654954103;7137.571745695275;6650.9667451662435;6733.696983635748;6741.662916854236;6813.931860681329;6829.93170068293;7025.543339682904;7039.331263529956;7090.149182098181;7129.607871566906;7161.57030578167;6802.285759995129;6806;6883.518153729191;6885.449164066963;6888.276730943379;6917.308269173042;6920.5847649141215;6961.860762784817;6973.19808222061;7008.264132266243;6536.901946470902;6540.607563546202;6542.705578248895;6544.705488252945;6629.701663425254;6513.8697226056165;6563.803085907431;6583.275839657538;6618.801435956929;6671.232808227116;6515.087887695631;6517.087607734826;6583.078369028244;6585.80242592723;6602.60384376939;6576.572522786004;6620.205575330799;6635.336466353326;6686.866262674622;6723.596584204964;6449.709763060768;6459.806205813833;6470.870582588416;6473.579217350857;6478.449331806849 04:01:15 INFO - PID 10133 | |1;ext.html;900.3922352412122;945.2343601682634;973.6397532912821;1009.9091081802636;1011.6358111080015;43024.56975430245;45133.32300015498;45279;45341.31988020182;45345.31982020268;42531;42576.78711606438;42710.7864460678;42773.144537109314;42813.571864281344;7371.668274927628;7511.248875112472;7530.548167109963;7532.284432978886;7536.773896783106;7394.963025184867;7473.439492038092;7475.775726728207;7476.252374762535;7487.438442116836;7914.445988780788;8085.07021692507;8087.959560202191;8091.19088091192;8095.797605059862;7960.283574478296;8056.959715201445;8059.274665280153;8060.03279606451;8060.677572897077;7867.763967080997;8048.356131509465;8053.15441878606;8059.153788852203;8061.395395345373;42135;42624;42634.14731705349;42697;42736;3782.508273924372;3798.0504873781556;3820.7134464915243;3837.424386342043;3839.4240863870364;33569.16077098068;33573;33589.160270993176;33700.32599348024;33742.493862592084;5497.582081954673;5504.422035686235;5539.2522009529;5553.888922221573;5573.8606534836545;209052;209188;210512;213568;247045.7647711768;53207;53387;53545;53653;53662;57041;57121.428785711614;57277;57284.42715572874;57311;16222.51332460028;16333.346666133459;16413.015219086654;16428.260728267258;16583.6683266334;13383.598492045254;13511.797323040162;13512.729745405037;13521.864781352257;13522.391492382867;15691.607709807346;15864.52406427809;15886;15897.602559936095;15984.840151598335;6181.412765787243;6241.313455519889;6286.277078136073;6371.203599550056;6374.58565193261;1070.8340207267886;1085.234909388879;1090.7273181704575;1094.813881640123;1096.1121491591837;25403.491930161294;25610.871945640527;25615.103471378414;25692.229233123035;26097.739022609912;1179.3867189061639;1183.0180949811636;1193.3675152169365;1193.8149586814059;1209.449700386322;13635.727285454434;13647.590572282847;13655.112417692819;13772.380242889094;13777.862221377858;282768;284321;285544;285906;286022;59659;59986.70006649939;60028.39971600316;60199.39800602025;60391;1513.8713209377106;1515.3484001879299;1533.7545992641124;1540.8998415103206;1559.5945054285967;25424.745752542236;25480.362990925376;25555.87222063878;25573;25840.35399114962;43063;43171.78414107909;43190;43201.78399107984;43247.783761080995;233147;234074;234174;234314;234321;39026.414603780395;39531;42175.36736948887;42214.788926055175;42450.78774606107;51583.48416515787;52200;52464.47535524596;52628.210576842146;52716;38519.422208667456;38631.03422414462;38759.806200968815;38857;39212.6078739209;38503;38642;38672.613273866904;38827;38957.80521097376;44770;44916.55083449124;45123.32315015343;45149.32276015928;45181;37323.44014839834;37476.2504749898;37539.24921501609;37709.622903771706;38222;27413;27426.5886011714;27697;27733.583996240475;27849.721502785524 04:01:15 INFO - PID 10133 | |2;jquery.html;582.525241927829;585.8301092683122;594.7888499582646;608.6713174885562;616.9198004259447;23663.76336236637;24044.639330410035;24261.27216183515;24343.26970190893;24361.390965225877;24396;27179.184624461297;27409.45181096377;27427;27447.31381715458;6586.242582103072;6665.600063996151;6741.730330786787;6802.251752307242;6814.250432452426;6441.6779161041995;6663.800085997404;6691.73233070679;6724.394804467597;6738.326167383247;6688.4649228061635;6693.866122677544;6696.799096027103;6699.564528305645;6701.798946031627;6400.359964003609;6679.3635559287795;6682.83292917676;6696.196456425236;6697.095892054584;6241.906371404432;6247.531435142337;6258.624482531017;6265.624062556261;6270.749170033238;30994.380112397852;31358.37283254322;31446.05661830149;31562;31605.20986975321;2296.8392212544964;2318.2813327868416;2319.3389883883183;2320.2923108451914;2321.6749655048307;20675.172993080258;21723.13107475699;21883.562328753334;21887.67168492474;22004.669929950902;2580.251726999168;2592.740725927411;2616.149751330825;2623.1081432313104;2632.4471860909234;140828;144092;152434.23782881125;154082;160375.19812400863;15265.771013434807;16658.66682666364;16683.416080437128;16688.6662266754;17076.876936918874;25236.621450678256;25299.114530991694;25343.366415839384;25534;25596;10942.726431839108;11105.389203593719;11127.833082503768;11149.16381271408;11190.94404527972;10010.599576016877;10092.747681308027;10156.289059765746;10164.33931794431;10185.33795303303;9946.303758736964;10168.28821982454;10186.134178594753;10211;10253.564500969871;2752.4632696623967;2756.986215068912;2764.1203981292915;2940.6765255821842;2990.8654110565076;1034.2863424237403;1040.380973320873;1053.3311347294523;1059.7880423915249;1067.114295135036;21532.461688457915;21949.122035118417;21957.560848782934;21987.450313741963;22097.447563811034;1096.3367162866512;1103.6302838549177;1111.5942680921405;1111.927724697892;1115.6876074699098;11674.94162529182;11996.400179990966;12034.63896083119;12085.939570302267;12151.453184606715;615404;619644.3285840641;625312;625992;637171;128457.35771321083;129138;131105;131351;131637;1112.7496313329436;1165.1785491228663;1199.2025303173466;1210.3282678113555;1261.236951644242;23004;23085;23294.417639559146;23452.882735586896;23549.764502355443;62237.377626223155;62722;63221.68389158025;63354.36645633669;64678.67660661667;75759.24240757522;79171.60414197893;79247;79705.60147199227;79738.60130699309;15628;15802.7629585554;15832.60418489547;15877;15922.124283164538;25017.249482515555;25185;25191.24426267215;25400.110996115047;25473.61789573195;19827.801721982596;20133.194672212947;20264.79735202629;20327.983600820196;20347.389578312675;17853.196606152494;18098.638027239645;18369.632607348045;18556;18708.345207917657;19885.602287953872;20821.583568328853;20947.8952605236;21161.73029618228;21317.680234796182;15598.688026239184;15615.609609759847;15689.372425102869;15753.369865205263;15811.920940395225;19112;19123.71314430257;19130.330438434587;20205;20563.4859128523 04:01:15 INFO - PID 10133 | |3;mootools.html;1390.6662401023755;1448.3989144505024;1451.8838492920568;1455.359641757626;1462.535627467717;16487;17158.485245442625;17191.054492002935;17214.311427542914;17230.827691723065;16878.662426751456;17021.48935531933;17021.91489042553;17023.744643830352;17026.74459883103;2786.3591373983995;2803.649543807024;2852.343960888986;2856.157433557106;2859.5710643403554;2855.6430446194227;2857.4856525825344;2869.4834929712642;2885.480613489571;2886.956695649567;2642.0224516928765;2822.252103192656;2929.5166297560877;2934.9119526414243;2936.192547049557;2885.9711402886123;2888.0902515707485;2906;2919.8832046718107;2926.2245504941316;2611.8041146914056;2811.5642075478336;2853.4578430098213;2855.1720001199833;2859.056511351249;16685.666286674197;17000.48998530046;17070.48788536346;17096.48710538686;17104.82895171045;8621.827563448696;8920.687775927812;8923.107689231025;8923.15230053144;8945;6031;6167.629942203482;6203.8138855834395;6268.216472940882;6297.905531417033;2039.6532589459828;2084.6560317547587;2121.3954023103342;2165.675148727688;2170.6201414752513;29836.850815746;29886.551701724493;29920.251993700113;29927.102186934426;30119.247018824484;7478.102627684604;7494.1381741099385;7506.512076714996;7538;7665.233476652402;19810.50473738168;19831;19839.107240174228;19843.702344464844;19846.60306793885;8450.239478446969;8756.03683594804;8757.2994160467;8767.649294028295;8770.035296117421;7942.245486678757;7958.403119766041;7981.321587664997;8011.679532818622;8050.396220283502;5562.360328562187;5708.571857110734;5710.628809127476;5740.368559458456;5759.8560035999435;1608.453125937187;1612.8145263294637;1626.8373162683874;1632;1639.8032236131503;901.5807649442909;923.7136487688704;931.1386967055582;933.6825479336923;938.7840796616816;7884.526928384315;7963.960180199062;7992.160823113606;8019.879701804478;8050.758477245692;767.2595944913074;777.8522080804629;781.0549235425199;783.5337973905517;800.1558355934545;4739.241721324572;5442.292501974718;5443.482869127427;5494.120940649477;5502.504774570308;23785.28644140644;24831.62752558713;25161.24516264515;25480.49039019209;25491.49017019649;23994.28017159488;24256.636150457758;24698.629520557206;24718.382040448774;25040.87479562627;11719.296842189497;11876.821847672292;11932;11992.460339284578;12011;8832.558372081241;8842.248408885316;8935;9009.099090090938;9054.909450905407;20638.484037899172;21271.680924785833;21409.250676226256;21885.234016809336;21945.341639750834;21289.78710212878;21630.242941496974;21846.672299915197;22206.555868882853;22434.102635895033;11973.640790776291;12148.149629525848;12230.082743794073;12326.81509777336;12334.259944403364;15450.150241736812;15456.381744730084;15590.610234743768;15604.843951560793;15744.29150688199;12665.176763510342;12736.872631273569;12789.61631151067;12802.295873727035;12891.742165156456;12097.69755756078;12352.4441400139;12484.750304994031;12565.623031308709;12625.368731563569;9833.16418104469;10106.39361638304;10122.392656440637;10132.138768204784;10141.695749127539;7446.813829654302;7520.736774212876;7557.773266802004;7570.432217583813;7612.543247405173;7731.226877312224;7732.497387669783;7733.955915951499;7754.806129846574;7876.72431464896 04:01:15 INFO - PID 10133 | |4;prototype.html;536.1127334261798;539.4659287305567;562.1595714406961;567.8069456384828;570.2444261353705;6204.937950620492;6227.968860155698;6228.626282423058;6243.906341404882;6285.182926219596;6143.784967526138;6177.691115444221;6188.597741146834;6222.346653601375;6258.930266484151;5053.761828352059;5064.252832772688;5085.338905942241;5101.132807422747;5107.336046313974;5016.520126562673;5064;5067.873303167432;5072.568831649314;5113.539781419671;4825.710457372569;4905.264210368456;4968.40379154502;4996.425411077718;5045.672031317971;4908.435529914034;4909.533594308535;4910.821402863323;4924.089043526959;4936.481669424713;4390;4445.9110817783785;4465.397171381855;4468.905118246018;4479.574440428154;6081.422264884829;6118.60229085108;6126.663033533154;6135.9079613805825;6150.169727086831;5822.33043200029;5823.330317013513;5824.679642619654;5829.795957141479;5852.531797456193;6528.347165283481;6533.509986751013;6572.70422830969;6603.867922641568;6622.768203112868;4961.578265847407;4978.303037574742;4980.601551875841;4992.950070499285;4993.875153121201;6670.1646553232085;6693.765718199888;6766.458683305324;6861.725530978755;6890.31096890312;5140.845774626767;5141.177411614124;5145.871353216125;5151.5621172200035;5184.326037615161;5197.792088316425;5200.84397468069;5212.973935130376;5242.501962313574;5250.1337279349245;5783.768649253982;5791.131330300489;5791.942080579224;5799.39106393831;5812;6546.738130474823;6563.440258299267;6572.375624315682;6581.736730530821;6635.938249880092;1781.8930864147933;1781.8930864148192;1787.8390944814769;1791.66854131986;1802.4862914069427;1213.5181190469204;1269.10528077705;1275.7129645829614;1280.4622058735354;1282.3652292115462;6123.38766123393;6139.969300153471;6147;6157.737663778915;6183.103449999725;6565.179352580927;6569;6600.73597056122;6630.602163870183;6681.732730690718;5853.180554722342;6030.5778595497895;6036.758529658764;6048.36492168316;6095.896915564123;3448.9310213795584;3468.757186996886;3483.3555792178527;3504.299140171925;3504.491848681978;6859.382655561023;6871;6888.896666550006;6906.965465172642;6947.687354069079;6870.7595234166565;6894.103766510422;6914.792556223321;6932.930670693329;6936.445084393236;6917.619530925746;6965.233824279224;6972.280810484017;6993.860122797617;7006.894896576556;6655.23464801554;6672.399484046459;6672.764623851064;6699.899501507384;6712.261651218264;6526.967365163144;6698.923333766548;6718;6732.326767323424;6736.66316684154;6882.483813714091;6886.48351373639;6887.20797108339;6937.826554336182;6946.37482626566;5127;5138.7923837897315;5146.099432599355;5164.845054648366;5200.843974680765;6594;6666.300038495888;6696.229933557508;6708.966455167693;6776.322367763184;6323.672028873804;6362.491000720024;6405.3594640535575;6475.320091390525;6481.4814814815645;6457.515686323451;6463.967680161569;6469.547131700736;6479.773207937699;6481.157449531719;6247.9062814056915;6270.655113968775;6338.74974384087;6361.491080713439;6386.68066596659;6451.290358060516;6476.579022363531;6484.28672845996;6526.967365163334;6558.508111891722;6151.415615516519;6260.280067792262;6264;6283.246010478589;6319.46284565817 04:01:15 INFO - PID 10133 | |5;yui.html;974.9415035097891;976.0971101730898;991.7471044883554;1001.4542074569359;1006.8187726209279;19851.900740496312;19876.90061549694;20169.59660806783;20191.09140088696;20194.59610807783;18433.723494147598;18801.62396752064;19074.237030518798;19108.331208407708;19125.139368728407;1042.4943902207424;1046.6493724602267;1047.5600247895902;1048.09863517375;1048.4076496779333;1059.5443959097624;1059.7350662334416;1059.9576016959313;1061.1404762142688;1064.3081996702128;1090.4057288777635;1117.4971262931713;1120.0535547462382;1121.9551217951273;1121.9831702524468;1109.2401704832175;1110.1340954055768;1113.6436340371085;1114.6934592986993;1118.983215251768;816.1919699497514;816.408104124505;819.1235378145387;819.512390127873;821.0557858462756;19843.90078049615;19925;19938.90030549838;19992.300269490643;20323.796762032485;23055.53888922212;23434.882825585933;23546.293611191693;23609.40976475585;23666.64500032501;17093.230804613697;17424.738628920575;17476.825231747647;17494.737578936325;17514.47456576305;3955.3078211312904;4001.799910004517;4013.578574249691;4029.9522124247615;4040.878773636796;142589;146200;156184;157814;160692;17960;18318.633627327377;18331.541711457052;18434.631307374046;18512.722309165372;35119.12202194965;35306.64693353033;35356.64643353534;35439.29121417557;35599.4660080099;9163.49600771964;9247.213986811063;9247.306452016126;9257.305702072372;9261.166495015346;4597.977010114928;4622.098690755271;4646.070785842778;4690.108879312919;4690.882727931761;6148.661823599656;6275.592086514362;6289.96855015722;6299.559030867887;6312.652804095727;1155.179822326141;1299.3048718935513;1331.740310639416;1342.2952949701485;1350.4125705318218;745.8769303065042;751.5302935665209;760.8782594784808;763.4465012865628;773.7988123087925;13523.256220907944;13652.590422287347;13904.86095139056;14738.926305368404;14872.776908346383;737.2811508779005;740.1599184925149;749.3330935467438;761.8704820180583;769.077107471037;6160.168377269101;6195.566310358232;6219.440250377488;6224.782132625427;6326.2724786649205;145226;145494.27252863668;146212;147676;148263;128560;128700;129598.35200824124;130103;132093;112023.99999999837;112397.4380128094;113465.4326728361;113506;116504.41747791207;11674.357910315015;11763.705907352385;11814.881851181379;11853.229540079867;11991;55571;56206.43793562012;56283;56540.43459565516;57569.136462953924;69862.65068674827;70982.29017709757;71209.28790712234;71658;73193.26806732078;17391.130443477523;17586.912065439592;17587.912060439616;17720;17734.201960912047;19207.61584768269;20356;20369.18523259053;20376.388708338774;20558.486037849172;18091.728624070915;18093.547661308574;18094.457166285032;18152.27390904349;18278.81721182771;17895.910520447316;18187.45437636873;18309.908450458195;18335.633287334447;18354.90822545879;15719.371225150866;15746;15778.605534861721;15910.0453972762;15912.602184945468;13815.792763108762;13919.79120313176;13952.79070813959;14051.086679365808;14127.364268607731;13346;13365.198088114745;13516.459341626225;13640;13688.520901768788 04:01:15 INFO - PID 10133 | __end_tp_report 04:01:15 INFO - PID 10133 | __start_cc_report 04:01:15 INFO - PID 10133 | _x_x_mozilla_cycle_collect,350 04:01:15 INFO - PID 10133 | __end_cc_report 04:01:15 INFO - PID 10133 | __startTimestamp1505127675329__endTimestamp 04:01:15 INFO - PID 10133 | 04:01:15 INFO - PID 10133 | ------- Summary: start ------- 04:01:15 INFO - PID 10133 | Number of tests: 6 04:01:15 INFO - PID 10133 | 04:01:15 INFO - PID 10133 | [#0] dojo.html Cycles:165 Average:6310.96 Median:6517.09 stddev:750.51 (11.5%) stddev-sans-first:727.74 04:01:15 INFO - PID 10133 | Values: 3858.7 3863.8 3868.1 3884.1 3936.6 6245.9 6273.7 6344.4 6359.4 6426.0 6311.6 6355.4 6369.7 6378.8 6393.0 5569.9 5573.2 5613.6 5623.0 5664.9 5666.9 5704.2 5707.3 5741.9 5770.2 5712.0 5770.1 5792.9 5812.8 5825.1 5553.8 5618.8 5692.7 5709.5 5785.2 5569.6 5637.0 5652.9 5688.7 5703.7 6269.7 6281.1 6354.6 6370.9 6387.7 6758.5 6857.4 6873.6 6948.7 6974.2 6806.3 6907.5 6988.7 6999.1 7035.3 6367.4 6380.3 6452.4 6456.0 6456.5 7023.8 7036.2 7058.6 7123.4 7123.7 6706.7 6714.4 6770.9 6782.9 6824.4 6900.9 6944.2 6956.4 6976.0 6987.5 6820.2 6846.7 6856.5 6927.6 6952.1 6800.2 6865.9 6878.6 6891.2 6896.1 4999.5 5057.3 5069.7 5071.7 5081.1 4554.8 4568.5 4585.4 4595.2 4604.2 6223.1 6287.5 6324.1 6351.3 6352.4 6732.9 6752.3 6837.4 6840.9 6844.2 6211.8 6216.0 6287.1 6311.6 6317.5 5443.6 5494.2 5530.9 5542.5 5566.4 7116.6 7126.8 7131.3 7133.5 7137.6 6651.0 6733.7 6741.7 6813.9 6829.9 7025.5 7039.3 7090.1 7129.6 7161.6 6802.3 6806.0 6883.5 6885.4 6888.3 6917.3 6920.6 6961.9 6973.2 7008.3 6536.9 6540.6 6542.7 6544.7 6629.7 6513.9 6563.8 6583.3 6618.8 6671.2 6515.1 6517.1 6583.1 6585.8 6602.6 6576.6 6620.2 6635.3 6686.9 6723.6 6449.7 6459.8 6470.9 6473.6 6478.4 04:01:15 INFO - PID 10133 | 04:01:15 INFO - PID 10133 | [#1] ext.html Cycles:180 Average:43495.62 Median:38992.11 stddev:64325.50 (165.0%) stddev-sans-first:64426.44 04:01:15 INFO - PID 10133 | Values: 900.4 945.2 973.6 1009.9 1011.6 43024.6 45133.3 45279.0 45341.3 45345.3 42531.0 42576.8 42710.8 42773.1 42813.6 7371.7 7511.2 7530.5 7532.3 7536.8 7395.0 7473.4 7475.8 7476.3 7487.4 7914.4 8085.1 8088.0 8091.2 8095.8 7960.3 8057.0 8059.3 8060.0 8060.7 7867.8 8048.4 8053.2 8059.2 8061.4 42135.0 42624.0 42634.1 42697.0 42736.0 3782.5 3798.1 3820.7 3837.4 3839.4 33569.2 33573.0 33589.2 33700.3 33742.5 5497.6 5504.4 5539.3 5553.9 5573.9 209052.0 209188.0 210512.0 213568.0 247045.8 53207.0 53387.0 53545.0 53653.0 53662.0 57041.0 57121.4 57277.0 57284.4 57311.0 16222.5 16333.3 16413.0 16428.3 16583.7 13383.6 13511.8 13512.7 13521.9 13522.4 15691.6 15864.5 15886.0 15897.6 15984.8 6181.4 6241.3 6286.3 6371.2 6374.6 1070.8 1085.2 1090.7 1094.8 1096.1 25403.5 25610.9 25615.1 25692.2 26097.7 1179.4 1183.0 1193.4 1193.8 1209.4 13635.7 13647.6 13655.1 13772.4 13777.9 282768.0 284321.0 285544.0 285906.0 286022.0 59659.0 59986.7 60028.4 60199.4 60391.0 1513.9 1515.3 1533.8 1540.9 1559.6 25424.7 25480.4 25555.9 25573.0 25840.4 43063.0 43171.8 43190.0 43201.8 43247.8 233147.0 234074.0 234174.0 234314.0 234321.0 39026.4 39531.0 42175.4 42214.8 42450.8 51583.5 52200.0 52464.5 52628.2 52716.0 38519.4 38631.0 38759.8 38857.0 39212.6 38503.0 38642.0 38672.6 38827.0 38957.8 44770.0 44916.6 45123.3 45149.3 45181.0 37323.4 37476.3 37539.2 37709.6 38222.0 27413.0 27426.6 27697.0 27733.6 27849.7 04:01:15 INFO - PID 10133 | 04:01:15 INFO - PID 10133 | [#2] jquery.html Cycles:180 Average:40614.24 Median:23044.50 stddev:104223.63 (452.3%) stddev-sans-first:104472.67 04:01:15 INFO - PID 10133 | Values: 582.5 585.8 594.8 608.7 616.9 23663.8 24044.6 24261.3 24343.3 24361.4 24396.0 27179.2 27409.5 27427.0 27447.3 6586.2 6665.6 6741.7 6802.3 6814.3 6441.7 6663.8 6691.7 6724.4 6738.3 6688.5 6693.9 6696.8 6699.6 6701.8 6400.4 6679.4 6682.8 6696.2 6697.1 6241.9 6247.5 6258.6 6265.6 6270.7 30994.4 31358.4 31446.1 31562.0 31605.2 2296.8 2318.3 2319.3 2320.3 2321.7 20675.2 21723.1 21883.6 21887.7 22004.7 2580.3 2592.7 2616.1 2623.1 2632.4 140828.0 144092.0 152434.2 154082.0 160375.2 15265.8 16658.7 16683.4 16688.7 17076.9 25236.6 25299.1 25343.4 25534.0 25596.0 10942.7 11105.4 11127.8 11149.2 11190.9 10010.6 10092.7 10156.3 10164.3 10185.3 9946.3 10168.3 10186.1 10211.0 10253.6 2752.5 2757.0 2764.1 2940.7 2990.9 1034.3 1040.4 1053.3 1059.8 1067.1 21532.5 21949.1 21957.6 21987.5 22097.4 1096.3 1103.6 1111.6 1111.9 1115.7 11674.9 11996.4 12034.6 12085.9 12151.5 615404.0 619644.3 625312.0 625992.0 637171.0 128457.4 129138.0 131105.0 131351.0 131637.0 1112.7 1165.2 1199.2 1210.3 1261.2 23004.0 23085.0 23294.4 23452.9 23549.8 62237.4 62722.0 63221.7 63354.4 64678.7 75759.2 79171.6 79247.0 79705.6 79738.6 15628.0 15802.8 15832.6 15877.0 15922.1 25017.2 25185.0 25191.2 25400.1 25473.6 19827.8 20133.2 20264.8 20328.0 20347.4 17853.2 18098.6 18369.6 18556.0 18708.3 19885.6 20821.6 20947.9 21161.7 21317.7 15598.7 15615.6 15689.4 15753.4 15811.9 19112.0 19123.7 19130.3 20205.0 20563.5 04:01:15 INFO - PID 10133 | 04:01:15 INFO - PID 10133 | [#3] mootools.html Cycles:180 Average:10340.16 Median:2852.90 stddev:7679.73 (269.2%) stddev-sans-first:7671.84 04:01:15 INFO - PID 10133 | Values: 1390.7 1448.4 1451.9 1455.4 1462.5 16487.0 17158.5 17191.1 17214.3 17230.8 16878.7 17021.5 17021.9 17023.7 17026.7 2786.4 2803.6 2852.3 2856.2 2859.6 2855.6 2857.5 2869.5 2885.5 2887.0 2642.0 2822.3 2929.5 2934.9 2936.2 2886.0 2888.1 2906.0 2919.9 2926.2 2611.8 2811.6 2853.5 2855.2 2859.1 16685.7 17000.5 17070.5 17096.5 17104.8 8621.8 8920.7 8923.1 8923.2 8945.0 6031.0 6167.6 6203.8 6268.2 6297.9 2039.7 2084.7 2121.4 2165.7 2170.6 29836.9 29886.6 29920.3 29927.1 30119.2 7478.1 7494.1 7506.5 7538.0 7665.2 19810.5 19831.0 19839.1 19843.7 19846.6 8450.2 8756.0 8757.3 8767.6 8770.0 7942.2 7958.4 7981.3 8011.7 8050.4 5562.4 5708.6 5710.6 5740.4 5759.9 1608.5 1612.8 1626.8 1632.0 1639.8 901.6 923.7 931.1 933.7 938.8 7884.5 7964.0 7992.2 8019.9 8050.8 767.3 777.9 781.1 783.5 800.2 4739.2 5442.3 5443.5 5494.1 5502.5 23785.3 24831.6 25161.2 25480.5 25491.5 23994.3 24256.6 24698.6 24718.4 25040.9 11719.3 11876.8 11932.0 11992.5 12011.0 8832.6 8842.2 8935.0 9009.1 9054.9 20638.5 21271.7 21409.3 21885.2 21945.3 21289.8 21630.2 21846.7 22206.6 22434.1 11973.6 12148.1 12230.1 12326.8 12334.3 15450.2 15456.4 15590.6 15604.8 15744.3 12665.2 12736.9 12789.6 12802.3 12891.7 12097.7 12352.4 12484.8 12565.6 12625.4 9833.2 10106.4 10122.4 10132.1 10141.7 7446.8 7520.7 7557.8 7570.4 7612.5 7731.2 7732.5 7734.0 7754.8 7876.7 04:01:15 INFO - PID 10133 | 04:01:15 INFO - PID 10133 | [#4] prototype.html Cycles:180 Average:5573.52 Median:6167.71 stddev:1555.09 (25.2%) stddev-sans-first:1512.79 04:01:15 INFO - PID 10133 | Values: 536.1 539.5 562.2 567.8 570.2 6204.9 6228.0 6228.6 6243.9 6285.2 6143.8 6177.7 6188.6 6222.3 6258.9 5053.8 5064.3 5085.3 5101.1 5107.3 5016.5 5064.0 5067.9 5072.6 5113.5 4825.7 4905.3 4968.4 4996.4 5045.7 4908.4 4909.5 4910.8 4924.1 4936.5 4390.0 4445.9 4465.4 4468.9 4479.6 6081.4 6118.6 6126.7 6135.9 6150.2 5822.3 5823.3 5824.7 5829.8 5852.5 6528.3 6533.5 6572.7 6603.9 6622.8 4961.6 4978.3 4980.6 4993.0 4993.9 6670.2 6693.8 6766.5 6861.7 6890.3 5140.8 5141.2 5145.9 5151.6 5184.3 5197.8 5200.8 5213.0 5242.5 5250.1 5783.8 5791.1 5791.9 5799.4 5812.0 6546.7 6563.4 6572.4 6581.7 6635.9 1781.9 1781.9 1787.8 1791.7 1802.5 1213.5 1269.1 1275.7 1280.5 1282.4 6123.4 6140.0 6147.0 6157.7 6183.1 6565.2 6569.0 6600.7 6630.6 6681.7 5853.2 6030.6 6036.8 6048.4 6095.9 3448.9 3468.8 3483.4 3504.3 3504.5 6859.4 6871.0 6888.9 6907.0 6947.7 6870.8 6894.1 6914.8 6932.9 6936.4 6917.6 6965.2 6972.3 6993.9 7006.9 6655.2 6672.4 6672.8 6699.9 6712.3 6527.0 6698.9 6718.0 6732.3 6736.7 6882.5 6886.5 6887.2 6937.8 6946.4 5127.0 5138.8 5146.1 5164.8 5200.8 6594.0 6666.3 6696.2 6709.0 6776.3 6323.7 6362.5 6405.4 6475.3 6481.5 6457.5 6464.0 6469.5 6479.8 6481.2 6247.9 6270.7 6338.7 6361.5 6386.7 6451.3 6476.6 6484.3 6527.0 6558.5 6151.4 6260.3 6264.0 6283.2 6319.5 04:01:15 INFO - PID 10133 | 04:01:15 INFO - PID 10133 | [#5] yui.html Cycles:180 Average:27964.20 Median:18314.27 stddev:41241.71 (225.2%) stddev-sans-first:41307.62 04:01:15 INFO - PID 10133 | Values: 974.9 976.1 991.7 1001.5 1006.8 19851.9 19876.9 20169.6 20191.1 20194.6 18433.7 18801.6 19074.2 19108.3 19125.1 1042.5 1046.6 1047.6 1048.1 1048.4 1059.5 1059.7 1060.0 1061.1 1064.3 1090.4 1117.5 1120.1 1122.0 1122.0 1109.2 1110.1 1113.6 1114.7 1119.0 816.2 816.4 819.1 819.5 821.1 19843.9 19925.0 19938.9 19992.3 20323.8 23055.5 23434.9 23546.3 23609.4 23666.6 17093.2 17424.7 17476.8 17494.7 17514.5 3955.3 4001.8 4013.6 4030.0 4040.9 142589.0 146200.0 156184.0 157814.0 160692.0 17960.0 18318.6 18331.5 18434.6 18512.7 35119.1 35306.6 35356.6 35439.3 35599.5 9163.5 9247.2 9247.3 9257.3 9261.2 4598.0 4622.1 4646.1 4690.1 4690.9 6148.7 6275.6 6290.0 6299.6 6312.7 1155.2 1299.3 1331.7 1342.3 1350.4 745.9 751.5 760.9 763.4 773.8 13523.3 13652.6 13904.9 14738.9 14872.8 737.3 740.2 749.3 761.9 769.1 6160.2 6195.6 6219.4 6224.8 6326.3 145226.0 145494.3 146212.0 147676.0 148263.0 128560.0 128700.0 129598.4 130103.0 132093.0 112024.0 112397.4 113465.4 113506.0 116504.4 11674.4 11763.7 11814.9 11853.2 11991.0 55571.0 56206.4 56283.0 56540.4 57569.1 69862.7 70982.3 71209.3 71658.0 73193.3 17391.1 17586.9 17587.9 17720.0 17734.2 19207.6 20356.0 20369.2 20376.4 20558.5 18091.7 18093.5 18094.5 18152.3 18278.8 17895.9 18187.5 18309.9 18335.6 18354.9 15719.4 15746.0 15778.6 15910.0 15912.6 13815.8 13919.8 13952.8 14051.1 14127.4 13346.0 13365.2 13516.5 13640.0 13688.5 04:01:15 INFO - PID 10133 | -------- Summary: end -------- 04:01:15 INFO - PID 10133 | 04:01:15 INFO - TEST-INFO | 10133: exit 0 04:01:16 INFO - TEST-OK | dromaeo_css | took 1108515ms 04:01:16 INFO - TEST-START | kraken 04:01:16 INFO - Initialising browser for kraken test... 04:01:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46750/getInfo.html -profile /tmp/tmpUTf47V/profile 04:01:16 INFO - TEST-INFO | started process 10518 (/builds/slave/test/build/application/firefox/firefox http://localhost:46750/getInfo.html) 04:01:21 INFO - TEST-INFO | 10518: exit 0 04:01:21 INFO - Browser initialized. 04:01:21 INFO - Running cycle 1/1 for kraken test... 04:01:21 INFO - Using env: {'DISPLAY': ':0', 04:01:21 INFO - 'HOME': '/home/cltbld', 04:01:21 INFO - 'JSGC_DISABLE_POISONING': '1', 04:01:21 INFO - 'LANG': 'en_US.UTF-8', 04:01:21 INFO - 'LANGUAGE': 'en_US:en', 04:01:21 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:01:21 INFO - 'LOGNAME': 'cltbld', 04:01:21 INFO - 'MAIL': '/var/mail/cltbld', 04:01:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:01:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:01:21 INFO - 'MOZ_CRASHREPORTER': '1', 04:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:21 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:01:21 INFO - 'MOZ_NO_REMOTE': '1', 04:01:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:01:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:21 INFO - 'NO_EM_RESTART': '1', 04:01:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:21 INFO - 'PWD': '/builds/slave/test', 04:01:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:01:21 INFO - 'RUST_BACKTRACE': 'full', 04:01:21 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:01:21 INFO - 'SHELL': '/bin/bash', 04:01:21 INFO - 'SHLVL': '1', 04:01:21 INFO - 'TERM': 'linux', 04:01:21 INFO - 'TMOUT': '86400', 04:01:21 INFO - 'USER': 'cltbld', 04:01:21 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332', 04:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:21 INFO - '_': '/tools/buildbot/bin/python'} 04:01:21 INFO - TEST-INFO | started process 10721 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUTf47V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:01:22 INFO - PID 10721 | 04:01:22 INFO - PID 10721 | (/builds/slave/test/build/application/firefox/firefox:10772): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:01:22 INFO - PID 10721 | 04:01:32 INFO - PID 10721 | RSS: Main: 164470784 04:01:32 INFO - PID 10721 | 04:01:35 INFO - PID 10721 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46750/tests/kraken/driver.html?testName=audio-beat-detection) 04:01:36 INFO - PID 10721 | RSS: Main: 170577920 04:01:36 INFO - PID 10721 | 04:01:38 INFO - PID 10721 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46750/tests/kraken/driver.html?testName=audio-dft) 04:01:39 INFO - PID 10721 | RSS: Main: 170999808 04:01:39 INFO - PID 10721 | 04:01:42 INFO - PID 10721 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46750/tests/kraken/driver.html?testName=audio-fft) 04:01:42 INFO - PID 10721 | RSS: Main: 164917248 04:01:42 INFO - PID 10721 | 04:01:44 INFO - PID 10721 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46750/tests/kraken/driver.html?testName=audio-oscillator) 04:01:45 INFO - PID 10721 | RSS: Main: 166178816 04:01:45 INFO - PID 10721 | 04:01:47 INFO - PID 10721 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46750/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:01:48 INFO - PID 10721 | RSS: Main: 166539264 04:01:48 INFO - PID 10721 | 04:01:51 INFO - PID 10721 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46750/tests/kraken/driver.html?testName=imaging-darkroom) 04:01:52 INFO - PID 10721 | RSS: Main: 169725952 04:01:52 INFO - PID 10721 | 04:01:55 INFO - PID 10721 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46750/tests/kraken/driver.html?testName=imaging-desaturate) 04:01:56 INFO - PID 10721 | RSS: Main: 169271296 04:01:56 INFO - PID 10721 | 04:01:59 INFO - PID 10721 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46750/tests/kraken/driver.html?testName=json-parse-financial) 04:01:59 INFO - PID 10721 | RSS: Main: 169070592 04:01:59 INFO - PID 10721 | 04:02:01 INFO - PID 10721 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46750/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:02:01 INFO - PID 10721 | RSS: Main: 168927232 04:02:01 INFO - PID 10721 | 04:02:03 INFO - PID 10721 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46750/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:02:04 INFO - PID 10721 | RSS: Main: 168923136 04:02:04 INFO - PID 10721 | 04:02:06 INFO - PID 10721 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46750/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:02:06 INFO - PID 10721 | RSS: Main: 165957632 04:02:06 INFO - PID 10721 | 04:02:09 INFO - PID 10721 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46750/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:02:10 INFO - PID 10721 | RSS: Main: 165834752 04:02:10 INFO - PID 10721 | 04:02:12 INFO - PID 10721 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46750/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:02:13 INFO - PID 10721 | RSS: Main: 166268928 04:02:13 INFO - PID 10721 | 04:02:15 INFO - PID 10721 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46750/tests/kraken/driver.html?testName=ai-astar) 04:02:15 INFO - PID 10721 | RSS: Main: 167493632 04:02:15 INFO - PID 10721 | 04:02:15 INFO - PID 10721 | __start_tp_report 04:02:15 INFO - PID 10721 | _x_x_mozilla_page_load 04:02:15 INFO - PID 10721 | _x_x_mozilla_page_load_details 04:02:15 INFO - PID 10721 | |i|pagename|runs| 04:02:15 INFO - PID 10721 | |0;ai-astar;107;104;105;105;108;108;107;106;105;107 04:02:15 INFO - PID 10721 | |1;audio-beat-detection;115;115;115;114;117;114;112;114;117;112 04:02:15 INFO - PID 10721 | |2;audio-dft;162;162;163;162;165;164;165;163;165;171 04:02:15 INFO - PID 10721 | |3;audio-fft;73;73;74;76;73;73;73;73;73;73 04:02:15 INFO - PID 10721 | |4;audio-oscillator;80;80;78;77;77;78;78;78;78;82 04:02:15 INFO - PID 10721 | |5;imaging-gaussian-blur;114;113;113;114;114;113;113;114;113;112 04:02:15 INFO - PID 10721 | |6;imaging-darkroom;151;151;152;151;150;150;150;150;149;150 04:02:15 INFO - PID 10721 | |7;imaging-desaturate;94;93;94;95;94;94;94;95;94;94 04:02:15 INFO - PID 10721 | |8;json-parse-financial;48;50;44;48;43;43;44;50;44;43 04:02:15 INFO - PID 10721 | |9;json-stringify-tinderbox;38;38;38;38;38;38;38;38;39;38 04:02:15 INFO - PID 10721 | |10;stanford-crypto-aes;74;74;73;72;74;73;73;73;77;73 04:02:15 INFO - PID 10721 | |11;stanford-crypto-ccm;120;116;124;109;122;115;117;120;108;117 04:02:15 INFO - PID 10721 | |12;stanford-crypto-pbkdf2;159;167;153;158;153;165;155;157;158;156 04:02:15 INFO - PID 10721 | |13;stanford-crypto-sha256-iterative;63;59;66;59;60;58;63;58;61;61 04:02:15 INFO - PID 10721 | __end_tp_report 04:02:15 INFO - PID 10721 | __start_cc_report 04:02:15 INFO - PID 10721 | _x_x_mozilla_cycle_collect,875 04:02:15 INFO - PID 10721 | __end_cc_report 04:02:15 INFO - PID 10721 | __startTimestamp1505127735441__endTimestamp 04:02:15 INFO - PID 10721 | 04:02:15 INFO - PID 10721 | ------- Summary: start ------- 04:02:15 INFO - PID 10721 | Number of tests: 14 04:02:15 INFO - PID 10721 | 04:02:15 INFO - PID 10721 | [#0] ai-astar Cycles:10 Average:106.20 Median:107.00 stddev:1.40 (1.3%) stddev-sans-first:1.45 04:02:15 INFO - PID 10721 | Values: 107.0 104.0 105.0 105.0 108.0 108.0 107.0 106.0 105.0 107.0 04:02:15 INFO - PID 10721 | 04:02:15 INFO - PID 10721 | [#1] audio-beat-detection Cycles:10 Average:114.50 Median:115.00 stddev:1.72 (1.5%) stddev-sans-first:1.81 04:02:15 INFO - PID 10721 | Values: 115.0 115.0 115.0 114.0 117.0 114.0 112.0 114.0 117.0 112.0 04:02:15 INFO - PID 10721 | 04:02:15 INFO - PID 10721 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.50 stddev:2.70 (1.6%) stddev-sans-first:2.74 04:02:15 INFO - PID 10721 | Values: 162.0 162.0 163.0 162.0 165.0 164.0 165.0 163.0 165.0 171.0 04:02:15 INFO - PID 10721 | 04:02:15 INFO - PID 10721 | [#3] audio-fft Cycles:10 Average:73.40 Median:73.00 stddev:0.97 (1.3%) stddev-sans-first:1.01 04:02:15 INFO - PID 10721 | Values: 73.0 73.0 74.0 76.0 73.0 73.0 73.0 73.0 73.0 73.0 04:02:15 INFO - PID 10721 | 04:02:15 INFO - PID 10721 | [#4] audio-oscillator Cycles:10 Average:78.60 Median:78.00 stddev:1.58 (2.0%) stddev-sans-first:1.59 04:02:15 INFO - PID 10721 | Values: 80.0 80.0 78.0 77.0 77.0 78.0 78.0 78.0 78.0 82.0 04:02:15 INFO - PID 10721 | 04:02:15 INFO - PID 10721 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:113.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 04:02:15 INFO - PID 10721 | Values: 114.0 113.0 113.0 114.0 114.0 113.0 113.0 114.0 113.0 112.0 04:02:15 INFO - PID 10721 | 04:02:15 INFO - PID 10721 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 04:02:15 INFO - PID 10721 | Values: 151.0 151.0 152.0 151.0 150.0 150.0 150.0 150.0 149.0 150.0 04:02:15 INFO - PID 10721 | 04:02:15 INFO - PID 10721 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 04:02:15 INFO - PID 10721 | Values: 94.0 93.0 94.0 95.0 94.0 94.0 94.0 95.0 94.0 94.0 04:02:15 INFO - PID 10721 | 04:02:15 INFO - PID 10721 | [#8] json-parse-financial Cycles:10 Average:45.70 Median:46.00 stddev:2.95 (6.4%) stddev-sans-first:3.00 04:02:15 INFO - PID 10721 | Values: 48.0 50.0 44.0 48.0 43.0 43.0 44.0 50.0 44.0 43.0 04:02:15 INFO - PID 10721 | 04:02:15 INFO - PID 10721 | [#9] json-stringify-tinderbox Cycles:10 Average:38.10 Median:38.00 stddev:0.32 (0.8%) stddev-sans-first:0.33 04:02:15 INFO - PID 10721 | Values: 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 39.0 38.0 04:02:15 INFO - PID 10721 | 04:02:15 INFO - PID 10721 | [#10] stanford-crypto-aes Cycles:10 Average:73.60 Median:73.50 stddev:1.35 (1.8%) stddev-sans-first:1.42 04:02:15 INFO - PID 10721 | Values: 74.0 74.0 73.0 72.0 74.0 73.0 73.0 73.0 77.0 73.0 04:02:15 INFO - PID 10721 | 04:02:15 INFO - PID 10721 | [#11] stanford-crypto-ccm Cycles:10 Average:116.80 Median:118.50 stddev:5.18 (4.4%) stddev-sans-first:5.36 04:02:15 INFO - PID 10721 | Values: 120.0 116.0 124.0 109.0 122.0 115.0 117.0 120.0 108.0 117.0 04:02:15 INFO - PID 10721 | 04:02:15 INFO - PID 10721 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.10 Median:158.00 stddev:4.65 (2.9%) stddev-sans-first:4.92 04:02:15 INFO - PID 10721 | Values: 159.0 167.0 153.0 158.0 153.0 165.0 155.0 157.0 158.0 156.0 04:02:15 INFO - PID 10721 | 04:02:15 INFO - PID 10721 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.80 Median:61.00 stddev:2.57 (4.2%) stddev-sans-first:2.60 04:02:15 INFO - PID 10721 | Values: 63.0 59.0 66.0 59.0 60.0 58.0 63.0 58.0 61.0 61.0 04:02:15 INFO - PID 10721 | -------- Summary: end -------- 04:02:15 INFO - PID 10721 | 04:02:16 INFO - PID 10721 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:02:16 INFO - TEST-INFO | 10721: exit 0 04:02:16 INFO - TEST-OK | kraken | took 60368ms 04:02:16 INFO - SUITE-END | took 1168s 04:02:16 INFO - Completed test suite (00:19:29) 04:02:16 INFO - javascript benchmark 04:02:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9105.447516144219, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3858.7491813032143, 3863.7681739095647, 3868.149007218413, 3884.10665546924, 3936.6457018868296, 6245.906311405332, 6273.717682704278, 6344.397282258178, 6359.364063593638, 6425.967870160648, 6311.589746666464, 6355.364463553642, 6369.681515924197, 6378.808635740924, 6392.968035159829, 5569.916451253234, 5573.247611572447, 5613.607047506686, 5623.0, 5664.943350566483, 5666.914996275039, 5704.172894930232, 5707.286589176353, 5741.885162296772, 5770.2210201622665, 5712.0, 5770.134479828017, 5792.942070579283, 5812.767489300423, 5825.126231065353, 5553.8333849984565, 5618.775248990036, 5692.743826527775, 5709.457601527848, 5785.190073389729, 5569.582281328876, 5637.0, 5652.858678533028, 5688.744006519716, 5703.657780533182, 6269.749210031593, 6281.089242059876, 6354.618722876642, 6370.904436433457, 6387.712552935082, 6758.459323254128, 6857.405538289358, 6873.621950792704, 6948.6525673716615, 6974.197967233782, 6806.251312355637, 6907.516473846833, 6988.720451181946, 6999.055127557765, 7035.261297563785, 6367.363263673688, 6380.266269378988, 6452.354764523557, 6456.031595260749, 6456.548041637087, 7023.754168604074, 7036.226015138331, 7058.647067646597, 7123.43012558994, 7123.679434425463, 6706.731730730814, 6714.362135597111, 6770.932290677129, 6782.898256526156, 6824.4199243064895, 6900.896486552706, 6944.166699996033, 6956.373926346653, 6976.0, 6987.475939304572, 6820.181578210647, 6846.726130954806, 6856.520043597, 6927.618980956096, 6952.130983627047, 6800.217974932847, 6865.931340686529, 6878.55289406187, 6891.173059232924, 6896.069030680794, 4999.475055119233, 5057.266696329012, 5069.695818250917, 5071.670341427795, 5081.136206844845, 4554.793843965482, 4568.451785785727, 4585.403897493371, 4595.195840727859, 4604.217283061887, 6223.066540019034, 6287.49700023997, 6324.08300796382, 6351.2696039956, 6352.36476352361, 6732.899006514906, 6752.257251702309, 6837.35045170708, 6840.863182736317, 6844.178698556205, 6211.844703882349, 6215.96892015537, 6287.088372186099, 6311.621302721851, 6317.4946004319545, 5443.618946673774, 5494.230807686927, 5530.889382212334, 5542.473465020817, 5566.443355664401, 7116.608586527687, 7126.821829454305, 7131.322524360177, 7133.500654954103, 7137.571745695275, 6650.9667451662435, 6733.696983635748, 6741.662916854236, 6813.931860681329, 6829.93170068293, 7025.543339682904, 7039.331263529956, 7090.149182098181, 7129.607871566906, 7161.57030578167, 6802.285759995129, 6806.0, 6883.518153729191, 6885.449164066963, 6888.276730943379, 6917.308269173042, 6920.5847649141215, 6961.860762784817, 6973.19808222061, 7008.264132266243, 6536.901946470902, 6540.607563546202, 6542.705578248895, 6544.705488252945, 6629.701663425254, 6513.8697226056165, 6563.803085907431, 6583.275839657538, 6618.801435956929, 6671.232808227116, 6515.087887695631, 6517.087607734826, 6583.078369028244, 6585.80242592723, 6602.60384376939, 6576.572522786004, 6620.205575330799, 6635.336466353326, 6686.866262674622, 6723.596584204964, 6449.709763060768, 6459.806205813833, 6470.870582588416, 6473.579217350857, 6478.449331806849], "value": 6259.883858948652, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [900.3922352412122, 945.2343601682634, 973.6397532912821, 1009.9091081802636, 1011.6358111080015, 43024.56975430245, 45133.32300015498, 45279.0, 45341.31988020182, 45345.31982020268, 42531.0, 42576.78711606438, 42710.7864460678, 42773.144537109314, 42813.571864281344, 7371.668274927628, 7511.248875112472, 7530.548167109963, 7532.284432978886, 7536.773896783106, 7394.963025184867, 7473.439492038092, 7475.775726728207, 7476.252374762535, 7487.438442116836, 7914.445988780788, 8085.07021692507, 8087.959560202191, 8091.19088091192, 8095.797605059862, 7960.283574478296, 8056.959715201445, 8059.274665280153, 8060.03279606451, 8060.677572897077, 7867.763967080997, 8048.356131509465, 8053.15441878606, 8059.153788852203, 8061.395395345373, 42135.0, 42624.0, 42634.14731705349, 42697.0, 42736.0, 3782.508273924372, 3798.0504873781556, 3820.7134464915243, 3837.424386342043, 3839.4240863870364, 33569.16077098068, 33573.0, 33589.160270993176, 33700.32599348024, 33742.493862592084, 5497.582081954673, 5504.422035686235, 5539.2522009529, 5553.888922221573, 5573.8606534836545, 209052.0, 209188.0, 210512.0, 213568.0, 247045.7647711768, 53207.0, 53387.0, 53545.0, 53653.0, 53662.0, 57041.0, 57121.428785711614, 57277.0, 57284.42715572874, 57311.0, 16222.51332460028, 16333.346666133459, 16413.015219086654, 16428.260728267258, 16583.6683266334, 13383.598492045254, 13511.797323040162, 13512.729745405037, 13521.864781352257, 13522.391492382867, 15691.607709807346, 15864.52406427809, 15886.0, 15897.602559936095, 15984.840151598335, 6181.412765787243, 6241.313455519889, 6286.277078136073, 6371.203599550056, 6374.58565193261, 1070.8340207267886, 1085.234909388879, 1090.7273181704575, 1094.813881640123, 1096.1121491591837, 25403.491930161294, 25610.871945640527, 25615.103471378414, 25692.229233123035, 26097.739022609912, 1179.3867189061639, 1183.0180949811636, 1193.3675152169365, 1193.8149586814059, 1209.449700386322, 13635.727285454434, 13647.590572282847, 13655.112417692819, 13772.380242889094, 13777.862221377858, 282768.0, 284321.0, 285544.0, 285906.0, 286022.0, 59659.0, 59986.70006649939, 60028.39971600316, 60199.39800602025, 60391.0, 1513.8713209377106, 1515.3484001879299, 1533.7545992641124, 1540.8998415103206, 1559.5945054285967, 25424.745752542236, 25480.362990925376, 25555.87222063878, 25573.0, 25840.35399114962, 43063.0, 43171.78414107909, 43190.0, 43201.78399107984, 43247.783761080995, 233147.0, 234074.0, 234174.0, 234314.0, 234321.0, 39026.414603780395, 39531.0, 42175.36736948887, 42214.788926055175, 42450.78774606107, 51583.48416515787, 52200.0, 52464.47535524596, 52628.210576842146, 52716.0, 38519.422208667456, 38631.03422414462, 38759.806200968815, 38857.0, 39212.6078739209, 38503.0, 38642.0, 38672.613273866904, 38827.0, 38957.80521097376, 44770.0, 44916.55083449124, 45123.32315015343, 45149.32276015928, 45181.0, 37323.44014839834, 37476.2504749898, 37539.24921501609, 37709.622903771706, 38222.0, 27413.0, 27426.5886011714, 27697.0, 27733.583996240475, 27849.721502785524], "value": 19018.1748160897, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.525241927829, 585.8301092683122, 594.7888499582646, 608.6713174885562, 616.9198004259447, 23663.76336236637, 24044.639330410035, 24261.27216183515, 24343.26970190893, 24361.390965225877, 24396.0, 27179.184624461297, 27409.45181096377, 27427.0, 27447.31381715458, 6586.242582103072, 6665.600063996151, 6741.730330786787, 6802.251752307242, 6814.250432452426, 6441.6779161041995, 6663.800085997404, 6691.73233070679, 6724.394804467597, 6738.326167383247, 6688.4649228061635, 6693.866122677544, 6696.799096027103, 6699.564528305645, 6701.798946031627, 6400.359964003609, 6679.3635559287795, 6682.83292917676, 6696.196456425236, 6697.095892054584, 6241.906371404432, 6247.531435142337, 6258.624482531017, 6265.624062556261, 6270.749170033238, 30994.380112397852, 31358.37283254322, 31446.05661830149, 31562.0, 31605.20986975321, 2296.8392212544964, 2318.2813327868416, 2319.3389883883183, 2320.2923108451914, 2321.6749655048307, 20675.172993080258, 21723.13107475699, 21883.562328753334, 21887.67168492474, 22004.669929950902, 2580.251726999168, 2592.740725927411, 2616.149751330825, 2623.1081432313104, 2632.4471860909234, 140828.0, 144092.0, 152434.23782881125, 154082.0, 160375.19812400863, 15265.771013434807, 16658.66682666364, 16683.416080437128, 16688.6662266754, 17076.876936918874, 25236.621450678256, 25299.114530991694, 25343.366415839384, 25534.0, 25596.0, 10942.726431839108, 11105.389203593719, 11127.833082503768, 11149.16381271408, 11190.94404527972, 10010.599576016877, 10092.747681308027, 10156.289059765746, 10164.33931794431, 10185.33795303303, 9946.303758736964, 10168.28821982454, 10186.134178594753, 10211.0, 10253.564500969871, 2752.4632696623967, 2756.986215068912, 2764.1203981292915, 2940.6765255821842, 2990.8654110565076, 1034.2863424237403, 1040.380973320873, 1053.3311347294523, 1059.7880423915249, 1067.114295135036, 21532.461688457915, 21949.122035118417, 21957.560848782934, 21987.450313741963, 22097.447563811034, 1096.3367162866512, 1103.6302838549177, 1111.5942680921405, 1111.927724697892, 1115.6876074699098, 11674.94162529182, 11996.400179990966, 12034.63896083119, 12085.939570302267, 12151.453184606715, 615404.0, 619644.3285840641, 625312.0, 625992.0, 637171.0, 128457.35771321083, 129138.0, 131105.0, 131351.0, 131637.0, 1112.7496313329436, 1165.1785491228663, 1199.2025303173466, 1210.3282678113555, 1261.236951644242, 23004.0, 23085.0, 23294.417639559146, 23452.882735586896, 23549.764502355443, 62237.377626223155, 62722.0, 63221.68389158025, 63354.36645633669, 64678.67660661667, 75759.24240757522, 79171.60414197893, 79247.0, 79705.60147199227, 79738.60130699309, 15628.0, 15802.7629585554, 15832.60418489547, 15877.0, 15922.124283164538, 25017.249482515555, 25185.0, 25191.24426267215, 25400.110996115047, 25473.61789573195, 19827.801721982596, 20133.194672212947, 20264.79735202629, 20327.983600820196, 20347.389578312675, 17853.196606152494, 18098.638027239645, 18369.632607348045, 18556.0, 18708.345207917657, 19885.602287953872, 20821.583568328853, 20947.8952605236, 21161.73029618228, 21317.680234796182, 15598.688026239184, 15615.609609759847, 15689.372425102869, 15753.369865205263, 15811.920940395225, 19112.0, 19123.71314430257, 19130.330438434587, 20205.0, 20563.4859128523], "value": 13013.07706451373, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1390.6662401023755, 1448.3989144505024, 1451.8838492920568, 1455.359641757626, 1462.535627467717, 16487.0, 17158.485245442625, 17191.054492002935, 17214.311427542914, 17230.827691723065, 16878.662426751456, 17021.48935531933, 17021.91489042553, 17023.744643830352, 17026.74459883103, 2786.3591373983995, 2803.649543807024, 2852.343960888986, 2856.157433557106, 2859.5710643403554, 2855.6430446194227, 2857.4856525825344, 2869.4834929712642, 2885.480613489571, 2886.956695649567, 2642.0224516928765, 2822.252103192656, 2929.5166297560877, 2934.9119526414243, 2936.192547049557, 2885.9711402886123, 2888.0902515707485, 2906.0, 2919.8832046718107, 2926.2245504941316, 2611.8041146914056, 2811.5642075478336, 2853.4578430098213, 2855.1720001199833, 2859.056511351249, 16685.666286674197, 17000.48998530046, 17070.48788536346, 17096.48710538686, 17104.82895171045, 8621.827563448696, 8920.687775927812, 8923.107689231025, 8923.15230053144, 8945.0, 6031.0, 6167.629942203482, 6203.8138855834395, 6268.216472940882, 6297.905531417033, 2039.6532589459828, 2084.6560317547587, 2121.3954023103342, 2165.675148727688, 2170.6201414752513, 29836.850815746, 29886.551701724493, 29920.251993700113, 29927.102186934426, 30119.247018824484, 7478.102627684604, 7494.1381741099385, 7506.512076714996, 7538.0, 7665.233476652402, 19810.50473738168, 19831.0, 19839.107240174228, 19843.702344464844, 19846.60306793885, 8450.239478446969, 8756.03683594804, 8757.2994160467, 8767.649294028295, 8770.035296117421, 7942.245486678757, 7958.403119766041, 7981.321587664997, 8011.679532818622, 8050.396220283502, 5562.360328562187, 5708.571857110734, 5710.628809127476, 5740.368559458456, 5759.8560035999435, 1608.453125937187, 1612.8145263294637, 1626.8373162683874, 1632.0, 1639.8032236131503, 901.5807649442909, 923.7136487688704, 931.1386967055582, 933.6825479336923, 938.7840796616816, 7884.526928384315, 7963.960180199062, 7992.160823113606, 8019.879701804478, 8050.758477245692, 767.2595944913074, 777.8522080804629, 781.0549235425199, 783.5337973905517, 800.1558355934545, 4739.241721324572, 5442.292501974718, 5443.482869127427, 5494.120940649477, 5502.504774570308, 23785.28644140644, 24831.62752558713, 25161.24516264515, 25480.49039019209, 25491.49017019649, 23994.28017159488, 24256.636150457758, 24698.629520557206, 24718.382040448774, 25040.87479562627, 11719.296842189497, 11876.821847672292, 11932.0, 11992.460339284578, 12011.0, 8832.558372081241, 8842.248408885316, 8935.0, 9009.099090090938, 9054.909450905407, 20638.484037899172, 21271.680924785833, 21409.250676226256, 21885.234016809336, 21945.341639750834, 21289.78710212878, 21630.242941496974, 21846.672299915197, 22206.555868882853, 22434.102635895033, 11973.640790776291, 12148.149629525848, 12230.082743794073, 12326.81509777336, 12334.259944403364, 15450.150241736812, 15456.381744730084, 15590.610234743768, 15604.843951560793, 15744.29150688199, 12665.176763510342, 12736.872631273569, 12789.61631151067, 12802.295873727035, 12891.742165156456, 12097.69755756078, 12352.4441400139, 12484.750304994031, 12565.623031308709, 12625.368731563569, 9833.16418104469, 10106.39361638304, 10122.392656440637, 10132.138768204784, 10141.695749127539, 7446.813829654302, 7520.736774212876, 7557.773266802004, 7570.432217583813, 7612.543247405173, 7731.226877312224, 7732.497387669783, 7733.955915951499, 7754.806129846574, 7876.72431464896], "value": 7205.3339869927395, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.1127334261798, 539.4659287305567, 562.1595714406961, 567.8069456384828, 570.2444261353705, 6204.937950620492, 6227.968860155698, 6228.626282423058, 6243.906341404882, 6285.182926219596, 6143.784967526138, 6177.691115444221, 6188.597741146834, 6222.346653601375, 6258.930266484151, 5053.761828352059, 5064.252832772688, 5085.338905942241, 5101.132807422747, 5107.336046313974, 5016.520126562673, 5064.0, 5067.873303167432, 5072.568831649314, 5113.539781419671, 4825.710457372569, 4905.264210368456, 4968.40379154502, 4996.425411077718, 5045.672031317971, 4908.435529914034, 4909.533594308535, 4910.821402863323, 4924.089043526959, 4936.481669424713, 4390.0, 4445.9110817783785, 4465.397171381855, 4468.905118246018, 4479.574440428154, 6081.422264884829, 6118.60229085108, 6126.663033533154, 6135.9079613805825, 6150.169727086831, 5822.33043200029, 5823.330317013513, 5824.679642619654, 5829.795957141479, 5852.531797456193, 6528.347165283481, 6533.509986751013, 6572.70422830969, 6603.867922641568, 6622.768203112868, 4961.578265847407, 4978.303037574742, 4980.601551875841, 4992.950070499285, 4993.875153121201, 6670.1646553232085, 6693.765718199888, 6766.458683305324, 6861.725530978755, 6890.31096890312, 5140.845774626767, 5141.177411614124, 5145.871353216125, 5151.5621172200035, 5184.326037615161, 5197.792088316425, 5200.84397468069, 5212.973935130376, 5242.501962313574, 5250.1337279349245, 5783.768649253982, 5791.131330300489, 5791.942080579224, 5799.39106393831, 5812.0, 6546.738130474823, 6563.440258299267, 6572.375624315682, 6581.736730530821, 6635.938249880092, 1781.8930864147933, 1781.8930864148192, 1787.8390944814769, 1791.66854131986, 1802.4862914069427, 1213.5181190469204, 1269.10528077705, 1275.7129645829614, 1280.4622058735354, 1282.3652292115462, 6123.38766123393, 6139.969300153471, 6147.0, 6157.737663778915, 6183.103449999725, 6565.179352580927, 6569.0, 6600.73597056122, 6630.602163870183, 6681.732730690718, 5853.180554722342, 6030.5778595497895, 6036.758529658764, 6048.36492168316, 6095.896915564123, 3448.9310213795584, 3468.757186996886, 3483.3555792178527, 3504.299140171925, 3504.491848681978, 6859.382655561023, 6871.0, 6888.896666550006, 6906.965465172642, 6947.687354069079, 6870.7595234166565, 6894.103766510422, 6914.792556223321, 6932.930670693329, 6936.445084393236, 6917.619530925746, 6965.233824279224, 6972.280810484017, 6993.860122797617, 7006.894896576556, 6655.23464801554, 6672.399484046459, 6672.764623851064, 6699.899501507384, 6712.261651218264, 6526.967365163144, 6698.923333766548, 6718.0, 6732.326767323424, 6736.66316684154, 6882.483813714091, 6886.48351373639, 6887.20797108339, 6937.826554336182, 6946.37482626566, 5127.0, 5138.7923837897315, 5146.099432599355, 5164.845054648366, 5200.843974680765, 6594.0, 6666.300038495888, 6696.229933557508, 6708.966455167693, 6776.322367763184, 6323.672028873804, 6362.491000720024, 6405.3594640535575, 6475.320091390525, 6481.4814814815645, 6457.515686323451, 6463.967680161569, 6469.547131700736, 6479.773207937699, 6481.157449531719, 6247.9062814056915, 6270.655113968775, 6338.74974384087, 6361.491080713439, 6386.68066596659, 6451.290358060516, 6476.579022363531, 6484.28672845996, 6526.967365163334, 6558.508111891722, 6151.415615516519, 6260.280067792262, 6264.0, 6283.246010478589, 6319.46284565817], "value": 5124.687659632707, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [974.9415035097891, 976.0971101730898, 991.7471044883554, 1001.4542074569359, 1006.8187726209279, 19851.900740496312, 19876.90061549694, 20169.59660806783, 20191.09140088696, 20194.59610807783, 18433.723494147598, 18801.62396752064, 19074.237030518798, 19108.331208407708, 19125.139368728407, 1042.4943902207424, 1046.6493724602267, 1047.5600247895902, 1048.09863517375, 1048.4076496779333, 1059.5443959097624, 1059.7350662334416, 1059.9576016959313, 1061.1404762142688, 1064.3081996702128, 1090.4057288777635, 1117.4971262931713, 1120.0535547462382, 1121.9551217951273, 1121.9831702524468, 1109.2401704832175, 1110.1340954055768, 1113.6436340371085, 1114.6934592986993, 1118.983215251768, 816.1919699497514, 816.408104124505, 819.1235378145387, 819.512390127873, 821.0557858462756, 19843.90078049615, 19925.0, 19938.90030549838, 19992.300269490643, 20323.796762032485, 23055.53888922212, 23434.882825585933, 23546.293611191693, 23609.40976475585, 23666.64500032501, 17093.230804613697, 17424.738628920575, 17476.825231747647, 17494.737578936325, 17514.47456576305, 3955.3078211312904, 4001.799910004517, 4013.578574249691, 4029.9522124247615, 4040.878773636796, 142589.0, 146200.0, 156184.0, 157814.0, 160692.0, 17960.0, 18318.633627327377, 18331.541711457052, 18434.631307374046, 18512.722309165372, 35119.12202194965, 35306.64693353033, 35356.64643353534, 35439.29121417557, 35599.4660080099, 9163.49600771964, 9247.213986811063, 9247.306452016126, 9257.305702072372, 9261.166495015346, 4597.977010114928, 4622.098690755271, 4646.070785842778, 4690.108879312919, 4690.882727931761, 6148.661823599656, 6275.592086514362, 6289.96855015722, 6299.559030867887, 6312.652804095727, 1155.179822326141, 1299.3048718935513, 1331.740310639416, 1342.2952949701485, 1350.4125705318218, 745.8769303065042, 751.5302935665209, 760.8782594784808, 763.4465012865628, 773.7988123087925, 13523.256220907944, 13652.590422287347, 13904.86095139056, 14738.926305368404, 14872.776908346383, 737.2811508779005, 740.1599184925149, 749.3330935467438, 761.8704820180583, 769.077107471037, 6160.168377269101, 6195.566310358232, 6219.440250377488, 6224.782132625427, 6326.2724786649205, 145226.0, 145494.27252863668, 146212.0, 147676.0, 148263.0, 128560.0, 128700.0, 129598.35200824124, 130103.0, 132093.0, 112023.99999999837, 112397.4380128094, 113465.4326728361, 113506.0, 116504.41747791207, 11674.357910315015, 11763.705907352385, 11814.881851181379, 11853.229540079867, 11991.0, 55571.0, 56206.43793562012, 56283.0, 56540.43459565516, 57569.136462953924, 69862.65068674827, 70982.29017709757, 71209.28790712234, 71658.0, 73193.26806732078, 17391.130443477523, 17586.912065439592, 17587.912060439616, 17720.0, 17734.201960912047, 19207.61584768269, 20356.0, 20369.18523259053, 20376.388708338774, 20558.486037849172, 18091.728624070915, 18093.547661308574, 18094.457166285032, 18152.27390904349, 18278.81721182771, 17895.910520447316, 18187.45437636873, 18309.908450458195, 18335.633287334447, 18354.90822545879, 15719.371225150866, 15746.0, 15778.605534861721, 15910.0453972762, 15912.602184945468, 13815.792763108762, 13919.79120313176, 13952.79070813959, 14051.086679365808, 14127.364268607731, 13346.0, 13365.198088114745, 13516.459341626225, 13640.0, 13688.520901768788], "value": 9961.921697227866, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1387.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 104.0, 105.0, 105.0, 108.0, 108.0, 107.0, 106.0, 105.0, 107.0], "value": 106.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 115.0, 114.0, 117.0, 114.0, 112.0, 114.0, 117.0, 112.0], "value": 114.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 162.0, 165.0, 164.0, 165.0, 163.0, 165.0, 171.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 76.0, 73.0, 73.0, 73.0, 73.0, 73.0, 73.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 78.0, 77.0, 77.0, 78.0, 78.0, 78.0, 78.0, 82.0], "value": 78.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 114.0, 114.0, 113.0, 113.0, 114.0, 113.0, 112.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 152.0, 151.0, 150.0, 150.0, 150.0, 150.0, 149.0, 150.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 50.0, 44.0, 48.0, 43.0, 43.0, 44.0, 50.0, 44.0, 43.0], "value": 45.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 39.0, 38.0], "value": 38.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 72.0, 74.0, 73.0, 73.0, 73.0, 77.0, 73.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 116.0, 124.0, 109.0, 122.0, 115.0, 117.0, 120.0, 108.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 167.0, 153.0, 158.0, 153.0, 165.0, 155.0, 157.0, 158.0, 156.0], "value": 158.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 59.0, 66.0, 59.0, 60.0, 58.0, 63.0, 58.0, 61.0, 61.0], "value": 60.8, "unit": "score"}]}]} 04:02:16 INFO - Return code: 0 04:02:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:02:16 INFO - # TBPL SUCCESS # 04:02:16 INFO - Running post-action listener: _package_coverage_data 04:02:16 INFO - Running post-action listener: _resource_record_post_action 04:02:16 INFO - [mozharness: 2017-09-11 11:02:16.714907Z] Finished run-tests step (success) 04:02:16 INFO - Running post-run listener: _resource_record_post_run 04:02:16 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 302047232; Read time: 248; Write time: 223944 04:02:16 INFO - TinderboxPrint: CPU usage
13.1% 04:02:16 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 248 04:02:16 INFO - TinderboxPrint: I/O write bytes / time
302,047,232 / 223,944 04:02:16 INFO - TinderboxPrint: CPU idle
8,219.8 (86.9%) 04:02:16 INFO - TinderboxPrint: CPU user
1,186.9 (12.5%) 04:02:16 INFO - TinderboxPrint: Swap in / out
0 / 0 04:02:16 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 12656640; Read time: 0; Write time: 2672 04:02:16 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:02:16 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 8192; Write bytes: 289390592; Read time: 248; Write time: 221272 04:02:17 INFO - Running post-run listener: _upload_blobber_files 04:02:17 INFO - Blob upload gear active. 04:02:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:02:17 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 04:02:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:02:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:02:17 INFO - (blobuploader) - INFO - Open directory for files ... 04:02:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:02:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:02:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:18 INFO - (blobuploader) - INFO - Done attempting. 04:02:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:02:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:02:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:24 INFO - (blobuploader) - INFO - Done attempting. 04:02:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:02:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:02:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:25 INFO - (blobuploader) - INFO - Done attempting. 04:02:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:02:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:02:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:26 INFO - (blobuploader) - INFO - Done attempting. 04:02:26 INFO - (blobuploader) - INFO - Iteration through files over. 04:02:26 INFO - Return code: 0 04:02:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:02:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:02:26 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5932b20b661f053c372f634f4ab22d6b8748d3974d412326f265d017c3b997923d180a41cdd4413ca754b727902a7f608416e1ccbcb828fc9e618ba31cc0e991", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb865630b7fd05427697d467a2c37943b47b5d1bdb890572d88659aac582c8c606dfcc4d79813889200fe9c87d710441b04f5ae481c51ecb0ba2a18518173748", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/731b8fa198900a73c5808d757167e41dab3dd7274033daaa8f8174635b49c9e8a75e34bf364b1daf5d611755756473905ed7f659244776cc9cb092979710becf", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09a0df3b26425ef3218abdfafde92b7f09981fc8b03f3ac1e3cfa0effc9a77a70c345f00772bc388fceef4f57a4e3e6f175c25de178437f7532d8bfa7e452d83"} 04:02:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:02:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:02:26 INFO - Contents: 04:02:26 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5932b20b661f053c372f634f4ab22d6b8748d3974d412326f265d017c3b997923d180a41cdd4413ca754b727902a7f608416e1ccbcb828fc9e618ba31cc0e991", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb865630b7fd05427697d467a2c37943b47b5d1bdb890572d88659aac582c8c606dfcc4d79813889200fe9c87d710441b04f5ae481c51ecb0ba2a18518173748", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/731b8fa198900a73c5808d757167e41dab3dd7274033daaa8f8174635b49c9e8a75e34bf364b1daf5d611755756473905ed7f659244776cc9cb092979710becf", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09a0df3b26425ef3218abdfafde92b7f09981fc8b03f3ac1e3cfa0effc9a77a70c345f00772bc388fceef4f57a4e3e6f175c25de178437f7532d8bfa7e452d83"} 04:02:26 INFO - Running post-run listener: copy_logs_to_upload_dir 04:02:26 INFO - Copying logs to upload dir... 04:02:26 INFO - mkdir: /builds/slave/test/build/upload/logs 04:02:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.514856 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-09-11 04:02:26.220652) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-11 04:02:26.224659) ========= 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=0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332 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/sha512/5932b20b661f053c372f634f4ab22d6b8748d3974d412326f265d017c3b997923d180a41cdd4413ca754b727902a7f608416e1ccbcb828fc9e618ba31cc0e991", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb865630b7fd05427697d467a2c37943b47b5d1bdb890572d88659aac582c8c606dfcc4d79813889200fe9c87d710441b04f5ae481c51ecb0ba2a18518173748", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/731b8fa198900a73c5808d757167e41dab3dd7274033daaa8f8174635b49c9e8a75e34bf364b1daf5d611755756473905ed7f659244776cc9cb092979710becf", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09a0df3b26425ef3218abdfafde92b7f09981fc8b03f3ac1e3cfa0effc9a77a70c345f00772bc388fceef4f57a4e3e6f175c25de178437f7532d8bfa7e452d83"} build_url:https://queue.taskcluster.net/v1/task/dUR9X3TfT1GYB9I681YwgQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011432 build_url: 'https://queue.taskcluster.net/v1/task/dUR9X3TfT1GYB9I681YwgQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5932b20b661f053c372f634f4ab22d6b8748d3974d412326f265d017c3b997923d180a41cdd4413ca754b727902a7f608416e1ccbcb828fc9e618ba31cc0e991", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb865630b7fd05427697d467a2c37943b47b5d1bdb890572d88659aac582c8c606dfcc4d79813889200fe9c87d710441b04f5ae481c51ecb0ba2a18518173748", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/731b8fa198900a73c5808d757167e41dab3dd7274033daaa8f8174635b49c9e8a75e34bf364b1daf5d611755756473905ed7f659244776cc9cb092979710becf", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09a0df3b26425ef3218abdfafde92b7f09981fc8b03f3ac1e3cfa0effc9a77a70c345f00772bc388fceef4f57a4e3e6f175c25de178437f7532d8bfa7e452d83"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-11 04:02:26.253228) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 04:02:26.253586) ========= 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=0e2a256762fed810e2f0f810000001b3-1505126509.926555-50269332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 04:02:26.336303) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-11 04:02:26.336614) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-11 04:02:26.336925) ========= ========= Total master_lag: 0.19 =========