builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-016 starttime: 1506990617.45 results: success (0) revision: 8c6b4fd1d76927cf8b07eb045c5aadd47b77d910 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 17:30:17.449585) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 17:30:17.450009) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 17:30:17.450279) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 17:30:17.528072) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 17:30:17.626998) ========= 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=00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-02 17:30:17-- 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% 77.4M=0s 2017-10-02 17:30:17 (77.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128359 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 17:30:17.777625) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 17:30:17.777949) ========= 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=00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014764 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 17:30:17.828092) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-02 17:30:17.828396) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8c6b4fd1d76927cf8b07eb045c5aadd47b77d910 --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 8c6b4fd1d76927cf8b07eb045c5aadd47b77d910 --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=00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-02 17:30:17,903 truncating revision to first 12 chars 2017-10-02 17:30:17,904 Setting DEBUG logging. 2017-10-02 17:30:17,904 attempt 1/10 2017-10-02 17:30:17,904 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8c6b4fd1d769?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-02 17:30:18,886 unpacking tar archive at: mozilla-central-8c6b4fd1d769/testing/mozharness/ program finished with exit code 0 elapsedTime=1.270437 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-02 17:30:19.116219) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 17:30:19.116543) ========= script_repo_revision: 8c6b4fd1d76927cf8b07eb045c5aadd47b77d910 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 17:30:19.117177) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 17:30:19.117438) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 17:30:19.130979) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-10-02 17:30:19.131365) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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-stylo-disabled-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=00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:30:19 INFO - MultiFileLogger online at 20171002 17:30:19 in /builds/slave/test 17:30:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:30:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:30:19 INFO - {'append_to_log': False, 17:30:19 INFO - 'base_work_dir': '/builds/slave/test', 17:30:19 INFO - 'blob_upload_branch': 'Firefox', 17:30:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:30:19 INFO - 'branch': 'Firefox', 17:30:19 INFO - 'buildbot_json_path': 'buildprops.json', 17:30:19 INFO - 'code_coverage': False, 17:30:19 INFO - 'config_files': ('talos/linux_config.py',), 17:30:19 INFO - 'default_actions': ('clobber', 17:30:19 INFO - 'read-buildbot-config', 17:30:19 INFO - 'download-and-extract', 17:30:19 INFO - 'populate-webroot', 17:30:19 INFO - 'create-virtualenv', 17:30:19 INFO - 'install', 17:30:19 INFO - 'setup-mitmproxy', 17:30:19 INFO - 'run-tests'), 17:30:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:30:19 INFO - 'disable_ccov_upload': False, 17:30:19 INFO - 'disable_stylo': False, 17:30:19 INFO - 'download_minidump_stackwalk': True, 17:30:19 INFO - 'download_symbols': 'ondemand', 17:30:19 INFO - 'enable_stylo': False, 17:30:19 INFO - 'enable_webrender': False, 17:30:19 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:30:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:30:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:30:19 INFO - 'gecko_profile': False, 17:30:19 INFO - 'gecko_profile_interval': 0, 17:30:19 INFO - 'installer_path': 'installer.exe', 17:30:19 INFO - 'log_level': 'info', 17:30:19 INFO - 'log_name': 'talos', 17:30:19 INFO - 'log_to_console': True, 17:30:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:30:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:30:19 INFO - 'opt_config_files': (), 17:30:19 INFO - 'pip_index': False, 17:30:19 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 17:30:19 INFO - 'system_bits': '32', 17:30:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:30:19 INFO - 'title': 'talos-linux64-ix-016', 17:30:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:30:19 INFO - 'use_talos_json': True, 17:30:19 INFO - 'verify': 'False', 17:30:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:30:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:30:19 INFO - 'work_dir': 'build'} 17:30:19 INFO - [mozharness: 2017-10-03 00:30:19.348228Z] Running clobber step. 17:30:19 INFO - Running pre-action listener: _resource_record_pre_action 17:30:19 INFO - Running main action method: clobber 17:30:19 INFO - rmtree: /builds/slave/test/build 17:30:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:30:20 INFO - Running post-action listener: _resource_record_post_action 17:30:20 INFO - [mozharness: 2017-10-03 00:30:20.848727Z] Finished clobber step (success) 17:30:20 INFO - [mozharness: 2017-10-03 00:30:20.848825Z] Running read-buildbot-config step. 17:30:20 INFO - Running pre-action listener: _resource_record_pre_action 17:30:20 INFO - Running main action method: read_buildbot_config 17:30:20 INFO - Using buildbot properties: 17:30:20 INFO - { 17:30:20 INFO - "project": "", 17:30:20 INFO - "product": "firefox", 17:30:20 INFO - "who": "kwierso@gmail.com", 17:30:20 INFO - "installer_path": "public/build/target.tar.bz2", 17:30:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 17:30:20 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:30:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 17:30:20 INFO - "stage_platform": "linux64-pgo", 17:30:20 INFO - "basedir": "/builds/slave/test", 17:30:20 INFO - "buildnumber": 49, 17:30:20 INFO - "platform": "ubuntu64_hw", 17:30:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:30:20 INFO - "slavebuilddir": "test", 17:30:20 INFO - "taskId": "Skeqz2UpQ7unD4C8r0DVlw", 17:30:20 INFO - "branch": "mozilla-central", 17:30:20 INFO - "script_repo_revision": "production", 17:30:20 INFO - "revision": "8c6b4fd1d76927cf8b07eb045c5aadd47b77d910", 17:30:20 INFO - "slavename": "talos-linux64-ix-016", 17:30:20 INFO - "repo_path": "mozilla-central" 17:30:20 INFO - } 17:30:20 INFO - Finding installer, test and symbols from parent task. 17:30:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Skeqz2UpQ7unD4C8r0DVlw'}, attempt #1 17:30:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Skeqz2UpQ7unD4C8r0DVlw'}, attempt #1 17:30:21 INFO - Task dependencies: O8PaNEsoTpCKDFDDGb4FLA 17:30:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O8PaNEsoTpCKDFDDGb4FLA'}, attempt #1 17:30:22 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/O8PaNEsoTpCKDFDDGb4FLA/artifacts/public/build/target.tar.bz2 17:30:22 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/O8PaNEsoTpCKDFDDGb4FLA/artifacts/public/build/target.test_packages.json 17:30:22 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/O8PaNEsoTpCKDFDDGb4FLA/artifacts/public/build/target.crashreporter-symbols.zip 17:30:22 INFO - Running post-action listener: _resource_record_post_action 17:30:22 INFO - [mozharness: 2017-10-03 00:30:22.486131Z] Finished read-buildbot-config step (success) 17:30:22 INFO - [mozharness: 2017-10-03 00:30:22.486440Z] Running download-and-extract step. 17:30:22 INFO - Running pre-action listener: _resource_record_pre_action 17:30:22 INFO - Running main action method: download_and_extract 17:30:22 INFO - mkdir: /builds/slave/test/build/tests 17:30:22 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')]} 17:30:22 INFO - trying https://queue.taskcluster.net/v1/task/O8PaNEsoTpCKDFDDGb4FLA/artifacts/public/build/target.test_packages.json 17:30:22 INFO - Downloading https://queue.taskcluster.net/v1/task/O8PaNEsoTpCKDFDDGb4FLA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:30:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O8PaNEsoTpCKDFDDGb4FLA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:30:23 INFO - Downloaded 989 bytes. 17:30:23 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:30:23 INFO - Using the following test package requirements: 17:30:23 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:30:23 INFO - u'common': [u'target.common.tests.zip'], 17:30:23 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:30:23 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:30:23 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:30:23 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:30:23 INFO - u'mozbase': [u'target.common.tests.zip'], 17:30:23 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:30:23 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:30:23 INFO - u'web-platform': [u'target.common.tests.zip', 17:30:23 INFO - u'target.web-platform.tests.tar.gz'], 17:30:23 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:30:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 17:30:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O8PaNEsoTpCKDFDDGb4FLA/artifacts/public/build/target.common.tests.zip 17:30:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O8PaNEsoTpCKDFDDGb4FLA/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:30:23 INFO - Fetch https://queue.taskcluster.net/v1/task/O8PaNEsoTpCKDFDDGb4FLA/artifacts/public/build/target.common.tests.zip into memory 17:30:25 INFO - Content-Length response header: 55909693 17:30:25 INFO - Bytes received: 55909693 17:30:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O8PaNEsoTpCKDFDDGb4FLA/artifacts/public/build/target.talos.tests.zip 17:30:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O8PaNEsoTpCKDFDDGb4FLA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:30:35 INFO - Fetch https://queue.taskcluster.net/v1/task/O8PaNEsoTpCKDFDDGb4FLA/artifacts/public/build/target.talos.tests.zip into memory 17:30:37 INFO - Content-Length response header: 14522427 17:30:37 INFO - Bytes received: 14522427 17:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:38 INFO - trying https://queue.taskcluster.net/v1/task/O8PaNEsoTpCKDFDDGb4FLA/artifacts/public/build/target.tar.bz2 17:30:38 INFO - Downloading https://queue.taskcluster.net/v1/task/O8PaNEsoTpCKDFDDGb4FLA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:30:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O8PaNEsoTpCKDFDDGb4FLA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:30:40 INFO - Downloaded 62344145 bytes. 17:30:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O8PaNEsoTpCKDFDDGb4FLA/artifacts/public/build/target.tar.bz2 17:30:40 INFO - mkdir: /builds/slave/test/properties 17:30:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:30:40 INFO - Writing to file /builds/slave/test/properties/build_url 17:30:40 INFO - Contents: 17:30:40 INFO - build_url:https://queue.taskcluster.net/v1/task/O8PaNEsoTpCKDFDDGb4FLA/artifacts/public/build/target.tar.bz2 17:30:40 INFO - Running post-action listener: _resource_record_post_action 17:30:40 INFO - Running post-action listener: find_tests_for_verification 17:30:40 INFO - Running post-action listener: set_extra_try_arguments 17:30:40 INFO - [mozharness: 2017-10-03 00:30:40.819419Z] Finished download-and-extract step (success) 17:30:40 INFO - [mozharness: 2017-10-03 00:30:40.819520Z] Running populate-webroot step. 17:30:40 INFO - Running pre-action listener: _resource_record_pre_action 17:30:40 INFO - Running main action method: populate_webroot 17:30:40 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:30:40 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:30:40 INFO - 'tests': ['tresize', 17:30:40 INFO - 'tcanvasmark']}, 17:30:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:30:40 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:30:40 INFO - 'tests': ['dromaeo_css', 17:30:40 INFO - 'kraken']}, 17:30:40 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:30:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:30:40 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:30:40 INFO - 'talos_options': ['--disable-stylo'], 17:30:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:30:40 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:30:40 INFO - 'tests': ['damp', 'tps']}, 17:30:40 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:30:40 INFO - 'talos_options': ['--disable-stylo'], 17:30:40 INFO - 'tests': ['damp', 'tps']}, 17:30:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:30:40 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:30:40 INFO - 'tests': ['dromaeo_dom']}, 17:30:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:30:40 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:30:40 INFO - 'tests': ['basic_compositor_video', 17:30:40 INFO - 'glvideo']}, 17:30:40 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:30:40 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:30:40 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:30:40 INFO - 'talos_options': ['--disable-stylo'], 17:30:40 INFO - 'tests': ['ts_paint_webext', 17:30:40 INFO - 'tp5o_webext']}, 17:30:40 INFO - 'other-e10s': {'tests': ['a11yr', 17:30:40 INFO - 'ts_paint', 17:30:40 INFO - 'tpaint', 17:30:40 INFO - 'sessionrestore', 17:30:40 INFO - 'sessionrestore_many_windows', 17:30:40 INFO - 'sessionrestore_no_auto_restore', 17:30:40 INFO - 'tabpaint', 17:30:40 INFO - 'cpstartup']}, 17:30:40 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:30:40 INFO - 'tests': ['a11yr', 17:30:40 INFO - 'ts_paint', 17:30:40 INFO - 'tpaint', 17:30:40 INFO - 'sessionrestore', 17:30:40 INFO - 'sessionrestore_many_windows', 17:30:40 INFO - 'sessionrestore_no_auto_restore', 17:30:40 INFO - 'tabpaint', 17:30:40 INFO - 'cpstartup']}, 17:30:40 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 17:30:40 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 17:30:40 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:30:40 INFO - 'tests': ['perf_reftest_singletons']}, 17:30:40 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:30:40 INFO - 'tests': ['perf_reftest']}, 17:30:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:30:40 INFO - 'tsvgr_opacity', 17:30:40 INFO - 'tart', 17:30:40 INFO - 'tscrollx', 17:30:40 INFO - 'tsvg_static']}, 17:30:40 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:30:40 INFO - 'tests': ['tsvgx', 17:30:40 INFO - 'tsvgr_opacity', 17:30:40 INFO - 'tart', 17:30:40 INFO - 'tscrollx', 17:30:40 INFO - 'tsvg_static']}, 17:30:40 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:30:40 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:30:40 INFO - 'talos_options': ['--disable-stylo'], 17:30:40 INFO - 'tests': ['tp5o']}, 17:30:40 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:30:40 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:30:40 INFO - 'talos_options': ['--mitmproxy', 17:30:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:30:40 INFO - '--firstNonBlankPaint'], 17:30:40 INFO - 'tests': ['tp6_google', 17:30:40 INFO - 'tp6_youtube', 17:30:40 INFO - 'tp6_amazon', 17:30:40 INFO - 'tp6_facebook']}, 17:30:40 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:30:40 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:30:40 INFO - 'talos_options': ['--disable-stylo', 17:30:40 INFO - '--mitmproxy', 17:30:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:30:40 INFO - '--firstNonBlankPaint'], 17:30:40 INFO - 'tests': ['tp6_google', 17:30:40 INFO - 'tp6_youtube', 17:30:40 INFO - 'tp6_amazon', 17:30:40 INFO - 'tp6_facebook']}, 17:30:40 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:30:40 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:30:40 INFO - 'talos_options': ['--stylo-threads=1', 17:30:40 INFO - '--mitmproxy', 17:30:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:30:40 INFO - '--firstNonBlankPaint'], 17:30:40 INFO - 'tests': ['tp6_google', 17:30:40 INFO - 'tp6_youtube', 17:30:40 INFO - 'tp6_amazon', 17:30:40 INFO - 'tp6_facebook']}, 17:30:40 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:30:40 INFO - 'talos_options': ['--xperf_path', 17:30:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:30:40 INFO - 'tests': ['tp5n']}, 17:30:40 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:30:40 INFO - 'talos_options': ['--disable-stylo', 17:30:40 INFO - '--xperf_path', 17:30:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:30:40 INFO - 'tests': ['tp5n']}}} 17:30:40 INFO - Running post-action listener: _resource_record_post_action 17:30:40 INFO - [mozharness: 2017-10-03 00:30:40.838960Z] Finished populate-webroot step (success) 17:30:40 INFO - [mozharness: 2017-10-03 00:30:40.839050Z] Running create-virtualenv step. 17:30:40 INFO - Running pre-action listener: _resource_record_pre_action 17:30:40 INFO - Running main action method: create_virtualenv 17:30:40 INFO - Creating virtualenv /builds/slave/test/build/venv 17:30:40 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:30:40 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:30:40 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:30:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:30:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:30:41 INFO - Installing distribute.............................................................................................................................................................................................done. 17:30:41 INFO - Installing pip...............done. 17:30:41 INFO - Return code: 0 17:30:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:30:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:30:41 INFO - Reading from file tmpfile_stdout 17:30:41 INFO - Output received: 17:30:41 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:30:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:30:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277cd60>, '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 0x277da60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277def0>, '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': '00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509', '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 17:30:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:30:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:30:41 INFO - Using env: {'DISPLAY': ':0', 17:30:41 INFO - 'HOME': '/home/cltbld', 17:30:41 INFO - 'LANG': 'en_US.UTF-8', 17:30:41 INFO - 'LANGUAGE': 'en_US:en', 17:30:41 INFO - 'LOGNAME': 'cltbld', 17:30:41 INFO - 'MAIL': '/var/mail/cltbld', 17:30:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:30:41 INFO - 'MOZ_NO_REMOTE': '1', 17:30:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:30:41 INFO - 'NO_EM_RESTART': '1', 17:30:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:30:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:30:41 INFO - 'PWD': '/builds/slave/test', 17:30:41 INFO - 'SHELL': '/bin/bash', 17:30:41 INFO - 'SHLVL': '1', 17:30:41 INFO - 'TERM': 'linux', 17:30:41 INFO - 'TMOUT': '86400', 17:30:41 INFO - 'USER': 'cltbld', 17:30:41 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509', 17:30:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:30:41 INFO - '_': '/tools/buildbot/bin/python'} 17:30:43 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:30:43 INFO - Downloading/unpacking pip>=1.5 17:30:43 INFO - Running setup.py egg_info for package pip 17:30:43 INFO - warning: no files found matching 'pip/cacert.pem' 17:30:43 INFO - warning: no files found matching '*.html' under directory 'docs' 17:30:43 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:30:43 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:30:43 INFO - Installing collected packages: pip 17:30:43 INFO - Found existing installation: pip 1.1 17:30:43 INFO - Uninstalling pip: 17:30:43 INFO - Successfully uninstalled pip 17:30:43 INFO - Running setup.py install for pip 17:30:43 INFO - warning: no files found matching 'pip/cacert.pem' 17:30:43 INFO - warning: no files found matching '*.html' under directory 'docs' 17:30:43 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:30:43 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:30:43 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:30:43 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:30:43 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:30:43 INFO - Successfully installed pip 17:30:43 INFO - Cleaning up... 17:30:43 INFO - Return code: 0 17:30:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:30:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:30:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:30:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277cd60>, '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 0x277da60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277def0>, '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': '00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509', '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 17:30:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:30:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:30:43 INFO - Using env: {'DISPLAY': ':0', 17:30:43 INFO - 'HOME': '/home/cltbld', 17:30:43 INFO - 'LANG': 'en_US.UTF-8', 17:30:43 INFO - 'LANGUAGE': 'en_US:en', 17:30:43 INFO - 'LOGNAME': 'cltbld', 17:30:43 INFO - 'MAIL': '/var/mail/cltbld', 17:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:30:43 INFO - 'MOZ_NO_REMOTE': '1', 17:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:30:43 INFO - 'NO_EM_RESTART': '1', 17:30:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:30:43 INFO - 'PWD': '/builds/slave/test', 17:30:43 INFO - 'SHELL': '/bin/bash', 17:30:43 INFO - 'SHLVL': '1', 17:30:43 INFO - 'TERM': 'linux', 17:30:43 INFO - 'TMOUT': '86400', 17:30:43 INFO - 'USER': 'cltbld', 17:30:43 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509', 17:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:30:43 INFO - '_': '/tools/buildbot/bin/python'} 17:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:30:43 INFO - Downloading/unpacking psutil>=3.1.1 17:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:30:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:30:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:30:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:30:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:30:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:30:44 INFO - Installing collected packages: psutil 17:30:44 INFO - Running setup.py install for psutil 17:30:44 INFO - building 'psutil._psutil_linux' extension 17:30:44 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 17:30:44 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 17:30:44 INFO - building 'psutil._psutil_posix' extension 17:30:44 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 17:30:44 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 17:30:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:30:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:30:45 INFO - Successfully installed psutil 17:30:45 INFO - Cleaning up... 17:30:45 INFO - Return code: 0 17:30:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:30:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277cd60>, '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 0x277da60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277def0>, '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': '00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509', '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 17:30:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:30:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:30:45 INFO - Using env: {'DISPLAY': ':0', 17:30:45 INFO - 'HOME': '/home/cltbld', 17:30:45 INFO - 'LANG': 'en_US.UTF-8', 17:30:45 INFO - 'LANGUAGE': 'en_US:en', 17:30:45 INFO - 'LOGNAME': 'cltbld', 17:30:45 INFO - 'MAIL': '/var/mail/cltbld', 17:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:30:45 INFO - 'MOZ_NO_REMOTE': '1', 17:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:30:45 INFO - 'NO_EM_RESTART': '1', 17:30:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:30:45 INFO - 'PWD': '/builds/slave/test', 17:30:45 INFO - 'SHELL': '/bin/bash', 17:30:45 INFO - 'SHLVL': '1', 17:30:45 INFO - 'TERM': 'linux', 17:30:45 INFO - 'TMOUT': '86400', 17:30:45 INFO - 'USER': 'cltbld', 17:30:45 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509', 17:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:30:45 INFO - '_': '/tools/buildbot/bin/python'} 17:30:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:30:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:30:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:30:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:30:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:30:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:30:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:30:46 INFO - Installing collected packages: mozsystemmonitor 17:30:46 INFO - Running setup.py install for mozsystemmonitor 17:30:46 INFO - Successfully installed mozsystemmonitor 17:30:46 INFO - Cleaning up... 17:30:47 INFO - Return code: 0 17:30:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:30: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')]} 17:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:30: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')]} 17:30:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:30:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277cd60>, '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 0x277da60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277def0>, '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': '00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509', '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 17:30:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:30:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:30:47 INFO - Using env: {'DISPLAY': ':0', 17:30:47 INFO - 'HOME': '/home/cltbld', 17:30:47 INFO - 'LANG': 'en_US.UTF-8', 17:30:47 INFO - 'LANGUAGE': 'en_US:en', 17:30:47 INFO - 'LOGNAME': 'cltbld', 17:30:47 INFO - 'MAIL': '/var/mail/cltbld', 17:30:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:30:47 INFO - 'MOZ_NO_REMOTE': '1', 17:30:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:30:47 INFO - 'NO_EM_RESTART': '1', 17:30:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:30:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:30:47 INFO - 'PWD': '/builds/slave/test', 17:30:47 INFO - 'SHELL': '/bin/bash', 17:30:47 INFO - 'SHLVL': '1', 17:30:47 INFO - 'TERM': 'linux', 17:30:47 INFO - 'TMOUT': '86400', 17:30:47 INFO - 'USER': 'cltbld', 17:30:47 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509', 17:30:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:30:47 INFO - '_': '/tools/buildbot/bin/python'} 17:30:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:30:47 INFO - Downloading/unpacking jsonschema==2.5.1 17:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:30:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:30:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:30:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:30:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:30:50 INFO - Downloading functools32-3.2.3-2.tar.gz 17:30:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:30:50 INFO - warning: no files found matching '*.txt' 17:30:50 INFO - no previously-included directories found matching 'build' 17:30:50 INFO - no previously-included directories found matching 'dist' 17:30:50 INFO - no previously-included directories found matching '.git*' 17:30:50 INFO - Installing collected packages: jsonschema, functools32 17:30:50 INFO - Running setup.py install for functools32 17:30:50 INFO - warning: no files found matching '*.txt' 17:30:50 INFO - no previously-included directories found matching 'build' 17:30:50 INFO - no previously-included directories found matching 'dist' 17:30:50 INFO - no previously-included directories found matching '.git*' 17:30:50 INFO - Successfully installed jsonschema functools32 17:30:50 INFO - Cleaning up... 17:30:50 INFO - Return code: 0 17:30:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:30:50 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')]} 17:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:30:50 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')]} 17:30:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:30:50 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 0x24121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277cd60>, '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 0x277da60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277def0>, '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': '00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509', '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 17:30:50 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 17:30:50 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 17:30:50 INFO - Using env: {'DISPLAY': ':0', 17:30:50 INFO - 'HOME': '/home/cltbld', 17:30:50 INFO - 'LANG': 'en_US.UTF-8', 17:30:50 INFO - 'LANGUAGE': 'en_US:en', 17:30:50 INFO - 'LOGNAME': 'cltbld', 17:30:50 INFO - 'MAIL': '/var/mail/cltbld', 17:30:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:30:50 INFO - 'MOZ_NO_REMOTE': '1', 17:30:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:30:50 INFO - 'NO_EM_RESTART': '1', 17:30:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:30:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:30:50 INFO - 'PWD': '/builds/slave/test', 17:30:50 INFO - 'SHELL': '/bin/bash', 17:30:50 INFO - 'SHLVL': '1', 17:30:50 INFO - 'TERM': 'linux', 17:30:50 INFO - 'TMOUT': '86400', 17:30:50 INFO - 'USER': 'cltbld', 17:30:50 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509', 17:30:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:30:50 INFO - '_': '/tools/buildbot/bin/python'} 17:30:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:30:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:30:50 INFO - Cleaning up... 17:30:50 INFO - Return code: 0 17:30:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:30:50 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')]} 17:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:30:50 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')]} 17:30:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:30:50 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 0x24121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277cd60>, '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 0x277da60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277def0>, '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': '00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509', '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 17:30:50 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 17:30:50 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 17:30:50 INFO - Using env: {'DISPLAY': ':0', 17:30:50 INFO - 'HOME': '/home/cltbld', 17:30:50 INFO - 'LANG': 'en_US.UTF-8', 17:30:50 INFO - 'LANGUAGE': 'en_US:en', 17:30:50 INFO - 'LOGNAME': 'cltbld', 17:30:50 INFO - 'MAIL': '/var/mail/cltbld', 17:30:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:30:50 INFO - 'MOZ_NO_REMOTE': '1', 17:30:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:30:50 INFO - 'NO_EM_RESTART': '1', 17:30:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:30:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:30:50 INFO - 'PWD': '/builds/slave/test', 17:30:50 INFO - 'SHELL': '/bin/bash', 17:30:50 INFO - 'SHLVL': '1', 17:30:50 INFO - 'TERM': 'linux', 17:30:50 INFO - 'TMOUT': '86400', 17:30:50 INFO - 'USER': 'cltbld', 17:30:50 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509', 17:30:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:30:50 INFO - '_': '/tools/buildbot/bin/python'} 17:30:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:30:50 INFO - Downloading/unpacking blobuploader==1.2.4 17:30:50 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 17:30:50 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 17:30:50 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 17:30:50 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 17:30:51 INFO - Downloading blobuploader-1.2.4.tar.gz 17:30:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:30:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:30:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:30:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:30:52 INFO - Downloading docopt-0.6.1.tar.gz 17:30:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:30:52 INFO - Installing collected packages: blobuploader, requests, docopt 17:30:52 INFO - Running setup.py install for blobuploader 17:30:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:30:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:30:52 INFO - Running setup.py install for requests 17:30:52 INFO - Running setup.py install for docopt 17:30:53 INFO - Successfully installed blobuploader requests docopt 17:30:53 INFO - Cleaning up... 17:30:53 INFO - Return code: 0 17:30:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:30:53 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 0x24121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277cd60>, '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 0x277da60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277def0>, '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': '00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509', '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 17:30:53 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 17:30:53 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 17:30:53 INFO - Using env: {'DISPLAY': ':0', 17:30:53 INFO - 'HOME': '/home/cltbld', 17:30:53 INFO - 'LANG': 'en_US.UTF-8', 17:30:53 INFO - 'LANGUAGE': 'en_US:en', 17:30:53 INFO - 'LOGNAME': 'cltbld', 17:30:53 INFO - 'MAIL': '/var/mail/cltbld', 17:30:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:30:53 INFO - 'MOZ_NO_REMOTE': '1', 17:30:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:30:53 INFO - 'NO_EM_RESTART': '1', 17:30:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:30:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:30:53 INFO - 'PWD': '/builds/slave/test', 17:30:53 INFO - 'SHELL': '/bin/bash', 17:30:53 INFO - 'SHLVL': '1', 17:30:53 INFO - 'TERM': 'linux', 17:30:53 INFO - 'TMOUT': '86400', 17:30:53 INFO - 'USER': 'cltbld', 17:30:53 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509', 17:30:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:30:53 INFO - '_': '/tools/buildbot/bin/python'} 17:30:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:30:53 INFO - Running setup.py (path:/tmp/pip-Tt0cwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:30:53 INFO - Running setup.py (path:/tmp/pip-y2lhtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:30:53 INFO - Running setup.py (path:/tmp/pip-tM_5kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:30:53 INFO - Running setup.py (path:/tmp/pip-ORP6v6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:30:53 INFO - Running setup.py (path:/tmp/pip-f314RA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:30:53 INFO - Running setup.py (path:/tmp/pip-eat0fK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:30:53 INFO - Running setup.py (path:/tmp/pip-Vq9ogp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:30:53 INFO - Running setup.py (path:/tmp/pip-KE3734-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:30:53 INFO - Running setup.py (path:/tmp/pip-okb67B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:30:53 INFO - Running setup.py (path:/tmp/pip-xT8Joy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:30:54 INFO - Running setup.py (path:/tmp/pip-q198qW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:30:54 INFO - Running setup.py (path:/tmp/pip-WhwHTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:30:54 INFO - Running setup.py (path:/tmp/pip-RstWXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:30:54 INFO - Running setup.py (path:/tmp/pip-psfCln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:30:54 INFO - Running setup.py (path:/tmp/pip-bWIHmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:30:54 INFO - Running setup.py (path:/tmp/pip-55phEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:30:54 INFO - Running setup.py (path:/tmp/pip-g8UZMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:30:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:30:54 INFO - Running setup.py install for manifestparser 17:30:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:30:54 INFO - Running setup.py install for mozcrash 17:30:54 INFO - Running setup.py install for mozdebug 17:30:54 INFO - Running setup.py install for mozdevice 17:30:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:30:54 INFO - Running setup.py install for mozfile 17:30:54 INFO - Running setup.py install for mozhttpd 17:30:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:30:55 INFO - Running setup.py install for mozinfo 17:30:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:30:55 INFO - Running setup.py install for mozInstall 17:30:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:30:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:30:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:30:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:30:55 INFO - Running setup.py install for mozleak 17:30:55 INFO - Running setup.py install for mozlog 17:30:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:30:55 INFO - Running setup.py install for moznetwork 17:30:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:30:55 INFO - Running setup.py install for mozprocess 17:30:55 INFO - Running setup.py install for mozprofile 17:30:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:30:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:30:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:30:55 INFO - Running setup.py install for mozrunner 17:30:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:30:55 INFO - Running setup.py install for mozscreenshot 17:30:56 INFO - Running setup.py install for moztest 17:30:56 INFO - Running setup.py install for mozversion 17:30:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:30:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:30:56 INFO - Cleaning up... 17:30:56 INFO - Return code: 0 17:30:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:30:56 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 0x24121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277cd60>, '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 0x277da60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277def0>, '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': '00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509', '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 17:30:56 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 17:30:56 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 17:30:56 INFO - Using env: {'DISPLAY': ':0', 17:30:56 INFO - 'HOME': '/home/cltbld', 17:30:56 INFO - 'LANG': 'en_US.UTF-8', 17:30:56 INFO - 'LANGUAGE': 'en_US:en', 17:30:56 INFO - 'LOGNAME': 'cltbld', 17:30:56 INFO - 'MAIL': '/var/mail/cltbld', 17:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:30:56 INFO - 'MOZ_NO_REMOTE': '1', 17:30:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:30:56 INFO - 'NO_EM_RESTART': '1', 17:30:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:30:56 INFO - 'PWD': '/builds/slave/test', 17:30:56 INFO - 'SHELL': '/bin/bash', 17:30:56 INFO - 'SHLVL': '1', 17:30:56 INFO - 'TERM': 'linux', 17:30:56 INFO - 'TMOUT': '86400', 17:30:56 INFO - 'USER': 'cltbld', 17:30:56 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509', 17:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:30:56 INFO - '_': '/tools/buildbot/bin/python'} 17:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:30:56 INFO - Running setup.py (path:/tmp/pip-SMnKGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:30:56 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)) 17:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:30:56 INFO - Running setup.py (path:/tmp/pip-md_2cD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:30:56 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)) 17:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:30:56 INFO - Running setup.py (path:/tmp/pip-zB73h9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:30:56 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)) 17:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:30:56 INFO - Running setup.py (path:/tmp/pip-fzWVfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:30:56 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)) 17:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:30:56 INFO - Running setup.py (path:/tmp/pip-dEjvZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:30:56 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)) 17:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:30:56 INFO - Running setup.py (path:/tmp/pip-XeeKxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:30:56 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)) 17:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:30:56 INFO - Running setup.py (path:/tmp/pip-sbqniq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:30:56 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)) 17:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:30:56 INFO - Running setup.py (path:/tmp/pip-4jTxYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:30:57 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)) 17:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:30:57 INFO - Running setup.py (path:/tmp/pip-l_mxFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:30:57 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)) 17:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:30:57 INFO - Running setup.py (path:/tmp/pip-oUQfM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:30:57 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)) 17:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:30:57 INFO - Running setup.py (path:/tmp/pip-C_7nSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:30:57 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)) 17:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:30:57 INFO - Running setup.py (path:/tmp/pip-siNDIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:30:57 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)) 17:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:30:57 INFO - Running setup.py (path:/tmp/pip-zmp6di-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:30:57 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)) 17:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:30:57 INFO - Running setup.py (path:/tmp/pip-sECKrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:30:57 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)) 17:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:30:57 INFO - Running setup.py (path:/tmp/pip-21LnLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:30:57 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)) 17:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:30:57 INFO - Running setup.py (path:/tmp/pip-lPk9Z9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:30:57 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)) 17:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:30:57 INFO - Running setup.py (path:/tmp/pip-qRYD5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:30:57 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)) 17:30:57 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)) 17:30:57 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)) 17:30:57 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)) 17:30:57 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)) 17:30:57 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)) 17:30:57 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)) 17:30:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:30:57 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 17:30:57 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 17:30:57 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 17:30:57 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 17:30:58 INFO - Downloading blessings-1.6.tar.gz 17:30:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:30:58 INFO - Installing collected packages: blessings 17:30:58 INFO - Running setup.py install for blessings 17:30:59 INFO - Successfully installed blessings 17:30:59 INFO - Cleaning up... 17:30:59 INFO - Return code: 0 17:30:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:30:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:30:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:30:59 INFO - Reading from file tmpfile_stdout 17:30:59 INFO - Current package versions: 17:30:59 INFO - argparse == 1.2.1 17:30:59 INFO - blessings == 1.6 17:30:59 INFO - blobuploader == 1.2.4 17:30:59 INFO - docopt == 0.6.1 17:30:59 INFO - functools32 == 3.2.3-2 17:30:59 INFO - jsonschema == 2.5.1 17:30:59 INFO - manifestparser == 1.1 17:30:59 INFO - mozInstall == 1.13 17:30:59 INFO - mozcrash == 1.0 17:30:59 INFO - mozdebug == 0.1 17:30:59 INFO - mozdevice == 0.51 17:30:59 INFO - mozfile == 1.2 17:30:59 INFO - mozhttpd == 0.7 17:30:59 INFO - mozinfo == 0.10 17:30:59 INFO - mozleak == 0.1 17:30:59 INFO - mozlog == 3.5 17:30:59 INFO - moznetwork == 0.27 17:30:59 INFO - mozprocess == 0.25 17:30:59 INFO - mozprofile == 0.28 17:30:59 INFO - mozrunner == 6.13 17:30:59 INFO - mozscreenshot == 0.1 17:30:59 INFO - mozsystemmonitor == 0.3 17:30:59 INFO - moztest == 0.8 17:30:59 INFO - mozversion == 1.4 17:30:59 INFO - psutil == 3.1.1 17:30:59 INFO - requests == 1.2.3 17:30:59 INFO - wsgiref == 0.1.2 17:30:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:30:59 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')]} 17:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:30:59 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')]} 17:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:30:59 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 0x24121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277cd60>, '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 0x277da60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277def0>, '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': '00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509', '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 17:30:59 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 17:30:59 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 17:30:59 INFO - Using env: {'DISPLAY': ':0', 17:30:59 INFO - 'HOME': '/home/cltbld', 17:30:59 INFO - 'LANG': 'en_US.UTF-8', 17:30:59 INFO - 'LANGUAGE': 'en_US:en', 17:30:59 INFO - 'LOGNAME': 'cltbld', 17:30:59 INFO - 'MAIL': '/var/mail/cltbld', 17:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:30:59 INFO - 'MOZ_NO_REMOTE': '1', 17:30:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:30:59 INFO - 'NO_EM_RESTART': '1', 17:30:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:30:59 INFO - 'PWD': '/builds/slave/test', 17:30:59 INFO - 'SHELL': '/bin/bash', 17:30:59 INFO - 'SHLVL': '1', 17:30:59 INFO - 'TERM': 'linux', 17:30:59 INFO - 'TMOUT': '86400', 17:30:59 INFO - 'USER': 'cltbld', 17:30:59 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509', 17:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:30:59 INFO - '_': '/tools/buildbot/bin/python'} 17:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:30:59 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)) 17:30:59 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)) 17:30:59 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)) 17:30:59 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)) 17:30:59 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)) 17:30:59 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)) 17:30:59 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)) 17:30:59 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)) 17:30:59 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)) 17:30:59 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:30:59 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 17:30:59 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 17:30:59 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 17:30:59 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 17:31:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:31:00 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)) 17:31:00 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)) 17:31:00 INFO - Installing collected packages: simplejson 17:31:00 INFO - Running setup.py install for simplejson 17:31:00 INFO - building 'simplejson._speedups' extension 17:31:00 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 17:31:01 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 17:31:01 INFO - Successfully installed simplejson 17:31:01 INFO - Cleaning up... 17:31:01 INFO - Return code: 0 17:31:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:31:01 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')]} 17:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:01 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')]} 17:31:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:01 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 0x24121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277cd60>, '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 0x277da60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277def0>, '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': '00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509', '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 17:31:01 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 17:31:01 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 17:31:01 INFO - Using env: {'DISPLAY': ':0', 17:31:01 INFO - 'HOME': '/home/cltbld', 17:31:01 INFO - 'LANG': 'en_US.UTF-8', 17:31:01 INFO - 'LANGUAGE': 'en_US:en', 17:31:01 INFO - 'LOGNAME': 'cltbld', 17:31:01 INFO - 'MAIL': '/var/mail/cltbld', 17:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:01 INFO - 'MOZ_NO_REMOTE': '1', 17:31:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:31:01 INFO - 'NO_EM_RESTART': '1', 17:31:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:01 INFO - 'PWD': '/builds/slave/test', 17:31:01 INFO - 'SHELL': '/bin/bash', 17:31:01 INFO - 'SHLVL': '1', 17:31:01 INFO - 'TERM': 'linux', 17:31:01 INFO - 'TMOUT': '86400', 17:31:01 INFO - 'USER': 'cltbld', 17:31:01 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509', 17:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:01 INFO - '_': '/tools/buildbot/bin/python'} 17:31:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:31:01 INFO - Cleaning up... 17:31:01 INFO - Return code: 0 17:31:01 INFO - Running post-action listener: _resource_record_post_action 17:31:01 INFO - Running post-action listener: _start_resource_monitoring 17:31:02 INFO - Starting resource monitoring. 17:31:02 INFO - [mozharness: 2017-10-03 00:31:02.022120Z] Finished create-virtualenv step (success) 17:31:02 INFO - [mozharness: 2017-10-03 00:31:02.022634Z] Running install step. 17:31:02 INFO - Running pre-action listener: _resource_record_pre_action 17:31:02 INFO - Running main action method: install 17:31:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:31:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:31:02 INFO - Reading from file tmpfile_stdout 17:31:02 INFO - Detecting whether we're running mozinstall >=1.0... 17:31:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:31:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:31:02 INFO - Reading from file tmpfile_stdout 17:31:02 INFO - Output received: 17:31:02 INFO - Usage: mozinstall [options] installer 17:31:02 INFO - Options: 17:31:02 INFO - -h, --help show this help message and exit 17:31:02 INFO - -d DEST, --destination=DEST 17:31:02 INFO - Directory to install application into. [default: 17:31:02 INFO - "/builds/slave/test"] 17:31:02 INFO - --app=APP Application being installed. [default: firefox] 17:31:02 INFO - mkdir: /builds/slave/test/build/application 17:31:02 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'] 17:31:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:31:20 INFO - Reading from file tmpfile_stdout 17:31:20 INFO - Output received: 17:31:20 INFO - /builds/slave/test/build/application/firefox/firefox 17:31:20 INFO - Running post-action listener: _resource_record_post_action 17:31:20 INFO - [mozharness: 2017-10-03 00:31:20.055140Z] Finished install step (success) 17:31:20 INFO - [mozharness: 2017-10-03 00:31:20.055395Z] Running setup-mitmproxy step. 17:31:20 INFO - Running pre-action listener: _resource_record_pre_action 17:31:20 INFO - Running main action method: setup_mitmproxy 17:31:20 INFO - Skipping: mitmproxy is not required 17:31:20 INFO - Running post-action listener: _resource_record_post_action 17:31:20 INFO - [mozharness: 2017-10-03 00:31:20.056539Z] Finished setup-mitmproxy step (success) 17:31:20 INFO - [mozharness: 2017-10-03 00:31:20.056760Z] Running run-tests step. 17:31:20 INFO - Running pre-action listener: _resource_record_pre_action 17:31:20 INFO - Running pre-action listener: _set_gcov_prefix 17:31:20 INFO - Running main action method: run_tests 17:31:20 WARNING - Try message not found. 17:31:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:31:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:31:20 INFO - Python 2.7.3 17:31:20 INFO - Return code: 0 17:31:20 INFO - grabbing minidump binary from tooltool 17:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:20 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 0x277cd60>, '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 0x277da60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277def0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:31:20 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 17:31:20 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 17:31:20 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 17:31:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:31:20 INFO - Return code: 0 17:31:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:31:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:31:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:31:20 INFO - ENV: RUST_BACKTRACE is now full 17:31:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:31:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:31:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O8PaNEsoTpCKDFDDGb4FLA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 17:31:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O8PaNEsoTpCKDFDDGb4FLA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 17:31:20 INFO - Using env: {'DISPLAY': ':0', 17:31:20 INFO - 'HOME': '/home/cltbld', 17:31:20 INFO - 'LANG': 'en_US.UTF-8', 17:31:20 INFO - 'LANGUAGE': 'en_US:en', 17:31:20 INFO - 'LOGNAME': 'cltbld', 17:31:20 INFO - 'MAIL': '/var/mail/cltbld', 17:31:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:31:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:31:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:20 INFO - 'MOZ_NO_REMOTE': '1', 17:31:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:31:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:31:20 INFO - 'NO_EM_RESTART': '1', 17:31:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:31:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:20 INFO - 'PWD': '/builds/slave/test', 17:31:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:31:20 INFO - 'RUST_BACKTRACE': 'full', 17:31:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:31:20 INFO - 'SHELL': '/bin/bash', 17:31:20 INFO - 'SHLVL': '1', 17:31:20 INFO - 'TERM': 'linux', 17:31:20 INFO - 'TMOUT': '86400', 17:31:20 INFO - 'USER': 'cltbld', 17:31:20 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509', 17:31:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:20 INFO - '_': '/tools/buildbot/bin/python'} 17:31:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O8PaNEsoTpCKDFDDGb4FLA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 17:31:20 INFO - mozversion application_buildid: 20171002230255 17:31:20 INFO - mozversion application_changeset: 8c6b4fd1d76927cf8b07eb045c5aadd47b77d910 17:31:20 INFO - mozversion application_display_name: Nightly 17:31:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:31:20 INFO - mozversion application_name: Firefox 17:31:20 INFO - mozversion application_remotingname: firefox 17:31:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:31:20 INFO - mozversion application_vendor: Mozilla 17:31:20 INFO - mozversion application_version: 58.0a1 17:31:20 INFO - mozversion platform_buildid: 20171002230255 17:31:20 INFO - mozversion platform_changeset: 8c6b4fd1d76927cf8b07eb045c5aadd47b77d910 17:31:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:31:20 INFO - mozversion platform_version: 58.0a1 17:31:20 INFO - using testdate: 1506990680 17:31:20 INFO - actual date: 1506990680 17:31:20 INFO - starting webserver on 'localhost:39380' 17:31:20 INFO - SUITE-START | Running 2 tests 17:31:20 INFO - TEST-START | dromaeo_css 17:31:20 INFO - Initialising browser for dromaeo_css test... 17:31:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39380/getInfo.html -profile /tmp/tmpAUom__/profile 17:31:20 INFO - TEST-INFO | started process 31797 (/builds/slave/test/build/application/firefox/firefox http://localhost:39380/getInfo.html) 17:31:26 INFO - TEST-INFO | 31797: exit 0 17:31:26 INFO - Browser initialized. 17:31:26 INFO - Running cycle 1/1 for dromaeo_css test... 17:31:26 INFO - Using env: {'DISPLAY': ':0', 17:31:26 INFO - 'HOME': '/home/cltbld', 17:31:26 INFO - 'JSGC_DISABLE_POISONING': '1', 17:31:26 INFO - 'LANG': 'en_US.UTF-8', 17:31:26 INFO - 'LANGUAGE': 'en_US:en', 17:31:26 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:31:26 INFO - 'LOGNAME': 'cltbld', 17:31:26 INFO - 'MAIL': '/var/mail/cltbld', 17:31:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:31:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:31:26 INFO - 'MOZ_CRASHREPORTER': '1', 17:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:26 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:31:26 INFO - 'MOZ_NO_REMOTE': '1', 17:31:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:31:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:31:26 INFO - 'NO_EM_RESTART': '1', 17:31:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:26 INFO - 'PWD': '/builds/slave/test', 17:31:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:31:26 INFO - 'RUST_BACKTRACE': 'full', 17:31:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:31:26 INFO - 'SHELL': '/bin/bash', 17:31:26 INFO - 'SHLVL': '1', 17:31:26 INFO - 'STYLO_FORCE_DISABLED': '1', 17:31:26 INFO - 'TERM': 'linux', 17:31:26 INFO - 'TMOUT': '86400', 17:31:26 INFO - 'USER': 'cltbld', 17:31:26 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509', 17:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:26 INFO - '_': '/tools/buildbot/bin/python'} 17:31:26 INFO - TEST-INFO | started process 32036 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAUom__/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:31:26 INFO - PID 32036 | 17:31:26 INFO - PID 32036 | (/builds/slave/test/build/application/firefox/firefox:32086): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:31:26 INFO - PID 32036 | 17:31:37 INFO - PID 32036 | RSS: Main: 144420864 17:31:37 INFO - PID 32036 | 17:34:34 INFO - PID 32036 | Cycle 1(1): loaded http://localhost:39380/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39380/tests/dromaeo/cssquery-ext.html) 17:34:35 INFO - PID 32036 | RSS: Main: 142258176 17:34:35 INFO - PID 32036 | 17:37:37 INFO - PID 32036 | Cycle 1(1): loaded http://localhost:39380/tests/dromaeo/cssquery-ext.html (next: http://localhost:39380/tests/dromaeo/cssquery-jquery.html) 17:37:37 INFO - PID 32036 | RSS: Main: 144244736 17:37:37 INFO - PID 32036 | 17:40:39 INFO - PID 32036 | Cycle 1(1): loaded http://localhost:39380/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39380/tests/dromaeo/cssquery-mootools.html) 17:40:40 INFO - PID 32036 | RSS: Main: 144728064 17:40:40 INFO - PID 32036 | 17:43:41 INFO - PID 32036 | Cycle 1(1): loaded http://localhost:39380/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39380/tests/dromaeo/cssquery-prototype.html) 17:43:42 INFO - PID 32036 | RSS: Main: 144580608 17:43:42 INFO - PID 32036 | 17:46:45 INFO - PID 32036 | Cycle 1(1): loaded http://localhost:39380/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39380/tests/dromaeo/cssquery-yui.html) 17:46:45 INFO - PID 32036 | RSS: Main: 147849216 17:46:45 INFO - PID 32036 | 17:49:47 INFO - PID 32036 | Cycle 1(1): loaded http://localhost:39380/tests/dromaeo/cssquery-yui.html (next: http://localhost:39380/tests/dromaeo/cssquery-dojo.html) 17:49:47 INFO - PID 32036 | RSS: Main: 149057536 17:49:47 INFO - PID 32036 | 17:49:47 INFO - PID 32036 | __start_tp_report 17:49:47 INFO - PID 32036 | _x_x_mozilla_page_load 17:49:47 INFO - PID 32036 | _x_x_mozilla_page_load_details 17:49:47 INFO - PID 32036 | |i|pagename|runs| 17:49:47 INFO - PID 32036 | |0;dojo.html;3930.0567863712704;3931.882043538694;3937.0944682722993;3950.0717331427127;3966.1274519605695;6222.5021998240145;6227.813165605039;6315.842103947398;6355.332690067546;6378.712957916893;6234.283057448383;6317.589356691812;6321.462675672562;6339.397757213069;6350.460210882069;5605.691686957216;5688.63023903445;5704;5711.143328500717;5730.36965933747;5540.63985840921;5684.971575142139;5748.109043098327;5764.884702305952;5780.913286300709;5608.6634801911605;5715.9428405716035;5734.483896449318;5745.482906538411;5789.565782566303;5517.503424691797;5597.580181486364;5620.213170156181;5649.745761440745;5658.603897727161;5587.357453892813;5643.6049476536655;5656.321241451011;5663.915041274384;5666.5183459406;6153.323134455206;6210.782622608187;6232.563720539564;6266.248050233956;6343;6701.195856497203;6717.865642687118;6743.865122697568;6834.726610935557;6868.828279293058;6742.865142697167;6818.624975626339;6857.177138743333;6871.828204294882;6879.208890977551;6272.247330320391;6286.025666021774;6360.872782544323;6361.141245931786;6443;6950.652467376611;6992.021117043618;7034.050403195503;7048.682809273595;7049.7885063448175;6624.668766561653;6654.401103900672;6702.865942681119;6749.291324410964;6773.051772751819;6781.25406205317;6819.24988251292;6829.726810927507;6908.861822763617;6913.481488888354;6680.96659516709;6751.122354093936;6767.323267673291;6775.932240677629;6788.728450862009;6825.897611535831;6839.658017099225;6873.1064961554675;6920.446364290845;6928.3764461197725;4957.702537847741;4990.675606085593;5013.649044566918;5024.447310795809;5086.974565127225;4435.090806384748;4474;4516.435445569304;4524.6832721709825;4525.841595544141;6334.809955701337;6359.9364006360265;6373.776917807854;6374.330695277022;6377.585456945284;6758.222804377461;6823.795286141324;6856.5200435969;6927.7228910843005;6941.271166527543;6131.84670383244;6215.844603884849;6260.029695397129;6286.465650419766;6315.652639104802;5490.3411590609385;5531.115021596525;5537.363203231599;5559.193916882029;5564.527015203672;7025.718971241093;7041.3310735480045;7136.6431678415875;7144.142702875584;7148.28517148281;6736.191657001191;6769.729210831511;6772.513147728064;6863.691133899087;6895.069165662571;7025.613591252326;7110.715571377087;7123.82190445243;7136.357727804522;7140.321669441395;6710.6309152997055;6747.966260168668;6788.321167883172;6817.318268173143;6840.7263709453055;6661.300563440769;6781.220159681502;6787.389134977876;6792.524523283323;6792.864142717217;6654.600723956578;6683.9639855822425;6690.732370705117;6697.966510167418;6699.698513566804;6518;6561.770338038145;6597.406233439014;6685.331466853276;6687.097241872285;6359.332270111757;6482.157319548429;6557.704903279459;6572.211334639683;6583.868322633425;6596;6641.701123449359;6644.269130395749;6659.101021362248;6679.76620818269;6456.903146452901;6461.386168314003;6462.7091780870915;6501.024846273097;6537.378948999837 17:49:47 INFO - PID 32036 | |1;ext.html;921.5115988526084;954.8663187153804;968.5447839515426;1012.1851909213085;1018.8981101889816;44902.32646510305;45633.771831140795;45829.31256031154;45852;45861.31208031882;43004.569954300445;45422.318665220046;46471.53528464714;46557;46699.06601867961;8447.450915690475;8625.568721563928;8643.178898004711;8651.13488651133;8681.913180868205;8493.872591911126;8621.913780862205;8622.698205562807;8645.870311945326;8648.005479369858;8626.396152269344;8664.826703465927;8666.176713212235;8671;8682.522461264627;8623.827523449527;8663.133686631287;8672.04607493172;8672.696455624055;8676.392652514327;8444.788880277982;8470.32237421011;8491.23578877904;8508.744737657818;8525.829483410296;41545;41835.372469412985;42294;42318.36522452166;42326.576734232876;3824.9043773905873;3854.8458061677497;3858.6334298241622;3865.8016015035428;3869.342211823997;34423.311533769185;34525.654743452746;34548.13629659254;34570.827145864365;34666.13334666628;5583.3858275589655;5589.664620122806;5604.355499117612;5631.71841407928;5736.082226843685;229296;229708;231159;231608.84195578913;231791;56847.43152568422;57732.71133644305;58066.419335806946;58113.4188658108;58292.251232463095;60157.39842601606;60359;60577.69711151416;60620.39379606147;60658.39341606616;16677.24952377146;16864.156792160342;16874.15629218534;16881.071541065114;16894.408695695838;13374.933125334506;13500.392482338319;13514.459421623025;13529.52646657382;13547.119437236548;16265.837341626433;16273.837261627232;16338.264778085015;16339.509814705578;16365.427210047592;6138.693065346715;6229.844253893689;6320.525960552977;6376.107344971708;6471.2234531856475;1072.4905669806778;1095.4084794211037;1098.9945050274857;1113.2819331531116;1117.2179474367974;26132.216033519024;26264.343391414986;26366.73633263643;26567;26644;1196.5094311332311;1214.8845859643498;1219.676785651803;1225.7058306006672;1247.731737676404;14018.929905350407;14072.707824113539;14083.155010699391;14327.35526901292;14387.064840785315;311199;314301;316424;316659;316727;59432.70283648554;59656.70171649114;59830;60090.39909600936;60269;1531.716632422983;1543.1589783567983;1558.6103474131467;1571.080917663157;1582.1772678207267;26070.73929260683;26366.209013729618;26445.867770661025;26512;26601;42825.785871070446;42838.78580607077;42930.78534607432;42951.785241073594;42970.14059718726;239527;241624;242289;243575;244250;38589.61410385973;42211.73364799061;43006.35490467708;43182.13635727205;43302.566974331115;52185.217221740946;52868;52974;53192.20211696905;53405.19892201698;38642.42036369513;38802.41796373113;38949;39192.80403598078;39425;38176.61823381731;38337.4249386265;38383.80808095942;38417.42373864338;38470.42294365643;44854;45006.54993450024;45054.098918022115;45111.32333015073;45364.092718146116;37238.62761372352;37310.440343395414;37337;37360.25279494341;37574.43638345482;27719.58420623652;27958;28278.57582136311;28286.434271314047;28614 17:49:47 INFO - PID 32036 | |2;jquery.html;633.5451569420371;635.5378856031806;636.2837145368972;636.5261368095217;644.5672191528546;23700.5259894802;24139.275821725332;24577.38556536085;24583.877080614573;24611.26166215012;25758.484830303383;26115;26166.869165654192;26172;26178;6258.874822503547;6487.12423822785;6729.293424190463;6759.898601520957;6769.898451523231;6502.869942601145;6578.967105164467;6584.506162037842;6588.505862060365;6589.275179730226;6453.096566480696;6524.412802847743;6708.161479815023;6713.160854893138;6714;6670.599764014175;6713.194416669982;6714.227863795652;6715.395614394728;6719.63042032688;5879.470847623692;6134.631922084689;6136.355682653347;6150.692465376714;6288.465480434169;30829;31173;31267.687323126705;31282.37435251305;31347;2312.491251924574;2320.2923108451914;2326.8720220387872;2326.8836558172025;2333.988330058356;20416.795832041636;20997.68503472449;21268.680969785466;21332.893335533223;21595.67606485904;2557.654716613252;2610.2691246451022;2610.334364736999;2665.8800353983925;2678.665166854143;144575.27712361372;151293;169907;175661;175822;16155.838441615668;16519.174041297887;16877.746833797504;16933.661326773396;17068.573285667957;27509.587356189673;27630.72369276322;27635.723642763718;27668.58497122545;27704.584431233547;10775.730606734738;11080;11110.666679999613;11120.38837863909;11220.719482013015;9958.452285124387;10015.098641122187;10016.54925528353;10023.5966964625;10119.443430611387;10028.899711002796;10083.243756718275;10381.11760500366;10459.11097556701;10486.213533984828;2854.942901142007;2856.1431570529176;2878.942421151565;2883.68279489256;2915.5772412999995;1047.3454091193005;1059.8410238464292;1063.9893601064045;1079.5196137718797;1080.1304949515559;21323.36029919105;21575.892120539298;21731.67402488964;21931.342059738232;22149.335519934426;1127.5997021057406;1133.3086817041599;1142.959996400122;1143.2854465958776;1152.3661985907718;11893.940530297294;11896.524139034342;11987.88012119885;12094.516219351128;12171.148019638717;585360;598645;609537;616301;616689;134697;138172;138923;139533.3023334877;141371;1241.1126044877956;1249.8875101241115;1267.3789842976876;1276.125853790138;1279.6097190356845;19130.904075636376;19224.231030759172;19276.61446771085;19499;19991.20035198634;66068;66319.66840165768;66429.33570664232;66561.33438665551;66890.33109668842;78245;79319.60340198262;80962;82577;83936.16063839283;15968.441104561285;16252.187390630657;16331;16376.508704738877;16378;24397.39006524851;24558.140465083638;24653.876730616234;24829;24871.751282486945;20008;20273.374626887795;20279.59440811205;20344.59310813805;20573.89713051425;17503.124843758014;17644;17959.461216163538;18192.090395479907;18279.752565780695;20519.38441846747;20558.486037849172;20740.896295518425;20893;20904;15808.288627011581;15976.920115399349;16001.19994000272;16015.119168445848;16071;19638.90180549088;20021;20225.79774202239;20243.696344554548;20372.47206459551 17:49:47 INFO - PID 32036 | |3;mootools.html;1394.9023568350217;1467.8018467506884;1471.5585324402678;1474.6829431672195;1488.5683151885953;17075.48773536793;17687.73468397975;17695.64608707827;17726.29094836205;17728.46814595564;17382.739258911093;17444.215010324533;17623.206955686994;17624.295028198856;17641;2929.370185410142;2929.6923822998597;2992.0425463851575;3000.9249768755735;3006.8045577037533;2902.2309088091674;2905.520589102806;2906.593076969226;2906.607607972918;2910.4179164167144;2850.686424493304;2931.8387488688113;2936.324645331575;2944.838033908134;2974.5240761478167;2862.2844288927768;2913.2279945814375;2919.6350456192977;2920.1823489422995;2921.1674672718173;2878.7553057990094;2904.0852131578486;2922.473954688155;3023.6220472440946;3024.077656314823;16823.915880420518;16938.576535586584;16960.74558881618;16965.15174241283;16974.066426346548;8543.95728021362;8791.164839340316;8859.778505537348;8859.955700221522;8862.980757212874;5666.291713535808;5799.942000580025;5833.620814647034;5840.532757379442;5924.7333869975955;2205.106931692667;2224.0325458425473;2239.585676649825;2267.263139479676;2271.2845453682203;30658.84670576655;31462;31508.054758357055;31521.52717709213;31523.684763152305;7830.960845195851;7893.329067029252;7932.365410767125;7983.84032319362;8188.7952801180445;19562.510937226398;20327.796722032886;20411.183552657727;20439.080241389172;23784.643230351558;8521.531315777567;8715.128487151362;8719.782005449788;8721.781955451164;8755.993060797962;7815.29662330393;7899.486533375312;8050.516968981763;8084.39367047462;8095;5746.885062298814;5976.701164941735;5977.641341519436;6026.216591843032;6100.633961962208;1707.4962885948676;1717.2358300556382;1731.7315816048533;1752.5005373468755;1758.9296428142732;984.7439665686973;997.9650712225038;1007.8135544924213;1019.7705516258783;1023.2376879225025;8254.711085111992;8385;8429.367797415096;8434;8525.616347264388;807.5275963561265;811.5901469757735;812.3298278919915;821.5604651511412;827.437342607033;5050.545450909436;5165.535101840777;5413.404525502192;5895.882082358329;5973.790917317873;23035.193768218032;23125.306240812803;23409.7659023411;23419.414514637272;24213.63679544808;22783.31650050501;22989;23396;23400.297991059953;23404.297871063554;11682.007029402426;11767.293962362115;11936.522539098512;12082.335471548973;12084.154109212272;8601.483910965362;8888.73333799987;9002.414843035182;9028.503432311287;9044.186023257938;20354.592908141458;20817.167313307298;20893.477663058544;20948.895255524236;21270.893645531673;19825;21146.788532114482;21603.35189944304;21718.23986160477;21903.45241368915;12761.106722529334;12971.41628626733;12974.091813573337;12979.480820767441;12980.545680901123;15396.84603153954;15471.458498952483;15513.45702900393;15885.126318052618;15908.363665453715;12755.48978040868;13051.28217948022;13073;13074.411651475897;13109.278989655279;12301.815472767737;12425.130240883413;12445.937770311091;12683.365831708563;12990.285534295705;10055.597776089167;10073.748156296151;10162.237832162766;10194.286399951932;10218.437985910548;8018.679252829821;8020.478668886503;8091.919080809352;8104.149064348158;8109.675612975415;8101.432899697201;8231.34149268069;8249.257566819015;8258.215469530385;8274.958625206835 17:49:47 INFO - PID 32036 | |4;prototype.html;547.4744245524297;571.9399463056379;582.4641329976423;586.1617886422417;586.4077281945234;6229.563930524865;6234.220722409699;6274.341194174609;6297.54395785644;6306.7161977711;6157.599756015867;6157.907631385533;6229.37706229378;6245.033609035717;6263.655498947556;5182.8704282393055;5184.481551844804;5186.0665080285535;5195.740212989354;5203.817866374678;4882.365292511969;5015.799368025275;5113.360829896263;5124.385073791151;5142.640015198919;4938.876528086791;5020.698758074527;5024.598032157437;5026.120428924942;5043;4985.326980857574;4999.4000719913665;5003.849884503471;5014.52362025607;5029.05800106936;4446.42152036029;4484.955150448486;4518.254488009475;4546.318052292183;4579.404677391951;5997.850053748648;6040.516758659297;6047.5766696331275;6082.452579267843;6089.950183128214;5802;5815.767369305223;5818.679972601505;5845.941540584625;5915.1718759373725;6559.245686746038;6577.309382514863;6578.210614726264;6607.438367738748;6633.810842421989;5038.722870242135;5073.543381095719;5084.034033533617;5117.923231151536;5130.153524668425;6666.733330666768;6680.432163266129;6793.592384456949;6811.761588344384;6873.48448866337;5205.401378841406;5213.478652134756;5236;5240.213967904769;5244.344456942882;5273.2617433559335;5290.761915713802;5290.81482148123;5309.177077552986;5372.274742909657;5882.470577648032;5884.47039766423;5891.558133140032;5903.970480147572;5916.881662366729;6466.6766661666725;6582.210134783857;6589.80230593083;6635.004749287646;6651.933480665131;1790.51656052865;1792.7131658934509;1792.8027916929127;1811.3026484803445;1822.5443639090226;1283.6393422971494;1314.1655049043734;1315.2700251360586;1324.5758073344396;1340.4169186403944;6008.759649613967;6018.729157187937;6037.335893051761;6042.244719410074;6088.112685067643;6478.935210647927;6616.536842420985;6663.500237482208;6696.531242812956;6696.564723293068;6030.728617212236;6134.355892631299;6166.445019948136;6204.153424876606;6211.534134939898;3516.7889926604485;3535.2575959048886;3554.360215161244;3557.5375201223674;3560.5549306336707;6906.447484201251;6934.306569343025;6949.722011119498;6953.443724502028;6956.234814170437;6798.456123510107;6799.5920244785475;6885.552439091443;6915.78973679604;6932.688029038705;6803.265167382286;6816.863662726718;6830.59016459014;6875.5530890491955;6909.412699920563;6579.868402631825;6595.207755540488;6625.337466253336;6716;6732.259451460238;6532.41208291256;6559.4752419805345;6600.2409722882485;6684.197896252481;6716.83207919806;6782.8643427132165;6813.693383797642;6824.283450237654;6880.724771009303;6934.7226110955;5211.791528338824;5236.6072544560075;5260.421353651172;5262.789488420573;5286.550643195218;6572.474202063728;6742.292059333896;6760.18877734675;6765.42493888025;6830.21452532965;6215.160953271251;6465.77369792055;6519.4784417245555;6520;6567.638779867153;6482.0229829900445;6524.347565243438;6527.67361631907;6549.100760779321;6571.638559879252;6353.841153971188;6382;6430.549861509649;6437.742490300336;6444.548881578245;6581.967090164519;6584.8024559263295;6591.34086591337;6616.735330586916;6632.767853125118;6298.149749783721;6422;6449.064885591657;6453.612473318259;6488.183308673579 17:49:47 INFO - PID 32036 | |5;yui.html;953.5661274120276;962.8555716642505;970;984.4634674102614;986.358866736621;17987.820121798777;18162.455126346198;18234;18242.908785456053;18259.90870045651;17334.826651733478;17410.30358785647;17434.82565174348;19609.901950490228;19835.107420166092;1048.491481631408;1056.2606175677017;1059.978800423991;1066.6053560182743;1068.834330678746;1066.2003497376968;1071.817790975532;1072.029813019215;1072.7639919217759;1078.5308390850005;1081.3890152064098;1125.5891599566141;1129.0967226219034;1134.4384529657832;1135.534430883338;1119.9608013719521;1120.9943950280278;1121.1367247219596;1122.2593088561591;1124.0670243697753;825.8637324841394;828.647824674517;829.8091438969011;829.9419040667156;830.5847076461769;18868.62262754751;21203.5759284815;21239.25662601817;21397.67903481449;21404.678929816066;23386.532269354517;23529.17647882316;24189.516209675883;24190.395240118964;24218.63672044921;16429.753553696704;16476.67046659072;16508.092054936973;16526.83473165265;16534.255958481896;3888.475055867478;3896.2012787378803;3916.843326266946;3925.0776067624083;3937.1928754605237;129139;140431;160528;167110;169217;16417;16426.671466570602;16518.75221871673;16738.665226695397;16810.243539040774;34963;35798.105047374025;35804.82097589495;35923.64076359255;35927.281454370765;9768.90231097694;9947.154491868128;9973.351732137387;9978.600855965826;9996.450195239331;4540.545945405433;4578.725276483355;4605.815767369268;4612.7924243409125;4620.2607582786595;6004.099385092271;6081.756729730761;6083.209182806207;6087.726052327655;6123.6019658722935;1171.701216189866;1182.1075088308273;1198.0774803401332;1202.3507306054807;1208.0094322655514;636.4717284653726;640.7501074580917;649.7076315657973;650.408128602969;663.6747993483159;11275.436228188557;11385.943070284762;11634.011109055826;11696.941515292368;11704.180707350573;642.8746394453037;648.2998361769278;648.8248172993266;655.5116438253436;655.9930506672331;5982.49148822355;6026.156338112668;6153.661548614779;6183.3816618337805;6196.721147548371;156067;157403;158610;159361.2031939833;160135;127903.36048319699;130004;131034.34482827525;132577;133292;114406.85593143963;114613;115280.42359788316;115751.42124289325;116753;11200.38397888124;11314.490847912028;11522.827157592475;11705.590304339306;11812.527498900292;58029.4197058024;58838.41161588329;59202.40797591969;60081.399186007584;60127;72255.63872180606;74826;75202;75308;76571;16623.66752664916;16755.078470684228;16755.74866376981;16796.916015420335;16860.241289141773;17927;18069.728954065962;18114.637707246045;18114.81885181184;18156.636867262845;14026.859731402556;14227.715445691236;14257.144571325754;14322.283885805877;14337.713245735236;15174.848251517344;15451.922740386675;15506.689866202387;15596.922015390304;15622.375104995674;15648.982816116915;15741.370345186064;15828.762568561251;15920.52238432849;15937.362505500114;11275.267107637977;11282.830757538479;11611.593594224161;11627.941860290644;12117.575884843987;12139.150259481752;12184.817227741769;12300.323482208565;12622.179558328678;12651.746965060463 17:49:47 INFO - PID 32036 | __end_tp_report 17:49:47 INFO - PID 32036 | __start_cc_report 17:49:47 INFO - PID 32036 | _x_x_mozilla_cycle_collect,245 17:49:47 INFO - PID 32036 | __end_cc_report 17:49:47 INFO - PID 32036 | __startTimestamp1506991787674__endTimestamp 17:49:47 INFO - PID 32036 | 17:49:47 INFO - PID 32036 | ------- Summary: start ------- 17:49:47 INFO - PID 32036 | Number of tests: 6 17:49:47 INFO - PID 32036 | 17:49:47 INFO - PID 32036 | [#0] dojo.html Cycles:165 Average:6282.27 Median:6537.38 stddev:738.47 (11.3%) stddev-sans-first:717.31 17:49:47 INFO - PID 32036 | Values: 3930.1 3931.9 3937.1 3950.1 3966.1 6222.5 6227.8 6315.8 6355.3 6378.7 6234.3 6317.6 6321.5 6339.4 6350.5 5605.7 5688.6 5704.0 5711.1 5730.4 5540.6 5685.0 5748.1 5764.9 5780.9 5608.7 5715.9 5734.5 5745.5 5789.6 5517.5 5597.6 5620.2 5649.7 5658.6 5587.4 5643.6 5656.3 5663.9 5666.5 6153.3 6210.8 6232.6 6266.2 6343.0 6701.2 6717.9 6743.9 6834.7 6868.8 6742.9 6818.6 6857.2 6871.8 6879.2 6272.2 6286.0 6360.9 6361.1 6443.0 6950.7 6992.0 7034.1 7048.7 7049.8 6624.7 6654.4 6702.9 6749.3 6773.1 6781.3 6819.2 6829.7 6908.9 6913.5 6681.0 6751.1 6767.3 6775.9 6788.7 6825.9 6839.7 6873.1 6920.4 6928.4 4957.7 4990.7 5013.6 5024.4 5087.0 4435.1 4474.0 4516.4 4524.7 4525.8 6334.8 6359.9 6373.8 6374.3 6377.6 6758.2 6823.8 6856.5 6927.7 6941.3 6131.8 6215.8 6260.0 6286.5 6315.7 5490.3 5531.1 5537.4 5559.2 5564.5 7025.7 7041.3 7136.6 7144.1 7148.3 6736.2 6769.7 6772.5 6863.7 6895.1 7025.6 7110.7 7123.8 7136.4 7140.3 6710.6 6748.0 6788.3 6817.3 6840.7 6661.3 6781.2 6787.4 6792.5 6792.9 6654.6 6684.0 6690.7 6698.0 6699.7 6518.0 6561.8 6597.4 6685.3 6687.1 6359.3 6482.2 6557.7 6572.2 6583.9 6596.0 6641.7 6644.3 6659.1 6679.8 6456.9 6461.4 6462.7 6501.0 6537.4 17:49:47 INFO - PID 32036 | 17:49:47 INFO - PID 32036 | [#1] ext.html Cycles:180 Average:45477.16 Median:39070.90 stddev:69084.39 (176.8%) stddev-sans-first:69197.18 17:49:47 INFO - PID 32036 | Values: 921.5 954.9 968.5 1012.2 1018.9 44902.3 45633.8 45829.3 45852.0 45861.3 43004.6 45422.3 46471.5 46557.0 46699.1 8447.5 8625.6 8643.2 8651.1 8681.9 8493.9 8621.9 8622.7 8645.9 8648.0 8626.4 8664.8 8666.2 8671.0 8682.5 8623.8 8663.1 8672.0 8672.7 8676.4 8444.8 8470.3 8491.2 8508.7 8525.8 41545.0 41835.4 42294.0 42318.4 42326.6 3824.9 3854.8 3858.6 3865.8 3869.3 34423.3 34525.7 34548.1 34570.8 34666.1 5583.4 5589.7 5604.4 5631.7 5736.1 229296.0 229708.0 231159.0 231608.8 231791.0 56847.4 57732.7 58066.4 58113.4 58292.3 60157.4 60359.0 60577.7 60620.4 60658.4 16677.2 16864.2 16874.2 16881.1 16894.4 13374.9 13500.4 13514.5 13529.5 13547.1 16265.8 16273.8 16338.3 16339.5 16365.4 6138.7 6229.8 6320.5 6376.1 6471.2 1072.5 1095.4 1099.0 1113.3 1117.2 26132.2 26264.3 26366.7 26567.0 26644.0 1196.5 1214.9 1219.7 1225.7 1247.7 14018.9 14072.7 14083.2 14327.4 14387.1 311199.0 314301.0 316424.0 316659.0 316727.0 59432.7 59656.7 59830.0 60090.4 60269.0 1531.7 1543.2 1558.6 1571.1 1582.2 26070.7 26366.2 26445.9 26512.0 26601.0 42825.8 42838.8 42930.8 42951.8 42970.1 239527.0 241624.0 242289.0 243575.0 244250.0 38589.6 42211.7 43006.4 43182.1 43302.6 52185.2 52868.0 52974.0 53192.2 53405.2 38642.4 38802.4 38949.0 39192.8 39425.0 38176.6 38337.4 38383.8 38417.4 38470.4 44854.0 45006.5 45054.1 45111.3 45364.1 37238.6 37310.4 37337.0 37360.3 37574.4 27719.6 27958.0 28278.6 28286.4 28614.0 17:49:47 INFO - PID 32036 | 17:49:47 INFO - PID 32036 | [#2] jquery.html Cycles:180 Average:40745.46 Median:21663.68 stddev:101912.80 (470.4%) stddev-sans-first:102154.19 17:49:47 INFO - PID 32036 | Values: 633.5 635.5 636.3 636.5 644.6 23700.5 24139.3 24577.4 24583.9 24611.3 25758.5 26115.0 26166.9 26172.0 26178.0 6258.9 6487.1 6729.3 6759.9 6769.9 6502.9 6579.0 6584.5 6588.5 6589.3 6453.1 6524.4 6708.2 6713.2 6714.0 6670.6 6713.2 6714.2 6715.4 6719.6 5879.5 6134.6 6136.4 6150.7 6288.5 30829.0 31173.0 31267.7 31282.4 31347.0 2312.5 2320.3 2326.9 2326.9 2334.0 20416.8 20997.7 21268.7 21332.9 21595.7 2557.7 2610.3 2610.3 2665.9 2678.7 144575.3 151293.0 169907.0 175661.0 175822.0 16155.8 16519.2 16877.7 16933.7 17068.6 27509.6 27630.7 27635.7 27668.6 27704.6 10775.7 11080.0 11110.7 11120.4 11220.7 9958.5 10015.1 10016.5 10023.6 10119.4 10028.9 10083.2 10381.1 10459.1 10486.2 2854.9 2856.1 2878.9 2883.7 2915.6 1047.3 1059.8 1064.0 1079.5 1080.1 21323.4 21575.9 21731.7 21931.3 22149.3 1127.6 1133.3 1143.0 1143.3 1152.4 11893.9 11896.5 11987.9 12094.5 12171.1 585360.0 598645.0 609537.0 616301.0 616689.0 134697.0 138172.0 138923.0 139533.3 141371.0 1241.1 1249.9 1267.4 1276.1 1279.6 19130.9 19224.2 19276.6 19499.0 19991.2 66068.0 66319.7 66429.3 66561.3 66890.3 78245.0 79319.6 80962.0 82577.0 83936.2 15968.4 16252.2 16331.0 16376.5 16378.0 24397.4 24558.1 24653.9 24829.0 24871.8 20008.0 20273.4 20279.6 20344.6 20573.9 17503.1 17644.0 17959.5 18192.1 18279.8 20519.4 20558.5 20740.9 20893.0 20904.0 15808.3 15976.9 16001.2 16015.1 16071.0 19638.9 20021.0 20225.8 20243.7 20372.5 17:49:47 INFO - PID 32036 | 17:49:47 INFO - PID 32036 | [#3] mootools.html Cycles:180 Average:10429.64 Median:2890.49 stddev:7631.02 (264.0%) stddev-sans-first:7622.24 17:49:47 INFO - PID 32036 | Values: 1394.9 1467.8 1471.6 1474.7 1488.6 17075.5 17687.7 17695.6 17726.3 17728.5 17382.7 17444.2 17623.2 17624.3 17641.0 2929.4 2929.7 2992.0 3000.9 3006.8 2902.2 2905.5 2906.6 2906.6 2910.4 2850.7 2931.8 2936.3 2944.8 2974.5 2862.3 2913.2 2919.6 2920.2 2921.2 2878.8 2904.1 2922.5 3023.6 3024.1 16823.9 16938.6 16960.7 16965.2 16974.1 8544.0 8791.2 8859.8 8860.0 8863.0 5666.3 5799.9 5833.6 5840.5 5924.7 2205.1 2224.0 2239.6 2267.3 2271.3 30658.8 31462.0 31508.1 31521.5 31523.7 7831.0 7893.3 7932.4 7983.8 8188.8 19562.5 20327.8 20411.2 20439.1 23784.6 8521.5 8715.1 8719.8 8721.8 8756.0 7815.3 7899.5 8050.5 8084.4 8095.0 5746.9 5976.7 5977.6 6026.2 6100.6 1707.5 1717.2 1731.7 1752.5 1758.9 984.7 998.0 1007.8 1019.8 1023.2 8254.7 8385.0 8429.4 8434.0 8525.6 807.5 811.6 812.3 821.6 827.4 5050.5 5165.5 5413.4 5895.9 5973.8 23035.2 23125.3 23409.8 23419.4 24213.6 22783.3 22989.0 23396.0 23400.3 23404.3 11682.0 11767.3 11936.5 12082.3 12084.2 8601.5 8888.7 9002.4 9028.5 9044.2 20354.6 20817.2 20893.5 20948.9 21270.9 19825.0 21146.8 21603.4 21718.2 21903.5 12761.1 12971.4 12974.1 12979.5 12980.5 15396.8 15471.5 15513.5 15885.1 15908.4 12755.5 13051.3 13073.0 13074.4 13109.3 12301.8 12425.1 12445.9 12683.4 12990.3 10055.6 10073.7 10162.2 10194.3 10218.4 8018.7 8020.5 8091.9 8104.1 8109.7 8101.4 8231.3 8249.3 8258.2 8275.0 17:49:47 INFO - PID 32036 | 17:49:47 INFO - PID 32036 | [#4] prototype.html Cycles:180 Average:5606.76 Median:6207.84 stddev:1542.72 (24.9%) stddev-sans-first:1499.59 17:49:47 INFO - PID 32036 | Values: 547.5 571.9 582.5 586.2 586.4 6229.6 6234.2 6274.3 6297.5 6306.7 6157.6 6157.9 6229.4 6245.0 6263.7 5182.9 5184.5 5186.1 5195.7 5203.8 4882.4 5015.8 5113.4 5124.4 5142.6 4938.9 5020.7 5024.6 5026.1 5043.0 4985.3 4999.4 5003.8 5014.5 5029.1 4446.4 4485.0 4518.3 4546.3 4579.4 5997.9 6040.5 6047.6 6082.5 6090.0 5802.0 5815.8 5818.7 5845.9 5915.2 6559.2 6577.3 6578.2 6607.4 6633.8 5038.7 5073.5 5084.0 5117.9 5130.2 6666.7 6680.4 6793.6 6811.8 6873.5 5205.4 5213.5 5236.0 5240.2 5244.3 5273.3 5290.8 5290.8 5309.2 5372.3 5882.5 5884.5 5891.6 5904.0 5916.9 6466.7 6582.2 6589.8 6635.0 6651.9 1790.5 1792.7 1792.8 1811.3 1822.5 1283.6 1314.2 1315.3 1324.6 1340.4 6008.8 6018.7 6037.3 6042.2 6088.1 6478.9 6616.5 6663.5 6696.5 6696.6 6030.7 6134.4 6166.4 6204.2 6211.5 3516.8 3535.3 3554.4 3557.5 3560.6 6906.4 6934.3 6949.7 6953.4 6956.2 6798.5 6799.6 6885.6 6915.8 6932.7 6803.3 6816.9 6830.6 6875.6 6909.4 6579.9 6595.2 6625.3 6716.0 6732.3 6532.4 6559.5 6600.2 6684.2 6716.8 6782.9 6813.7 6824.3 6880.7 6934.7 5211.8 5236.6 5260.4 5262.8 5286.6 6572.5 6742.3 6760.2 6765.4 6830.2 6215.2 6465.8 6519.5 6520.0 6567.6 6482.0 6524.3 6527.7 6549.1 6571.6 6353.8 6382.0 6430.5 6437.7 6444.5 6582.0 6584.8 6591.3 6616.7 6632.8 6298.1 6422.0 6449.1 6453.6 6488.2 17:49:47 INFO - PID 32036 | 17:49:47 INFO - PID 32036 | [#5] yui.html Cycles:180 Average:28018.25 Median:16776.33 stddev:42836.88 (255.3%) stddev-sans-first:42908.85 17:49:47 INFO - PID 32036 | Values: 953.6 962.9 970.0 984.5 986.4 17987.8 18162.5 18234.0 18242.9 18259.9 17334.8 17410.3 17434.8 19609.9 19835.1 1048.5 1056.3 1060.0 1066.6 1068.8 1066.2 1071.8 1072.0 1072.8 1078.5 1081.4 1125.6 1129.1 1134.4 1135.5 1120.0 1121.0 1121.1 1122.3 1124.1 825.9 828.6 829.8 829.9 830.6 18868.6 21203.6 21239.3 21397.7 21404.7 23386.5 23529.2 24189.5 24190.4 24218.6 16429.8 16476.7 16508.1 16526.8 16534.3 3888.5 3896.2 3916.8 3925.1 3937.2 129139.0 140431.0 160528.0 167110.0 169217.0 16417.0 16426.7 16518.8 16738.7 16810.2 34963.0 35798.1 35804.8 35923.6 35927.3 9768.9 9947.2 9973.4 9978.6 9996.5 4540.5 4578.7 4605.8 4612.8 4620.3 6004.1 6081.8 6083.2 6087.7 6123.6 1171.7 1182.1 1198.1 1202.4 1208.0 636.5 640.8 649.7 650.4 663.7 11275.4 11385.9 11634.0 11696.9 11704.2 642.9 648.3 648.8 655.5 656.0 5982.5 6026.2 6153.7 6183.4 6196.7 156067.0 157403.0 158610.0 159361.2 160135.0 127903.4 130004.0 131034.3 132577.0 133292.0 114406.9 114613.0 115280.4 115751.4 116753.0 11200.4 11314.5 11522.8 11705.6 11812.5 58029.4 58838.4 59202.4 60081.4 60127.0 72255.6 74826.0 75202.0 75308.0 76571.0 16623.7 16755.1 16755.7 16796.9 16860.2 17927.0 18069.7 18114.6 18114.8 18156.6 14026.9 14227.7 14257.1 14322.3 14337.7 15174.8 15451.9 15506.7 15596.9 15622.4 15649.0 15741.4 15828.8 15920.5 15937.4 11275.3 11282.8 11611.6 11627.9 12117.6 12139.2 12184.8 12300.3 12622.2 12651.7 17:49:47 INFO - PID 32036 | -------- Summary: end -------- 17:49:47 INFO - PID 32036 | 17:49:48 INFO - TEST-INFO | 32036: exit 0 17:49:48 INFO - TEST-OK | dromaeo_css | took 1107985ms 17:49:48 INFO - TEST-START | kraken 17:49:48 INFO - Initialising browser for kraken test... 17:49:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39380/getInfo.html -profile /tmp/tmpOmr1IE/profile 17:49:48 INFO - TEST-INFO | started process 32402 (/builds/slave/test/build/application/firefox/firefox http://localhost:39380/getInfo.html) 17:49:53 INFO - TEST-INFO | 32402: exit 0 17:49:53 INFO - Browser initialized. 17:49:53 INFO - Running cycle 1/1 for kraken test... 17:49:53 INFO - Using env: {'DISPLAY': ':0', 17:49:53 INFO - 'HOME': '/home/cltbld', 17:49:53 INFO - 'JSGC_DISABLE_POISONING': '1', 17:49:53 INFO - 'LANG': 'en_US.UTF-8', 17:49:53 INFO - 'LANGUAGE': 'en_US:en', 17:49:53 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:49:53 INFO - 'LOGNAME': 'cltbld', 17:49:53 INFO - 'MAIL': '/var/mail/cltbld', 17:49:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:49:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:49:53 INFO - 'MOZ_CRASHREPORTER': '1', 17:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:53 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:49:53 INFO - 'MOZ_NO_REMOTE': '1', 17:49:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:49:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:53 INFO - 'NO_EM_RESTART': '1', 17:49:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:53 INFO - 'PWD': '/builds/slave/test', 17:49:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:49:53 INFO - 'RUST_BACKTRACE': 'full', 17:49:53 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:49:53 INFO - 'SHELL': '/bin/bash', 17:49:53 INFO - 'SHLVL': '1', 17:49:53 INFO - 'STYLO_FORCE_DISABLED': '1', 17:49:53 INFO - 'TERM': 'linux', 17:49:53 INFO - 'TMOUT': '86400', 17:49:53 INFO - 'USER': 'cltbld', 17:49:53 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509', 17:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:53 INFO - '_': '/tools/buildbot/bin/python'} 17:49:53 INFO - TEST-INFO | started process 32641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOmr1IE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:49:54 INFO - PID 32641 | 17:49:54 INFO - PID 32641 | (/builds/slave/test/build/application/firefox/firefox:32691): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:49:54 INFO - PID 32641 | 17:50:04 INFO - PID 32641 | RSS: Main: 145522688 17:50:04 INFO - PID 32641 | 17:50:07 INFO - PID 32641 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39380/tests/kraken/driver.html?testName=audio-beat-detection) 17:50:08 INFO - PID 32641 | RSS: Main: 152088576 17:50:08 INFO - PID 32641 | 17:50:10 INFO - PID 32641 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39380/tests/kraken/driver.html?testName=audio-dft) 17:50:11 INFO - PID 32641 | RSS: Main: 152215552 17:50:11 INFO - PID 32641 | 17:50:14 INFO - PID 32641 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39380/tests/kraken/driver.html?testName=audio-fft) 17:50:14 INFO - PID 32641 | RSS: Main: 148680704 17:50:14 INFO - PID 32641 | 17:50:16 INFO - PID 32641 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39380/tests/kraken/driver.html?testName=audio-oscillator) 17:50:17 INFO - PID 32641 | RSS: Main: 149770240 17:50:17 INFO - PID 32641 | 17:50:19 INFO - PID 32641 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39380/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:50:20 INFO - PID 32641 | RSS: Main: 149508096 17:50:20 INFO - PID 32641 | 17:50:23 INFO - PID 32641 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39380/tests/kraken/driver.html?testName=imaging-darkroom) 17:50:23 INFO - PID 32641 | RSS: Main: 149901312 17:50:23 INFO - PID 32641 | 17:50:27 INFO - PID 32641 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39380/tests/kraken/driver.html?testName=imaging-desaturate) 17:50:28 INFO - PID 32641 | RSS: Main: 150814720 17:50:28 INFO - PID 32641 | 17:50:31 INFO - PID 32641 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39380/tests/kraken/driver.html?testName=json-parse-financial) 17:50:31 INFO - PID 32641 | RSS: Main: 152522752 17:50:31 INFO - PID 32641 | 17:50:33 INFO - PID 32641 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39380/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:50:33 INFO - PID 32641 | RSS: Main: 152412160 17:50:33 INFO - PID 32641 | 17:50:35 INFO - PID 32641 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39380/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:50:35 INFO - PID 32641 | RSS: Main: 152137728 17:50:35 INFO - PID 32641 | 17:50:37 INFO - PID 32641 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39380/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:50:38 INFO - PID 32641 | RSS: Main: 148889600 17:50:38 INFO - PID 32641 | 17:50:40 INFO - PID 32641 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39380/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:50:41 INFO - PID 32641 | RSS: Main: 149164032 17:50:41 INFO - PID 32641 | 17:50:44 INFO - PID 32641 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39380/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:50:44 INFO - PID 32641 | RSS: Main: 149757952 17:50:44 INFO - PID 32641 | 17:50:46 INFO - PID 32641 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39380/tests/kraken/driver.html?testName=ai-astar) 17:50:46 INFO - PID 32641 | RSS: Main: 151285760 17:50:46 INFO - PID 32641 | 17:50:46 INFO - PID 32641 | __start_tp_report 17:50:46 INFO - PID 32641 | _x_x_mozilla_page_load 17:50:46 INFO - PID 32641 | _x_x_mozilla_page_load_details 17:50:46 INFO - PID 32641 | |i|pagename|runs| 17:50:46 INFO - PID 32641 | |0;ai-astar;106;105;105;105;105;110;106;106;109;106 17:50:46 INFO - PID 32641 | |1;audio-beat-detection;115;113;113;122;114;116;115;113;113;125 17:50:46 INFO - PID 32641 | |2;audio-dft;163;162;161;161;162;162;162;161;162;164 17:50:46 INFO - PID 32641 | |3;audio-fft;85;73;76;73;73;72;75;73;73;74 17:50:46 INFO - PID 32641 | |4;audio-oscillator;78;79;78;77;78;78;78;79;78;79 17:50:46 INFO - PID 32641 | |5;imaging-gaussian-blur;114;113;110;114;114;113;122;114;114;115 17:50:46 INFO - PID 32641 | |6;imaging-darkroom;150;151;151;149;152;152;149;152;152;149 17:50:46 INFO - PID 32641 | |7;imaging-desaturate;96;94;94;94;95;94;94;94;94;96 17:50:46 INFO - PID 32641 | |8;json-parse-financial;44;44;45;44;48;45;47;43;45;44 17:50:46 INFO - PID 32641 | |9;json-stringify-tinderbox;38;42;38;38;43;38;38;40;39;38 17:50:46 INFO - PID 32641 | |10;stanford-crypto-aes;71;68;73;69;70;68;70;68;71;68 17:50:46 INFO - PID 32641 | |11;stanford-crypto-ccm;111;101;105;103;110;106;102;102;110;102 17:50:46 INFO - PID 32641 | |12;stanford-crypto-pbkdf2;154;153;149;148;155;145;147;143;145;149 17:50:46 INFO - PID 32641 | |13;stanford-crypto-sha256-iterative;60;58;59;59;58;62;60;60;64;59 17:50:46 INFO - PID 32641 | __end_tp_report 17:50:46 INFO - PID 32641 | __start_cc_report 17:50:46 INFO - PID 32641 | _x_x_mozilla_cycle_collect,716 17:50:46 INFO - PID 32641 | __end_cc_report 17:50:46 INFO - PID 32641 | __startTimestamp1506991846703__endTimestamp 17:50:46 INFO - PID 32641 | 17:50:46 INFO - PID 32641 | ------- Summary: start ------- 17:50:46 INFO - PID 32641 | Number of tests: 14 17:50:46 INFO - PID 32641 | 17:50:46 INFO - PID 32641 | [#0] ai-astar Cycles:10 Average:106.30 Median:106.00 stddev:1.77 (1.7%) stddev-sans-first:1.87 17:50:46 INFO - PID 32641 | Values: 106.0 105.0 105.0 105.0 105.0 110.0 106.0 106.0 109.0 106.0 17:50:46 INFO - PID 32641 | 17:50:46 INFO - PID 32641 | [#1] audio-beat-detection Cycles:10 Average:115.90 Median:115.00 stddev:4.20 (3.7%) stddev-sans-first:4.44 17:50:46 INFO - PID 32641 | Values: 115.0 113.0 113.0 122.0 114.0 116.0 115.0 113.0 113.0 125.0 17:50:46 INFO - PID 32641 | 17:50:46 INFO - PID 32641 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 17:50:46 INFO - PID 32641 | Values: 163.0 162.0 161.0 161.0 162.0 162.0 162.0 161.0 162.0 164.0 17:50:46 INFO - PID 32641 | 17:50:46 INFO - PID 32641 | [#3] audio-fft Cycles:10 Average:74.70 Median:73.50 stddev:3.80 (5.2%) stddev-sans-first:1.24 17:50:46 INFO - PID 32641 | Values: 85.0 73.0 76.0 73.0 73.0 72.0 75.0 73.0 73.0 74.0 17:50:46 INFO - PID 32641 | 17:50:46 INFO - PID 32641 | [#4] audio-oscillator Cycles:10 Average:78.20 Median:78.00 stddev:0.63 (0.8%) stddev-sans-first:0.67 17:50:46 INFO - PID 32641 | Values: 78.0 79.0 78.0 77.0 78.0 78.0 78.0 79.0 78.0 79.0 17:50:46 INFO - PID 32641 | 17:50:46 INFO - PID 32641 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:3.02 (2.6%) stddev-sans-first:3.20 17:50:46 INFO - PID 32641 | Values: 114.0 113.0 110.0 114.0 114.0 113.0 122.0 114.0 114.0 115.0 17:50:46 INFO - PID 32641 | 17:50:46 INFO - PID 32641 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.50 stddev:1.34 (0.9%) stddev-sans-first:1.39 17:50:46 INFO - PID 32641 | Values: 150.0 151.0 151.0 149.0 152.0 152.0 149.0 152.0 152.0 149.0 17:50:46 INFO - PID 32641 | 17:50:46 INFO - PID 32641 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:0.85 (0.9%) stddev-sans-first:0.71 17:50:46 INFO - PID 32641 | Values: 96.0 94.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 96.0 17:50:46 INFO - PID 32641 | 17:50:46 INFO - PID 32641 | [#8] json-parse-financial Cycles:10 Average:44.90 Median:45.00 stddev:1.52 (3.4%) stddev-sans-first:1.58 17:50:46 INFO - PID 32641 | Values: 44.0 44.0 45.0 44.0 48.0 45.0 47.0 43.0 45.0 44.0 17:50:46 INFO - PID 32641 | 17:50:46 INFO - PID 32641 | [#9] json-stringify-tinderbox Cycles:10 Average:39.20 Median:38.50 stddev:1.87 (4.9%) stddev-sans-first:1.94 17:50:46 INFO - PID 32641 | Values: 38.0 42.0 38.0 38.0 43.0 38.0 38.0 40.0 39.0 38.0 17:50:46 INFO - PID 32641 | 17:50:46 INFO - PID 32641 | [#10] stanford-crypto-aes Cycles:10 Average:69.60 Median:70.00 stddev:1.71 (2.4%) stddev-sans-first:1.74 17:50:46 INFO - PID 32641 | Values: 71.0 68.0 73.0 69.0 70.0 68.0 70.0 68.0 71.0 68.0 17:50:46 INFO - PID 32641 | 17:50:46 INFO - PID 32641 | [#11] stanford-crypto-ccm Cycles:10 Average:105.20 Median:105.50 stddev:3.85 (3.7%) stddev-sans-first:3.47 17:50:46 INFO - PID 32641 | Values: 111.0 101.0 105.0 103.0 110.0 106.0 102.0 102.0 110.0 102.0 17:50:46 INFO - PID 32641 | 17:50:46 INFO - PID 32641 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.80 Median:149.00 stddev:4.08 (2.7%) stddev-sans-first:3.87 17:50:46 INFO - PID 32641 | Values: 154.0 153.0 149.0 148.0 155.0 145.0 147.0 143.0 145.0 149.0 17:50:46 INFO - PID 32641 | 17:50:46 INFO - PID 32641 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.90 Median:60.00 stddev:1.85 (3.1%) stddev-sans-first:1.96 17:50:46 INFO - PID 32641 | Values: 60.0 58.0 59.0 59.0 58.0 62.0 60.0 60.0 64.0 59.0 17:50:46 INFO - PID 32641 | -------- Summary: end -------- 17:50:46 INFO - PID 32641 | 17:50:47 INFO - PID 32641 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:50:47 INFO - TEST-INFO | 32641: exit 0 17:50:47 INFO - TEST-OK | kraken | took 58916ms 17:50:47 INFO - SUITE-END | took 1166s 17:50:47 INFO - Completed test suite (00:19:26) 17:50:47 INFO - javascript benchmark 17:50:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9139.205269020576, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3930.0567863712704, 3931.882043538694, 3937.0944682722993, 3950.0717331427127, 3966.1274519605695, 6222.5021998240145, 6227.813165605039, 6315.842103947398, 6355.332690067546, 6378.712957916893, 6234.283057448383, 6317.589356691812, 6321.462675672562, 6339.397757213069, 6350.460210882069, 5605.691686957216, 5688.63023903445, 5704.0, 5711.143328500717, 5730.36965933747, 5540.63985840921, 5684.971575142139, 5748.109043098327, 5764.884702305952, 5780.913286300709, 5608.6634801911605, 5715.9428405716035, 5734.483896449318, 5745.482906538411, 5789.565782566303, 5517.503424691797, 5597.580181486364, 5620.213170156181, 5649.745761440745, 5658.603897727161, 5587.357453892813, 5643.6049476536655, 5656.321241451011, 5663.915041274384, 5666.5183459406, 6153.323134455206, 6210.782622608187, 6232.563720539564, 6266.248050233956, 6343.0, 6701.195856497203, 6717.865642687118, 6743.865122697568, 6834.726610935557, 6868.828279293058, 6742.865142697167, 6818.624975626339, 6857.177138743333, 6871.828204294882, 6879.208890977551, 6272.247330320391, 6286.025666021774, 6360.872782544323, 6361.141245931786, 6443.0, 6950.652467376611, 6992.021117043618, 7034.050403195503, 7048.682809273595, 7049.7885063448175, 6624.668766561653, 6654.401103900672, 6702.865942681119, 6749.291324410964, 6773.051772751819, 6781.25406205317, 6819.24988251292, 6829.726810927507, 6908.861822763617, 6913.481488888354, 6680.96659516709, 6751.122354093936, 6767.323267673291, 6775.932240677629, 6788.728450862009, 6825.897611535831, 6839.658017099225, 6873.1064961554675, 6920.446364290845, 6928.3764461197725, 4957.702537847741, 4990.675606085593, 5013.649044566918, 5024.447310795809, 5086.974565127225, 4435.090806384748, 4474.0, 4516.435445569304, 4524.6832721709825, 4525.841595544141, 6334.809955701337, 6359.9364006360265, 6373.776917807854, 6374.330695277022, 6377.585456945284, 6758.222804377461, 6823.795286141324, 6856.5200435969, 6927.7228910843005, 6941.271166527543, 6131.84670383244, 6215.844603884849, 6260.029695397129, 6286.465650419766, 6315.652639104802, 5490.3411590609385, 5531.115021596525, 5537.363203231599, 5559.193916882029, 5564.527015203672, 7025.718971241093, 7041.3310735480045, 7136.6431678415875, 7144.142702875584, 7148.28517148281, 6736.191657001191, 6769.729210831511, 6772.513147728064, 6863.691133899087, 6895.069165662571, 7025.613591252326, 7110.715571377087, 7123.82190445243, 7136.357727804522, 7140.321669441395, 6710.6309152997055, 6747.966260168668, 6788.321167883172, 6817.318268173143, 6840.7263709453055, 6661.300563440769, 6781.220159681502, 6787.389134977876, 6792.524523283323, 6792.864142717217, 6654.600723956578, 6683.9639855822425, 6690.732370705117, 6697.966510167418, 6699.698513566804, 6518.0, 6561.770338038145, 6597.406233439014, 6685.331466853276, 6687.097241872285, 6359.332270111757, 6482.157319548429, 6557.704903279459, 6572.211334639683, 6583.868322633425, 6596.0, 6641.701123449359, 6644.269130395749, 6659.101021362248, 6679.76620818269, 6456.903146452901, 6461.386168314003, 6462.7091780870915, 6501.024846273097, 6537.378948999837], "value": 6232.781385802083, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [921.5115988526084, 954.8663187153804, 968.5447839515426, 1012.1851909213085, 1018.8981101889816, 44902.32646510305, 45633.771831140795, 45829.31256031154, 45852.0, 45861.31208031882, 43004.569954300445, 45422.318665220046, 46471.53528464714, 46557.0, 46699.06601867961, 8447.450915690475, 8625.568721563928, 8643.178898004711, 8651.13488651133, 8681.913180868205, 8493.872591911126, 8621.913780862205, 8622.698205562807, 8645.870311945326, 8648.005479369858, 8626.396152269344, 8664.826703465927, 8666.176713212235, 8671.0, 8682.522461264627, 8623.827523449527, 8663.133686631287, 8672.04607493172, 8672.696455624055, 8676.392652514327, 8444.788880277982, 8470.32237421011, 8491.23578877904, 8508.744737657818, 8525.829483410296, 41545.0, 41835.372469412985, 42294.0, 42318.36522452166, 42326.576734232876, 3824.9043773905873, 3854.8458061677497, 3858.6334298241622, 3865.8016015035428, 3869.342211823997, 34423.311533769185, 34525.654743452746, 34548.13629659254, 34570.827145864365, 34666.13334666628, 5583.3858275589655, 5589.664620122806, 5604.355499117612, 5631.71841407928, 5736.082226843685, 229296.0, 229708.0, 231159.0, 231608.84195578913, 231791.0, 56847.43152568422, 57732.71133644305, 58066.419335806946, 58113.4188658108, 58292.251232463095, 60157.39842601606, 60359.0, 60577.69711151416, 60620.39379606147, 60658.39341606616, 16677.24952377146, 16864.156792160342, 16874.15629218534, 16881.071541065114, 16894.408695695838, 13374.933125334506, 13500.392482338319, 13514.459421623025, 13529.52646657382, 13547.119437236548, 16265.837341626433, 16273.837261627232, 16338.264778085015, 16339.509814705578, 16365.427210047592, 6138.693065346715, 6229.844253893689, 6320.525960552977, 6376.107344971708, 6471.2234531856475, 1072.4905669806778, 1095.4084794211037, 1098.9945050274857, 1113.2819331531116, 1117.2179474367974, 26132.216033519024, 26264.343391414986, 26366.73633263643, 26567.0, 26644.0, 1196.5094311332311, 1214.8845859643498, 1219.676785651803, 1225.7058306006672, 1247.731737676404, 14018.929905350407, 14072.707824113539, 14083.155010699391, 14327.35526901292, 14387.064840785315, 311199.0, 314301.0, 316424.0, 316659.0, 316727.0, 59432.70283648554, 59656.70171649114, 59830.0, 60090.39909600936, 60269.0, 1531.716632422983, 1543.1589783567983, 1558.6103474131467, 1571.080917663157, 1582.1772678207267, 26070.73929260683, 26366.209013729618, 26445.867770661025, 26512.0, 26601.0, 42825.785871070446, 42838.78580607077, 42930.78534607432, 42951.785241073594, 42970.14059718726, 239527.0, 241624.0, 242289.0, 243575.0, 244250.0, 38589.61410385973, 42211.73364799061, 43006.35490467708, 43182.13635727205, 43302.566974331115, 52185.217221740946, 52868.0, 52974.0, 53192.20211696905, 53405.19892201698, 38642.42036369513, 38802.41796373113, 38949.0, 39192.80403598078, 39425.0, 38176.61823381731, 38337.4249386265, 38383.80808095942, 38417.42373864338, 38470.42294365643, 44854.0, 45006.54993450024, 45054.098918022115, 45111.32333015073, 45364.092718146116, 37238.62761372352, 37310.440343395414, 37337.0, 37360.25279494341, 37574.43638345482, 27719.58420623652, 27958.0, 28278.57582136311, 28286.434271314047, 28614.0], "value": 19652.469342552293, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.5451569420371, 635.5378856031806, 636.2837145368972, 636.5261368095217, 644.5672191528546, 23700.5259894802, 24139.275821725332, 24577.38556536085, 24583.877080614573, 24611.26166215012, 25758.484830303383, 26115.0, 26166.869165654192, 26172.0, 26178.0, 6258.874822503547, 6487.12423822785, 6729.293424190463, 6759.898601520957, 6769.898451523231, 6502.869942601145, 6578.967105164467, 6584.506162037842, 6588.505862060365, 6589.275179730226, 6453.096566480696, 6524.412802847743, 6708.161479815023, 6713.160854893138, 6714.0, 6670.599764014175, 6713.194416669982, 6714.227863795652, 6715.395614394728, 6719.63042032688, 5879.470847623692, 6134.631922084689, 6136.355682653347, 6150.692465376714, 6288.465480434169, 30829.0, 31173.0, 31267.687323126705, 31282.37435251305, 31347.0, 2312.491251924574, 2320.2923108451914, 2326.8720220387872, 2326.8836558172025, 2333.988330058356, 20416.795832041636, 20997.68503472449, 21268.680969785466, 21332.893335533223, 21595.67606485904, 2557.654716613252, 2610.2691246451022, 2610.334364736999, 2665.8800353983925, 2678.665166854143, 144575.27712361372, 151293.0, 169907.0, 175661.0, 175822.0, 16155.838441615668, 16519.174041297887, 16877.746833797504, 16933.661326773396, 17068.573285667957, 27509.587356189673, 27630.72369276322, 27635.723642763718, 27668.58497122545, 27704.584431233547, 10775.730606734738, 11080.0, 11110.666679999613, 11120.38837863909, 11220.719482013015, 9958.452285124387, 10015.098641122187, 10016.54925528353, 10023.5966964625, 10119.443430611387, 10028.899711002796, 10083.243756718275, 10381.11760500366, 10459.11097556701, 10486.213533984828, 2854.942901142007, 2856.1431570529176, 2878.942421151565, 2883.68279489256, 2915.5772412999995, 1047.3454091193005, 1059.8410238464292, 1063.9893601064045, 1079.5196137718797, 1080.1304949515559, 21323.36029919105, 21575.892120539298, 21731.67402488964, 21931.342059738232, 22149.335519934426, 1127.5997021057406, 1133.3086817041599, 1142.959996400122, 1143.2854465958776, 1152.3661985907718, 11893.940530297294, 11896.524139034342, 11987.88012119885, 12094.516219351128, 12171.148019638717, 585360.0, 598645.0, 609537.0, 616301.0, 616689.0, 134697.0, 138172.0, 138923.0, 139533.3023334877, 141371.0, 1241.1126044877956, 1249.8875101241115, 1267.3789842976876, 1276.125853790138, 1279.6097190356845, 19130.904075636376, 19224.231030759172, 19276.61446771085, 19499.0, 19991.20035198634, 66068.0, 66319.66840165768, 66429.33570664232, 66561.33438665551, 66890.33109668842, 78245.0, 79319.60340198262, 80962.0, 82577.0, 83936.16063839283, 15968.441104561285, 16252.187390630657, 16331.0, 16376.508704738877, 16378.0, 24397.39006524851, 24558.140465083638, 24653.876730616234, 24829.0, 24871.751282486945, 20008.0, 20273.374626887795, 20279.59440811205, 20344.59310813805, 20573.89713051425, 17503.124843758014, 17644.0, 17959.461216163538, 18192.090395479907, 18279.752565780695, 20519.38441846747, 20558.486037849172, 20740.896295518425, 20893.0, 20904.0, 15808.288627011581, 15976.920115399349, 16001.19994000272, 16015.119168445848, 16071.0, 19638.90180549088, 20021.0, 20225.79774202239, 20243.696344554548, 20372.47206459551], "value": 13090.605432870763, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1394.9023568350217, 1467.8018467506884, 1471.5585324402678, 1474.6829431672195, 1488.5683151885953, 17075.48773536793, 17687.73468397975, 17695.64608707827, 17726.29094836205, 17728.46814595564, 17382.739258911093, 17444.215010324533, 17623.206955686994, 17624.295028198856, 17641.0, 2929.370185410142, 2929.6923822998597, 2992.0425463851575, 3000.9249768755735, 3006.8045577037533, 2902.2309088091674, 2905.520589102806, 2906.593076969226, 2906.607607972918, 2910.4179164167144, 2850.686424493304, 2931.8387488688113, 2936.324645331575, 2944.838033908134, 2974.5240761478167, 2862.2844288927768, 2913.2279945814375, 2919.6350456192977, 2920.1823489422995, 2921.1674672718173, 2878.7553057990094, 2904.0852131578486, 2922.473954688155, 3023.6220472440946, 3024.077656314823, 16823.915880420518, 16938.576535586584, 16960.74558881618, 16965.15174241283, 16974.066426346548, 8543.95728021362, 8791.164839340316, 8859.778505537348, 8859.955700221522, 8862.980757212874, 5666.291713535808, 5799.942000580025, 5833.620814647034, 5840.532757379442, 5924.7333869975955, 2205.106931692667, 2224.0325458425473, 2239.585676649825, 2267.263139479676, 2271.2845453682203, 30658.84670576655, 31462.0, 31508.054758357055, 31521.52717709213, 31523.684763152305, 7830.960845195851, 7893.329067029252, 7932.365410767125, 7983.84032319362, 8188.7952801180445, 19562.510937226398, 20327.796722032886, 20411.183552657727, 20439.080241389172, 23784.643230351558, 8521.531315777567, 8715.128487151362, 8719.782005449788, 8721.781955451164, 8755.993060797962, 7815.29662330393, 7899.486533375312, 8050.516968981763, 8084.39367047462, 8095.0, 5746.885062298814, 5976.701164941735, 5977.641341519436, 6026.216591843032, 6100.633961962208, 1707.4962885948676, 1717.2358300556382, 1731.7315816048533, 1752.5005373468755, 1758.9296428142732, 984.7439665686973, 997.9650712225038, 1007.8135544924213, 1019.7705516258783, 1023.2376879225025, 8254.711085111992, 8385.0, 8429.367797415096, 8434.0, 8525.616347264388, 807.5275963561265, 811.5901469757735, 812.3298278919915, 821.5604651511412, 827.437342607033, 5050.545450909436, 5165.535101840777, 5413.404525502192, 5895.882082358329, 5973.790917317873, 23035.193768218032, 23125.306240812803, 23409.7659023411, 23419.414514637272, 24213.63679544808, 22783.31650050501, 22989.0, 23396.0, 23400.297991059953, 23404.297871063554, 11682.007029402426, 11767.293962362115, 11936.522539098512, 12082.335471548973, 12084.154109212272, 8601.483910965362, 8888.73333799987, 9002.414843035182, 9028.503432311287, 9044.186023257938, 20354.592908141458, 20817.167313307298, 20893.477663058544, 20948.895255524236, 21270.893645531673, 19825.0, 21146.788532114482, 21603.35189944304, 21718.23986160477, 21903.45241368915, 12761.106722529334, 12971.41628626733, 12974.091813573337, 12979.480820767441, 12980.545680901123, 15396.84603153954, 15471.458498952483, 15513.45702900393, 15885.126318052618, 15908.363665453715, 12755.48978040868, 13051.28217948022, 13073.0, 13074.411651475897, 13109.278989655279, 12301.815472767737, 12425.130240883413, 12445.937770311091, 12683.365831708563, 12990.285534295705, 10055.597776089167, 10073.748156296151, 10162.237832162766, 10194.286399951932, 10218.437985910548, 8018.679252829821, 8020.478668886503, 8091.919080809352, 8104.149064348158, 8109.675612975415, 8101.432899697201, 8231.34149268069, 8249.257566819015, 8258.215469530385, 8274.958625206835], "value": 7350.07027337707, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.4744245524297, 571.9399463056379, 582.4641329976423, 586.1617886422417, 586.4077281945234, 6229.563930524865, 6234.220722409699, 6274.341194174609, 6297.54395785644, 6306.7161977711, 6157.599756015867, 6157.907631385533, 6229.37706229378, 6245.033609035717, 6263.655498947556, 5182.8704282393055, 5184.481551844804, 5186.0665080285535, 5195.740212989354, 5203.817866374678, 4882.365292511969, 5015.799368025275, 5113.360829896263, 5124.385073791151, 5142.640015198919, 4938.876528086791, 5020.698758074527, 5024.598032157437, 5026.120428924942, 5043.0, 4985.326980857574, 4999.4000719913665, 5003.849884503471, 5014.52362025607, 5029.05800106936, 4446.42152036029, 4484.955150448486, 4518.254488009475, 4546.318052292183, 4579.404677391951, 5997.850053748648, 6040.516758659297, 6047.5766696331275, 6082.452579267843, 6089.950183128214, 5802.0, 5815.767369305223, 5818.679972601505, 5845.941540584625, 5915.1718759373725, 6559.245686746038, 6577.309382514863, 6578.210614726264, 6607.438367738748, 6633.810842421989, 5038.722870242135, 5073.543381095719, 5084.034033533617, 5117.923231151536, 5130.153524668425, 6666.733330666768, 6680.432163266129, 6793.592384456949, 6811.761588344384, 6873.48448866337, 5205.401378841406, 5213.478652134756, 5236.0, 5240.213967904769, 5244.344456942882, 5273.2617433559335, 5290.761915713802, 5290.81482148123, 5309.177077552986, 5372.274742909657, 5882.470577648032, 5884.47039766423, 5891.558133140032, 5903.970480147572, 5916.881662366729, 6466.6766661666725, 6582.210134783857, 6589.80230593083, 6635.004749287646, 6651.933480665131, 1790.51656052865, 1792.7131658934509, 1792.8027916929127, 1811.3026484803445, 1822.5443639090226, 1283.6393422971494, 1314.1655049043734, 1315.2700251360586, 1324.5758073344396, 1340.4169186403944, 6008.759649613967, 6018.729157187937, 6037.335893051761, 6042.244719410074, 6088.112685067643, 6478.935210647927, 6616.536842420985, 6663.500237482208, 6696.531242812956, 6696.564723293068, 6030.728617212236, 6134.355892631299, 6166.445019948136, 6204.153424876606, 6211.534134939898, 3516.7889926604485, 3535.2575959048886, 3554.360215161244, 3557.5375201223674, 3560.5549306336707, 6906.447484201251, 6934.306569343025, 6949.722011119498, 6953.443724502028, 6956.234814170437, 6798.456123510107, 6799.5920244785475, 6885.552439091443, 6915.78973679604, 6932.688029038705, 6803.265167382286, 6816.863662726718, 6830.59016459014, 6875.5530890491955, 6909.412699920563, 6579.868402631825, 6595.207755540488, 6625.337466253336, 6716.0, 6732.259451460238, 6532.41208291256, 6559.4752419805345, 6600.2409722882485, 6684.197896252481, 6716.83207919806, 6782.8643427132165, 6813.693383797642, 6824.283450237654, 6880.724771009303, 6934.7226110955, 5211.791528338824, 5236.6072544560075, 5260.421353651172, 5262.789488420573, 5286.550643195218, 6572.474202063728, 6742.292059333896, 6760.18877734675, 6765.42493888025, 6830.21452532965, 6215.160953271251, 6465.77369792055, 6519.4784417245555, 6520.0, 6567.638779867153, 6482.0229829900445, 6524.347565243438, 6527.67361631907, 6549.100760779321, 6571.638559879252, 6353.841153971188, 6382.0, 6430.549861509649, 6437.742490300336, 6444.548881578245, 6581.967090164519, 6584.8024559263295, 6591.34086591337, 6616.735330586916, 6632.767853125118, 6298.149749783721, 6422.0, 6449.064885591657, 6453.612473318259, 6488.183308673579], "value": 5166.955565487001, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [953.5661274120276, 962.8555716642505, 970.0, 984.4634674102614, 986.358866736621, 17987.820121798777, 18162.455126346198, 18234.0, 18242.908785456053, 18259.90870045651, 17334.826651733478, 17410.30358785647, 17434.82565174348, 19609.901950490228, 19835.107420166092, 1048.491481631408, 1056.2606175677017, 1059.978800423991, 1066.6053560182743, 1068.834330678746, 1066.2003497376968, 1071.817790975532, 1072.029813019215, 1072.7639919217759, 1078.5308390850005, 1081.3890152064098, 1125.5891599566141, 1129.0967226219034, 1134.4384529657832, 1135.534430883338, 1119.9608013719521, 1120.9943950280278, 1121.1367247219596, 1122.2593088561591, 1124.0670243697753, 825.8637324841394, 828.647824674517, 829.8091438969011, 829.9419040667156, 830.5847076461769, 18868.62262754751, 21203.5759284815, 21239.25662601817, 21397.67903481449, 21404.678929816066, 23386.532269354517, 23529.17647882316, 24189.516209675883, 24190.395240118964, 24218.63672044921, 16429.753553696704, 16476.67046659072, 16508.092054936973, 16526.83473165265, 16534.255958481896, 3888.475055867478, 3896.2012787378803, 3916.843326266946, 3925.0776067624083, 3937.1928754605237, 129139.0, 140431.0, 160528.0, 167110.0, 169217.0, 16417.0, 16426.671466570602, 16518.75221871673, 16738.665226695397, 16810.243539040774, 34963.0, 35798.105047374025, 35804.82097589495, 35923.64076359255, 35927.281454370765, 9768.90231097694, 9947.154491868128, 9973.351732137387, 9978.600855965826, 9996.450195239331, 4540.545945405433, 4578.725276483355, 4605.815767369268, 4612.7924243409125, 4620.2607582786595, 6004.099385092271, 6081.756729730761, 6083.209182806207, 6087.726052327655, 6123.6019658722935, 1171.701216189866, 1182.1075088308273, 1198.0774803401332, 1202.3507306054807, 1208.0094322655514, 636.4717284653726, 640.7501074580917, 649.7076315657973, 650.408128602969, 663.6747993483159, 11275.436228188557, 11385.943070284762, 11634.011109055826, 11696.941515292368, 11704.180707350573, 642.8746394453037, 648.2998361769278, 648.8248172993266, 655.5116438253436, 655.9930506672331, 5982.49148822355, 6026.156338112668, 6153.661548614779, 6183.3816618337805, 6196.721147548371, 156067.0, 157403.0, 158610.0, 159361.2031939833, 160135.0, 127903.36048319699, 130004.0, 131034.34482827525, 132577.0, 133292.0, 114406.85593143963, 114613.0, 115280.42359788316, 115751.42124289325, 116753.0, 11200.38397888124, 11314.490847912028, 11522.827157592475, 11705.590304339306, 11812.527498900292, 58029.4197058024, 58838.41161588329, 59202.40797591969, 60081.399186007584, 60127.0, 72255.63872180606, 74826.0, 75202.0, 75308.0, 76571.0, 16623.66752664916, 16755.078470684228, 16755.74866376981, 16796.916015420335, 16860.241289141773, 17927.0, 18069.728954065962, 18114.637707246045, 18114.81885181184, 18156.636867262845, 14026.859731402556, 14227.715445691236, 14257.144571325754, 14322.283885805877, 14337.713245735236, 15174.848251517344, 15451.922740386675, 15506.689866202387, 15596.922015390304, 15622.375104995674, 15648.982816116915, 15741.370345186064, 15828.762568561251, 15920.52238432849, 15937.362505500114, 11275.267107637977, 11282.830757538479, 11611.593594224161, 11627.941860290644, 12117.575884843987, 12139.150259481752, 12184.817227741769, 12300.323482208565, 12622.179558328678, 12651.746965060463], "value": 9568.354609473801, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1364.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 105.0, 105.0, 105.0, 110.0, 106.0, 106.0, 109.0, 106.0], "value": 106.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 113.0, 122.0, 114.0, 116.0, 115.0, 113.0, 113.0, 125.0], "value": 115.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 161.0, 162.0, 162.0, 162.0, 161.0, 162.0, 164.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 73.0, 76.0, 73.0, 73.0, 72.0, 75.0, 73.0, 73.0, 74.0], "value": 74.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 77.0, 78.0, 78.0, 78.0, 79.0, 78.0, 79.0], "value": 78.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 110.0, 114.0, 114.0, 113.0, 122.0, 114.0, 114.0, 115.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 151.0, 149.0, 152.0, 152.0, 149.0, 152.0, 152.0, 149.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 96.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 44.0, 45.0, 44.0, 48.0, 45.0, 47.0, 43.0, 45.0, 44.0], "value": 44.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 42.0, 38.0, 38.0, 43.0, 38.0, 38.0, 40.0, 39.0, 38.0], "value": 39.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 73.0, 69.0, 70.0, 68.0, 70.0, 68.0, 71.0, 68.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 101.0, 105.0, 103.0, 110.0, 106.0, 102.0, 102.0, 110.0, 102.0], "value": 105.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 153.0, 149.0, 148.0, 155.0, 145.0, 147.0, 143.0, 145.0, 149.0], "value": 148.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 59.0, 59.0, 58.0, 62.0, 60.0, 60.0, 64.0, 59.0], "value": 59.9, "unit": "score"}]}]} 17:50:47 INFO - Return code: 0 17:50:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:50:47 INFO - # TBPL SUCCESS # 17:50:47 INFO - Running post-action listener: _package_coverage_data 17:50:47 INFO - Running post-action listener: _resource_record_post_action 17:50:47 INFO - [mozharness: 2017-10-03 00:50:47.491579Z] Finished run-tests step (success) 17:50:47 INFO - Running post-run listener: _resource_record_post_run 17:50:47 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 12288; Write bytes: 331550720; Read time: 376; Write time: 192036 17:50:47 INFO - TinderboxPrint: CPU usage
13.1% 17:50:47 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 376 17:50:47 INFO - TinderboxPrint: I/O write bytes / time
331,550,720 / 192,036 17:50:47 INFO - TinderboxPrint: CPU idle
8,212.8 (86.9%) 17:50:47 INFO - TinderboxPrint: CPU user
1,185.4 (12.5%) 17:50:47 INFO - TinderboxPrint: Swap in / out
0 / 0 17:50:47 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13344768; Read time: 0; Write time: 3712 17:50:47 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:50:47 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 8192; Write bytes: 317652992; Read time: 360; Write time: 188184 17:50:48 INFO - Running post-run listener: _upload_blobber_files 17:50:48 INFO - Blob upload gear active. 17:50:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:50:48 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 17:50:48 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'] 17:50:48 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 17:50:48 INFO - (blobuploader) - INFO - Open directory for files ... 17:50:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:50:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:50:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:50:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:50:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:50:49 INFO - (blobuploader) - INFO - Done attempting. 17:50:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 17:50:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:50:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:50:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 17:50:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:50:50 INFO - (blobuploader) - INFO - Done attempting. 17:50:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 17:50:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:50:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:50:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 17:50:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:50:51 INFO - (blobuploader) - INFO - Done attempting. 17:50:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:50:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:50:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:50:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:50:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:50:58 INFO - (blobuploader) - INFO - Done attempting. 17:50:58 INFO - (blobuploader) - INFO - Iteration through files over. 17:50:58 INFO - Return code: 0 17:50:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:50:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:50:58 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f2a583ba2dfa6aff7cd155103d27c69a2a1fb8f645d59c61488f860a95f7a9dd8d12cf7366462aacae19293604f28c4bad793212fa2d569e9916a949eb94912", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1612d8e6d8607f4b2bb30dda43271780c5a20193178c56070597f1abec31af2111bc306bd2eb4a883b7fc5d1549940e2528139cc9bb22e054d79ebe6e405540e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/769f3127d0225d1d34bdb11d863136aa121eb72abf96b1d51b64f2623305b82fcff841eabb55835f2665d8bbd2c3777f301e20eda360da1e54dcc6e9aae262f4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5130286eae3c13cc508814dde427b53e185775948faa03a9925390c7f36b792000eec677194705d39470995983517259db9c9734a1010dc5ce6fdfa2915c8bbe"} 17:50:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:50:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:50:58 INFO - Contents: 17:50:58 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f2a583ba2dfa6aff7cd155103d27c69a2a1fb8f645d59c61488f860a95f7a9dd8d12cf7366462aacae19293604f28c4bad793212fa2d569e9916a949eb94912", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1612d8e6d8607f4b2bb30dda43271780c5a20193178c56070597f1abec31af2111bc306bd2eb4a883b7fc5d1549940e2528139cc9bb22e054d79ebe6e405540e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/769f3127d0225d1d34bdb11d863136aa121eb72abf96b1d51b64f2623305b82fcff841eabb55835f2665d8bbd2c3777f301e20eda360da1e54dcc6e9aae262f4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5130286eae3c13cc508814dde427b53e185775948faa03a9925390c7f36b792000eec677194705d39470995983517259db9c9734a1010dc5ce6fdfa2915c8bbe"} 17:50:58 INFO - Running post-run listener: copy_logs_to_upload_dir 17:50:58 INFO - Copying logs to upload dir... 17:50:58 INFO - mkdir: /builds/slave/test/build/upload/logs 17:50:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.042229 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-10-02 17:50:58.217746) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 17:50:58.223925) ========= 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=00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509 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/4f2a583ba2dfa6aff7cd155103d27c69a2a1fb8f645d59c61488f860a95f7a9dd8d12cf7366462aacae19293604f28c4bad793212fa2d569e9916a949eb94912", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1612d8e6d8607f4b2bb30dda43271780c5a20193178c56070597f1abec31af2111bc306bd2eb4a883b7fc5d1549940e2528139cc9bb22e054d79ebe6e405540e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/769f3127d0225d1d34bdb11d863136aa121eb72abf96b1d51b64f2623305b82fcff841eabb55835f2665d8bbd2c3777f301e20eda360da1e54dcc6e9aae262f4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5130286eae3c13cc508814dde427b53e185775948faa03a9925390c7f36b792000eec677194705d39470995983517259db9c9734a1010dc5ce6fdfa2915c8bbe"} build_url:https://queue.taskcluster.net/v1/task/O8PaNEsoTpCKDFDDGb4FLA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011430 build_url: 'https://queue.taskcluster.net/v1/task/O8PaNEsoTpCKDFDDGb4FLA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f2a583ba2dfa6aff7cd155103d27c69a2a1fb8f645d59c61488f860a95f7a9dd8d12cf7366462aacae19293604f28c4bad793212fa2d569e9916a949eb94912", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1612d8e6d8607f4b2bb30dda43271780c5a20193178c56070597f1abec31af2111bc306bd2eb4a883b7fc5d1549940e2528139cc9bb22e054d79ebe6e405540e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/769f3127d0225d1d34bdb11d863136aa121eb72abf96b1d51b64f2623305b82fcff841eabb55835f2665d8bbd2c3777f301e20eda360da1e54dcc6e9aae262f4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5130286eae3c13cc508814dde427b53e185775948faa03a9925390c7f36b792000eec677194705d39470995983517259db9c9734a1010dc5ce6fdfa2915c8bbe"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 17:50:58.252291) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 17:50:58.256663) ========= 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=00204705a9daa57ed339a427000001b9-1506989696.253977-1207151509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004645 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 17:50:58.339529) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 17:50:58.339858) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 17:50:58.340144) ========= ========= Total master_lag: 0.21 =========