builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-055 starttime: 1506293010.98 results: success (0) revision: b44e80e0590e6eed86a1902365424673c8c2eaec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:30.983572) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:30.984087) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:30.984365) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:31.099947) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:31.100211) ========= 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=bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-24 15:43:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 46.2M=0s 2017-09-24 15:43:31 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119637 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:31.244721) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:31.245087) ========= 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=bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021184 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:31.295928) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:31.296337) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b44e80e0590e6eed86a1902365424673c8c2eaec --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 b44e80e0590e6eed86a1902365424673c8c2eaec --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=bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-24 15:43:31,380 truncating revision to first 12 chars 2017-09-24 15:43:31,381 Setting DEBUG logging. 2017-09-24 15:43:31,381 attempt 1/10 2017-09-24 15:43:31,381 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b44e80e0590e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-24 15:43:31,630 unpacking tar archive at: mozilla-central-b44e80e0590e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.593358 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:31.907507) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:31.907831) ========= script_repo_revision: b44e80e0590e6eed86a1902365424673c8c2eaec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:31.908282) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:31.908943) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:31.928531) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-24 15:43:31.928826) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:43:32 INFO - MultiFileLogger online at 20170924 15:43:32 in /builds/slave/test 15:43:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:43:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:43:32 INFO - {'append_to_log': False, 15:43:32 INFO - 'base_work_dir': '/builds/slave/test', 15:43:32 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:43:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:43:32 INFO - 'branch': 'Firefox-Non-PGO', 15:43:32 INFO - 'buildbot_json_path': 'buildprops.json', 15:43:32 INFO - 'code_coverage': False, 15:43:32 INFO - 'config_files': ('talos/linux_config.py',), 15:43:32 INFO - 'default_actions': ('clobber', 15:43:32 INFO - 'read-buildbot-config', 15:43:32 INFO - 'download-and-extract', 15:43:32 INFO - 'populate-webroot', 15:43:32 INFO - 'create-virtualenv', 15:43:32 INFO - 'install', 15:43:32 INFO - 'setup-mitmproxy', 15:43:32 INFO - 'run-tests'), 15:43:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:43:32 INFO - 'disable_ccov_upload': False, 15:43:32 INFO - 'disable_stylo': False, 15:43:32 INFO - 'download_minidump_stackwalk': True, 15:43:32 INFO - 'download_symbols': 'ondemand', 15:43:32 INFO - 'enable_stylo': False, 15:43:32 INFO - 'enable_webrender': False, 15:43:32 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:43:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:43:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:43:32 INFO - 'gecko_profile': False, 15:43:32 INFO - 'gecko_profile_interval': 0, 15:43:32 INFO - 'installer_path': 'installer.exe', 15:43:32 INFO - 'log_level': 'info', 15:43:32 INFO - 'log_name': 'talos', 15:43:32 INFO - 'log_to_console': True, 15:43:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:43:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:43:32 INFO - 'opt_config_files': (), 15:43:32 INFO - 'pip_index': False, 15:43:32 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 15:43:32 INFO - 'system_bits': '32', 15:43:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:43:32 INFO - 'title': 'talos-linux64-ix-055', 15:43:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:43:32 INFO - 'use_talos_json': True, 15:43:32 INFO - 'verify': 'False', 15:43:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:43:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:43:32 INFO - 'work_dir': 'build'} 15:43:32 INFO - [mozharness: 2017-09-24 22:43:32.155556Z] Running clobber step. 15:43:32 INFO - Running pre-action listener: _resource_record_pre_action 15:43:32 INFO - Running main action method: clobber 15:43:32 INFO - rmtree: /builds/slave/test/build 15:43:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:43:33 INFO - Running post-action listener: _resource_record_post_action 15:43:33 INFO - [mozharness: 2017-09-24 22:43:33.169020Z] Finished clobber step (success) 15:43:33 INFO - [mozharness: 2017-09-24 22:43:33.169117Z] Running read-buildbot-config step. 15:43:33 INFO - Running pre-action listener: _resource_record_pre_action 15:43:33 INFO - Running main action method: read_buildbot_config 15:43:33 INFO - Using buildbot properties: 15:43:33 INFO - { 15:43:33 INFO - "project": "", 15:43:33 INFO - "product": "firefox", 15:43:33 INFO - "who": "archaeopteryx@coole-files.de", 15:43:33 INFO - "installer_path": "public/build/target.tar.bz2", 15:43:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 15:43:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:43:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 15:43:33 INFO - "stage_platform": "linux64", 15:43:33 INFO - "basedir": "/builds/slave/test", 15:43:33 INFO - "buildnumber": 37, 15:43:33 INFO - "platform": "ubuntu64_hw", 15:43:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:43:33 INFO - "slavebuilddir": "test", 15:43:33 INFO - "taskId": "HLNcMQh9RlyW-13pNZ7AeQ", 15:43:33 INFO - "branch": "mozilla-central", 15:43:33 INFO - "script_repo_revision": "production", 15:43:33 INFO - "revision": "b44e80e0590e6eed86a1902365424673c8c2eaec", 15:43:33 INFO - "slavename": "talos-linux64-ix-055", 15:43:33 INFO - "repo_path": "mozilla-central" 15:43:33 INFO - } 15:43:33 INFO - Finding installer, test and symbols from parent task. 15:43:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HLNcMQh9RlyW-13pNZ7AeQ'}, attempt #1 15:43:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HLNcMQh9RlyW-13pNZ7AeQ'}, attempt #1 15:43:34 INFO - Task dependencies: B7iTL-CwQoyRUaZIwcocAA 15:43:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA'}, attempt #1 15:43:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.tar.bz2 15:43:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.test_packages.json 15:43:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.crashreporter-symbols.zip 15:43:34 INFO - Running post-action listener: _resource_record_post_action 15:43:34 INFO - [mozharness: 2017-09-24 22:43:34.494079Z] Finished read-buildbot-config step (success) 15:43:34 INFO - [mozharness: 2017-09-24 22:43:34.494295Z] Running download-and-extract step. 15:43:34 INFO - Running pre-action listener: _resource_record_pre_action 15:43:34 INFO - Running main action method: download_and_extract 15:43:34 INFO - mkdir: /builds/slave/test/build/tests 15:43:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:34 INFO - trying https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.test_packages.json 15:43:34 INFO - Downloading https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:43:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:43:35 INFO - Downloaded 989 bytes. 15:43:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:43:35 INFO - Using the following test package requirements: 15:43:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:43:35 INFO - u'common': [u'target.common.tests.zip'], 15:43:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:43:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:43:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:43:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:43:35 INFO - u'mozbase': [u'target.common.tests.zip'], 15:43:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:43:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:43:35 INFO - u'web-platform': [u'target.common.tests.zip', 15:43:35 INFO - u'target.web-platform.tests.tar.gz'], 15:43:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:43:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:43:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.common.tests.zip 15:43:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:43:35 INFO - Fetch https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.common.tests.zip into memory 15:43:38 INFO - Content-Length response header: 54943940 15:43:38 INFO - Bytes received: 54943940 15:43:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.talos.tests.zip 15:43:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:43:49 INFO - Fetch https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.talos.tests.zip into memory 15:43:50 INFO - Content-Length response header: 14513823 15:43:50 INFO - Bytes received: 14513823 15:43: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')]} 15:43:50 INFO - trying https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.tar.bz2 15:43:50 INFO - Downloading https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:43:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:43:55 INFO - Downloaded 61537979 bytes. 15:43:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.tar.bz2 15:43:55 INFO - mkdir: /builds/slave/test/properties 15:43:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:43:55 INFO - Writing to file /builds/slave/test/properties/build_url 15:43:55 INFO - Contents: 15:43:55 INFO - build_url:https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.tar.bz2 15:43:55 INFO - Running post-action listener: _resource_record_post_action 15:43:55 INFO - Running post-action listener: find_tests_for_verification 15:43:55 INFO - Running post-action listener: set_extra_try_arguments 15:43:55 INFO - [mozharness: 2017-09-24 22:43:55.132424Z] Finished download-and-extract step (success) 15:43:55 INFO - [mozharness: 2017-09-24 22:43:55.132651Z] Running populate-webroot step. 15:43:55 INFO - Running pre-action listener: _resource_record_pre_action 15:43:55 INFO - Running main action method: populate_webroot 15:43:55 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:43:55 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['tresize', 15:43:55 INFO - 'tcanvasmark']}, 15:43:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:43:55 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['dromaeo_css', 15:43:55 INFO - 'kraken']}, 15:43:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:43:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:43:55 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:43:55 INFO - 'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:43:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:43:55 INFO - 'tests': ['damp', 'tps']}, 15:43:55 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:43:55 INFO - 'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['damp', 'tps']}, 15:43:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:43:55 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['dromaeo_dom']}, 15:43:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:43:55 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['basic_compositor_video', 15:43:55 INFO - 'glvideo']}, 15:43:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:43:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:43:55 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:43:55 INFO - 'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['ts_paint_webext', 15:43:55 INFO - 'tp5o_webext']}, 15:43:55 INFO - 'other-e10s': {'tests': ['a11yr', 15:43:55 INFO - 'ts_paint', 15:43:55 INFO - 'tpaint', 15:43:55 INFO - 'sessionrestore', 15:43:55 INFO - 'sessionrestore_many_windows', 15:43:55 INFO - 'sessionrestore_no_auto_restore', 15:43:55 INFO - 'tabpaint']}, 15:43:55 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['a11yr', 15:43:55 INFO - 'ts_paint', 15:43:55 INFO - 'tpaint', 15:43:55 INFO - 'sessionrestore', 15:43:55 INFO - 'sessionrestore_many_windows', 15:43:55 INFO - 'sessionrestore_no_auto_restore', 15:43:55 INFO - 'tabpaint']}, 15:43:55 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 15:43:55 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 15:43:55 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['perf_reftest_singletons']}, 15:43:55 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['perf_reftest']}, 15:43:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:43:55 INFO - 'tsvgr_opacity', 15:43:55 INFO - 'tart', 15:43:55 INFO - 'tscrollx', 15:43:55 INFO - 'tsvg_static']}, 15:43:55 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['tsvgx', 15:43:55 INFO - 'tsvgr_opacity', 15:43:55 INFO - 'tart', 15:43:55 INFO - 'tscrollx', 15:43:55 INFO - 'tsvg_static']}, 15:43:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:43:55 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:43:55 INFO - 'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['tp5o']}, 15:43:55 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:43:55 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:43:55 INFO - 'talos_options': ['--mitmproxy', 15:43:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:43:55 INFO - '--firstNonBlankPaint'], 15:43:55 INFO - 'tests': ['tp6_google', 15:43:55 INFO - 'tp6_youtube', 15:43:55 INFO - 'tp6_amazon', 15:43:55 INFO - 'tp6_facebook']}, 15:43:55 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:43:55 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:43:55 INFO - 'talos_options': ['--disable-stylo', 15:43:55 INFO - '--mitmproxy', 15:43:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:43:55 INFO - '--firstNonBlankPaint'], 15:43:55 INFO - 'tests': ['tp6_google', 15:43:55 INFO - 'tp6_youtube', 15:43:55 INFO - 'tp6_amazon', 15:43:55 INFO - 'tp6_facebook']}, 15:43:55 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:43:55 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:43:55 INFO - 'talos_options': ['--stylo-threads=1', 15:43:55 INFO - '--mitmproxy', 15:43:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:43:55 INFO - '--firstNonBlankPaint'], 15:43:55 INFO - 'tests': ['tp6_google', 15:43:55 INFO - 'tp6_youtube', 15:43:55 INFO - 'tp6_amazon', 15:43:55 INFO - 'tp6_facebook']}, 15:43:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:43:55 INFO - 'talos_options': ['--xperf_path', 15:43:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:43:55 INFO - 'tests': ['tp5n']}, 15:43:55 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:43:55 INFO - 'talos_options': ['--disable-stylo', 15:43:55 INFO - '--xperf_path', 15:43:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:43:55 INFO - 'tests': ['tp5n']}}} 15:43:55 INFO - Running post-action listener: _resource_record_post_action 15:43:55 INFO - [mozharness: 2017-09-24 22:43:55.153631Z] Finished populate-webroot step (success) 15:43:55 INFO - [mozharness: 2017-09-24 22:43:55.153721Z] Running create-virtualenv step. 15:43:55 INFO - Running pre-action listener: _resource_record_pre_action 15:43:55 INFO - Running main action method: create_virtualenv 15:43:55 INFO - Creating virtualenv /builds/slave/test/build/venv 15:43:55 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:43:55 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:43:55 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:43:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:43:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:43:55 INFO - Installing distribute.............................................................................................................................................................................................done. 15:43:56 INFO - Installing pip...............done. 15:43:56 INFO - Return code: 0 15:43:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:43:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:43:56 INFO - Reading from file tmpfile_stdout 15:43:56 INFO - Output received: 15:43:56 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:43:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:43: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')]} 15:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43: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')]} 15:43:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:56 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 0x18621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcf9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bccd60>, '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 0x1bcda60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcdef0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:43:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:43:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:43:56 INFO - Using env: {'DISPLAY': ':0', 15:43:56 INFO - 'HOME': '/home/cltbld', 15:43:56 INFO - 'LANG': 'en_US.UTF-8', 15:43:56 INFO - 'LANGUAGE': 'en_US:en', 15:43:56 INFO - 'LOGNAME': 'cltbld', 15:43:56 INFO - 'MAIL': '/var/mail/cltbld', 15:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:56 INFO - 'MOZ_NO_REMOTE': '1', 15:43:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:56 INFO - 'NO_EM_RESTART': '1', 15:43:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:56 INFO - 'PWD': '/builds/slave/test', 15:43:56 INFO - 'SHELL': '/bin/bash', 15:43:56 INFO - 'SHLVL': '1', 15:43:56 INFO - 'TERM': 'linux', 15:43:56 INFO - 'TMOUT': '86400', 15:43:56 INFO - 'USER': 'cltbld', 15:43:56 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587', 15:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:56 INFO - '_': '/tools/buildbot/bin/python'} 15:43:57 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:43:57 INFO - Downloading/unpacking pip>=1.5 15:43:57 INFO - Running setup.py egg_info for package pip 15:43:57 INFO - warning: no files found matching 'pip/cacert.pem' 15:43:57 INFO - warning: no files found matching '*.html' under directory 'docs' 15:43:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:43:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:43:57 INFO - Installing collected packages: pip 15:43:57 INFO - Found existing installation: pip 1.1 15:43:57 INFO - Uninstalling pip: 15:43:57 INFO - Successfully uninstalled pip 15:43:57 INFO - Running setup.py install for pip 15:43:57 INFO - warning: no files found matching 'pip/cacert.pem' 15:43:57 INFO - warning: no files found matching '*.html' under directory 'docs' 15:43:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:43:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:43:57 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:43:57 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:43:57 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:43:57 INFO - Successfully installed pip 15:43:57 INFO - Cleaning up... 15:43:57 INFO - Return code: 0 15:43:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:57 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 0x18621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcf9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bccd60>, '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 0x1bcda60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcdef0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:43:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:43:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:43:57 INFO - Using env: {'DISPLAY': ':0', 15:43:57 INFO - 'HOME': '/home/cltbld', 15:43:57 INFO - 'LANG': 'en_US.UTF-8', 15:43:57 INFO - 'LANGUAGE': 'en_US:en', 15:43:57 INFO - 'LOGNAME': 'cltbld', 15:43:57 INFO - 'MAIL': '/var/mail/cltbld', 15:43:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:57 INFO - 'MOZ_NO_REMOTE': '1', 15:43:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:57 INFO - 'NO_EM_RESTART': '1', 15:43:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:57 INFO - 'PWD': '/builds/slave/test', 15:43:57 INFO - 'SHELL': '/bin/bash', 15:43:57 INFO - 'SHLVL': '1', 15:43:57 INFO - 'TERM': 'linux', 15:43:57 INFO - 'TMOUT': '86400', 15:43:57 INFO - 'USER': 'cltbld', 15:43:57 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587', 15:43:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:57 INFO - '_': '/tools/buildbot/bin/python'} 15:43:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:57 INFO - Downloading/unpacking psutil>=3.1.1 15:43: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 15:43: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 15:43: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 15:43: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 15:44:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:44:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:44:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:44:05 INFO - Installing collected packages: psutil 15:44:05 INFO - Running setup.py install for psutil 15:44:05 INFO - building 'psutil._psutil_linux' extension 15:44:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:44:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:44:06 INFO - building 'psutil._psutil_posix' extension 15:44:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:44:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:44:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:44:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:44:06 INFO - Successfully installed psutil 15:44:06 INFO - Cleaning up... 15:44:06 INFO - Return code: 0 15:44:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:06 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 0x18621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcf9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bccd60>, '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 0x1bcda60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcdef0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:44:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:44:06 INFO - Using env: {'DISPLAY': ':0', 15:44:06 INFO - 'HOME': '/home/cltbld', 15:44:06 INFO - 'LANG': 'en_US.UTF-8', 15:44:06 INFO - 'LANGUAGE': 'en_US:en', 15:44:06 INFO - 'LOGNAME': 'cltbld', 15:44:06 INFO - 'MAIL': '/var/mail/cltbld', 15:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:06 INFO - 'MOZ_NO_REMOTE': '1', 15:44:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:06 INFO - 'NO_EM_RESTART': '1', 15:44:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:06 INFO - 'PWD': '/builds/slave/test', 15:44:06 INFO - 'SHELL': '/bin/bash', 15:44:06 INFO - 'SHLVL': '1', 15:44:06 INFO - 'TERM': 'linux', 15:44:06 INFO - 'TMOUT': '86400', 15:44:06 INFO - 'USER': 'cltbld', 15:44:06 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587', 15:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:06 INFO - '_': '/tools/buildbot/bin/python'} 15:44:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:44:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:44:07 INFO - Installing collected packages: mozsystemmonitor 15:44:07 INFO - Running setup.py install for mozsystemmonitor 15:44:07 INFO - Successfully installed mozsystemmonitor 15:44:07 INFO - Cleaning up... 15:44:07 INFO - Return code: 0 15:44:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcf9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bccd60>, '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 0x1bcda60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcdef0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:44:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:44:07 INFO - Using env: {'DISPLAY': ':0', 15:44:07 INFO - 'HOME': '/home/cltbld', 15:44:07 INFO - 'LANG': 'en_US.UTF-8', 15:44:07 INFO - 'LANGUAGE': 'en_US:en', 15:44:07 INFO - 'LOGNAME': 'cltbld', 15:44:07 INFO - 'MAIL': '/var/mail/cltbld', 15:44:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:07 INFO - 'MOZ_NO_REMOTE': '1', 15:44:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:07 INFO - 'NO_EM_RESTART': '1', 15:44:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:07 INFO - 'PWD': '/builds/slave/test', 15:44:07 INFO - 'SHELL': '/bin/bash', 15:44:07 INFO - 'SHLVL': '1', 15:44:07 INFO - 'TERM': 'linux', 15:44:07 INFO - 'TMOUT': '86400', 15:44:07 INFO - 'USER': 'cltbld', 15:44:07 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587', 15:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:07 INFO - '_': '/tools/buildbot/bin/python'} 15:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:08 INFO - Downloading/unpacking jsonschema==2.5.1 15:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:44:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:09 INFO - Downloading functools32-3.2.3-2.tar.gz 15:44:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:44:09 INFO - warning: no files found matching '*.txt' 15:44:09 INFO - no previously-included directories found matching 'build' 15:44:09 INFO - no previously-included directories found matching 'dist' 15:44:09 INFO - no previously-included directories found matching '.git*' 15:44:09 INFO - Installing collected packages: jsonschema, functools32 15:44:09 INFO - Running setup.py install for functools32 15:44:09 INFO - warning: no files found matching '*.txt' 15:44:09 INFO - no previously-included directories found matching 'build' 15:44:09 INFO - no previously-included directories found matching 'dist' 15:44:09 INFO - no previously-included directories found matching '.git*' 15:44:09 INFO - Successfully installed jsonschema functools32 15:44:09 INFO - Cleaning up... 15:44:09 INFO - Return code: 0 15:44:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:44:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcf9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bccd60>, '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 0x1bcda60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcdef0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:44:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:44:09 INFO - Using env: {'DISPLAY': ':0', 15:44:09 INFO - 'HOME': '/home/cltbld', 15:44:09 INFO - 'LANG': 'en_US.UTF-8', 15:44:09 INFO - 'LANGUAGE': 'en_US:en', 15:44:09 INFO - 'LOGNAME': 'cltbld', 15:44:09 INFO - 'MAIL': '/var/mail/cltbld', 15:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:09 INFO - 'MOZ_NO_REMOTE': '1', 15:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:09 INFO - 'NO_EM_RESTART': '1', 15:44:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:09 INFO - 'PWD': '/builds/slave/test', 15:44:09 INFO - 'SHELL': '/bin/bash', 15:44:09 INFO - 'SHLVL': '1', 15:44:09 INFO - 'TERM': 'linux', 15:44:09 INFO - 'TMOUT': '86400', 15:44:09 INFO - 'USER': 'cltbld', 15:44:09 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587', 15:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:09 INFO - '_': '/tools/buildbot/bin/python'} 15:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:44:09 INFO - Cleaning up... 15:44:09 INFO - Return code: 0 15:44:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:44:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcf9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bccd60>, '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 0x1bcda60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcdef0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:44:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:44:09 INFO - Using env: {'DISPLAY': ':0', 15:44:09 INFO - 'HOME': '/home/cltbld', 15:44:09 INFO - 'LANG': 'en_US.UTF-8', 15:44:09 INFO - 'LANGUAGE': 'en_US:en', 15:44:09 INFO - 'LOGNAME': 'cltbld', 15:44:09 INFO - 'MAIL': '/var/mail/cltbld', 15:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:09 INFO - 'MOZ_NO_REMOTE': '1', 15:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:09 INFO - 'NO_EM_RESTART': '1', 15:44:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:09 INFO - 'PWD': '/builds/slave/test', 15:44:09 INFO - 'SHELL': '/bin/bash', 15:44:09 INFO - 'SHLVL': '1', 15:44:09 INFO - 'TERM': 'linux', 15:44:09 INFO - 'TMOUT': '86400', 15:44:09 INFO - 'USER': 'cltbld', 15:44:09 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587', 15:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:09 INFO - '_': '/tools/buildbot/bin/python'} 15:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:10 INFO - Downloading/unpacking blobuploader==1.2.4 15:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:11 INFO - Downloading blobuploader-1.2.4.tar.gz 15:44:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:44:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:44:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:11 INFO - Downloading docopt-0.6.1.tar.gz 15:44:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:44:11 INFO - Installing collected packages: blobuploader, requests, docopt 15:44:11 INFO - Running setup.py install for blobuploader 15:44:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:44:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:44:11 INFO - Running setup.py install for requests 15:44:12 INFO - Running setup.py install for docopt 15:44:12 INFO - Successfully installed blobuploader requests docopt 15:44:12 INFO - Cleaning up... 15:44:12 INFO - Return code: 0 15:44:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:12 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 0x18621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcf9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bccd60>, '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 0x1bcda60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcdef0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:44:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:44:12 INFO - Using env: {'DISPLAY': ':0', 15:44:12 INFO - 'HOME': '/home/cltbld', 15:44:12 INFO - 'LANG': 'en_US.UTF-8', 15:44:12 INFO - 'LANGUAGE': 'en_US:en', 15:44:12 INFO - 'LOGNAME': 'cltbld', 15:44:12 INFO - 'MAIL': '/var/mail/cltbld', 15:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:12 INFO - 'MOZ_NO_REMOTE': '1', 15:44:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:12 INFO - 'NO_EM_RESTART': '1', 15:44:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:12 INFO - 'PWD': '/builds/slave/test', 15:44:12 INFO - 'SHELL': '/bin/bash', 15:44:12 INFO - 'SHLVL': '1', 15:44:12 INFO - 'TERM': 'linux', 15:44:12 INFO - 'TMOUT': '86400', 15:44:12 INFO - 'USER': 'cltbld', 15:44:12 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587', 15:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:12 INFO - '_': '/tools/buildbot/bin/python'} 15:44:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:44:12 INFO - Running setup.py (path:/tmp/pip-I86ZQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:44:12 INFO - Running setup.py (path:/tmp/pip-HxwYS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:44:12 INFO - Running setup.py (path:/tmp/pip-CWobaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:44:12 INFO - Running setup.py (path:/tmp/pip-xF0CCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:44:12 INFO - Running setup.py (path:/tmp/pip-2EEU9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:44:12 INFO - Running setup.py (path:/tmp/pip-cweLdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:44:12 INFO - Running setup.py (path:/tmp/pip-5a8_4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:44:13 INFO - Running setup.py (path:/tmp/pip-Ibnam9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:44:13 INFO - Running setup.py (path:/tmp/pip-F5ZQW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:44:13 INFO - Running setup.py (path:/tmp/pip-fKXncU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:44:13 INFO - Running setup.py (path:/tmp/pip-zSMdOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:44:13 INFO - Running setup.py (path:/tmp/pip-XvSkly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:44:13 INFO - Running setup.py (path:/tmp/pip-KGr8vK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:44:13 INFO - Running setup.py (path:/tmp/pip-fWLmBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:13 INFO - Running setup.py (path:/tmp/pip-QRoPxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:44:13 INFO - Running setup.py (path:/tmp/pip-AwEN3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:44:13 INFO - Running setup.py (path:/tmp/pip-trbSdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:44:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:44:13 INFO - Running setup.py install for manifestparser 15:44:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:44:13 INFO - Running setup.py install for mozcrash 15:44:13 INFO - Running setup.py install for mozdebug 15:44:14 INFO - Running setup.py install for mozdevice 15:44:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:44:14 INFO - Running setup.py install for mozfile 15:44:14 INFO - Running setup.py install for mozhttpd 15:44:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:44:14 INFO - Running setup.py install for mozinfo 15:44:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:44:14 INFO - Running setup.py install for mozInstall 15:44:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:44:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:44:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:44:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:44:14 INFO - Running setup.py install for mozleak 15:44:14 INFO - Running setup.py install for mozlog 15:44:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:44:14 INFO - Running setup.py install for moznetwork 15:44:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:44:14 INFO - Running setup.py install for mozprocess 15:44:14 INFO - Running setup.py install for mozprofile 15:44:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:44:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:44:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:44:15 INFO - Running setup.py install for mozrunner 15:44:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:44:15 INFO - Running setup.py install for mozscreenshot 15:44:15 INFO - Running setup.py install for moztest 15:44:15 INFO - Running setup.py install for mozversion 15:44:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:44:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:44:15 INFO - Cleaning up... 15:44:15 INFO - Return code: 0 15:44:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:44:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:15 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 0x18621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcf9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bccd60>, '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 0x1bcda60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcdef0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:44:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:44:15 INFO - Using env: {'DISPLAY': ':0', 15:44:15 INFO - 'HOME': '/home/cltbld', 15:44:15 INFO - 'LANG': 'en_US.UTF-8', 15:44:15 INFO - 'LANGUAGE': 'en_US:en', 15:44:15 INFO - 'LOGNAME': 'cltbld', 15:44:15 INFO - 'MAIL': '/var/mail/cltbld', 15:44:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:15 INFO - 'MOZ_NO_REMOTE': '1', 15:44:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:15 INFO - 'NO_EM_RESTART': '1', 15:44:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:15 INFO - 'PWD': '/builds/slave/test', 15:44:15 INFO - 'SHELL': '/bin/bash', 15:44:15 INFO - 'SHLVL': '1', 15:44:15 INFO - 'TERM': 'linux', 15:44:15 INFO - 'TMOUT': '86400', 15:44:15 INFO - 'USER': 'cltbld', 15:44:15 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587', 15:44:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:15 INFO - '_': '/tools/buildbot/bin/python'} 15:44:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:44:15 INFO - Running setup.py (path:/tmp/pip-5qNZjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:44:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:44:15 INFO - Running setup.py (path:/tmp/pip-kAyg5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:44:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:44:15 INFO - Running setup.py (path:/tmp/pip-mz24Fy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:44:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:44:15 INFO - Running setup.py (path:/tmp/pip-P1CWnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:44:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:44:15 INFO - Running setup.py (path:/tmp/pip-U7i1zJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:44:16 INFO - Running setup.py (path:/tmp/pip-2J7r3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:44:16 INFO - Running setup.py (path:/tmp/pip-kRgXtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:44:16 INFO - Running setup.py (path:/tmp/pip-gl8ekf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:44:16 INFO - Running setup.py (path:/tmp/pip-8ikZEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:44:16 INFO - Running setup.py (path:/tmp/pip-xer1NV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:44:16 INFO - Running setup.py (path:/tmp/pip-MIyG3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:44:16 INFO - Running setup.py (path:/tmp/pip-tBwpNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:44:16 INFO - Running setup.py (path:/tmp/pip-phRdF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:44:16 INFO - Running setup.py (path:/tmp/pip-sRg3gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:16 INFO - Running setup.py (path:/tmp/pip-oqmUM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:44:16 INFO - Running setup.py (path:/tmp/pip-X9beHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:44:16 INFO - Running setup.py (path:/tmp/pip-EZzVqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:44:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:18 INFO - Downloading blessings-1.6.tar.gz 15:44:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:44:18 INFO - Installing collected packages: blessings 15:44:18 INFO - Running setup.py install for blessings 15:44:18 INFO - Successfully installed blessings 15:44:18 INFO - Cleaning up... 15:44:18 INFO - Return code: 0 15:44:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:44:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:44:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:44:18 INFO - Reading from file tmpfile_stdout 15:44:18 INFO - Current package versions: 15:44:18 INFO - argparse == 1.2.1 15:44:18 INFO - blessings == 1.6 15:44:18 INFO - blobuploader == 1.2.4 15:44:18 INFO - docopt == 0.6.1 15:44:18 INFO - functools32 == 3.2.3-2 15:44:18 INFO - jsonschema == 2.5.1 15:44:18 INFO - manifestparser == 1.1 15:44:18 INFO - mozInstall == 1.13 15:44:18 INFO - mozcrash == 1.0 15:44:18 INFO - mozdebug == 0.1 15:44:18 INFO - mozdevice == 0.51 15:44:18 INFO - mozfile == 1.2 15:44:18 INFO - mozhttpd == 0.7 15:44:18 INFO - mozinfo == 0.10 15:44:18 INFO - mozleak == 0.1 15:44:18 INFO - mozlog == 3.5 15:44:18 INFO - moznetwork == 0.27 15:44:18 INFO - mozprocess == 0.25 15:44:18 INFO - mozprofile == 0.28 15:44:18 INFO - mozrunner == 6.13 15:44:18 INFO - mozscreenshot == 0.1 15:44:18 INFO - mozsystemmonitor == 0.3 15:44:18 INFO - moztest == 0.8 15:44:18 INFO - mozversion == 1.4 15:44:18 INFO - psutil == 3.1.1 15:44:18 INFO - requests == 1.2.3 15:44:18 INFO - wsgiref == 0.1.2 15:44:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:44:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:18 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 0x18621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcf9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bccd60>, '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 0x1bcda60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcdef0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:44:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:44:18 INFO - Using env: {'DISPLAY': ':0', 15:44:18 INFO - 'HOME': '/home/cltbld', 15:44:18 INFO - 'LANG': 'en_US.UTF-8', 15:44:18 INFO - 'LANGUAGE': 'en_US:en', 15:44:18 INFO - 'LOGNAME': 'cltbld', 15:44:18 INFO - 'MAIL': '/var/mail/cltbld', 15:44:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:18 INFO - 'MOZ_NO_REMOTE': '1', 15:44:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:18 INFO - 'NO_EM_RESTART': '1', 15:44:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:18 INFO - 'PWD': '/builds/slave/test', 15:44:18 INFO - 'SHELL': '/bin/bash', 15:44:18 INFO - 'SHLVL': '1', 15:44:18 INFO - 'TERM': 'linux', 15:44:18 INFO - 'TMOUT': '86400', 15:44:18 INFO - 'USER': 'cltbld', 15:44:18 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587', 15:44:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:18 INFO - '_': '/tools/buildbot/bin/python'} 15:44:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:44:18 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:44:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:44:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:44:19 INFO - Installing collected packages: simplejson 15:44:19 INFO - Running setup.py install for simplejson 15:44:19 INFO - building 'simplejson._speedups' extension 15:44:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 15:44:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 15:44:20 INFO - Successfully installed simplejson 15:44:20 INFO - Cleaning up... 15:44:20 INFO - Return code: 0 15:44:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:44: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')]} 15:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44: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')]} 15:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:20 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 0x18621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcf9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bccd60>, '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 0x1bcda60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcdef0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:44:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:44:20 INFO - Using env: {'DISPLAY': ':0', 15:44:20 INFO - 'HOME': '/home/cltbld', 15:44:20 INFO - 'LANG': 'en_US.UTF-8', 15:44:20 INFO - 'LANGUAGE': 'en_US:en', 15:44:20 INFO - 'LOGNAME': 'cltbld', 15:44:20 INFO - 'MAIL': '/var/mail/cltbld', 15:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:20 INFO - 'MOZ_NO_REMOTE': '1', 15:44:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:20 INFO - 'NO_EM_RESTART': '1', 15:44:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:20 INFO - 'PWD': '/builds/slave/test', 15:44:20 INFO - 'SHELL': '/bin/bash', 15:44:20 INFO - 'SHLVL': '1', 15:44:20 INFO - 'TERM': 'linux', 15:44:20 INFO - 'TMOUT': '86400', 15:44:20 INFO - 'USER': 'cltbld', 15:44:20 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587', 15:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:20 INFO - '_': '/tools/buildbot/bin/python'} 15:44:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:44:21 INFO - Cleaning up... 15:44:21 INFO - Return code: 0 15:44:21 INFO - Running post-action listener: _resource_record_post_action 15:44:21 INFO - Running post-action listener: _start_resource_monitoring 15:44:21 INFO - Starting resource monitoring. 15:44:21 INFO - [mozharness: 2017-09-24 22:44:21.175756Z] Finished create-virtualenv step (success) 15:44:21 INFO - [mozharness: 2017-09-24 22:44:21.176270Z] Running install step. 15:44:21 INFO - Running pre-action listener: _resource_record_pre_action 15:44:21 INFO - Running main action method: install 15:44:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:44:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:44:21 INFO - Reading from file tmpfile_stdout 15:44:21 INFO - Detecting whether we're running mozinstall >=1.0... 15:44:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:44:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:44:21 INFO - Reading from file tmpfile_stdout 15:44:21 INFO - Output received: 15:44:21 INFO - Usage: mozinstall [options] installer 15:44:21 INFO - Options: 15:44:21 INFO - -h, --help show this help message and exit 15:44:21 INFO - -d DEST, --destination=DEST 15:44:21 INFO - Directory to install application into. [default: 15:44:21 INFO - "/builds/slave/test"] 15:44:21 INFO - --app=APP Application being installed. [default: firefox] 15:44:21 INFO - mkdir: /builds/slave/test/build/application 15:44:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:44:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:44:39 INFO - Reading from file tmpfile_stdout 15:44:39 INFO - Output received: 15:44:39 INFO - /builds/slave/test/build/application/firefox/firefox 15:44:39 INFO - Running post-action listener: _resource_record_post_action 15:44:39 INFO - [mozharness: 2017-09-24 22:44:39.341737Z] Finished install step (success) 15:44:39 INFO - [mozharness: 2017-09-24 22:44:39.341991Z] Running setup-mitmproxy step. 15:44:39 INFO - Running pre-action listener: _resource_record_pre_action 15:44:39 INFO - Running main action method: setup_mitmproxy 15:44:39 INFO - Skipping: mitmproxy is not required 15:44:39 INFO - Running post-action listener: _resource_record_post_action 15:44:39 INFO - [mozharness: 2017-09-24 22:44:39.343124Z] Finished setup-mitmproxy step (success) 15:44:39 INFO - [mozharness: 2017-09-24 22:44:39.343343Z] Running run-tests step. 15:44:39 INFO - Running pre-action listener: _resource_record_pre_action 15:44:39 INFO - Running pre-action listener: _set_gcov_prefix 15:44:39 INFO - Running main action method: run_tests 15:44:39 WARNING - Try message not found. 15:44:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:44:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:44:39 INFO - Python 2.7.3 15:44:39 INFO - Return code: 0 15:44:39 INFO - grabbing minidump binary from tooltool 15:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:39 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 0x1bccd60>, '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 0x1bcda60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcdef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:44:39 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 15:44:39 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 15:44:39 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 15:44:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:44:39 INFO - Return code: 0 15:44:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:44:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:44:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:44:39 INFO - ENV: RUST_BACKTRACE is now full 15:44:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:44:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:44:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 15:44:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 15:44:39 INFO - Using env: {'DISPLAY': ':0', 15:44:39 INFO - 'HOME': '/home/cltbld', 15:44:39 INFO - 'LANG': 'en_US.UTF-8', 15:44:39 INFO - 'LANGUAGE': 'en_US:en', 15:44:39 INFO - 'LOGNAME': 'cltbld', 15:44:39 INFO - 'MAIL': '/var/mail/cltbld', 15:44:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:44:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:44:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:39 INFO - 'MOZ_NO_REMOTE': '1', 15:44:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:44:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:39 INFO - 'NO_EM_RESTART': '1', 15:44:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:39 INFO - 'PWD': '/builds/slave/test', 15:44:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:44:39 INFO - 'RUST_BACKTRACE': 'full', 15:44:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:44:39 INFO - 'SHELL': '/bin/bash', 15:44:39 INFO - 'SHLVL': '1', 15:44:39 INFO - 'TERM': 'linux', 15:44:39 INFO - 'TMOUT': '86400', 15:44:39 INFO - 'USER': 'cltbld', 15:44:39 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587', 15:44:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:39 INFO - '_': '/tools/buildbot/bin/python'} 15:44:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 15:44:39 INFO - mozversion application_buildid: 20170924215251 15:44:39 INFO - mozversion application_changeset: b44e80e0590e6eed86a1902365424673c8c2eaec 15:44:39 INFO - mozversion application_display_name: Nightly 15:44:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:44:39 INFO - mozversion application_name: Firefox 15:44:39 INFO - mozversion application_remotingname: firefox 15:44:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:44:39 INFO - mozversion application_vendor: Mozilla 15:44:39 INFO - mozversion application_version: 58.0a1 15:44:39 INFO - mozversion platform_buildid: 20170924215251 15:44:39 INFO - mozversion platform_changeset: b44e80e0590e6eed86a1902365424673c8c2eaec 15:44:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:44:39 INFO - mozversion platform_version: 58.0a1 15:44:39 INFO - using testdate: 1506293079 15:44:39 INFO - actual date: 1506293079 15:44:39 INFO - starting webserver on 'localhost:51742' 15:44:39 INFO - SUITE-START | Running 2 tests 15:44:39 INFO - TEST-START | dromaeo_css 15:44:39 INFO - Initialising browser for dromaeo_css test... 15:44:39 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51742/getInfo.html -profile /tmp/tmpVjJNTp/profile 15:44:39 INFO - TEST-INFO | started process 18897 (/builds/slave/test/build/application/firefox/firefox http://localhost:51742/getInfo.html) 15:44:45 INFO - TEST-INFO | 18897: exit 0 15:44:45 INFO - Browser initialized. 15:44:45 INFO - Running cycle 1/1 for dromaeo_css test... 15:44:45 INFO - Using env: {'DISPLAY': ':0', 15:44:45 INFO - 'HOME': '/home/cltbld', 15:44:45 INFO - 'JSGC_DISABLE_POISONING': '1', 15:44:45 INFO - 'LANG': 'en_US.UTF-8', 15:44:45 INFO - 'LANGUAGE': 'en_US:en', 15:44:45 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:44:45 INFO - 'LOGNAME': 'cltbld', 15:44:45 INFO - 'MAIL': '/var/mail/cltbld', 15:44:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:44:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:44:45 INFO - 'MOZ_CRASHREPORTER': '1', 15:44:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:45 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:44:45 INFO - 'MOZ_NO_REMOTE': '1', 15:44:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:44:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:45 INFO - 'NO_EM_RESTART': '1', 15:44:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:45 INFO - 'PWD': '/builds/slave/test', 15:44:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:44:45 INFO - 'RUST_BACKTRACE': 'full', 15:44:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:44:45 INFO - 'SHELL': '/bin/bash', 15:44:45 INFO - 'SHLVL': '1', 15:44:45 INFO - 'STYLO_FORCE_DISABLED': '1', 15:44:45 INFO - 'TERM': 'linux', 15:44:45 INFO - 'TMOUT': '86400', 15:44:45 INFO - 'USER': 'cltbld', 15:44:45 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587', 15:44:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:45 INFO - '_': '/tools/buildbot/bin/python'} 15:44:45 INFO - TEST-INFO | started process 19135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVjJNTp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:44:46 INFO - PID 19135 | 15:44:46 INFO - PID 19135 | (/builds/slave/test/build/application/firefox/firefox:19186): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:44:46 INFO - PID 19135 | 15:44:56 INFO - PID 19135 | RSS: Main: 151175168 15:44:56 INFO - PID 19135 | 15:47:53 INFO - PID 19135 | Cycle 1(1): loaded http://localhost:51742/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51742/tests/dromaeo/cssquery-ext.html) 15:47:55 INFO - PID 19135 | RSS: Main: 153210880 15:47:55 INFO - PID 19135 | 15:50:56 INFO - PID 19135 | Cycle 1(1): loaded http://localhost:51742/tests/dromaeo/cssquery-ext.html (next: http://localhost:51742/tests/dromaeo/cssquery-jquery.html) 15:50:57 INFO - PID 19135 | RSS: Main: 152391680 15:50:57 INFO - PID 19135 | 15:53:59 INFO - PID 19135 | Cycle 1(1): loaded http://localhost:51742/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51742/tests/dromaeo/cssquery-mootools.html) 15:53:59 INFO - PID 19135 | RSS: Main: 154759168 15:53:59 INFO - PID 19135 | 15:57:01 INFO - PID 19135 | Cycle 1(1): loaded http://localhost:51742/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51742/tests/dromaeo/cssquery-prototype.html) 15:57:02 INFO - PID 19135 | RSS: Main: 153206784 15:57:02 INFO - PID 19135 | 16:00:05 INFO - PID 19135 | Cycle 1(1): loaded http://localhost:51742/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51742/tests/dromaeo/cssquery-yui.html) 16:00:05 INFO - PID 19135 | RSS: Main: 154509312 16:00:05 INFO - PID 19135 | 16:03:07 INFO - PID 19135 | Cycle 1(1): loaded http://localhost:51742/tests/dromaeo/cssquery-yui.html (next: http://localhost:51742/tests/dromaeo/cssquery-dojo.html) 16:03:07 INFO - PID 19135 | RSS: Main: 156880896 16:03:07 INFO - PID 19135 | 16:03:07 INFO - PID 19135 | __start_tp_report 16:03:07 INFO - PID 19135 | _x_x_mozilla_page_load 16:03:07 INFO - PID 19135 | _x_x_mozilla_page_load_details 16:03:07 INFO - PID 19135 | |i|pagename|runs| 16:03:07 INFO - PID 19135 | |0;dojo.html;3134.43580155572;3142.921426964327;3149.385869755398;3157.431662300785;3163.8576264068115;6350.650714210717;6351.936480635192;6357.396047375503;6407.711652975616;6489.31862154474;6389.744410223586;6461.612303261808;6481.31946145655;6492.6429046402545;6504.2194936607675;5478.287822583068;5767.250257466544;5879.911801322984;5923.5853490255695;5954.4640982311585;5794.797182098628;5796.275465566804;5858.53131749459;5865.120231965197;5906.734196961147;5795.449432303924;5862.824115276549;5881.470667639912;5885.176075349433;5947.910781338283;5791.739371728282;5839.562032847553;5847.093700476433;5910.497607703351;5930.525557955353;5869.677167755772;5911.556633252523;5931.673757943311;5939.762409503614;5953.404659534055;6323;6380.744770209186;6416.903746443807;6422.4862011039;6449.871002579969;6634.966825165843;6738.629375384352;6753.493487988371;6838.418734407582;6913.654317284166;6912.239653638146;6918.411934985532;6923.169219693618;6929.72281108755;6931.896021559681;6207.4723648489935;6296.338884417116;6299.811005669837;6408.583442076297;6432;6942.444604431634;7117.6085315308155;7133.108361454818;7142.4286057115305;7143.678534465961;6714.127163468718;6714.328567143247;6785.796426107225;6795.150606174228;6824.454043676494;6697.497687673444;6811.693473793592;6841.486888483384;6932.0988271524375;6934.098567186234;6837.38463538274;6837.931620683729;6841.657917104224;6849.280825513349;6856.657167141623;6704.128463299739;6807.4894382921475;6892.035115083892;6894.482913781487;6902.792916212522;5072.112380333427;5145.279660847485;5170.5346518813485;5242.951409718072;5246.7638956247065;4513.796879140446;4518.841840535565;4526.660500462479;4541.046380260116;4624.5144259852905;5766.077427611646;5799.594028417971;5808;5813.82558523245;5827.533797296206;6776.9322306777285;6787.5588086774205;6793.864122717518;6795.354441328066;6874.381305682413;5633.549316054706;5708.343540492897;5748.137779333133;5800.303963524404;5826.096954971986;5913.172155898178;5926.111083337534;5931.73307201177;5934.228550288522;5935.554833387513;6568.704408301543;6640.800775976729;6649.168853893263;6662.966685166543;6704.698288577026;6818.93181068183;6826.93173068263;6832.521723479408;6849.554778939353;6952.409045231212;6377.202849643794;6422;6433.388828061326;6446.8388290293115;6447.677616119082;6718.630475323708;6806.659667016728;6810.182778066664;6821.454283657196;6821.829454263683;6873.621950792554;6883.346082122191;6966.930330696831;6995.650217489004;6995.685194166173;6612.537122401386;6626.900596491153;6674.966625166843;6709.832254193684;6715.227748808949;6491.967540162269;6613.43785778195;6640.335966403321;6725.361090696376;6733.023711561698;6489.643069631215;6509.446697030616;6511.772087976898;6516.152900122954;6516.543841931019;6621.900671489835;6624.6025238485845;6629.171353580802;6629.237637671729;6772.627505487246;6504.056911747864;6508.316626754123;6556.672166391566;6561.737530498726;6565.737370505318 16:03:07 INFO - PID 19135 | |1;ext.html;870.7910101575621;895.753667741371;905.6965916417997;906.1572737354262;912.2063804490094;42528.787356063214;43091;43110.56889431105;43187.78406107973;43310;38838.61161388392;38901.221975560475;39070.60929390705;39179.60820391795;41994.79002604983;4351.543087975764;4371.606555410012;4376.737395756249;4401.9119617607785;4807.855764327067;7978.281954624083;8048.919510804905;8102.635381407851;8103.554304513249;8121.796955076111;8075.475094118893;8132.837343253132;8133.633986470623;8143.714969976052;8147.511149331059;8045.798855028613;8058.274755272025;8096.838063238732;8109.594520273963;8110;7226.3857572106435;7252.673629686677;7301.1603665578605;7302.415806735502;7305.159906610755;38178.61821381778;38192.80903595492;38221;38412.42381364282;38438;3552.786832790041;3567.1795487037866;3579.4451859961746;3588.8923332300074;3592.8203589820405;30993.845030774926;31231;31333.843330783428;31334.843325783455;31346.21634459134;4972.378452693413;5151.8196863109615;5193.402758682762;5223.347081614798;5243.134882744343;183239;183261;184460.99999999866;184861;185654;43061.569384306385;43877;49868.50131498711;50737.23894141591;50913.49086509162;52482;52556.21165682518;52755.73622131865;52777;52861.735691322065;16235;16345.918270408809;16400.425985090464;16411.343546258016;16423.507294781175;13177.802332965013;13332.866671333357;13383;13388.866111338762;13391.799123013163;13899.16605003703;13957.58127256184;14038.71922561543;14053.22707251111;14205.21871297068;5411.675299482044;5538.418466061086;5613.214150019001;5618.719064046782;5634.098544232903;1010.2574607663508;1015.4973288222377;1031.0514326819343;1043.2280112716535;1052.6157952347337;23576.17483388073;23699.170529031748;23724;23806.690632015405;23967.640485392734;1107.5403707461314;1114.8272017837248;1127.2841745491671;1129.1418521923397;1142.3831131189231;12386;12501.56244531437;12566.183198092094;12571.120021598583;12638.304893230777;217021;218439;218516;219564;220862;54308.72845635826;54351;54732.179017314775;54788.726056369465;54837.1774423384;1466.911985280865;1474.122896876357;1489.9925500372428;1492.1867582167745;1506;22836;23029.309120726404;23152.536949260582;23249.651255230845;23298.883505582362;38639.22721545609;38815.417768734056;38881.80559097186;38894.80552597219;38896.80551597224;186203;187260;187563;188409;189078.10921890606;31188;31257.37485250328;31318.373632527677;35374.823125884206;36016.63983360238;42942.141157176055;44487.332690009025;44501.554984449744;44740.55259447364;44902.10195796131;32739.34521309513;32905.34189316152;33062;33119;33757.49363759496;32216.355672885944;32310;32420.513692294164;32810;33219.833900830345;35018.299634007686;36530;36630.45054324134;36786.81606592057;36923.26153476969;31603.683963160074;32153.35693286168;32306;32370.676293236767;32420.675793241764;23678.408039799142;23774;23957.10423730049;23986;24217.878910605334 16:03:07 INFO - PID 19135 | |2;jquery.html;567.3532173322413;593.7743657410183;595.359988012886;596.2010905386782;609.4180058044568;22094.668579971294;23071.653925191134;23098.65352019719;23109;23155.652665209993;22694.773052269473;23997.160099396526;24727.505449890992;24821.75178248217;24924.50150996979;6587.670616469181;6726.764563240287;6737.629430381327;6744.123263975676;6789.083473731057;6565.1465309509695;6569.93430065698;6669.866602667944;6678.098456708331;6693.765718199864;6610.669466526679;6618.404343609074;6623.6025838449605;6636.270010298863;6657.800265992028;6255.749770009194;6614.0740296358545;6633.4693224541925;6640.335966403321;6642.136522252101;6051.909221361683;6062.514998800086;6095.390460953913;6130.478909292716;6131.570790044699;27124.321891952663;27681.584776228374;27682.861585691942;27694.723052769416;27729.861350693318;2070.927517536879;2092.4036649554955;2094.7381577302835;2101.1805395895612;2103.568768402474;17807;19656.606867862563;19808.504787380287;19815.207391704316;19815.207391704316;2369.845960012594;2406.927792166238;2450.6936632920883;2456.754324567529;2471.258622413287;119516.40241798823;122806.38596807048;125930;130204;136341.3182934079;14371.866669927245;14635.268236588128;14641.291351135826;14792.704145917021;15025;22599.54800903973;22610;22633.660495092587;22635;22698.546029079327;9838.508074596384;9937.65218217359;10016.49917504122;10064.547095380725;10121.493925303705;9186.08139186076;9260.536973151315;9297.581608827619;9301.953490232505;9315.72052838416;8881.511516866634;8913.732588022369;9067.138621830916;9069.863952040725;9086.500242486727;2690.5157071727276;2736.931576710558;2746.5605503119405;2755.6830964438946;2760.751532362097;965.1362030982372;992.1219720547223;997.1026076531035;1001.0540039662449;1013.5844303835539;18825.435236942914;18864;18956.81043189578;19409.4177174685;19501.609967800847;1028.4651980969854;1053.752368193474;1056.2025670618634;1070.9758556328545;1071.4535586850761;10539.683809485728;10640.148788096934;10728.409937453358;10734.892651073545;10978.231523793258;463856;476766;484059;489179;489898;110058;111719;112418;113264;114810.42594786972;1061.3366645846345;1147.2485521983115;1192.099964526794;1228.9446974885973;1234.450669452085;19492.220311187393;19887.502812429804;20167.69748453745;20338.288159914333;20363.49091272671;57334;58806.70596647161;59405.70297148487;59983;60768.696156518934;70177.64911175412;71044;71278;71427.28572714415;71824.64087679528;14075.366608502438;14407.855921440652;14415.063020903608;14425.567232983027;14425.711485770436;22079.44801379914;22178.778212218316;22248.998795054584;22296.10815567359;22329.665055024514;16770.32918683239;16992.830071699125;17192.570185744957;17193.398231061852;17748.556286092433;15929.442469513511;16107.194640268173;16153.75769363484;16185.514434566981;16582.25379857885;18128.728069078712;18233.817661823214;18254.543636409195;18319.81680183181;18392;13809.585712428643;13886.166829990232;14014;14053.508127215498;14065.156090634595;17322.22050007778;17438.564035899202;17460;17472.38846640412;17602.647947041245 16:03:07 INFO - PID 19135 | |3;mootools.html;1347.1580262336042;1373.5329987804143;1409.5536413469065;1425.8716715495602;1429.8284205895288;15140.167290799016;15856.762148567781;15862.286197121142;15864.048157110552;15869.444569440071;15197.848021519809;16269.755953660704;16274.75587866183;16328.101954392503;16339.59151021225;2754.476649436601;2815.9859200704072;2823.449427361665;2824.265690920355;2828.9434211315865;2734.4531093781225;2768.3771151490955;2802.2153796936786;2808.873600687974;2828.5898544711004;2812.9578056329174;2822.5483922572394;2843.2323272716353;2843.2323272716353;2846.7437930586243;2741.7806575473915;2791.148699646617;2791.1626512046405;2804.2008027712004;2806.9438611227865;2714.1450443110357;2728.386113124551;2744.6157537944705;2745.9862700686567;2747.9450410991867;14887.925560372238;15159.24203789806;15240.466583669519;15241.847581524155;15258;8081.6363263653275;8458.619362128657;8468.280196183332;8468.872966905501;8472.703455379033;5389.973050134763;5511.145772405283;5588.748506317225;5588.91616625751;5593.664380137205;1916.1473144450724;1959.9902000489906;1987.831034362081;2001.1495114576246;2003.9899800500905;27549.86225068882;27627.585586216224;27677.169684909484;27754.306142346602;27876.581851272043;6874.553154044971;7073.221945585981;7318.853622927511;7434.36807871337;7438.218987006395;18053.187606557738;18132.637347253243;18150.81849181518;18156.727649085275;18190.5452363692;8043.954285942907;8194.426390152752;8198.8360232795;8205.138460461685;8207.671693132328;7296.197418283985;7437.661220980275;7482.176960534337;7485.588292643848;7538.509996850187;4786.659735274129;5404.432534583891;5551.72241387929;5573.470520300565;5624;1415.9929200354138;1579.447193482272;1581.8022747156606;1601.119384338609;1609.3643011010586;882.9470231786113;884.823035392924;907.1065000974036;910.1762904571374;910.5538286239695;8954.373193876367;8955.328350373748;9028.232600228923;9066.818663626691;9138.406003609743;995.5967833027636;1001.3140998416109;1003.2375394700081;1005.9245556583139;1027.1782573940818;4756.310335001405;4787.928181077286;5024.246363045572;5433.402325744165;5781.277340332458;20748;22109.115635374405;22967.655485167736;22977.425564360692;22980.4254893629;21570.35288941334;21758.78241217599;22070.66893996591;22350.888245558668;22355.44111397228;11806;11834.940825295991;12026.398680066137;12050.156489045683;12066.215695979734;8351.749447516584;8387.203215694499;8420.073791882765;8450.535220562928;8471.364647651328;18648.906755466134;18722.81277187265;18965.33621323247;19124.139413726138;19191.232350705814;19426.2229510818;19508.122134503697;19602.313919012766;19666.21335146578;19811.20755169777;10762.73093172677;10867.945660271647;10870.61952831647;11048.668539943814;11221.551137954717;12210.26738395699;14051;14170.716585668022;14176.503822366167;14211.857881421467;8908.420952638058;9563.808723825345;10713;10884.455777211266;11023.944880275547;11128.888711112786;11241.71895702614;11346.205765596329;11361.659150225507;11508.942455288005;9724.562394692115;9920.801583968425;10015.649452269136;10025.348352357074;10053.849192262269;7305.817354565966;7347.26527347261;7362.852742945218;7371.299726525972;7383.040204773345;7395.667194976131;7410.62946852666;7441.4046876248685;7499.400047996256;7626.656800443882 16:03:07 INFO - PID 19135 | |4;prototype.html;522.8457605006523;523.9004589128067;538.501885755676;542.2327406719489;546.8004178474855;6329.556931014825;6373.458256048236;6412.909805333093;6433.839154021146;6520.380563846427;6304.684765761716;6322.810315690525;6323.083152942832;6352.714127864246;6355.68221588921;5278.524932756051;5281.471852814726;5302.6023048271345;5323.680579165262;5323.946760532383;4963.726995015273;5238.371395432553;5249.4750524947585;5343.251944727741;5345.251664766916;5027.974860125712;5057.949420505803;5059.241113832918;5105.719185444799;5137.588992880561;5059.974700126494;5071.746412679351;5080.187170052793;5100.449775112444;5123.385193776733;4560.95439045612;4607.677462577621;4610.2623580227;4612.5156858530045;4616.28447590624;6246.6252024878195;6246.906296405557;6247.9062814057825;6267.153934218868;6325.462335701471;5775.736708759538;5810.912836307417;5818.505427038707;5861.384554621789;5888.02847530157;6624.635645039521;6630.237522684856;6684.465242780566;6688.598684078922;6765.458763298924;5009.849704508834;5010.423801262865;5019.824306149304;5024.572911302544;5048.268001139851;6777.423918966893;6841.350071743226;6951.165860096719;7121.572705637678;7131.964340178318;4959.652824302264;5097.541221290102;5123.5132662397755;5141.794328226903;5168.586513078944;5184.818531351385;5186.611004174702;5192.870178245498;5237.450067742832;5242;5725.141228815628;5834.416558344132;5838.328592211865;5898.587098903122;5904.40581043116;6812.8296792579595;6815.591064536144;6852.554583952027;6866.210385805596;6889.621070841152;1782.5721826761744;1799.561594040083;1815.1378095404577;1821.3807305516189;1834.596388794463;1203.2179083595734;1228.1157566552067;1235.8022716365338;1254.3540076860425;1254.5546331052528;5663.801766938137;5670.404607516151;5687.8009269676195;5701.315842098975;5743.597948143673;6686.531942764057;6878.38094571491;6882.621455819878;6918.861622767517;6921.861562768717;5745.13822926556;5758.395368486333;5776.56675749312;5780;5805.622634528742;3579.964200358015;3594.4967704521387;3651;3652.9634703653155;3657.74395792292;6150.477209437158;6507.8698426031215;6513.381228783258;6539.444147247442;6568.310327415648;6885.277045910208;6914.585124892523;6958.965205174043;6989.196242432084;7041.612711300928;6388.93611063902;6460.8707825842275;6470.870582588416;6545.476361891133;6565.24499682533;6665.933340666531;6800.5239633227175;6819.283975182534;6848.9657551711925;6910.20532638753;6766.221884483348;6767.966160169168;6790.1851777785005;6801.18385793708;6881.208661004049;6598.208215014037;6629.005649152473;6642.900356494753;6656.134702488645;6668.566543174678;5086.253423151456;5121.257417674342;5141.614378921521;5153.845384638467;5164.302819119371;6486.9351306488215;6670.132882725215;6672.466202703675;6722.5714885407815;6920.169579650273;6513.743128435782;6520.836979075561;6610;6692.59844409337;6714.496412768965;6542.443892269211;6638.137042184679;6642;6654;6691.2639609643875;6549.574277671936;6555.4427873631275;6575.342465753578;6595.472362210916;6600.504962127764;6474.733843154858;6583.63789991555;6717.757214915257;6742.797716068526;6747.696353663999;6399.200099987502;6430.2605200400685;6439.098526206429;6486.578372405778;6560.8359791005605 16:03:07 INFO - PID 19135 | |5;yui.html;907.9682211122604;926.9490178040207;934.4113208678532;945.3618807305068;948.6300342866281;19611.705824412627;20541.794582054175;20565.794342056575;20583;20608.69086963693;18718.812811871878;19009.429717108473;19104.808951910476;19387;19548;954.3415043619898;973.0512750068697;974.9805003899918;975.1126474907835;978.0512902484578;993.3295025857553;994.24934174698;994.796066806303;994.8656931314252;995.810795948771;1023.805476959379;1062.3572738493178;1066.6426747039711;1067.023673338894;1069.5080263078994;991.4596544883057;1051.7265510967165;1056.4242487844144;1056.4770438632888;1063.0910571461366;749.7638243953137;753.3784627682185;755.5542230084277;756.4893696754668;756.4893696754724;20218.797812021985;20334.796652033438;20570;20593.176272949066;20595.176192952265;21487.462813429633;21865.781342186532;22459.55080898389;22649.433764155863;22674.206402775824;17564.473065808048;18037.27850885963;18111.547211319692;18217.362392316205;18288;3711.257748450321;3760.9435858462143;3769.321522126016;3771.41543060826;3771.641694039062;143160;143414.2829285847;145392;146020.99999999892;147778;17393.478195654152;17478.91260543689;17481.912590436965;17485.912570437322;17493.7375939361;32074.83962580172;33158;33303.83348083244;33332.3333533328;33409.66590334114;8579.613917373734;8748.300135989106;8761.474311541328;8958.193762561401;8994;4101.384792281122;4212.978935105305;4223.345381465878;4234.470691163605;4241.830326786894;5365.195220716846;5394.568434525228;5448.754806033738;5463.3717122530625;5481.561475081984;976.1312431935582;987.5704068730125;999.2256001598673;1007.325092188221;1009.152312057875;668.5854770042507;677.4478799778165;683.1221879884424;692.2350802363316;696.5368030259821;11678.76642467146;11695.824562631567;11845.348505832262;11882.702932426586;12209.023278137727;621.7948077134535;630.0926665601519;639.4532674563275;639.6354078175489;639.6737663791407;5336.306280183629;5358.356997160366;5377.623566350318;5430.13117901134;5566.721663916788;120268;121314;122217;123791;124924;104410.47794761129;105590;108098;108475;110678;96028;96565.51717241369;98819;99732;102147.48926255469;10243.641472548425;10261.794764104825;10313.793724125626;10347.447882817336;10555.15558755313;42829.14341713086;43579.12841743084;43612.34581481344;44145.11709765851;45238.54761452475;55007.72496137654;56555;56843.431565683815;58069.419305806405;59291;15534.456294029655;15836.52490425289;15844.841551584337;15882;16061.759073613672;15533.84466155324;16941.407050753165;17246.310147593955;17332.480025599252;17367.826321737128;14634.195119268117;14712.337944792296;14790.6302342438;14883.10701357922;14887.776683349543;14249.857501425267;14296.714065718419;14395.064320819114;14398.496052638107;14483.637909052359;14246.216458094905;14249.287535623385;14339.283035847957;14450.205238711971;14543.345549450089;11869.881301186877;11907;11953.402329883646;12000;12422.440990155645;11342.729007061922;11599.76800463969;11660.416979151178;11865;11949.64151075469 16:03:07 INFO - PID 19135 | __end_tp_report 16:03:07 INFO - PID 19135 | __start_cc_report 16:03:07 INFO - PID 19135 | _x_x_mozilla_cycle_collect,272 16:03:07 INFO - PID 19135 | __end_cc_report 16:03:07 INFO - PID 19135 | __startTimestamp1506294187692__endTimestamp 16:03:07 INFO - PID 19135 | 16:03:07 INFO - PID 19135 | ------- Summary: start ------- 16:03:07 INFO - PID 19135 | Number of tests: 6 16:03:07 INFO - PID 19135 | 16:03:07 INFO - PID 19135 | [#0] dojo.html Cycles:165 Average:6266.88 Median:6504.22 stddev:785.75 (12.1%) stddev-sans-first:748.75 16:03:07 INFO - PID 19135 | Values: 3134.4 3142.9 3149.4 3157.4 3163.9 6350.7 6351.9 6357.4 6407.7 6489.3 6389.7 6461.6 6481.3 6492.6 6504.2 5478.3 5767.3 5879.9 5923.6 5954.5 5794.8 5796.3 5858.5 5865.1 5906.7 5795.4 5862.8 5881.5 5885.2 5947.9 5791.7 5839.6 5847.1 5910.5 5930.5 5869.7 5911.6 5931.7 5939.8 5953.4 6323.0 6380.7 6416.9 6422.5 6449.9 6635.0 6738.6 6753.5 6838.4 6913.7 6912.2 6918.4 6923.2 6929.7 6931.9 6207.5 6296.3 6299.8 6408.6 6432.0 6942.4 7117.6 7133.1 7142.4 7143.7 6714.1 6714.3 6785.8 6795.2 6824.5 6697.5 6811.7 6841.5 6932.1 6934.1 6837.4 6837.9 6841.7 6849.3 6856.7 6704.1 6807.5 6892.0 6894.5 6902.8 5072.1 5145.3 5170.5 5243.0 5246.8 4513.8 4518.8 4526.7 4541.0 4624.5 5766.1 5799.6 5808.0 5813.8 5827.5 6776.9 6787.6 6793.9 6795.4 6874.4 5633.5 5708.3 5748.1 5800.3 5826.1 5913.2 5926.1 5931.7 5934.2 5935.6 6568.7 6640.8 6649.2 6663.0 6704.7 6818.9 6826.9 6832.5 6849.6 6952.4 6377.2 6422.0 6433.4 6446.8 6447.7 6718.6 6806.7 6810.2 6821.5 6821.8 6873.6 6883.3 6966.9 6995.7 6995.7 6612.5 6626.9 6675.0 6709.8 6715.2 6492.0 6613.4 6640.3 6725.4 6733.0 6489.6 6509.4 6511.8 6516.2 6516.5 6621.9 6624.6 6629.2 6629.2 6772.6 6504.1 6508.3 6556.7 6561.7 6565.7 16:03:07 INFO - PID 19135 | 16:03:07 INFO - PID 19135 | [#1] ext.html Cycles:180 Average:36954.99 Median:3559.98 stddev:51174.82 (1437.5%) stddev-sans-first:51246.65 16:03:07 INFO - PID 19135 | Values: 870.8 895.8 905.7 906.2 912.2 42528.8 43091.0 43110.6 43187.8 43310.0 38838.6 38901.2 39070.6 39179.6 41994.8 4351.5 4371.6 4376.7 4401.9 4807.9 7978.3 8048.9 8102.6 8103.6 8121.8 8075.5 8132.8 8133.6 8143.7 8147.5 8045.8 8058.3 8096.8 8109.6 8110.0 7226.4 7252.7 7301.2 7302.4 7305.2 38178.6 38192.8 38221.0 38412.4 38438.0 3552.8 3567.2 3579.4 3588.9 3592.8 30993.8 31231.0 31333.8 31334.8 31346.2 4972.4 5151.8 5193.4 5223.3 5243.1 183239.0 183261.0 184461.0 184861.0 185654.0 43061.6 43877.0 49868.5 50737.2 50913.5 52482.0 52556.2 52755.7 52777.0 52861.7 16235.0 16345.9 16400.4 16411.3 16423.5 13177.8 13332.9 13383.0 13388.9 13391.8 13899.2 13957.6 14038.7 14053.2 14205.2 5411.7 5538.4 5613.2 5618.7 5634.1 1010.3 1015.5 1031.1 1043.2 1052.6 23576.2 23699.2 23724.0 23806.7 23967.6 1107.5 1114.8 1127.3 1129.1 1142.4 12386.0 12501.6 12566.2 12571.1 12638.3 217021.0 218439.0 218516.0 219564.0 220862.0 54308.7 54351.0 54732.2 54788.7 54837.2 1466.9 1474.1 1490.0 1492.2 1506.0 22836.0 23029.3 23152.5 23249.7 23298.9 38639.2 38815.4 38881.8 38894.8 38896.8 186203.0 187260.0 187563.0 188409.0 189078.1 31188.0 31257.4 31318.4 35374.8 36016.6 42942.1 44487.3 44501.6 44740.6 44902.1 32739.3 32905.3 33062.0 33119.0 33757.5 32216.4 32310.0 32420.5 32810.0 33219.8 35018.3 36530.0 36630.5 36786.8 36923.3 31603.7 32153.4 32306.0 32370.7 32420.7 23678.4 23774.0 23957.1 23986.0 24217.9 16:03:07 INFO - PID 19135 | 16:03:07 INFO - PID 19135 | [#2] jquery.html Cycles:180 Average:33986.44 Median:22464.61 stddev:80754.72 (359.5%) stddev-sans-first:80942.28 16:03:07 INFO - PID 19135 | Values: 567.4 593.8 595.4 596.2 609.4 22094.7 23071.7 23098.7 23109.0 23155.7 22694.8 23997.2 24727.5 24821.8 24924.5 6587.7 6726.8 6737.6 6744.1 6789.1 6565.1 6569.9 6669.9 6678.1 6693.8 6610.7 6618.4 6623.6 6636.3 6657.8 6255.7 6614.1 6633.5 6640.3 6642.1 6051.9 6062.5 6095.4 6130.5 6131.6 27124.3 27681.6 27682.9 27694.7 27729.9 2070.9 2092.4 2094.7 2101.2 2103.6 17807.0 19656.6 19808.5 19815.2 19815.2 2369.8 2406.9 2450.7 2456.8 2471.3 119516.4 122806.4 125930.0 130204.0 136341.3 14371.9 14635.3 14641.3 14792.7 15025.0 22599.5 22610.0 22633.7 22635.0 22698.5 9838.5 9937.7 10016.5 10064.5 10121.5 9186.1 9260.5 9297.6 9302.0 9315.7 8881.5 8913.7 9067.1 9069.9 9086.5 2690.5 2736.9 2746.6 2755.7 2760.8 965.1 992.1 997.1 1001.1 1013.6 18825.4 18864.0 18956.8 19409.4 19501.6 1028.5 1053.8 1056.2 1071.0 1071.5 10539.7 10640.1 10728.4 10734.9 10978.2 463856.0 476766.0 484059.0 489179.0 489898.0 110058.0 111719.0 112418.0 113264.0 114810.4 1061.3 1147.2 1192.1 1228.9 1234.5 19492.2 19887.5 20167.7 20338.3 20363.5 57334.0 58806.7 59405.7 59983.0 60768.7 70177.6 71044.0 71278.0 71427.3 71824.6 14075.4 14407.9 14415.1 14425.6 14425.7 22079.4 22178.8 22249.0 22296.1 22329.7 16770.3 16992.8 17192.6 17193.4 17748.6 15929.4 16107.2 16153.8 16185.5 16582.3 18128.7 18233.8 18254.5 18319.8 18392.0 13809.6 13886.2 14014.0 14053.5 14065.2 17322.2 17438.6 17460.0 17472.4 17602.6 16:03:07 INFO - PID 19135 | 16:03:07 INFO - PID 19135 | [#3] mootools.html Cycles:180 Average:9562.23 Median:2746.97 stddev:6883.95 (250.6%) stddev-sans-first:6875.59 16:03:07 INFO - PID 19135 | Values: 1347.2 1373.5 1409.6 1425.9 1429.8 15140.2 15856.8 15862.3 15864.0 15869.4 15197.8 16269.8 16274.8 16328.1 16339.6 2754.5 2816.0 2823.4 2824.3 2828.9 2734.5 2768.4 2802.2 2808.9 2828.6 2813.0 2822.5 2843.2 2843.2 2846.7 2741.8 2791.1 2791.2 2804.2 2806.9 2714.1 2728.4 2744.6 2746.0 2747.9 14887.9 15159.2 15240.5 15241.8 15258.0 8081.6 8458.6 8468.3 8468.9 8472.7 5390.0 5511.1 5588.7 5588.9 5593.7 1916.1 1960.0 1987.8 2001.1 2004.0 27549.9 27627.6 27677.2 27754.3 27876.6 6874.6 7073.2 7318.9 7434.4 7438.2 18053.2 18132.6 18150.8 18156.7 18190.5 8044.0 8194.4 8198.8 8205.1 8207.7 7296.2 7437.7 7482.2 7485.6 7538.5 4786.7 5404.4 5551.7 5573.5 5624.0 1416.0 1579.4 1581.8 1601.1 1609.4 882.9 884.8 907.1 910.2 910.6 8954.4 8955.3 9028.2 9066.8 9138.4 995.6 1001.3 1003.2 1005.9 1027.2 4756.3 4787.9 5024.2 5433.4 5781.3 20748.0 22109.1 22967.7 22977.4 22980.4 21570.4 21758.8 22070.7 22350.9 22355.4 11806.0 11834.9 12026.4 12050.2 12066.2 8351.7 8387.2 8420.1 8450.5 8471.4 18648.9 18722.8 18965.3 19124.1 19191.2 19426.2 19508.1 19602.3 19666.2 19811.2 10762.7 10867.9 10870.6 11048.7 11221.6 12210.3 14051.0 14170.7 14176.5 14211.9 8908.4 9563.8 10713.0 10884.5 11023.9 11128.9 11241.7 11346.2 11361.7 11508.9 9724.6 9920.8 10015.6 10025.3 10053.8 7305.8 7347.3 7362.9 7371.3 7383.0 7395.7 7410.6 7441.4 7499.4 7626.7 16:03:07 INFO - PID 19135 | 16:03:07 INFO - PID 19135 | [#4] prototype.html Cycles:180 Average:5617.93 Median:6313.75 stddev:1560.83 (24.7%) stddev-sans-first:1517.64 16:03:07 INFO - PID 19135 | Values: 522.8 523.9 538.5 542.2 546.8 6329.6 6373.5 6412.9 6433.8 6520.4 6304.7 6322.8 6323.1 6352.7 6355.7 5278.5 5281.5 5302.6 5323.7 5323.9 4963.7 5238.4 5249.5 5343.3 5345.3 5028.0 5057.9 5059.2 5105.7 5137.6 5060.0 5071.7 5080.2 5100.4 5123.4 4561.0 4607.7 4610.3 4612.5 4616.3 6246.6 6246.9 6247.9 6267.2 6325.5 5775.7 5810.9 5818.5 5861.4 5888.0 6624.6 6630.2 6684.5 6688.6 6765.5 5009.8 5010.4 5019.8 5024.6 5048.3 6777.4 6841.4 6951.2 7121.6 7132.0 4959.7 5097.5 5123.5 5141.8 5168.6 5184.8 5186.6 5192.9 5237.5 5242.0 5725.1 5834.4 5838.3 5898.6 5904.4 6812.8 6815.6 6852.6 6866.2 6889.6 1782.6 1799.6 1815.1 1821.4 1834.6 1203.2 1228.1 1235.8 1254.4 1254.6 5663.8 5670.4 5687.8 5701.3 5743.6 6686.5 6878.4 6882.6 6918.9 6921.9 5745.1 5758.4 5776.6 5780.0 5805.6 3580.0 3594.5 3651.0 3653.0 3657.7 6150.5 6507.9 6513.4 6539.4 6568.3 6885.3 6914.6 6959.0 6989.2 7041.6 6388.9 6460.9 6470.9 6545.5 6565.2 6665.9 6800.5 6819.3 6849.0 6910.2 6766.2 6768.0 6790.2 6801.2 6881.2 6598.2 6629.0 6642.9 6656.1 6668.6 5086.3 5121.3 5141.6 5153.8 5164.3 6486.9 6670.1 6672.5 6722.6 6920.2 6513.7 6520.8 6610.0 6692.6 6714.5 6542.4 6638.1 6642.0 6654.0 6691.3 6549.6 6555.4 6575.3 6595.5 6600.5 6474.7 6583.6 6717.8 6742.8 6747.7 6399.2 6430.3 6439.1 6486.6 6560.8 16:03:07 INFO - PID 19135 | 16:03:07 INFO - PID 19135 | [#5] yui.html Cycles:180 Average:24539.45 Median:20553.79 stddev:35915.22 (174.7%) stddev-sans-first:35972.14 16:03:07 INFO - PID 19135 | Values: 908.0 926.9 934.4 945.4 948.6 19611.7 20541.8 20565.8 20583.0 20608.7 18718.8 19009.4 19104.8 19387.0 19548.0 954.3 973.1 975.0 975.1 978.1 993.3 994.2 994.8 994.9 995.8 1023.8 1062.4 1066.6 1067.0 1069.5 991.5 1051.7 1056.4 1056.5 1063.1 749.8 753.4 755.6 756.5 756.5 20218.8 20334.8 20570.0 20593.2 20595.2 21487.5 21865.8 22459.6 22649.4 22674.2 17564.5 18037.3 18111.5 18217.4 18288.0 3711.3 3760.9 3769.3 3771.4 3771.6 143160.0 143414.3 145392.0 146021.0 147778.0 17393.5 17478.9 17481.9 17485.9 17493.7 32074.8 33158.0 33303.8 33332.3 33409.7 8579.6 8748.3 8761.5 8958.2 8994.0 4101.4 4213.0 4223.3 4234.5 4241.8 5365.2 5394.6 5448.8 5463.4 5481.6 976.1 987.6 999.2 1007.3 1009.2 668.6 677.4 683.1 692.2 696.5 11678.8 11695.8 11845.3 11882.7 12209.0 621.8 630.1 639.5 639.6 639.7 5336.3 5358.4 5377.6 5430.1 5566.7 120268.0 121314.0 122217.0 123791.0 124924.0 104410.5 105590.0 108098.0 108475.0 110678.0 96028.0 96565.5 98819.0 99732.0 102147.5 10243.6 10261.8 10313.8 10347.4 10555.2 42829.1 43579.1 43612.3 44145.1 45238.5 55007.7 56555.0 56843.4 58069.4 59291.0 15534.5 15836.5 15844.8 15882.0 16061.8 15533.8 16941.4 17246.3 17332.5 17367.8 14634.2 14712.3 14790.6 14883.1 14887.8 14249.9 14296.7 14395.1 14398.5 14483.6 14246.2 14249.3 14339.3 14450.2 14543.3 11869.9 11907.0 11953.4 12000.0 12422.4 11342.7 11599.8 11660.4 11865.0 11949.6 16:03:07 INFO - PID 19135 | -------- Summary: end -------- 16:03:07 INFO - PID 19135 | 16:03:08 INFO - TEST-INFO | 19135: exit 0 16:03:08 INFO - TEST-OK | dromaeo_css | took 1108609ms 16:03:08 INFO - TEST-START | kraken 16:03:08 INFO - Initialising browser for kraken test... 16:03:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51742/getInfo.html -profile /tmp/tmpLA9TvC/profile 16:03:08 INFO - TEST-INFO | started process 19504 (/builds/slave/test/build/application/firefox/firefox http://localhost:51742/getInfo.html) 16:03:13 INFO - TEST-INFO | 19504: exit 0 16:03:13 INFO - Browser initialized. 16:03:13 INFO - Running cycle 1/1 for kraken test... 16:03:13 INFO - Using env: {'DISPLAY': ':0', 16:03:13 INFO - 'HOME': '/home/cltbld', 16:03:13 INFO - 'JSGC_DISABLE_POISONING': '1', 16:03:13 INFO - 'LANG': 'en_US.UTF-8', 16:03:13 INFO - 'LANGUAGE': 'en_US:en', 16:03:13 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:03:13 INFO - 'LOGNAME': 'cltbld', 16:03:13 INFO - 'MAIL': '/var/mail/cltbld', 16:03:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:03:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:03:13 INFO - 'MOZ_CRASHREPORTER': '1', 16:03:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:13 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:03:13 INFO - 'MOZ_NO_REMOTE': '1', 16:03:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:03:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:13 INFO - 'NO_EM_RESTART': '1', 16:03:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:13 INFO - 'PWD': '/builds/slave/test', 16:03:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:03:13 INFO - 'RUST_BACKTRACE': 'full', 16:03:13 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:03:13 INFO - 'SHELL': '/bin/bash', 16:03:13 INFO - 'SHLVL': '1', 16:03:13 INFO - 'STYLO_FORCE_DISABLED': '1', 16:03:13 INFO - 'TERM': 'linux', 16:03:13 INFO - 'TMOUT': '86400', 16:03:13 INFO - 'USER': 'cltbld', 16:03:13 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587', 16:03:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:13 INFO - '_': '/tools/buildbot/bin/python'} 16:03:13 INFO - TEST-INFO | started process 19736 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLA9TvC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:03:14 INFO - PID 19736 | 16:03:14 INFO - PID 19736 | (/builds/slave/test/build/application/firefox/firefox:19785): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:03:14 INFO - PID 19736 | 16:03:24 INFO - PID 19736 | RSS: Main: 152936448 16:03:24 INFO - PID 19736 | 16:03:27 INFO - PID 19736 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51742/tests/kraken/driver.html?testName=audio-beat-detection) 16:03:28 INFO - PID 19736 | RSS: Main: 160333824 16:03:28 INFO - PID 19736 | 16:03:30 INFO - PID 19736 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51742/tests/kraken/driver.html?testName=audio-dft) 16:03:31 INFO - PID 19736 | RSS: Main: 159801344 16:03:31 INFO - PID 19736 | 16:03:34 INFO - PID 19736 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51742/tests/kraken/driver.html?testName=audio-fft) 16:03:35 INFO - PID 19736 | RSS: Main: 156049408 16:03:35 INFO - PID 19736 | 16:03:37 INFO - PID 19736 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51742/tests/kraken/driver.html?testName=audio-oscillator) 16:03:37 INFO - PID 19736 | RSS: Main: 156590080 16:03:37 INFO - PID 19736 | 16:03:39 INFO - PID 19736 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51742/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:03:40 INFO - PID 19736 | RSS: Main: 156512256 16:03:40 INFO - PID 19736 | 16:03:43 INFO - PID 19736 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51742/tests/kraken/driver.html?testName=imaging-darkroom) 16:03:44 INFO - PID 19736 | RSS: Main: 159076352 16:03:44 INFO - PID 19736 | 16:03:47 INFO - PID 19736 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51742/tests/kraken/driver.html?testName=imaging-desaturate) 16:03:48 INFO - PID 19736 | RSS: Main: 159768576 16:03:48 INFO - PID 19736 | 16:03:51 INFO - PID 19736 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51742/tests/kraken/driver.html?testName=json-parse-financial) 16:03:52 INFO - PID 19736 | RSS: Main: 159363072 16:03:52 INFO - PID 19736 | 16:03:53 INFO - PID 19736 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51742/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:03:54 INFO - PID 19736 | RSS: Main: 159666176 16:03:54 INFO - PID 19736 | 16:03:55 INFO - PID 19736 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51742/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:03:56 INFO - PID 19736 | RSS: Main: 159543296 16:03:56 INFO - PID 19736 | 16:03:58 INFO - PID 19736 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51742/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:03:59 INFO - PID 19736 | RSS: Main: 156377088 16:03:59 INFO - PID 19736 | 16:04:01 INFO - PID 19736 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51742/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:04:02 INFO - PID 19736 | RSS: Main: 156377088 16:04:02 INFO - PID 19736 | 16:04:05 INFO - PID 19736 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51742/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:04:05 INFO - PID 19736 | RSS: Main: 156987392 16:04:05 INFO - PID 19736 | 16:04:07 INFO - PID 19736 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51742/tests/kraken/driver.html?testName=ai-astar) 16:04:08 INFO - PID 19736 | RSS: Main: 158175232 16:04:08 INFO - PID 19736 | 16:04:08 INFO - PID 19736 | __start_tp_report 16:04:08 INFO - PID 19736 | _x_x_mozilla_page_load 16:04:08 INFO - PID 19736 | _x_x_mozilla_page_load_details 16:04:08 INFO - PID 19736 | |i|pagename|runs| 16:04:08 INFO - PID 19736 | |0;ai-astar;107;109;106;107;113;106;108;107;107;109 16:04:08 INFO - PID 19736 | |1;audio-beat-detection;121;117;117;116;115;145;119;119;116;120 16:04:08 INFO - PID 19736 | |2;audio-dft;165;163;163;165;161;163;163;164;165;171 16:04:08 INFO - PID 19736 | |3;audio-fft;76;74;76;73;73;74;75;75;73;76 16:04:08 INFO - PID 19736 | |4;audio-oscillator;78;80;79;80;80;79;79;81;79;77 16:04:08 INFO - PID 19736 | |5;imaging-gaussian-blur;114;114;114;114;114;113;113;114;114;113 16:04:08 INFO - PID 19736 | |6;imaging-darkroom;156;147;148;148;149;149;149;148;147;146 16:04:08 INFO - PID 19736 | |7;imaging-desaturate;94;94;96;94;94;94;95;94;95;94 16:04:08 INFO - PID 19736 | |8;json-parse-financial;57;56;56;59;54;53;54;54;53;54 16:04:08 INFO - PID 19736 | |9;json-stringify-tinderbox;39;39;39;38;38;39;39;38;38;38 16:04:08 INFO - PID 19736 | |10;stanford-crypto-aes;74;72;73;74;75;74;75;73;81;79 16:04:08 INFO - PID 19736 | |11;stanford-crypto-ccm;110;108;117;116;113;119;117;114;115;108 16:04:08 INFO - PID 19736 | |12;stanford-crypto-pbkdf2;167;165;170;163;170;162;172;171;173;169 16:04:08 INFO - PID 19736 | |13;stanford-crypto-sha256-iterative;69;68;66;70;66;63;65;70;68;70 16:04:08 INFO - PID 19736 | __end_tp_report 16:04:08 INFO - PID 19736 | __start_cc_report 16:04:08 INFO - PID 19736 | _x_x_mozilla_cycle_collect,715 16:04:08 INFO - PID 19736 | __end_cc_report 16:04:08 INFO - PID 19736 | __startTimestamp1506294248028__endTimestamp 16:04:08 INFO - PID 19736 | 16:04:08 INFO - PID 19736 | ------- Summary: start ------- 16:04:08 INFO - PID 19736 | Number of tests: 14 16:04:08 INFO - PID 19736 | 16:04:08 INFO - PID 19736 | [#0] ai-astar Cycles:10 Average:107.90 Median:107.50 stddev:2.08 (1.9%) stddev-sans-first:2.18 16:04:08 INFO - PID 19736 | Values: 107.0 109.0 106.0 107.0 113.0 106.0 108.0 107.0 107.0 109.0 16:04:08 INFO - PID 19736 | 16:04:08 INFO - PID 19736 | [#1] audio-beat-detection Cycles:10 Average:120.50 Median:119.00 stddev:8.82 (7.4%) stddev-sans-first:9.36 16:04:08 INFO - PID 19736 | Values: 121.0 117.0 117.0 116.0 115.0 145.0 119.0 119.0 116.0 120.0 16:04:08 INFO - PID 19736 | 16:04:08 INFO - PID 19736 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.50 stddev:2.67 (1.6%) stddev-sans-first:2.82 16:04:08 INFO - PID 19736 | Values: 165.0 163.0 163.0 165.0 161.0 163.0 163.0 164.0 165.0 171.0 16:04:08 INFO - PID 19736 | 16:04:08 INFO - PID 19736 | [#3] audio-fft Cycles:10 Average:74.50 Median:75.00 stddev:1.27 (1.7%) stddev-sans-first:1.22 16:04:08 INFO - PID 19736 | Values: 76.0 74.0 76.0 73.0 73.0 74.0 75.0 75.0 73.0 76.0 16:04:08 INFO - PID 19736 | 16:04:08 INFO - PID 19736 | [#4] audio-oscillator Cycles:10 Average:79.20 Median:79.50 stddev:1.14 (1.4%) stddev-sans-first:1.12 16:04:08 INFO - PID 19736 | Values: 78.0 80.0 79.0 80.0 80.0 79.0 79.0 81.0 79.0 77.0 16:04:08 INFO - PID 19736 | 16:04:08 INFO - PID 19736 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 16:04:08 INFO - PID 19736 | Values: 114.0 114.0 114.0 114.0 114.0 113.0 113.0 114.0 114.0 113.0 16:04:08 INFO - PID 19736 | 16:04:08 INFO - PID 19736 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:148.50 stddev:2.75 (1.9%) stddev-sans-first:1.05 16:04:08 INFO - PID 19736 | Values: 156.0 147.0 148.0 148.0 149.0 149.0 149.0 148.0 147.0 146.0 16:04:08 INFO - PID 19736 | 16:04:08 INFO - PID 19736 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 16:04:08 INFO - PID 19736 | Values: 94.0 94.0 96.0 94.0 94.0 94.0 95.0 94.0 95.0 94.0 16:04:08 INFO - PID 19736 | 16:04:08 INFO - PID 19736 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:1.94 (3.5%) stddev-sans-first:1.92 16:04:08 INFO - PID 19736 | Values: 57.0 56.0 56.0 59.0 54.0 53.0 54.0 54.0 53.0 54.0 16:04:08 INFO - PID 19736 | 16:04:08 INFO - PID 19736 | [#9] json-stringify-tinderbox Cycles:10 Average:38.50 Median:39.00 stddev:0.53 (1.4%) stddev-sans-first:0.53 16:04:08 INFO - PID 19736 | Values: 39.0 39.0 39.0 38.0 38.0 39.0 39.0 38.0 38.0 38.0 16:04:08 INFO - PID 19736 | 16:04:08 INFO - PID 19736 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:74.50 stddev:2.83 (3.8%) stddev-sans-first:2.98 16:04:08 INFO - PID 19736 | Values: 74.0 72.0 73.0 74.0 75.0 74.0 75.0 73.0 81.0 79.0 16:04:08 INFO - PID 19736 | 16:04:08 INFO - PID 19736 | [#11] stanford-crypto-ccm Cycles:10 Average:113.70 Median:115.50 stddev:3.89 (3.4%) stddev-sans-first:3.89 16:04:08 INFO - PID 19736 | Values: 110.0 108.0 117.0 116.0 113.0 119.0 117.0 114.0 115.0 108.0 16:04:08 INFO - PID 19736 | 16:04:08 INFO - PID 19736 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.20 Median:170.00 stddev:3.79 (2.2%) stddev-sans-first:4.00 16:04:08 INFO - PID 19736 | Values: 167.0 165.0 170.0 163.0 170.0 162.0 172.0 171.0 173.0 169.0 16:04:08 INFO - PID 19736 | 16:04:08 INFO - PID 19736 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.50 stddev:2.42 (3.5%) stddev-sans-first:2.50 16:04:08 INFO - PID 19736 | Values: 69.0 68.0 66.0 70.0 66.0 63.0 65.0 70.0 68.0 70.0 16:04:08 INFO - PID 19736 | -------- Summary: end -------- 16:04:08 INFO - PID 19736 | 16:04:08 INFO - PID 19736 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:04:08 INFO - TEST-INFO | 19736: exit 0 16:04:08 INFO - TEST-OK | kraken | took 60430ms 16:04:08 INFO - SUITE-END | took 1169s 16:04:09 INFO - Completed test suite (00:19:29) 16:04:09 INFO - javascript benchmark 16:04:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8564.050663373775, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3134.43580155572, 3142.921426964327, 3149.385869755398, 3157.431662300785, 3163.8576264068115, 6350.650714210717, 6351.936480635192, 6357.396047375503, 6407.711652975616, 6489.31862154474, 6389.744410223586, 6461.612303261808, 6481.31946145655, 6492.6429046402545, 6504.2194936607675, 5478.287822583068, 5767.250257466544, 5879.911801322984, 5923.5853490255695, 5954.4640982311585, 5794.797182098628, 5796.275465566804, 5858.53131749459, 5865.120231965197, 5906.734196961147, 5795.449432303924, 5862.824115276549, 5881.470667639912, 5885.176075349433, 5947.910781338283, 5791.739371728282, 5839.562032847553, 5847.093700476433, 5910.497607703351, 5930.525557955353, 5869.677167755772, 5911.556633252523, 5931.673757943311, 5939.762409503614, 5953.404659534055, 6323.0, 6380.744770209186, 6416.903746443807, 6422.4862011039, 6449.871002579969, 6634.966825165843, 6738.629375384352, 6753.493487988371, 6838.418734407582, 6913.654317284166, 6912.239653638146, 6918.411934985532, 6923.169219693618, 6929.72281108755, 6931.896021559681, 6207.4723648489935, 6296.338884417116, 6299.811005669837, 6408.583442076297, 6432.0, 6942.444604431634, 7117.6085315308155, 7133.108361454818, 7142.4286057115305, 7143.678534465961, 6714.127163468718, 6714.328567143247, 6785.796426107225, 6795.150606174228, 6824.454043676494, 6697.497687673444, 6811.693473793592, 6841.486888483384, 6932.0988271524375, 6934.098567186234, 6837.38463538274, 6837.931620683729, 6841.657917104224, 6849.280825513349, 6856.657167141623, 6704.128463299739, 6807.4894382921475, 6892.035115083892, 6894.482913781487, 6902.792916212522, 5072.112380333427, 5145.279660847485, 5170.5346518813485, 5242.951409718072, 5246.7638956247065, 4513.796879140446, 4518.841840535565, 4526.660500462479, 4541.046380260116, 4624.5144259852905, 5766.077427611646, 5799.594028417971, 5808.0, 5813.82558523245, 5827.533797296206, 6776.9322306777285, 6787.5588086774205, 6793.864122717518, 6795.354441328066, 6874.381305682413, 5633.549316054706, 5708.343540492897, 5748.137779333133, 5800.303963524404, 5826.096954971986, 5913.172155898178, 5926.111083337534, 5931.73307201177, 5934.228550288522, 5935.554833387513, 6568.704408301543, 6640.800775976729, 6649.168853893263, 6662.966685166543, 6704.698288577026, 6818.93181068183, 6826.93173068263, 6832.521723479408, 6849.554778939353, 6952.409045231212, 6377.202849643794, 6422.0, 6433.388828061326, 6446.8388290293115, 6447.677616119082, 6718.630475323708, 6806.659667016728, 6810.182778066664, 6821.454283657196, 6821.829454263683, 6873.621950792554, 6883.346082122191, 6966.930330696831, 6995.650217489004, 6995.685194166173, 6612.537122401386, 6626.900596491153, 6674.966625166843, 6709.832254193684, 6715.227748808949, 6491.967540162269, 6613.43785778195, 6640.335966403321, 6725.361090696376, 6733.023711561698, 6489.643069631215, 6509.446697030616, 6511.772087976898, 6516.152900122954, 6516.543841931019, 6621.900671489835, 6624.6025238485845, 6629.171353580802, 6629.237637671729, 6772.627505487246, 6504.056911747864, 6508.316626754123, 6556.672166391566, 6561.737530498726, 6565.737370505318], "value": 6204.283055604445, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [870.7910101575621, 895.753667741371, 905.6965916417997, 906.1572737354262, 912.2063804490094, 42528.787356063214, 43091.0, 43110.56889431105, 43187.78406107973, 43310.0, 38838.61161388392, 38901.221975560475, 39070.60929390705, 39179.60820391795, 41994.79002604983, 4351.543087975764, 4371.606555410012, 4376.737395756249, 4401.9119617607785, 4807.855764327067, 7978.281954624083, 8048.919510804905, 8102.635381407851, 8103.554304513249, 8121.796955076111, 8075.475094118893, 8132.837343253132, 8133.633986470623, 8143.714969976052, 8147.511149331059, 8045.798855028613, 8058.274755272025, 8096.838063238732, 8109.594520273963, 8110.0, 7226.3857572106435, 7252.673629686677, 7301.1603665578605, 7302.415806735502, 7305.159906610755, 38178.61821381778, 38192.80903595492, 38221.0, 38412.42381364282, 38438.0, 3552.786832790041, 3567.1795487037866, 3579.4451859961746, 3588.8923332300074, 3592.8203589820405, 30993.845030774926, 31231.0, 31333.843330783428, 31334.843325783455, 31346.21634459134, 4972.378452693413, 5151.8196863109615, 5193.402758682762, 5223.347081614798, 5243.134882744343, 183239.0, 183261.0, 184460.99999999866, 184861.0, 185654.0, 43061.569384306385, 43877.0, 49868.50131498711, 50737.23894141591, 50913.49086509162, 52482.0, 52556.21165682518, 52755.73622131865, 52777.0, 52861.735691322065, 16235.0, 16345.918270408809, 16400.425985090464, 16411.343546258016, 16423.507294781175, 13177.802332965013, 13332.866671333357, 13383.0, 13388.866111338762, 13391.799123013163, 13899.16605003703, 13957.58127256184, 14038.71922561543, 14053.22707251111, 14205.21871297068, 5411.675299482044, 5538.418466061086, 5613.214150019001, 5618.719064046782, 5634.098544232903, 1010.2574607663508, 1015.4973288222377, 1031.0514326819343, 1043.2280112716535, 1052.6157952347337, 23576.17483388073, 23699.170529031748, 23724.0, 23806.690632015405, 23967.640485392734, 1107.5403707461314, 1114.8272017837248, 1127.2841745491671, 1129.1418521923397, 1142.3831131189231, 12386.0, 12501.56244531437, 12566.183198092094, 12571.120021598583, 12638.304893230777, 217021.0, 218439.0, 218516.0, 219564.0, 220862.0, 54308.72845635826, 54351.0, 54732.179017314775, 54788.726056369465, 54837.1774423384, 1466.911985280865, 1474.122896876357, 1489.9925500372428, 1492.1867582167745, 1506.0, 22836.0, 23029.309120726404, 23152.536949260582, 23249.651255230845, 23298.883505582362, 38639.22721545609, 38815.417768734056, 38881.80559097186, 38894.80552597219, 38896.80551597224, 186203.0, 187260.0, 187563.0, 188409.0, 189078.10921890606, 31188.0, 31257.37485250328, 31318.373632527677, 35374.823125884206, 36016.63983360238, 42942.141157176055, 44487.332690009025, 44501.554984449744, 44740.55259447364, 44902.10195796131, 32739.34521309513, 32905.34189316152, 33062.0, 33119.0, 33757.49363759496, 32216.355672885944, 32310.0, 32420.513692294164, 32810.0, 33219.833900830345, 35018.299634007686, 36530.0, 36630.45054324134, 36786.81606592057, 36923.26153476969, 31603.683963160074, 32153.35693286168, 32306.0, 32370.676293236767, 32420.675793241764, 23678.408039799142, 23774.0, 23957.10423730049, 23986.0, 24217.878910605334], "value": 17028.639159851835, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.3532173322413, 593.7743657410183, 595.359988012886, 596.2010905386782, 609.4180058044568, 22094.668579971294, 23071.653925191134, 23098.65352019719, 23109.0, 23155.652665209993, 22694.773052269473, 23997.160099396526, 24727.505449890992, 24821.75178248217, 24924.50150996979, 6587.670616469181, 6726.764563240287, 6737.629430381327, 6744.123263975676, 6789.083473731057, 6565.1465309509695, 6569.93430065698, 6669.866602667944, 6678.098456708331, 6693.765718199864, 6610.669466526679, 6618.404343609074, 6623.6025838449605, 6636.270010298863, 6657.800265992028, 6255.749770009194, 6614.0740296358545, 6633.4693224541925, 6640.335966403321, 6642.136522252101, 6051.909221361683, 6062.514998800086, 6095.390460953913, 6130.478909292716, 6131.570790044699, 27124.321891952663, 27681.584776228374, 27682.861585691942, 27694.723052769416, 27729.861350693318, 2070.927517536879, 2092.4036649554955, 2094.7381577302835, 2101.1805395895612, 2103.568768402474, 17807.0, 19656.606867862563, 19808.504787380287, 19815.207391704316, 19815.207391704316, 2369.845960012594, 2406.927792166238, 2450.6936632920883, 2456.754324567529, 2471.258622413287, 119516.40241798823, 122806.38596807048, 125930.0, 130204.0, 136341.3182934079, 14371.866669927245, 14635.268236588128, 14641.291351135826, 14792.704145917021, 15025.0, 22599.54800903973, 22610.0, 22633.660495092587, 22635.0, 22698.546029079327, 9838.508074596384, 9937.65218217359, 10016.49917504122, 10064.547095380725, 10121.493925303705, 9186.08139186076, 9260.536973151315, 9297.581608827619, 9301.953490232505, 9315.72052838416, 8881.511516866634, 8913.732588022369, 9067.138621830916, 9069.863952040725, 9086.500242486727, 2690.5157071727276, 2736.931576710558, 2746.5605503119405, 2755.6830964438946, 2760.751532362097, 965.1362030982372, 992.1219720547223, 997.1026076531035, 1001.0540039662449, 1013.5844303835539, 18825.435236942914, 18864.0, 18956.81043189578, 19409.4177174685, 19501.609967800847, 1028.4651980969854, 1053.752368193474, 1056.2025670618634, 1070.9758556328545, 1071.4535586850761, 10539.683809485728, 10640.148788096934, 10728.409937453358, 10734.892651073545, 10978.231523793258, 463856.0, 476766.0, 484059.0, 489179.0, 489898.0, 110058.0, 111719.0, 112418.0, 113264.0, 114810.42594786972, 1061.3366645846345, 1147.2485521983115, 1192.099964526794, 1228.9446974885973, 1234.450669452085, 19492.220311187393, 19887.502812429804, 20167.69748453745, 20338.288159914333, 20363.49091272671, 57334.0, 58806.70596647161, 59405.70297148487, 59983.0, 60768.696156518934, 70177.64911175412, 71044.0, 71278.0, 71427.28572714415, 71824.64087679528, 14075.366608502438, 14407.855921440652, 14415.063020903608, 14425.567232983027, 14425.711485770436, 22079.44801379914, 22178.778212218316, 22248.998795054584, 22296.10815567359, 22329.665055024514, 16770.32918683239, 16992.830071699125, 17192.570185744957, 17193.398231061852, 17748.556286092433, 15929.442469513511, 16107.194640268173, 16153.75769363484, 16185.514434566981, 16582.25379857885, 18128.728069078712, 18233.817661823214, 18254.543636409195, 18319.81680183181, 18392.0, 13809.585712428643, 13886.166829990232, 14014.0, 14053.508127215498, 14065.156090634595, 17322.22050007778, 17438.564035899202, 17460.0, 17472.38846640412, 17602.647947041245], "value": 11861.291212774351, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.1580262336042, 1373.5329987804143, 1409.5536413469065, 1425.8716715495602, 1429.8284205895288, 15140.167290799016, 15856.762148567781, 15862.286197121142, 15864.048157110552, 15869.444569440071, 15197.848021519809, 16269.755953660704, 16274.75587866183, 16328.101954392503, 16339.59151021225, 2754.476649436601, 2815.9859200704072, 2823.449427361665, 2824.265690920355, 2828.9434211315865, 2734.4531093781225, 2768.3771151490955, 2802.2153796936786, 2808.873600687974, 2828.5898544711004, 2812.9578056329174, 2822.5483922572394, 2843.2323272716353, 2843.2323272716353, 2846.7437930586243, 2741.7806575473915, 2791.148699646617, 2791.1626512046405, 2804.2008027712004, 2806.9438611227865, 2714.1450443110357, 2728.386113124551, 2744.6157537944705, 2745.9862700686567, 2747.9450410991867, 14887.925560372238, 15159.24203789806, 15240.466583669519, 15241.847581524155, 15258.0, 8081.6363263653275, 8458.619362128657, 8468.280196183332, 8468.872966905501, 8472.703455379033, 5389.973050134763, 5511.145772405283, 5588.748506317225, 5588.91616625751, 5593.664380137205, 1916.1473144450724, 1959.9902000489906, 1987.831034362081, 2001.1495114576246, 2003.9899800500905, 27549.86225068882, 27627.585586216224, 27677.169684909484, 27754.306142346602, 27876.581851272043, 6874.553154044971, 7073.221945585981, 7318.853622927511, 7434.36807871337, 7438.218987006395, 18053.187606557738, 18132.637347253243, 18150.81849181518, 18156.727649085275, 18190.5452363692, 8043.954285942907, 8194.426390152752, 8198.8360232795, 8205.138460461685, 8207.671693132328, 7296.197418283985, 7437.661220980275, 7482.176960534337, 7485.588292643848, 7538.509996850187, 4786.659735274129, 5404.432534583891, 5551.72241387929, 5573.470520300565, 5624.0, 1415.9929200354138, 1579.447193482272, 1581.8022747156606, 1601.119384338609, 1609.3643011010586, 882.9470231786113, 884.823035392924, 907.1065000974036, 910.1762904571374, 910.5538286239695, 8954.373193876367, 8955.328350373748, 9028.232600228923, 9066.818663626691, 9138.406003609743, 995.5967833027636, 1001.3140998416109, 1003.2375394700081, 1005.9245556583139, 1027.1782573940818, 4756.310335001405, 4787.928181077286, 5024.246363045572, 5433.402325744165, 5781.277340332458, 20748.0, 22109.115635374405, 22967.655485167736, 22977.425564360692, 22980.4254893629, 21570.35288941334, 21758.78241217599, 22070.66893996591, 22350.888245558668, 22355.44111397228, 11806.0, 11834.940825295991, 12026.398680066137, 12050.156489045683, 12066.215695979734, 8351.749447516584, 8387.203215694499, 8420.073791882765, 8450.535220562928, 8471.364647651328, 18648.906755466134, 18722.81277187265, 18965.33621323247, 19124.139413726138, 19191.232350705814, 19426.2229510818, 19508.122134503697, 19602.313919012766, 19666.21335146578, 19811.20755169777, 10762.73093172677, 10867.945660271647, 10870.61952831647, 11048.668539943814, 11221.551137954717, 12210.26738395699, 14051.0, 14170.716585668022, 14176.503822366167, 14211.857881421467, 8908.420952638058, 9563.808723825345, 10713.0, 10884.455777211266, 11023.944880275547, 11128.888711112786, 11241.71895702614, 11346.205765596329, 11361.659150225507, 11508.942455288005, 9724.562394692115, 9920.801583968425, 10015.649452269136, 10025.348352357074, 10053.849192262269, 7305.817354565966, 7347.26527347261, 7362.852742945218, 7371.299726525972, 7383.040204773345, 7395.667194976131, 7410.62946852666, 7441.4046876248685, 7499.400047996256, 7626.656800443882], "value": 6837.971950716801, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [522.8457605006523, 523.9004589128067, 538.501885755676, 542.2327406719489, 546.8004178474855, 6329.556931014825, 6373.458256048236, 6412.909805333093, 6433.839154021146, 6520.380563846427, 6304.684765761716, 6322.810315690525, 6323.083152942832, 6352.714127864246, 6355.68221588921, 5278.524932756051, 5281.471852814726, 5302.6023048271345, 5323.680579165262, 5323.946760532383, 4963.726995015273, 5238.371395432553, 5249.4750524947585, 5343.251944727741, 5345.251664766916, 5027.974860125712, 5057.949420505803, 5059.241113832918, 5105.719185444799, 5137.588992880561, 5059.974700126494, 5071.746412679351, 5080.187170052793, 5100.449775112444, 5123.385193776733, 4560.95439045612, 4607.677462577621, 4610.2623580227, 4612.5156858530045, 4616.28447590624, 6246.6252024878195, 6246.906296405557, 6247.9062814057825, 6267.153934218868, 6325.462335701471, 5775.736708759538, 5810.912836307417, 5818.505427038707, 5861.384554621789, 5888.02847530157, 6624.635645039521, 6630.237522684856, 6684.465242780566, 6688.598684078922, 6765.458763298924, 5009.849704508834, 5010.423801262865, 5019.824306149304, 5024.572911302544, 5048.268001139851, 6777.423918966893, 6841.350071743226, 6951.165860096719, 7121.572705637678, 7131.964340178318, 4959.652824302264, 5097.541221290102, 5123.5132662397755, 5141.794328226903, 5168.586513078944, 5184.818531351385, 5186.611004174702, 5192.870178245498, 5237.450067742832, 5242.0, 5725.141228815628, 5834.416558344132, 5838.328592211865, 5898.587098903122, 5904.40581043116, 6812.8296792579595, 6815.591064536144, 6852.554583952027, 6866.210385805596, 6889.621070841152, 1782.5721826761744, 1799.561594040083, 1815.1378095404577, 1821.3807305516189, 1834.596388794463, 1203.2179083595734, 1228.1157566552067, 1235.8022716365338, 1254.3540076860425, 1254.5546331052528, 5663.801766938137, 5670.404607516151, 5687.8009269676195, 5701.315842098975, 5743.597948143673, 6686.531942764057, 6878.38094571491, 6882.621455819878, 6918.861622767517, 6921.861562768717, 5745.13822926556, 5758.395368486333, 5776.56675749312, 5780.0, 5805.622634528742, 3579.964200358015, 3594.4967704521387, 3651.0, 3652.9634703653155, 3657.74395792292, 6150.477209437158, 6507.8698426031215, 6513.381228783258, 6539.444147247442, 6568.310327415648, 6885.277045910208, 6914.585124892523, 6958.965205174043, 6989.196242432084, 7041.612711300928, 6388.93611063902, 6460.8707825842275, 6470.870582588416, 6545.476361891133, 6565.24499682533, 6665.933340666531, 6800.5239633227175, 6819.283975182534, 6848.9657551711925, 6910.20532638753, 6766.221884483348, 6767.966160169168, 6790.1851777785005, 6801.18385793708, 6881.208661004049, 6598.208215014037, 6629.005649152473, 6642.900356494753, 6656.134702488645, 6668.566543174678, 5086.253423151456, 5121.257417674342, 5141.614378921521, 5153.845384638467, 5164.302819119371, 6486.9351306488215, 6670.132882725215, 6672.466202703675, 6722.5714885407815, 6920.169579650273, 6513.743128435782, 6520.836979075561, 6610.0, 6692.59844409337, 6714.496412768965, 6542.443892269211, 6638.137042184679, 6642.0, 6654.0, 6691.2639609643875, 6549.574277671936, 6555.4427873631275, 6575.342465753578, 6595.472362210916, 6600.504962127764, 6474.733843154858, 6583.63789991555, 6717.757214915257, 6742.797716068526, 6747.696353663999, 6399.200099987502, 6430.2605200400685, 6439.098526206429, 6486.578372405778, 6560.8359791005605], "value": 5160.447218079792, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [907.9682211122604, 926.9490178040207, 934.4113208678532, 945.3618807305068, 948.6300342866281, 19611.705824412627, 20541.794582054175, 20565.794342056575, 20583.0, 20608.69086963693, 18718.812811871878, 19009.429717108473, 19104.808951910476, 19387.0, 19548.0, 954.3415043619898, 973.0512750068697, 974.9805003899918, 975.1126474907835, 978.0512902484578, 993.3295025857553, 994.24934174698, 994.796066806303, 994.8656931314252, 995.810795948771, 1023.805476959379, 1062.3572738493178, 1066.6426747039711, 1067.023673338894, 1069.5080263078994, 991.4596544883057, 1051.7265510967165, 1056.4242487844144, 1056.4770438632888, 1063.0910571461366, 749.7638243953137, 753.3784627682185, 755.5542230084277, 756.4893696754668, 756.4893696754724, 20218.797812021985, 20334.796652033438, 20570.0, 20593.176272949066, 20595.176192952265, 21487.462813429633, 21865.781342186532, 22459.55080898389, 22649.433764155863, 22674.206402775824, 17564.473065808048, 18037.27850885963, 18111.547211319692, 18217.362392316205, 18288.0, 3711.257748450321, 3760.9435858462143, 3769.321522126016, 3771.41543060826, 3771.641694039062, 143160.0, 143414.2829285847, 145392.0, 146020.99999999892, 147778.0, 17393.478195654152, 17478.91260543689, 17481.912590436965, 17485.912570437322, 17493.7375939361, 32074.83962580172, 33158.0, 33303.83348083244, 33332.3333533328, 33409.66590334114, 8579.613917373734, 8748.300135989106, 8761.474311541328, 8958.193762561401, 8994.0, 4101.384792281122, 4212.978935105305, 4223.345381465878, 4234.470691163605, 4241.830326786894, 5365.195220716846, 5394.568434525228, 5448.754806033738, 5463.3717122530625, 5481.561475081984, 976.1312431935582, 987.5704068730125, 999.2256001598673, 1007.325092188221, 1009.152312057875, 668.5854770042507, 677.4478799778165, 683.1221879884424, 692.2350802363316, 696.5368030259821, 11678.76642467146, 11695.824562631567, 11845.348505832262, 11882.702932426586, 12209.023278137727, 621.7948077134535, 630.0926665601519, 639.4532674563275, 639.6354078175489, 639.6737663791407, 5336.306280183629, 5358.356997160366, 5377.623566350318, 5430.13117901134, 5566.721663916788, 120268.0, 121314.0, 122217.0, 123791.0, 124924.0, 104410.47794761129, 105590.0, 108098.0, 108475.0, 110678.0, 96028.0, 96565.51717241369, 98819.0, 99732.0, 102147.48926255469, 10243.641472548425, 10261.794764104825, 10313.793724125626, 10347.447882817336, 10555.15558755313, 42829.14341713086, 43579.12841743084, 43612.34581481344, 44145.11709765851, 45238.54761452475, 55007.72496137654, 56555.0, 56843.431565683815, 58069.419305806405, 59291.0, 15534.456294029655, 15836.52490425289, 15844.841551584337, 15882.0, 16061.759073613672, 15533.84466155324, 16941.407050753165, 17246.310147593955, 17332.480025599252, 17367.826321737128, 14634.195119268117, 14712.337944792296, 14790.6302342438, 14883.10701357922, 14887.776683349543, 14249.857501425267, 14296.714065718419, 14395.064320819114, 14398.496052638107, 14483.637909052359, 14246.216458094905, 14249.287535623385, 14339.283035847957, 14450.205238711971, 14543.345549450089, 11869.881301186877, 11907.0, 11953.402329883646, 12000.0, 12422.440990155645, 11342.729007061922, 11599.76800463969, 11660.416979151178, 11865.0, 11949.64151075469], "value": 8921.399814662214, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1421.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 109.0, 106.0, 107.0, 113.0, 106.0, 108.0, 107.0, 107.0, 109.0], "value": 107.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 117.0, 117.0, 116.0, 115.0, 145.0, 119.0, 119.0, 116.0, 120.0], "value": 120.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 163.0, 165.0, 161.0, 163.0, 163.0, 164.0, 165.0, 171.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 73.0, 73.0, 74.0, 75.0, 75.0, 73.0, 76.0], "value": 74.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 79.0, 80.0, 80.0, 79.0, 79.0, 81.0, 79.0, 77.0], "value": 79.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 114.0, 114.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 147.0, 148.0, 148.0, 149.0, 149.0, 149.0, 148.0, 147.0, 146.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 96.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 59.0, 54.0, 53.0, 54.0, 54.0, 53.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 39.0, 38.0, 38.0, 39.0, 39.0, 38.0, 38.0, 38.0], "value": 38.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 73.0, 74.0, 75.0, 74.0, 75.0, 73.0, 81.0, 79.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 108.0, 117.0, 116.0, 113.0, 119.0, 117.0, 114.0, 115.0, 108.0], "value": 113.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 170.0, 163.0, 170.0, 162.0, 172.0, 171.0, 173.0, 169.0], "value": 168.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 66.0, 70.0, 66.0, 63.0, 65.0, 70.0, 68.0, 70.0], "value": 67.5, "unit": "score"}]}]} 16:04:09 INFO - Return code: 0 16:04:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:04:09 INFO - # TBPL SUCCESS # 16:04:09 INFO - Running post-action listener: _package_coverage_data 16:04:09 INFO - Running post-action listener: _resource_record_post_action 16:04:09 INFO - [mozharness: 2017-09-24 23:04:09.318345Z] Finished run-tests step (success) 16:04:09 INFO - Running post-run listener: _resource_record_post_run 16:04:09 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 346050560; Read time: 12; Write time: 203028 16:04:09 INFO - TinderboxPrint: CPU usage
13.1% 16:04:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:04:09 INFO - TinderboxPrint: I/O write bytes / time
346,050,560 / 203,028 16:04:09 INFO - TinderboxPrint: CPU idle
8,229.9 (86.9%) 16:04:09 INFO - TinderboxPrint: CPU user
1,193.9 (12.6%) 16:04:09 INFO - TinderboxPrint: Swap in / out
0 / 0 16:04:09 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 18997248; Read time: 0; Write time: 3240 16:04:09 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:04:09 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 327053312; Read time: 0; Write time: 199788 16:04:09 INFO - Running post-run listener: _upload_blobber_files 16:04:09 INFO - Blob upload gear active. 16:04:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:04:09 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 16:04:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:04:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:04:10 INFO - (blobuploader) - INFO - Open directory for files ... 16:04:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 16:04:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:04:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:04:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 16:04:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:04:11 INFO - (blobuploader) - INFO - Done attempting. 16:04:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:04:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:04:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:04:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:04:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:04:14 INFO - (blobuploader) - INFO - Done attempting. 16:04:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:04:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:04:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:04:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:04:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:04:15 INFO - (blobuploader) - INFO - Done attempting. 16:04:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 16:04:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:04:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:04:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 16:04:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:04:16 INFO - (blobuploader) - INFO - Done attempting. 16:04:16 INFO - (blobuploader) - INFO - Iteration through files over. 16:04:16 INFO - Return code: 0 16:04:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:04:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:04:16 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35adea3da159e9b754d8f4804987a7aed6cada2962ebf9b5ec77317fec4b3db5afde7c42e6781539070f7144394aea9ac5a3501335646dd2e27f045e97a6e9d2", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/68baa95a20d0a05db6f9c391960ce6b74320cfbf3f51406179ba944614e742238f5c95f7e88b16335b181ab24e80deb069c81ef00301528cf7f22f5ebe800f1a", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6237c3e751ef85417641c8a693439855454d46d271e40e3fbc2baf298b26be185acc53a2951b8ad748af54a0072f9021f9b417b4d427d3729c97bdf3985bbeb0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c19b910b0acdb015e10a8ee884afe5251650bb75910813864f0c8f34e2e5dc37d9a9fdf1f26a7872685e606831f1c442e60ab60050b548b525dcc14fc1413cb2"} 16:04:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:04:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:04:16 INFO - Contents: 16:04:16 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35adea3da159e9b754d8f4804987a7aed6cada2962ebf9b5ec77317fec4b3db5afde7c42e6781539070f7144394aea9ac5a3501335646dd2e27f045e97a6e9d2", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/68baa95a20d0a05db6f9c391960ce6b74320cfbf3f51406179ba944614e742238f5c95f7e88b16335b181ab24e80deb069c81ef00301528cf7f22f5ebe800f1a", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6237c3e751ef85417641c8a693439855454d46d271e40e3fbc2baf298b26be185acc53a2951b8ad748af54a0072f9021f9b417b4d427d3729c97bdf3985bbeb0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c19b910b0acdb015e10a8ee884afe5251650bb75910813864f0c8f34e2e5dc37d9a9fdf1f26a7872685e606831f1c442e60ab60050b548b525dcc14fc1413cb2"} 16:04:16 INFO - Running post-run listener: copy_logs_to_upload_dir 16:04:16 INFO - Copying logs to upload dir... 16:04:16 INFO - mkdir: /builds/slave/test/build/upload/logs 16:04:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.849368 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-24 16:04:16.827261) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-24 16:04:16.830260) ========= 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=bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35adea3da159e9b754d8f4804987a7aed6cada2962ebf9b5ec77317fec4b3db5afde7c42e6781539070f7144394aea9ac5a3501335646dd2e27f045e97a6e9d2", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/68baa95a20d0a05db6f9c391960ce6b74320cfbf3f51406179ba944614e742238f5c95f7e88b16335b181ab24e80deb069c81ef00301528cf7f22f5ebe800f1a", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6237c3e751ef85417641c8a693439855454d46d271e40e3fbc2baf298b26be185acc53a2951b8ad748af54a0072f9021f9b417b4d427d3729c97bdf3985bbeb0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c19b910b0acdb015e10a8ee884afe5251650bb75910813864f0c8f34e2e5dc37d9a9fdf1f26a7872685e606831f1c442e60ab60050b548b525dcc14fc1413cb2"} build_url:https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011509 build_url: 'https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35adea3da159e9b754d8f4804987a7aed6cada2962ebf9b5ec77317fec4b3db5afde7c42e6781539070f7144394aea9ac5a3501335646dd2e27f045e97a6e9d2", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/68baa95a20d0a05db6f9c391960ce6b74320cfbf3f51406179ba944614e742238f5c95f7e88b16335b181ab24e80deb069c81ef00301528cf7f22f5ebe800f1a", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6237c3e751ef85417641c8a693439855454d46d271e40e3fbc2baf298b26be185acc53a2951b8ad748af54a0072f9021f9b417b4d427d3729c97bdf3985bbeb0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c19b910b0acdb015e10a8ee884afe5251650bb75910813864f0c8f34e2e5dc37d9a9fdf1f26a7872685e606831f1c442e60ab60050b548b525dcc14fc1413cb2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-24 16:04:16.858975) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 16:04:16.859467) ========= 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=bb9b54edd4a927dc735d112f000001d9-1506291457.413759-531138587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 16:04:16.945517) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-24 16:04:16.945955) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-24 16:04:16.946376) ========= ========= Total master_lag: 0.22 =========