builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-005 starttime: 1506536850.53 results: success (0) revision: 756e10aa8bbd416cbc49b7739f78fb81d5525477 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 11:27:30.531056) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 11:27:30.531679) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 11:27:30.531972) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 11:27:30.581961) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:27:30.582315) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-27 11:27:30-- 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% 225M=0s 2017-09-27 11:27:30 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124123 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:27:30.724081) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:27:30.724398) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016107 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:27:30.773934) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:27:30.774270) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 756e10aa8bbd416cbc49b7739f78fb81d5525477 --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 756e10aa8bbd416cbc49b7739f78fb81d5525477 --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=7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-27 11:27:31,030 truncating revision to first 12 chars 2017-09-27 11:27:31,030 Setting DEBUG logging. 2017-09-27 11:27:31,030 attempt 1/10 2017-09-27 11:27:31,031 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/756e10aa8bbd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-27 11:27:31,284 unpacking tar archive at: mozilla-central-756e10aa8bbd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.605289 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:27:31.395469) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 11:27:31.395738) ========= script_repo_revision: 756e10aa8bbd416cbc49b7739f78fb81d5525477 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 11:27:31.396108) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 11:27:31.396397) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 11:27:31.414511) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-27 11:27:31.414919) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:27:31 INFO - MultiFileLogger online at 20170927 11:27:31 in /builds/slave/test 11:27:31 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 11:27:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:27:31 INFO - {'append_to_log': False, 11:27:31 INFO - 'base_work_dir': '/builds/slave/test', 11:27:31 INFO - 'blob_upload_branch': 'Firefox', 11:27:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:27:31 INFO - 'branch': 'Firefox', 11:27:31 INFO - 'buildbot_json_path': 'buildprops.json', 11:27:31 INFO - 'code_coverage': False, 11:27:31 INFO - 'config_files': ('talos/linux_config.py',), 11:27:31 INFO - 'default_actions': ('clobber', 11:27:31 INFO - 'read-buildbot-config', 11:27:31 INFO - 'download-and-extract', 11:27:31 INFO - 'populate-webroot', 11:27:31 INFO - 'create-virtualenv', 11:27:31 INFO - 'install', 11:27:31 INFO - 'setup-mitmproxy', 11:27:31 INFO - 'run-tests'), 11:27:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:27:31 INFO - 'disable_ccov_upload': False, 11:27:31 INFO - 'disable_stylo': False, 11:27:31 INFO - 'download_minidump_stackwalk': True, 11:27:31 INFO - 'download_symbols': 'ondemand', 11:27:31 INFO - 'enable_stylo': False, 11:27:31 INFO - 'enable_webrender': False, 11:27:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:27:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:27:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:27:31 INFO - 'gecko_profile': False, 11:27:31 INFO - 'gecko_profile_interval': 0, 11:27:31 INFO - 'installer_path': 'installer.exe', 11:27:31 INFO - 'log_level': 'info', 11:27:31 INFO - 'log_name': 'talos', 11:27:31 INFO - 'log_to_console': True, 11:27:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:27:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:27:31 INFO - 'opt_config_files': (), 11:27:31 INFO - 'pip_index': False, 11:27:31 INFO - 'suite': 'dromaeojs-e10s', 11:27:31 INFO - 'system_bits': '32', 11:27:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:27:31 INFO - 'title': 'talos-linux64-ix-005', 11:27:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:27:31 INFO - 'use_talos_json': True, 11:27:31 INFO - 'verify': 'False', 11:27:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:27:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:27:31 INFO - 'work_dir': 'build'} 11:27:31 INFO - [mozharness: 2017-09-27 18:27:31.806988Z] Running clobber step. 11:27:31 INFO - Running pre-action listener: _resource_record_pre_action 11:27:31 INFO - Running main action method: clobber 11:27:31 INFO - rmtree: /builds/slave/test/build 11:27:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:27:32 INFO - Running post-action listener: _resource_record_post_action 11:27:32 INFO - [mozharness: 2017-09-27 18:27:32.818587Z] Finished clobber step (success) 11:27:32 INFO - [mozharness: 2017-09-27 18:27:32.818684Z] Running read-buildbot-config step. 11:27:32 INFO - Running pre-action listener: _resource_record_pre_action 11:27:32 INFO - Running main action method: read_buildbot_config 11:27:32 INFO - Using buildbot properties: 11:27:32 INFO - { 11:27:32 INFO - "project": "", 11:27:32 INFO - "product": "firefox", 11:27:32 INFO - "who": "ffxbld@noreply.mozilla.org", 11:27:32 INFO - "installer_path": "public/build/target.tar.bz2", 11:27:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 11:27:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:27:32 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 11:27:32 INFO - "stage_platform": "linux64-qr", 11:27:32 INFO - "basedir": "/builds/slave/test", 11:27:32 INFO - "buildnumber": 88, 11:27:32 INFO - "platform": "ubuntu64_hw_qr", 11:27:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:27:32 INFO - "slavebuilddir": "test", 11:27:32 INFO - "taskId": "clOxuEEvRIKZbZBU8dq-lg", 11:27:32 INFO - "branch": "mozilla-central", 11:27:32 INFO - "script_repo_revision": "production", 11:27:32 INFO - "revision": "756e10aa8bbd416cbc49b7739f78fb81d5525477", 11:27:32 INFO - "slavename": "talos-linux64-ix-005", 11:27:32 INFO - "repo_path": "mozilla-central" 11:27:32 INFO - } 11:27:32 INFO - Finding installer, test and symbols from parent task. 11:27:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/clOxuEEvRIKZbZBU8dq-lg'}, attempt #1 11:27:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/clOxuEEvRIKZbZBU8dq-lg'}, attempt #1 11:27:33 INFO - Task dependencies: d8mZXx0pQCyLHthBkHAPng 11:27:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng'}, attempt #1 11:27:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.tar.bz2 11:27:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.test_packages.json 11:27:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.crashreporter-symbols.zip 11:27:34 INFO - Running post-action listener: _resource_record_post_action 11:27:34 INFO - [mozharness: 2017-09-27 18:27:34.200818Z] Finished read-buildbot-config step (success) 11:27:34 INFO - [mozharness: 2017-09-27 18:27:34.201036Z] Running download-and-extract step. 11:27:34 INFO - Running pre-action listener: _resource_record_pre_action 11:27:34 INFO - Running main action method: download_and_extract 11:27:34 INFO - mkdir: /builds/slave/test/build/tests 11:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:34 INFO - trying https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.test_packages.json 11:27:34 INFO - Downloading https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:27:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:27:34 INFO - Downloaded 989 bytes. 11:27:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:27:34 INFO - Using the following test package requirements: 11:27:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:27:34 INFO - u'common': [u'target.common.tests.zip'], 11:27:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:27:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:27:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:27:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:27:34 INFO - u'mozbase': [u'target.common.tests.zip'], 11:27:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:27:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:27:34 INFO - u'web-platform': [u'target.common.tests.zip', 11:27:34 INFO - u'target.web-platform.tests.tar.gz'], 11:27:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:27:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:27:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.common.tests.zip 11:27:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:27:34 INFO - Fetch https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.common.tests.zip into memory 11:27:36 INFO - Content-Length response header: 54946080 11:27:36 INFO - Bytes received: 54946080 11:27:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.talos.tests.zip 11:27:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:27:47 INFO - Fetch https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.talos.tests.zip into memory 11:27:49 INFO - Content-Length response header: 14513665 11:27:49 INFO - Bytes received: 14513665 11:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:49 INFO - trying https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.tar.bz2 11:27:49 INFO - Downloading https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:27:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:27:51 INFO - Downloaded 61658681 bytes. 11:27:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.tar.bz2 11:27:51 INFO - mkdir: /builds/slave/test/properties 11:27:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:27:51 INFO - Writing to file /builds/slave/test/properties/build_url 11:27:51 INFO - Contents: 11:27:51 INFO - build_url:https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.tar.bz2 11:27:51 INFO - Running post-action listener: _resource_record_post_action 11:27:51 INFO - Running post-action listener: find_tests_for_verification 11:27:51 INFO - Running post-action listener: set_extra_try_arguments 11:27:51 INFO - [mozharness: 2017-09-27 18:27:51.734929Z] Finished download-and-extract step (success) 11:27:51 INFO - [mozharness: 2017-09-27 18:27:51.735027Z] Running populate-webroot step. 11:27:51 INFO - Running pre-action listener: _resource_record_pre_action 11:27:51 INFO - Running main action method: populate_webroot 11:27:51 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:27:51 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:27:51 INFO - 'tests': ['tresize', 11:27:51 INFO - 'tcanvasmark']}, 11:27:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:27:51 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:27:51 INFO - 'tests': ['dromaeo_css', 11:27:51 INFO - 'kraken']}, 11:27:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:27:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:27:51 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:27:51 INFO - 'talos_options': ['--disable-stylo'], 11:27:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:27:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:27:51 INFO - 'tests': ['damp', 'tps']}, 11:27:51 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:27:51 INFO - 'talos_options': ['--disable-stylo'], 11:27:51 INFO - 'tests': ['damp', 'tps']}, 11:27:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:27:51 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:27:51 INFO - 'tests': ['dromaeo_dom']}, 11:27:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:27:51 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:27:51 INFO - 'tests': ['basic_compositor_video', 11:27:51 INFO - 'glvideo']}, 11:27:51 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:27:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:27:51 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:27:51 INFO - 'talos_options': ['--disable-stylo'], 11:27:51 INFO - 'tests': ['ts_paint_webext', 11:27:51 INFO - 'tp5o_webext']}, 11:27:51 INFO - 'other-e10s': {'tests': ['a11yr', 11:27:51 INFO - 'ts_paint', 11:27:51 INFO - 'tpaint', 11:27:51 INFO - 'sessionrestore', 11:27:51 INFO - 'sessionrestore_many_windows', 11:27:51 INFO - 'sessionrestore_no_auto_restore', 11:27:51 INFO - 'tabpaint']}, 11:27:51 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:27:51 INFO - 'tests': ['a11yr', 11:27:51 INFO - 'ts_paint', 11:27:51 INFO - 'tpaint', 11:27:51 INFO - 'sessionrestore', 11:27:51 INFO - 'sessionrestore_many_windows', 11:27:51 INFO - 'sessionrestore_no_auto_restore', 11:27:51 INFO - 'tabpaint']}, 11:27:51 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 11:27:51 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:27:51 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:27:51 INFO - 'tests': ['perf_reftest_singletons']}, 11:27:51 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:27:51 INFO - 'tests': ['perf_reftest']}, 11:27:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:27:51 INFO - 'tsvgr_opacity', 11:27:51 INFO - 'tart', 11:27:51 INFO - 'tscrollx', 11:27:51 INFO - 'tsvg_static']}, 11:27:51 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:27:51 INFO - 'tests': ['tsvgx', 11:27:51 INFO - 'tsvgr_opacity', 11:27:51 INFO - 'tart', 11:27:51 INFO - 'tscrollx', 11:27:51 INFO - 'tsvg_static']}, 11:27:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:27:51 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:27:51 INFO - 'talos_options': ['--disable-stylo'], 11:27:51 INFO - 'tests': ['tp5o']}, 11:27:51 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:27:51 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:27:51 INFO - 'talos_options': ['--mitmproxy', 11:27:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:27:51 INFO - '--firstNonBlankPaint'], 11:27:51 INFO - 'tests': ['tp6_google', 11:27:51 INFO - 'tp6_youtube', 11:27:51 INFO - 'tp6_amazon', 11:27:51 INFO - 'tp6_facebook']}, 11:27:51 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:27:51 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:27:51 INFO - 'talos_options': ['--disable-stylo', 11:27:51 INFO - '--mitmproxy', 11:27:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:27:51 INFO - '--firstNonBlankPaint'], 11:27:51 INFO - 'tests': ['tp6_google', 11:27:51 INFO - 'tp6_youtube', 11:27:51 INFO - 'tp6_amazon', 11:27:51 INFO - 'tp6_facebook']}, 11:27:51 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:27:51 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:27:51 INFO - 'talos_options': ['--stylo-threads=1', 11:27:51 INFO - '--mitmproxy', 11:27:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:27:51 INFO - '--firstNonBlankPaint'], 11:27:51 INFO - 'tests': ['tp6_google', 11:27:51 INFO - 'tp6_youtube', 11:27:51 INFO - 'tp6_amazon', 11:27:51 INFO - 'tp6_facebook']}, 11:27:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:27:51 INFO - 'talos_options': ['--xperf_path', 11:27:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:27:51 INFO - 'tests': ['tp5n']}, 11:27:51 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:27:51 INFO - 'talos_options': ['--disable-stylo', 11:27:51 INFO - '--xperf_path', 11:27:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:27:51 INFO - 'tests': ['tp5n']}}} 11:27:51 INFO - Running post-action listener: _resource_record_post_action 11:27:51 INFO - [mozharness: 2017-09-27 18:27:51.755870Z] Finished populate-webroot step (success) 11:27:51 INFO - [mozharness: 2017-09-27 18:27:51.755959Z] Running create-virtualenv step. 11:27:51 INFO - Running pre-action listener: _resource_record_pre_action 11:27:51 INFO - Running main action method: create_virtualenv 11:27:51 INFO - Creating virtualenv /builds/slave/test/build/venv 11:27:51 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:27:51 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:27:51 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:27:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:27:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:27:52 INFO - Installing distribute.............................................................................................................................................................................................done. 11:27:52 INFO - Installing pip...............done. 11:27:52 INFO - Return code: 0 11:27:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:27:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:27:52 INFO - Reading from file tmpfile_stdout 11:27:52 INFO - Output received: 11:27:52 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:27:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:27:52 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')]} 11:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:52 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')]} 11:27:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:52 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 0x15de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1948d60>, '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 0x1949a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1949ef0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495', '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 11:27:52 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 11:27:52 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 11:27:52 INFO - Using env: {'DISPLAY': ':0', 11:27:52 INFO - 'HOME': '/home/cltbld', 11:27:52 INFO - 'LANG': 'en_US.UTF-8', 11:27:52 INFO - 'LANGUAGE': 'en_US:en', 11:27:52 INFO - 'LOGNAME': 'cltbld', 11:27:52 INFO - 'MAIL': '/var/mail/cltbld', 11:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:52 INFO - 'MOZ_NO_REMOTE': '1', 11:27:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:52 INFO - 'NO_EM_RESTART': '1', 11:27:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:52 INFO - 'PWD': '/builds/slave/test', 11:27:52 INFO - 'SHELL': '/bin/bash', 11:27:52 INFO - 'SHLVL': '1', 11:27:52 INFO - 'TERM': 'linux', 11:27:52 INFO - 'TMOUT': '86400', 11:27:52 INFO - 'USER': 'cltbld', 11:27:52 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495', 11:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:52 INFO - '_': '/tools/buildbot/bin/python'} 11:27:54 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:27:54 INFO - Downloading/unpacking pip>=1.5 11:27:54 INFO - Running setup.py egg_info for package pip 11:27:54 INFO - warning: no files found matching 'pip/cacert.pem' 11:27:54 INFO - warning: no files found matching '*.html' under directory 'docs' 11:27:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:27:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:27:54 INFO - Installing collected packages: pip 11:27:54 INFO - Found existing installation: pip 1.1 11:27:54 INFO - Uninstalling pip: 11:27:54 INFO - Successfully uninstalled pip 11:27:54 INFO - Running setup.py install for pip 11:27:54 INFO - warning: no files found matching 'pip/cacert.pem' 11:27:54 INFO - warning: no files found matching '*.html' under directory 'docs' 11:27:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:27:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:27:54 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:27:54 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:27:54 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:27:54 INFO - Successfully installed pip 11:27:54 INFO - Cleaning up... 11:27:54 INFO - Return code: 0 11:27:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:27:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:54 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 0x15de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1948d60>, '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 0x1949a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1949ef0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495', '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 11:27:54 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 11:27:54 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 11:27:54 INFO - Using env: {'DISPLAY': ':0', 11:27:54 INFO - 'HOME': '/home/cltbld', 11:27:54 INFO - 'LANG': 'en_US.UTF-8', 11:27:54 INFO - 'LANGUAGE': 'en_US:en', 11:27:54 INFO - 'LOGNAME': 'cltbld', 11:27:54 INFO - 'MAIL': '/var/mail/cltbld', 11:27:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:54 INFO - 'MOZ_NO_REMOTE': '1', 11:27:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:54 INFO - 'NO_EM_RESTART': '1', 11:27:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:54 INFO - 'PWD': '/builds/slave/test', 11:27:54 INFO - 'SHELL': '/bin/bash', 11:27:54 INFO - 'SHLVL': '1', 11:27:54 INFO - 'TERM': 'linux', 11:27:54 INFO - 'TMOUT': '86400', 11:27:54 INFO - 'USER': 'cltbld', 11:27:54 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495', 11:27:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:54 INFO - '_': '/tools/buildbot/bin/python'} 11:27:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:54 INFO - Downloading/unpacking psutil>=3.1.1 11:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:27:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:27:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:27:55 INFO - Installing collected packages: psutil 11:27:55 INFO - Running setup.py install for psutil 11:27:55 INFO - building 'psutil._psutil_linux' extension 11:27:55 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 11:27:55 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 11:27:55 INFO - building 'psutil._psutil_posix' extension 11:27:55 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 11:27:55 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 11:27:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:27:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:27:55 INFO - Successfully installed psutil 11:27:55 INFO - Cleaning up... 11:27:56 INFO - Return code: 0 11:27:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1948d60>, '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 0x1949a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1949ef0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495', '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 11:27:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:27:56 INFO - Using env: {'DISPLAY': ':0', 11:27:56 INFO - 'HOME': '/home/cltbld', 11:27:56 INFO - 'LANG': 'en_US.UTF-8', 11:27:56 INFO - 'LANGUAGE': 'en_US:en', 11:27:56 INFO - 'LOGNAME': 'cltbld', 11:27:56 INFO - 'MAIL': '/var/mail/cltbld', 11:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:56 INFO - 'MOZ_NO_REMOTE': '1', 11:27:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:56 INFO - 'NO_EM_RESTART': '1', 11:27:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:56 INFO - 'PWD': '/builds/slave/test', 11:27:56 INFO - 'SHELL': '/bin/bash', 11:27:56 INFO - 'SHLVL': '1', 11:27:56 INFO - 'TERM': 'linux', 11:27:56 INFO - 'TMOUT': '86400', 11:27:56 INFO - 'USER': 'cltbld', 11:27:56 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495', 11:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:56 INFO - '_': '/tools/buildbot/bin/python'} 11:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:27:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:27:57 INFO - Installing collected packages: mozsystemmonitor 11:27:57 INFO - Running setup.py install for mozsystemmonitor 11:27:57 INFO - Successfully installed mozsystemmonitor 11:27:57 INFO - Cleaning up... 11:27:57 INFO - Return code: 0 11:27:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:27: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')]} 11:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27: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')]} 11:27:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1948d60>, '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 0x1949a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1949ef0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495', '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 11:27:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:27:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:27:57 INFO - Using env: {'DISPLAY': ':0', 11:27:57 INFO - 'HOME': '/home/cltbld', 11:27:57 INFO - 'LANG': 'en_US.UTF-8', 11:27:57 INFO - 'LANGUAGE': 'en_US:en', 11:27:57 INFO - 'LOGNAME': 'cltbld', 11:27:57 INFO - 'MAIL': '/var/mail/cltbld', 11:27:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:57 INFO - 'MOZ_NO_REMOTE': '1', 11:27:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:57 INFO - 'NO_EM_RESTART': '1', 11:27:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:57 INFO - 'PWD': '/builds/slave/test', 11:27:57 INFO - 'SHELL': '/bin/bash', 11:27:57 INFO - 'SHLVL': '1', 11:27:57 INFO - 'TERM': 'linux', 11:27:57 INFO - 'TMOUT': '86400', 11:27:57 INFO - 'USER': 'cltbld', 11:27:57 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495', 11:27:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:57 INFO - '_': '/tools/buildbot/bin/python'} 11:27:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:57 INFO - Downloading/unpacking jsonschema==2.5.1 11:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:27:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:27:58 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 11:27:58 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 11:27:58 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 11:27:58 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 11:27:59 INFO - Downloading functools32-3.2.3-2.tar.gz 11:27:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:27:59 INFO - warning: no files found matching '*.txt' 11:27:59 INFO - no previously-included directories found matching 'build' 11:27:59 INFO - no previously-included directories found matching 'dist' 11:27:59 INFO - no previously-included directories found matching '.git*' 11:27:59 INFO - Installing collected packages: jsonschema, functools32 11:27:59 INFO - Running setup.py install for functools32 11:27:59 INFO - warning: no files found matching '*.txt' 11:27:59 INFO - no previously-included directories found matching 'build' 11:27:59 INFO - no previously-included directories found matching 'dist' 11:27:59 INFO - no previously-included directories found matching '.git*' 11:27:59 INFO - Successfully installed jsonschema functools32 11:27:59 INFO - Cleaning up... 11:27:59 INFO - Return code: 0 11:27:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:27: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')]} 11:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27: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')]} 11:27:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27: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', '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 0x15de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1948d60>, '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 0x1949a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1949ef0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495', '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 11:27: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:27: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 functools32==3.2.3-2 11:27:59 INFO - Using env: {'DISPLAY': ':0', 11:27:59 INFO - 'HOME': '/home/cltbld', 11:27:59 INFO - 'LANG': 'en_US.UTF-8', 11:27:59 INFO - 'LANGUAGE': 'en_US:en', 11:27:59 INFO - 'LOGNAME': 'cltbld', 11:27:59 INFO - 'MAIL': '/var/mail/cltbld', 11:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:59 INFO - 'MOZ_NO_REMOTE': '1', 11:27:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:59 INFO - 'NO_EM_RESTART': '1', 11:27:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:59 INFO - 'PWD': '/builds/slave/test', 11:27:59 INFO - 'SHELL': '/bin/bash', 11:27:59 INFO - 'SHLVL': '1', 11:27:59 INFO - 'TERM': 'linux', 11:27:59 INFO - 'TMOUT': '86400', 11:27:59 INFO - 'USER': 'cltbld', 11:27:59 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495', 11:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:59 INFO - '_': '/tools/buildbot/bin/python'} 11:27:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:27:59 INFO - Cleaning up... 11:27:59 INFO - Return code: 0 11:27:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:27: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')]} 11:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27: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')]} 11:27:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27: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', '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 0x15de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1948d60>, '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 0x1949a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1949ef0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495', '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 11:27: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:27: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 blobuploader==1.2.4 11:27:59 INFO - Using env: {'DISPLAY': ':0', 11:27:59 INFO - 'HOME': '/home/cltbld', 11:27:59 INFO - 'LANG': 'en_US.UTF-8', 11:27:59 INFO - 'LANGUAGE': 'en_US:en', 11:27:59 INFO - 'LOGNAME': 'cltbld', 11:27:59 INFO - 'MAIL': '/var/mail/cltbld', 11:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:59 INFO - 'MOZ_NO_REMOTE': '1', 11:27:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:59 INFO - 'NO_EM_RESTART': '1', 11:27:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:59 INFO - 'PWD': '/builds/slave/test', 11:27:59 INFO - 'SHELL': '/bin/bash', 11:27:59 INFO - 'SHLVL': '1', 11:27:59 INFO - 'TERM': 'linux', 11:27:59 INFO - 'TMOUT': '86400', 11:27:59 INFO - 'USER': 'cltbld', 11:27:59 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495', 11:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:59 INFO - '_': '/tools/buildbot/bin/python'} 11:27:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:59 INFO - Downloading/unpacking blobuploader==1.2.4 11:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:00 INFO - Downloading blobuploader-1.2.4.tar.gz 11:28:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:28:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:28:00 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 11:28:00 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 11:28:00 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 11:28:00 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 11:28:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:28:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:28: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 11:28: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 11:28: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 11:28: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 11:28:01 INFO - Downloading docopt-0.6.1.tar.gz 11:28:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:28:01 INFO - Installing collected packages: blobuploader, requests, docopt 11:28:01 INFO - Running setup.py install for blobuploader 11:28:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:28:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:28:01 INFO - Running setup.py install for requests 11:28:01 INFO - Running setup.py install for docopt 11:28:02 INFO - Successfully installed blobuploader requests docopt 11:28:02 INFO - Cleaning up... 11:28:02 INFO - Return code: 0 11:28:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:28: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')]} 11:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28: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')]} 11:28:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:02 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 0x15de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1948d60>, '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 0x1949a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1949ef0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495', '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 11:28:02 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 11:28:02 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 11:28:02 INFO - Using env: {'DISPLAY': ':0', 11:28:02 INFO - 'HOME': '/home/cltbld', 11:28:02 INFO - 'LANG': 'en_US.UTF-8', 11:28:02 INFO - 'LANGUAGE': 'en_US:en', 11:28:02 INFO - 'LOGNAME': 'cltbld', 11:28:02 INFO - 'MAIL': '/var/mail/cltbld', 11:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:02 INFO - 'MOZ_NO_REMOTE': '1', 11:28:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:02 INFO - 'NO_EM_RESTART': '1', 11:28:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:02 INFO - 'PWD': '/builds/slave/test', 11:28:02 INFO - 'SHELL': '/bin/bash', 11:28:02 INFO - 'SHLVL': '1', 11:28:02 INFO - 'TERM': 'linux', 11:28:02 INFO - 'TMOUT': '86400', 11:28:02 INFO - 'USER': 'cltbld', 11:28:02 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495', 11:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:02 INFO - '_': '/tools/buildbot/bin/python'} 11:28:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:28:02 INFO - Running setup.py (path:/tmp/pip-NB8cal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:28:02 INFO - Running setup.py (path:/tmp/pip-8AihB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:28:02 INFO - Running setup.py (path:/tmp/pip-VUadak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:28:02 INFO - Running setup.py (path:/tmp/pip-5dJMDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:28:02 INFO - Running setup.py (path:/tmp/pip-27UxoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:28:03 INFO - Running setup.py (path:/tmp/pip-xsJaLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:28:03 INFO - Running setup.py (path:/tmp/pip-wlesRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:28:03 INFO - Running setup.py (path:/tmp/pip-89fakP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:28:03 INFO - Running setup.py (path:/tmp/pip-glfW6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:28:03 INFO - Running setup.py (path:/tmp/pip-MIch64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:28:03 INFO - Running setup.py (path:/tmp/pip-s7RRIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:28:03 INFO - Running setup.py (path:/tmp/pip-AZP4Gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:28:03 INFO - Running setup.py (path:/tmp/pip-fBgj7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:28:03 INFO - Running setup.py (path:/tmp/pip-f6a9ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:28:03 INFO - Running setup.py (path:/tmp/pip-mUGxBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:28:03 INFO - Running setup.py (path:/tmp/pip-B6H43F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:28:03 INFO - Running setup.py (path:/tmp/pip-uXcAak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:28:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:28:03 INFO - Running setup.py install for manifestparser 11:28:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:28:03 INFO - Running setup.py install for mozcrash 11:28:04 INFO - Running setup.py install for mozdebug 11:28:04 INFO - Running setup.py install for mozdevice 11:28:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:28:04 INFO - Running setup.py install for mozfile 11:28:04 INFO - Running setup.py install for mozhttpd 11:28:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:28:04 INFO - Running setup.py install for mozinfo 11:28:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:28:04 INFO - Running setup.py install for mozInstall 11:28:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:28:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:28:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:28:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:28:04 INFO - Running setup.py install for mozleak 11:28:04 INFO - Running setup.py install for mozlog 11:28:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:28:04 INFO - Running setup.py install for moznetwork 11:28:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:28:04 INFO - Running setup.py install for mozprocess 11:28:05 INFO - Running setup.py install for mozprofile 11:28:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:28:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:28:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:28:05 INFO - Running setup.py install for mozrunner 11:28:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:28:05 INFO - Running setup.py install for mozscreenshot 11:28:05 INFO - Running setup.py install for moztest 11:28:05 INFO - Running setup.py install for mozversion 11:28:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:28:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:28:05 INFO - Cleaning up... 11:28:05 INFO - Return code: 0 11:28:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:28:05 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')]} 11:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:05 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')]} 11:28:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:05 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 0x15de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1948d60>, '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 0x1949a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1949ef0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495', '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 11:28:05 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 11:28:05 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 11:28:05 INFO - Using env: {'DISPLAY': ':0', 11:28:05 INFO - 'HOME': '/home/cltbld', 11:28:05 INFO - 'LANG': 'en_US.UTF-8', 11:28:05 INFO - 'LANGUAGE': 'en_US:en', 11:28:05 INFO - 'LOGNAME': 'cltbld', 11:28:05 INFO - 'MAIL': '/var/mail/cltbld', 11:28:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:05 INFO - 'MOZ_NO_REMOTE': '1', 11:28:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:05 INFO - 'NO_EM_RESTART': '1', 11:28:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:05 INFO - 'PWD': '/builds/slave/test', 11:28:05 INFO - 'SHELL': '/bin/bash', 11:28:05 INFO - 'SHLVL': '1', 11:28:05 INFO - 'TERM': 'linux', 11:28:05 INFO - 'TMOUT': '86400', 11:28:05 INFO - 'USER': 'cltbld', 11:28:05 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495', 11:28:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:05 INFO - '_': '/tools/buildbot/bin/python'} 11:28:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:28:05 INFO - Running setup.py (path:/tmp/pip-M_UYpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:28:05 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)) 11:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:28:05 INFO - Running setup.py (path:/tmp/pip-fgjaoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:28:05 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)) 11:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:28:05 INFO - Running setup.py (path:/tmp/pip-pVRiyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:28:06 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)) 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:28:06 INFO - Running setup.py (path:/tmp/pip-zdQZzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:28:06 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)) 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:28:06 INFO - Running setup.py (path:/tmp/pip-wg__IT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:28:06 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)) 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:28:06 INFO - Running setup.py (path:/tmp/pip-6hDkz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:28:06 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)) 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:28:06 INFO - Running setup.py (path:/tmp/pip-jxeHxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:28:06 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)) 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:28:06 INFO - Running setup.py (path:/tmp/pip-usDygF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:28:06 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)) 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:28:06 INFO - Running setup.py (path:/tmp/pip-FtjmEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:28:06 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)) 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:28:06 INFO - Running setup.py (path:/tmp/pip-9_JriC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:28:06 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)) 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:28:06 INFO - Running setup.py (path:/tmp/pip-iynFny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:28:06 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)) 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:28:06 INFO - Running setup.py (path:/tmp/pip-sXxwR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:28:06 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)) 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:28:06 INFO - Running setup.py (path:/tmp/pip-ilI0Jv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:28:06 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)) 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:28:06 INFO - Running setup.py (path:/tmp/pip-DDjPtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:28:06 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)) 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:28:06 INFO - Running setup.py (path:/tmp/pip-HFqBCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:28:06 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)) 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:28:06 INFO - Running setup.py (path:/tmp/pip-jDJLt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:28:06 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)) 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:28:06 INFO - Running setup.py (path:/tmp/pip-zxfwMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:28:07 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)) 11:28:07 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)) 11:28:07 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)) 11:28:07 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)) 11:28:07 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)) 11:28:07 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)) 11:28:07 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)) 11:28:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:28:07 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 11:28:07 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 11:28:07 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 11:28:07 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 11:28:08 INFO - Downloading blessings-1.6.tar.gz 11:28:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:28:08 INFO - Installing collected packages: blessings 11:28:08 INFO - Running setup.py install for blessings 11:28:08 INFO - Successfully installed blessings 11:28:08 INFO - Cleaning up... 11:28:08 INFO - Return code: 0 11:28:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:28:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:28:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:28:08 INFO - Reading from file tmpfile_stdout 11:28:08 INFO - Current package versions: 11:28:08 INFO - argparse == 1.2.1 11:28:08 INFO - blessings == 1.6 11:28:08 INFO - blobuploader == 1.2.4 11:28:08 INFO - docopt == 0.6.1 11:28:08 INFO - functools32 == 3.2.3-2 11:28:08 INFO - jsonschema == 2.5.1 11:28:08 INFO - manifestparser == 1.1 11:28:08 INFO - mozInstall == 1.13 11:28:08 INFO - mozcrash == 1.0 11:28:08 INFO - mozdebug == 0.1 11:28:08 INFO - mozdevice == 0.51 11:28:08 INFO - mozfile == 1.2 11:28:08 INFO - mozhttpd == 0.7 11:28:08 INFO - mozinfo == 0.10 11:28:08 INFO - mozleak == 0.1 11:28:08 INFO - mozlog == 3.5 11:28:08 INFO - moznetwork == 0.27 11:28:08 INFO - mozprocess == 0.25 11:28:08 INFO - mozprofile == 0.28 11:28:08 INFO - mozrunner == 6.13 11:28:08 INFO - mozscreenshot == 0.1 11:28:08 INFO - mozsystemmonitor == 0.3 11:28:08 INFO - moztest == 0.8 11:28:08 INFO - mozversion == 1.4 11:28:08 INFO - psutil == 3.1.1 11:28:08 INFO - requests == 1.2.3 11:28:08 INFO - wsgiref == 0.1.2 11:28:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:08 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 0x15de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1948d60>, '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 0x1949a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1949ef0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495', '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 11:28:08 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 11:28:08 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 11:28:08 INFO - Using env: {'DISPLAY': ':0', 11:28:08 INFO - 'HOME': '/home/cltbld', 11:28:08 INFO - 'LANG': 'en_US.UTF-8', 11:28:08 INFO - 'LANGUAGE': 'en_US:en', 11:28:08 INFO - 'LOGNAME': 'cltbld', 11:28:08 INFO - 'MAIL': '/var/mail/cltbld', 11:28:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:08 INFO - 'MOZ_NO_REMOTE': '1', 11:28:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:08 INFO - 'NO_EM_RESTART': '1', 11:28:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:08 INFO - 'PWD': '/builds/slave/test', 11:28:08 INFO - 'SHELL': '/bin/bash', 11:28:08 INFO - 'SHLVL': '1', 11:28:08 INFO - 'TERM': 'linux', 11:28:08 INFO - 'TMOUT': '86400', 11:28:08 INFO - 'USER': 'cltbld', 11:28:08 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495', 11:28:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:08 INFO - '_': '/tools/buildbot/bin/python'} 11:28:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:08 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)) 11:28:08 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)) 11:28:08 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)) 11:28:08 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)) 11:28:08 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)) 11:28:08 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)) 11:28:08 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)) 11:28:08 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)) 11:28:08 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)) 11:28:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:28: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 11:28: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 11:28: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 11:28: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 11:28:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:28:10 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)) 11:28:10 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)) 11:28:10 INFO - Installing collected packages: simplejson 11:28:10 INFO - Running setup.py install for simplejson 11:28:10 INFO - building 'simplejson._speedups' extension 11:28:10 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 11:28:10 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 11:28:11 INFO - Successfully installed simplejson 11:28:11 INFO - Cleaning up... 11:28:11 INFO - Return code: 0 11:28:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:28: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')]} 11:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28: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')]} 11:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:11 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 0x15de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1948d60>, '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 0x1949a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1949ef0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495', '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 11:28:11 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 11:28:11 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 11:28:11 INFO - Using env: {'DISPLAY': ':0', 11:28:11 INFO - 'HOME': '/home/cltbld', 11:28:11 INFO - 'LANG': 'en_US.UTF-8', 11:28:11 INFO - 'LANGUAGE': 'en_US:en', 11:28:11 INFO - 'LOGNAME': 'cltbld', 11:28:11 INFO - 'MAIL': '/var/mail/cltbld', 11:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:11 INFO - 'MOZ_NO_REMOTE': '1', 11:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:11 INFO - 'NO_EM_RESTART': '1', 11:28:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:11 INFO - 'PWD': '/builds/slave/test', 11:28:11 INFO - 'SHELL': '/bin/bash', 11:28:11 INFO - 'SHLVL': '1', 11:28:11 INFO - 'TERM': 'linux', 11:28:11 INFO - 'TMOUT': '86400', 11:28:11 INFO - 'USER': 'cltbld', 11:28:11 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495', 11:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:11 INFO - '_': '/tools/buildbot/bin/python'} 11:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:28:11 INFO - Cleaning up... 11:28:11 INFO - Return code: 0 11:28:11 INFO - Running post-action listener: _resource_record_post_action 11:28:11 INFO - Running post-action listener: _start_resource_monitoring 11:28:11 INFO - Starting resource monitoring. 11:28:11 INFO - [mozharness: 2017-09-27 18:28:11.320321Z] Finished create-virtualenv step (success) 11:28:11 INFO - [mozharness: 2017-09-27 18:28:11.320796Z] Running install step. 11:28:11 INFO - Running pre-action listener: _resource_record_pre_action 11:28:11 INFO - Running main action method: install 11:28:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:28:11 INFO - Reading from file tmpfile_stdout 11:28:11 INFO - Detecting whether we're running mozinstall >=1.0... 11:28:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:28:11 INFO - Reading from file tmpfile_stdout 11:28:11 INFO - Output received: 11:28:11 INFO - Usage: mozinstall [options] installer 11:28:11 INFO - Options: 11:28:11 INFO - -h, --help show this help message and exit 11:28:11 INFO - -d DEST, --destination=DEST 11:28:11 INFO - Directory to install application into. [default: 11:28:11 INFO - "/builds/slave/test"] 11:28:11 INFO - --app=APP Application being installed. [default: firefox] 11:28:11 INFO - mkdir: /builds/slave/test/build/application 11:28:11 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'] 11:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:28:29 INFO - Reading from file tmpfile_stdout 11:28:29 INFO - Output received: 11:28:29 INFO - /builds/slave/test/build/application/firefox/firefox 11:28:29 INFO - Running post-action listener: _resource_record_post_action 11:28:29 INFO - [mozharness: 2017-09-27 18:28:29.418030Z] Finished install step (success) 11:28:29 INFO - [mozharness: 2017-09-27 18:28:29.418280Z] Running setup-mitmproxy step. 11:28:29 INFO - Running pre-action listener: _resource_record_pre_action 11:28:29 INFO - Running main action method: setup_mitmproxy 11:28:29 INFO - Skipping: mitmproxy is not required 11:28:29 INFO - Running post-action listener: _resource_record_post_action 11:28:29 INFO - [mozharness: 2017-09-27 18:28:29.419392Z] Finished setup-mitmproxy step (success) 11:28:29 INFO - [mozharness: 2017-09-27 18:28:29.419607Z] Running run-tests step. 11:28:29 INFO - Running pre-action listener: _resource_record_pre_action 11:28:29 INFO - Running pre-action listener: _set_gcov_prefix 11:28:29 INFO - Running main action method: run_tests 11:28:29 WARNING - Try message not found. 11:28:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:28:29 INFO - Python 2.7.3 11:28:29 INFO - Return code: 0 11:28:29 INFO - grabbing minidump binary from tooltool 11:28:29 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')]} 11:28:29 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 0x1948d60>, '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 0x1949a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1949ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:28:29 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 11:28:29 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 11:28:29 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 11:28:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:28:29 INFO - Return code: 0 11:28:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:28:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:28:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:28:29 INFO - ENV: RUST_BACKTRACE is now full 11:28:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:28:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:28:29 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/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 11:28:29 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/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 11:28:29 INFO - Using env: {'DISPLAY': ':0', 11:28:29 INFO - 'HOME': '/home/cltbld', 11:28:29 INFO - 'LANG': 'en_US.UTF-8', 11:28:29 INFO - 'LANGUAGE': 'en_US:en', 11:28:29 INFO - 'LOGNAME': 'cltbld', 11:28:29 INFO - 'MAIL': '/var/mail/cltbld', 11:28:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:28:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:28:29 INFO - 'MOZ_ACCELERATED': '1', 11:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:29 INFO - 'MOZ_NO_REMOTE': '1', 11:28:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:28:29 INFO - 'MOZ_WEBRENDER': '1', 11:28:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:29 INFO - 'NO_EM_RESTART': '1', 11:28:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:29 INFO - 'PWD': '/builds/slave/test', 11:28:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:28:29 INFO - 'RUST_BACKTRACE': 'full', 11:28:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:28:29 INFO - 'SHELL': '/bin/bash', 11:28:29 INFO - 'SHLVL': '1', 11:28:29 INFO - 'TERM': 'linux', 11:28:29 INFO - 'TMOUT': '86400', 11:28:29 INFO - 'USER': 'cltbld', 11:28:29 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495', 11:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:29 INFO - '_': '/tools/buildbot/bin/python'} 11:28:29 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/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 11:28:29 INFO - mozversion application_buildid: 20170927173830 11:28:29 INFO - mozversion application_changeset: 756e10aa8bbd416cbc49b7739f78fb81d5525477 11:28:29 INFO - mozversion application_display_name: Nightly 11:28:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:28:29 INFO - mozversion application_name: Firefox 11:28:29 INFO - mozversion application_remotingname: firefox 11:28:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:28:29 INFO - mozversion application_vendor: Mozilla 11:28:29 INFO - mozversion application_version: 58.0a1 11:28:29 INFO - mozversion platform_buildid: 20170927173830 11:28:29 INFO - mozversion platform_changeset: 756e10aa8bbd416cbc49b7739f78fb81d5525477 11:28:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:28:29 INFO - mozversion platform_version: 58.0a1 11:28:29 INFO - using testdate: 1506536909 11:28:29 INFO - actual date: 1506536909 11:28:29 INFO - starting webserver on 'localhost:40428' 11:28:29 INFO - SUITE-START | Running 2 tests 11:28:29 INFO - TEST-START | dromaeo_css 11:28:29 INFO - Initialising browser for dromaeo_css test... 11:28:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40428/getInfo.html -profile /tmp/tmpq76gz0/profile 11:28:29 INFO - TEST-INFO | started process 4424 (/builds/slave/test/build/application/firefox/firefox http://localhost:40428/getInfo.html) 11:28:36 INFO - TEST-INFO | 4424: exit 0 11:28:36 INFO - Browser initialized. 11:28:36 INFO - Running cycle 1/1 for dromaeo_css test... 11:28:36 INFO - Using env: {'DISPLAY': ':0', 11:28:36 INFO - 'HOME': '/home/cltbld', 11:28:36 INFO - 'JSGC_DISABLE_POISONING': '1', 11:28:36 INFO - 'LANG': 'en_US.UTF-8', 11:28:36 INFO - 'LANGUAGE': 'en_US:en', 11:28:37 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:28:37 INFO - 'LOGNAME': 'cltbld', 11:28:37 INFO - 'MAIL': '/var/mail/cltbld', 11:28:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:28:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:28:37 INFO - 'MOZ_ACCELERATED': '1', 11:28:37 INFO - 'MOZ_CRASHREPORTER': '1', 11:28:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:37 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:28:37 INFO - 'MOZ_NO_REMOTE': '1', 11:28:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:28:37 INFO - 'MOZ_WEBRENDER': '1', 11:28:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:37 INFO - 'NO_EM_RESTART': '1', 11:28:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:37 INFO - 'PWD': '/builds/slave/test', 11:28:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:28:37 INFO - 'RUST_BACKTRACE': 'full', 11:28:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:28:37 INFO - 'SHELL': '/bin/bash', 11:28:37 INFO - 'SHLVL': '1', 11:28:37 INFO - 'TERM': 'linux', 11:28:37 INFO - 'TMOUT': '86400', 11:28:37 INFO - 'USER': 'cltbld', 11:28:37 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495', 11:28:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:37 INFO - '_': '/tools/buildbot/bin/python'} 11:28:37 INFO - TEST-INFO | started process 4667 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq76gz0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:28:37 INFO - PID 4667 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:28:38 INFO - PID 4667 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:28:38 INFO - PID 4667 | 11:28:38 INFO - PID 4667 | (/builds/slave/test/build/application/firefox/firefox:4726): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:28:38 INFO - PID 4667 | 11:28:48 INFO - PID 4667 | RSS: Main: 205213696 11:28:48 INFO - PID 4667 | 11:31:46 INFO - PID 4667 | Cycle 1(1): loaded http://localhost:40428/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40428/tests/dromaeo/cssquery-ext.html) 11:31:47 INFO - PID 4667 | RSS: Main: 207962112 11:31:47 INFO - PID 4667 | 11:34:50 INFO - PID 4667 | Cycle 1(1): loaded http://localhost:40428/tests/dromaeo/cssquery-ext.html (next: http://localhost:40428/tests/dromaeo/cssquery-jquery.html) 11:34:50 INFO - PID 4667 | RSS: Main: 205623296 11:34:50 INFO - PID 4667 | 11:37:52 INFO - PID 4667 | Cycle 1(1): loaded http://localhost:40428/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40428/tests/dromaeo/cssquery-mootools.html) 11:37:53 INFO - PID 4667 | RSS: Main: 208220160 11:37:53 INFO - PID 4667 | 11:40:55 INFO - PID 4667 | Cycle 1(1): loaded http://localhost:40428/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40428/tests/dromaeo/cssquery-prototype.html) 11:40:55 INFO - PID 4667 | RSS: Main: 205869056 11:40:55 INFO - PID 4667 | 11:43:59 INFO - PID 4667 | Cycle 1(1): loaded http://localhost:40428/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40428/tests/dromaeo/cssquery-yui.html) 11:44:00 INFO - PID 4667 | RSS: Main: 207278080 11:44:00 INFO - PID 4667 | 11:47:01 INFO - PID 4667 | Cycle 1(1): loaded http://localhost:40428/tests/dromaeo/cssquery-yui.html (next: http://localhost:40428/tests/dromaeo/cssquery-dojo.html) 11:47:02 INFO - PID 4667 | RSS: Main: 209850368 11:47:02 INFO - PID 4667 | 11:47:02 INFO - PID 4667 | __start_tp_report 11:47:02 INFO - PID 4667 | _x_x_mozilla_page_load 11:47:02 INFO - PID 4667 | _x_x_mozilla_page_load_details 11:47:02 INFO - PID 4667 | |i|pagename|runs| 11:47:02 INFO - PID 4667 | |0;dojo.html;3175.333180032194;3188.9043328700136;3194.952075718866;3207.3745619604188;3233.5311379849923;6201.81394558164;6304.1174235606995;6308.053791931213;6339.778107766229;6389.361063893608;6193.752249909998;6261.937380626192;6269.153664255324;6295.244570651528;6304.306526282106;5721.370649228582;5725.055365864628;5773.595848290622;5791.362950075489;5800.506956908668;5725.971370143144;5780.739866706008;5817.738201780909;5847.473727364536;5852.824415267528;5825.708714564276;5858.502027327682;5876.382979787125;5899.085641725539;5943.049112142058;5607.327120745495;5847.356790753014;5854.648721076749;5883.970580147094;5894.587378883459;5601.29983752031;5624.465675760796;5683.374828768832;5752.942470575283;5778.971105144489;6236.126942228092;6253.624782513064;6260.686965651745;6315.621062736251;6323.557350985433;6446.774362897323;6572.277049524549;6589.967050164766;6690.665466726693;6695.3304669533145;6673.9666301668185;6692.899606505906;6694.531382803206;6742.865142697118;6743.763968261087;6253.843653908643;6298.433141017331;6356.96821515894;6385.297617262051;6388.872222555523;6925.515213934977;6944.270851560514;7047.89428158578;7049.9647501762165;7057.89413158803;6494.155759751202;6517.4134327910715;6688.230853451818;6762.357576030269;6774.085498457744;6607.603543787388;6607.603543787388;6714.899276510856;6726.529142959946;6752.324767523209;6642.568233064835;6691.26396096429;6772.153480814898;6793.830154246183;6825.5222134451105;6723.697433615499;6730.293319201512;6779.610179913106;6799.252082270947;6802.115724955724;5101.566366858784;5208.322918020633;5218.66078704883;5245.501677340723;5269.71016594091;4536.705114167568;4595.1039547287955;4660.930086048712;4663.533646635377;4668.883277918079;5756.5682573807135;5772.7690892363835;5854.268216472941;5861.941380586225;5889.293284805851;6710.328967103251;6749.143985404053;6794.93205067943;6809.863802724017;6820.829479263058;5613.831585052455;5749.453801888814;5756.48191662744;5811.535077193815;5821.621594596338;5786.594938354275;5818.272715910512;5849.356570777211;5862.794802181903;5873.2658417697785;6527.967360163264;6552.50856185788;6554.279029306773;6602.7689030883685;6649.434798042221;6594.076829243813;6690.029945657755;6704.161979752531;6728.495362847708;6800.149981252343;6450.032495125769;6453.709583068679;6468.288488266193;6469.061986012096;6506;6518.5111116667385;6550.6069635822005;6570.671466426755;6607.537472376887;6653.866922661617;6734.057231987427;6817.216020157547;6827.112475378169;6833.794986150423;6836.692348844214;6433;6471.967640161769;6491.188601424822;6602.735890564323;6605;6322.810315690536;6380.330065343258;6422.807315780534;6433.613983161025;6593.670316484253;6297.937020629735;6300.180976473029;6351.015592583157;6367.586106903036;6383.234011918599;6515.120458738199;6541.542092053511;6591.538592298685;6617.139771829631;6657.201135863727;6275.968620157053;6315.621062736251;6342.556021078481;6385.840353991188;6401.967990160019 11:47:02 INFO - PID 4667 | |1;ext.html;848.1899785704653;860.3633311349603;867.5662168915542;874.1520724896848;874.6195404998824;37919.24161516768;41548.58451415485;41827.16345673085;41877.581224187714;42006.57993420065;38919.41620875689;39062.60937390625;39092.609073909254;39196.60803391965;39328.60671393285;7255.383292420138;7336.926630733705;7390.224026477224;7902.525848449082;8047.3562115030945;7932.405069619773;8101.797455063612;8105.027396712403;8105.635246413896;8106.513609183438;8050;8058.516489010649;8119.472234304781;8159.061707903578;8163.469374490669;8004.799880003046;8026.398020148483;8043.39674524413;8063.395245356622;8065.6773729050765;7945.602719864041;8009.799755006114;8018.759437216893;8025.919740802576;8042;36802.63197368019;36814.631853681385;36825;36941.445878311846;36945.44581831275;3213.694699003591;3216.9195770105703;3233.96766032339;3251.398491279121;3253.430649636328;31029.37941241185;31137;31171;31179;31208.37583248345;5261.5264626183825;5261.579073674096;5288.2596436498925;5316.494932981361;5339.759710813023;190128;190738;191263.9999999986;191593;192559;46450.303245451345;46663.30005049927;47117.293240601415;47129.52870471252;49013.509864900894;50548.24177637338;50940.490595094314;51047.7447612767;51156;51163.232551511755;15490.845091549165;15639.296231669603;15704.685906281811;15708.764368534481;15716.29276682552;12206.08454365926;12377;12422.192557483735;12510.311932843599;12528.561500347445;14611.173603299587;14697.191654458893;14734.263286835616;14744.778828317583;14769.113853168845;5742.598018138774;5938.406159384113;5943.405659434022;5986.371430999682;6040.456358927718;966.79213968997;997.670768646345;1001.2090448545713;1014.9797004059877;1018.6485662446444;23265.30204093846;23266.534669306857;23398.64902026471;23447.17934872271;23884.33754187314;1077.4989629822014;1085.3542142425244;1099.2470157941837;1106.2975010867997;1109.8890110988837;12379.195352302071;12380.380980951097;12541.122121451594;12632.305223212628;12632.368381580884;240918;244162;244692;246126;246399;46277.537224627325;46876.296855547196;47037.76481117572;47078.29382559264;47271.76364118158;1395.7278330725615;1461.8099647045815;1464.5752731708112;1464.8388677245493;1471.1026273972868;23080.884595576914;23213.651795222748;23447.17934872271;23629;24024.15915442951;33603.83198083994;33894.32211355808;37534.8123259382;38116.23767524689;38123.42814857835;189493;200817;202958;203102;203517;34312.313753725284;34583.4812477808;34617.65382346144;34685.65314346824;34938.47592286169;44014;44099.11801764011;44329.55670443383;44652.55347446614;44855.10289794121;31423.685763142992;32284.83857580697;32342.19144521406;32365.838170808995;32440.83779581087;31430.685693143692;31684.683153168175;31739.365212696077;31789.20526986844;31914.20214494656;33835;35370;35517.46723799093;35818;36180.81909590435;30710.692893070784;31368.843155784074;31429.8428507856;31788;31860;23763.524729504967;23901.282961511184;23908.282751517483;23925.16261930824;24414 11:47:02 INFO - PID 4667 | |2;jquery.html;577.5581680014792;579.614556320047;586.5014737473145;587.7972099625629;600.177756473631;22117.889410552943;22796.88601556992;22895.313140605766;22907.885460572674;22971.885140574275;23847.76152238477;24844;24949.376265593324;25013;25258.621120683158;6659.9001014984815;6694.966525167368;6698;6734.696938637749;6770.593764374154;6661.733530658767;6712.127423434947;6742.52802303839;6801.93198068018;6803.55776874504;6451.29035806061;6707.362800533966;6711.597304161742;6726.865462690744;6758.763443279487;6639.103720997652;6687.097241872334;6713.664316784166;6716.1604799400075;6727.899081513781;5875.471207591295;6250.156228909084;6260.186175797163;6268.843278918018;6270.6864656766975;27929.162125136278;28491;28578;28598;28640.283992900346;1980.1980198019826;1989.7313862628505;1990.1740777577288;1990.512324480497;2011.4468521156653;18090.90954545219;18579.256829726928;18829.717554236697;18872.433826985212;18885.62228755417;2224.410531209231;2269.965950510744;2273.6134857074335;2276.499170182557;2288.645259984705;118142.40928795387;123771.38114309461;123819.3809030949;134827;138947.30526347406;14275.791385951663;14628.561143165722;14648.047876888182;14749.510215505143;14953.847992113928;22484.662730059063;22923;22933;23161.420964476023;23179.420514487272;9845.655402060893;9885.209183265322;9909.752256193653;9932.404055756677;10031.598736050477;9097.90902090984;9204.95397523008;9251.537423128952;9285.396449230779;9376.203022743006;8631.525266110424;9028.36801423894;9120.315976301805;9273.258139348836;9335.579898904565;2708.3229192701824;2741.561350183961;2784.568391899259;2801.2856721535877;2876.5109931311727;960.4333443268505;977.2035790830593;980.3382716666222;981.5435822342645;994.2692121290845;18801.623967520572;18836.905815470836;19237.61524769497;19426.22295108208;19655.705164422547;1024.6772266736104;1026.609888242463;1031.2832581355885;1036.512838965685;1046.0794500839213;10387.324823886423;10490.213234007328;10707.250492465453;10759.892401076046;10805.891941080647;443480;447047;459519;465562;467119;108903;112046.43976780064;112923;114100.42949785198;114253;1120.506976930148;1150.8734039255676;1160.9709757256137;1169.842071320378;1176.6234804862534;16608.83391166121;17027.48917532476;17124.315027398763;17401.30394784245;17599.384021559184;53380;54550.45449545613;57492;57607.71196143993;57850.4214957845;68211.31788682248;69077;69829.65085174744;70613.58772824412;71216;14079.0848594841;14176.645583860485;14299.213543254804;14392.928035359757;14413;21671.566568668855;21757.347279581638;21798.237061702763;21832.781672183075;22229;17531.21109550048;17648.823511765233;17805.910970445064;17815.287388504315;17977.910110449888;14486.85513144855;15576.454824081104;15901.363945442054;16003.439879604159;16393;17370.913145434697;18068.54828629295;18078.367257145936;18114.456566303033;18124.81875181284;13967.092139010932;14136.717265654424;14169.858301416854;14190.432382704988;20939.16243350249;18037.458876233733;18560.907195463937;18641.44075677732;18816;18872 11:47:02 INFO - PID 4667 | |3;mootools.html;1291.360776415674;1354.9919179421693;1375.5529452927794;1387.3964825300995;1402.0325975077196;15014.39942402304;15691.21543922805;15712.292946817392;15759.842401575981;15789.44736934206;15051.172185529791;15214.087154770721;15275.388984440637;15398.538043858702;15441.69116617667;2754.0498528007806;2820.4500122476124;2836.9716302836914;2837.3757773289844;2866.727660872224;2712.32191952012;2774.1261502626708;2774.88900443982;2796.0213925126245;2800.9159725208174;2633.3548280671166;2633.7234590367925;2634.973650263492;2723.046933573253;2839.0205379144163;2747.9038233661727;2771.5426954552477;2778.4165325281715;2798.790090743182;2802.3974845408234;2732.098407525512;2758.931026724348;2781.193453898367;2790.720927907193;2797.8740956656998;14620.122792632475;14892.553223403314;15080.472183473526;15236.314365853563;15296.770548441782;8056.959715201445;8334.333253339719;8345.248927596545;8355.289800366916;8374.204450577185;5169.689818610896;5339.41266460689;5412.5940554458175;5425.9186112208345;5432.782688692448;1953.082051435823;1992.7010948357718;2012.9798702013086;2052.4971382011354;2059.4748339173416;26342;26545.734542654518;26693.599596005883;26698.19905402841;26829.853611711213;6606;6787.592744435349;6821.624810635363;6989.33601307875;7011.474139439562;17039.48881533556;17259.827401726074;17279.82720172782;17297.65404691899;17417.39039133624;7446.218147094585;7723.65243564041;7810.843783124419;7944;7969.322607578305;7344.48588598793;7370.005049318273;7411.88882166768;7415.851682966419;7556.811079722941;5004.1492946198505;5119.078565858107;5129.435762066169;5178.171492561172;5243.449437809051;1442.343733601209;1477.5862758427656;1483.7403454395437;1493.2533733133432;1510.3128076725063;882.8057827277988;885.9557022148866;897.9057198994142;903.1375036839802;918.8070505193984;7335.0293131281915;7346.926530734624;7389.408847292204;7425.368843648243;7470.0662417197855;724.9021382113452;737.2295950731499;740.9666565004587;752.2552672853835;763.5189830406808;4621;4651.883702907455;4653.581177693956;4663.160631086437;4710.764461776966;20220.89889550543;21577;21723;21757.891210543847;21797.45506362322;20234.797652023586;20300.695489567668;20969.161233550793;21121.68317475239;21559.35321940344;11174.27367221128;11275.32348059119;11464.566929133858;11471.483783229774;11644.35956022427;7929.5242285463055;8166.632501537564;8211.507309561446;8212.260896519341;8264.504129752235;18009.189586468903;18499.90750046241;18526.258949641862;18980.43058708241;19038.428847134608;18493.352732654294;18902.905485472485;19183.712244316626;19360;19818.306359277358;10963.451827408438;11068.944655276671;11107.278026928223;11137.10903127764;11146.721331966766;13511.797323039966;14202.928985355007;14310.928445357707;14316.498922537661;14362.425502979764;11281.32312061279;11634.418279086181;11718.296902185895;11763.058955283728;11886.28682279066;11244.26912250701;11398.94300528492;11418.0865530759;11434.142439317251;11555.768884622092;9934.602615895283;9943.353682010646;10004.599816007278;10008.299419040597;10019.54912028975;6742.730290788313;6868;6924.653767311514;6944.791656250321;7012.894806577803;7089.220185779457;7165.140183178052;7186.029885965328;7221.855562888818;7247.927520724726 11:47:02 INFO - PID 4667 | |4;prototype.html;498.5188238790516;529.7166016181343;530.7452422837035;531.1111221208772;533.7731464127747;6103.664298463583;6116.204893363862;6165.784197553086;6215.937840621593;6230.781922632703;5941.494972927296;6026.9095963560585;6029.130969399489;6057.273127224728;6080.686026115766;5002.324686167357;5027;5041.092603331399;5074.771635276403;5099.694018358901;5028.296038554606;5082.23766435034;5100.540951314381;5134.306868572732;5140.126178549637;4787.712737235777;4882.755862206894;4891.217405215166;4894.657373983822;4926.802927882881;4859.465458799565;4862.635302352338;4881.536254055877;4906.264060390934;4915.729634870081;4324.308110702273;4374.58441448062;4396.582324679151;4411.117776444692;4427.645788336926;5959.135925290809;5971.134185543072;5979.2824861016525;5984.491318237955;6032.45707886288;5557.3886872444;5576.315894648475;5601.187827764951;5636.15457681347;5654.660720356751;6347.428731414195;6351.967370441461;6389.98715404646;6408.583442076297;6413.29453760086;4752.985600191796;4768.117898188846;4789.736564488951;4806.687565308243;4818.566329030369;6363.872722545523;6456.192975878015;6615.966920165417;6627.966860165669;6648.567843090232;4832.139626243921;4885.7312847793;4891.144049791273;4926.1379258629595;4955.702657840541;4942.431620363633;4987.925181122286;5015.3229314042865;5023.14606516893;5036.823711170092;5527.281453411111;5530.253415788817;5572.60991730575;5591.245181900392;5611.410801865827;6420.325865784025;6449.290578036413;6455.4512866406885;6488.448481879093;6511.34886511345;1730.195459111519;1732;1741.9651606968043;1750.2998800479909;1752.8948263104255;1146.2148428326623;1196.1519452445991;1208.238809549978;1214.550616271985;1214.8094867030359;5525.226468294442;5554.86112847174;5581.776728930879;5636.689982051026;5644.971775141098;6568.80293591193;6581.835454113685;6582.605043697394;6606.735730570819;6660.533762636665;5556.749946252428;5562.972185139049;5615.4665306796605;5625.971870140623;5671.432856714378;3369.1913940654067;3424.5890493140982;3433.914152146216;3451.4822776583715;3504.5268888699698;6254.593451425734;6311.715972781236;6327.936720632827;6372.502461921445;6377.808665740035;6638.203415590064;6693.966530167318;6700.262971073178;6762.058504550536;6763.864722705617;6136.693165341715;6208.603064310494;6209.436064492595;6233.657148856766;6310.842228944313;5887.676177810262;6317.764283825379;6348.619082855043;6348.984162533972;6453.41919227253;6369.108324834619;6388.520860935356;6417.743290268337;6437.8390540235;6481.805545833632;6305.180326557702;6305.747770089329;6308.810735677937;6372.171617689671;6419.528481534736;4727.7163370197895;4786.210275304536;4894.681845680019;4921.606271498343;4963.503649635152;6257.43683068526;6487;6518.282988871126;6535.901961470487;6623.768168114093;5998.220231369894;6271.78048768291;6345.841353966188;6355.5551111421755;6383.744650213939;6254.02998055611;6312.589681670676;6376.298607153117;6385.904211436925;6429.4534964526665;6182.165407669907;6244.250689917239;6257.747211003943;6273.811785646438;6379.425851673372;6308.716107775253;6390.7763228286785;6411.807645770635;6445.2587952386075;6484.254310754323;6155.984262596621;6174;6187.907181392373;6203.193584833943;6221.3156552778255 11:47:02 INFO - PID 4667 | |5;yui.html;875.0636818604088;892.3887137310942;904.5386852705122;908.8954770201425;921.4839689773725;18227.544311392205;18654.720179197306;18764.53088672784;18843.340483083095;18860.622787544275;18088.54778630535;18489.35287264946;18709.719354209665;18786.812131878676;19262.51843703908;960.8750862387898;977.7311239409148;978.2369751593768;980.0689345122126;980.3382716666257;986.1617625018748;997.3766396002499;999.030939988214;1001.5893483671696;1002.6941782756256;1010.6715317521798;1024.9743756406076;1048.8898665640113;1059.1420949031271;1061.936283822973;1043.9269251152423;1044.8641676582033;1045.5660900726189;1048.1719441641094;1049.695588279398;721.3976329764653;749.8275396658745;750.7447467860899;751.1662055118813;751.9473636845423;19734.70397944032;19742.802571974386;19966.600667986706;20066.799332006638;20494.795052049587;21211.46971325714;21274.574508509744;22172.667409988862;22305.776942230696;22351.664725028975;17358;17454.30182792687;17645.647087058187;17698.380556680455;17712.114394280365;3804.258169656918;3839.4432807243074;3841.308564458396;3841.9039524011846;3843.250566139604;131922;132625.336873315;133446.33276833652;134074;135473.3226333862;16636.916815415847;16963.915180424017;17085.743713844302;17164.914175429043;17193.398231061852;30828.38343233123;30891.845540772152;31165.376692466478;31361.52957705636;31569.36861262762;8581.313494920392;8722.34582406322;8737.475751454933;8746.431481953652;8747.475151490931;4012.538558065801;4064.085580744309;4070;4102.364133559303;4109.4246805447265;5224.294720212799;5448.536874365724;5537.695426751487;5561.610687251854;5562.499375056264;1012.9898701013043;1042.5412818359898;1044.1177205261542;1049.7165765243342;1056.572088304238;628.7076509423049;651.3291309950758;655.446148004935;662.5726406467898;672.922613899398;11527.76876581594;11677.941610291895;11897;12962.287074211008;13100.60698179056;640.5804198250154;649.4185612191501;654.5516321319816;668.2081733146238;669.0165456778528;5294.523492885659;5332.840014799563;5389.461053894579;5404.91892621611;5517.972410137923;119251;121027.39486302513;123004.38497807454;123365.38317308357;125783;107271;109380;109877.45061274643;110985;111399;89822.55088724515;92702;94462.5276873625;94622;95546;9510.429374237292;9519.333646644945;9588.424694518351;9615.326927115315;9818.75453113678;41535.16929661329;42528;43066.78466607647;43904.78047609742;44362.890927727065;55402.16896746471;56863;57612.42387576071;57942;58140;14508.419663213775;14764.261786910396;14815.777763333343;14873.18197499148;14971.401143954556;16373.263203156124;16503.09232992197;16553.751693724844;16601.91699041497;16698.332066717194;15656.765148522554;15700.528984130495;15729.606759831096;15753.763693544835;15988.280527376528;15984.600384990468;16216.513504594881;16281.51155465338;16478.588035299214;16522.17389130563;15836.604084897508;15845.286962086964;15937.442189523312;15951.521454356387;15992.120433376276;11573.826392603949;11634.70913227176;11708.70728231801;12041.976432003377;12104.152709310263;12191.817122743343;12292.631221063382;12303;12462.43919023628;12586.559470418491 11:47:02 INFO - PID 4667 | __end_tp_report 11:47:02 INFO - PID 4667 | __start_cc_report 11:47:02 INFO - PID 4667 | _x_x_mozilla_cycle_collect,282 11:47:02 INFO - PID 4667 | __end_cc_report 11:47:02 INFO - PID 4667 | __startTimestamp1506538022229__endTimestamp 11:47:02 INFO - PID 4667 | 11:47:02 INFO - PID 4667 | ------- Summary: start ------- 11:47:02 INFO - PID 4667 | Number of tests: 6 11:47:02 INFO - PID 4667 | 11:47:02 INFO - PID 4667 | [#0] dojo.html Cycles:165 Average:6178.29 Median:6385.30 stddev:734.84 (11.5%) stddev-sans-first:698.31 11:47:02 INFO - PID 4667 | Values: 3175.3 3188.9 3195.0 3207.4 3233.5 6201.8 6304.1 6308.1 6339.8 6389.4 6193.8 6261.9 6269.2 6295.2 6304.3 5721.4 5725.1 5773.6 5791.4 5800.5 5726.0 5780.7 5817.7 5847.5 5852.8 5825.7 5858.5 5876.4 5899.1 5943.0 5607.3 5847.4 5854.6 5884.0 5894.6 5601.3 5624.5 5683.4 5752.9 5779.0 6236.1 6253.6 6260.7 6315.6 6323.6 6446.8 6572.3 6590.0 6690.7 6695.3 6674.0 6692.9 6694.5 6742.9 6743.8 6253.8 6298.4 6357.0 6385.3 6388.9 6925.5 6944.3 7047.9 7050.0 7057.9 6494.2 6517.4 6688.2 6762.4 6774.1 6607.6 6607.6 6714.9 6726.5 6752.3 6642.6 6691.3 6772.2 6793.8 6825.5 6723.7 6730.3 6779.6 6799.3 6802.1 5101.6 5208.3 5218.7 5245.5 5269.7 4536.7 4595.1 4660.9 4663.5 4668.9 5756.6 5772.8 5854.3 5861.9 5889.3 6710.3 6749.1 6794.9 6809.9 6820.8 5613.8 5749.5 5756.5 5811.5 5821.6 5786.6 5818.3 5849.4 5862.8 5873.3 6528.0 6552.5 6554.3 6602.8 6649.4 6594.1 6690.0 6704.2 6728.5 6800.1 6450.0 6453.7 6468.3 6469.1 6506.0 6518.5 6550.6 6570.7 6607.5 6653.9 6734.1 6817.2 6827.1 6833.8 6836.7 6433.0 6472.0 6491.2 6602.7 6605.0 6322.8 6380.3 6422.8 6433.6 6593.7 6297.9 6300.2 6351.0 6367.6 6383.2 6515.1 6541.5 6591.5 6617.1 6657.2 6276.0 6315.6 6342.6 6385.8 6402.0 11:47:02 INFO - PID 4667 | 11:47:02 INFO - PID 4667 | [#1] ext.html Cycles:180 Average:37773.05 Median:34103.32 stddev:55226.90 (161.9%) stddev-sans-first:55312.23 11:47:02 INFO - PID 4667 | Values: 848.2 860.4 867.6 874.2 874.6 37919.2 41548.6 41827.2 41877.6 42006.6 38919.4 39062.6 39092.6 39196.6 39328.6 7255.4 7336.9 7390.2 7902.5 8047.4 7932.4 8101.8 8105.0 8105.6 8106.5 8050.0 8058.5 8119.5 8159.1 8163.5 8004.8 8026.4 8043.4 8063.4 8065.7 7945.6 8009.8 8018.8 8025.9 8042.0 36802.6 36814.6 36825.0 36941.4 36945.4 3213.7 3216.9 3234.0 3251.4 3253.4 31029.4 31137.0 31171.0 31179.0 31208.4 5261.5 5261.6 5288.3 5316.5 5339.8 190128.0 190738.0 191264.0 191593.0 192559.0 46450.3 46663.3 47117.3 47129.5 49013.5 50548.2 50940.5 51047.7 51156.0 51163.2 15490.8 15639.3 15704.7 15708.8 15716.3 12206.1 12377.0 12422.2 12510.3 12528.6 14611.2 14697.2 14734.3 14744.8 14769.1 5742.6 5938.4 5943.4 5986.4 6040.5 966.8 997.7 1001.2 1015.0 1018.6 23265.3 23266.5 23398.6 23447.2 23884.3 1077.5 1085.4 1099.2 1106.3 1109.9 12379.2 12380.4 12541.1 12632.3 12632.4 240918.0 244162.0 244692.0 246126.0 246399.0 46277.5 46876.3 47037.8 47078.3 47271.8 1395.7 1461.8 1464.6 1464.8 1471.1 23080.9 23213.7 23447.2 23629.0 24024.2 33603.8 33894.3 37534.8 38116.2 38123.4 189493.0 200817.0 202958.0 203102.0 203517.0 34312.3 34583.5 34617.7 34685.7 34938.5 44014.0 44099.1 44329.6 44652.6 44855.1 31423.7 32284.8 32342.2 32365.8 32440.8 31430.7 31684.7 31739.4 31789.2 31914.2 33835.0 35370.0 35517.5 35818.0 36180.8 30710.7 31368.8 31429.8 31788.0 31860.0 23763.5 23901.3 23908.3 23925.2 24414.0 11:47:02 INFO - PID 4667 | 11:47:02 INFO - PID 4667 | [#2] jquery.html Cycles:180 Average:33212.79 Median:2275.06 stddev:77022.18 (3385.5%) stddev-sans-first:77199.28 11:47:02 INFO - PID 4667 | Values: 577.6 579.6 586.5 587.8 600.2 22117.9 22796.9 22895.3 22907.9 22971.9 23847.8 24844.0 24949.4 25013.0 25258.6 6659.9 6695.0 6698.0 6734.7 6770.6 6661.7 6712.1 6742.5 6801.9 6803.6 6451.3 6707.4 6711.6 6726.9 6758.8 6639.1 6687.1 6713.7 6716.2 6727.9 5875.5 6250.2 6260.2 6268.8 6270.7 27929.2 28491.0 28578.0 28598.0 28640.3 1980.2 1989.7 1990.2 1990.5 2011.4 18090.9 18579.3 18829.7 18872.4 18885.6 2224.4 2270.0 2273.6 2276.5 2288.6 118142.4 123771.4 123819.4 134827.0 138947.3 14275.8 14628.6 14648.0 14749.5 14953.8 22484.7 22923.0 22933.0 23161.4 23179.4 9845.7 9885.2 9909.8 9932.4 10031.6 9097.9 9205.0 9251.5 9285.4 9376.2 8631.5 9028.4 9120.3 9273.3 9335.6 2708.3 2741.6 2784.6 2801.3 2876.5 960.4 977.2 980.3 981.5 994.3 18801.6 18836.9 19237.6 19426.2 19655.7 1024.7 1026.6 1031.3 1036.5 1046.1 10387.3 10490.2 10707.3 10759.9 10805.9 443480.0 447047.0 459519.0 465562.0 467119.0 108903.0 112046.4 112923.0 114100.4 114253.0 1120.5 1150.9 1161.0 1169.8 1176.6 16608.8 17027.5 17124.3 17401.3 17599.4 53380.0 54550.5 57492.0 57607.7 57850.4 68211.3 69077.0 69829.7 70613.6 71216.0 14079.1 14176.6 14299.2 14392.9 14413.0 21671.6 21757.3 21798.2 21832.8 22229.0 17531.2 17648.8 17805.9 17815.3 17977.9 14486.9 15576.5 15901.4 16003.4 16393.0 17370.9 18068.5 18078.4 18114.5 18124.8 13967.1 14136.7 14169.9 14190.4 20939.2 18037.5 18560.9 18641.4 18816.0 18872.0 11:47:02 INFO - PID 4667 | 11:47:02 INFO - PID 4667 | [#3] mootools.html Cycles:180 Average:9303.53 Median:14771.09 stddev:6674.88 (45.2%) stddev-sans-first:6666.46 11:47:02 INFO - PID 4667 | Values: 1291.4 1355.0 1375.6 1387.4 1402.0 15014.4 15691.2 15712.3 15759.8 15789.4 15051.2 15214.1 15275.4 15398.5 15441.7 2754.0 2820.5 2837.0 2837.4 2866.7 2712.3 2774.1 2774.9 2796.0 2800.9 2633.4 2633.7 2635.0 2723.0 2839.0 2747.9 2771.5 2778.4 2798.8 2802.4 2732.1 2758.9 2781.2 2790.7 2797.9 14620.1 14892.6 15080.5 15236.3 15296.8 8057.0 8334.3 8345.2 8355.3 8374.2 5169.7 5339.4 5412.6 5425.9 5432.8 1953.1 1992.7 2013.0 2052.5 2059.5 26342.0 26545.7 26693.6 26698.2 26829.9 6606.0 6787.6 6821.6 6989.3 7011.5 17039.5 17259.8 17279.8 17297.7 17417.4 7446.2 7723.7 7810.8 7944.0 7969.3 7344.5 7370.0 7411.9 7415.9 7556.8 5004.1 5119.1 5129.4 5178.2 5243.4 1442.3 1477.6 1483.7 1493.3 1510.3 882.8 886.0 897.9 903.1 918.8 7335.0 7346.9 7389.4 7425.4 7470.1 724.9 737.2 741.0 752.3 763.5 4621.0 4651.9 4653.6 4663.2 4710.8 20220.9 21577.0 21723.0 21757.9 21797.5 20234.8 20300.7 20969.2 21121.7 21559.4 11174.3 11275.3 11464.6 11471.5 11644.4 7929.5 8166.6 8211.5 8212.3 8264.5 18009.2 18499.9 18526.3 18980.4 19038.4 18493.4 18902.9 19183.7 19360.0 19818.3 10963.5 11068.9 11107.3 11137.1 11146.7 13511.8 14202.9 14310.9 14316.5 14362.4 11281.3 11634.4 11718.3 11763.1 11886.3 11244.3 11398.9 11418.1 11434.1 11555.8 9934.6 9943.4 10004.6 10008.3 10019.5 6742.7 6868.0 6924.7 6944.8 7012.9 7089.2 7165.1 7186.0 7221.9 7247.9 11:47:02 INFO - PID 4667 | 11:47:02 INFO - PID 4667 | [#4] prototype.html Cycles:180 Average:5376.08 Median:5991.36 stddev:1486.93 (24.8%) stddev-sans-first:1445.33 11:47:02 INFO - PID 4667 | Values: 498.5 529.7 530.7 531.1 533.8 6103.7 6116.2 6165.8 6215.9 6230.8 5941.5 6026.9 6029.1 6057.3 6080.7 5002.3 5027.0 5041.1 5074.8 5099.7 5028.3 5082.2 5100.5 5134.3 5140.1 4787.7 4882.8 4891.2 4894.7 4926.8 4859.5 4862.6 4881.5 4906.3 4915.7 4324.3 4374.6 4396.6 4411.1 4427.6 5959.1 5971.1 5979.3 5984.5 6032.5 5557.4 5576.3 5601.2 5636.2 5654.7 6347.4 6352.0 6390.0 6408.6 6413.3 4753.0 4768.1 4789.7 4806.7 4818.6 6363.9 6456.2 6616.0 6628.0 6648.6 4832.1 4885.7 4891.1 4926.1 4955.7 4942.4 4987.9 5015.3 5023.1 5036.8 5527.3 5530.3 5572.6 5591.2 5611.4 6420.3 6449.3 6455.5 6488.4 6511.3 1730.2 1732.0 1742.0 1750.3 1752.9 1146.2 1196.2 1208.2 1214.6 1214.8 5525.2 5554.9 5581.8 5636.7 5645.0 6568.8 6581.8 6582.6 6606.7 6660.5 5556.7 5563.0 5615.5 5626.0 5671.4 3369.2 3424.6 3433.9 3451.5 3504.5 6254.6 6311.7 6327.9 6372.5 6377.8 6638.2 6694.0 6700.3 6762.1 6763.9 6136.7 6208.6 6209.4 6233.7 6310.8 5887.7 6317.8 6348.6 6349.0 6453.4 6369.1 6388.5 6417.7 6437.8 6481.8 6305.2 6305.7 6308.8 6372.2 6419.5 4727.7 4786.2 4894.7 4921.6 4963.5 6257.4 6487.0 6518.3 6535.9 6623.8 5998.2 6271.8 6345.8 6355.6 6383.7 6254.0 6312.6 6376.3 6385.9 6429.5 6182.2 6244.3 6257.7 6273.8 6379.4 6308.7 6390.8 6411.8 6445.3 6484.3 6156.0 6174.0 6187.9 6203.2 6221.3 11:47:02 INFO - PID 4667 | 11:47:02 INFO - PID 4667 | [#5] yui.html Cycles:180 Average:24035.66 Median:19061.57 stddev:34683.72 (182.0%) stddev-sans-first:34737.41 11:47:02 INFO - PID 4667 | Values: 875.1 892.4 904.5 908.9 921.5 18227.5 18654.7 18764.5 18843.3 18860.6 18088.5 18489.4 18709.7 18786.8 19262.5 960.9 977.7 978.2 980.1 980.3 986.2 997.4 999.0 1001.6 1002.7 1010.7 1025.0 1048.9 1059.1 1061.9 1043.9 1044.9 1045.6 1048.2 1049.7 721.4 749.8 750.7 751.2 751.9 19734.7 19742.8 19966.6 20066.8 20494.8 21211.5 21274.6 22172.7 22305.8 22351.7 17358.0 17454.3 17645.6 17698.4 17712.1 3804.3 3839.4 3841.3 3841.9 3843.3 131922.0 132625.3 133446.3 134074.0 135473.3 16636.9 16963.9 17085.7 17164.9 17193.4 30828.4 30891.8 31165.4 31361.5 31569.4 8581.3 8722.3 8737.5 8746.4 8747.5 4012.5 4064.1 4070.0 4102.4 4109.4 5224.3 5448.5 5537.7 5561.6 5562.5 1013.0 1042.5 1044.1 1049.7 1056.6 628.7 651.3 655.4 662.6 672.9 11527.8 11677.9 11897.0 12962.3 13100.6 640.6 649.4 654.6 668.2 669.0 5294.5 5332.8 5389.5 5404.9 5518.0 119251.0 121027.4 123004.4 123365.4 125783.0 107271.0 109380.0 109877.5 110985.0 111399.0 89822.6 92702.0 94462.5 94622.0 95546.0 9510.4 9519.3 9588.4 9615.3 9818.8 41535.2 42528.0 43066.8 43904.8 44362.9 55402.2 56863.0 57612.4 57942.0 58140.0 14508.4 14764.3 14815.8 14873.2 14971.4 16373.3 16503.1 16553.8 16601.9 16698.3 15656.8 15700.5 15729.6 15753.8 15988.3 15984.6 16216.5 16281.5 16478.6 16522.2 15836.6 15845.3 15937.4 15951.5 15992.1 11573.8 11634.7 11708.7 12042.0 12104.2 12191.8 12292.6 12303.0 12462.4 12586.6 11:47:02 INFO - PID 4667 | -------- Summary: end -------- 11:47:02 INFO - PID 4667 | 11:47:03 INFO - TEST-INFO | 4667: exit 0 11:47:03 INFO - TEST-OK | dromaeo_css | took 1113323ms 11:47:03 INFO - TEST-START | kraken 11:47:03 INFO - Initialising browser for kraken test... 11:47:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40428/getInfo.html -profile /tmp/tmpJwQWn5/profile 11:47:03 INFO - TEST-INFO | started process 5044 (/builds/slave/test/build/application/firefox/firefox http://localhost:40428/getInfo.html) 11:47:08 INFO - TEST-INFO | 5044: exit 0 11:47:09 INFO - Browser initialized. 11:47:09 INFO - Running cycle 1/1 for kraken test... 11:47:09 INFO - Using env: {'DISPLAY': ':0', 11:47:09 INFO - 'HOME': '/home/cltbld', 11:47:09 INFO - 'JSGC_DISABLE_POISONING': '1', 11:47:09 INFO - 'LANG': 'en_US.UTF-8', 11:47:09 INFO - 'LANGUAGE': 'en_US:en', 11:47:09 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:47:09 INFO - 'LOGNAME': 'cltbld', 11:47:09 INFO - 'MAIL': '/var/mail/cltbld', 11:47:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:47:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:47:09 INFO - 'MOZ_ACCELERATED': '1', 11:47:09 INFO - 'MOZ_CRASHREPORTER': '1', 11:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:09 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:47:09 INFO - 'MOZ_NO_REMOTE': '1', 11:47:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:47:09 INFO - 'MOZ_WEBRENDER': '1', 11:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:09 INFO - 'NO_EM_RESTART': '1', 11:47:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:09 INFO - 'PWD': '/builds/slave/test', 11:47:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:47:09 INFO - 'RUST_BACKTRACE': 'full', 11:47:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:47:09 INFO - 'SHELL': '/bin/bash', 11:47:09 INFO - 'SHLVL': '1', 11:47:09 INFO - 'TERM': 'linux', 11:47:09 INFO - 'TMOUT': '86400', 11:47:09 INFO - 'USER': 'cltbld', 11:47:09 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495', 11:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:09 INFO - '_': '/tools/buildbot/bin/python'} 11:47:09 INFO - TEST-INFO | started process 5289 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJwQWn5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:47:09 INFO - PID 5289 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:47:10 INFO - PID 5289 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:47:10 INFO - PID 5289 | 11:47:10 INFO - PID 5289 | (/builds/slave/test/build/application/firefox/firefox:5348): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:47:10 INFO - PID 5289 | 11:47:20 INFO - PID 5289 | RSS: Main: 209809408 11:47:20 INFO - PID 5289 | 11:47:23 INFO - PID 5289 | Cycle 1(1): loaded http://localhost:40428/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40428/tests/kraken/driver.html?testName=audio-beat-detection) 11:47:24 INFO - PID 5289 | RSS: Main: 207613952 11:47:24 INFO - PID 5289 | 11:47:26 INFO - PID 5289 | Cycle 1(1): loaded http://localhost:40428/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40428/tests/kraken/driver.html?testName=audio-dft) 11:47:27 INFO - PID 5289 | RSS: Main: 207327232 11:47:27 INFO - PID 5289 | 11:47:30 INFO - PID 5289 | Cycle 1(1): loaded http://localhost:40428/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40428/tests/kraken/driver.html?testName=audio-fft) 11:47:31 INFO - PID 5289 | RSS: Main: 203792384 11:47:31 INFO - PID 5289 | 11:47:33 INFO - PID 5289 | Cycle 1(1): loaded http://localhost:40428/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40428/tests/kraken/driver.html?testName=audio-oscillator) 11:47:34 INFO - PID 5289 | RSS: Main: 204263424 11:47:34 INFO - PID 5289 | 11:47:36 INFO - PID 5289 | Cycle 1(1): loaded http://localhost:40428/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40428/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:47:36 INFO - PID 5289 | RSS: Main: 204529664 11:47:36 INFO - PID 5289 | 11:47:40 INFO - PID 5289 | Cycle 1(1): loaded http://localhost:40428/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40428/tests/kraken/driver.html?testName=imaging-darkroom) 11:47:40 INFO - PID 5289 | RSS: Main: 206594048 11:47:40 INFO - PID 5289 | 11:47:44 INFO - PID 5289 | Cycle 1(1): loaded http://localhost:40428/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40428/tests/kraken/driver.html?testName=imaging-desaturate) 11:47:45 INFO - PID 5289 | RSS: Main: 206553088 11:47:45 INFO - PID 5289 | 11:47:48 INFO - PID 5289 | Cycle 1(1): loaded http://localhost:40428/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40428/tests/kraken/driver.html?testName=json-parse-financial) 11:47:48 INFO - PID 5289 | RSS: Main: 207011840 11:47:48 INFO - PID 5289 | 11:47:50 INFO - PID 5289 | Cycle 1(1): loaded http://localhost:40428/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40428/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:47:50 INFO - PID 5289 | RSS: Main: 206798848 11:47:50 INFO - PID 5289 | 11:47:52 INFO - PID 5289 | Cycle 1(1): loaded http://localhost:40428/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40428/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:47:53 INFO - PID 5289 | RSS: Main: 204103680 11:47:53 INFO - PID 5289 | 11:47:55 INFO - PID 5289 | Cycle 1(1): loaded http://localhost:40428/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40428/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:47:56 INFO - PID 5289 | RSS: Main: 203841536 11:47:56 INFO - PID 5289 | 11:47:58 INFO - PID 5289 | Cycle 1(1): loaded http://localhost:40428/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40428/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:47:59 INFO - PID 5289 | RSS: Main: 204337152 11:47:59 INFO - PID 5289 | 11:48:02 INFO - PID 5289 | Cycle 1(1): loaded http://localhost:40428/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40428/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:48:03 INFO - PID 5289 | RSS: Main: 204488704 11:48:03 INFO - PID 5289 | 11:48:04 INFO - PID 5289 | Cycle 1(1): loaded http://localhost:40428/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40428/tests/kraken/driver.html?testName=ai-astar) 11:48:05 INFO - PID 5289 | RSS: Main: 205901824 11:48:05 INFO - PID 5289 | 11:48:05 INFO - PID 5289 | __start_tp_report 11:48:05 INFO - PID 5289 | _x_x_mozilla_page_load 11:48:05 INFO - PID 5289 | _x_x_mozilla_page_load_details 11:48:05 INFO - PID 5289 | |i|pagename|runs| 11:48:05 INFO - PID 5289 | |0;ai-astar;113;110;108;108;107;105;107;111;107;115 11:48:05 INFO - PID 5289 | |1;audio-beat-detection;117;121;115;116;117;121;130;117;144;116 11:48:05 INFO - PID 5289 | |2;audio-dft;167;161;165;172;166;166;166;165;162;165 11:48:05 INFO - PID 5289 | |3;audio-fft;80;88;84;76;74;86;78;82;81;78 11:48:05 INFO - PID 5289 | |4;audio-oscillator;85;80;78;79;83;86;91;79;137;80 11:48:05 INFO - PID 5289 | |5;imaging-gaussian-blur;114;114;112;114;121;115;114;117;116;115 11:48:05 INFO - PID 5289 | |6;imaging-darkroom;154;149;152;150;152;157;151;149;147;150 11:48:05 INFO - PID 5289 | |7;imaging-desaturate;100;100;96;96;94;102;95;94;94;95 11:48:05 INFO - PID 5289 | |8;json-parse-financial;66;56;56;56;57;54;55;66;55;54 11:48:05 INFO - PID 5289 | |9;json-stringify-tinderbox;42;46;48;40;38;49;42;48;40;39 11:48:05 INFO - PID 5289 | |10;stanford-crypto-aes;79;74;71;71;78;79;78;77;80;75 11:48:05 INFO - PID 5289 | |11;stanford-crypto-ccm;126;114;119;120;113;118;114;112;112;132 11:48:05 INFO - PID 5289 | |12;stanford-crypto-pbkdf2;172;167;169;165;167;172;167;173;167;171 11:48:05 INFO - PID 5289 | |13;stanford-crypto-sha256-iterative;67;63;67;64;67;63;68;67;63;63 11:48:05 INFO - PID 5289 | __end_tp_report 11:48:05 INFO - PID 5289 | __start_cc_report 11:48:05 INFO - PID 5289 | _x_x_mozilla_cycle_collect,768 11:48:05 INFO - PID 5289 | __end_cc_report 11:48:05 INFO - PID 5289 | __startTimestamp1506538085039__endTimestamp 11:48:05 INFO - PID 5289 | 11:48:05 INFO - PID 5289 | ------- Summary: start ------- 11:48:05 INFO - PID 5289 | Number of tests: 14 11:48:05 INFO - PID 5289 | 11:48:05 INFO - PID 5289 | [#0] ai-astar Cycles:10 Average:109.10 Median:109.00 stddev:3.11 (2.9%) stddev-sans-first:2.96 11:48:05 INFO - PID 5289 | Values: 113.0 110.0 108.0 108.0 107.0 105.0 107.0 111.0 107.0 115.0 11:48:05 INFO - PID 5289 | 11:48:05 INFO - PID 5289 | [#1] audio-beat-detection Cycles:10 Average:121.40 Median:119.00 stddev:9.08 (7.6%) stddev-sans-first:9.49 11:48:05 INFO - PID 5289 | Values: 117.0 121.0 115.0 116.0 117.0 121.0 130.0 117.0 144.0 116.0 11:48:05 INFO - PID 5289 | 11:48:05 INFO - PID 5289 | [#2] audio-dft Cycles:10 Average:165.50 Median:166.00 stddev:2.95 (1.8%) stddev-sans-first:3.08 11:48:05 INFO - PID 5289 | Values: 167.0 161.0 165.0 172.0 166.0 166.0 166.0 165.0 162.0 165.0 11:48:05 INFO - PID 5289 | 11:48:05 INFO - PID 5289 | [#3] audio-fft Cycles:10 Average:80.70 Median:81.50 stddev:4.42 (5.4%) stddev-sans-first:4.68 11:48:05 INFO - PID 5289 | Values: 80.0 88.0 84.0 76.0 74.0 86.0 78.0 82.0 81.0 78.0 11:48:05 INFO - PID 5289 | 11:48:05 INFO - PID 5289 | [#4] audio-oscillator Cycles:10 Average:87.80 Median:81.50 stddev:17.76 (21.8%) stddev-sans-first:18.80 11:48:05 INFO - PID 5289 | Values: 85.0 80.0 78.0 79.0 83.0 86.0 91.0 79.0 137.0 80.0 11:48:05 INFO - PID 5289 | 11:48:05 INFO - PID 5289 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:115.00 stddev:2.44 (2.1%) stddev-sans-first:2.55 11:48:05 INFO - PID 5289 | Values: 114.0 114.0 112.0 114.0 121.0 115.0 114.0 117.0 116.0 115.0 11:48:05 INFO - PID 5289 | 11:48:05 INFO - PID 5289 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.50 stddev:2.85 (1.9%) stddev-sans-first:2.82 11:48:05 INFO - PID 5289 | Values: 154.0 149.0 152.0 150.0 152.0 157.0 151.0 149.0 147.0 150.0 11:48:05 INFO - PID 5289 | 11:48:05 INFO - PID 5289 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:94.50 stddev:2.95 (3.1%) stddev-sans-first:2.86 11:48:05 INFO - PID 5289 | Values: 100.0 100.0 96.0 96.0 94.0 102.0 95.0 94.0 94.0 95.0 11:48:05 INFO - PID 5289 | 11:48:05 INFO - PID 5289 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:56.00 stddev:4.58 (8.2%) stddev-sans-first:3.68 11:48:05 INFO - PID 5289 | Values: 66.0 56.0 56.0 56.0 57.0 54.0 55.0 66.0 55.0 54.0 11:48:05 INFO - PID 5289 | 11:48:05 INFO - PID 5289 | [#9] json-stringify-tinderbox Cycles:10 Average:43.20 Median:44.00 stddev:4.16 (9.4%) stddev-sans-first:4.39 11:48:05 INFO - PID 5289 | Values: 42.0 46.0 48.0 40.0 38.0 49.0 42.0 48.0 40.0 39.0 11:48:05 INFO - PID 5289 | 11:48:05 INFO - PID 5289 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:78.00 stddev:3.29 (4.2%) stddev-sans-first:3.33 11:48:05 INFO - PID 5289 | Values: 79.0 74.0 71.0 71.0 78.0 79.0 78.0 77.0 80.0 75.0 11:48:05 INFO - PID 5289 | 11:48:05 INFO - PID 5289 | [#11] stanford-crypto-ccm Cycles:10 Average:118.00 Median:118.50 stddev:6.62 (5.6%) stddev-sans-first:6.35 11:48:05 INFO - PID 5289 | Values: 126.0 114.0 119.0 120.0 113.0 118.0 114.0 112.0 112.0 132.0 11:48:05 INFO - PID 5289 | 11:48:05 INFO - PID 5289 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:170.00 stddev:2.79 (1.6%) stddev-sans-first:2.74 11:48:05 INFO - PID 5289 | Values: 172.0 167.0 169.0 165.0 167.0 172.0 167.0 173.0 167.0 171.0 11:48:05 INFO - PID 5289 | 11:48:05 INFO - PID 5289 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:67.00 stddev:2.15 (3.2%) stddev-sans-first:2.18 11:48:05 INFO - PID 5289 | Values: 67.0 63.0 67.0 64.0 67.0 63.0 68.0 67.0 63.0 63.0 11:48:05 INFO - PID 5289 | -------- Summary: end -------- 11:48:05 INFO - PID 5289 | 11:48:05 INFO - PID 5289 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:48:05 INFO - TEST-INFO | 5289: exit 0 11:48:05 INFO - TEST-OK | kraken | took 62814ms 11:48:05 INFO - SUITE-END | took 1176s 11:48:06 INFO - Completed test suite (00:19:36) 11:48:06 INFO - javascript benchmark 11:48:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8426.980935210255, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3175.333180032194, 3188.9043328700136, 3194.952075718866, 3207.3745619604188, 3233.5311379849923, 6201.81394558164, 6304.1174235606995, 6308.053791931213, 6339.778107766229, 6389.361063893608, 6193.752249909998, 6261.937380626192, 6269.153664255324, 6295.244570651528, 6304.306526282106, 5721.370649228582, 5725.055365864628, 5773.595848290622, 5791.362950075489, 5800.506956908668, 5725.971370143144, 5780.739866706008, 5817.738201780909, 5847.473727364536, 5852.824415267528, 5825.708714564276, 5858.502027327682, 5876.382979787125, 5899.085641725539, 5943.049112142058, 5607.327120745495, 5847.356790753014, 5854.648721076749, 5883.970580147094, 5894.587378883459, 5601.29983752031, 5624.465675760796, 5683.374828768832, 5752.942470575283, 5778.971105144489, 6236.126942228092, 6253.624782513064, 6260.686965651745, 6315.621062736251, 6323.557350985433, 6446.774362897323, 6572.277049524549, 6589.967050164766, 6690.665466726693, 6695.3304669533145, 6673.9666301668185, 6692.899606505906, 6694.531382803206, 6742.865142697118, 6743.763968261087, 6253.843653908643, 6298.433141017331, 6356.96821515894, 6385.297617262051, 6388.872222555523, 6925.515213934977, 6944.270851560514, 7047.89428158578, 7049.9647501762165, 7057.89413158803, 6494.155759751202, 6517.4134327910715, 6688.230853451818, 6762.357576030269, 6774.085498457744, 6607.603543787388, 6607.603543787388, 6714.899276510856, 6726.529142959946, 6752.324767523209, 6642.568233064835, 6691.26396096429, 6772.153480814898, 6793.830154246183, 6825.5222134451105, 6723.697433615499, 6730.293319201512, 6779.610179913106, 6799.252082270947, 6802.115724955724, 5101.566366858784, 5208.322918020633, 5218.66078704883, 5245.501677340723, 5269.71016594091, 4536.705114167568, 4595.1039547287955, 4660.930086048712, 4663.533646635377, 4668.883277918079, 5756.5682573807135, 5772.7690892363835, 5854.268216472941, 5861.941380586225, 5889.293284805851, 6710.328967103251, 6749.143985404053, 6794.93205067943, 6809.863802724017, 6820.829479263058, 5613.831585052455, 5749.453801888814, 5756.48191662744, 5811.535077193815, 5821.621594596338, 5786.594938354275, 5818.272715910512, 5849.356570777211, 5862.794802181903, 5873.2658417697785, 6527.967360163264, 6552.50856185788, 6554.279029306773, 6602.7689030883685, 6649.434798042221, 6594.076829243813, 6690.029945657755, 6704.161979752531, 6728.495362847708, 6800.149981252343, 6450.032495125769, 6453.709583068679, 6468.288488266193, 6469.061986012096, 6506.0, 6518.5111116667385, 6550.6069635822005, 6570.671466426755, 6607.537472376887, 6653.866922661617, 6734.057231987427, 6817.216020157547, 6827.112475378169, 6833.794986150423, 6836.692348844214, 6433.0, 6471.967640161769, 6491.188601424822, 6602.735890564323, 6605.0, 6322.810315690536, 6380.330065343258, 6422.807315780534, 6433.613983161025, 6593.670316484253, 6297.937020629735, 6300.180976473029, 6351.015592583157, 6367.586106903036, 6383.234011918599, 6515.120458738199, 6541.542092053511, 6591.538592298685, 6617.139771829631, 6657.201135863727, 6275.968620157053, 6315.621062736251, 6342.556021078481, 6385.840353991188, 6401.967990160019], "value": 6123.163084705775, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [848.1899785704653, 860.3633311349603, 867.5662168915542, 874.1520724896848, 874.6195404998824, 37919.24161516768, 41548.58451415485, 41827.16345673085, 41877.581224187714, 42006.57993420065, 38919.41620875689, 39062.60937390625, 39092.609073909254, 39196.60803391965, 39328.60671393285, 7255.383292420138, 7336.926630733705, 7390.224026477224, 7902.525848449082, 8047.3562115030945, 7932.405069619773, 8101.797455063612, 8105.027396712403, 8105.635246413896, 8106.513609183438, 8050.0, 8058.516489010649, 8119.472234304781, 8159.061707903578, 8163.469374490669, 8004.799880003046, 8026.398020148483, 8043.39674524413, 8063.395245356622, 8065.6773729050765, 7945.602719864041, 8009.799755006114, 8018.759437216893, 8025.919740802576, 8042.0, 36802.63197368019, 36814.631853681385, 36825.0, 36941.445878311846, 36945.44581831275, 3213.694699003591, 3216.9195770105703, 3233.96766032339, 3251.398491279121, 3253.430649636328, 31029.37941241185, 31137.0, 31171.0, 31179.0, 31208.37583248345, 5261.5264626183825, 5261.579073674096, 5288.2596436498925, 5316.494932981361, 5339.759710813023, 190128.0, 190738.0, 191263.9999999986, 191593.0, 192559.0, 46450.303245451345, 46663.30005049927, 47117.293240601415, 47129.52870471252, 49013.509864900894, 50548.24177637338, 50940.490595094314, 51047.7447612767, 51156.0, 51163.232551511755, 15490.845091549165, 15639.296231669603, 15704.685906281811, 15708.764368534481, 15716.29276682552, 12206.08454365926, 12377.0, 12422.192557483735, 12510.311932843599, 12528.561500347445, 14611.173603299587, 14697.191654458893, 14734.263286835616, 14744.778828317583, 14769.113853168845, 5742.598018138774, 5938.406159384113, 5943.405659434022, 5986.371430999682, 6040.456358927718, 966.79213968997, 997.670768646345, 1001.2090448545713, 1014.9797004059877, 1018.6485662446444, 23265.30204093846, 23266.534669306857, 23398.64902026471, 23447.17934872271, 23884.33754187314, 1077.4989629822014, 1085.3542142425244, 1099.2470157941837, 1106.2975010867997, 1109.8890110988837, 12379.195352302071, 12380.380980951097, 12541.122121451594, 12632.305223212628, 12632.368381580884, 240918.0, 244162.0, 244692.0, 246126.0, 246399.0, 46277.537224627325, 46876.296855547196, 47037.76481117572, 47078.29382559264, 47271.76364118158, 1395.7278330725615, 1461.8099647045815, 1464.5752731708112, 1464.8388677245493, 1471.1026273972868, 23080.884595576914, 23213.651795222748, 23447.17934872271, 23629.0, 24024.15915442951, 33603.83198083994, 33894.32211355808, 37534.8123259382, 38116.23767524689, 38123.42814857835, 189493.0, 200817.0, 202958.0, 203102.0, 203517.0, 34312.313753725284, 34583.4812477808, 34617.65382346144, 34685.65314346824, 34938.47592286169, 44014.0, 44099.11801764011, 44329.55670443383, 44652.55347446614, 44855.10289794121, 31423.685763142992, 32284.83857580697, 32342.19144521406, 32365.838170808995, 32440.83779581087, 31430.685693143692, 31684.683153168175, 31739.365212696077, 31789.20526986844, 31914.20214494656, 33835.0, 35370.0, 35517.46723799093, 35818.0, 36180.81909590435, 30710.692893070784, 31368.843155784074, 31429.8428507856, 31788.0, 31860.0, 23763.524729504967, 23901.282961511184, 23908.282751517483, 23925.16261930824, 24414.0], "value": 17130.29997790674, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.5581680014792, 579.614556320047, 586.5014737473145, 587.7972099625629, 600.177756473631, 22117.889410552943, 22796.88601556992, 22895.313140605766, 22907.885460572674, 22971.885140574275, 23847.76152238477, 24844.0, 24949.376265593324, 25013.0, 25258.621120683158, 6659.9001014984815, 6694.966525167368, 6698.0, 6734.696938637749, 6770.593764374154, 6661.733530658767, 6712.127423434947, 6742.52802303839, 6801.93198068018, 6803.55776874504, 6451.29035806061, 6707.362800533966, 6711.597304161742, 6726.865462690744, 6758.763443279487, 6639.103720997652, 6687.097241872334, 6713.664316784166, 6716.1604799400075, 6727.899081513781, 5875.471207591295, 6250.156228909084, 6260.186175797163, 6268.843278918018, 6270.6864656766975, 27929.162125136278, 28491.0, 28578.0, 28598.0, 28640.283992900346, 1980.1980198019826, 1989.7313862628505, 1990.1740777577288, 1990.512324480497, 2011.4468521156653, 18090.90954545219, 18579.256829726928, 18829.717554236697, 18872.433826985212, 18885.62228755417, 2224.410531209231, 2269.965950510744, 2273.6134857074335, 2276.499170182557, 2288.645259984705, 118142.40928795387, 123771.38114309461, 123819.3809030949, 134827.0, 138947.30526347406, 14275.791385951663, 14628.561143165722, 14648.047876888182, 14749.510215505143, 14953.847992113928, 22484.662730059063, 22923.0, 22933.0, 23161.420964476023, 23179.420514487272, 9845.655402060893, 9885.209183265322, 9909.752256193653, 9932.404055756677, 10031.598736050477, 9097.90902090984, 9204.95397523008, 9251.537423128952, 9285.396449230779, 9376.203022743006, 8631.525266110424, 9028.36801423894, 9120.315976301805, 9273.258139348836, 9335.579898904565, 2708.3229192701824, 2741.561350183961, 2784.568391899259, 2801.2856721535877, 2876.5109931311727, 960.4333443268505, 977.2035790830593, 980.3382716666222, 981.5435822342645, 994.2692121290845, 18801.623967520572, 18836.905815470836, 19237.61524769497, 19426.22295108208, 19655.705164422547, 1024.6772266736104, 1026.609888242463, 1031.2832581355885, 1036.512838965685, 1046.0794500839213, 10387.324823886423, 10490.213234007328, 10707.250492465453, 10759.892401076046, 10805.891941080647, 443480.0, 447047.0, 459519.0, 465562.0, 467119.0, 108903.0, 112046.43976780064, 112923.0, 114100.42949785198, 114253.0, 1120.506976930148, 1150.8734039255676, 1160.9709757256137, 1169.842071320378, 1176.6234804862534, 16608.83391166121, 17027.48917532476, 17124.315027398763, 17401.30394784245, 17599.384021559184, 53380.0, 54550.45449545613, 57492.0, 57607.71196143993, 57850.4214957845, 68211.31788682248, 69077.0, 69829.65085174744, 70613.58772824412, 71216.0, 14079.0848594841, 14176.645583860485, 14299.213543254804, 14392.928035359757, 14413.0, 21671.566568668855, 21757.347279581638, 21798.237061702763, 21832.781672183075, 22229.0, 17531.21109550048, 17648.823511765233, 17805.910970445064, 17815.287388504315, 17977.910110449888, 14486.85513144855, 15576.454824081104, 15901.363945442054, 16003.439879604159, 16393.0, 17370.913145434697, 18068.54828629295, 18078.367257145936, 18114.456566303033, 18124.81875181284, 13967.092139010932, 14136.717265654424, 14169.858301416854, 14190.432382704988, 20939.16243350249, 18037.458876233733, 18560.907195463937, 18641.44075677732, 18816.0, 18872.0], "value": 11781.271829881272, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1291.360776415674, 1354.9919179421693, 1375.5529452927794, 1387.3964825300995, 1402.0325975077196, 15014.39942402304, 15691.21543922805, 15712.292946817392, 15759.842401575981, 15789.44736934206, 15051.172185529791, 15214.087154770721, 15275.388984440637, 15398.538043858702, 15441.69116617667, 2754.0498528007806, 2820.4500122476124, 2836.9716302836914, 2837.3757773289844, 2866.727660872224, 2712.32191952012, 2774.1261502626708, 2774.88900443982, 2796.0213925126245, 2800.9159725208174, 2633.3548280671166, 2633.7234590367925, 2634.973650263492, 2723.046933573253, 2839.0205379144163, 2747.9038233661727, 2771.5426954552477, 2778.4165325281715, 2798.790090743182, 2802.3974845408234, 2732.098407525512, 2758.931026724348, 2781.193453898367, 2790.720927907193, 2797.8740956656998, 14620.122792632475, 14892.553223403314, 15080.472183473526, 15236.314365853563, 15296.770548441782, 8056.959715201445, 8334.333253339719, 8345.248927596545, 8355.289800366916, 8374.204450577185, 5169.689818610896, 5339.41266460689, 5412.5940554458175, 5425.9186112208345, 5432.782688692448, 1953.082051435823, 1992.7010948357718, 2012.9798702013086, 2052.4971382011354, 2059.4748339173416, 26342.0, 26545.734542654518, 26693.599596005883, 26698.19905402841, 26829.853611711213, 6606.0, 6787.592744435349, 6821.624810635363, 6989.33601307875, 7011.474139439562, 17039.48881533556, 17259.827401726074, 17279.82720172782, 17297.65404691899, 17417.39039133624, 7446.218147094585, 7723.65243564041, 7810.843783124419, 7944.0, 7969.322607578305, 7344.48588598793, 7370.005049318273, 7411.88882166768, 7415.851682966419, 7556.811079722941, 5004.1492946198505, 5119.078565858107, 5129.435762066169, 5178.171492561172, 5243.449437809051, 1442.343733601209, 1477.5862758427656, 1483.7403454395437, 1493.2533733133432, 1510.3128076725063, 882.8057827277988, 885.9557022148866, 897.9057198994142, 903.1375036839802, 918.8070505193984, 7335.0293131281915, 7346.926530734624, 7389.408847292204, 7425.368843648243, 7470.0662417197855, 724.9021382113452, 737.2295950731499, 740.9666565004587, 752.2552672853835, 763.5189830406808, 4621.0, 4651.883702907455, 4653.581177693956, 4663.160631086437, 4710.764461776966, 20220.89889550543, 21577.0, 21723.0, 21757.891210543847, 21797.45506362322, 20234.797652023586, 20300.695489567668, 20969.161233550793, 21121.68317475239, 21559.35321940344, 11174.27367221128, 11275.32348059119, 11464.566929133858, 11471.483783229774, 11644.35956022427, 7929.5242285463055, 8166.632501537564, 8211.507309561446, 8212.260896519341, 8264.504129752235, 18009.189586468903, 18499.90750046241, 18526.258949641862, 18980.43058708241, 19038.428847134608, 18493.352732654294, 18902.905485472485, 19183.712244316626, 19360.0, 19818.306359277358, 10963.451827408438, 11068.944655276671, 11107.278026928223, 11137.10903127764, 11146.721331966766, 13511.797323039966, 14202.928985355007, 14310.928445357707, 14316.498922537661, 14362.425502979764, 11281.32312061279, 11634.418279086181, 11718.296902185895, 11763.058955283728, 11886.28682279066, 11244.26912250701, 11398.94300528492, 11418.0865530759, 11434.142439317251, 11555.768884622092, 9934.602615895283, 9943.353682010646, 10004.599816007278, 10008.299419040597, 10019.54912028975, 6742.730290788313, 6868.0, 6924.653767311514, 6944.791656250321, 7012.894806577803, 7089.220185779457, 7165.140183178052, 7186.029885965328, 7221.855562888818, 7247.927520724726], "value": 6614.136006503331, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.5188238790516, 529.7166016181343, 530.7452422837035, 531.1111221208772, 533.7731464127747, 6103.664298463583, 6116.204893363862, 6165.784197553086, 6215.937840621593, 6230.781922632703, 5941.494972927296, 6026.9095963560585, 6029.130969399489, 6057.273127224728, 6080.686026115766, 5002.324686167357, 5027.0, 5041.092603331399, 5074.771635276403, 5099.694018358901, 5028.296038554606, 5082.23766435034, 5100.540951314381, 5134.306868572732, 5140.126178549637, 4787.712737235777, 4882.755862206894, 4891.217405215166, 4894.657373983822, 4926.802927882881, 4859.465458799565, 4862.635302352338, 4881.536254055877, 4906.264060390934, 4915.729634870081, 4324.308110702273, 4374.58441448062, 4396.582324679151, 4411.117776444692, 4427.645788336926, 5959.135925290809, 5971.134185543072, 5979.2824861016525, 5984.491318237955, 6032.45707886288, 5557.3886872444, 5576.315894648475, 5601.187827764951, 5636.15457681347, 5654.660720356751, 6347.428731414195, 6351.967370441461, 6389.98715404646, 6408.583442076297, 6413.29453760086, 4752.985600191796, 4768.117898188846, 4789.736564488951, 4806.687565308243, 4818.566329030369, 6363.872722545523, 6456.192975878015, 6615.966920165417, 6627.966860165669, 6648.567843090232, 4832.139626243921, 4885.7312847793, 4891.144049791273, 4926.1379258629595, 4955.702657840541, 4942.431620363633, 4987.925181122286, 5015.3229314042865, 5023.14606516893, 5036.823711170092, 5527.281453411111, 5530.253415788817, 5572.60991730575, 5591.245181900392, 5611.410801865827, 6420.325865784025, 6449.290578036413, 6455.4512866406885, 6488.448481879093, 6511.34886511345, 1730.195459111519, 1732.0, 1741.9651606968043, 1750.2998800479909, 1752.8948263104255, 1146.2148428326623, 1196.1519452445991, 1208.238809549978, 1214.550616271985, 1214.8094867030359, 5525.226468294442, 5554.86112847174, 5581.776728930879, 5636.689982051026, 5644.971775141098, 6568.80293591193, 6581.835454113685, 6582.605043697394, 6606.735730570819, 6660.533762636665, 5556.749946252428, 5562.972185139049, 5615.4665306796605, 5625.971870140623, 5671.432856714378, 3369.1913940654067, 3424.5890493140982, 3433.914152146216, 3451.4822776583715, 3504.5268888699698, 6254.593451425734, 6311.715972781236, 6327.936720632827, 6372.502461921445, 6377.808665740035, 6638.203415590064, 6693.966530167318, 6700.262971073178, 6762.058504550536, 6763.864722705617, 6136.693165341715, 6208.603064310494, 6209.436064492595, 6233.657148856766, 6310.842228944313, 5887.676177810262, 6317.764283825379, 6348.619082855043, 6348.984162533972, 6453.41919227253, 6369.108324834619, 6388.520860935356, 6417.743290268337, 6437.8390540235, 6481.805545833632, 6305.180326557702, 6305.747770089329, 6308.810735677937, 6372.171617689671, 6419.528481534736, 4727.7163370197895, 4786.210275304536, 4894.681845680019, 4921.606271498343, 4963.503649635152, 6257.43683068526, 6487.0, 6518.282988871126, 6535.901961470487, 6623.768168114093, 5998.220231369894, 6271.78048768291, 6345.841353966188, 6355.5551111421755, 6383.744650213939, 6254.02998055611, 6312.589681670676, 6376.298607153117, 6385.904211436925, 6429.4534964526665, 6182.165407669907, 6244.250689917239, 6257.747211003943, 6273.811785646438, 6379.425851673372, 6308.716107775253, 6390.7763228286785, 6411.807645770635, 6445.2587952386075, 6484.254310754323, 6155.984262596621, 6174.0, 6187.907181392373, 6203.193584833943, 6221.3156552778255], "value": 4943.65508735839, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [875.0636818604088, 892.3887137310942, 904.5386852705122, 908.8954770201425, 921.4839689773725, 18227.544311392205, 18654.720179197306, 18764.53088672784, 18843.340483083095, 18860.622787544275, 18088.54778630535, 18489.35287264946, 18709.719354209665, 18786.812131878676, 19262.51843703908, 960.8750862387898, 977.7311239409148, 978.2369751593768, 980.0689345122126, 980.3382716666257, 986.1617625018748, 997.3766396002499, 999.030939988214, 1001.5893483671696, 1002.6941782756256, 1010.6715317521798, 1024.9743756406076, 1048.8898665640113, 1059.1420949031271, 1061.936283822973, 1043.9269251152423, 1044.8641676582033, 1045.5660900726189, 1048.1719441641094, 1049.695588279398, 721.3976329764653, 749.8275396658745, 750.7447467860899, 751.1662055118813, 751.9473636845423, 19734.70397944032, 19742.802571974386, 19966.600667986706, 20066.799332006638, 20494.795052049587, 21211.46971325714, 21274.574508509744, 22172.667409988862, 22305.776942230696, 22351.664725028975, 17358.0, 17454.30182792687, 17645.647087058187, 17698.380556680455, 17712.114394280365, 3804.258169656918, 3839.4432807243074, 3841.308564458396, 3841.9039524011846, 3843.250566139604, 131922.0, 132625.336873315, 133446.33276833652, 134074.0, 135473.3226333862, 16636.916815415847, 16963.915180424017, 17085.743713844302, 17164.914175429043, 17193.398231061852, 30828.38343233123, 30891.845540772152, 31165.376692466478, 31361.52957705636, 31569.36861262762, 8581.313494920392, 8722.34582406322, 8737.475751454933, 8746.431481953652, 8747.475151490931, 4012.538558065801, 4064.085580744309, 4070.0, 4102.364133559303, 4109.4246805447265, 5224.294720212799, 5448.536874365724, 5537.695426751487, 5561.610687251854, 5562.499375056264, 1012.9898701013043, 1042.5412818359898, 1044.1177205261542, 1049.7165765243342, 1056.572088304238, 628.7076509423049, 651.3291309950758, 655.446148004935, 662.5726406467898, 672.922613899398, 11527.76876581594, 11677.941610291895, 11897.0, 12962.287074211008, 13100.60698179056, 640.5804198250154, 649.4185612191501, 654.5516321319816, 668.2081733146238, 669.0165456778528, 5294.523492885659, 5332.840014799563, 5389.461053894579, 5404.91892621611, 5517.972410137923, 119251.0, 121027.39486302513, 123004.38497807454, 123365.38317308357, 125783.0, 107271.0, 109380.0, 109877.45061274643, 110985.0, 111399.0, 89822.55088724515, 92702.0, 94462.5276873625, 94622.0, 95546.0, 9510.429374237292, 9519.333646644945, 9588.424694518351, 9615.326927115315, 9818.75453113678, 41535.16929661329, 42528.0, 43066.78466607647, 43904.78047609742, 44362.890927727065, 55402.16896746471, 56863.0, 57612.42387576071, 57942.0, 58140.0, 14508.419663213775, 14764.261786910396, 14815.777763333343, 14873.18197499148, 14971.401143954556, 16373.263203156124, 16503.09232992197, 16553.751693724844, 16601.91699041497, 16698.332066717194, 15656.765148522554, 15700.528984130495, 15729.606759831096, 15753.763693544835, 15988.280527376528, 15984.600384990468, 16216.513504594881, 16281.51155465338, 16478.588035299214, 16522.17389130563, 15836.604084897508, 15845.286962086964, 15937.442189523312, 15951.521454356387, 15992.120433376276, 11573.826392603949, 11634.70913227176, 11708.70728231801, 12041.976432003377, 12104.152709310263, 12191.817122743343, 12292.631221063382, 12303.0, 12462.43919023628, 12586.559470418491], "value": 8862.40065331266, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1456.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 108.0, 108.0, 107.0, 105.0, 107.0, 111.0, 107.0, 115.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 121.0, 115.0, 116.0, 117.0, 121.0, 130.0, 117.0, 144.0, 116.0], "value": 121.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 161.0, 165.0, 172.0, 166.0, 166.0, 166.0, 165.0, 162.0, 165.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 88.0, 84.0, 76.0, 74.0, 86.0, 78.0, 82.0, 81.0, 78.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 80.0, 78.0, 79.0, 83.0, 86.0, 91.0, 79.0, 137.0, 80.0], "value": 87.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 112.0, 114.0, 121.0, 115.0, 114.0, 117.0, 116.0, 115.0], "value": 115.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 149.0, 152.0, 150.0, 152.0, 157.0, 151.0, 149.0, 147.0, 150.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 100.0, 96.0, 96.0, 94.0, 102.0, 95.0, 94.0, 94.0, 95.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 56.0, 56.0, 56.0, 57.0, 54.0, 55.0, 66.0, 55.0, 54.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [42.0, 46.0, 48.0, 40.0, 38.0, 49.0, 42.0, 48.0, 40.0, 39.0], "value": 43.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 74.0, 71.0, 71.0, 78.0, 79.0, 78.0, 77.0, 80.0, 75.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 114.0, 119.0, 120.0, 113.0, 118.0, 114.0, 112.0, 112.0, 132.0], "value": 118.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 167.0, 169.0, 165.0, 167.0, 172.0, 167.0, 173.0, 167.0, 171.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 67.0, 64.0, 67.0, 63.0, 68.0, 67.0, 63.0, 63.0], "value": 65.2, "unit": "score"}]}]} 11:48:06 INFO - Return code: 0 11:48:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:48:06 INFO - # TBPL SUCCESS # 11:48:06 INFO - Running post-action listener: _package_coverage_data 11:48:06 INFO - Running post-action listener: _resource_record_post_action 11:48:06 INFO - [mozharness: 2017-09-27 18:48:06.346361Z] Finished run-tests step (success) 11:48:06 INFO - Running post-run listener: _resource_record_post_run 11:48:06 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 10330112; Write bytes: 327938048; Read time: 4764; Write time: 166836 11:48:06 INFO - TinderboxPrint: CPU usage
13.2% 11:48:06 INFO - TinderboxPrint: I/O read bytes / time
10,330,112 / 4,764 11:48:06 INFO - TinderboxPrint: I/O write bytes / time
327,938,048 / 166,836 11:48:06 INFO - TinderboxPrint: CPU idle
8,263.2 (86.8%) 11:48:06 INFO - TinderboxPrint: CPU user
1,198.6 (12.6%) 11:48:06 INFO - TinderboxPrint: Swap in / out
0 / 0 11:48:06 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 421888; Read time: 0; Write time: 40 11:48:06 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:48:06 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 10326016; Write bytes: 327069696; Read time: 4752; Write time: 166796 11:48:06 INFO - Running post-run listener: _upload_blobber_files 11:48:06 INFO - Blob upload gear active. 11:48:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:48:06 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 11:48:06 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'] 11:48:06 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 11:48:07 INFO - (blobuploader) - INFO - Open directory for files ... 11:48:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:48:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:48:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:48:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:48:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:48:08 INFO - (blobuploader) - INFO - Done attempting. 11:48:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:48:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:48:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:48:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:48:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:48:09 INFO - (blobuploader) - INFO - Done attempting. 11:48:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:48:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:48:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:48:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:48:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:48:16 INFO - (blobuploader) - INFO - Done attempting. 11:48:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:48:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:48:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:48:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:48:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:48:17 INFO - (blobuploader) - INFO - Done attempting. 11:48:17 INFO - (blobuploader) - INFO - Iteration through files over. 11:48:17 INFO - Return code: 0 11:48:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:48:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:48:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbf1e4abd3d89aac90cdeec1622fac3978f9238daff27603f2e3d35a4a3b7f1ab68e8f4b8b39f78f11471c7e963447efa669e1cd3da5aad9c8efe5f1ae544547", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/860f22b258b585118844a5150bcfbe849874d9e920ab2db3d2de96b6af825e2a234bef241c4556d7681a1365cc3087cb0369a01e5d212814194dfcb501b31a88", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8961f5d14c9712a894ac4646dd57418c93a5d0497b184ed136decf2c3bf25447fca80e31e5b1f8b6a0164cd103cb0d65365c2e4065751ef22c0e9610cbabb71a", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d349ffc542f3db924ac8259881854da6bd56a82cbda81653d2e99e37c482d8df71d37f05e2e370862024a5204a2a780300a6cd3a92f0d0c92795b65a1195c061"} 11:48:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:48:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:48:17 INFO - Contents: 11:48:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbf1e4abd3d89aac90cdeec1622fac3978f9238daff27603f2e3d35a4a3b7f1ab68e8f4b8b39f78f11471c7e963447efa669e1cd3da5aad9c8efe5f1ae544547", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/860f22b258b585118844a5150bcfbe849874d9e920ab2db3d2de96b6af825e2a234bef241c4556d7681a1365cc3087cb0369a01e5d212814194dfcb501b31a88", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8961f5d14c9712a894ac4646dd57418c93a5d0497b184ed136decf2c3bf25447fca80e31e5b1f8b6a0164cd103cb0d65365c2e4065751ef22c0e9610cbabb71a", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d349ffc542f3db924ac8259881854da6bd56a82cbda81653d2e99e37c482d8df71d37f05e2e370862024a5204a2a780300a6cd3a92f0d0c92795b65a1195c061"} 11:48:17 INFO - Running post-run listener: copy_logs_to_upload_dir 11:48:17 INFO - Copying logs to upload dir... 11:48:17 INFO - mkdir: /builds/slave/test/build/upload/logs 11:48:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.030839 ========= master_lag: 0.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-27 11:48:17.648136) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 11:48:17.651891) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495 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/bbf1e4abd3d89aac90cdeec1622fac3978f9238daff27603f2e3d35a4a3b7f1ab68e8f4b8b39f78f11471c7e963447efa669e1cd3da5aad9c8efe5f1ae544547", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/860f22b258b585118844a5150bcfbe849874d9e920ab2db3d2de96b6af825e2a234bef241c4556d7681a1365cc3087cb0369a01e5d212814194dfcb501b31a88", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8961f5d14c9712a894ac4646dd57418c93a5d0497b184ed136decf2c3bf25447fca80e31e5b1f8b6a0164cd103cb0d65365c2e4065751ef22c0e9610cbabb71a", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d349ffc542f3db924ac8259881854da6bd56a82cbda81653d2e99e37c482d8df71d37f05e2e370862024a5204a2a780300a6cd3a92f0d0c92795b65a1195c061"} build_url:https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011150 build_url: 'https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbf1e4abd3d89aac90cdeec1622fac3978f9238daff27603f2e3d35a4a3b7f1ab68e8f4b8b39f78f11471c7e963447efa669e1cd3da5aad9c8efe5f1ae544547", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/860f22b258b585118844a5150bcfbe849874d9e920ab2db3d2de96b6af825e2a234bef241c4556d7681a1365cc3087cb0369a01e5d212814194dfcb501b31a88", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8961f5d14c9712a894ac4646dd57418c93a5d0497b184ed136decf2c3bf25447fca80e31e5b1f8b6a0164cd103cb0d65365c2e4065751ef22c0e9610cbabb71a", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d349ffc542f3db924ac8259881854da6bd56a82cbda81653d2e99e37c482d8df71d37f05e2e370862024a5204a2a780300a6cd3a92f0d0c92795b65a1195c061"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 11:48:17.696381) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:48:17.696722) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1506536366.953642-574909495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004586 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:48:17.780690) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 11:48:17.781004) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 11:48:17.781320) ========= ========= Total master_lag: 0.38 =========