builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-069 starttime: 1505862340.03 results: success (0) revision: a0eb21bf55e1c1ae0ba311e6f2273da05c712799 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:40.029695) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:40.030351) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:40.030622) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:40.125091) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:40.125498) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-19 16:05:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2017-09-19 16:05:40 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128858 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:40.295579) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:40.295850) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020256 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:40.375396) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:40.375727) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a0eb21bf55e1c1ae0ba311e6f2273da05c712799 --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 a0eb21bf55e1c1ae0ba311e6f2273da05c712799 --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=05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-19 16:05:40,439 truncating revision to first 12 chars 2017-09-19 16:05:40,439 Setting DEBUG logging. 2017-09-19 16:05:40,439 attempt 1/10 2017-09-19 16:05:40,439 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a0eb21bf55e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-19 16:05:40,697 unpacking tar archive at: mozilla-central-a0eb21bf55e1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.566947 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:40.979511) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:40.979801) ========= script_repo_revision: a0eb21bf55e1c1ae0ba311e6f2273da05c712799 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:40.980160) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:40.980431) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 16:05:41.000405) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-19 16:05:41.000664) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:05:41 INFO - MultiFileLogger online at 20170919 16:05:41 in /builds/slave/test 16:05:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:05:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:05:41 INFO - {'append_to_log': False, 16:05:41 INFO - 'base_work_dir': '/builds/slave/test', 16:05:41 INFO - 'blob_upload_branch': 'Firefox', 16:05:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:05:41 INFO - 'branch': 'Firefox', 16:05:41 INFO - 'buildbot_json_path': 'buildprops.json', 16:05:41 INFO - 'code_coverage': False, 16:05:41 INFO - 'config_files': ('talos/linux_config.py',), 16:05:41 INFO - 'default_actions': ('clobber', 16:05:41 INFO - 'read-buildbot-config', 16:05:41 INFO - 'download-and-extract', 16:05:41 INFO - 'populate-webroot', 16:05:41 INFO - 'create-virtualenv', 16:05:41 INFO - 'install', 16:05:41 INFO - 'setup-mitmproxy', 16:05:41 INFO - 'run-tests'), 16:05:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:05:41 INFO - 'disable_ccov_upload': False, 16:05:41 INFO - 'disable_stylo': False, 16:05:41 INFO - 'download_minidump_stackwalk': True, 16:05:41 INFO - 'download_symbols': 'ondemand', 16:05:41 INFO - 'enable_stylo': False, 16:05:41 INFO - 'enable_webrender': False, 16:05:41 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 16:05:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:05:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:05:41 INFO - 'gecko_profile': False, 16:05:41 INFO - 'gecko_profile_interval': 0, 16:05:41 INFO - 'installer_path': 'installer.exe', 16:05:41 INFO - 'log_level': 'info', 16:05:41 INFO - 'log_name': 'talos', 16:05:41 INFO - 'log_to_console': True, 16:05:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:05:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:05:41 INFO - 'opt_config_files': (), 16:05:41 INFO - 'pip_index': False, 16:05:41 INFO - 'suite': 'dromaeojs-e10s', 16:05:41 INFO - 'system_bits': '32', 16:05:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:05:41 INFO - 'title': 'talos-linux64-ix-069', 16:05:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:05:41 INFO - 'use_talos_json': True, 16:05:41 INFO - 'verify': 'False', 16:05:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:05:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:05:41 INFO - 'work_dir': 'build'} 16:05:41 INFO - [mozharness: 2017-09-19 23:05:41.189955Z] Running clobber step. 16:05:41 INFO - Running pre-action listener: _resource_record_pre_action 16:05:41 INFO - Running main action method: clobber 16:05:41 INFO - rmtree: /builds/slave/test/build 16:05:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:05:42 INFO - Running post-action listener: _resource_record_post_action 16:05:42 INFO - [mozharness: 2017-09-19 23:05:42.181662Z] Finished clobber step (success) 16:05:42 INFO - [mozharness: 2017-09-19 23:05:42.181758Z] Running read-buildbot-config step. 16:05:42 INFO - Running pre-action listener: _resource_record_pre_action 16:05:42 INFO - Running main action method: read_buildbot_config 16:05:42 INFO - Using buildbot properties: 16:05:42 INFO - { 16:05:42 INFO - "project": "", 16:05:42 INFO - "product": "firefox", 16:05:42 INFO - "who": "kwierso@gmail.com", 16:05:42 INFO - "installer_path": "public/build/target.tar.bz2", 16:05:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:05:42 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:05:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 16:05:42 INFO - "stage_platform": "linux64-pgo", 16:05:42 INFO - "basedir": "/builds/slave/test", 16:05:42 INFO - "buildnumber": 184, 16:05:42 INFO - "platform": "ubuntu64_hw", 16:05:42 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:05:42 INFO - "slavebuilddir": "test", 16:05:42 INFO - "taskId": "dC17MxukSqiTeBbGgs6uxw", 16:05:42 INFO - "branch": "mozilla-central", 16:05:42 INFO - "script_repo_revision": "production", 16:05:42 INFO - "revision": "a0eb21bf55e1c1ae0ba311e6f2273da05c712799", 16:05:42 INFO - "slavename": "talos-linux64-ix-069", 16:05:42 INFO - "repo_path": "mozilla-central" 16:05:42 INFO - } 16:05:42 INFO - Finding installer, test and symbols from parent task. 16:05:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dC17MxukSqiTeBbGgs6uxw'}, attempt #1 16:05:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dC17MxukSqiTeBbGgs6uxw'}, attempt #1 16:05:43 INFO - Task dependencies: Y7gb7BDOTseBUm1jZrOsyg 16:05:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg'}, attempt #1 16:05:43 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.tar.bz2 16:05:43 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.test_packages.json 16:05:43 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.crashreporter-symbols.zip 16:05:43 INFO - Running post-action listener: _resource_record_post_action 16:05:43 INFO - [mozharness: 2017-09-19 23:05:43.567656Z] Finished read-buildbot-config step (success) 16:05:43 INFO - [mozharness: 2017-09-19 23:05:43.567870Z] Running download-and-extract step. 16:05:43 INFO - Running pre-action listener: _resource_record_pre_action 16:05:43 INFO - Running main action method: download_and_extract 16:05:43 INFO - mkdir: /builds/slave/test/build/tests 16:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:43 INFO - trying https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.test_packages.json 16:05:43 INFO - Downloading https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:05:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:05:44 INFO - Downloaded 989 bytes. 16:05:44 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:05:44 INFO - Using the following test package requirements: 16:05:44 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:05:44 INFO - u'common': [u'target.common.tests.zip'], 16:05:44 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:05:44 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:05:44 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:05:44 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:05:44 INFO - u'mozbase': [u'target.common.tests.zip'], 16:05:44 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:05:44 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:05:44 INFO - u'web-platform': [u'target.common.tests.zip', 16:05:44 INFO - u'target.web-platform.tests.tar.gz'], 16:05:44 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:05:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 16:05:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.common.tests.zip 16:05:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:05:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.common.tests.zip into memory 16:05:45 INFO - Content-Length response header: 55285033 16:05:45 INFO - Bytes received: 55285033 16:05:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.talos.tests.zip 16:05:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:05:56 INFO - Fetch https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.talos.tests.zip into memory 16:05:56 INFO - Content-Length response header: 14508904 16:05:56 INFO - Bytes received: 14508904 16:05: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')]} 16:05:57 INFO - trying https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.tar.bz2 16:05:57 INFO - Downloading https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:05:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:05:58 INFO - Downloaded 62273763 bytes. 16:05:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.tar.bz2 16:05:58 INFO - mkdir: /builds/slave/test/properties 16:05:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:05:58 INFO - Writing to file /builds/slave/test/properties/build_url 16:05:58 INFO - Contents: 16:05:58 INFO - build_url:https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.tar.bz2 16:05:58 INFO - Running post-action listener: _resource_record_post_action 16:05:58 INFO - Running post-action listener: find_tests_for_verification 16:05:58 INFO - Running post-action listener: set_extra_try_arguments 16:05:58 INFO - [mozharness: 2017-09-19 23:05:58.335232Z] Finished download-and-extract step (success) 16:05:58 INFO - [mozharness: 2017-09-19 23:05:58.335329Z] Running populate-webroot step. 16:05:58 INFO - Running pre-action listener: _resource_record_pre_action 16:05:58 INFO - Running main action method: populate_webroot 16:05:58 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:05:58 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:05:58 INFO - 'tests': ['tresize', 16:05:58 INFO - 'tcanvasmark']}, 16:05:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:05:58 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:05:58 INFO - 'tests': ['dromaeo_css', 16:05:58 INFO - 'kraken']}, 16:05:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:05:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:05:58 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:05:58 INFO - 'talos_options': ['--disable-stylo'], 16:05:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:05:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:05:58 INFO - 'tests': ['damp', 'tps']}, 16:05:58 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:05:58 INFO - 'talos_options': ['--disable-stylo'], 16:05:58 INFO - 'tests': ['damp', 'tps']}, 16:05:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:05:58 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:05:58 INFO - 'tests': ['dromaeo_dom']}, 16:05:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:05:58 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:05:58 INFO - 'tests': ['basic_compositor_video', 16:05:58 INFO - 'glvideo']}, 16:05:58 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:05:58 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:05:58 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:05:58 INFO - 'talos_options': ['--disable-stylo'], 16:05:58 INFO - 'tests': ['ts_paint_webext', 16:05:58 INFO - 'tp5o_webext']}, 16:05:58 INFO - 'other-e10s': {'tests': ['a11yr', 16:05:58 INFO - 'ts_paint', 16:05:58 INFO - 'tpaint', 16:05:58 INFO - 'sessionrestore', 16:05:58 INFO - 'sessionrestore_many_windows', 16:05:58 INFO - 'sessionrestore_no_auto_restore', 16:05:58 INFO - 'tabpaint']}, 16:05:58 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:05:58 INFO - 'tests': ['a11yr', 16:05:58 INFO - 'ts_paint', 16:05:58 INFO - 'tpaint', 16:05:58 INFO - 'sessionrestore', 16:05:58 INFO - 'sessionrestore_many_windows', 16:05:58 INFO - 'sessionrestore_no_auto_restore', 16:05:58 INFO - 'tabpaint']}, 16:05:58 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:05:58 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 16:05:58 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:05:58 INFO - 'tests': ['perf_reftest_singletons']}, 16:05:58 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:05:58 INFO - 'tests': ['bloom_basic']}, 16:05:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:05:58 INFO - 'tsvgr_opacity', 16:05:58 INFO - 'tart', 16:05:58 INFO - 'tscrollx', 16:05:58 INFO - 'tsvg_static']}, 16:05:58 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:05:58 INFO - 'tests': ['tsvgx', 16:05:58 INFO - 'tsvgr_opacity', 16:05:58 INFO - 'tart', 16:05:58 INFO - 'tscrollx', 16:05:58 INFO - 'tsvg_static']}, 16:05:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:05:58 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:05:58 INFO - 'talos_options': ['--disable-stylo'], 16:05:58 INFO - 'tests': ['tp5o']}, 16:05:58 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:05:58 INFO - 'talos_options': ['--mitmproxy', 16:05:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:05:58 INFO - '--firstNonBlankPaint'], 16:05:58 INFO - 'tests': ['tp6_google', 16:05:58 INFO - 'tp6_youtube', 16:05:58 INFO - 'tp6_amazon', 16:05:58 INFO - 'tp6_facebook']}, 16:05:58 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:05:58 INFO - 'talos_options': ['--disable-stylo', 16:05:58 INFO - '--mitmproxy', 16:05:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:05:58 INFO - '--firstNonBlankPaint'], 16:05:58 INFO - 'tests': ['tp6_google', 16:05:58 INFO - 'tp6_youtube', 16:05:58 INFO - 'tp6_amazon', 16:05:58 INFO - 'tp6_facebook']}, 16:05:58 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:05:58 INFO - 'talos_options': ['--stylo-threads=1', 16:05:58 INFO - '--mitmproxy', 16:05:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:05:58 INFO - '--firstNonBlankPaint'], 16:05:58 INFO - 'tests': ['tp6_google', 16:05:58 INFO - 'tp6_youtube', 16:05:58 INFO - 'tp6_amazon', 16:05:58 INFO - 'tp6_facebook']}, 16:05:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:05:58 INFO - 'talos_options': ['--xperf_path', 16:05:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:05:58 INFO - 'tests': ['tp5n']}, 16:05:58 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:05:58 INFO - 'talos_options': ['--disable-stylo', 16:05:58 INFO - '--xperf_path', 16:05:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:05:58 INFO - 'tests': ['tp5n']}}} 16:05:58 INFO - Running post-action listener: _resource_record_post_action 16:05:58 INFO - [mozharness: 2017-09-19 23:05:58.350116Z] Finished populate-webroot step (success) 16:05:58 INFO - [mozharness: 2017-09-19 23:05:58.350204Z] Running create-virtualenv step. 16:05:58 INFO - Running pre-action listener: _resource_record_pre_action 16:05:58 INFO - Running main action method: create_virtualenv 16:05:58 INFO - Creating virtualenv /builds/slave/test/build/venv 16:05:58 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:05:58 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 16:05:58 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:05:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:05:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:05:59 INFO - Installing distribute.............................................................................................................................................................................................done. 16:05:59 INFO - Installing pip...............done. 16:05:59 INFO - Return code: 0 16:05:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:05:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:05:59 INFO - Reading from file tmpfile_stdout 16:05:59 INFO - Output received: 16:05:59 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 16:05:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:59 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 0x29b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d22090>, '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 0x2d22d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278', '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 16:05:59 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 16:05:59 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 16:05:59 INFO - Using env: {'DISPLAY': ':0', 16:05:59 INFO - 'HOME': '/home/cltbld', 16:05:59 INFO - 'LANG': 'en_US.UTF-8', 16:05:59 INFO - 'LANGUAGE': 'en_US:en', 16:05:59 INFO - 'LOGNAME': 'cltbld', 16:05:59 INFO - 'MAIL': '/var/mail/cltbld', 16:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:59 INFO - 'MOZ_NO_REMOTE': '1', 16:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:59 INFO - 'NO_EM_RESTART': '1', 16:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:59 INFO - 'PWD': '/builds/slave/test', 16:05:59 INFO - 'SHELL': '/bin/bash', 16:05:59 INFO - 'SHLVL': '1', 16:05:59 INFO - 'TERM': 'linux', 16:05:59 INFO - 'TMOUT': '86400', 16:05:59 INFO - 'USER': 'cltbld', 16:05:59 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278', 16:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:59 INFO - '_': '/tools/buildbot/bin/python'} 16:06:00 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:06:00 INFO - Downloading/unpacking pip>=1.5 16:06:00 INFO - Running setup.py egg_info for package pip 16:06:00 INFO - warning: no files found matching 'pip/cacert.pem' 16:06:00 INFO - warning: no files found matching '*.html' under directory 'docs' 16:06:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:06:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:06:00 INFO - Installing collected packages: pip 16:06:00 INFO - Found existing installation: pip 1.1 16:06:00 INFO - Uninstalling pip: 16:06:00 INFO - Successfully uninstalled pip 16:06:00 INFO - Running setup.py install for pip 16:06:00 INFO - warning: no files found matching 'pip/cacert.pem' 16:06:00 INFO - warning: no files found matching '*.html' under directory 'docs' 16:06:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:06:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:06:00 INFO - Installing pip script to /builds/slave/test/build/venv/bin 16:06:00 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 16:06:00 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 16:06:00 INFO - Successfully installed pip 16:06:00 INFO - Cleaning up... 16:06:00 INFO - Return code: 0 16:06:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:06:00 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')]} 16:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:00 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')]} 16:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:00 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 0x29b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d22090>, '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 0x2d22d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278', '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 16:06:00 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 16:06:00 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 16:06:00 INFO - Using env: {'DISPLAY': ':0', 16:06:00 INFO - 'HOME': '/home/cltbld', 16:06:00 INFO - 'LANG': 'en_US.UTF-8', 16:06:00 INFO - 'LANGUAGE': 'en_US:en', 16:06:00 INFO - 'LOGNAME': 'cltbld', 16:06:00 INFO - 'MAIL': '/var/mail/cltbld', 16:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:00 INFO - 'MOZ_NO_REMOTE': '1', 16:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:00 INFO - 'NO_EM_RESTART': '1', 16:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:00 INFO - 'PWD': '/builds/slave/test', 16:06:00 INFO - 'SHELL': '/bin/bash', 16:06:00 INFO - 'SHLVL': '1', 16:06:00 INFO - 'TERM': 'linux', 16:06:00 INFO - 'TMOUT': '86400', 16:06:00 INFO - 'USER': 'cltbld', 16:06:00 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278', 16:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:00 INFO - '_': '/tools/buildbot/bin/python'} 16:06:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:01 INFO - Downloading/unpacking psutil>=3.1.1 16:06:01 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 16:06:01 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 16:06:01 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 16:06:01 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 16:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:06:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:06:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:06:02 INFO - Installing collected packages: psutil 16:06:02 INFO - Running setup.py install for psutil 16:06:02 INFO - building 'psutil._psutil_linux' extension 16:06:02 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 16:06:02 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 16:06:02 INFO - building 'psutil._psutil_posix' extension 16:06:02 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 16:06:02 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 16:06:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:06:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:06:02 INFO - Successfully installed psutil 16:06:02 INFO - Cleaning up... 16:06:02 INFO - Return code: 0 16:06:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:06:02 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')]} 16:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:02 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')]} 16:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:02 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 0x29b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d22090>, '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 0x2d22d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278', '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 16:06:02 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 16:06:02 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 16:06:02 INFO - Using env: {'DISPLAY': ':0', 16:06:02 INFO - 'HOME': '/home/cltbld', 16:06:02 INFO - 'LANG': 'en_US.UTF-8', 16:06:02 INFO - 'LANGUAGE': 'en_US:en', 16:06:02 INFO - 'LOGNAME': 'cltbld', 16:06:02 INFO - 'MAIL': '/var/mail/cltbld', 16:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:02 INFO - 'MOZ_NO_REMOTE': '1', 16:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:02 INFO - 'NO_EM_RESTART': '1', 16:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:02 INFO - 'PWD': '/builds/slave/test', 16:06:02 INFO - 'SHELL': '/bin/bash', 16:06:02 INFO - 'SHLVL': '1', 16:06:02 INFO - 'TERM': 'linux', 16:06:02 INFO - 'TMOUT': '86400', 16:06:02 INFO - 'USER': 'cltbld', 16:06:02 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278', 16:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:02 INFO - '_': '/tools/buildbot/bin/python'} 16:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:06:03 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 16:06:03 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 16:06:03 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 16:06:03 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 16:06:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:06:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:06:04 INFO - Installing collected packages: mozsystemmonitor 16:06:04 INFO - Running setup.py install for mozsystemmonitor 16:06:04 INFO - Successfully installed mozsystemmonitor 16:06:04 INFO - Cleaning up... 16:06:06 INFO - Return code: 0 16:06:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:06: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')]} 16:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06: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')]} 16:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06: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', '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 0x29b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d22090>, '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 0x2d22d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278', '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 16:06: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:06: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 jsonschema==2.5.1 16:06:06 INFO - Using env: {'DISPLAY': ':0', 16:06:06 INFO - 'HOME': '/home/cltbld', 16:06:06 INFO - 'LANG': 'en_US.UTF-8', 16:06:06 INFO - 'LANGUAGE': 'en_US:en', 16:06:06 INFO - 'LOGNAME': 'cltbld', 16:06:06 INFO - 'MAIL': '/var/mail/cltbld', 16:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:06 INFO - 'MOZ_NO_REMOTE': '1', 16:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:06 INFO - 'NO_EM_RESTART': '1', 16:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:06 INFO - 'PWD': '/builds/slave/test', 16:06:06 INFO - 'SHELL': '/bin/bash', 16:06:06 INFO - 'SHLVL': '1', 16:06:06 INFO - 'TERM': 'linux', 16:06:06 INFO - 'TMOUT': '86400', 16:06:06 INFO - 'USER': 'cltbld', 16:06:06 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278', 16:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:06 INFO - '_': '/tools/buildbot/bin/python'} 16:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:06 INFO - Downloading/unpacking jsonschema==2.5.1 16:06: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 16:06: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 16:06: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 16:06: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 16:06:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:06:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:06: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 16:06: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 16:06: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 16:06: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 16:06:08 INFO - Downloading functools32-3.2.3-2.tar.gz 16:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:06:08 INFO - warning: no files found matching '*.txt' 16:06:08 INFO - no previously-included directories found matching 'build' 16:06:08 INFO - no previously-included directories found matching 'dist' 16:06:08 INFO - no previously-included directories found matching '.git*' 16:06:08 INFO - Installing collected packages: jsonschema, functools32 16:06:08 INFO - Running setup.py install for functools32 16:06:08 INFO - warning: no files found matching '*.txt' 16:06:08 INFO - no previously-included directories found matching 'build' 16:06:08 INFO - no previously-included directories found matching 'dist' 16:06:08 INFO - no previously-included directories found matching '.git*' 16:06:09 INFO - Successfully installed jsonschema functools32 16:06:09 INFO - Cleaning up... 16:06:09 INFO - Return code: 0 16:06:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:06: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')]} 16:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06: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')]} 16:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06: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 0x29b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d22090>, '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 0x2d22d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278', '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 16:06: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 16:06: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 16:06:09 INFO - Using env: {'DISPLAY': ':0', 16:06:09 INFO - 'HOME': '/home/cltbld', 16:06:09 INFO - 'LANG': 'en_US.UTF-8', 16:06:09 INFO - 'LANGUAGE': 'en_US:en', 16:06:09 INFO - 'LOGNAME': 'cltbld', 16:06:09 INFO - 'MAIL': '/var/mail/cltbld', 16:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:09 INFO - 'MOZ_NO_REMOTE': '1', 16:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:09 INFO - 'NO_EM_RESTART': '1', 16:06:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:09 INFO - 'PWD': '/builds/slave/test', 16:06:09 INFO - 'SHELL': '/bin/bash', 16:06:09 INFO - 'SHLVL': '1', 16:06:09 INFO - 'TERM': 'linux', 16:06:09 INFO - 'TMOUT': '86400', 16:06:09 INFO - 'USER': 'cltbld', 16:06:09 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278', 16:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:09 INFO - '_': '/tools/buildbot/bin/python'} 16:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:06:09 INFO - Cleaning up... 16:06:09 INFO - Return code: 0 16:06:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:06: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')]} 16:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06: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')]} 16:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06: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 0x29b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d22090>, '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 0x2d22d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278', '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 16:06: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 16:06: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 16:06:09 INFO - Using env: {'DISPLAY': ':0', 16:06:09 INFO - 'HOME': '/home/cltbld', 16:06:09 INFO - 'LANG': 'en_US.UTF-8', 16:06:09 INFO - 'LANGUAGE': 'en_US:en', 16:06:09 INFO - 'LOGNAME': 'cltbld', 16:06:09 INFO - 'MAIL': '/var/mail/cltbld', 16:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:09 INFO - 'MOZ_NO_REMOTE': '1', 16:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:09 INFO - 'NO_EM_RESTART': '1', 16:06:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:09 INFO - 'PWD': '/builds/slave/test', 16:06:09 INFO - 'SHELL': '/bin/bash', 16:06:09 INFO - 'SHLVL': '1', 16:06:09 INFO - 'TERM': 'linux', 16:06:09 INFO - 'TMOUT': '86400', 16:06:09 INFO - 'USER': 'cltbld', 16:06:09 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278', 16:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:09 INFO - '_': '/tools/buildbot/bin/python'} 16:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:09 INFO - Downloading/unpacking blobuploader==1.2.4 16:06: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 16:06: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 16:06: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 16:06: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 16:06:10 INFO - Downloading blobuploader-1.2.4.tar.gz 16:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:06:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:06: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 16:06: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 16:06: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 16:06: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 16:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:06:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:06: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 16:06: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 16:06: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 16:06: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 16:06:11 INFO - Downloading docopt-0.6.1.tar.gz 16:06:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:06:11 INFO - Installing collected packages: blobuploader, requests, docopt 16:06:11 INFO - Running setup.py install for blobuploader 16:06:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:06:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:06:11 INFO - Running setup.py install for requests 16:06:11 INFO - Running setup.py install for docopt 16:06:11 INFO - Successfully installed blobuploader requests docopt 16:06:11 INFO - Cleaning up... 16:06:11 INFO - Return code: 0 16:06:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:11 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 0x29b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d22090>, '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 0x2d22d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278', '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 16:06:11 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 16:06:11 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 16:06:11 INFO - Using env: {'DISPLAY': ':0', 16:06:11 INFO - 'HOME': '/home/cltbld', 16:06:11 INFO - 'LANG': 'en_US.UTF-8', 16:06:11 INFO - 'LANGUAGE': 'en_US:en', 16:06:11 INFO - 'LOGNAME': 'cltbld', 16:06:11 INFO - 'MAIL': '/var/mail/cltbld', 16:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:11 INFO - 'MOZ_NO_REMOTE': '1', 16:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:11 INFO - 'NO_EM_RESTART': '1', 16:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:11 INFO - 'PWD': '/builds/slave/test', 16:06:11 INFO - 'SHELL': '/bin/bash', 16:06:11 INFO - 'SHLVL': '1', 16:06:11 INFO - 'TERM': 'linux', 16:06:11 INFO - 'TMOUT': '86400', 16:06:11 INFO - 'USER': 'cltbld', 16:06:11 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278', 16:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:11 INFO - '_': '/tools/buildbot/bin/python'} 16:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:06:12 INFO - Running setup.py (path:/tmp/pip-pUxB2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:06:12 INFO - Running setup.py (path:/tmp/pip-YN3VhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:06:12 INFO - Running setup.py (path:/tmp/pip-zJO2wX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:06:12 INFO - Running setup.py (path:/tmp/pip-vGo7vP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:06:12 INFO - Running setup.py (path:/tmp/pip-IIdZv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:06:12 INFO - Running setup.py (path:/tmp/pip-Hjpjgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:06:12 INFO - Running setup.py (path:/tmp/pip-6janDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:06:12 INFO - Running setup.py (path:/tmp/pip-XNvsi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:06:12 INFO - Running setup.py (path:/tmp/pip-e9w3es-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:06:12 INFO - Running setup.py (path:/tmp/pip-ZYNeh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:06:12 INFO - Running setup.py (path:/tmp/pip-c_CLHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:06:12 INFO - Running setup.py (path:/tmp/pip-ZaO1jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:06:12 INFO - Running setup.py (path:/tmp/pip-jg5gMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:06:12 INFO - Running setup.py (path:/tmp/pip-VD2q6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:06:13 INFO - Running setup.py (path:/tmp/pip-GuEovf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:06:13 INFO - Running setup.py (path:/tmp/pip-NgimFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:06:13 INFO - Running setup.py (path:/tmp/pip-U0sVTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:06:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:06:13 INFO - Running setup.py install for manifestparser 16:06:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:06:13 INFO - Running setup.py install for mozcrash 16:06:13 INFO - Running setup.py install for mozdebug 16:06:13 INFO - Running setup.py install for mozdevice 16:06:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:06:13 INFO - Running setup.py install for mozfile 16:06:13 INFO - Running setup.py install for mozhttpd 16:06:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:06:13 INFO - Running setup.py install for mozinfo 16:06:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:06:13 INFO - Running setup.py install for mozInstall 16:06:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:06:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:06:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:06:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:06:14 INFO - Running setup.py install for mozleak 16:06:14 INFO - Running setup.py install for mozlog 16:06:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:06:14 INFO - Running setup.py install for moznetwork 16:06:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:06:14 INFO - Running setup.py install for mozprocess 16:06:14 INFO - Running setup.py install for mozprofile 16:06:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:06:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:06:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:06:14 INFO - Running setup.py install for mozrunner 16:06:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:06:14 INFO - Running setup.py install for mozscreenshot 16:06:14 INFO - Running setup.py install for moztest 16:06:14 INFO - Running setup.py install for mozversion 16:06:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:06:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:06:15 INFO - Cleaning up... 16:06:15 INFO - Return code: 0 16:06:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:06: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')]} 16:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06: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')]} 16:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06: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 0x29b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d22090>, '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 0x2d22d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278', '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 16:06: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 16:06: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 16:06:15 INFO - Using env: {'DISPLAY': ':0', 16:06:15 INFO - 'HOME': '/home/cltbld', 16:06:15 INFO - 'LANG': 'en_US.UTF-8', 16:06:15 INFO - 'LANGUAGE': 'en_US:en', 16:06:15 INFO - 'LOGNAME': 'cltbld', 16:06:15 INFO - 'MAIL': '/var/mail/cltbld', 16:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:15 INFO - 'MOZ_NO_REMOTE': '1', 16:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:15 INFO - 'NO_EM_RESTART': '1', 16:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:15 INFO - 'PWD': '/builds/slave/test', 16:06:15 INFO - 'SHELL': '/bin/bash', 16:06:15 INFO - 'SHLVL': '1', 16:06:15 INFO - 'TERM': 'linux', 16:06:15 INFO - 'TMOUT': '86400', 16:06:15 INFO - 'USER': 'cltbld', 16:06:15 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278', 16:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:15 INFO - '_': '/tools/buildbot/bin/python'} 16:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:06:15 INFO - Running setup.py (path:/tmp/pip-UG_M92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:06: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)) 16:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:06:15 INFO - Running setup.py (path:/tmp/pip-8cGmQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:06: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)) 16:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:06:15 INFO - Running setup.py (path:/tmp/pip-boYSRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:06: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)) 16:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:06:15 INFO - Running setup.py (path:/tmp/pip-vaM9wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:06: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)) 16:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:06:15 INFO - Running setup.py (path:/tmp/pip-cWS46m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:06:15 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)) 16:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:06:15 INFO - Running setup.py (path:/tmp/pip-b6HXym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:06:15 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)) 16:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:06:15 INFO - Running setup.py (path:/tmp/pip-mMXG_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:06:15 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)) 16:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:06:15 INFO - Running setup.py (path:/tmp/pip-JwScTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:06:15 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)) 16:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:06:15 INFO - Running setup.py (path:/tmp/pip-WlySHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:06:15 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)) 16:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:06:15 INFO - Running setup.py (path:/tmp/pip-9BtVYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:06:15 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)) 16:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:06:15 INFO - Running setup.py (path:/tmp/pip-WsYRHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:06: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)) 16:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:06:16 INFO - Running setup.py (path:/tmp/pip-QbK0B6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:06: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)) 16:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:06:16 INFO - Running setup.py (path:/tmp/pip-RmJRgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:06: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)) 16:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:06:16 INFO - Running setup.py (path:/tmp/pip-9k7lUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:06: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)) 16:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:06:16 INFO - Running setup.py (path:/tmp/pip-ew0IVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:06: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)) 16:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:06:16 INFO - Running setup.py (path:/tmp/pip-qkFOYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:06: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)) 16:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:06:16 INFO - Running setup.py (path:/tmp/pip-4y4yXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:06: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)) 16:06: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)) 16:06: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)) 16:06: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)) 16:06: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)) 16:06: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)) 16:06: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)) 16:06:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:06: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 16:06: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 16:06: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 16:06: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 16:06:17 INFO - Downloading blessings-1.6.tar.gz 16:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:06:17 INFO - Installing collected packages: blessings 16:06:17 INFO - Running setup.py install for blessings 16:06:17 INFO - Successfully installed blessings 16:06:17 INFO - Cleaning up... 16:06:17 INFO - Return code: 0 16:06:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:06:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:06:18 INFO - Reading from file tmpfile_stdout 16:06:18 INFO - Current package versions: 16:06:18 INFO - argparse == 1.2.1 16:06:18 INFO - blessings == 1.6 16:06:18 INFO - blobuploader == 1.2.4 16:06:18 INFO - docopt == 0.6.1 16:06:18 INFO - functools32 == 3.2.3-2 16:06:18 INFO - jsonschema == 2.5.1 16:06:18 INFO - manifestparser == 1.1 16:06:18 INFO - mozInstall == 1.13 16:06:18 INFO - mozcrash == 1.0 16:06:18 INFO - mozdebug == 0.1 16:06:18 INFO - mozdevice == 0.51 16:06:18 INFO - mozfile == 1.2 16:06:18 INFO - mozhttpd == 0.7 16:06:18 INFO - mozinfo == 0.10 16:06:18 INFO - mozleak == 0.1 16:06:18 INFO - mozlog == 3.5 16:06:18 INFO - moznetwork == 0.27 16:06:18 INFO - mozprocess == 0.25 16:06:18 INFO - mozprofile == 0.28 16:06:18 INFO - mozrunner == 6.13 16:06:18 INFO - mozscreenshot == 0.1 16:06:18 INFO - mozsystemmonitor == 0.3 16:06:18 INFO - moztest == 0.8 16:06:18 INFO - mozversion == 1.4 16:06:18 INFO - psutil == 3.1.1 16:06:18 INFO - requests == 1.2.3 16:06:18 INFO - wsgiref == 0.1.2 16:06:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:06: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')]} 16:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06: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')]} 16:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06: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 0x29b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d22090>, '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 0x2d22d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278', '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 16:06: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 16:06: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 16:06:18 INFO - Using env: {'DISPLAY': ':0', 16:06:18 INFO - 'HOME': '/home/cltbld', 16:06:18 INFO - 'LANG': 'en_US.UTF-8', 16:06:18 INFO - 'LANGUAGE': 'en_US:en', 16:06:18 INFO - 'LOGNAME': 'cltbld', 16:06:18 INFO - 'MAIL': '/var/mail/cltbld', 16:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:18 INFO - 'MOZ_NO_REMOTE': '1', 16:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:18 INFO - 'NO_EM_RESTART': '1', 16:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:18 INFO - 'PWD': '/builds/slave/test', 16:06:18 INFO - 'SHELL': '/bin/bash', 16:06:18 INFO - 'SHLVL': '1', 16:06:18 INFO - 'TERM': 'linux', 16:06:18 INFO - 'TMOUT': '86400', 16:06:18 INFO - 'USER': 'cltbld', 16:06:18 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278', 16:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:18 INFO - '_': '/tools/buildbot/bin/python'} 16:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06: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)) 16:06: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)) 16:06: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)) 16:06: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)) 16:06: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)) 16:06: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)) 16:06: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)) 16:06: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)) 16:06: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)) 16:06:18 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:06: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 16:06: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 16:06: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 16:06: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 16:06:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:06: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)) 16:06: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)) 16:06:19 INFO - Installing collected packages: simplejson 16:06:19 INFO - Running setup.py install for simplejson 16:06:19 INFO - building 'simplejson._speedups' extension 16:06: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 16:06: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 16:06:20 INFO - Successfully installed simplejson 16:06:20 INFO - Cleaning up... 16:06:20 INFO - Return code: 0 16:06:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:06: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')]} 16:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06: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')]} 16:06:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06: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 0x29b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d22090>, '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 0x2d22d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278', '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 16:06: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 16:06: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 16:06:20 INFO - Using env: {'DISPLAY': ':0', 16:06:20 INFO - 'HOME': '/home/cltbld', 16:06:20 INFO - 'LANG': 'en_US.UTF-8', 16:06:20 INFO - 'LANGUAGE': 'en_US:en', 16:06:20 INFO - 'LOGNAME': 'cltbld', 16:06:20 INFO - 'MAIL': '/var/mail/cltbld', 16:06:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:20 INFO - 'MOZ_NO_REMOTE': '1', 16:06:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:20 INFO - 'NO_EM_RESTART': '1', 16:06:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:20 INFO - 'PWD': '/builds/slave/test', 16:06:20 INFO - 'SHELL': '/bin/bash', 16:06:20 INFO - 'SHLVL': '1', 16:06:20 INFO - 'TERM': 'linux', 16:06:20 INFO - 'TMOUT': '86400', 16:06:20 INFO - 'USER': 'cltbld', 16:06:20 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278', 16:06:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:20 INFO - '_': '/tools/buildbot/bin/python'} 16:06:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:06:20 INFO - Cleaning up... 16:06:20 INFO - Return code: 0 16:06:20 INFO - Running post-action listener: _resource_record_post_action 16:06:20 INFO - Running post-action listener: _start_resource_monitoring 16:06:20 INFO - Starting resource monitoring. 16:06:20 INFO - [mozharness: 2017-09-19 23:06:20.753521Z] Finished create-virtualenv step (success) 16:06:20 INFO - [mozharness: 2017-09-19 23:06:20.754042Z] Running install step. 16:06:20 INFO - Running pre-action listener: _resource_record_pre_action 16:06:20 INFO - Running main action method: install 16:06:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:06:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:06:20 INFO - Reading from file tmpfile_stdout 16:06:20 INFO - Detecting whether we're running mozinstall >=1.0... 16:06:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:06:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:06:21 INFO - Reading from file tmpfile_stdout 16:06:21 INFO - Output received: 16:06:21 INFO - Usage: mozinstall [options] installer 16:06:21 INFO - Options: 16:06:21 INFO - -h, --help show this help message and exit 16:06:21 INFO - -d DEST, --destination=DEST 16:06:21 INFO - Directory to install application into. [default: 16:06:21 INFO - "/builds/slave/test"] 16:06:21 INFO - --app=APP Application being installed. [default: firefox] 16:06:21 INFO - mkdir: /builds/slave/test/build/application 16:06: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'] 16:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:06:38 INFO - Reading from file tmpfile_stdout 16:06:38 INFO - Output received: 16:06:38 INFO - /builds/slave/test/build/application/firefox/firefox 16:06:38 INFO - Running post-action listener: _resource_record_post_action 16:06:38 INFO - [mozharness: 2017-09-19 23:06:38.862322Z] Finished install step (success) 16:06:38 INFO - [mozharness: 2017-09-19 23:06:38.862573Z] Running setup-mitmproxy step. 16:06:38 INFO - Running pre-action listener: _resource_record_pre_action 16:06:38 INFO - Running main action method: setup_mitmproxy 16:06:38 INFO - Skipping: mitmproxy is not required 16:06:38 INFO - Running post-action listener: _resource_record_post_action 16:06:38 INFO - [mozharness: 2017-09-19 23:06:38.863696Z] Finished setup-mitmproxy step (success) 16:06:38 INFO - [mozharness: 2017-09-19 23:06:38.863916Z] Running run-tests step. 16:06:38 INFO - Running pre-action listener: _resource_record_pre_action 16:06:38 INFO - Running pre-action listener: _set_gcov_prefix 16:06:38 INFO - Running main action method: run_tests 16:06:38 WARNING - Try message not found. 16:06:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:06:38 INFO - Python 2.7.3 16:06:38 INFO - Return code: 0 16:06:38 INFO - grabbing minidump binary from tooltool 16:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:38 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 0x2d22090>, '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 0x2d22d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1cf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:06:38 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 16:06:38 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 16:06:38 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 16:06:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:06:38 INFO - Return code: 0 16:06:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:06:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:06:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:06:38 INFO - ENV: RUST_BACKTRACE is now full 16:06:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:06:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:06:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:06:38 INFO - Using env: {'DISPLAY': ':0', 16:06:38 INFO - 'HOME': '/home/cltbld', 16:06:38 INFO - 'LANG': 'en_US.UTF-8', 16:06:38 INFO - 'LANGUAGE': 'en_US:en', 16:06:38 INFO - 'LOGNAME': 'cltbld', 16:06:38 INFO - 'MAIL': '/var/mail/cltbld', 16:06:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:06:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:38 INFO - 'MOZ_NO_REMOTE': '1', 16:06:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:06:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:38 INFO - 'NO_EM_RESTART': '1', 16:06:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:39 INFO - 'PWD': '/builds/slave/test', 16:06:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:06:39 INFO - 'RUST_BACKTRACE': 'full', 16:06:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:06:39 INFO - 'SHELL': '/bin/bash', 16:06:39 INFO - 'SHLVL': '1', 16:06:39 INFO - 'TERM': 'linux', 16:06:39 INFO - 'TMOUT': '86400', 16:06:39 INFO - 'USER': 'cltbld', 16:06:39 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278', 16:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:39 INFO - '_': '/tools/buildbot/bin/python'} 16:06:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:06:39 INFO - mozversion application_buildid: 20170919214925 16:06:39 INFO - mozversion application_changeset: a0eb21bf55e1c1ae0ba311e6f2273da05c712799 16:06:39 INFO - mozversion application_display_name: Nightly 16:06:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:06:39 INFO - mozversion application_name: Firefox 16:06:39 INFO - mozversion application_remotingname: firefox 16:06:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:06:39 INFO - mozversion application_vendor: Mozilla 16:06:39 INFO - mozversion application_version: 57.0a1 16:06:39 INFO - mozversion platform_buildid: 20170919214925 16:06:39 INFO - mozversion platform_changeset: a0eb21bf55e1c1ae0ba311e6f2273da05c712799 16:06:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:06:39 INFO - mozversion platform_version: 57.0a1 16:06:39 INFO - using testdate: 1505862399 16:06:39 INFO - actual date: 1505862399 16:06:39 INFO - starting webserver on 'localhost:45088' 16:06:39 INFO - SUITE-START | Running 2 tests 16:06:39 INFO - TEST-START | dromaeo_css 16:06:39 INFO - Initialising browser for dromaeo_css test... 16:06:39 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45088/getInfo.html -profile /tmp/tmpJqmBHf/profile 16:06:39 INFO - TEST-INFO | started process 22643 (/builds/slave/test/build/application/firefox/firefox http://localhost:45088/getInfo.html) 16:06:44 INFO - TEST-INFO | 22643: exit 0 16:06:44 INFO - Browser initialized. 16:06:44 INFO - Running cycle 1/1 for dromaeo_css test... 16:06:44 INFO - Using env: {'DISPLAY': ':0', 16:06:44 INFO - 'HOME': '/home/cltbld', 16:06:44 INFO - 'JSGC_DISABLE_POISONING': '1', 16:06:44 INFO - 'LANG': 'en_US.UTF-8', 16:06:44 INFO - 'LANGUAGE': 'en_US:en', 16:06:44 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:06:44 INFO - 'LOGNAME': 'cltbld', 16:06:44 INFO - 'MAIL': '/var/mail/cltbld', 16:06:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:06:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:06:44 INFO - 'MOZ_CRASHREPORTER': '1', 16:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:44 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:06:44 INFO - 'MOZ_NO_REMOTE': '1', 16:06:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:44 INFO - 'NO_EM_RESTART': '1', 16:06:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:44 INFO - 'PWD': '/builds/slave/test', 16:06:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:06:44 INFO - 'RUST_BACKTRACE': 'full', 16:06:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:06:44 INFO - 'SHELL': '/bin/bash', 16:06:44 INFO - 'SHLVL': '1', 16:06:44 INFO - 'TERM': 'linux', 16:06:44 INFO - 'TMOUT': '86400', 16:06:44 INFO - 'USER': 'cltbld', 16:06:44 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278', 16:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:44 INFO - '_': '/tools/buildbot/bin/python'} 16:06:44 INFO - TEST-INFO | started process 22884 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJqmBHf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:06:45 INFO - PID 22884 | 16:06:45 INFO - PID 22884 | (/builds/slave/test/build/application/firefox/firefox:22935): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:06:45 INFO - PID 22884 | 16:06:56 INFO - PID 22884 | RSS: Main: 147308544 16:06:56 INFO - PID 22884 | 16:09:52 INFO - PID 22884 | Cycle 1(1): loaded http://localhost:45088/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45088/tests/dromaeo/cssquery-ext.html) 16:09:54 INFO - PID 22884 | RSS: Main: 151142400 16:09:54 INFO - PID 22884 | 16:12:55 INFO - PID 22884 | Cycle 1(1): loaded http://localhost:45088/tests/dromaeo/cssquery-ext.html (next: http://localhost:45088/tests/dromaeo/cssquery-jquery.html) 16:12:56 INFO - PID 22884 | RSS: Main: 148430848 16:12:56 INFO - PID 22884 | 16:15:57 INFO - PID 22884 | Cycle 1(1): loaded http://localhost:45088/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45088/tests/dromaeo/cssquery-mootools.html) 16:15:58 INFO - PID 22884 | RSS: Main: 150740992 16:15:58 INFO - PID 22884 | 16:18:59 INFO - PID 22884 | Cycle 1(1): loaded http://localhost:45088/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45088/tests/dromaeo/cssquery-prototype.html) 16:19:00 INFO - PID 22884 | RSS: Main: 148824064 16:19:00 INFO - PID 22884 | 16:22:03 INFO - PID 22884 | Cycle 1(1): loaded http://localhost:45088/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45088/tests/dromaeo/cssquery-yui.html) 16:22:04 INFO - PID 22884 | RSS: Main: 150695936 16:22:04 INFO - PID 22884 | 16:25:05 INFO - PID 22884 | Cycle 1(1): loaded http://localhost:45088/tests/dromaeo/cssquery-yui.html (next: http://localhost:45088/tests/dromaeo/cssquery-dojo.html) 16:25:05 INFO - PID 22884 | RSS: Main: 153001984 16:25:05 INFO - PID 22884 | 16:25:05 INFO - PID 22884 | __start_tp_report 16:25:05 INFO - PID 22884 | _x_x_mozilla_page_load 16:25:05 INFO - PID 22884 | _x_x_mozilla_page_load_details 16:25:05 INFO - PID 22884 | |i|pagename|runs| 16:25:05 INFO - PID 22884 | |0;dojo.html;3877.515310586175;3880.437336586195;3880.941785873211;3891.435741817435;3913.6869050475966;6217.813465596028;6331.176946996896;6338;6361.872762544752;6380.106785050097;6312.33720459352;6319.526035547329;6350.110984462179;6434.195725534309;6446.290908000116;5722.141678748179;5725.141228815669;5728.455796699317;5752.65484070955;5790.247267855173;149.8485415154765;5569.749361278732;5707.942920570783;5780.335261444925;5805.303363596375;5584.553235741151;5584.748686309126;5676.347220069683;5681.715914204294;5682.318121825366;5637.041702910515;5651.802186923479;5740.1102829061565;5745.310562732457;5753.482186603226;5608.214849920973;5637.013522633522;5682.545396368322;5708.77164913403;5721.570882183812;6255.40573645503;6288.371162883721;6320.557560970734;6379.617222966637;6384.6169229846355;6731.427828634572;6789.388954994074;6808.931910680879;6814.761483348059;6910.378065974036;6868.347506986828;6938.826529336757;6951.304869513059;6963.1296087989;6977.302269773033;6392.904106438407;6451.225852897635;6479.838004049937;6493.480521558264;6498.610083395011;7053.858922821515;7057.18842333128;7062.187848397397;7106.395956343666;7129.536580122275;6601.438877695354;6701.396874281338;6770.187577490733;6825.829354266183;6832.111825462757;6928.861422771516;6935.3411425914455;6963.338482844223;6977.755778547727;6989.89515157273;6785.728570857209;6827.044213810071;6839.760608378683;6847.349501797321;6878.759243426456;6724.831879203059;6795.354441328066;6796.796096117125;6807.285235050347;6909.827254318682;4905.1416002200185;4940.75296235194;4947.678400903929;4954.108260513142;4954.752262386866;4473.35136405226;4510.932336014962;4537.296719008559;4577.153226653079;4580.748058856795;6260.499160067184;6272.372762723691;6280.497560195174;6357.427831495188;6363.459105975951;6828.180618325733;6836.658167091626;6903.75836845708;6914.481413893978;6916.827079322957;6227.96886015567;6310.368963103653;6311.400416960381;6320.336364681734;6361.363863613602;5476.835694929158;5511.063119269734;5522;5528.834134975958;5548.195511650869;6869.416099631488;6994.370506654425;7112.431005519546;7125.1093613298335;7130.180029296594;6857.519973601899;6861.416779573792;6864.313568643096;6952.44380449573;6971.721131154798;6820.795376138723;7003.439724822104;7014.158301003912;7103.2186459488385;7124.679389427592;6636.303188165173;6638.502112341497;6657.833554161185;6704;6732.259451460238;6802.14973128359;6950;6973;6976.441884649317;7015.614141222281;6667.699953502201;6751;6761.526693131434;6761.560498567577;6780.966095169492;6645.003249512612;6652.501062420434;6656.30108838565;6738.124043874265;6745.325467453215;6482.643454610042;6570.342965703391;6588.472922166311;6645.8006259810345;6659.101021362248;6680.098186744922;6730.831729206809;6739.831504212434;6762.830929226809;6769.289224631343;6481.449076828522;6490.156279683611;6574.638394888136;6579.671016449062;6587.670616469253 16:25:05 INFO - PID 22884 | |1;ext.html;966.304260932129;978.8482785168297;982.4792859784308;984.2470510059806;992.4690290694477;40412.19175616486;44805.327920081225;45043.77478112605;45168.548314516884;45224.321635175496;42329.788351058276;42428;42489.7875510622;42597.574024259746;42660.573394266044;7662.88505672414;7716.961415192916;7779.105402878685;8501.574921253912;8691.435056721324;8206.671733130668;8254.133316001824;8268.09051004389;8268.214519620626;8273.793155171108;8205.425620206588;8231.053428855668;8256.25693687568;8264.090949995496;8287.212714792115;8186.713465028725;8239.95880020599;8257.752267431986;8261.752147435587;8263.380246481507;8509.149085091503;8557.358198135102;8576.528290943996;8594.097619749899;8603.741887743377;41119.383209251886;41314.586854131376;41409.378859317134;41487;41692.166156677;3809.4476300936485;3843.9231215375817;3846.211526637033;3846.442265871461;3846.499955005859;33512.6648733512;33679;33693.494597581055;33767.493487597705;33783;5533.6403133796175;5537.556995440355;5573;5580.832575022756;5750.166225897222;224838;227406;227633;227840;228376;47963.280550791766;48885.51114488809;54282.18576721352;54710;54776.17835732467;48918.755406223456;57662;57962;58711;58758;16530;16563.08903010346;16661.583460413345;16664.75002874958;16713.415030473876;13400.597982060553;13496.257705826274;13500.459981600627;13504.662383440493;13511.121777084458;15378.846211537964;15465.14941678196;15474;15542.766858497132;15647.295871685801;6118.898598252268;6205.937940620626;6229.719662615194;6284.214473190851;6309.211348581427;1100.1693721240572;1115.760111576015;1116.5143162724241;1117.0672488472055;1125.6397952655236;26084.34789130249;26121.608175877376;26156.607650885253;26300.21099367022;26316.473670526866;1206.9396530173456;1208.1301462946665;1210.1045226532303;1211.763706077324;1224.8897599215936;13517.324133793467;13699.246541440316;13768.655783605289;13811.861881381057;13922.164670119826;288177;288863;289337;289550;289830;60024;60024.39975600188;60333.69833150894;60411.39588604146;60499.99999999912;1491.9552413427614;1501.2718831366778;1542.691461707663;1553.7747026681068;1558.7116383469095;25547.872260638578;25812.22563323103;25841.870790645928;25859.741402586485;26197.214083577524;43181.352279716455;43207.78396108125;43267.56732432635;43298.78350608227;43304.78347608242;247750;249472;249761;250087;250253;37132.62867371292;40020.19959600733;40467.797661012686;40486;40566.1886762269;50792.23811642754;52552.73723631357;52599;52718.47281527136;52982.73508632432;37676.2464750709;37679.81160094182;37679.81160094182;37722.62277377301;38199.04502387463;37962;38008;38221.61778382181;38235.61764382432;38293.42559861549;43664.781676091414;44789.77605112084;44814.55185448104;44948.77525612482;45057.774711126236;35514.8224258877;36236.81881590575;36327.27345453129;36488.452673209395;36802.63197368099;27489.31276718018;27855.02507412231;27988.72011279861;28099.859500702365;28281 16:25:05 INFO - PID 22884 | |2;jquery.html;590.138397939009;602.3494625804129;610.5420934299276;620.8199622109588;639.3606393606393;23353.76646233537;23501.589904605735;23915.28254152376;24024.87987560064;24078.75921240789;25477;25509.617355739632;25801.967921283125;25851.22446326613;25861.74138258617;6468.385503377183;6591.176102987127;6642.5350225484235;6653.234877989021;6656.667166641672;6501.804945851632;6692.799216023527;6729.293424190463;6759.526833121683;6773.1872175338785;6710.832229194285;6724.5965242085385;6741.9887016947605;6756.020377045325;6762.594244345355;6515.543911926144;6721.193456785192;6736.562123461984;6737.124173857416;6752.763653272112;6193.225846769154;6264.310925798159;6291.213598300213;6313.936860631381;6318.74725010999;29136.854315728287;29904.70095299041;30275.697243027727;30466.238344041354;30468;2186.9234576789895;2223.833212509052;2230.241717815934;2231.2859884836857;2232.631615783394;19991.60016799656;20541.28105516315;20588.588228235352;20612.484687882774;20648.896755516125;2494.6881639795024;2574.292069680834;2585.831920925134;2586.3275548357374;2631.1711810779543;135580.32209838985;143209;146909.2654536731;150429;157068;15424.305906234247;15497.767533487007;15915.283812228477;15954.60113497172;16541.421050263183;25524.617130743052;25595.74404255971;25633;25636.871815641174;25756.227313180636;10101.949490252502;10526.736831579272;10622.490059765765;10636.149108071335;10638.414887181125;9429.622815087458;9560.235181185488;9594.568244429018;9648.565814538362;9651.855222171673;9610.279229057849;9744.415335079917;9753.780777402824;9777.21782257432;9879.753006174904;2741.2598598378327;2764.433291175304;2844.416894536615;2850.446128658217;2916.5187744022423;996.6860438961704;1036.9585216591402;1044.1438020822852;1052.5789684126257;1062.8033813744328;20713.925592400417;21146;21278.468038299165;21340.893295533424;21532.13871445156;1054.530733823441;1099.301943266032;1100.5432745410565;1101.5043230546287;1105.1103861391657;11284.943575282236;11749.236299640495;11894.554866045031;11915;12059.155859089955;621499;624211;630982;631146;638456;127687;127750;129381;129590.35204823916;130175.34912325378;1209.7701436726993;1216.3735676126803;1248.650377894191;1254.3728135932033;1255.334672623511;18677.252909883453;18814.526601752234;18858.339958101402;18893.149808258386;18979.145938432528;62462.68768656128;63172;63276.68361658162;63819;64299.35700643121;79475.60262198652;81022.59488702519;81168;82518.58740706499;83425;15122.924385378003;15314.693706126038;15753;15799;15807.446739364066;24495;24582.631260531463;24646.137385191432;24784.50430991406;24882.626760598243;19905.701414479085;19934.90032549886;20042.89978550098;20227.494312641713;20233.392998210078;16953.406630767862;17126.657466850844;17176.91411542984;17248.482545523653;17757.378491752726;19329.226830926604;20488.078036488692;20712.792872071688;20774.792252077285;20979.58040839144;15588.532344029698;15719.607009824846;15721.528354148937;15736.213189340717;15742.134182620066;19186.80813191906;19554.60890782205;19604.705929410786;19608;19659.70510442373 16:25:05 INFO - PID 22884 | |3;mootools.html;1422.6870088580513;1468.4243866185832;1471.4261438039166;1485.6285928517873;1489.515907330118;16508.339666413343;17193.828061719396;17196.312147514083;17214.225359858807;17233.91383043083;16753.748693769605;16916.746248806277;16936.153192340364;17017.319307227728;17020;2729.972700272992;2780.8470534120615;2781.4576157649267;2782;2783.401568662737;2631.5657916443765;2710.268227578553;2713.4573085382904;2717.605947137664;2718.972810271892;2847;2963.0073925235074;2966.9554956675665;2967.213688372583;2968.0650595062484;2849.6722876869217;2866.068527728486;2879.3665393613373;2882.5964364988813;2887.581300711406;2812.3953350029637;2891.81203221792;2928.2825707701536;2930.4871647461823;2932.1936467471614;16861.578460538585;17015.064171470563;17022.404215852508;17028.063456509888;17033.403830865984;8371.246587807127;8443.451175673561;8779.517126558037;8780;8784.429012114193;5804.738786754606;5912;5964.403559644044;5990.9700451497465;6013.398660133996;2184.5740080684272;2445.3397582652583;2628.2378110347977;2659.734026597325;2681.6245725598433;31692.841535792402;31709.524357134662;31918.680813191804;31962.520562191352;32006;7111.217766045731;7287.2712728727765;7344.081989751281;7454.217307182667;7548.131964824006;19526.804731952783;19537.60924781525;19561.315353962542;19629.11668974871;19710.507237318896;8364.079951205362;8474.915250847413;8476.025257095513;8561.52911589856;8576.356773242032;7739.535627862347;7856.096548896836;7892.960535197402;7910.564918929399;7985.041794984639;5646.153077038477;5742.511886489695;5786.826395208151;5789.884202316014;6100.572959892854;1619.1580378203269;1679.3114822922544;1679.6388776412884;1682.3102527963476;1703.540044188087;965.9661911833052;987.2990176974429;987.3335498538602;1009.0716540782352;1019.3883669798211;8685.739427817176;8701.347398945105;8743.956280218557;9263.25893928484;9883.406995580288;768.4390395011673;797.5015615240475;802.193795235796;808.1635507250086;815.6256707447969;5109.948900510947;5759.366469688331;5779.557159880134;5793.131030345482;5936.851578710567;24163.63754543683;25016.24951251429;25199.87400062988;25245.62131568028;25295.114670986793;23250.65124023141;24439.144629937866;24575.508489830103;24839.130630427848;25088.372790680012;10098.242631802645;10537.104346130665;11539.076873850072;11554.711132221593;11773.529058837721;9974.700758977242;9999.400035997864;10030.448325342177;10234.181265498593;10278.743031424274;20939.8953005234;21193.78806211918;21239.57520849605;21290.148394064065;21681.89159054258;21752.238671646417;21922.23272185466;21998.45003874916;22057.448563786034;22336.21823236179;12044.638660840188;12187.085968552572;12188.75622487563;12197.231401446918;12206.206596571194;15215.315310811262;15621.921890390475;15723;15728.76406853921;15754.133522656364;12580.559680411141;12597.307148106576;12630.43163057683;12695.746085078432;13113;11963.222390544586;12056.819147712617;12091.274523528617;12373.319467429377;12426.316552589695;11082.944585277022;11097.778044438905;11107.278026928223;11238.66284011481;11291.266067705574;8370.037445693579;8391.832163356577;8425.620847061775;8482.703105391281;8555.401121921406;8442.409031367746;8461.32309415233;8542.231199192103;8575.485470871768;8644.91355086441 16:25:05 INFO - PID 22884 | |4;prototype.html;533.751805410484;551.8896220755847;562.606175677026;575.3010092737323;580.3471095018105;6364;6365.363463653633;6382.8404289892715;6407.070974708665;6414.71133798979;6180.783672571461;6253.1870856788555;6269.905951410732;6274.592151510149;6349.746010159588;5089.854782673906;5127.871868188992;5138.126518491847;5146.459621739719;5156.762377029505;4996.700197988114;5087.6184286178495;5101.821436249732;5107;5136.024155410479;4815.927761083586;4891.951080489185;4919.77860996256;4928.137575924216;5005.499450055002;4928.260760885896;4950.752462376867;4967.950320496821;4969.403671559436;4982.402111746595;4399;4477.261251893467;4495.617872480843;4516.20966330894;4517.819287228507;6161.784337548164;6173.166622505994;6179.907301390483;6195.969020154916;6225.284092329395;5850.502707269887;5860.472557469806;5868.706564671749;5875.471207591295;5896.204012458306;6611.9338806611795;6639.634820084893;6652.2017357916875;6711.597304161766;6724.731010759564;4819.180739274332;5066.721330326831;5074.5432911037815;5078.2128770040335;5087.186050231945;6802.931970680279;6811.863762724767;6867.793966181022;6944.826379340507;6981.3367730065565;5119.078565858107;5133.153029750049;5154.793808247703;5156.303898973665;5162.845114646567;5142.6914385137015;5183.092958732207;5219.191025390995;5239.816606418757;5241.397239317527;5811.186433899257;5813.331466881278;5819.970900145472;5820.912686309709;5844.415558444121;6686.231083425371;6704.865902681919;6709.597424154566;6712.228093769279;6739.460843132538;1793.3006127610242;1805.0794095011638;1808.023667219713;1819.854411647065;1832.9633407331778;1208.572942825582;1263.1158189267549;1263.279930439659;1263.8357013588359;1270.371166272701;6102.511799056065;6157.476614487819;6188.381161883865;6196.690165491707;6250.4374606285655;6710.765123220664;6715.597064176165;6746.696398661974;6837.453003759687;6860.451163906875;6068.817935461943;6129.233845769279;6181.84545386369;6208.782692605737;6246.094941043026;3372.1906742382143;3517;3550.7336949728874;3570.6072332043454;3591.676749092594;6762.357576030269;6893.414059804973;6938.861222775517;6999.195092564319;7002.894956575656;6773.627450490172;6801.3612717196065;6858.759943402057;6907.412869906114;6925.965370173218;6860.622665753332;6868.759593414306;6950.513464057467;6982.965085174542;7010.649467526603;6658.300878407891;6689.799306020827;6728.865422691617;6775.62734049632;6787.21946976104;6686.465082793267;6732.663366831541;6740.9325906740305;6754.93245067543;6770.52606317553;6770.424513916372;6829.829254268683;6877.317846040149;6939.716152511802;6944.826379340557;5143.099957507496;5154.252633368065;5168.121419358793;5174.033867130466;5175.896482070413;6518.837029074311;6569.4744420447205;6752.696128674123;6875.759348422781;6919.481038922;6497.73294207625;6525;6563.343665633399;6575.145231119924;6640.136782218281;6434.774782882577;6454.838629034124;6458.22501299847;6488.286288508355;6544.738210471528;6317.526185536011;6456.7740129095255;6473.805785826433;6483.902741458787;6509.707063182073;6592.0111983202905;6638.535302528777;6657.234418041987;6712.6979285931275;6726.3609957054005;6420.422162005442;6449.290578036318;6455.837294506393;6493.902591461227;6517.543771936109 16:25:05 INFO - PID 22884 | |5;yui.html;956.870822438971;988.6885631026227;999.6351331763906;1026.296986564203;1029.4235228272169;21190.25834095807;21569.352919412402;21574.784252157475;21590.24434144805;21593.35219943404;19828.504287392785;20098.59802803943;20209.292674756387;20228.59542809143;20268;1053.7365658585372;1067.268920789258;1068.1988508618535;1069.2782371898977;1075.7471994081384;1082.7076689293885;1084.766775143344;1087.7715679707271;1089.7820435912809;1090.0462095666292;1070.2347821307762;1104.7403860092911;1118.5637601335486;1126.6507382711386;1130.7060164357285;1116.6315116011697;1122.1976286954784;1123.7583919457275;1126.1835169502128;1126.8929451702074;793.3613441179848;814.1614137438448;814.5112932240609;820.2044017303207;832.1803024021334;18880.811191888042;18944.905275473673;18951.336703215322;18960.810391896044;18975.905120474446;22566.77433225663;22600.88699556508;23658.171963981178;23734.76265237343;23855.165069222494;17809.376671816422;17992.370267040722;18093.095345232687;18105.63788724218;18165.36421225251;3947.1513624570566;3964.306246406867;3979.1643754811525;3984.342583473723;3988.441618173429;125908.37045814712;154370;154704;155100;158055;19218.4234472966;19291;19379.127939242488;19537.804621953597;19806;35080.47379289313;35265.64734352675;35316.29367412638;35336.293274134376;35505.46741798875;9441.197498212729;9442.858357124649;9444.102810233016;9450.338476306593;9453.763655908657;4347.869563913087;4381.18947994622;4442.133783912106;4486.371907932892;4489.685721999494;6112.083187521907;6261.624302541862;6272.435480806749;6293.842653933597;6294.968525157345;1245.8131280308025;1264.3046324521476;1285.5243559882904;1290.1742884553894;1293.0108467022735;696.1506961506954;710.3535782437957;711.2567367101288;727.5343779980816;746.1270313732946;12310.630681079581;13217.669558260928;13725.519606813914;14113.929430352782;14192.432302707775;691.3039147325371;700.58315302395;705.5343473307593;714.1893950366268;719.4963525532148;6273.153124328249;6387.840303992437;6410.102585638015;6415.1981002374705;6460.838479038061;140244;146107;147429;149357.2532137354;153895;124694;128745.3562732199;130389;130568;135937;113081;116149;120168.3991580054;120215.39892300483;123156.38421807834;14092.506762263272;14305.570832874613;14309.211348581428;14491.130532168103;14600;53285.7335713319;53631.46368536421;54092.72953635207;54186;54511.454885450636;71749;72087.63956180395;72109.27890721236;72669;73936.63031684807;18784.15471303822;18894.905525472284;18993.050347482847;19086.713699294243;19152.946587937797;21291.148354066285;21299.041543130286;21356.35930922075;21495.355139345844;21534.138634454448;21269;21510.8924455383;21512;21594.8920255404;21776.237831675815;18210;18333.39969737999;18366.72449913279;18371.90814045921;18529.72205416947;19129.617407652047;19195.520111997314;19334.12996415193;19511.60976780428;19602.50993725168;13689.178649281075;13922.373493192628;14048.438062477795;14146.78779818324;14259.358328875018;13438.46246150143;13501.932490337485;13616.31918404056;13626.863731362559;13761.38073786662 16:25:05 INFO - PID 22884 | __end_tp_report 16:25:05 INFO - PID 22884 | __start_cc_report 16:25:05 INFO - PID 22884 | _x_x_mozilla_cycle_collect,272 16:25:05 INFO - PID 22884 | __end_cc_report 16:25:05 INFO - PID 22884 | __startTimestamp1505863505750__endTimestamp 16:25:05 INFO - PID 22884 | 16:25:05 INFO - PID 22884 | ------- Summary: start ------- 16:25:05 INFO - PID 22884 | Number of tests: 6 16:25:05 INFO - PID 22884 | 16:25:05 INFO - PID 22884 | [#0] dojo.html Cycles:165 Average:6281.44 Median:6588.47 stddev:895.23 (13.6%) stddev-sans-first:877.89 16:25:05 INFO - PID 22884 | Values: 3877.5 3880.4 3880.9 3891.4 3913.7 6217.8 6331.2 6338.0 6361.9 6380.1 6312.3 6319.5 6350.1 6434.2 6446.3 5722.1 5725.1 5728.5 5752.7 5790.2 149.8 5569.7 5707.9 5780.3 5805.3 5584.6 5584.7 5676.3 5681.7 5682.3 5637.0 5651.8 5740.1 5745.3 5753.5 5608.2 5637.0 5682.5 5708.8 5721.6 6255.4 6288.4 6320.6 6379.6 6384.6 6731.4 6789.4 6808.9 6814.8 6910.4 6868.3 6938.8 6951.3 6963.1 6977.3 6392.9 6451.2 6479.8 6493.5 6498.6 7053.9 7057.2 7062.2 7106.4 7129.5 6601.4 6701.4 6770.2 6825.8 6832.1 6928.9 6935.3 6963.3 6977.8 6989.9 6785.7 6827.0 6839.8 6847.3 6878.8 6724.8 6795.4 6796.8 6807.3 6909.8 4905.1 4940.8 4947.7 4954.1 4954.8 4473.4 4510.9 4537.3 4577.2 4580.7 6260.5 6272.4 6280.5 6357.4 6363.5 6828.2 6836.7 6903.8 6914.5 6916.8 6228.0 6310.4 6311.4 6320.3 6361.4 5476.8 5511.1 5522.0 5528.8 5548.2 6869.4 6994.4 7112.4 7125.1 7130.2 6857.5 6861.4 6864.3 6952.4 6971.7 6820.8 7003.4 7014.2 7103.2 7124.7 6636.3 6638.5 6657.8 6704.0 6732.3 6802.1 6950.0 6973.0 6976.4 7015.6 6667.7 6751.0 6761.5 6761.6 6781.0 6645.0 6652.5 6656.3 6738.1 6745.3 6482.6 6570.3 6588.5 6645.8 6659.1 6680.1 6730.8 6739.8 6762.8 6769.3 6481.4 6490.2 6574.6 6579.7 6587.7 16:25:05 INFO - PID 22884 | 16:25:05 INFO - PID 22884 | [#1] ext.html Cycles:180 Average:44159.80 Median:21933.35 stddev:66699.64 (304.1%) stddev-sans-first:66807.90 16:25:05 INFO - PID 22884 | Values: 966.3 978.8 982.5 984.2 992.5 40412.2 44805.3 45043.8 45168.5 45224.3 42329.8 42428.0 42489.8 42597.6 42660.6 7662.9 7717.0 7779.1 8501.6 8691.4 8206.7 8254.1 8268.1 8268.2 8273.8 8205.4 8231.1 8256.3 8264.1 8287.2 8186.7 8240.0 8257.8 8261.8 8263.4 8509.1 8557.4 8576.5 8594.1 8603.7 41119.4 41314.6 41409.4 41487.0 41692.2 3809.4 3843.9 3846.2 3846.4 3846.5 33512.7 33679.0 33693.5 33767.5 33783.0 5533.6 5537.6 5573.0 5580.8 5750.2 224838.0 227406.0 227633.0 227840.0 228376.0 47963.3 48885.5 54282.2 54710.0 54776.2 48918.8 57662.0 57962.0 58711.0 58758.0 16530.0 16563.1 16661.6 16664.8 16713.4 13400.6 13496.3 13500.5 13504.7 13511.1 15378.8 15465.1 15474.0 15542.8 15647.3 6118.9 6205.9 6229.7 6284.2 6309.2 1100.2 1115.8 1116.5 1117.1 1125.6 26084.3 26121.6 26156.6 26300.2 26316.5 1206.9 1208.1 1210.1 1211.8 1224.9 13517.3 13699.2 13768.7 13811.9 13922.2 288177.0 288863.0 289337.0 289550.0 289830.0 60024.0 60024.4 60333.7 60411.4 60500.0 1492.0 1501.3 1542.7 1553.8 1558.7 25547.9 25812.2 25841.9 25859.7 26197.2 43181.4 43207.8 43267.6 43298.8 43304.8 247750.0 249472.0 249761.0 250087.0 250253.0 37132.6 40020.2 40467.8 40486.0 40566.2 50792.2 52552.7 52599.0 52718.5 52982.7 37676.2 37679.8 37679.8 37722.6 38199.0 37962.0 38008.0 38221.6 38235.6 38293.4 43664.8 44789.8 44814.6 44948.8 45057.8 35514.8 36236.8 36327.3 36488.5 36802.6 27489.3 27855.0 27988.7 28099.9 28281.0 16:25:05 INFO - PID 22884 | 16:25:05 INFO - PID 22884 | [#2] jquery.html Cycles:180 Average:40298.46 Median:23708.44 stddev:104896.96 (442.4%) stddev-sans-first:105148.85 16:25:05 INFO - PID 22884 | Values: 590.1 602.3 610.5 620.8 639.4 23353.8 23501.6 23915.3 24024.9 24078.8 25477.0 25509.6 25802.0 25851.2 25861.7 6468.4 6591.2 6642.5 6653.2 6656.7 6501.8 6692.8 6729.3 6759.5 6773.2 6710.8 6724.6 6742.0 6756.0 6762.6 6515.5 6721.2 6736.6 6737.1 6752.8 6193.2 6264.3 6291.2 6313.9 6318.7 29136.9 29904.7 30275.7 30466.2 30468.0 2186.9 2223.8 2230.2 2231.3 2232.6 19991.6 20541.3 20588.6 20612.5 20648.9 2494.7 2574.3 2585.8 2586.3 2631.2 135580.3 143209.0 146909.3 150429.0 157068.0 15424.3 15497.8 15915.3 15954.6 16541.4 25524.6 25595.7 25633.0 25636.9 25756.2 10101.9 10526.7 10622.5 10636.1 10638.4 9429.6 9560.2 9594.6 9648.6 9651.9 9610.3 9744.4 9753.8 9777.2 9879.8 2741.3 2764.4 2844.4 2850.4 2916.5 996.7 1037.0 1044.1 1052.6 1062.8 20713.9 21146.0 21278.5 21340.9 21532.1 1054.5 1099.3 1100.5 1101.5 1105.1 11284.9 11749.2 11894.6 11915.0 12059.2 621499.0 624211.0 630982.0 631146.0 638456.0 127687.0 127750.0 129381.0 129590.4 130175.3 1209.8 1216.4 1248.7 1254.4 1255.3 18677.3 18814.5 18858.3 18893.1 18979.1 62462.7 63172.0 63276.7 63819.0 64299.4 79475.6 81022.6 81168.0 82518.6 83425.0 15122.9 15314.7 15753.0 15799.0 15807.4 24495.0 24582.6 24646.1 24784.5 24882.6 19905.7 19934.9 20042.9 20227.5 20233.4 16953.4 17126.7 17176.9 17248.5 17757.4 19329.2 20488.1 20712.8 20774.8 20979.6 15588.5 15719.6 15721.5 15736.2 15742.1 19186.8 19554.6 19604.7 19608.0 19659.7 16:25:05 INFO - PID 22884 | 16:25:05 INFO - PID 22884 | [#3] mootools.html Cycles:180 Average:10489.94 Median:2695.95 stddev:7766.49 (288.1%) stddev-sans-first:7758.40 16:25:05 INFO - PID 22884 | Values: 1422.7 1468.4 1471.4 1485.6 1489.5 16508.3 17193.8 17196.3 17214.2 17233.9 16753.7 16916.7 16936.2 17017.3 17020.0 2730.0 2780.8 2781.5 2782.0 2783.4 2631.6 2710.3 2713.5 2717.6 2719.0 2847.0 2963.0 2967.0 2967.2 2968.1 2849.7 2866.1 2879.4 2882.6 2887.6 2812.4 2891.8 2928.3 2930.5 2932.2 16861.6 17015.1 17022.4 17028.1 17033.4 8371.2 8443.5 8779.5 8780.0 8784.4 5804.7 5912.0 5964.4 5991.0 6013.4 2184.6 2445.3 2628.2 2659.7 2681.6 31692.8 31709.5 31918.7 31962.5 32006.0 7111.2 7287.3 7344.1 7454.2 7548.1 19526.8 19537.6 19561.3 19629.1 19710.5 8364.1 8474.9 8476.0 8561.5 8576.4 7739.5 7856.1 7893.0 7910.6 7985.0 5646.2 5742.5 5786.8 5789.9 6100.6 1619.2 1679.3 1679.6 1682.3 1703.5 966.0 987.3 987.3 1009.1 1019.4 8685.7 8701.3 8744.0 9263.3 9883.4 768.4 797.5 802.2 808.2 815.6 5109.9 5759.4 5779.6 5793.1 5936.9 24163.6 25016.2 25199.9 25245.6 25295.1 23250.7 24439.1 24575.5 24839.1 25088.4 10098.2 10537.1 11539.1 11554.7 11773.5 9974.7 9999.4 10030.4 10234.2 10278.7 20939.9 21193.8 21239.6 21290.1 21681.9 21752.2 21922.2 21998.5 22057.4 22336.2 12044.6 12187.1 12188.8 12197.2 12206.2 15215.3 15621.9 15723.0 15728.8 15754.1 12580.6 12597.3 12630.4 12695.7 13113.0 11963.2 12056.8 12091.3 12373.3 12426.3 11082.9 11097.8 11107.3 11238.7 11291.3 8370.0 8391.8 8425.6 8482.7 8555.4 8442.4 8461.3 8542.2 8575.5 8644.9 16:25:05 INFO - PID 22884 | 16:25:05 INFO - PID 22884 | [#4] prototype.html Cycles:180 Average:5626.63 Median:6251.81 stddev:1576.46 (25.2%) stddev-sans-first:1533.84 16:25:05 INFO - PID 22884 | Values: 533.8 551.9 562.6 575.3 580.3 6364.0 6365.4 6382.8 6407.1 6414.7 6180.8 6253.2 6269.9 6274.6 6349.7 5089.9 5127.9 5138.1 5146.5 5156.8 4996.7 5087.6 5101.8 5107.0 5136.0 4815.9 4892.0 4919.8 4928.1 5005.5 4928.3 4950.8 4968.0 4969.4 4982.4 4399.0 4477.3 4495.6 4516.2 4517.8 6161.8 6173.2 6179.9 6196.0 6225.3 5850.5 5860.5 5868.7 5875.5 5896.2 6611.9 6639.6 6652.2 6711.6 6724.7 4819.2 5066.7 5074.5 5078.2 5087.2 6802.9 6811.9 6867.8 6944.8 6981.3 5119.1 5133.2 5154.8 5156.3 5162.8 5142.7 5183.1 5219.2 5239.8 5241.4 5811.2 5813.3 5820.0 5820.9 5844.4 6686.2 6704.9 6709.6 6712.2 6739.5 1793.3 1805.1 1808.0 1819.9 1833.0 1208.6 1263.1 1263.3 1263.8 1270.4 6102.5 6157.5 6188.4 6196.7 6250.4 6710.8 6715.6 6746.7 6837.5 6860.5 6068.8 6129.2 6181.8 6208.8 6246.1 3372.2 3517.0 3550.7 3570.6 3591.7 6762.4 6893.4 6938.9 6999.2 7002.9 6773.6 6801.4 6858.8 6907.4 6926.0 6860.6 6868.8 6950.5 6983.0 7010.6 6658.3 6689.8 6728.9 6775.6 6787.2 6686.5 6732.7 6740.9 6754.9 6770.5 6770.4 6829.8 6877.3 6939.7 6944.8 5143.1 5154.3 5168.1 5174.0 5175.9 6518.8 6569.5 6752.7 6875.8 6919.5 6497.7 6525.0 6563.3 6575.1 6640.1 6434.8 6454.8 6458.2 6488.3 6544.7 6317.5 6456.8 6473.8 6483.9 6509.7 6592.0 6638.5 6657.2 6712.7 6726.4 6420.4 6449.3 6455.8 6493.9 6517.5 16:25:05 INFO - PID 22884 | 16:25:05 INFO - PID 22884 | [#5] yui.html Cycles:180 Average:28423.10 Median:19312.56 stddev:41298.04 (213.8%) stddev-sans-first:41362.40 16:25:05 INFO - PID 22884 | Values: 956.9 988.7 999.6 1026.3 1029.4 21190.3 21569.4 21574.8 21590.2 21593.4 19828.5 20098.6 20209.3 20228.6 20268.0 1053.7 1067.3 1068.2 1069.3 1075.7 1082.7 1084.8 1087.8 1089.8 1090.0 1070.2 1104.7 1118.6 1126.7 1130.7 1116.6 1122.2 1123.8 1126.2 1126.9 793.4 814.2 814.5 820.2 832.2 18880.8 18944.9 18951.3 18960.8 18975.9 22566.8 22600.9 23658.2 23734.8 23855.2 17809.4 17992.4 18093.1 18105.6 18165.4 3947.2 3964.3 3979.2 3984.3 3988.4 125908.4 154370.0 154704.0 155100.0 158055.0 19218.4 19291.0 19379.1 19537.8 19806.0 35080.5 35265.6 35316.3 35336.3 35505.5 9441.2 9442.9 9444.1 9450.3 9453.8 4347.9 4381.2 4442.1 4486.4 4489.7 6112.1 6261.6 6272.4 6293.8 6295.0 1245.8 1264.3 1285.5 1290.2 1293.0 696.2 710.4 711.3 727.5 746.1 12310.6 13217.7 13725.5 14113.9 14192.4 691.3 700.6 705.5 714.2 719.5 6273.2 6387.8 6410.1 6415.2 6460.8 140244.0 146107.0 147429.0 149357.3 153895.0 124694.0 128745.4 130389.0 130568.0 135937.0 113081.0 116149.0 120168.4 120215.4 123156.4 14092.5 14305.6 14309.2 14491.1 14600.0 53285.7 53631.5 54092.7 54186.0 54511.5 71749.0 72087.6 72109.3 72669.0 73936.6 18784.2 18894.9 18993.1 19086.7 19152.9 21291.1 21299.0 21356.4 21495.4 21534.1 21269.0 21510.9 21512.0 21594.9 21776.2 18210.0 18333.4 18366.7 18371.9 18529.7 19129.6 19195.5 19334.1 19511.6 19602.5 13689.2 13922.4 14048.4 14146.8 14259.4 13438.5 13501.9 13616.3 13626.9 13761.4 16:25:05 INFO - PID 22884 | -------- Summary: end -------- 16:25:05 INFO - PID 22884 | 16:25:06 INFO - TEST-INFO | 22884: exit 0 16:25:06 INFO - TEST-OK | dromaeo_css | took 1107250ms 16:25:06 INFO - TEST-START | kraken 16:25:06 INFO - Initialising browser for kraken test... 16:25:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45088/getInfo.html -profile /tmp/tmpukXERK/profile 16:25:06 INFO - TEST-INFO | started process 23263 (/builds/slave/test/build/application/firefox/firefox http://localhost:45088/getInfo.html) 16:25:11 INFO - TEST-INFO | 23263: exit 0 16:25:11 INFO - Browser initialized. 16:25:11 INFO - Running cycle 1/1 for kraken test... 16:25:11 INFO - Using env: {'DISPLAY': ':0', 16:25:11 INFO - 'HOME': '/home/cltbld', 16:25:11 INFO - 'JSGC_DISABLE_POISONING': '1', 16:25:11 INFO - 'LANG': 'en_US.UTF-8', 16:25:11 INFO - 'LANGUAGE': 'en_US:en', 16:25:11 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:25:11 INFO - 'LOGNAME': 'cltbld', 16:25:11 INFO - 'MAIL': '/var/mail/cltbld', 16:25:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:25:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:25:11 INFO - 'MOZ_CRASHREPORTER': '1', 16:25:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:11 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:25:11 INFO - 'MOZ_NO_REMOTE': '1', 16:25:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:25:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:11 INFO - 'NO_EM_RESTART': '1', 16:25:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:11 INFO - 'PWD': '/builds/slave/test', 16:25:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:25:11 INFO - 'RUST_BACKTRACE': 'full', 16:25:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:25:11 INFO - 'SHELL': '/bin/bash', 16:25:11 INFO - 'SHLVL': '1', 16:25:11 INFO - 'TERM': 'linux', 16:25:11 INFO - 'TMOUT': '86400', 16:25:11 INFO - 'USER': 'cltbld', 16:25:11 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278', 16:25:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:11 INFO - '_': '/tools/buildbot/bin/python'} 16:25:11 INFO - TEST-INFO | started process 23500 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpukXERK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:25:12 INFO - PID 23500 | 16:25:12 INFO - PID 23500 | (/builds/slave/test/build/application/firefox/firefox:23549): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:25:12 INFO - PID 23500 | 16:25:23 INFO - PID 23500 | RSS: Main: 146849792 16:25:23 INFO - PID 23500 | 16:25:25 INFO - PID 23500 | Cycle 1(1): loaded http://localhost:45088/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45088/tests/kraken/driver.html?testName=audio-beat-detection) 16:25:26 INFO - PID 23500 | RSS: Main: 152268800 16:25:26 INFO - PID 23500 | 16:25:29 INFO - PID 23500 | Cycle 1(1): loaded http://localhost:45088/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45088/tests/kraken/driver.html?testName=audio-dft) 16:25:29 INFO - PID 23500 | RSS: Main: 152748032 16:25:29 INFO - PID 23500 | 16:25:32 INFO - PID 23500 | Cycle 1(1): loaded http://localhost:45088/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45088/tests/kraken/driver.html?testName=audio-fft) 16:25:33 INFO - PID 23500 | RSS: Main: 149155840 16:25:33 INFO - PID 23500 | 16:25:35 INFO - PID 23500 | Cycle 1(1): loaded http://localhost:45088/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45088/tests/kraken/driver.html?testName=audio-oscillator) 16:25:35 INFO - PID 23500 | RSS: Main: 150429696 16:25:35 INFO - PID 23500 | 16:25:37 INFO - PID 23500 | Cycle 1(1): loaded http://localhost:45088/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45088/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:25:38 INFO - PID 23500 | RSS: Main: 150331392 16:25:38 INFO - PID 23500 | 16:25:41 INFO - PID 23500 | Cycle 1(1): loaded http://localhost:45088/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45088/tests/kraken/driver.html?testName=imaging-darkroom) 16:25:42 INFO - PID 23500 | RSS: Main: 150339584 16:25:42 INFO - PID 23500 | 16:25:45 INFO - PID 23500 | Cycle 1(1): loaded http://localhost:45088/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45088/tests/kraken/driver.html?testName=imaging-desaturate) 16:25:46 INFO - PID 23500 | RSS: Main: 151924736 16:25:46 INFO - PID 23500 | 16:25:49 INFO - PID 23500 | Cycle 1(1): loaded http://localhost:45088/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45088/tests/kraken/driver.html?testName=json-parse-financial) 16:25:49 INFO - PID 23500 | RSS: Main: 152932352 16:25:49 INFO - PID 23500 | 16:25:51 INFO - PID 23500 | Cycle 1(1): loaded http://localhost:45088/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45088/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:25:51 INFO - PID 23500 | RSS: Main: 152887296 16:25:51 INFO - PID 23500 | 16:25:53 INFO - PID 23500 | Cycle 1(1): loaded http://localhost:45088/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45088/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:25:54 INFO - PID 23500 | RSS: Main: 152756224 16:25:54 INFO - PID 23500 | 16:25:56 INFO - PID 23500 | Cycle 1(1): loaded http://localhost:45088/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45088/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:25:56 INFO - PID 23500 | RSS: Main: 149856256 16:25:56 INFO - PID 23500 | 16:25:59 INFO - PID 23500 | Cycle 1(1): loaded http://localhost:45088/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45088/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:25:59 INFO - PID 23500 | RSS: Main: 150040576 16:25:59 INFO - PID 23500 | 16:26:02 INFO - PID 23500 | Cycle 1(1): loaded http://localhost:45088/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45088/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:26:03 INFO - PID 23500 | RSS: Main: 150523904 16:26:03 INFO - PID 23500 | 16:26:04 INFO - PID 23500 | Cycle 1(1): loaded http://localhost:45088/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45088/tests/kraken/driver.html?testName=ai-astar) 16:26:05 INFO - PID 23500 | RSS: Main: 151846912 16:26:05 INFO - PID 23500 | 16:26:05 INFO - PID 23500 | __start_tp_report 16:26:05 INFO - PID 23500 | _x_x_mozilla_page_load 16:26:05 INFO - PID 23500 | _x_x_mozilla_page_load_details 16:26:05 INFO - PID 23500 | |i|pagename|runs| 16:26:05 INFO - PID 23500 | |0;ai-astar;107;104;105;106;105;108;109;106;109;105 16:26:05 INFO - PID 23500 | |1;audio-beat-detection;128;111;116;112;112;125;112;140;113;113 16:26:05 INFO - PID 23500 | |2;audio-dft;161;163;161;161;162;160;162;162;163;165 16:26:05 INFO - PID 23500 | |3;audio-fft;75;73;74;73;74;74;74;86;72;73 16:26:05 INFO - PID 23500 | |4;audio-oscillator;84;82;81;89;77;87;78;78;78;78 16:26:05 INFO - PID 23500 | |5;imaging-gaussian-blur;110;114;109;114;114;114;118;118;113;111 16:26:05 INFO - PID 23500 | |6;imaging-darkroom;151;150;152;151;149;149;150;150;150;149 16:26:05 INFO - PID 23500 | |7;imaging-desaturate;94;94;99;93;94;95;93;94;93;94 16:26:05 INFO - PID 23500 | |8;json-parse-financial;44;44;48;43;44;47;43;43;44;50 16:26:05 INFO - PID 23500 | |9;json-stringify-tinderbox;38;38;38;38;38;47;38;38;38;39 16:26:05 INFO - PID 23500 | |10;stanford-crypto-aes;81;71;72;72;73;72;72;71;73;73 16:26:05 INFO - PID 23500 | |11;stanford-crypto-ccm;103;105;104;110;108;109;106;122;104;104 16:26:05 INFO - PID 23500 | |12;stanford-crypto-pbkdf2;153;148;152;153;165;153;151;151;160;153 16:26:05 INFO - PID 23500 | |13;stanford-crypto-sha256-iterative;69;61;63;59;59;67;60;59;60;63 16:26:05 INFO - PID 23500 | __end_tp_report 16:26:05 INFO - PID 23500 | __start_cc_report 16:26:05 INFO - PID 23500 | _x_x_mozilla_cycle_collect,709 16:26:05 INFO - PID 23500 | __end_cc_report 16:26:05 INFO - PID 23500 | __startTimestamp1505863565155__endTimestamp 16:26:05 INFO - PID 23500 | 16:26:05 INFO - PID 23500 | ------- Summary: start ------- 16:26:05 INFO - PID 23500 | Number of tests: 14 16:26:05 INFO - PID 23500 | 16:26:05 INFO - PID 23500 | [#0] ai-astar Cycles:10 Average:106.40 Median:106.50 stddev:1.78 (1.7%) stddev-sans-first:1.87 16:26:05 INFO - PID 23500 | Values: 107.0 104.0 105.0 106.0 105.0 108.0 109.0 106.0 109.0 105.0 16:26:05 INFO - PID 23500 | 16:26:05 INFO - PID 23500 | [#1] audio-beat-detection Cycles:10 Average:118.20 Median:114.50 stddev:9.68 (8.5%) stddev-sans-first:9.60 16:26:05 INFO - PID 23500 | Values: 128.0 111.0 116.0 112.0 112.0 125.0 112.0 140.0 113.0 113.0 16:26:05 INFO - PID 23500 | 16:26:05 INFO - PID 23500 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.41 (0.9%) stddev-sans-first:1.45 16:26:05 INFO - PID 23500 | Values: 161.0 163.0 161.0 161.0 162.0 160.0 162.0 162.0 163.0 165.0 16:26:05 INFO - PID 23500 | 16:26:05 INFO - PID 23500 | [#3] audio-fft Cycles:10 Average:74.80 Median:74.00 stddev:4.02 (5.4%) stddev-sans-first:4.27 16:26:05 INFO - PID 23500 | Values: 75.0 73.0 74.0 73.0 74.0 74.0 74.0 86.0 72.0 73.0 16:26:05 INFO - PID 23500 | 16:26:05 INFO - PID 23500 | [#4] audio-oscillator Cycles:10 Average:81.20 Median:81.50 stddev:4.24 (5.2%) stddev-sans-first:4.37 16:26:05 INFO - PID 23500 | Values: 84.0 82.0 81.0 89.0 77.0 87.0 78.0 78.0 78.0 78.0 16:26:05 INFO - PID 23500 | 16:26:05 INFO - PID 23500 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:2.99 (2.6%) stddev-sans-first:2.89 16:26:05 INFO - PID 23500 | Values: 110.0 114.0 109.0 114.0 114.0 114.0 118.0 118.0 113.0 111.0 16:26:05 INFO - PID 23500 | 16:26:05 INFO - PID 23500 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:150.00 stddev:0.99 (0.7%) stddev-sans-first:1.00 16:26:05 INFO - PID 23500 | Values: 151.0 150.0 152.0 151.0 149.0 149.0 150.0 150.0 150.0 149.0 16:26:05 INFO - PID 23500 | 16:26:05 INFO - PID 23500 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:1.77 (1.9%) stddev-sans-first:1.87 16:26:05 INFO - PID 23500 | Values: 94.0 94.0 99.0 93.0 94.0 95.0 93.0 94.0 93.0 94.0 16:26:05 INFO - PID 23500 | 16:26:05 INFO - PID 23500 | [#8] json-parse-financial Cycles:10 Average:45.00 Median:44.00 stddev:2.45 (5.6%) stddev-sans-first:2.57 16:26:05 INFO - PID 23500 | Values: 44.0 44.0 48.0 43.0 44.0 47.0 43.0 43.0 44.0 50.0 16:26:05 INFO - PID 23500 | 16:26:05 INFO - PID 23500 | [#9] json-stringify-tinderbox Cycles:10 Average:39.00 Median:38.00 stddev:2.83 (7.4%) stddev-sans-first:2.98 16:26:05 INFO - PID 23500 | Values: 38.0 38.0 38.0 38.0 38.0 47.0 38.0 38.0 38.0 39.0 16:26:05 INFO - PID 23500 | 16:26:05 INFO - PID 23500 | [#10] stanford-crypto-aes Cycles:10 Average:73.00 Median:72.50 stddev:2.91 (4.0%) stddev-sans-first:0.78 16:26:05 INFO - PID 23500 | Values: 81.0 71.0 72.0 72.0 73.0 72.0 72.0 71.0 73.0 73.0 16:26:05 INFO - PID 23500 | 16:26:05 INFO - PID 23500 | [#11] stanford-crypto-ccm Cycles:10 Average:107.50 Median:107.00 stddev:5.62 (5.3%) stddev-sans-first:5.72 16:26:05 INFO - PID 23500 | Values: 103.0 105.0 104.0 110.0 108.0 109.0 106.0 122.0 104.0 104.0 16:26:05 INFO - PID 23500 | 16:26:05 INFO - PID 23500 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.90 Median:153.00 stddev:4.93 (3.2%) stddev-sans-first:5.22 16:26:05 INFO - PID 23500 | Values: 153.0 148.0 152.0 153.0 165.0 153.0 151.0 151.0 160.0 153.0 16:26:05 INFO - PID 23500 | 16:26:05 INFO - PID 23500 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:62.00 stddev:3.53 (5.7%) stddev-sans-first:2.68 16:26:05 INFO - PID 23500 | Values: 69.0 61.0 63.0 59.0 59.0 67.0 60.0 59.0 60.0 63.0 16:26:05 INFO - PID 23500 | -------- Summary: end -------- 16:26:05 INFO - PID 23500 | 16:26:05 INFO - PID 23500 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:26:06 INFO - TEST-INFO | 23500: exit 0 16:26:06 INFO - TEST-OK | kraken | took 59576ms 16:26:06 INFO - SUITE-END | took 1166s 16:26:06 INFO - Completed test suite (00:19:27) 16:26:06 INFO - javascript benchmark 16:26:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9154.862059584073, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3877.515310586175, 3880.437336586195, 3880.941785873211, 3891.435741817435, 3913.6869050475966, 6217.813465596028, 6331.176946996896, 6338.0, 6361.872762544752, 6380.106785050097, 6312.33720459352, 6319.526035547329, 6350.110984462179, 6434.195725534309, 6446.290908000116, 5722.141678748179, 5725.141228815669, 5728.455796699317, 5752.65484070955, 5790.247267855173, 149.8485415154765, 5569.749361278732, 5707.942920570783, 5780.335261444925, 5805.303363596375, 5584.553235741151, 5584.748686309126, 5676.347220069683, 5681.715914204294, 5682.318121825366, 5637.041702910515, 5651.802186923479, 5740.1102829061565, 5745.310562732457, 5753.482186603226, 5608.214849920973, 5637.013522633522, 5682.545396368322, 5708.77164913403, 5721.570882183812, 6255.40573645503, 6288.371162883721, 6320.557560970734, 6379.617222966637, 6384.6169229846355, 6731.427828634572, 6789.388954994074, 6808.931910680879, 6814.761483348059, 6910.378065974036, 6868.347506986828, 6938.826529336757, 6951.304869513059, 6963.1296087989, 6977.302269773033, 6392.904106438407, 6451.225852897635, 6479.838004049937, 6493.480521558264, 6498.610083395011, 7053.858922821515, 7057.18842333128, 7062.187848397397, 7106.395956343666, 7129.536580122275, 6601.438877695354, 6701.396874281338, 6770.187577490733, 6825.829354266183, 6832.111825462757, 6928.861422771516, 6935.3411425914455, 6963.338482844223, 6977.755778547727, 6989.89515157273, 6785.728570857209, 6827.044213810071, 6839.760608378683, 6847.349501797321, 6878.759243426456, 6724.831879203059, 6795.354441328066, 6796.796096117125, 6807.285235050347, 6909.827254318682, 4905.1416002200185, 4940.75296235194, 4947.678400903929, 4954.108260513142, 4954.752262386866, 4473.35136405226, 4510.932336014962, 4537.296719008559, 4577.153226653079, 4580.748058856795, 6260.499160067184, 6272.372762723691, 6280.497560195174, 6357.427831495188, 6363.459105975951, 6828.180618325733, 6836.658167091626, 6903.75836845708, 6914.481413893978, 6916.827079322957, 6227.96886015567, 6310.368963103653, 6311.400416960381, 6320.336364681734, 6361.363863613602, 5476.835694929158, 5511.063119269734, 5522.0, 5528.834134975958, 5548.195511650869, 6869.416099631488, 6994.370506654425, 7112.431005519546, 7125.1093613298335, 7130.180029296594, 6857.519973601899, 6861.416779573792, 6864.313568643096, 6952.44380449573, 6971.721131154798, 6820.795376138723, 7003.439724822104, 7014.158301003912, 7103.2186459488385, 7124.679389427592, 6636.303188165173, 6638.502112341497, 6657.833554161185, 6704.0, 6732.259451460238, 6802.14973128359, 6950.0, 6973.0, 6976.441884649317, 7015.614141222281, 6667.699953502201, 6751.0, 6761.526693131434, 6761.560498567577, 6780.966095169492, 6645.003249512612, 6652.501062420434, 6656.30108838565, 6738.124043874265, 6745.325467453215, 6482.643454610042, 6570.342965703391, 6588.472922166311, 6645.8006259810345, 6659.101021362248, 6680.098186744922, 6730.831729206809, 6739.831504212434, 6762.830929226809, 6769.289224631343, 6481.449076828522, 6490.156279683611, 6574.638394888136, 6579.671016449062, 6587.670616469253], "value": 6222.071090496677, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [966.304260932129, 978.8482785168297, 982.4792859784308, 984.2470510059806, 992.4690290694477, 40412.19175616486, 44805.327920081225, 45043.77478112605, 45168.548314516884, 45224.321635175496, 42329.788351058276, 42428.0, 42489.7875510622, 42597.574024259746, 42660.573394266044, 7662.88505672414, 7716.961415192916, 7779.105402878685, 8501.574921253912, 8691.435056721324, 8206.671733130668, 8254.133316001824, 8268.09051004389, 8268.214519620626, 8273.793155171108, 8205.425620206588, 8231.053428855668, 8256.25693687568, 8264.090949995496, 8287.212714792115, 8186.713465028725, 8239.95880020599, 8257.752267431986, 8261.752147435587, 8263.380246481507, 8509.149085091503, 8557.358198135102, 8576.528290943996, 8594.097619749899, 8603.741887743377, 41119.383209251886, 41314.586854131376, 41409.378859317134, 41487.0, 41692.166156677, 3809.4476300936485, 3843.9231215375817, 3846.211526637033, 3846.442265871461, 3846.499955005859, 33512.6648733512, 33679.0, 33693.494597581055, 33767.493487597705, 33783.0, 5533.6403133796175, 5537.556995440355, 5573.0, 5580.832575022756, 5750.166225897222, 224838.0, 227406.0, 227633.0, 227840.0, 228376.0, 47963.280550791766, 48885.51114488809, 54282.18576721352, 54710.0, 54776.17835732467, 48918.755406223456, 57662.0, 57962.0, 58711.0, 58758.0, 16530.0, 16563.08903010346, 16661.583460413345, 16664.75002874958, 16713.415030473876, 13400.597982060553, 13496.257705826274, 13500.459981600627, 13504.662383440493, 13511.121777084458, 15378.846211537964, 15465.14941678196, 15474.0, 15542.766858497132, 15647.295871685801, 6118.898598252268, 6205.937940620626, 6229.719662615194, 6284.214473190851, 6309.211348581427, 1100.1693721240572, 1115.760111576015, 1116.5143162724241, 1117.0672488472055, 1125.6397952655236, 26084.34789130249, 26121.608175877376, 26156.607650885253, 26300.21099367022, 26316.473670526866, 1206.9396530173456, 1208.1301462946665, 1210.1045226532303, 1211.763706077324, 1224.8897599215936, 13517.324133793467, 13699.246541440316, 13768.655783605289, 13811.861881381057, 13922.164670119826, 288177.0, 288863.0, 289337.0, 289550.0, 289830.0, 60024.0, 60024.39975600188, 60333.69833150894, 60411.39588604146, 60499.99999999912, 1491.9552413427614, 1501.2718831366778, 1542.691461707663, 1553.7747026681068, 1558.7116383469095, 25547.872260638578, 25812.22563323103, 25841.870790645928, 25859.741402586485, 26197.214083577524, 43181.352279716455, 43207.78396108125, 43267.56732432635, 43298.78350608227, 43304.78347608242, 247750.0, 249472.0, 249761.0, 250087.0, 250253.0, 37132.62867371292, 40020.19959600733, 40467.797661012686, 40486.0, 40566.1886762269, 50792.23811642754, 52552.73723631357, 52599.0, 52718.47281527136, 52982.73508632432, 37676.2464750709, 37679.81160094182, 37679.81160094182, 37722.62277377301, 38199.04502387463, 37962.0, 38008.0, 38221.61778382181, 38235.61764382432, 38293.42559861549, 43664.781676091414, 44789.77605112084, 44814.55185448104, 44948.77525612482, 45057.774711126236, 35514.8224258877, 36236.81881590575, 36327.27345453129, 36488.452673209395, 36802.63197368099, 27489.31276718018, 27855.02507412231, 27988.72011279861, 28099.859500702365, 28281.0], "value": 19180.272211433934, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.138397939009, 602.3494625804129, 610.5420934299276, 620.8199622109588, 639.3606393606393, 23353.76646233537, 23501.589904605735, 23915.28254152376, 24024.87987560064, 24078.75921240789, 25477.0, 25509.617355739632, 25801.967921283125, 25851.22446326613, 25861.74138258617, 6468.385503377183, 6591.176102987127, 6642.5350225484235, 6653.234877989021, 6656.667166641672, 6501.804945851632, 6692.799216023527, 6729.293424190463, 6759.526833121683, 6773.1872175338785, 6710.832229194285, 6724.5965242085385, 6741.9887016947605, 6756.020377045325, 6762.594244345355, 6515.543911926144, 6721.193456785192, 6736.562123461984, 6737.124173857416, 6752.763653272112, 6193.225846769154, 6264.310925798159, 6291.213598300213, 6313.936860631381, 6318.74725010999, 29136.854315728287, 29904.70095299041, 30275.697243027727, 30466.238344041354, 30468.0, 2186.9234576789895, 2223.833212509052, 2230.241717815934, 2231.2859884836857, 2232.631615783394, 19991.60016799656, 20541.28105516315, 20588.588228235352, 20612.484687882774, 20648.896755516125, 2494.6881639795024, 2574.292069680834, 2585.831920925134, 2586.3275548357374, 2631.1711810779543, 135580.32209838985, 143209.0, 146909.2654536731, 150429.0, 157068.0, 15424.305906234247, 15497.767533487007, 15915.283812228477, 15954.60113497172, 16541.421050263183, 25524.617130743052, 25595.74404255971, 25633.0, 25636.871815641174, 25756.227313180636, 10101.949490252502, 10526.736831579272, 10622.490059765765, 10636.149108071335, 10638.414887181125, 9429.622815087458, 9560.235181185488, 9594.568244429018, 9648.565814538362, 9651.855222171673, 9610.279229057849, 9744.415335079917, 9753.780777402824, 9777.21782257432, 9879.753006174904, 2741.2598598378327, 2764.433291175304, 2844.416894536615, 2850.446128658217, 2916.5187744022423, 996.6860438961704, 1036.9585216591402, 1044.1438020822852, 1052.5789684126257, 1062.8033813744328, 20713.925592400417, 21146.0, 21278.468038299165, 21340.893295533424, 21532.13871445156, 1054.530733823441, 1099.301943266032, 1100.5432745410565, 1101.5043230546287, 1105.1103861391657, 11284.943575282236, 11749.236299640495, 11894.554866045031, 11915.0, 12059.155859089955, 621499.0, 624211.0, 630982.0, 631146.0, 638456.0, 127687.0, 127750.0, 129381.0, 129590.35204823916, 130175.34912325378, 1209.7701436726993, 1216.3735676126803, 1248.650377894191, 1254.3728135932033, 1255.334672623511, 18677.252909883453, 18814.526601752234, 18858.339958101402, 18893.149808258386, 18979.145938432528, 62462.68768656128, 63172.0, 63276.68361658162, 63819.0, 64299.35700643121, 79475.60262198652, 81022.59488702519, 81168.0, 82518.58740706499, 83425.0, 15122.924385378003, 15314.693706126038, 15753.0, 15799.0, 15807.446739364066, 24495.0, 24582.631260531463, 24646.137385191432, 24784.50430991406, 24882.626760598243, 19905.701414479085, 19934.90032549886, 20042.89978550098, 20227.494312641713, 20233.392998210078, 16953.406630767862, 17126.657466850844, 17176.91411542984, 17248.482545523653, 17757.378491752726, 19329.226830926604, 20488.078036488692, 20712.792872071688, 20774.792252077285, 20979.58040839144, 15588.532344029698, 15719.607009824846, 15721.528354148937, 15736.213189340717, 15742.134182620066, 19186.80813191906, 19554.60890782205, 19604.705929410786, 19608.0, 19659.70510442373], "value": 12751.439606029582, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1422.6870088580513, 1468.4243866185832, 1471.4261438039166, 1485.6285928517873, 1489.515907330118, 16508.339666413343, 17193.828061719396, 17196.312147514083, 17214.225359858807, 17233.91383043083, 16753.748693769605, 16916.746248806277, 16936.153192340364, 17017.319307227728, 17020.0, 2729.972700272992, 2780.8470534120615, 2781.4576157649267, 2782.0, 2783.401568662737, 2631.5657916443765, 2710.268227578553, 2713.4573085382904, 2717.605947137664, 2718.972810271892, 2847.0, 2963.0073925235074, 2966.9554956675665, 2967.213688372583, 2968.0650595062484, 2849.6722876869217, 2866.068527728486, 2879.3665393613373, 2882.5964364988813, 2887.581300711406, 2812.3953350029637, 2891.81203221792, 2928.2825707701536, 2930.4871647461823, 2932.1936467471614, 16861.578460538585, 17015.064171470563, 17022.404215852508, 17028.063456509888, 17033.403830865984, 8371.246587807127, 8443.451175673561, 8779.517126558037, 8780.0, 8784.429012114193, 5804.738786754606, 5912.0, 5964.403559644044, 5990.9700451497465, 6013.398660133996, 2184.5740080684272, 2445.3397582652583, 2628.2378110347977, 2659.734026597325, 2681.6245725598433, 31692.841535792402, 31709.524357134662, 31918.680813191804, 31962.520562191352, 32006.0, 7111.217766045731, 7287.2712728727765, 7344.081989751281, 7454.217307182667, 7548.131964824006, 19526.804731952783, 19537.60924781525, 19561.315353962542, 19629.11668974871, 19710.507237318896, 8364.079951205362, 8474.915250847413, 8476.025257095513, 8561.52911589856, 8576.356773242032, 7739.535627862347, 7856.096548896836, 7892.960535197402, 7910.564918929399, 7985.041794984639, 5646.153077038477, 5742.511886489695, 5786.826395208151, 5789.884202316014, 6100.572959892854, 1619.1580378203269, 1679.3114822922544, 1679.6388776412884, 1682.3102527963476, 1703.540044188087, 965.9661911833052, 987.2990176974429, 987.3335498538602, 1009.0716540782352, 1019.3883669798211, 8685.739427817176, 8701.347398945105, 8743.956280218557, 9263.25893928484, 9883.406995580288, 768.4390395011673, 797.5015615240475, 802.193795235796, 808.1635507250086, 815.6256707447969, 5109.948900510947, 5759.366469688331, 5779.557159880134, 5793.131030345482, 5936.851578710567, 24163.63754543683, 25016.24951251429, 25199.87400062988, 25245.62131568028, 25295.114670986793, 23250.65124023141, 24439.144629937866, 24575.508489830103, 24839.130630427848, 25088.372790680012, 10098.242631802645, 10537.104346130665, 11539.076873850072, 11554.711132221593, 11773.529058837721, 9974.700758977242, 9999.400035997864, 10030.448325342177, 10234.181265498593, 10278.743031424274, 20939.8953005234, 21193.78806211918, 21239.57520849605, 21290.148394064065, 21681.89159054258, 21752.238671646417, 21922.23272185466, 21998.45003874916, 22057.448563786034, 22336.21823236179, 12044.638660840188, 12187.085968552572, 12188.75622487563, 12197.231401446918, 12206.206596571194, 15215.315310811262, 15621.921890390475, 15723.0, 15728.76406853921, 15754.133522656364, 12580.559680411141, 12597.307148106576, 12630.43163057683, 12695.746085078432, 13113.0, 11963.222390544586, 12056.819147712617, 12091.274523528617, 12373.319467429377, 12426.316552589695, 11082.944585277022, 11097.778044438905, 11107.278026928223, 11238.66284011481, 11291.266067705574, 8370.037445693579, 8391.832163356577, 8425.620847061775, 8482.703105391281, 8555.401121921406, 8442.409031367746, 8461.32309415233, 8542.231199192103, 8575.485470871768, 8644.91355086441], "value": 7355.813154751945, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.751805410484, 551.8896220755847, 562.606175677026, 575.3010092737323, 580.3471095018105, 6364.0, 6365.363463653633, 6382.8404289892715, 6407.070974708665, 6414.71133798979, 6180.783672571461, 6253.1870856788555, 6269.905951410732, 6274.592151510149, 6349.746010159588, 5089.854782673906, 5127.871868188992, 5138.126518491847, 5146.459621739719, 5156.762377029505, 4996.700197988114, 5087.6184286178495, 5101.821436249732, 5107.0, 5136.024155410479, 4815.927761083586, 4891.951080489185, 4919.77860996256, 4928.137575924216, 5005.499450055002, 4928.260760885896, 4950.752462376867, 4967.950320496821, 4969.403671559436, 4982.402111746595, 4399.0, 4477.261251893467, 4495.617872480843, 4516.20966330894, 4517.819287228507, 6161.784337548164, 6173.166622505994, 6179.907301390483, 6195.969020154916, 6225.284092329395, 5850.502707269887, 5860.472557469806, 5868.706564671749, 5875.471207591295, 5896.204012458306, 6611.9338806611795, 6639.634820084893, 6652.2017357916875, 6711.597304161766, 6724.731010759564, 4819.180739274332, 5066.721330326831, 5074.5432911037815, 5078.2128770040335, 5087.186050231945, 6802.931970680279, 6811.863762724767, 6867.793966181022, 6944.826379340507, 6981.3367730065565, 5119.078565858107, 5133.153029750049, 5154.793808247703, 5156.303898973665, 5162.845114646567, 5142.6914385137015, 5183.092958732207, 5219.191025390995, 5239.816606418757, 5241.397239317527, 5811.186433899257, 5813.331466881278, 5819.970900145472, 5820.912686309709, 5844.415558444121, 6686.231083425371, 6704.865902681919, 6709.597424154566, 6712.228093769279, 6739.460843132538, 1793.3006127610242, 1805.0794095011638, 1808.023667219713, 1819.854411647065, 1832.9633407331778, 1208.572942825582, 1263.1158189267549, 1263.279930439659, 1263.8357013588359, 1270.371166272701, 6102.511799056065, 6157.476614487819, 6188.381161883865, 6196.690165491707, 6250.4374606285655, 6710.765123220664, 6715.597064176165, 6746.696398661974, 6837.453003759687, 6860.451163906875, 6068.817935461943, 6129.233845769279, 6181.84545386369, 6208.782692605737, 6246.094941043026, 3372.1906742382143, 3517.0, 3550.7336949728874, 3570.6072332043454, 3591.676749092594, 6762.357576030269, 6893.414059804973, 6938.861222775517, 6999.195092564319, 7002.894956575656, 6773.627450490172, 6801.3612717196065, 6858.759943402057, 6907.412869906114, 6925.965370173218, 6860.622665753332, 6868.759593414306, 6950.513464057467, 6982.965085174542, 7010.649467526603, 6658.300878407891, 6689.799306020827, 6728.865422691617, 6775.62734049632, 6787.21946976104, 6686.465082793267, 6732.663366831541, 6740.9325906740305, 6754.93245067543, 6770.52606317553, 6770.424513916372, 6829.829254268683, 6877.317846040149, 6939.716152511802, 6944.826379340557, 5143.099957507496, 5154.252633368065, 5168.121419358793, 5174.033867130466, 5175.896482070413, 6518.837029074311, 6569.4744420447205, 6752.696128674123, 6875.759348422781, 6919.481038922, 6497.73294207625, 6525.0, 6563.343665633399, 6575.145231119924, 6640.136782218281, 6434.774782882577, 6454.838629034124, 6458.22501299847, 6488.286288508355, 6544.738210471528, 6317.526185536011, 6456.7740129095255, 6473.805785826433, 6483.902741458787, 6509.707063182073, 6592.0111983202905, 6638.535302528777, 6657.234418041987, 6712.6979285931275, 6726.3609957054005, 6420.422162005442, 6449.290578036318, 6455.837294506393, 6493.902591461227, 6517.543771936109], "value": 5170.61434136562, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [956.870822438971, 988.6885631026227, 999.6351331763906, 1026.296986564203, 1029.4235228272169, 21190.25834095807, 21569.352919412402, 21574.784252157475, 21590.24434144805, 21593.35219943404, 19828.504287392785, 20098.59802803943, 20209.292674756387, 20228.59542809143, 20268.0, 1053.7365658585372, 1067.268920789258, 1068.1988508618535, 1069.2782371898977, 1075.7471994081384, 1082.7076689293885, 1084.766775143344, 1087.7715679707271, 1089.7820435912809, 1090.0462095666292, 1070.2347821307762, 1104.7403860092911, 1118.5637601335486, 1126.6507382711386, 1130.7060164357285, 1116.6315116011697, 1122.1976286954784, 1123.7583919457275, 1126.1835169502128, 1126.8929451702074, 793.3613441179848, 814.1614137438448, 814.5112932240609, 820.2044017303207, 832.1803024021334, 18880.811191888042, 18944.905275473673, 18951.336703215322, 18960.810391896044, 18975.905120474446, 22566.77433225663, 22600.88699556508, 23658.171963981178, 23734.76265237343, 23855.165069222494, 17809.376671816422, 17992.370267040722, 18093.095345232687, 18105.63788724218, 18165.36421225251, 3947.1513624570566, 3964.306246406867, 3979.1643754811525, 3984.342583473723, 3988.441618173429, 125908.37045814712, 154370.0, 154704.0, 155100.0, 158055.0, 19218.4234472966, 19291.0, 19379.127939242488, 19537.804621953597, 19806.0, 35080.47379289313, 35265.64734352675, 35316.29367412638, 35336.293274134376, 35505.46741798875, 9441.197498212729, 9442.858357124649, 9444.102810233016, 9450.338476306593, 9453.763655908657, 4347.869563913087, 4381.18947994622, 4442.133783912106, 4486.371907932892, 4489.685721999494, 6112.083187521907, 6261.624302541862, 6272.435480806749, 6293.842653933597, 6294.968525157345, 1245.8131280308025, 1264.3046324521476, 1285.5243559882904, 1290.1742884553894, 1293.0108467022735, 696.1506961506954, 710.3535782437957, 711.2567367101288, 727.5343779980816, 746.1270313732946, 12310.630681079581, 13217.669558260928, 13725.519606813914, 14113.929430352782, 14192.432302707775, 691.3039147325371, 700.58315302395, 705.5343473307593, 714.1893950366268, 719.4963525532148, 6273.153124328249, 6387.840303992437, 6410.102585638015, 6415.1981002374705, 6460.838479038061, 140244.0, 146107.0, 147429.0, 149357.2532137354, 153895.0, 124694.0, 128745.3562732199, 130389.0, 130568.0, 135937.0, 113081.0, 116149.0, 120168.3991580054, 120215.39892300483, 123156.38421807834, 14092.506762263272, 14305.570832874613, 14309.211348581428, 14491.130532168103, 14600.0, 53285.7335713319, 53631.46368536421, 54092.72953635207, 54186.0, 54511.454885450636, 71749.0, 72087.63956180395, 72109.27890721236, 72669.0, 73936.63031684807, 18784.15471303822, 18894.905525472284, 18993.050347482847, 19086.713699294243, 19152.946587937797, 21291.148354066285, 21299.041543130286, 21356.35930922075, 21495.355139345844, 21534.138634454448, 21269.0, 21510.8924455383, 21512.0, 21594.8920255404, 21776.237831675815, 18210.0, 18333.39969737999, 18366.72449913279, 18371.90814045921, 18529.72205416947, 19129.617407652047, 19195.520111997314, 19334.12996415193, 19511.60976780428, 19602.50993725168, 13689.178649281075, 13922.373493192628, 14048.438062477795, 14146.78779818324, 14259.358328875018, 13438.46246150143, 13501.932490337485, 13616.31918404056, 13626.863731362559, 13761.38073786662], "value": 10170.94826525667, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1380.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 104.0, 105.0, 106.0, 105.0, 108.0, 109.0, 106.0, 109.0, 105.0], "value": 106.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 111.0, 116.0, 112.0, 112.0, 125.0, 112.0, 140.0, 113.0, 113.0], "value": 118.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 161.0, 162.0, 160.0, 162.0, 162.0, 163.0, 165.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 74.0, 73.0, 74.0, 74.0, 74.0, 86.0, 72.0, 73.0], "value": 74.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 81.0, 89.0, 77.0, 87.0, 78.0, 78.0, 78.0, 78.0], "value": 81.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 109.0, 114.0, 114.0, 114.0, 118.0, 118.0, 113.0, 111.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 152.0, 151.0, 149.0, 149.0, 150.0, 150.0, 150.0, 149.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 99.0, 93.0, 94.0, 95.0, 93.0, 94.0, 93.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 44.0, 48.0, 43.0, 44.0, 47.0, 43.0, 43.0, 44.0, 50.0], "value": 45.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 47.0, 38.0, 38.0, 38.0, 39.0], "value": 39.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 71.0, 72.0, 72.0, 73.0, 72.0, 72.0, 71.0, 73.0, 73.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 105.0, 104.0, 110.0, 108.0, 109.0, 106.0, 122.0, 104.0, 104.0], "value": 107.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 148.0, 152.0, 153.0, 165.0, 153.0, 151.0, 151.0, 160.0, 153.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 61.0, 63.0, 59.0, 59.0, 67.0, 60.0, 59.0, 60.0, 63.0], "value": 62.0, "unit": "score"}]}]} 16:26:06 INFO - Return code: 0 16:26:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:26:06 INFO - # TBPL SUCCESS # 16:26:06 INFO - Running post-action listener: _package_coverage_data 16:26:06 INFO - Running post-action listener: _resource_record_post_action 16:26:06 INFO - [mozharness: 2017-09-19 23:26:06.440284Z] Finished run-tests step (success) 16:26:06 INFO - Running post-run listener: _resource_record_post_run 16:26:06 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 329555968; Read time: 0; Write time: 248772 16:26:06 INFO - TinderboxPrint: CPU usage
13.1% 16:26:06 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:26:06 INFO - TinderboxPrint: I/O write bytes / time
329,555,968 / 248,772 16:26:06 INFO - TinderboxPrint: CPU idle
8,212.6 (86.9%) 16:26:06 INFO - TinderboxPrint: CPU user
1,186.0 (12.6%) 16:26:06 INFO - TinderboxPrint: Swap in / out
0 / 0 16:26:06 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10027008; Read time: 0; Write time: 1800 16:26:06 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:26:06 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 0; Write bytes: 319127552; Read time: 0; Write time: 246968 16:26:07 INFO - Running post-run listener: _upload_blobber_files 16:26:07 INFO - Blob upload gear active. 16:26:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:26:07 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:26:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:26:07 INFO - (blobuploader) - INFO - Open directory for files ... 16:26:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:26:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:26:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:26:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:26:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:26:08 INFO - (blobuploader) - INFO - Done attempting. 16:26:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:26:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:26:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:26:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:26:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:26:15 INFO - (blobuploader) - INFO - Done attempting. 16:26:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:26:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:26:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:26:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:26:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:26:16 INFO - (blobuploader) - INFO - Done attempting. 16:26:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:26:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:26:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:26:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:26:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:26:17 INFO - (blobuploader) - INFO - Done attempting. 16:26:17 INFO - (blobuploader) - INFO - Iteration through files over. 16:26:17 INFO - Return code: 0 16:26:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:26:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:26:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81b6d8abe7eabc9dd87b4cfa93aed4071f4c00fc39c4ed05575b9b029545584f214d82d10bd84622f95ec700b4a9e44635268aa98dfeb6050ae2084e54836563", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8213541aab2fa7f576773acdc68028e90b35ff309b5e1d4a00ea003e6a423a359dd13c97f50d9fbffc7291e220bdffd1165a432ab5a3b92110016e9214323e74", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87081433a11cd86b6d0ba94a6511028e964c97c1f981916fe85fde9b0d7da305955cfbdc88ccca711c0a454645ba0b5a58c928ef2564e1c8ca073e1b78ae56a1", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d1c3cfceeec315c375125848cd54f5f881306fc1ce0dad01c3476686d009d82c15d1b6492ed3c8cb77ac1384d69684a3185864213e6d458a83896bdb1dfe9b5"} 16:26:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:26:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:26:17 INFO - Contents: 16:26:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81b6d8abe7eabc9dd87b4cfa93aed4071f4c00fc39c4ed05575b9b029545584f214d82d10bd84622f95ec700b4a9e44635268aa98dfeb6050ae2084e54836563", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8213541aab2fa7f576773acdc68028e90b35ff309b5e1d4a00ea003e6a423a359dd13c97f50d9fbffc7291e220bdffd1165a432ab5a3b92110016e9214323e74", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87081433a11cd86b6d0ba94a6511028e964c97c1f981916fe85fde9b0d7da305955cfbdc88ccca711c0a454645ba0b5a58c928ef2564e1c8ca073e1b78ae56a1", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d1c3cfceeec315c375125848cd54f5f881306fc1ce0dad01c3476686d009d82c15d1b6492ed3c8cb77ac1384d69684a3185864213e6d458a83896bdb1dfe9b5"} 16:26:17 INFO - Running post-run listener: copy_logs_to_upload_dir 16:26:17 INFO - Copying logs to upload dir... 16:26:17 INFO - mkdir: /builds/slave/test/build/upload/logs 16:26:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.487953 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-19 16:26:17.542227) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 16:26:17.549777) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81b6d8abe7eabc9dd87b4cfa93aed4071f4c00fc39c4ed05575b9b029545584f214d82d10bd84622f95ec700b4a9e44635268aa98dfeb6050ae2084e54836563", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8213541aab2fa7f576773acdc68028e90b35ff309b5e1d4a00ea003e6a423a359dd13c97f50d9fbffc7291e220bdffd1165a432ab5a3b92110016e9214323e74", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87081433a11cd86b6d0ba94a6511028e964c97c1f981916fe85fde9b0d7da305955cfbdc88ccca711c0a454645ba0b5a58c928ef2564e1c8ca073e1b78ae56a1", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d1c3cfceeec315c375125848cd54f5f881306fc1ce0dad01c3476686d009d82c15d1b6492ed3c8cb77ac1384d69684a3185864213e6d458a83896bdb1dfe9b5"} build_url:https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011394 build_url: 'https://queue.taskcluster.net/v1/task/Y7gb7BDOTseBUm1jZrOsyg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81b6d8abe7eabc9dd87b4cfa93aed4071f4c00fc39c4ed05575b9b029545584f214d82d10bd84622f95ec700b4a9e44635268aa98dfeb6050ae2084e54836563", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8213541aab2fa7f576773acdc68028e90b35ff309b5e1d4a00ea003e6a423a359dd13c97f50d9fbffc7291e220bdffd1165a432ab5a3b92110016e9214323e74", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87081433a11cd86b6d0ba94a6511028e964c97c1f981916fe85fde9b0d7da305955cfbdc88ccca711c0a454645ba0b5a58c928ef2564e1c8ca073e1b78ae56a1", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d1c3cfceeec315c375125848cd54f5f881306fc1ce0dad01c3476686d009d82c15d1b6492ed3c8cb77ac1384d69684a3185864213e6d458a83896bdb1dfe9b5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 16:26:17.578701) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 16:26:17.578993) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505861330.420604-199020278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 16:26:17.661075) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 16:26:17.664385) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 16:26:17.664682) ========= ========= Total master_lag: 0.29 =========