builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-071 starttime: 1505817002.94 results: success (0) revision: e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:02.944627) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:02.945436) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:02.945851) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:03.092215) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:03.092532) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-19 03:30:03-- 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% 32.8M=0s 2017-09-19 03:30:03 (32.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.218139 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:03.357985) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:03.358324) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016159 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:03.412932) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:03.416296) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5 --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 e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5 --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=dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-19 03:30:03,473 truncating revision to first 12 chars 2017-09-19 03:30:03,474 Setting DEBUG logging. 2017-09-19 03:30:03,474 attempt 1/10 2017-09-19 03:30:03,474 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e4261f5b96eb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-19 03:30:03,844 unpacking tar archive at: mozilla-central-e4261f5b96eb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.706489 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:04.145052) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:04.145348) ========= script_repo_revision: e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:04.145727) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:04.145987) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:04.159629) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-19 03:30:04.159964) ========= /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=dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:30:04 INFO - MultiFileLogger online at 20170919 03:30:04 in /builds/slave/test 03:30:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:30:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:30:04 INFO - {'append_to_log': False, 03:30:04 INFO - 'base_work_dir': '/builds/slave/test', 03:30:04 INFO - 'blob_upload_branch': 'Firefox', 03:30:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:30:04 INFO - 'branch': 'Firefox', 03:30:04 INFO - 'buildbot_json_path': 'buildprops.json', 03:30:04 INFO - 'code_coverage': False, 03:30:04 INFO - 'config_files': ('talos/linux_config.py',), 03:30:04 INFO - 'default_actions': ('clobber', 03:30:04 INFO - 'read-buildbot-config', 03:30:04 INFO - 'download-and-extract', 03:30:04 INFO - 'populate-webroot', 03:30:04 INFO - 'create-virtualenv', 03:30:04 INFO - 'install', 03:30:04 INFO - 'setup-mitmproxy', 03:30:04 INFO - 'run-tests'), 03:30:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:30:04 INFO - 'disable_ccov_upload': False, 03:30:04 INFO - 'disable_stylo': False, 03:30:04 INFO - 'download_minidump_stackwalk': True, 03:30:04 INFO - 'download_symbols': 'ondemand', 03:30:04 INFO - 'enable_stylo': False, 03:30:04 INFO - 'enable_webrender': False, 03:30:04 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:30:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:30:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:30:04 INFO - 'gecko_profile': False, 03:30:04 INFO - 'gecko_profile_interval': 0, 03:30:04 INFO - 'installer_path': 'installer.exe', 03:30:04 INFO - 'log_level': 'info', 03:30:04 INFO - 'log_name': 'talos', 03:30:04 INFO - 'log_to_console': True, 03:30:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:30:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:30:04 INFO - 'opt_config_files': (), 03:30:04 INFO - 'pip_index': False, 03:30:04 INFO - 'suite': 'dromaeojs-e10s', 03:30:04 INFO - 'system_bits': '32', 03:30:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:30:04 INFO - 'title': 'talos-linux64-ix-071', 03:30:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:30:04 INFO - 'use_talos_json': True, 03:30:04 INFO - 'verify': 'False', 03:30:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:30:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:30:04 INFO - 'work_dir': 'build'} 03:30:04 INFO - [mozharness: 2017-09-19 10:30:04.456126Z] Running clobber step. 03:30:04 INFO - Running pre-action listener: _resource_record_pre_action 03:30:04 INFO - Running main action method: clobber 03:30:04 INFO - rmtree: /builds/slave/test/build 03:30:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:30:05 INFO - Running post-action listener: _resource_record_post_action 03:30:05 INFO - [mozharness: 2017-09-19 10:30:05.392060Z] Finished clobber step (success) 03:30:05 INFO - [mozharness: 2017-09-19 10:30:05.392157Z] Running read-buildbot-config step. 03:30:05 INFO - Running pre-action listener: _resource_record_pre_action 03:30:05 INFO - Running main action method: read_buildbot_config 03:30:05 INFO - Using buildbot properties: 03:30:05 INFO - { 03:30:05 INFO - "project": "", 03:30:05 INFO - "product": "firefox", 03:30:05 INFO - "who": "archaeopteryx@coole-files.de", 03:30:05 INFO - "installer_path": "public/build/target.tar.bz2", 03:30:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:30:05 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:30:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 03:30:05 INFO - "stage_platform": "linux64-pgo", 03:30:05 INFO - "basedir": "/builds/slave/test", 03:30:05 INFO - "buildnumber": 193, 03:30:05 INFO - "platform": "ubuntu64_hw", 03:30:05 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:30:05 INFO - "slavebuilddir": "test", 03:30:05 INFO - "taskId": "fg8VztQ5SmK0RrBFLOfMdw", 03:30:05 INFO - "branch": "mozilla-central", 03:30:05 INFO - "script_repo_revision": "production", 03:30:05 INFO - "revision": "e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5", 03:30:05 INFO - "slavename": "talos-linux64-ix-071", 03:30:05 INFO - "repo_path": "mozilla-central" 03:30:05 INFO - } 03:30:05 INFO - Finding installer, test and symbols from parent task. 03:30:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fg8VztQ5SmK0RrBFLOfMdw'}, attempt #1 03:30:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fg8VztQ5SmK0RrBFLOfMdw'}, attempt #1 03:30:06 INFO - Task dependencies: Y9n31viyR8mh7pkqvQO0YA 03:30:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA'}, attempt #1 03:30:06 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.tar.bz2 03:30:06 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.test_packages.json 03:30:06 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.crashreporter-symbols.zip 03:30:06 INFO - Running post-action listener: _resource_record_post_action 03:30:06 INFO - [mozharness: 2017-09-19 10:30:06.721216Z] Finished read-buildbot-config step (success) 03:30:06 INFO - [mozharness: 2017-09-19 10:30:06.721433Z] Running download-and-extract step. 03:30:06 INFO - Running pre-action listener: _resource_record_pre_action 03:30:06 INFO - Running main action method: download_and_extract 03:30:06 INFO - mkdir: /builds/slave/test/build/tests 03:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:06 INFO - trying https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.test_packages.json 03:30:06 INFO - Downloading https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:30:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:30:07 INFO - Downloaded 989 bytes. 03:30:07 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:30:07 INFO - Using the following test package requirements: 03:30:07 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:30:07 INFO - u'common': [u'target.common.tests.zip'], 03:30:07 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:30:07 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:30:07 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:30:07 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:30:07 INFO - u'mozbase': [u'target.common.tests.zip'], 03:30:07 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:30:07 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:30:07 INFO - u'web-platform': [u'target.common.tests.zip', 03:30:07 INFO - u'target.web-platform.tests.tar.gz'], 03:30:07 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:30:07 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:30:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.common.tests.zip 03:30:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:30:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.common.tests.zip into memory 03:30:09 INFO - Content-Length response header: 55327111 03:30:09 INFO - Bytes received: 55327111 03:30:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.talos.tests.zip 03:30:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:30:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.talos.tests.zip into memory 03:30:21 INFO - Content-Length response header: 14508787 03:30:21 INFO - Bytes received: 14508787 03:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:21 INFO - trying https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.tar.bz2 03:30:21 INFO - Downloading https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:30:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:30:24 INFO - Downloaded 62293283 bytes. 03:30:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.tar.bz2 03:30:24 INFO - mkdir: /builds/slave/test/properties 03:30:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:30:24 INFO - Writing to file /builds/slave/test/properties/build_url 03:30:24 INFO - Contents: 03:30:24 INFO - build_url:https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.tar.bz2 03:30:24 INFO - Running post-action listener: _resource_record_post_action 03:30:24 INFO - Running post-action listener: find_tests_for_verification 03:30:24 INFO - Running post-action listener: set_extra_try_arguments 03:30:24 INFO - [mozharness: 2017-09-19 10:30:24.571460Z] Finished download-and-extract step (success) 03:30:24 INFO - [mozharness: 2017-09-19 10:30:24.571693Z] Running populate-webroot step. 03:30:24 INFO - Running pre-action listener: _resource_record_pre_action 03:30:24 INFO - Running main action method: populate_webroot 03:30:24 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:30:24 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:30:24 INFO - 'tests': ['tresize', 03:30:24 INFO - 'tcanvasmark']}, 03:30:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:30:24 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:30:24 INFO - 'tests': ['dromaeo_css', 03:30:24 INFO - 'kraken']}, 03:30:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:30:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:24 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:30:24 INFO - 'talos_options': ['--disable-stylo'], 03:30:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:30:24 INFO - 'tests': ['damp', 'tps']}, 03:30:24 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:30:24 INFO - 'talos_options': ['--disable-stylo'], 03:30:24 INFO - 'tests': ['damp', 'tps']}, 03:30:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:30:24 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:30:24 INFO - 'tests': ['dromaeo_dom']}, 03:30:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:30:24 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:30:24 INFO - 'tests': ['basic_compositor_video', 03:30:24 INFO - 'glvideo']}, 03:30:24 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:30:24 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:30:24 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:30:24 INFO - 'talos_options': ['--disable-stylo'], 03:30:24 INFO - 'tests': ['ts_paint_webext', 03:30:24 INFO - 'tp5o_webext']}, 03:30:24 INFO - 'other-e10s': {'tests': ['a11yr', 03:30:24 INFO - 'ts_paint', 03:30:24 INFO - 'tpaint', 03:30:24 INFO - 'sessionrestore', 03:30:24 INFO - 'sessionrestore_many_windows', 03:30:24 INFO - 'sessionrestore_no_auto_restore', 03:30:24 INFO - 'tabpaint']}, 03:30:24 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:30:24 INFO - 'tests': ['a11yr', 03:30:24 INFO - 'ts_paint', 03:30:24 INFO - 'tpaint', 03:30:24 INFO - 'sessionrestore', 03:30:24 INFO - 'sessionrestore_many_windows', 03:30:24 INFO - 'sessionrestore_no_auto_restore', 03:30:24 INFO - 'tabpaint']}, 03:30:24 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:30:24 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:30:24 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:30:24 INFO - 'tests': ['perf_reftest_singletons']}, 03:30:24 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:30:24 INFO - 'tests': ['bloom_basic']}, 03:30:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:30:24 INFO - 'tsvgr_opacity', 03:30:24 INFO - 'tart', 03:30:24 INFO - 'tscrollx', 03:30:24 INFO - 'tsvg_static']}, 03:30:24 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:30:24 INFO - 'tests': ['tsvgx', 03:30:24 INFO - 'tsvgr_opacity', 03:30:24 INFO - 'tart', 03:30:24 INFO - 'tscrollx', 03:30:24 INFO - 'tsvg_static']}, 03:30:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:30:24 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:30:24 INFO - 'talos_options': ['--disable-stylo'], 03:30:24 INFO - 'tests': ['tp5o']}, 03:30:24 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:30:24 INFO - 'talos_options': ['--mitmproxy', 03:30:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:30:24 INFO - '--firstNonBlankPaint'], 03:30:24 INFO - 'tests': ['tp6_google', 03:30:24 INFO - 'tp6_youtube', 03:30:24 INFO - 'tp6_amazon', 03:30:24 INFO - 'tp6_facebook']}, 03:30:24 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:30:24 INFO - 'talos_options': ['--disable-stylo', 03:30:24 INFO - '--mitmproxy', 03:30:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:30:24 INFO - '--firstNonBlankPaint'], 03:30:24 INFO - 'tests': ['tp6_google', 03:30:24 INFO - 'tp6_youtube', 03:30:24 INFO - 'tp6_amazon', 03:30:24 INFO - 'tp6_facebook']}, 03:30:24 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:30:24 INFO - 'talos_options': ['--stylo-threads=1', 03:30:24 INFO - '--mitmproxy', 03:30:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:30:24 INFO - '--firstNonBlankPaint'], 03:30:24 INFO - 'tests': ['tp6_google', 03:30:24 INFO - 'tp6_youtube', 03:30:24 INFO - 'tp6_amazon', 03:30:24 INFO - 'tp6_facebook']}, 03:30:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:30:24 INFO - 'talos_options': ['--xperf_path', 03:30:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:24 INFO - 'tests': ['tp5n']}, 03:30:24 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:30:24 INFO - 'talos_options': ['--disable-stylo', 03:30:24 INFO - '--xperf_path', 03:30:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:24 INFO - 'tests': ['tp5n']}}} 03:30:24 INFO - Running post-action listener: _resource_record_post_action 03:30:24 INFO - [mozharness: 2017-09-19 10:30:24.596652Z] Finished populate-webroot step (success) 03:30:24 INFO - [mozharness: 2017-09-19 10:30:24.596745Z] Running create-virtualenv step. 03:30:24 INFO - Running pre-action listener: _resource_record_pre_action 03:30:24 INFO - Running main action method: create_virtualenv 03:30:24 INFO - Creating virtualenv /builds/slave/test/build/venv 03:30:24 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:30:24 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:30:24 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:30:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:30:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:30:25 INFO - Installing distribute.............................................................................................................................................................................................done. 03:30:26 INFO - Installing pip...............done. 03:30:26 INFO - Return code: 0 03:30:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:30:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:30:26 INFO - Reading from file tmpfile_stdout 03:30:26 INFO - Output received: 03:30:26 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:30:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:26 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 0xce21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052090>, '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 0x1052d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cf90>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:30:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:30:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:30:26 INFO - Using env: {'DISPLAY': ':0', 03:30:26 INFO - 'HOME': '/home/cltbld', 03:30:26 INFO - 'LANG': 'en_US.UTF-8', 03:30:26 INFO - 'LANGUAGE': 'en_US:en', 03:30:26 INFO - 'LOGNAME': 'cltbld', 03:30:26 INFO - 'MAIL': '/var/mail/cltbld', 03:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:26 INFO - 'MOZ_NO_REMOTE': '1', 03:30:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:26 INFO - 'NO_EM_RESTART': '1', 03:30:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:26 INFO - 'PWD': '/builds/slave/test', 03:30:26 INFO - 'SHELL': '/bin/bash', 03:30:26 INFO - 'SHLVL': '1', 03:30:26 INFO - 'TERM': 'linux', 03:30:26 INFO - 'TMOUT': '86400', 03:30:26 INFO - 'USER': 'cltbld', 03:30:26 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860', 03:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:26 INFO - '_': '/tools/buildbot/bin/python'} 03:30:27 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:30:27 INFO - Downloading/unpacking pip>=1.5 03:30:27 INFO - Running setup.py egg_info for package pip 03:30:27 INFO - warning: no files found matching 'pip/cacert.pem' 03:30:27 INFO - warning: no files found matching '*.html' under directory 'docs' 03:30:27 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:30:27 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:30:27 INFO - Installing collected packages: pip 03:30:27 INFO - Found existing installation: pip 1.1 03:30:27 INFO - Uninstalling pip: 03:30:27 INFO - Successfully uninstalled pip 03:30:27 INFO - Running setup.py install for pip 03:30:27 INFO - warning: no files found matching 'pip/cacert.pem' 03:30:27 INFO - warning: no files found matching '*.html' under directory 'docs' 03:30:27 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:30:27 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:30:27 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:30:27 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:30:27 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:30:27 INFO - Successfully installed pip 03:30:27 INFO - Cleaning up... 03:30:27 INFO - Return code: 0 03:30:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:27 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 0xce21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052090>, '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 0x1052d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cf90>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:30:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:30:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:30:27 INFO - Using env: {'DISPLAY': ':0', 03:30:27 INFO - 'HOME': '/home/cltbld', 03:30:27 INFO - 'LANG': 'en_US.UTF-8', 03:30:27 INFO - 'LANGUAGE': 'en_US:en', 03:30:27 INFO - 'LOGNAME': 'cltbld', 03:30:27 INFO - 'MAIL': '/var/mail/cltbld', 03:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:27 INFO - 'MOZ_NO_REMOTE': '1', 03:30:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:27 INFO - 'NO_EM_RESTART': '1', 03:30:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:27 INFO - 'PWD': '/builds/slave/test', 03:30:27 INFO - 'SHELL': '/bin/bash', 03:30:27 INFO - 'SHLVL': '1', 03:30:27 INFO - 'TERM': 'linux', 03:30:27 INFO - 'TMOUT': '86400', 03:30:27 INFO - 'USER': 'cltbld', 03:30:27 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860', 03:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:27 INFO - '_': '/tools/buildbot/bin/python'} 03:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:27 INFO - Downloading/unpacking psutil>=3.1.1 03:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:30:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:28 INFO - Installing collected packages: psutil 03:30:28 INFO - Running setup.py install for psutil 03:30:29 INFO - building 'psutil._psutil_linux' extension 03:30:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:30:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:30:31 INFO - building 'psutil._psutil_posix' extension 03:30:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:30:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:30:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:31 INFO - Successfully installed psutil 03:30:31 INFO - Cleaning up... 03:30:31 INFO - Return code: 0 03:30:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:31 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 0xce21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052090>, '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 0x1052d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cf90>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:30:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:30:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:30:31 INFO - Using env: {'DISPLAY': ':0', 03:30:31 INFO - 'HOME': '/home/cltbld', 03:30:31 INFO - 'LANG': 'en_US.UTF-8', 03:30:31 INFO - 'LANGUAGE': 'en_US:en', 03:30:31 INFO - 'LOGNAME': 'cltbld', 03:30:31 INFO - 'MAIL': '/var/mail/cltbld', 03:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:31 INFO - 'MOZ_NO_REMOTE': '1', 03:30:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:31 INFO - 'NO_EM_RESTART': '1', 03:30:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:31 INFO - 'PWD': '/builds/slave/test', 03:30:31 INFO - 'SHELL': '/bin/bash', 03:30:31 INFO - 'SHLVL': '1', 03:30:31 INFO - 'TERM': 'linux', 03:30:31 INFO - 'TMOUT': '86400', 03:30:31 INFO - 'USER': 'cltbld', 03:30:31 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860', 03:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:31 INFO - '_': '/tools/buildbot/bin/python'} 03:30:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:30:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:30:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:30:32 INFO - Installing collected packages: mozsystemmonitor 03:30:32 INFO - Running setup.py install for mozsystemmonitor 03:30:32 INFO - Successfully installed mozsystemmonitor 03:30:32 INFO - Cleaning up... 03:30:32 INFO - Return code: 0 03:30:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:32 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 0xce21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052090>, '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 0x1052d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cf90>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:30:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:30:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:30:32 INFO - Using env: {'DISPLAY': ':0', 03:30:32 INFO - 'HOME': '/home/cltbld', 03:30:32 INFO - 'LANG': 'en_US.UTF-8', 03:30:32 INFO - 'LANGUAGE': 'en_US:en', 03:30:32 INFO - 'LOGNAME': 'cltbld', 03:30:32 INFO - 'MAIL': '/var/mail/cltbld', 03:30:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:32 INFO - 'MOZ_NO_REMOTE': '1', 03:30:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:32 INFO - 'NO_EM_RESTART': '1', 03:30:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:32 INFO - 'PWD': '/builds/slave/test', 03:30:32 INFO - 'SHELL': '/bin/bash', 03:30:32 INFO - 'SHLVL': '1', 03:30:32 INFO - 'TERM': 'linux', 03:30:32 INFO - 'TMOUT': '86400', 03:30:32 INFO - 'USER': 'cltbld', 03:30:32 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860', 03:30:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:32 INFO - '_': '/tools/buildbot/bin/python'} 03:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:33 INFO - Downloading/unpacking jsonschema==2.5.1 03:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:30:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:34 INFO - Downloading functools32-3.2.3-2.tar.gz 03:30:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:30:34 INFO - warning: no files found matching '*.txt' 03:30:34 INFO - no previously-included directories found matching 'build' 03:30:34 INFO - no previously-included directories found matching 'dist' 03:30:34 INFO - no previously-included directories found matching '.git*' 03:30:34 INFO - Installing collected packages: jsonschema, functools32 03:30:34 INFO - Running setup.py install for functools32 03:30:34 INFO - warning: no files found matching '*.txt' 03:30:34 INFO - no previously-included directories found matching 'build' 03:30:34 INFO - no previously-included directories found matching 'dist' 03:30:34 INFO - no previously-included directories found matching '.git*' 03:30:34 INFO - Successfully installed jsonschema functools32 03:30:34 INFO - Cleaning up... 03:30:34 INFO - Return code: 0 03:30:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30: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')]} 03:30:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:34 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 0xce21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052090>, '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 0x1052d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cf90>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:30:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:30:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:30:34 INFO - Using env: {'DISPLAY': ':0', 03:30:34 INFO - 'HOME': '/home/cltbld', 03:30:34 INFO - 'LANG': 'en_US.UTF-8', 03:30:34 INFO - 'LANGUAGE': 'en_US:en', 03:30:34 INFO - 'LOGNAME': 'cltbld', 03:30:34 INFO - 'MAIL': '/var/mail/cltbld', 03:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:34 INFO - 'MOZ_NO_REMOTE': '1', 03:30:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:34 INFO - 'NO_EM_RESTART': '1', 03:30:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:34 INFO - 'PWD': '/builds/slave/test', 03:30:34 INFO - 'SHELL': '/bin/bash', 03:30:34 INFO - 'SHLVL': '1', 03:30:34 INFO - 'TERM': 'linux', 03:30:34 INFO - 'TMOUT': '86400', 03:30:34 INFO - 'USER': 'cltbld', 03:30:34 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860', 03:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:34 INFO - '_': '/tools/buildbot/bin/python'} 03:30:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:30:34 INFO - Cleaning up... 03:30:34 INFO - Return code: 0 03:30:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30: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')]} 03:30:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:34 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 0xce21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052090>, '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 0x1052d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cf90>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:30:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:30:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:30:34 INFO - Using env: {'DISPLAY': ':0', 03:30:34 INFO - 'HOME': '/home/cltbld', 03:30:34 INFO - 'LANG': 'en_US.UTF-8', 03:30:34 INFO - 'LANGUAGE': 'en_US:en', 03:30:34 INFO - 'LOGNAME': 'cltbld', 03:30:34 INFO - 'MAIL': '/var/mail/cltbld', 03:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:34 INFO - 'MOZ_NO_REMOTE': '1', 03:30:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:34 INFO - 'NO_EM_RESTART': '1', 03:30:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:34 INFO - 'PWD': '/builds/slave/test', 03:30:34 INFO - 'SHELL': '/bin/bash', 03:30:34 INFO - 'SHLVL': '1', 03:30:34 INFO - 'TERM': 'linux', 03:30:34 INFO - 'TMOUT': '86400', 03:30:34 INFO - 'USER': 'cltbld', 03:30:34 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860', 03:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:34 INFO - '_': '/tools/buildbot/bin/python'} 03:30:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:34 INFO - Downloading/unpacking blobuploader==1.2.4 03:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:36 INFO - Downloading blobuploader-1.2.4.tar.gz 03:30:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:30:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:30:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:36 INFO - Downloading docopt-0.6.1.tar.gz 03:30:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:30:36 INFO - Installing collected packages: blobuploader, requests, docopt 03:30:36 INFO - Running setup.py install for blobuploader 03:30:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:30:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:30:36 INFO - Running setup.py install for requests 03:30:37 INFO - Running setup.py install for docopt 03:30:37 INFO - Successfully installed blobuploader requests docopt 03:30:37 INFO - Cleaning up... 03:30:37 INFO - Return code: 0 03:30:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:37 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 0xce21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052090>, '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 0x1052d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cf90>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:30:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:30:37 INFO - Using env: {'DISPLAY': ':0', 03:30:37 INFO - 'HOME': '/home/cltbld', 03:30:37 INFO - 'LANG': 'en_US.UTF-8', 03:30:37 INFO - 'LANGUAGE': 'en_US:en', 03:30:37 INFO - 'LOGNAME': 'cltbld', 03:30:37 INFO - 'MAIL': '/var/mail/cltbld', 03:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:37 INFO - 'MOZ_NO_REMOTE': '1', 03:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:37 INFO - 'NO_EM_RESTART': '1', 03:30:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:37 INFO - 'PWD': '/builds/slave/test', 03:30:37 INFO - 'SHELL': '/bin/bash', 03:30:37 INFO - 'SHLVL': '1', 03:30:37 INFO - 'TERM': 'linux', 03:30:37 INFO - 'TMOUT': '86400', 03:30:37 INFO - 'USER': 'cltbld', 03:30:37 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860', 03:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:37 INFO - '_': '/tools/buildbot/bin/python'} 03:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:37 INFO - Running setup.py (path:/tmp/pip-VSRj_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:37 INFO - Running setup.py (path:/tmp/pip-gqkDob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:37 INFO - Running setup.py (path:/tmp/pip-UWnypQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:37 INFO - Running setup.py (path:/tmp/pip-5oCrfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:37 INFO - Running setup.py (path:/tmp/pip-xQ2MYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:37 INFO - Running setup.py (path:/tmp/pip-2zwN8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:37 INFO - Running setup.py (path:/tmp/pip-dAuLfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:37 INFO - Running setup.py (path:/tmp/pip-2Tf668-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:38 INFO - Running setup.py (path:/tmp/pip-4LYvS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:38 INFO - Running setup.py (path:/tmp/pip-cAQdda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:38 INFO - Running setup.py (path:/tmp/pip-HU1IR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:38 INFO - Running setup.py (path:/tmp/pip-8tIFlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:38 INFO - Running setup.py (path:/tmp/pip-BstP35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:38 INFO - Running setup.py (path:/tmp/pip-O9vByK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:38 INFO - Running setup.py (path:/tmp/pip-iU2wdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:38 INFO - Running setup.py (path:/tmp/pip-yJq98z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:38 INFO - Running setup.py (path:/tmp/pip-bsesfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:30:38 INFO - Running setup.py install for manifestparser 03:30:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:30:38 INFO - Running setup.py install for mozcrash 03:30:38 INFO - Running setup.py install for mozdebug 03:30:38 INFO - Running setup.py install for mozdevice 03:30:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:30:39 INFO - Running setup.py install for mozfile 03:30:39 INFO - Running setup.py install for mozhttpd 03:30:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:30:39 INFO - Running setup.py install for mozinfo 03:30:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:30:39 INFO - Running setup.py install for mozInstall 03:30:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:30:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:30:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:30:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:30:39 INFO - Running setup.py install for mozleak 03:30:39 INFO - Running setup.py install for mozlog 03:30:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:30:39 INFO - Running setup.py install for moznetwork 03:30:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:30:39 INFO - Running setup.py install for mozprocess 03:30:39 INFO - Running setup.py install for mozprofile 03:30:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:30:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:30:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:30:39 INFO - Running setup.py install for mozrunner 03:30:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:30:40 INFO - Running setup.py install for mozscreenshot 03:30:40 INFO - Running setup.py install for moztest 03:30:40 INFO - Running setup.py install for mozversion 03:30:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:30:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:30:40 INFO - Cleaning up... 03:30:40 INFO - Return code: 0 03:30:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:40 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 0xce21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052090>, '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 0x1052d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cf90>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:30:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:30:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:30:40 INFO - Using env: {'DISPLAY': ':0', 03:30:40 INFO - 'HOME': '/home/cltbld', 03:30:40 INFO - 'LANG': 'en_US.UTF-8', 03:30:40 INFO - 'LANGUAGE': 'en_US:en', 03:30:40 INFO - 'LOGNAME': 'cltbld', 03:30:40 INFO - 'MAIL': '/var/mail/cltbld', 03:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:40 INFO - 'MOZ_NO_REMOTE': '1', 03:30:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:40 INFO - 'NO_EM_RESTART': '1', 03:30:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:40 INFO - 'PWD': '/builds/slave/test', 03:30:40 INFO - 'SHELL': '/bin/bash', 03:30:40 INFO - 'SHLVL': '1', 03:30:40 INFO - 'TERM': 'linux', 03:30:40 INFO - 'TMOUT': '86400', 03:30:40 INFO - 'USER': 'cltbld', 03:30:40 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860', 03:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:40 INFO - '_': '/tools/buildbot/bin/python'} 03:30:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:40 INFO - Running setup.py (path:/tmp/pip-LF7tKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:40 INFO - Running setup.py (path:/tmp/pip-65EHvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:40 INFO - Running setup.py (path:/tmp/pip-Aq8xTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:40 INFO - Running setup.py (path:/tmp/pip-tw72fT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:40 INFO - Running setup.py (path:/tmp/pip-Jhrc1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:41 INFO - Running setup.py (path:/tmp/pip-JowHTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:41 INFO - Running setup.py (path:/tmp/pip-nz3jV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:41 INFO - Running setup.py (path:/tmp/pip-HBRzna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:41 INFO - Running setup.py (path:/tmp/pip-oRhcqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:41 INFO - Running setup.py (path:/tmp/pip-9aZOyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:41 INFO - Running setup.py (path:/tmp/pip-YnojkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:41 INFO - Running setup.py (path:/tmp/pip-K0JQOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:41 INFO - Running setup.py (path:/tmp/pip-opHE9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:41 INFO - Running setup.py (path:/tmp/pip-Wx1pzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:41 INFO - Running setup.py (path:/tmp/pip-Ax6UVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:41 INFO - Running setup.py (path:/tmp/pip-BSBPuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:41 INFO - Running setup.py (path:/tmp/pip-kJMZjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:30:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:30:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:30:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:30:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:30:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:30:41 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:30:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:43 INFO - Downloading blessings-1.6.tar.gz 03:30:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:30:43 INFO - Installing collected packages: blessings 03:30:43 INFO - Running setup.py install for blessings 03:30:43 INFO - Successfully installed blessings 03:30:43 INFO - Cleaning up... 03:30:43 INFO - Return code: 0 03:30:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:30:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:43 INFO - Reading from file tmpfile_stdout 03:30:43 INFO - Current package versions: 03:30:43 INFO - argparse == 1.2.1 03:30:43 INFO - blessings == 1.6 03:30:43 INFO - blobuploader == 1.2.4 03:30:43 INFO - docopt == 0.6.1 03:30:43 INFO - functools32 == 3.2.3-2 03:30:43 INFO - jsonschema == 2.5.1 03:30:43 INFO - manifestparser == 1.1 03:30:43 INFO - mozInstall == 1.13 03:30:43 INFO - mozcrash == 1.0 03:30:43 INFO - mozdebug == 0.1 03:30:43 INFO - mozdevice == 0.51 03:30:43 INFO - mozfile == 1.2 03:30:43 INFO - mozhttpd == 0.7 03:30:43 INFO - mozinfo == 0.10 03:30:43 INFO - mozleak == 0.1 03:30:43 INFO - mozlog == 3.5 03:30:43 INFO - moznetwork == 0.27 03:30:43 INFO - mozprocess == 0.25 03:30:43 INFO - mozprofile == 0.28 03:30:43 INFO - mozrunner == 6.13 03:30:43 INFO - mozscreenshot == 0.1 03:30:43 INFO - mozsystemmonitor == 0.3 03:30:43 INFO - moztest == 0.8 03:30:43 INFO - mozversion == 1.4 03:30:43 INFO - psutil == 3.1.1 03:30:43 INFO - requests == 1.2.3 03:30:43 INFO - wsgiref == 0.1.2 03:30:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:43 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 0xce21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052090>, '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 0x1052d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cf90>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:30:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:30:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:30:43 INFO - Using env: {'DISPLAY': ':0', 03:30:43 INFO - 'HOME': '/home/cltbld', 03:30:43 INFO - 'LANG': 'en_US.UTF-8', 03:30:43 INFO - 'LANGUAGE': 'en_US:en', 03:30:43 INFO - 'LOGNAME': 'cltbld', 03:30:43 INFO - 'MAIL': '/var/mail/cltbld', 03:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:43 INFO - 'MOZ_NO_REMOTE': '1', 03:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:43 INFO - 'NO_EM_RESTART': '1', 03:30:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:43 INFO - 'PWD': '/builds/slave/test', 03:30:43 INFO - 'SHELL': '/bin/bash', 03:30:43 INFO - 'SHLVL': '1', 03:30:43 INFO - 'TERM': 'linux', 03:30:43 INFO - 'TMOUT': '86400', 03:30:43 INFO - 'USER': 'cltbld', 03:30:43 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860', 03:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:43 INFO - '_': '/tools/buildbot/bin/python'} 03:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:30:43 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:30:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:30:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:30:44 INFO - Installing collected packages: simplejson 03:30:44 INFO - Running setup.py install for simplejson 03:30:44 INFO - building 'simplejson._speedups' extension 03:30:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:30:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:30:45 INFO - Successfully installed simplejson 03:30:45 INFO - Cleaning up... 03:30:45 INFO - Return code: 0 03:30:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052090>, '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 0x1052d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cf90>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:30:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:30:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:30:45 INFO - Using env: {'DISPLAY': ':0', 03:30:45 INFO - 'HOME': '/home/cltbld', 03:30:45 INFO - 'LANG': 'en_US.UTF-8', 03:30:45 INFO - 'LANGUAGE': 'en_US:en', 03:30:45 INFO - 'LOGNAME': 'cltbld', 03:30:45 INFO - 'MAIL': '/var/mail/cltbld', 03:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:45 INFO - 'MOZ_NO_REMOTE': '1', 03:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:45 INFO - 'NO_EM_RESTART': '1', 03:30:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:45 INFO - 'PWD': '/builds/slave/test', 03:30:45 INFO - 'SHELL': '/bin/bash', 03:30:45 INFO - 'SHLVL': '1', 03:30:45 INFO - 'TERM': 'linux', 03:30:45 INFO - 'TMOUT': '86400', 03:30:45 INFO - 'USER': 'cltbld', 03:30:45 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860', 03:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:45 INFO - '_': '/tools/buildbot/bin/python'} 03:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:30:46 INFO - Cleaning up... 03:30:46 INFO - Return code: 0 03:30:46 INFO - Running post-action listener: _resource_record_post_action 03:30:46 INFO - Running post-action listener: _start_resource_monitoring 03:30:46 INFO - Starting resource monitoring. 03:30:46 INFO - [mozharness: 2017-09-19 10:30:46.203464Z] Finished create-virtualenv step (success) 03:30:46 INFO - [mozharness: 2017-09-19 10:30:46.204394Z] Running install step. 03:30:46 INFO - Running pre-action listener: _resource_record_pre_action 03:30:46 INFO - Running main action method: install 03:30:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:46 INFO - Reading from file tmpfile_stdout 03:30:46 INFO - Detecting whether we're running mozinstall >=1.0... 03:30:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:30:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:30:46 INFO - Reading from file tmpfile_stdout 03:30:46 INFO - Output received: 03:30:46 INFO - Usage: mozinstall [options] installer 03:30:46 INFO - Options: 03:30:46 INFO - -h, --help show this help message and exit 03:30:46 INFO - -d DEST, --destination=DEST 03:30:46 INFO - Directory to install application into. [default: 03:30:46 INFO - "/builds/slave/test"] 03:30:46 INFO - --app=APP Application being installed. [default: firefox] 03:30:46 INFO - mkdir: /builds/slave/test/build/application 03:30:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:30:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:31:04 INFO - Reading from file tmpfile_stdout 03:31:04 INFO - Output received: 03:31:04 INFO - /builds/slave/test/build/application/firefox/firefox 03:31:04 INFO - Running post-action listener: _resource_record_post_action 03:31:04 INFO - [mozharness: 2017-09-19 10:31:04.178340Z] Finished install step (success) 03:31:04 INFO - [mozharness: 2017-09-19 10:31:04.178487Z] Running setup-mitmproxy step. 03:31:04 INFO - Running pre-action listener: _resource_record_pre_action 03:31:04 INFO - Running main action method: setup_mitmproxy 03:31:04 INFO - Skipping: mitmproxy is not required 03:31:04 INFO - Running post-action listener: _resource_record_post_action 03:31:04 INFO - [mozharness: 2017-09-19 10:31:04.179015Z] Finished setup-mitmproxy step (success) 03:31:04 INFO - [mozharness: 2017-09-19 10:31:04.179118Z] Running run-tests step. 03:31:04 INFO - Running pre-action listener: _resource_record_pre_action 03:31:04 INFO - Running pre-action listener: _set_gcov_prefix 03:31:04 INFO - Running main action method: run_tests 03:31:04 WARNING - Try message not found. 03:31:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:31:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:31:04 INFO - Python 2.7.3 03:31:04 INFO - Return code: 0 03:31:04 INFO - grabbing minidump binary from tooltool 03:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:04 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 0x1052090>, '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 0x1052d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:31:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:31:04 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:31:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:31:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:31:04 INFO - Return code: 0 03:31:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:31:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:31:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:31:04 INFO - ENV: RUST_BACKTRACE is now full 03:31:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:31:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:31:04 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/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:31:04 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/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-071 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:31:04 INFO - Using env: {'DISPLAY': ':0', 03:31:04 INFO - 'HOME': '/home/cltbld', 03:31:04 INFO - 'LANG': 'en_US.UTF-8', 03:31:04 INFO - 'LANGUAGE': 'en_US:en', 03:31:04 INFO - 'LOGNAME': 'cltbld', 03:31:04 INFO - 'MAIL': '/var/mail/cltbld', 03:31:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:31:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:31:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:04 INFO - 'MOZ_NO_REMOTE': '1', 03:31:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:31:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:04 INFO - 'NO_EM_RESTART': '1', 03:31:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:04 INFO - 'PWD': '/builds/slave/test', 03:31:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:31:04 INFO - 'RUST_BACKTRACE': 'full', 03:31:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:31:04 INFO - 'SHELL': '/bin/bash', 03:31:04 INFO - 'SHLVL': '1', 03:31:04 INFO - 'TERM': 'linux', 03:31:04 INFO - 'TMOUT': '86400', 03:31:04 INFO - 'USER': 'cltbld', 03:31:04 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860', 03:31:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:04 INFO - '_': '/tools/buildbot/bin/python'} 03:31:04 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/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:31:04 INFO - mozversion application_buildid: 20170919091230 03:31:04 INFO - mozversion application_changeset: e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5 03:31:04 INFO - mozversion application_display_name: Nightly 03:31:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:31:04 INFO - mozversion application_name: Firefox 03:31:04 INFO - mozversion application_remotingname: firefox 03:31:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:31:04 INFO - mozversion application_vendor: Mozilla 03:31:04 INFO - mozversion application_version: 57.0a1 03:31:04 INFO - mozversion platform_buildid: 20170919091230 03:31:04 INFO - mozversion platform_changeset: e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5 03:31:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:31:04 INFO - mozversion platform_version: 57.0a1 03:31:04 INFO - using testdate: 1505817064 03:31:04 INFO - actual date: 1505817064 03:31:04 INFO - starting webserver on 'localhost:48871' 03:31:04 INFO - SUITE-START | Running 2 tests 03:31:04 INFO - TEST-START | dromaeo_css 03:31:04 INFO - Initialising browser for dromaeo_css test... 03:31:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48871/getInfo.html -profile /tmp/tmpiipPmA/profile 03:31:04 INFO - TEST-INFO | started process 3545 (/builds/slave/test/build/application/firefox/firefox http://localhost:48871/getInfo.html) 03:31:12 INFO - TEST-INFO | 3545: exit 0 03:31:13 INFO - Browser initialized. 03:31:13 INFO - Running cycle 1/1 for dromaeo_css test... 03:31:13 INFO - Using env: {'DISPLAY': ':0', 03:31:13 INFO - 'HOME': '/home/cltbld', 03:31:13 INFO - 'JSGC_DISABLE_POISONING': '1', 03:31:13 INFO - 'LANG': 'en_US.UTF-8', 03:31:13 INFO - 'LANGUAGE': 'en_US:en', 03:31:13 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:31:13 INFO - 'LOGNAME': 'cltbld', 03:31:13 INFO - 'MAIL': '/var/mail/cltbld', 03:31:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:31:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:31:13 INFO - 'MOZ_CRASHREPORTER': '1', 03:31:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:13 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:31:13 INFO - 'MOZ_NO_REMOTE': '1', 03:31:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:31:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:13 INFO - 'NO_EM_RESTART': '1', 03:31:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:13 INFO - 'PWD': '/builds/slave/test', 03:31:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:31:13 INFO - 'RUST_BACKTRACE': 'full', 03:31:13 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:31:13 INFO - 'SHELL': '/bin/bash', 03:31:13 INFO - 'SHLVL': '1', 03:31:13 INFO - 'TERM': 'linux', 03:31:13 INFO - 'TMOUT': '86400', 03:31:13 INFO - 'USER': 'cltbld', 03:31:13 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860', 03:31:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:13 INFO - '_': '/tools/buildbot/bin/python'} 03:31:13 INFO - TEST-INFO | started process 3788 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiipPmA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:31:13 INFO - PID 3788 | 03:31:13 INFO - PID 3788 | (/builds/slave/test/build/application/firefox/firefox:3837): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:31:13 INFO - PID 3788 | 03:31:24 INFO - PID 3788 | RSS: Main: 146898944 03:31:24 INFO - PID 3788 | 03:34:21 INFO - PID 3788 | Cycle 1(1): loaded http://localhost:48871/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48871/tests/dromaeo/cssquery-ext.html) 03:34:23 INFO - PID 3788 | RSS: Main: 148295680 03:34:23 INFO - PID 3788 | 03:37:25 INFO - PID 3788 | Cycle 1(1): loaded http://localhost:48871/tests/dromaeo/cssquery-ext.html (next: http://localhost:48871/tests/dromaeo/cssquery-jquery.html) 03:37:25 INFO - PID 3788 | RSS: Main: 148234240 03:37:25 INFO - PID 3788 | 03:40:27 INFO - PID 3788 | Cycle 1(1): loaded http://localhost:48871/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48871/tests/dromaeo/cssquery-mootools.html) 03:40:27 INFO - PID 3788 | RSS: Main: 150106112 03:40:27 INFO - PID 3788 | 03:43:29 INFO - PID 3788 | Cycle 1(1): loaded http://localhost:48871/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48871/tests/dromaeo/cssquery-prototype.html) 03:43:29 INFO - PID 3788 | RSS: Main: 148439040 03:43:29 INFO - PID 3788 | 03:46:33 INFO - PID 3788 | Cycle 1(1): loaded http://localhost:48871/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48871/tests/dromaeo/cssquery-yui.html) 03:46:33 INFO - PID 3788 | RSS: Main: 147845120 03:46:33 INFO - PID 3788 | 03:49:35 INFO - PID 3788 | Cycle 1(1): loaded http://localhost:48871/tests/dromaeo/cssquery-yui.html (next: http://localhost:48871/tests/dromaeo/cssquery-dojo.html) 03:49:35 INFO - PID 3788 | RSS: Main: 153047040 03:49:35 INFO - PID 3788 | 03:49:35 INFO - PID 3788 | __start_tp_report 03:49:35 INFO - PID 3788 | _x_x_mozilla_page_load 03:49:35 INFO - PID 3788 | _x_x_mozilla_page_load_details 03:49:35 INFO - PID 3788 | |i|pagename|runs| 03:49:35 INFO - PID 3788 | |0;dojo.html;3913.295606790778;3919.8628048018327;3927.84288628455;3935.5080614923136;3976;6224.502039836813;6271.843203919899;6308.085327627491;6308.243010838706;6416.294207637156;6320.304766475684;6327.746890124389;6354.14219080424;6366.936330636692;6477.222733272002;5577.69322687252;5664.376918538957;5675.574331925101;5729.713514324288;5742.655440673552;1089.9040832392238;5645.943540564583;5742.425757424245;5759.798407055754;5816.9418305817035;5306.63353458484;5610.775568977236;5651.4913657770585;5684.999999999959;5750.568707346944;5651.9152212716845;5664;5689.089745640677;5699.116636921284;5703.5437165027115;5674.177244299594;5691.203231547586;5711.742971566289;5756.65460072397;5767.394423585547;6302.4958003359625;6352.618842869442;6354.17395738551;6364.618122912594;6396.2964073951825;6896.827579310508;6899.344562266577;6971.58170509771;6995.160580730294;7012.614306213156;6772.119624448839;6820.31796820314;6879.931200687979;6941.34057264559;6997.265287144827;6428.228612566522;6452.7418903243815;6455.870882582369;6475.999999999953;6515.902261466082;7115;7117.572945623279;7191.424686025105;7211.314925082109;7211.387032102225;6827;6834.077399551096;6887.965560172267;6898;6905.482088843357;6809.38715515606;6855.451563874878;6890.655467226618;6939.583624982517;6963.965180174168;6833.077534532775;6843.3840954314355;6870.5534140281725;6916.896246556305;6921.515493915478;6804.523683342119;6818.079559259437;6826.317368263134;6905.37851593359;6943.409810166091;4827.179379505493;4937.259411088366;4944.975275123673;4988.925166122511;4989.126902791997;4430.269005614102;4527.958569529027;4544.500104988449;4570.382998295254;4580.358749775034;6203.720832562545;6209.441150296495;6290.276618188876;6297.811065668037;6301.464375528039;6748.122744043243;6771.255161932184;6800.217974932847;6813.3527314906;6844.28135045823;6254.6872656366995;6257.78097766576;6288.937110628835;6312;6346.619202847752;5546.55627549795;5590.440955904377;5605.971970140124;5615.354234263112;5621.7189140542805;7087.1849737279845;7128.5722856627735;7144.9642751785905;7152.213256541776;7244.49288549807;6816.216135144423;6836.487263455161;6839.965800170968;6847.828804279933;6856.622885741132;7073.469489788184;7121.67952442131;7138.214796372498;7142.464315176278;7146.106736657918;6887.724491020504;6959.826004349932;6970.337817907291;6982.581045137308;6983.895241571482;6960.199577048502;6965.512414131165;6965.721371145098;7078.858422831411;7081.681324340314;6575.868482630416;6625.900611490928;6630;6638.634875081723;6641.701123449359;6631.3700198481065;6699.330066993261;6703.128593282842;6705.396514313735;6738.124043874265;6588.901166482411;6657.7669781557415;6677.165354330708;6685.298043705341;6685.832854178684;6724.159480064992;6753.662316884234;6769.323067693192;6816.965915170393;6829.180498340231;6463.773767918288;6504.349565043458;6506.512011599054;6515.055316978916;6531.052997315458 03:49:35 INFO - PID 3788 | |1;ext.html;956.3974695941556;963.3256720295794;986.7631768375587;993.7863359377733;1005.7787286796902;45496.77251613741;45904;46010.76994615031;46111.76944115275;46150.53849461509;42926;42974.78512607433;43103;43208;43294.99999999992;7681.270279323469;7796.4932279401655;7800;7807.648655810473;7831.608419579026;7688.654010569509;7748.2251774822635;7787.844243115134;7789;7793.220677932218;8182.877256841152;8435.95782021092;8444.197801208875;8449.281811046068;8483.830323393528;8311.127331630152;8395.328373730148;8397.53813540255;8401.95799021004;8402.369822263325;8076.3942704297415;8228.341732661373;8290.751277461686;8294.751157465285;8332.083470818205;40807;41076.38385424221;41138.588614113774;41162.76511704654;41188.58811411908;3677.1358730698266;3747.8126093695205;3756.549214094299;3757.9624203757885;3758.361078616642;32872.67127328744;33046.17384565381;33149;33212.667873321196;33255.50116748251;5496.038193316193;5521.585881058937;5569.359523654791;5571.331440227158;5594.636348637367;213183;213775;215362;215609.99999999843;215648;46437.76781116073;47355.526444735115;53625.463745362824;54353.72823135859;54370.91258174814;56451.71774141103;56919.71540142356;56939.715301423224;57020;57020;16455.42406015784;16500.25748841305;16619.6676066478;16645.16774161287;16687.08221047854;13369.131006484547;13478.86521134776;13521.256330901895;13545.119567228296;13563.05058645905;15017.774733379008;15047.623809404853;15168;15169.544913652608;15315.693686126215;6073.362296958844;6093.939060609426;6094.939050609526;6147.66187859672;6320.810375688737;1100.5432745410565;1114.5207560748956;1115.3475216998147;1118.2954738514684;1122.4780477078198;25000.624990625154;25186.496270074495;25279.241622751346;25525.077356256374;25683.10109146171;1205.9638210853689;1207.251504067484;1211.3216598704753;1215.9513619455122;1232.0944106082022;13508.98682598809;13581.592552223448;13618.86381136176;13646.454141834216;13732.931335343259;286864;286939;286942;287727;287831;57883.131753023736;58037.4196258032;58319;58356;58472;1508.1705062215956;1514.8182218133895;1532.96167595811;1550.9457168999031;1553.2156261088078;24815.87592062028;25006.74993250117;25061.624075638516;25072.74927250704;25375.873120634278;40481.39277910775;40525;40532.79733601313;40549.594504054585;40626.79686601548;234532;234731;235928;236038;237119;35817.283654327286;36391.27217455583;38116.42825357677;38209;38289.617103828605;48997.75501122472;50898;51178.74410627923;51299.74350128225;51397.48602513927;34932.82533587316;35262.82368588243;35534.822325888206;35982.4602630966;36328.27343453169;36450.453243201904;36779;36871;37097.258054839294;37121.25757484889;41684.166316674105;42692;42729;42969;43056.56943430525;34864.825675871456;35059;35110.29779404448;35173.12067198341;35412;26045.6093158599;26840;26855.731442686105;26971.460570788866;27540.036098736447 03:49:35 INFO - PID 3788 | |2;jquery.html;591.9970400147998;600.6816387314722;605.207178596039;616.223558316521;623.9937600623994;23655.526889462202;24408;24504.509909801793;24595.877020614873;24602.507949841016;23217.303480895556;26347.604785928226;26515.602265966027;26551.336216594595;26654;6420.935790642092;6602.636854972975;6619.073329733841;6640.800775976729;6645.269020407752;6334.461570766491;6371.745130194787;6459.386358295955;6460.967695161517;6461.676916154197;6517.413432791048;6551.967240163816;6553.279139294697;6555.77054803082;6560.2455717592375;6316.30520642729;6504.447121994636;6543.280239173735;6559.639219842907;6560.573562718432;6164.352742961969;6176.69116544171;6203.96898015507;6205.906911396332;6210.441060304549;30050.54924176139;30255;30409.087727368213;30487.542686859713;30577.847110764527;2341.0518739910362;2371.6205407134776;2374.03851440167;2375.3349062262596;2380.4643955110137;20095.698564521543;20657.5868482631;21383.35849924505;21416.785832141635;21473.67789483159;2509.9372515687255;2512.108201588428;2562.2185233503774;2648.0996461203285;2649.3906401527756;140580;147019;157000.21499892542;164952;165105;15274.31265593051;16022.19889005545;16347;16640.916795415946;16890.226526214818;25654.588997604937;25901.481970360488;25944.48111037769;25948.61077083845;25956.35109122287;10733.516991735234;10821.188410869216;10856.34861908288;10925.962033606795;11002.33985960845;9997.45014024221;10011.549480273405;10072.848907266396;10115.949420252999;10226.846597301046;9702.854457183148;9779.755506112404;9783.726059662597;9846;9952;2680.32991752062;2700.5409080455975;2769.667639883227;2834.9433011339656;2842.990738287919;1031.4739482863642;1044.8589440425446;1053.6680945502142;1055.3931489393628;1062.8352605346183;20632.793672063086;20864;20866.06102725381;21442.678359824615;21554;1104.320842681745;1104.928179668319;1109.8113320735495;1123.8314252862135;1125.234840308598;11403.657890263305;11564.826527601925;11641;11806.46870890812;11820.70448238801;627246;631281;656037;658015;658124;128797.35601322122;129743;131619;132678;135724.3213783925;1152.4525850221078;1215.2708374974945;1228.4471987605614;1237.418413345726;1247.4698253242518;18790.6241875159;18841.15214815309;18906.43280701581;19097.61804763869;19183.232670693014;63355;63409.682951584946;63630.68184659047;64074.3592564087;64311.678441607495;82181;83011;83061;83334;83654.58172709098;15010.324535396152;15386.307616157075;15407.922960385127;15447.845521544641;15468.690626187637;23045.53908921846;23263.76736232684;23333.18333858307;23359.065637374995;23450.296491105295;17923.641527169122;18920.33778817735;19084.427467176007;19217.90391048036;19252.8074719251;16158.192090395198;16630.008797888662;17144.485665430057;17430.47708568745;17567;19010.714839277145;19424.125914333606;19521.804781952;19544.90227548853;19609.607807844048;14946.551603451913;14972.625684357978;15106;15126.546203613469;15171.92414037967;18846.43460696181;18855.811441885406;19022.144003520152;19055.333063342718;19109.713354299976 03:49:35 INFO - PID 3788 | |3;mootools.html;1397.468961794518;1513.2811914340682;1513.296317212496;1515.9772603410947;1528.4573976238435;16392;17026.06356650384;17055.573610659707;17105.828941710595;17125;16549.586260343498;16554.172291385443;16698.833011669878;16709.749353759675;16742;2503.4993001399703;2522.697276326843;2576.896924123033;2578.316746062295;2579.3938424470234;2785.6100145979476;2876.0796545105572;2888.378998515319;2915.7230063143966;2919.927001824961;2818.9295267618268;2835.4754370441533;2836.276749428893;2837.248129245741;2843.147055883237;2786;2843.843588602626;2850.9002184923534;2853.058490698065;2854.1722900358973;2760.903368382117;2784.0951690700604;2784.693683694792;2788.177487641151;2802.9719702802913;16024.679506409806;16188.433404830892;16330;16385.262663180067;16455.588610284718;8364.790880228044;8638.352123590756;8640.913590864075;8656.913430865674;8658.523781192032;5718.142278658193;5868.061110222387;5871.324797648283;6045.697715114226;6059.878802423971;2105.2947262667026;2127.276725913197;2129;2171.1315473810446;2192.6930229767845;29586.704132958825;29980.70019299801;30020.99999999978;30026.69973300261;30082.398352033055;7002.264762199998;7111.111111111111;7149.53528020677;7309.853802923912;7454.925450745532;18962;19058.42824715261;19219.51951201231;19220.90389548071;19231.13459894308;8302.294304984023;8495.575221238912;8503.872441913376;8525.531095789791;8539.103394143649;7695.846083078419;7737.690492380354;7812.414068944852;7886.802829929297;7946.046474423106;5583.916241256303;5752.252207213036;5757.6833274169485;5812.796552120655;5816.41835816415;1542.2365928865283;1646.9258883350278;1656.7100757367411;1672.3979367427717;1680.487451327357;811.922867327603;955.7085089047769;980.2207245240052;996.6113215845826;1011.8785745710562;8347.95650543682;8453;8489.151084891462;8715.869261961076;8991.235744961621;1034.3225187502048;1037.6938803053117;1039.428314427062;1046.7958748044211;1072.5441687282873;5162.586993040548;5223.13818219997;5310.973445132827;5425.972870135624;5436.320459942507;24206.63690044651;24634.630480542804;24915.750842491707;24988.500229995298;25243.24270271858;24546.263612091665;24582.87708561446;24624.753752462606;24636.13773517918;24724.629130563055;11206.719832004102;11923.403829808474;12087.516499340103;12092.758144837055;12118.212316199242;9591.28065395112;9648.2211466492;9849.704508864745;9888.703338899844;9915.504224788876;20754.792452075286;20814.479638009172;21595;21704.782952170906;21779.673304900123;21649.35051948444;21766;21771.238006670323;21932;22113.66829497591;11812.881871181178;12069.215500992408;12098.879011210127;12106.878931210927;12109.152359334763;15330.770038449655;15507.84492155064;15555.766663500282;15622.609434764221;15700.764488532453;11800.3509806958;12262.20295680778;12382.752344953231;12470.812937806122;12572.622821315375;11970.20446932967;12267.386630668609;12293.323867187391;12471;12688.111832171659;10308;10534.841977370499;10537.789244214919;10540.472976350999;10552.577896884039;7859.09620393662;7992.16082311349;8058.637361318872;8060.919390806017;8130.308923741311;8317.875231871647;8463.830723385621;8529.445586036887;8546.444481108956;8563.272121869712 03:49:35 INFO - PID 3788 | |4;prototype.html;529.5551736541305;565.7227958300434;569.7464628240432;569.9430056994302;575.8934597099534;6284.811455656332;6345.52408569358;6367.426931576158;6394.168758061452;6410.519211059166;6278.1838361013115;6290.528210384216;6299.244090709121;6334.429901308881;6373.426391624753;5136.845894623168;5147.948520514784;5170.819021334254;5188.195829646411;5188.533032027136;4859.902801943959;4961.156603377416;5145.922811157836;5158.27784110223;5171.637985341028;4893.437254715717;4895.657303988723;4924.507549245065;4935.111679897617;4983.950160498385;4918.704877707331;4942.604591632661;4952.167697951763;4960.33035540201;5007.649464537484;4491.6855820092605;4498.392716983198;4505.3917721107555;4529.592336689714;4546.749928753918;6145.8156255312415;6188.8762224755255;6217.751289948396;6222.848772977014;6228.283747369065;5770.769169233267;5825.097109947965;5865.736041878125;5918.674472903988;5933.584649074566;6592.670366481657;6593.835154121138;6599.769008084694;6664.566803157779;6666;4997.175466048097;5003.574696150831;5006.07387633289;5055.368078990126;5057.393112826448;6736.393724564764;6775.966120169417;6898.793036208922;6942.72229110835;6977.162740471176;5119.948800511947;5129.8717532062;5187.844364669066;5196.896062078813;5217.191335343028;5251.52736253739;5255.947440525622;5278.868028299324;5307.495787900143;5321.574274058066;5864.8533786654825;5877.823665290048;5882.088276317178;5888.175655408247;5901.468867801918;6659.600423974577;6667.799966001027;6678.131842860397;6718.865622687519;6720.529562930646;1760.7358896165422;1776.3782676063274;1777.5111844242936;1802.1439816087254;1809.8461630761533;1253.0476837603487;1293.6571808470762;1295.7084655952524;1306.2162702378687;1306.9803952940713;6127.662978536134;6168.228971378578;6213.65824879636;6254.15568898202;6259.186305780219;6483.448906842971;6626.204855417284;6748.527603067836;6771.187457505131;6841.863162736718;6064.514838812885;6178.938210617836;6203.379662033851;6243.43809057187;6277.937220627827;3521.8591256349973;3560.2701446203464;3560.4303311470558;3563.483294922222;3576.4277715565386;7092.6099064551945;7126.441375726941;7137.823668467482;7156.141263048364;7161.534500257467;6859.759908403182;6945.583265004116;6965.721371145098;6966.909927021873;6972.477064220204;6951.6871740770775;6952.652367381712;7021.543599666005;7096.9483122257925;7103.9289607103265;6700.2964688708935;6702.865942681216;6755.966220168868;6769.646070785764;6802.761903333359;6633.568818026813;6637.701303441453;6675.265720770614;6755.256921738703;6770.6614669265355;7009.929900701131;7040.3598650506065;7046.506744528039;7079.929200707927;7125.394341480825;5096.821611243588;5169.172932330809;5172.896542069213;5187.766550505312;5192.688438693691;6794.93205067943;6853.417459515997;6881.346272104142;6892.069570607904;6935.306469353024;6541.738330466728;6571.605703657605;6610.768623098168;6620.801375958729;6640.90038649411;6525.3800888915475;6537.182852143482;6553.442957348679;6554.541182117206;6606.669666516751;6365.4589359903075;6455.9677201613695;6505.2518960318275;6508.72793037641;6509.251436084911;6559.836004099936;6587.63767992765;6619.470442364503;6639.4688424924925;6649.534532582867;6043.335233124265;6381.361863813581;6404.743810247538;6405.8718825624155;6464.806055818333 03:49:35 INFO - PID 3788 | |5;yui.html;949.0936155971044;973.23600973236;973.6105557776892;977.9755506112351;996.1084829077976;21010.684839727397;21716.131354745812;22985.4253643659;22989.195378161767;23083;20079;20882.164713411446;20959.21846643037;21016.264430744926;21128.683069753966;1089.1667874076338;1089.3518356577824;1096.797092537879;1099.1756182862853;1102.2835157147838;1088.0751361342875;1091.6397588795678;1092.1699508373613;1096.4956120184725;1099.3239157917862;1145.6104924325728;1156.02316042944;1156.2022204678744;1156.2715489241807;1158.7856246594406;1146.5241924601323;1153.4463457540344;1156.4853640130145;1156.6183159557327;1157.6816375496765;848.9235968762841;849.8300339932039;850.2390360627265;851.3572252949045;852.9232369086812;18718.532036699056;19405.32081377145;19529.316473923343;19609.509762255915;19682.901585492124;22763.886180569156;22807.543849122925;23253.76746232533;23300.7669923302;23449.17927872516;18683.53291167718;18796.24815007398;18834.152463139053;18854.62290754191;18947.147378368005;3944.960550394488;3967.662748666367;3968.305546529346;3974.4833171687783;3981.28336899358;147220;148465.99999999892;148867;149361;150468;16162.595935101717;16431.507054788377;16647.3341066356;16700.916495417445;16725.581860453585;34483;34643.30713385718;34680.826595866856;34928.476072858924;34962;8431.241188292961;8769.780755481164;9056.683016094405;9397.671081512115;9572.473513956798;4386.18855511725;4489.775511224426;4496.662750293741;4513.255312873339;4531.161735079021;5980.342162362137;6039.7282122304605;6077;6096.664683442454;6137.202163718688;1115.9609413670482;1142.662914440242;1150.1086657840074;1150.327058670687;1151;680.3808534233823;694.861027794433;696.8989496522976;709.5458906299972;715.6350261366637;12656.303903285223;13058.608241752763;13184.934075329562;13787.86212137886;14082.71834563303;676.4385559985201;680.2075581946976;680.5134328954722;690.1304356510833;700.9614471204133;5916.26046744157;5924.20023296858;6039.818805435844;6060.636361818305;6062.42406971337;143182;143709;143866;144376;144839.27580362032;129508;131426;131995;134184;134512;111469;112746;114886;118208.40895795466;118495.81504185192;11322.830157547809;11326.943365283121;11534.423278835857;11597.420128993348;11698.76602467963;48846.26730598973;48925.26612100893;49496;49707.502924970286;49962.25056624081;63657.0451443238;63847.36152638414;64324;64515.35484645094;64805;15365.231738412811;15458.84541154574;15556;15578.221088945735;15839.841601583837;19773.307934222234;21573.892130539247;21621.567568648225;21851.235206767687;22040.228591999203;17817.376391826223;17909.10454477245;17987.10064496744;18014.459566213034;18019.459416217534;16592.170391480136;16846.66306673884;16906;16916;16931.407400740914;17514.912425438302;17875.106244687453;17898.28406863763;17934.91032544829;18087.276508939496;14146.363413646617;14321.57035288943;14377.424903003763;14560;14709.852901470847;14085.929570352082;14095.95311665414;14127.576172714835;14198;14275.500357487437 03:49:35 INFO - PID 3788 | __end_tp_report 03:49:35 INFO - PID 3788 | __start_cc_report 03:49:35 INFO - PID 3788 | _x_x_mozilla_cycle_collect,285 03:49:35 INFO - PID 3788 | __end_cc_report 03:49:35 INFO - PID 3788 | __startTimestamp1505818175541__endTimestamp 03:49:35 INFO - PID 3788 | 03:49:35 INFO - PID 3788 | ------- Summary: start ------- 03:49:35 INFO - PID 3788 | Number of tests: 6 03:49:35 INFO - PID 3788 | 03:49:35 INFO - PID 3788 | [#0] dojo.html Cycles:165 Average:6308.52 Median:6625.90 stddev:870.48 (13.1%) stddev-sans-first:852.63 03:49:35 INFO - PID 3788 | Values: 3913.3 3919.9 3927.8 3935.5 3976.0 6224.5 6271.8 6308.1 6308.2 6416.3 6320.3 6327.7 6354.1 6366.9 6477.2 5577.7 5664.4 5675.6 5729.7 5742.7 1089.9 5645.9 5742.4 5759.8 5816.9 5306.6 5610.8 5651.5 5685.0 5750.6 5651.9 5664.0 5689.1 5699.1 5703.5 5674.2 5691.2 5711.7 5756.7 5767.4 6302.5 6352.6 6354.2 6364.6 6396.3 6896.8 6899.3 6971.6 6995.2 7012.6 6772.1 6820.3 6879.9 6941.3 6997.3 6428.2 6452.7 6455.9 6476.0 6515.9 7115.0 7117.6 7191.4 7211.3 7211.4 6827.0 6834.1 6888.0 6898.0 6905.5 6809.4 6855.5 6890.7 6939.6 6964.0 6833.1 6843.4 6870.6 6916.9 6921.5 6804.5 6818.1 6826.3 6905.4 6943.4 4827.2 4937.3 4945.0 4988.9 4989.1 4430.3 4528.0 4544.5 4570.4 4580.4 6203.7 6209.4 6290.3 6297.8 6301.5 6748.1 6771.3 6800.2 6813.4 6844.3 6254.7 6257.8 6288.9 6312.0 6346.6 5546.6 5590.4 5606.0 5615.4 5621.7 7087.2 7128.6 7145.0 7152.2 7244.5 6816.2 6836.5 6840.0 6847.8 6856.6 7073.5 7121.7 7138.2 7142.5 7146.1 6887.7 6959.8 6970.3 6982.6 6983.9 6960.2 6965.5 6965.7 7078.9 7081.7 6575.9 6625.9 6630.0 6638.6 6641.7 6631.4 6699.3 6703.1 6705.4 6738.1 6588.9 6657.8 6677.2 6685.3 6685.8 6724.2 6753.7 6769.3 6817.0 6829.2 6463.8 6504.3 6506.5 6515.1 6531.1 03:49:35 INFO - PID 3788 | 03:49:35 INFO - PID 3788 | [#1] ext.html Cycles:180 Average:42861.09 Median:3757.26 stddev:64430.86 (1714.8%) stddev-sans-first:64534.77 03:49:35 INFO - PID 3788 | Values: 956.4 963.3 986.8 993.8 1005.8 45496.8 45904.0 46010.8 46111.8 46150.5 42926.0 42974.8 43103.0 43208.0 43295.0 7681.3 7796.5 7800.0 7807.6 7831.6 7688.7 7748.2 7787.8 7789.0 7793.2 8182.9 8436.0 8444.2 8449.3 8483.8 8311.1 8395.3 8397.5 8402.0 8402.4 8076.4 8228.3 8290.8 8294.8 8332.1 40807.0 41076.4 41138.6 41162.8 41188.6 3677.1 3747.8 3756.5 3758.0 3758.4 32872.7 33046.2 33149.0 33212.7 33255.5 5496.0 5521.6 5569.4 5571.3 5594.6 213183.0 213775.0 215362.0 215610.0 215648.0 46437.8 47355.5 53625.5 54353.7 54370.9 56451.7 56919.7 56939.7 57020.0 57020.0 16455.4 16500.3 16619.7 16645.2 16687.1 13369.1 13478.9 13521.3 13545.1 13563.1 15017.8 15047.6 15168.0 15169.5 15315.7 6073.4 6093.9 6094.9 6147.7 6320.8 1100.5 1114.5 1115.3 1118.3 1122.5 25000.6 25186.5 25279.2 25525.1 25683.1 1206.0 1207.3 1211.3 1216.0 1232.1 13509.0 13581.6 13618.9 13646.5 13732.9 286864.0 286939.0 286942.0 287727.0 287831.0 57883.1 58037.4 58319.0 58356.0 58472.0 1508.2 1514.8 1533.0 1550.9 1553.2 24815.9 25006.7 25061.6 25072.7 25375.9 40481.4 40525.0 40532.8 40549.6 40626.8 234532.0 234731.0 235928.0 236038.0 237119.0 35817.3 36391.3 38116.4 38209.0 38289.6 48997.8 50898.0 51178.7 51299.7 51397.5 34932.8 35262.8 35534.8 35982.5 36328.3 36450.5 36779.0 36871.0 37097.3 37121.3 41684.2 42692.0 42729.0 42969.0 43056.6 34864.8 35059.0 35110.3 35173.1 35412.0 26045.6 26840.0 26855.7 26971.5 27540.0 03:49:35 INFO - PID 3788 | 03:49:35 INFO - PID 3788 | [#2] jquery.html Cycles:180 Average:41045.24 Median:23240.54 stddev:107912.04 (464.3%) stddev-sans-first:108172.02 03:49:35 INFO - PID 3788 | Values: 592.0 600.7 605.2 616.2 624.0 23655.5 24408.0 24504.5 24595.9 24602.5 23217.3 26347.6 26515.6 26551.3 26654.0 6420.9 6602.6 6619.1 6640.8 6645.3 6334.5 6371.7 6459.4 6461.0 6461.7 6517.4 6552.0 6553.3 6555.8 6560.2 6316.3 6504.4 6543.3 6559.6 6560.6 6164.4 6176.7 6204.0 6205.9 6210.4 30050.5 30255.0 30409.1 30487.5 30577.8 2341.1 2371.6 2374.0 2375.3 2380.5 20095.7 20657.6 21383.4 21416.8 21473.7 2509.9 2512.1 2562.2 2648.1 2649.4 140580.0 147019.0 157000.2 164952.0 165105.0 15274.3 16022.2 16347.0 16640.9 16890.2 25654.6 25901.5 25944.5 25948.6 25956.4 10733.5 10821.2 10856.3 10926.0 11002.3 9997.5 10011.5 10072.8 10115.9 10226.8 9702.9 9779.8 9783.7 9846.0 9952.0 2680.3 2700.5 2769.7 2834.9 2843.0 1031.5 1044.9 1053.7 1055.4 1062.8 20632.8 20864.0 20866.1 21442.7 21554.0 1104.3 1104.9 1109.8 1123.8 1125.2 11403.7 11564.8 11641.0 11806.5 11820.7 627246.0 631281.0 656037.0 658015.0 658124.0 128797.4 129743.0 131619.0 132678.0 135724.3 1152.5 1215.3 1228.4 1237.4 1247.5 18790.6 18841.2 18906.4 19097.6 19183.2 63355.0 63409.7 63630.7 64074.4 64311.7 82181.0 83011.0 83061.0 83334.0 83654.6 15010.3 15386.3 15407.9 15447.8 15468.7 23045.5 23263.8 23333.2 23359.1 23450.3 17923.6 18920.3 19084.4 19217.9 19252.8 16158.2 16630.0 17144.5 17430.5 17567.0 19010.7 19424.1 19521.8 19544.9 19609.6 14946.6 14972.6 15106.0 15126.5 15171.9 18846.4 18855.8 19022.1 19055.3 19109.7 03:49:35 INFO - PID 3788 | 03:49:35 INFO - PID 3788 | [#3] mootools.html Cycles:180 Average:10312.27 Median:2513.10 stddev:7604.32 (302.6%) stddev-sans-first:7596.15 03:49:35 INFO - PID 3788 | Values: 1397.5 1513.3 1513.3 1516.0 1528.5 16392.0 17026.1 17055.6 17105.8 17125.0 16549.6 16554.2 16698.8 16709.7 16742.0 2503.5 2522.7 2576.9 2578.3 2579.4 2785.6 2876.1 2888.4 2915.7 2919.9 2818.9 2835.5 2836.3 2837.2 2843.1 2786.0 2843.8 2850.9 2853.1 2854.2 2760.9 2784.1 2784.7 2788.2 2803.0 16024.7 16188.4 16330.0 16385.3 16455.6 8364.8 8638.4 8640.9 8656.9 8658.5 5718.1 5868.1 5871.3 6045.7 6059.9 2105.3 2127.3 2129.0 2171.1 2192.7 29586.7 29980.7 30021.0 30026.7 30082.4 7002.3 7111.1 7149.5 7309.9 7454.9 18962.0 19058.4 19219.5 19220.9 19231.1 8302.3 8495.6 8503.9 8525.5 8539.1 7695.8 7737.7 7812.4 7886.8 7946.0 5583.9 5752.3 5757.7 5812.8 5816.4 1542.2 1646.9 1656.7 1672.4 1680.5 811.9 955.7 980.2 996.6 1011.9 8348.0 8453.0 8489.2 8715.9 8991.2 1034.3 1037.7 1039.4 1046.8 1072.5 5162.6 5223.1 5311.0 5426.0 5436.3 24206.6 24634.6 24915.8 24988.5 25243.2 24546.3 24582.9 24624.8 24636.1 24724.6 11206.7 11923.4 12087.5 12092.8 12118.2 9591.3 9648.2 9849.7 9888.7 9915.5 20754.8 20814.5 21595.0 21704.8 21779.7 21649.4 21766.0 21771.2 21932.0 22113.7 11812.9 12069.2 12098.9 12106.9 12109.2 15330.8 15507.8 15555.8 15622.6 15700.8 11800.4 12262.2 12382.8 12470.8 12572.6 11970.2 12267.4 12293.3 12471.0 12688.1 10308.0 10534.8 10537.8 10540.5 10552.6 7859.1 7992.2 8058.6 8060.9 8130.3 8317.9 8463.8 8529.4 8546.4 8563.3 03:49:35 INFO - PID 3788 | 03:49:35 INFO - PID 3788 | [#4] prototype.html Cycles:180 Average:5650.00 Median:6278.06 stddev:1586.10 (25.3%) stddev-sans-first:1543.28 03:49:35 INFO - PID 3788 | Values: 529.6 565.7 569.7 569.9 575.9 6284.8 6345.5 6367.4 6394.2 6410.5 6278.2 6290.5 6299.2 6334.4 6373.4 5136.8 5147.9 5170.8 5188.2 5188.5 4859.9 4961.2 5145.9 5158.3 5171.6 4893.4 4895.7 4924.5 4935.1 4984.0 4918.7 4942.6 4952.2 4960.3 5007.6 4491.7 4498.4 4505.4 4529.6 4546.7 6145.8 6188.9 6217.8 6222.8 6228.3 5770.8 5825.1 5865.7 5918.7 5933.6 6592.7 6593.8 6599.8 6664.6 6666.0 4997.2 5003.6 5006.1 5055.4 5057.4 6736.4 6776.0 6898.8 6942.7 6977.2 5119.9 5129.9 5187.8 5196.9 5217.2 5251.5 5255.9 5278.9 5307.5 5321.6 5864.9 5877.8 5882.1 5888.2 5901.5 6659.6 6667.8 6678.1 6718.9 6720.5 1760.7 1776.4 1777.5 1802.1 1809.8 1253.0 1293.7 1295.7 1306.2 1307.0 6127.7 6168.2 6213.7 6254.2 6259.2 6483.4 6626.2 6748.5 6771.2 6841.9 6064.5 6178.9 6203.4 6243.4 6277.9 3521.9 3560.3 3560.4 3563.5 3576.4 7092.6 7126.4 7137.8 7156.1 7161.5 6859.8 6945.6 6965.7 6966.9 6972.5 6951.7 6952.7 7021.5 7096.9 7103.9 6700.3 6702.9 6756.0 6769.6 6802.8 6633.6 6637.7 6675.3 6755.3 6770.7 7009.9 7040.4 7046.5 7079.9 7125.4 5096.8 5169.2 5172.9 5187.8 5192.7 6794.9 6853.4 6881.3 6892.1 6935.3 6541.7 6571.6 6610.8 6620.8 6640.9 6525.4 6537.2 6553.4 6554.5 6606.7 6365.5 6456.0 6505.3 6508.7 6509.3 6559.8 6587.6 6619.5 6639.5 6649.5 6043.3 6381.4 6404.7 6405.9 6464.8 03:49:35 INFO - PID 3788 | 03:49:35 INFO - PID 3788 | [#5] yui.html Cycles:180 Average:27532.46 Median:18701.03 stddev:40658.43 (217.4%) stddev-sans-first:40723.49 03:49:35 INFO - PID 3788 | Values: 949.1 973.2 973.6 978.0 996.1 21010.7 21716.1 22985.4 22989.2 23083.0 20079.0 20882.2 20959.2 21016.3 21128.7 1089.2 1089.4 1096.8 1099.2 1102.3 1088.1 1091.6 1092.2 1096.5 1099.3 1145.6 1156.0 1156.2 1156.3 1158.8 1146.5 1153.4 1156.5 1156.6 1157.7 848.9 849.8 850.2 851.4 852.9 18718.5 19405.3 19529.3 19609.5 19682.9 22763.9 22807.5 23253.8 23300.8 23449.2 18683.5 18796.2 18834.2 18854.6 18947.1 3945.0 3967.7 3968.3 3974.5 3981.3 147220.0 148466.0 148867.0 149361.0 150468.0 16162.6 16431.5 16647.3 16700.9 16725.6 34483.0 34643.3 34680.8 34928.5 34962.0 8431.2 8769.8 9056.7 9397.7 9572.5 4386.2 4489.8 4496.7 4513.3 4531.2 5980.3 6039.7 6077.0 6096.7 6137.2 1116.0 1142.7 1150.1 1150.3 1151.0 680.4 694.9 696.9 709.5 715.6 12656.3 13058.6 13184.9 13787.9 14082.7 676.4 680.2 680.5 690.1 701.0 5916.3 5924.2 6039.8 6060.6 6062.4 143182.0 143709.0 143866.0 144376.0 144839.3 129508.0 131426.0 131995.0 134184.0 134512.0 111469.0 112746.0 114886.0 118208.4 118495.8 11322.8 11326.9 11534.4 11597.4 11698.8 48846.3 48925.3 49496.0 49707.5 49962.3 63657.0 63847.4 64324.0 64515.4 64805.0 15365.2 15458.8 15556.0 15578.2 15839.8 19773.3 21573.9 21621.6 21851.2 22040.2 17817.4 17909.1 17987.1 18014.5 18019.5 16592.2 16846.7 16906.0 16916.0 16931.4 17514.9 17875.1 17898.3 17934.9 18087.3 14146.4 14321.6 14377.4 14560.0 14709.9 14085.9 14096.0 14127.6 14198.0 14275.5 03:49:35 INFO - PID 3788 | -------- Summary: end -------- 03:49:35 INFO - PID 3788 | 03:49:36 INFO - TEST-INFO | 3788: exit 0 03:49:36 INFO - TEST-OK | dromaeo_css | took 1111496ms 03:49:36 INFO - TEST-START | kraken 03:49:36 INFO - Initialising browser for kraken test... 03:49:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48871/getInfo.html -profile /tmp/tmp_Mz22S/profile 03:49:36 INFO - TEST-INFO | started process 4200 (/builds/slave/test/build/application/firefox/firefox http://localhost:48871/getInfo.html) 03:49:41 INFO - TEST-INFO | 4200: exit 0 03:49:41 INFO - Browser initialized. 03:49:41 INFO - Running cycle 1/1 for kraken test... 03:49:41 INFO - Using env: {'DISPLAY': ':0', 03:49:41 INFO - 'HOME': '/home/cltbld', 03:49:41 INFO - 'JSGC_DISABLE_POISONING': '1', 03:49:41 INFO - 'LANG': 'en_US.UTF-8', 03:49:41 INFO - 'LANGUAGE': 'en_US:en', 03:49:41 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:49:41 INFO - 'LOGNAME': 'cltbld', 03:49:41 INFO - 'MAIL': '/var/mail/cltbld', 03:49:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:49:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:49:41 INFO - 'MOZ_CRASHREPORTER': '1', 03:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:41 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:49:41 INFO - 'MOZ_NO_REMOTE': '1', 03:49:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:49:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:41 INFO - 'NO_EM_RESTART': '1', 03:49:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:41 INFO - 'PWD': '/builds/slave/test', 03:49:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:49:41 INFO - 'RUST_BACKTRACE': 'full', 03:49:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:49:41 INFO - 'SHELL': '/bin/bash', 03:49:41 INFO - 'SHLVL': '1', 03:49:41 INFO - 'TERM': 'linux', 03:49:41 INFO - 'TMOUT': '86400', 03:49:41 INFO - 'USER': 'cltbld', 03:49:41 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860', 03:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:41 INFO - '_': '/tools/buildbot/bin/python'} 03:49:41 INFO - TEST-INFO | started process 4437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_Mz22S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:49:42 INFO - PID 4437 | 03:49:42 INFO - PID 4437 | (/builds/slave/test/build/application/firefox/firefox:4487): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:49:42 INFO - PID 4437 | 03:49:52 INFO - PID 4437 | RSS: Main: 146452480 03:49:52 INFO - PID 4437 | 03:49:55 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:48871/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48871/tests/kraken/driver.html?testName=audio-beat-detection) 03:49:56 INFO - PID 4437 | RSS: Main: 152182784 03:49:56 INFO - PID 4437 | 03:49:58 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:48871/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48871/tests/kraken/driver.html?testName=audio-dft) 03:49:59 INFO - PID 4437 | RSS: Main: 152154112 03:49:59 INFO - PID 4437 | 03:50:02 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:48871/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48871/tests/kraken/driver.html?testName=audio-fft) 03:50:02 INFO - PID 4437 | RSS: Main: 149168128 03:50:02 INFO - PID 4437 | 03:50:04 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:48871/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48871/tests/kraken/driver.html?testName=audio-oscillator) 03:50:05 INFO - PID 4437 | RSS: Main: 149954560 03:50:05 INFO - PID 4437 | 03:50:07 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:48871/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48871/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:50:08 INFO - PID 4437 | RSS: Main: 149712896 03:50:08 INFO - PID 4437 | 03:50:11 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:48871/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48871/tests/kraken/driver.html?testName=imaging-darkroom) 03:50:11 INFO - PID 4437 | RSS: Main: 149786624 03:50:11 INFO - PID 4437 | 03:50:15 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:48871/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48871/tests/kraken/driver.html?testName=imaging-desaturate) 03:50:15 INFO - PID 4437 | RSS: Main: 150720512 03:50:15 INFO - PID 4437 | 03:50:18 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:48871/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48871/tests/kraken/driver.html?testName=json-parse-financial) 03:50:19 INFO - PID 4437 | RSS: Main: 152358912 03:50:19 INFO - PID 4437 | 03:50:20 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:48871/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48871/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:50:21 INFO - PID 4437 | RSS: Main: 152731648 03:50:21 INFO - PID 4437 | 03:50:23 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:48871/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48871/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:50:23 INFO - PID 4437 | RSS: Main: 153378816 03:50:23 INFO - PID 4437 | 03:50:25 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:48871/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48871/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:50:26 INFO - PID 4437 | RSS: Main: 149852160 03:50:26 INFO - PID 4437 | 03:50:28 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:48871/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48871/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:50:29 INFO - PID 4437 | RSS: Main: 150016000 03:50:29 INFO - PID 4437 | 03:50:32 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:48871/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48871/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:50:32 INFO - PID 4437 | RSS: Main: 150499328 03:50:32 INFO - PID 4437 | 03:50:34 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:48871/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48871/tests/kraken/driver.html?testName=ai-astar) 03:50:34 INFO - PID 4437 | RSS: Main: 152330240 03:50:34 INFO - PID 4437 | 03:50:34 INFO - PID 4437 | __start_tp_report 03:50:34 INFO - PID 4437 | _x_x_mozilla_page_load 03:50:34 INFO - PID 4437 | _x_x_mozilla_page_load_details 03:50:34 INFO - PID 4437 | |i|pagename|runs| 03:50:34 INFO - PID 4437 | |0;ai-astar;108;106;107;105;105;114;105;106;105;106 03:50:34 INFO - PID 4437 | |1;audio-beat-detection;113;110;112;114;114;113;112;116;112;122 03:50:34 INFO - PID 4437 | |2;audio-dft;163;162;162;162;162;160;162;163;168;166 03:50:34 INFO - PID 4437 | |3;audio-fft;73;73;73;72;73;73;74;74;73;73 03:50:34 INFO - PID 4437 | |4;audio-oscillator;79;78;78;77;76;78;79;77;77;78 03:50:34 INFO - PID 4437 | |5;imaging-gaussian-blur;110;114;109;114;114;115;113;110;115;114 03:50:34 INFO - PID 4437 | |6;imaging-darkroom;149;150;149;150;149;150;149;151;148;149 03:50:34 INFO - PID 4437 | |7;imaging-desaturate;94;94;94;94;94;93;94;94;94;94 03:50:34 INFO - PID 4437 | |8;json-parse-financial;45;46;45;45;46;44;42;48;43;43 03:50:34 INFO - PID 4437 | |9;json-stringify-tinderbox;38;37;38;37;37;37;37;38;37;37 03:50:34 INFO - PID 4437 | |10;stanford-crypto-aes;72;78;69;71;71;70;71;71;76;71 03:50:34 INFO - PID 4437 | |11;stanford-crypto-ccm;114;108;103;104;108;105;104;106;104;117 03:50:34 INFO - PID 4437 | |12;stanford-crypto-pbkdf2;154;161;154;146;151;154;158;153;157;152 03:50:34 INFO - PID 4437 | |13;stanford-crypto-sha256-iterative;63;63;59;60;58;64;64;59;60;59 03:50:34 INFO - PID 4437 | __end_tp_report 03:50:34 INFO - PID 4437 | __start_cc_report 03:50:34 INFO - PID 4437 | _x_x_mozilla_cycle_collect,693 03:50:34 INFO - PID 4437 | __end_cc_report 03:50:34 INFO - PID 4437 | __startTimestamp1505818234642__endTimestamp 03:50:34 INFO - PID 4437 | 03:50:34 INFO - PID 4437 | ------- Summary: start ------- 03:50:34 INFO - PID 4437 | Number of tests: 14 03:50:34 INFO - PID 4437 | 03:50:34 INFO - PID 4437 | [#0] ai-astar Cycles:10 Average:106.70 Median:106.00 stddev:2.75 (2.6%) stddev-sans-first:2.88 03:50:34 INFO - PID 4437 | Values: 108.0 106.0 107.0 105.0 105.0 114.0 105.0 106.0 105.0 106.0 03:50:34 INFO - PID 4437 | 03:50:34 INFO - PID 4437 | [#1] audio-beat-detection Cycles:10 Average:113.80 Median:113.50 stddev:3.29 (2.9%) stddev-sans-first:3.48 03:50:34 INFO - PID 4437 | Values: 113.0 110.0 112.0 114.0 114.0 113.0 112.0 116.0 112.0 122.0 03:50:34 INFO - PID 4437 | 03:50:34 INFO - PID 4437 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.50 stddev:2.31 (1.4%) stddev-sans-first:2.45 03:50:34 INFO - PID 4437 | Values: 163.0 162.0 162.0 162.0 162.0 160.0 162.0 163.0 168.0 166.0 03:50:34 INFO - PID 4437 | 03:50:34 INFO - PID 4437 | [#3] audio-fft Cycles:10 Average:73.10 Median:73.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 03:50:34 INFO - PID 4437 | Values: 73.0 73.0 73.0 72.0 73.0 73.0 74.0 74.0 73.0 73.0 03:50:34 INFO - PID 4437 | 03:50:34 INFO - PID 4437 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:78.00 stddev:0.95 (1.2%) stddev-sans-first:0.88 03:50:34 INFO - PID 4437 | Values: 79.0 78.0 78.0 77.0 76.0 78.0 79.0 77.0 77.0 78.0 03:50:34 INFO - PID 4437 | 03:50:34 INFO - PID 4437 | [#5] imaging-gaussian-blur Cycles:10 Average:112.80 Median:114.00 stddev:2.25 (2.0%) stddev-sans-first:2.15 03:50:34 INFO - PID 4437 | Values: 110.0 114.0 109.0 114.0 114.0 115.0 113.0 110.0 115.0 114.0 03:50:34 INFO - PID 4437 | 03:50:34 INFO - PID 4437 | [#6] imaging-darkroom Cycles:10 Average:149.40 Median:149.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 03:50:34 INFO - PID 4437 | Values: 149.0 150.0 149.0 150.0 149.0 150.0 149.0 151.0 148.0 149.0 03:50:34 INFO - PID 4437 | 03:50:34 INFO - PID 4437 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:50:34 INFO - PID 4437 | Values: 94.0 94.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 03:50:34 INFO - PID 4437 | 03:50:34 INFO - PID 4437 | [#8] json-parse-financial Cycles:10 Average:44.70 Median:45.00 stddev:1.77 (3.9%) stddev-sans-first:1.87 03:50:34 INFO - PID 4437 | Values: 45.0 46.0 45.0 45.0 46.0 44.0 42.0 48.0 43.0 43.0 03:50:34 INFO - PID 4437 | 03:50:34 INFO - PID 4437 | [#9] json-stringify-tinderbox Cycles:10 Average:37.30 Median:37.00 stddev:0.48 (1.3%) stddev-sans-first:0.44 03:50:34 INFO - PID 4437 | Values: 38.0 37.0 38.0 37.0 37.0 37.0 37.0 38.0 37.0 37.0 03:50:34 INFO - PID 4437 | 03:50:34 INFO - PID 4437 | [#10] stanford-crypto-aes Cycles:10 Average:72.00 Median:71.00 stddev:2.79 (3.9%) stddev-sans-first:2.96 03:50:34 INFO - PID 4437 | Values: 72.0 78.0 69.0 71.0 71.0 70.0 71.0 71.0 76.0 71.0 03:50:34 INFO - PID 4437 | 03:50:34 INFO - PID 4437 | [#11] stanford-crypto-ccm Cycles:10 Average:107.30 Median:107.00 stddev:4.69 (4.4%) stddev-sans-first:4.30 03:50:34 INFO - PID 4437 | Values: 114.0 108.0 103.0 104.0 108.0 105.0 104.0 106.0 104.0 117.0 03:50:34 INFO - PID 4437 | 03:50:34 INFO - PID 4437 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.00 Median:154.00 stddev:4.11 (2.7%) stddev-sans-first:4.36 03:50:34 INFO - PID 4437 | Values: 154.0 161.0 154.0 146.0 151.0 154.0 158.0 153.0 157.0 152.0 03:50:34 INFO - PID 4437 | 03:50:34 INFO - PID 4437 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.90 Median:61.50 stddev:2.33 (3.8%) stddev-sans-first:2.35 03:50:34 INFO - PID 4437 | Values: 63.0 63.0 59.0 60.0 58.0 64.0 64.0 59.0 60.0 59.0 03:50:34 INFO - PID 4437 | -------- Summary: end -------- 03:50:34 INFO - PID 4437 | 03:50:35 INFO - PID 4437 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:50:35 INFO - TEST-INFO | 4437: exit 0 03:50:35 INFO - TEST-OK | kraken | took 59152ms 03:50:35 INFO - SUITE-END | took 1170s 03:50:35 INFO - Completed test suite (00:19:30) 03:50:35 INFO - javascript benchmark 03:50:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9064.393960208963, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3913.295606790778, 3919.8628048018327, 3927.84288628455, 3935.5080614923136, 3976.0, 6224.502039836813, 6271.843203919899, 6308.085327627491, 6308.243010838706, 6416.294207637156, 6320.304766475684, 6327.746890124389, 6354.14219080424, 6366.936330636692, 6477.222733272002, 5577.69322687252, 5664.376918538957, 5675.574331925101, 5729.713514324288, 5742.655440673552, 1089.9040832392238, 5645.943540564583, 5742.425757424245, 5759.798407055754, 5816.9418305817035, 5306.63353458484, 5610.775568977236, 5651.4913657770585, 5684.999999999959, 5750.568707346944, 5651.9152212716845, 5664.0, 5689.089745640677, 5699.116636921284, 5703.5437165027115, 5674.177244299594, 5691.203231547586, 5711.742971566289, 5756.65460072397, 5767.394423585547, 6302.4958003359625, 6352.618842869442, 6354.17395738551, 6364.618122912594, 6396.2964073951825, 6896.827579310508, 6899.344562266577, 6971.58170509771, 6995.160580730294, 7012.614306213156, 6772.119624448839, 6820.31796820314, 6879.931200687979, 6941.34057264559, 6997.265287144827, 6428.228612566522, 6452.7418903243815, 6455.870882582369, 6475.999999999953, 6515.902261466082, 7115.0, 7117.572945623279, 7191.424686025105, 7211.314925082109, 7211.387032102225, 6827.0, 6834.077399551096, 6887.965560172267, 6898.0, 6905.482088843357, 6809.38715515606, 6855.451563874878, 6890.655467226618, 6939.583624982517, 6963.965180174168, 6833.077534532775, 6843.3840954314355, 6870.5534140281725, 6916.896246556305, 6921.515493915478, 6804.523683342119, 6818.079559259437, 6826.317368263134, 6905.37851593359, 6943.409810166091, 4827.179379505493, 4937.259411088366, 4944.975275123673, 4988.925166122511, 4989.126902791997, 4430.269005614102, 4527.958569529027, 4544.500104988449, 4570.382998295254, 4580.358749775034, 6203.720832562545, 6209.441150296495, 6290.276618188876, 6297.811065668037, 6301.464375528039, 6748.122744043243, 6771.255161932184, 6800.217974932847, 6813.3527314906, 6844.28135045823, 6254.6872656366995, 6257.78097766576, 6288.937110628835, 6312.0, 6346.619202847752, 5546.55627549795, 5590.440955904377, 5605.971970140124, 5615.354234263112, 5621.7189140542805, 7087.1849737279845, 7128.5722856627735, 7144.9642751785905, 7152.213256541776, 7244.49288549807, 6816.216135144423, 6836.487263455161, 6839.965800170968, 6847.828804279933, 6856.622885741132, 7073.469489788184, 7121.67952442131, 7138.214796372498, 7142.464315176278, 7146.106736657918, 6887.724491020504, 6959.826004349932, 6970.337817907291, 6982.581045137308, 6983.895241571482, 6960.199577048502, 6965.512414131165, 6965.721371145098, 7078.858422831411, 7081.681324340314, 6575.868482630416, 6625.900611490928, 6630.0, 6638.634875081723, 6641.701123449359, 6631.3700198481065, 6699.330066993261, 6703.128593282842, 6705.396514313735, 6738.124043874265, 6588.901166482411, 6657.7669781557415, 6677.165354330708, 6685.298043705341, 6685.832854178684, 6724.159480064992, 6753.662316884234, 6769.323067693192, 6816.965915170393, 6829.180498340231, 6463.773767918288, 6504.349565043458, 6506.512011599054, 6515.055316978916, 6531.052997315458], "value": 6249.782270254863, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [956.3974695941556, 963.3256720295794, 986.7631768375587, 993.7863359377733, 1005.7787286796902, 45496.77251613741, 45904.0, 46010.76994615031, 46111.76944115275, 46150.53849461509, 42926.0, 42974.78512607433, 43103.0, 43208.0, 43294.99999999992, 7681.270279323469, 7796.4932279401655, 7800.0, 7807.648655810473, 7831.608419579026, 7688.654010569509, 7748.2251774822635, 7787.844243115134, 7789.0, 7793.220677932218, 8182.877256841152, 8435.95782021092, 8444.197801208875, 8449.281811046068, 8483.830323393528, 8311.127331630152, 8395.328373730148, 8397.53813540255, 8401.95799021004, 8402.369822263325, 8076.3942704297415, 8228.341732661373, 8290.751277461686, 8294.751157465285, 8332.083470818205, 40807.0, 41076.38385424221, 41138.588614113774, 41162.76511704654, 41188.58811411908, 3677.1358730698266, 3747.8126093695205, 3756.549214094299, 3757.9624203757885, 3758.361078616642, 32872.67127328744, 33046.17384565381, 33149.0, 33212.667873321196, 33255.50116748251, 5496.038193316193, 5521.585881058937, 5569.359523654791, 5571.331440227158, 5594.636348637367, 213183.0, 213775.0, 215362.0, 215609.99999999843, 215648.0, 46437.76781116073, 47355.526444735115, 53625.463745362824, 54353.72823135859, 54370.91258174814, 56451.71774141103, 56919.71540142356, 56939.715301423224, 57020.0, 57020.0, 16455.42406015784, 16500.25748841305, 16619.6676066478, 16645.16774161287, 16687.08221047854, 13369.131006484547, 13478.86521134776, 13521.256330901895, 13545.119567228296, 13563.05058645905, 15017.774733379008, 15047.623809404853, 15168.0, 15169.544913652608, 15315.693686126215, 6073.362296958844, 6093.939060609426, 6094.939050609526, 6147.66187859672, 6320.810375688737, 1100.5432745410565, 1114.5207560748956, 1115.3475216998147, 1118.2954738514684, 1122.4780477078198, 25000.624990625154, 25186.496270074495, 25279.241622751346, 25525.077356256374, 25683.10109146171, 1205.9638210853689, 1207.251504067484, 1211.3216598704753, 1215.9513619455122, 1232.0944106082022, 13508.98682598809, 13581.592552223448, 13618.86381136176, 13646.454141834216, 13732.931335343259, 286864.0, 286939.0, 286942.0, 287727.0, 287831.0, 57883.131753023736, 58037.4196258032, 58319.0, 58356.0, 58472.0, 1508.1705062215956, 1514.8182218133895, 1532.96167595811, 1550.9457168999031, 1553.2156261088078, 24815.87592062028, 25006.74993250117, 25061.624075638516, 25072.74927250704, 25375.873120634278, 40481.39277910775, 40525.0, 40532.79733601313, 40549.594504054585, 40626.79686601548, 234532.0, 234731.0, 235928.0, 236038.0, 237119.0, 35817.283654327286, 36391.27217455583, 38116.42825357677, 38209.0, 38289.617103828605, 48997.75501122472, 50898.0, 51178.74410627923, 51299.74350128225, 51397.48602513927, 34932.82533587316, 35262.82368588243, 35534.822325888206, 35982.4602630966, 36328.27343453169, 36450.453243201904, 36779.0, 36871.0, 37097.258054839294, 37121.25757484889, 41684.166316674105, 42692.0, 42729.0, 42969.0, 43056.56943430525, 34864.825675871456, 35059.0, 35110.29779404448, 35173.12067198341, 35412.0, 26045.6093158599, 26840.0, 26855.731442686105, 26971.460570788866, 27540.036098736447], "value": 18785.59584469974, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.9970400147998, 600.6816387314722, 605.207178596039, 616.223558316521, 623.9937600623994, 23655.526889462202, 24408.0, 24504.509909801793, 24595.877020614873, 24602.507949841016, 23217.303480895556, 26347.604785928226, 26515.602265966027, 26551.336216594595, 26654.0, 6420.935790642092, 6602.636854972975, 6619.073329733841, 6640.800775976729, 6645.269020407752, 6334.461570766491, 6371.745130194787, 6459.386358295955, 6460.967695161517, 6461.676916154197, 6517.413432791048, 6551.967240163816, 6553.279139294697, 6555.77054803082, 6560.2455717592375, 6316.30520642729, 6504.447121994636, 6543.280239173735, 6559.639219842907, 6560.573562718432, 6164.352742961969, 6176.69116544171, 6203.96898015507, 6205.906911396332, 6210.441060304549, 30050.54924176139, 30255.0, 30409.087727368213, 30487.542686859713, 30577.847110764527, 2341.0518739910362, 2371.6205407134776, 2374.03851440167, 2375.3349062262596, 2380.4643955110137, 20095.698564521543, 20657.5868482631, 21383.35849924505, 21416.785832141635, 21473.67789483159, 2509.9372515687255, 2512.108201588428, 2562.2185233503774, 2648.0996461203285, 2649.3906401527756, 140580.0, 147019.0, 157000.21499892542, 164952.0, 165105.0, 15274.31265593051, 16022.19889005545, 16347.0, 16640.916795415946, 16890.226526214818, 25654.588997604937, 25901.481970360488, 25944.48111037769, 25948.61077083845, 25956.35109122287, 10733.516991735234, 10821.188410869216, 10856.34861908288, 10925.962033606795, 11002.33985960845, 9997.45014024221, 10011.549480273405, 10072.848907266396, 10115.949420252999, 10226.846597301046, 9702.854457183148, 9779.755506112404, 9783.726059662597, 9846.0, 9952.0, 2680.32991752062, 2700.5409080455975, 2769.667639883227, 2834.9433011339656, 2842.990738287919, 1031.4739482863642, 1044.8589440425446, 1053.6680945502142, 1055.3931489393628, 1062.8352605346183, 20632.793672063086, 20864.0, 20866.06102725381, 21442.678359824615, 21554.0, 1104.320842681745, 1104.928179668319, 1109.8113320735495, 1123.8314252862135, 1125.234840308598, 11403.657890263305, 11564.826527601925, 11641.0, 11806.46870890812, 11820.70448238801, 627246.0, 631281.0, 656037.0, 658015.0, 658124.0, 128797.35601322122, 129743.0, 131619.0, 132678.0, 135724.3213783925, 1152.4525850221078, 1215.2708374974945, 1228.4471987605614, 1237.418413345726, 1247.4698253242518, 18790.6241875159, 18841.15214815309, 18906.43280701581, 19097.61804763869, 19183.232670693014, 63355.0, 63409.682951584946, 63630.68184659047, 64074.3592564087, 64311.678441607495, 82181.0, 83011.0, 83061.0, 83334.0, 83654.58172709098, 15010.324535396152, 15386.307616157075, 15407.922960385127, 15447.845521544641, 15468.690626187637, 23045.53908921846, 23263.76736232684, 23333.18333858307, 23359.065637374995, 23450.296491105295, 17923.641527169122, 18920.33778817735, 19084.427467176007, 19217.90391048036, 19252.8074719251, 16158.192090395198, 16630.008797888662, 17144.485665430057, 17430.47708568745, 17567.0, 19010.714839277145, 19424.125914333606, 19521.804781952, 19544.90227548853, 19609.607807844048, 14946.551603451913, 14972.625684357978, 15106.0, 15126.546203613469, 15171.92414037967, 18846.43460696181, 18855.811441885406, 19022.144003520152, 19055.333063342718, 19109.713354299976], "value": 12740.42134418655, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1397.468961794518, 1513.2811914340682, 1513.296317212496, 1515.9772603410947, 1528.4573976238435, 16392.0, 17026.06356650384, 17055.573610659707, 17105.828941710595, 17125.0, 16549.586260343498, 16554.172291385443, 16698.833011669878, 16709.749353759675, 16742.0, 2503.4993001399703, 2522.697276326843, 2576.896924123033, 2578.316746062295, 2579.3938424470234, 2785.6100145979476, 2876.0796545105572, 2888.378998515319, 2915.7230063143966, 2919.927001824961, 2818.9295267618268, 2835.4754370441533, 2836.276749428893, 2837.248129245741, 2843.147055883237, 2786.0, 2843.843588602626, 2850.9002184923534, 2853.058490698065, 2854.1722900358973, 2760.903368382117, 2784.0951690700604, 2784.693683694792, 2788.177487641151, 2802.9719702802913, 16024.679506409806, 16188.433404830892, 16330.0, 16385.262663180067, 16455.588610284718, 8364.790880228044, 8638.352123590756, 8640.913590864075, 8656.913430865674, 8658.523781192032, 5718.142278658193, 5868.061110222387, 5871.324797648283, 6045.697715114226, 6059.878802423971, 2105.2947262667026, 2127.276725913197, 2129.0, 2171.1315473810446, 2192.6930229767845, 29586.704132958825, 29980.70019299801, 30020.99999999978, 30026.69973300261, 30082.398352033055, 7002.264762199998, 7111.111111111111, 7149.53528020677, 7309.853802923912, 7454.925450745532, 18962.0, 19058.42824715261, 19219.51951201231, 19220.90389548071, 19231.13459894308, 8302.294304984023, 8495.575221238912, 8503.872441913376, 8525.531095789791, 8539.103394143649, 7695.846083078419, 7737.690492380354, 7812.414068944852, 7886.802829929297, 7946.046474423106, 5583.916241256303, 5752.252207213036, 5757.6833274169485, 5812.796552120655, 5816.41835816415, 1542.2365928865283, 1646.9258883350278, 1656.7100757367411, 1672.3979367427717, 1680.487451327357, 811.922867327603, 955.7085089047769, 980.2207245240052, 996.6113215845826, 1011.8785745710562, 8347.95650543682, 8453.0, 8489.151084891462, 8715.869261961076, 8991.235744961621, 1034.3225187502048, 1037.6938803053117, 1039.428314427062, 1046.7958748044211, 1072.5441687282873, 5162.586993040548, 5223.13818219997, 5310.973445132827, 5425.972870135624, 5436.320459942507, 24206.63690044651, 24634.630480542804, 24915.750842491707, 24988.500229995298, 25243.24270271858, 24546.263612091665, 24582.87708561446, 24624.753752462606, 24636.13773517918, 24724.629130563055, 11206.719832004102, 11923.403829808474, 12087.516499340103, 12092.758144837055, 12118.212316199242, 9591.28065395112, 9648.2211466492, 9849.704508864745, 9888.703338899844, 9915.504224788876, 20754.792452075286, 20814.479638009172, 21595.0, 21704.782952170906, 21779.673304900123, 21649.35051948444, 21766.0, 21771.238006670323, 21932.0, 22113.66829497591, 11812.881871181178, 12069.215500992408, 12098.879011210127, 12106.878931210927, 12109.152359334763, 15330.770038449655, 15507.84492155064, 15555.766663500282, 15622.609434764221, 15700.764488532453, 11800.3509806958, 12262.20295680778, 12382.752344953231, 12470.812937806122, 12572.622821315375, 11970.20446932967, 12267.386630668609, 12293.323867187391, 12471.0, 12688.111832171659, 10308.0, 10534.841977370499, 10537.789244214919, 10540.472976350999, 10552.577896884039, 7859.09620393662, 7992.16082311349, 8058.637361318872, 8060.919390806017, 8130.308923741311, 8317.875231871647, 8463.830723385621, 8529.445586036887, 8546.444481108956, 8563.272121869712], "value": 7256.2695773098885, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [529.5551736541305, 565.7227958300434, 569.7464628240432, 569.9430056994302, 575.8934597099534, 6284.811455656332, 6345.52408569358, 6367.426931576158, 6394.168758061452, 6410.519211059166, 6278.1838361013115, 6290.528210384216, 6299.244090709121, 6334.429901308881, 6373.426391624753, 5136.845894623168, 5147.948520514784, 5170.819021334254, 5188.195829646411, 5188.533032027136, 4859.902801943959, 4961.156603377416, 5145.922811157836, 5158.27784110223, 5171.637985341028, 4893.437254715717, 4895.657303988723, 4924.507549245065, 4935.111679897617, 4983.950160498385, 4918.704877707331, 4942.604591632661, 4952.167697951763, 4960.33035540201, 5007.649464537484, 4491.6855820092605, 4498.392716983198, 4505.3917721107555, 4529.592336689714, 4546.749928753918, 6145.8156255312415, 6188.8762224755255, 6217.751289948396, 6222.848772977014, 6228.283747369065, 5770.769169233267, 5825.097109947965, 5865.736041878125, 5918.674472903988, 5933.584649074566, 6592.670366481657, 6593.835154121138, 6599.769008084694, 6664.566803157779, 6666.0, 4997.175466048097, 5003.574696150831, 5006.07387633289, 5055.368078990126, 5057.393112826448, 6736.393724564764, 6775.966120169417, 6898.793036208922, 6942.72229110835, 6977.162740471176, 5119.948800511947, 5129.8717532062, 5187.844364669066, 5196.896062078813, 5217.191335343028, 5251.52736253739, 5255.947440525622, 5278.868028299324, 5307.495787900143, 5321.574274058066, 5864.8533786654825, 5877.823665290048, 5882.088276317178, 5888.175655408247, 5901.468867801918, 6659.600423974577, 6667.799966001027, 6678.131842860397, 6718.865622687519, 6720.529562930646, 1760.7358896165422, 1776.3782676063274, 1777.5111844242936, 1802.1439816087254, 1809.8461630761533, 1253.0476837603487, 1293.6571808470762, 1295.7084655952524, 1306.2162702378687, 1306.9803952940713, 6127.662978536134, 6168.228971378578, 6213.65824879636, 6254.15568898202, 6259.186305780219, 6483.448906842971, 6626.204855417284, 6748.527603067836, 6771.187457505131, 6841.863162736718, 6064.514838812885, 6178.938210617836, 6203.379662033851, 6243.43809057187, 6277.937220627827, 3521.8591256349973, 3560.2701446203464, 3560.4303311470558, 3563.483294922222, 3576.4277715565386, 7092.6099064551945, 7126.441375726941, 7137.823668467482, 7156.141263048364, 7161.534500257467, 6859.759908403182, 6945.583265004116, 6965.721371145098, 6966.909927021873, 6972.477064220204, 6951.6871740770775, 6952.652367381712, 7021.543599666005, 7096.9483122257925, 7103.9289607103265, 6700.2964688708935, 6702.865942681216, 6755.966220168868, 6769.646070785764, 6802.761903333359, 6633.568818026813, 6637.701303441453, 6675.265720770614, 6755.256921738703, 6770.6614669265355, 7009.929900701131, 7040.3598650506065, 7046.506744528039, 7079.929200707927, 7125.394341480825, 5096.821611243588, 5169.172932330809, 5172.896542069213, 5187.766550505312, 5192.688438693691, 6794.93205067943, 6853.417459515997, 6881.346272104142, 6892.069570607904, 6935.306469353024, 6541.738330466728, 6571.605703657605, 6610.768623098168, 6620.801375958729, 6640.90038649411, 6525.3800888915475, 6537.182852143482, 6553.442957348679, 6554.541182117206, 6606.669666516751, 6365.4589359903075, 6455.9677201613695, 6505.2518960318275, 6508.72793037641, 6509.251436084911, 6559.836004099936, 6587.63767992765, 6619.470442364503, 6639.4688424924925, 6649.534532582867, 6043.335233124265, 6381.361863813581, 6404.743810247538, 6405.8718825624155, 6464.806055818333], "value": 5192.3988616253555, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [949.0936155971044, 973.23600973236, 973.6105557776892, 977.9755506112351, 996.1084829077976, 21010.684839727397, 21716.131354745812, 22985.4253643659, 22989.195378161767, 23083.0, 20079.0, 20882.164713411446, 20959.21846643037, 21016.264430744926, 21128.683069753966, 1089.1667874076338, 1089.3518356577824, 1096.797092537879, 1099.1756182862853, 1102.2835157147838, 1088.0751361342875, 1091.6397588795678, 1092.1699508373613, 1096.4956120184725, 1099.3239157917862, 1145.6104924325728, 1156.02316042944, 1156.2022204678744, 1156.2715489241807, 1158.7856246594406, 1146.5241924601323, 1153.4463457540344, 1156.4853640130145, 1156.6183159557327, 1157.6816375496765, 848.9235968762841, 849.8300339932039, 850.2390360627265, 851.3572252949045, 852.9232369086812, 18718.532036699056, 19405.32081377145, 19529.316473923343, 19609.509762255915, 19682.901585492124, 22763.886180569156, 22807.543849122925, 23253.76746232533, 23300.7669923302, 23449.17927872516, 18683.53291167718, 18796.24815007398, 18834.152463139053, 18854.62290754191, 18947.147378368005, 3944.960550394488, 3967.662748666367, 3968.305546529346, 3974.4833171687783, 3981.28336899358, 147220.0, 148465.99999999892, 148867.0, 149361.0, 150468.0, 16162.595935101717, 16431.507054788377, 16647.3341066356, 16700.916495417445, 16725.581860453585, 34483.0, 34643.30713385718, 34680.826595866856, 34928.476072858924, 34962.0, 8431.241188292961, 8769.780755481164, 9056.683016094405, 9397.671081512115, 9572.473513956798, 4386.18855511725, 4489.775511224426, 4496.662750293741, 4513.255312873339, 4531.161735079021, 5980.342162362137, 6039.7282122304605, 6077.0, 6096.664683442454, 6137.202163718688, 1115.9609413670482, 1142.662914440242, 1150.1086657840074, 1150.327058670687, 1151.0, 680.3808534233823, 694.861027794433, 696.8989496522976, 709.5458906299972, 715.6350261366637, 12656.303903285223, 13058.608241752763, 13184.934075329562, 13787.86212137886, 14082.71834563303, 676.4385559985201, 680.2075581946976, 680.5134328954722, 690.1304356510833, 700.9614471204133, 5916.26046744157, 5924.20023296858, 6039.818805435844, 6060.636361818305, 6062.42406971337, 143182.0, 143709.0, 143866.0, 144376.0, 144839.27580362032, 129508.0, 131426.0, 131995.0, 134184.0, 134512.0, 111469.0, 112746.0, 114886.0, 118208.40895795466, 118495.81504185192, 11322.830157547809, 11326.943365283121, 11534.423278835857, 11597.420128993348, 11698.76602467963, 48846.26730598973, 48925.26612100893, 49496.0, 49707.502924970286, 49962.25056624081, 63657.0451443238, 63847.36152638414, 64324.0, 64515.35484645094, 64805.0, 15365.231738412811, 15458.84541154574, 15556.0, 15578.221088945735, 15839.841601583837, 19773.307934222234, 21573.892130539247, 21621.567568648225, 21851.235206767687, 22040.228591999203, 17817.376391826223, 17909.10454477245, 17987.10064496744, 18014.459566213034, 18019.459416217534, 16592.170391480136, 16846.66306673884, 16906.0, 16916.0, 16931.407400740914, 17514.912425438302, 17875.106244687453, 17898.28406863763, 17934.91032544829, 18087.276508939496, 14146.363413646617, 14321.57035288943, 14377.424903003763, 14560.0, 14709.852901470847, 14085.929570352082, 14095.95311665414, 14127.576172714835, 14198.0, 14275.500357487437], "value": 9841.25964160125, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1366.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 106.0, 107.0, 105.0, 105.0, 114.0, 105.0, 106.0, 105.0, 106.0], "value": 106.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 112.0, 114.0, 114.0, 113.0, 112.0, 116.0, 112.0, 122.0], "value": 113.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 162.0, 162.0, 160.0, 162.0, 163.0, 168.0, 166.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 72.0, 73.0, 73.0, 74.0, 74.0, 73.0, 73.0], "value": 73.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 77.0, 76.0, 78.0, 79.0, 77.0, 77.0, 78.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 109.0, 114.0, 114.0, 115.0, 113.0, 110.0, 115.0, 114.0], "value": 112.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 149.0, 150.0, 149.0, 150.0, 149.0, 151.0, 148.0, 149.0], "value": 149.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 46.0, 45.0, 45.0, 46.0, 44.0, 42.0, 48.0, 43.0, 43.0], "value": 44.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 37.0, 38.0, 37.0, 37.0, 37.0, 37.0, 38.0, 37.0, 37.0], "value": 37.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 78.0, 69.0, 71.0, 71.0, 70.0, 71.0, 71.0, 76.0, 71.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 103.0, 104.0, 108.0, 105.0, 104.0, 106.0, 104.0, 117.0], "value": 107.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 161.0, 154.0, 146.0, 151.0, 154.0, 158.0, 153.0, 157.0, 152.0], "value": 154.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 59.0, 60.0, 58.0, 64.0, 64.0, 59.0, 60.0, 59.0], "value": 60.9, "unit": "score"}]}]} 03:50:35 INFO - Return code: 0 03:50:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:50:35 INFO - # TBPL SUCCESS # 03:50:35 INFO - Running post-action listener: _package_coverage_data 03:50:35 INFO - Running post-action listener: _resource_record_post_action 03:50:35 INFO - [mozharness: 2017-09-19 10:50:35.412979Z] Finished run-tests step (success) 03:50:35 INFO - Running post-run listener: _resource_record_post_run 03:50:35 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 11628544; Write bytes: 460550144; Read time: 3824; Write time: 404660 03:50:35 INFO - TinderboxPrint: CPU usage
13.1% 03:50:35 INFO - TinderboxPrint: I/O read bytes / time
11,628,544 / 3,824 03:50:35 INFO - TinderboxPrint: I/O write bytes / time
460,550,144 / 404,660 03:50:35 INFO - TinderboxPrint: CPU idle
8,238.0 (86.9%) 03:50:35 INFO - TinderboxPrint: CPU user
1,186.9 (12.5%) 03:50:35 INFO - TinderboxPrint: Swap in / out
0 / 0 03:50:35 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12394496; Read time: 0; Write time: 2620 03:50:35 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:50:35 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 11628544; Write bytes: 448155648; Read time: 3824; Write time: 402040 03:50:36 INFO - Running post-run listener: _upload_blobber_files 03:50:36 INFO - Blob upload gear active. 03:50:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:50:36 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 03:50:36 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'] 03:50:36 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 03:50:36 INFO - (blobuploader) - INFO - Open directory for files ... 03:50:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:50:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:50:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:37 INFO - (blobuploader) - INFO - Done attempting. 03:50:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:50:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:50:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:38 INFO - (blobuploader) - INFO - Done attempting. 03:50:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:50:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:50:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:45 INFO - (blobuploader) - INFO - Done attempting. 03:50:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:50:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:50:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:46 INFO - (blobuploader) - INFO - Done attempting. 03:50:46 INFO - (blobuploader) - INFO - Iteration through files over. 03:50:46 INFO - Return code: 0 03:50:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:50:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:50:46 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa3f9822d18cf11f72978e0b8c4e53ac707ecbf3bf6bd018624c0157504de8581fe1269f84506772cdff66e28caa70190ed58b1ae9e2b73be2ae9aba6a8742fa", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4bf3e68592c22c7c75af25dc455f538959f44759fd83fcd3beb32e3fd1906604b3c131726fbec61ce27af15039aa544972fa8724aaf150315ee3f6aae06b6ea", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36bde25488de781867157fd6fc84133810989e839553adf9437707b7527a5acae68b701f86a79169d485f12ea904b73d0b0fc9cb6b83ba4ae71ffd67c947cdda", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a12b66c9f5d257d5af9e14605f8d2108d947a4143bca903a522f767b4f1b590c349ac4e255c3b400c38ae82e00b50e98aab2a24f840b3ff48c8d4f895b68389"} 03:50:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:50:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:50:46 INFO - Contents: 03:50:46 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa3f9822d18cf11f72978e0b8c4e53ac707ecbf3bf6bd018624c0157504de8581fe1269f84506772cdff66e28caa70190ed58b1ae9e2b73be2ae9aba6a8742fa", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4bf3e68592c22c7c75af25dc455f538959f44759fd83fcd3beb32e3fd1906604b3c131726fbec61ce27af15039aa544972fa8724aaf150315ee3f6aae06b6ea", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36bde25488de781867157fd6fc84133810989e839553adf9437707b7527a5acae68b701f86a79169d485f12ea904b73d0b0fc9cb6b83ba4ae71ffd67c947cdda", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a12b66c9f5d257d5af9e14605f8d2108d947a4143bca903a522f767b4f1b590c349ac4e255c3b400c38ae82e00b50e98aab2a24f840b3ff48c8d4f895b68389"} 03:50:46 INFO - Running post-run listener: copy_logs_to_upload_dir 03:50:46 INFO - Copying logs to upload dir... 03:50:46 INFO - mkdir: /builds/slave/test/build/upload/logs 03:50:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.072075 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-19 03:50:46.260319) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 03:50:46.263560) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa3f9822d18cf11f72978e0b8c4e53ac707ecbf3bf6bd018624c0157504de8581fe1269f84506772cdff66e28caa70190ed58b1ae9e2b73be2ae9aba6a8742fa", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4bf3e68592c22c7c75af25dc455f538959f44759fd83fcd3beb32e3fd1906604b3c131726fbec61ce27af15039aa544972fa8724aaf150315ee3f6aae06b6ea", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36bde25488de781867157fd6fc84133810989e839553adf9437707b7527a5acae68b701f86a79169d485f12ea904b73d0b0fc9cb6b83ba4ae71ffd67c947cdda", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a12b66c9f5d257d5af9e14605f8d2108d947a4143bca903a522f767b4f1b590c349ac4e255c3b400c38ae82e00b50e98aab2a24f840b3ff48c8d4f895b68389"} build_url:https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011217 build_url: 'https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa3f9822d18cf11f72978e0b8c4e53ac707ecbf3bf6bd018624c0157504de8581fe1269f84506772cdff66e28caa70190ed58b1ae9e2b73be2ae9aba6a8742fa", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4bf3e68592c22c7c75af25dc455f538959f44759fd83fcd3beb32e3fd1906604b3c131726fbec61ce27af15039aa544972fa8724aaf150315ee3f6aae06b6ea", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36bde25488de781867157fd6fc84133810989e839553adf9437707b7527a5acae68b701f86a79169d485f12ea904b73d0b0fc9cb6b83ba4ae71ffd67c947cdda", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a12b66c9f5d257d5af9e14605f8d2108d947a4143bca903a522f767b4f1b590c349ac4e255c3b400c38ae82e00b50e98aab2a24f840b3ff48c8d4f895b68389"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 03:50:46.292000) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:50:46.292342) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1505816887.21248-675074860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:50:46.377032) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 03:50:46.377360) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 03:50:46.377698) ========= ========= Total master_lag: 0.23 =========