builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-020 starttime: 1504203409.03 results: success (0) revision: 4984da22242841a5d84c4e5fd866e93a450d9723 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-31 11:16:49.034246) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-31 11:16:49.034674) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-31 11:16:49.034956) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-31 11:16:49.050889) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 11:16:49.051224) ========= 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=af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-31 11:16:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 287K=0.04s 2017-08-31 11:16:49 (287 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.179754 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 11:16:49.245879) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 11:16:49.249233) ========= 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=af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015378 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 11:16:49.298989) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 11:16:49.302345) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4984da22242841a5d84c4e5fd866e93a450d9723 --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 4984da22242841a5d84c4e5fd866e93a450d9723 --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=af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-31 11:16:49,611 truncating revision to first 12 chars 2017-08-31 11:16:49,611 Setting DEBUG logging. 2017-08-31 11:16:49,611 attempt 1/10 2017-08-31 11:16:49,611 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4984da222428?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-31 11:16:49,954 unpacking tar archive at: mozilla-central-4984da222428/testing/mozharness/ program finished with exit code 0 elapsedTime=0.741665 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 11:16:50.058674) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-31 11:16:50.058994) ========= script_repo_revision: 4984da22242841a5d84c4e5fd866e93a450d9723 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-31 11:16:50.062393) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-31 11:16:50.062663) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-31 11:16:50.074280) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-08-31 11:16:50.074550) ========= /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=af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:16:50 INFO - MultiFileLogger online at 20170831 11:16:50 in /builds/slave/test 11:16:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:16:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:16:50 INFO - {'append_to_log': False, 11:16:50 INFO - 'base_work_dir': '/builds/slave/test', 11:16:50 INFO - 'blob_upload_branch': 'Firefox', 11:16:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:16:50 INFO - 'branch': 'Firefox', 11:16:50 INFO - 'buildbot_json_path': 'buildprops.json', 11:16:50 INFO - 'code_coverage': False, 11:16:50 INFO - 'config_files': ('talos/linux_config.py',), 11:16:50 INFO - 'default_actions': ('clobber', 11:16:50 INFO - 'read-buildbot-config', 11:16:50 INFO - 'download-and-extract', 11:16:50 INFO - 'populate-webroot', 11:16:50 INFO - 'create-virtualenv', 11:16:50 INFO - 'install', 11:16:50 INFO - 'setup-mitmproxy', 11:16:50 INFO - 'run-tests'), 11:16:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:16:50 INFO - 'disable_ccov_upload': False, 11:16:50 INFO - 'disable_stylo': False, 11:16:50 INFO - 'download_minidump_stackwalk': True, 11:16:50 INFO - 'download_symbols': 'ondemand', 11:16:50 INFO - 'enable_stylo': False, 11:16:50 INFO - 'enable_webrender': False, 11:16:50 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:16:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:16:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:16:50 INFO - 'gecko_profile': False, 11:16:50 INFO - 'gecko_profile_interval': 0, 11:16:50 INFO - 'installer_path': 'installer.exe', 11:16:50 INFO - 'log_level': 'info', 11:16:50 INFO - 'log_name': 'talos', 11:16:50 INFO - 'log_to_console': True, 11:16:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:16:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:16:50 INFO - 'opt_config_files': (), 11:16:50 INFO - 'pip_index': False, 11:16:50 INFO - 'suite': 'dromaeojs-e10s', 11:16:50 INFO - 'system_bits': '32', 11:16:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:16:50 INFO - 'title': 'talos-linux64-ix-020', 11:16:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:16:50 INFO - 'use_talos_json': True, 11:16:50 INFO - 'verify': 'False', 11:16:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:16:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:16:50 INFO - 'work_dir': 'build'} 11:16:50 INFO - [mozharness: 2017-08-31 18:16:50.519045Z] Running clobber step. 11:16:50 INFO - Running pre-action listener: _resource_record_pre_action 11:16:50 INFO - Running main action method: clobber 11:16:50 INFO - rmtree: /builds/slave/test/build 11:16:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:16:52 INFO - Running post-action listener: _resource_record_post_action 11:16:52 INFO - [mozharness: 2017-08-31 18:16:52.051891Z] Finished clobber step (success) 11:16:52 INFO - [mozharness: 2017-08-31 18:16:52.052007Z] Running read-buildbot-config step. 11:16:52 INFO - Running pre-action listener: _resource_record_pre_action 11:16:52 INFO - Running main action method: read_buildbot_config 11:16:52 INFO - Using buildbot properties: 11:16:52 INFO - { 11:16:52 INFO - "project": "", 11:16:52 INFO - "product": "firefox", 11:16:52 INFO - "who": "ffxbld@noreply.mozilla.org", 11:16:52 INFO - "installer_path": "public/build/target.tar.bz2", 11:16:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 11:16:52 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:16:52 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 11:16:52 INFO - "stage_platform": "linux64-stylo", 11:16:52 INFO - "basedir": "/builds/slave/test", 11:16:52 INFO - "buildnumber": 111, 11:16:52 INFO - "platform": "ubuntu64_hw_stylo", 11:16:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:16:52 INFO - "slavebuilddir": "test", 11:16:52 INFO - "taskId": "Nwa0KFYhQBuKMQNzXEp9XA", 11:16:52 INFO - "branch": "mozilla-central", 11:16:52 INFO - "script_repo_revision": "production", 11:16:52 INFO - "revision": "4984da22242841a5d84c4e5fd866e93a450d9723", 11:16:52 INFO - "slavename": "talos-linux64-ix-020", 11:16:52 INFO - "repo_path": "mozilla-central" 11:16:52 INFO - } 11:16:52 INFO - Finding installer, test and symbols from parent task. 11:16:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nwa0KFYhQBuKMQNzXEp9XA'}, attempt #1 11:16:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nwa0KFYhQBuKMQNzXEp9XA'}, attempt #1 11:16:53 INFO - Task dependencies: JlZ4lx7RTwaSgq5fLFMGvQ 11:16:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ'}, attempt #1 11:16:53 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.tar.bz2 11:16:53 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.test_packages.json 11:16:53 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.crashreporter-symbols.zip 11:16:53 INFO - Running post-action listener: _resource_record_post_action 11:16:53 INFO - [mozharness: 2017-08-31 18:16:53.536248Z] Finished read-buildbot-config step (success) 11:16:53 INFO - [mozharness: 2017-08-31 18:16:53.536464Z] Running download-and-extract step. 11:16:53 INFO - Running pre-action listener: _resource_record_pre_action 11:16:53 INFO - Running main action method: download_and_extract 11:16:53 INFO - mkdir: /builds/slave/test/build/tests 11:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:53 INFO - trying https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.test_packages.json 11:16:53 INFO - Downloading https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:16:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:16:54 INFO - Downloaded 989 bytes. 11:16:54 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:16:54 INFO - Using the following test package requirements: 11:16:54 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:16:54 INFO - u'common': [u'target.common.tests.zip'], 11:16:54 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:16:54 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:16:54 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:16:54 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:16:54 INFO - u'mozbase': [u'target.common.tests.zip'], 11:16:54 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:16:54 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:16:54 INFO - u'web-platform': [u'target.common.tests.zip', 11:16:54 INFO - u'target.web-platform.tests.tar.gz'], 11:16:54 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:16:54 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:16:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.common.tests.zip 11:16:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:16:54 INFO - Fetch https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.common.tests.zip into memory 11:16:55 INFO - Content-Length response header: 54932997 11:16:55 INFO - Bytes received: 54932997 11:17:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:17:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.common.tests.zip 11:17:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:17:06 INFO - Fetch https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.common.tests.zip into memory 11:17:07 INFO - Content-Length response header: 54932997 11:17:07 INFO - Bytes received: 54932997 11:17:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.talos.tests.zip 11:17:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:17:19 INFO - Fetch https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.talos.tests.zip into memory 11:17:19 INFO - Content-Length response header: 14496650 11:17:19 INFO - Bytes received: 14496650 11:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:20 INFO - trying https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.tar.bz2 11:17:20 INFO - Downloading https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:17:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:17:21 INFO - Downloaded 62586538 bytes. 11:17:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.tar.bz2 11:17:21 INFO - mkdir: /builds/slave/test/properties 11:17:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:17:21 INFO - Writing to file /builds/slave/test/properties/build_url 11:17:21 INFO - Contents: 11:17:21 INFO - build_url:https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.tar.bz2 11:17:21 INFO - Running post-action listener: _resource_record_post_action 11:17:21 INFO - Running post-action listener: find_tests_for_verification 11:17:21 INFO - Running post-action listener: set_extra_try_arguments 11:17:21 INFO - [mozharness: 2017-08-31 18:17:21.413408Z] Finished download-and-extract step (success) 11:17:21 INFO - [mozharness: 2017-08-31 18:17:21.413504Z] Running populate-webroot step. 11:17:21 INFO - Running pre-action listener: _resource_record_pre_action 11:17:21 INFO - Running main action method: populate_webroot 11:17:21 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:17:21 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:17:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:17:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:17:21 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:17:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:17:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:17:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:17:21 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:17:21 INFO - 'talos_options': ['--enable-stylo'], 11:17:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:17:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:17:21 INFO - 'tests': ['damp', 'tps']}, 11:17:21 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:17:21 INFO - 'talos_options': ['--enable-stylo'], 11:17:21 INFO - 'tests': ['damp', 'tps']}, 11:17:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:17:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:17:21 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:17:21 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 11:17:21 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:17:21 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:17:21 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:17:21 INFO - 'talos_options': ['--enable-stylo'], 11:17:21 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:17:21 INFO - 'other-e10s': {'tests': ['a11yr', 11:17:21 INFO - 'ts_paint', 11:17:21 INFO - 'tpaint', 11:17:21 INFO - 'sessionrestore', 11:17:21 INFO - 'sessionrestore_many_windows', 11:17:21 INFO - 'sessionrestore_no_auto_restore', 11:17:21 INFO - 'tabpaint']}, 11:17:21 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:17:21 INFO - 'tests': ['a11yr', 11:17:21 INFO - 'ts_paint', 11:17:21 INFO - 'tpaint', 11:17:21 INFO - 'sessionrestore', 11:17:21 INFO - 'sessionrestore_many_windows', 11:17:21 INFO - 'sessionrestore_no_auto_restore', 11:17:21 INFO - 'tabpaint']}, 11:17:21 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:17:21 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:17:21 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:17:21 INFO - 'tests': ['bloom_basic_singleton']}, 11:17:21 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:17:21 INFO - 'tests': ['bloom_basic']}, 11:17:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:17:21 INFO - 'tsvgr_opacity', 11:17:21 INFO - 'tart', 11:17:21 INFO - 'tscrollx', 11:17:21 INFO - 'tsvg_static']}, 11:17:21 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:17:21 INFO - 'tests': ['tsvgx', 11:17:21 INFO - 'tsvgr_opacity', 11:17:21 INFO - 'tart', 11:17:21 INFO - 'tscrollx', 11:17:21 INFO - 'tsvg_static']}, 11:17:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:17:21 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:17:21 INFO - 'talos_options': ['--enable-stylo'], 11:17:21 INFO - 'tests': ['tp5o']}, 11:17:21 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:17:21 INFO - 'talos_options': ['--mitmproxy', 11:17:21 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:17:21 INFO - '--firstNonBlankPaint'], 11:17:21 INFO - 'tests': ['tp6_google', 11:17:21 INFO - 'tp6_youtube', 11:17:21 INFO - 'tp6_amazon', 11:17:21 INFO - 'tp6_facebook']}, 11:17:21 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:17:21 INFO - 'talos_options': ['--enable-stylo', 11:17:21 INFO - '--mitmproxy', 11:17:21 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:17:21 INFO - '--firstNonBlankPaint'], 11:17:21 INFO - 'tests': ['tp6_google', 11:17:21 INFO - 'tp6_youtube', 11:17:21 INFO - 'tp6_amazon', 11:17:21 INFO - 'tp6_facebook']}, 11:17:21 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:17:21 INFO - 'talos_options': ['--enable-stylo', 11:17:21 INFO - '--stylo-threads=1', 11:17:21 INFO - '--mitmproxy', 11:17:21 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:17:21 INFO - '--firstNonBlankPaint'], 11:17:21 INFO - 'tests': ['tp6_google', 11:17:21 INFO - 'tp6_youtube', 11:17:21 INFO - 'tp6_amazon', 11:17:21 INFO - 'tp6_facebook']}, 11:17:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:17:21 INFO - 'talos_options': ['--xperf_path', 11:17:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:17:21 INFO - 'tests': ['tp5n']}, 11:17:21 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:17:21 INFO - 'talos_options': ['--enable-stylo', 11:17:21 INFO - '--xperf_path', 11:17:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:17:21 INFO - 'tests': ['tp5n']}}} 11:17:21 INFO - Running post-action listener: _resource_record_post_action 11:17:21 INFO - [mozharness: 2017-08-31 18:17:21.427627Z] Finished populate-webroot step (success) 11:17:21 INFO - [mozharness: 2017-08-31 18:17:21.427715Z] Running create-virtualenv step. 11:17:21 INFO - Running pre-action listener: _resource_record_pre_action 11:17:21 INFO - Running main action method: create_virtualenv 11:17:21 INFO - Creating virtualenv /builds/slave/test/build/venv 11:17:21 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:17:21 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:17:21 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:17:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:17:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:17:22 INFO - Installing distribute.............................................................................................................................................................................................done. 11:17:22 INFO - Installing pip...............done. 11:17:22 INFO - Return code: 0 11:17:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:17:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:17:22 INFO - Reading from file tmpfile_stdout 11:17:22 INFO - Output received: 11:17:22 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:17:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:22 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 0x1d741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e3b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e0580>, '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 0x20e1480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e1910>, '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': 'af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:17:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:17:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:17:22 INFO - Using env: {'DISPLAY': ':0', 11:17:22 INFO - 'HOME': '/home/cltbld', 11:17:22 INFO - 'LANG': 'en_US.UTF-8', 11:17:22 INFO - 'LANGUAGE': 'en_US:en', 11:17:22 INFO - 'LOGNAME': 'cltbld', 11:17:22 INFO - 'MAIL': '/var/mail/cltbld', 11:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:22 INFO - 'MOZ_NO_REMOTE': '1', 11:17:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:22 INFO - 'NO_EM_RESTART': '1', 11:17:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:22 INFO - 'PWD': '/builds/slave/test', 11:17:22 INFO - 'SHELL': '/bin/bash', 11:17:22 INFO - 'SHLVL': '1', 11:17:22 INFO - 'TERM': 'linux', 11:17:22 INFO - 'TMOUT': '86400', 11:17:22 INFO - 'USER': 'cltbld', 11:17:22 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952', 11:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:22 INFO - '_': '/tools/buildbot/bin/python'} 11:17:23 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:17:23 INFO - Downloading/unpacking pip>=1.5 11:17:23 INFO - Running setup.py egg_info for package pip 11:17:23 INFO - warning: no files found matching 'pip/cacert.pem' 11:17:23 INFO - warning: no files found matching '*.html' under directory 'docs' 11:17:23 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:17:23 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:17:23 INFO - Installing collected packages: pip 11:17:23 INFO - Found existing installation: pip 1.1 11:17:23 INFO - Uninstalling pip: 11:17:23 INFO - Successfully uninstalled pip 11:17:23 INFO - Running setup.py install for pip 11:17:23 INFO - warning: no files found matching 'pip/cacert.pem' 11:17:23 INFO - warning: no files found matching '*.html' under directory 'docs' 11:17:23 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:17:23 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:17:23 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:17:23 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:17:23 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:17:23 INFO - Successfully installed pip 11:17:23 INFO - Cleaning up... 11:17:23 INFO - Return code: 0 11:17:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:17:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:23 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 0x1d741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e3b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e0580>, '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 0x20e1480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e1910>, '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': 'af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:17:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:17:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:17:23 INFO - Using env: {'DISPLAY': ':0', 11:17:23 INFO - 'HOME': '/home/cltbld', 11:17:23 INFO - 'LANG': 'en_US.UTF-8', 11:17:23 INFO - 'LANGUAGE': 'en_US:en', 11:17:23 INFO - 'LOGNAME': 'cltbld', 11:17:23 INFO - 'MAIL': '/var/mail/cltbld', 11:17:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:23 INFO - 'MOZ_NO_REMOTE': '1', 11:17:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:23 INFO - 'NO_EM_RESTART': '1', 11:17:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:23 INFO - 'PWD': '/builds/slave/test', 11:17:23 INFO - 'SHELL': '/bin/bash', 11:17:23 INFO - 'SHLVL': '1', 11:17:23 INFO - 'TERM': 'linux', 11:17:23 INFO - 'TMOUT': '86400', 11:17:23 INFO - 'USER': 'cltbld', 11:17:23 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952', 11:17:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:23 INFO - '_': '/tools/buildbot/bin/python'} 11:17:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:23 INFO - Downloading/unpacking psutil>=3.1.1 11:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:17:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:17:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:17:25 INFO - Installing collected packages: psutil 11:17:25 INFO - Running setup.py install for psutil 11:17:25 INFO - building 'psutil._psutil_linux' extension 11:17:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:17:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:17:25 INFO - building 'psutil._psutil_posix' extension 11:17:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:17:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:17:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:17:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:17:25 INFO - Successfully installed psutil 11:17:25 INFO - Cleaning up... 11:17:25 INFO - Return code: 0 11:17:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:25 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 0x1d741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e3b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e0580>, '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 0x20e1480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e1910>, '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': 'af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:17:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:17:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:17:25 INFO - Using env: {'DISPLAY': ':0', 11:17:25 INFO - 'HOME': '/home/cltbld', 11:17:25 INFO - 'LANG': 'en_US.UTF-8', 11:17:25 INFO - 'LANGUAGE': 'en_US:en', 11:17:25 INFO - 'LOGNAME': 'cltbld', 11:17:25 INFO - 'MAIL': '/var/mail/cltbld', 11:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:25 INFO - 'MOZ_NO_REMOTE': '1', 11:17:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:25 INFO - 'NO_EM_RESTART': '1', 11:17:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:25 INFO - 'PWD': '/builds/slave/test', 11:17:25 INFO - 'SHELL': '/bin/bash', 11:17:25 INFO - 'SHLVL': '1', 11:17:25 INFO - 'TERM': 'linux', 11:17:25 INFO - 'TMOUT': '86400', 11:17:25 INFO - 'USER': 'cltbld', 11:17:25 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952', 11:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:25 INFO - '_': '/tools/buildbot/bin/python'} 11:17:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:17:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:17:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:17:26 INFO - Installing collected packages: mozsystemmonitor 11:17:26 INFO - Running setup.py install for mozsystemmonitor 11:17:26 INFO - Successfully installed mozsystemmonitor 11:17:26 INFO - Cleaning up... 11:17:27 INFO - Return code: 0 11:17:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:17: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')]} 11:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17: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')]} 11:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17: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', '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 0x1d741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e3b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e0580>, '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 0x20e1480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e1910>, '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': 'af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:17: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:17: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 jsonschema==2.5.1 11:17:27 INFO - Using env: {'DISPLAY': ':0', 11:17:27 INFO - 'HOME': '/home/cltbld', 11:17:27 INFO - 'LANG': 'en_US.UTF-8', 11:17:27 INFO - 'LANGUAGE': 'en_US:en', 11:17:27 INFO - 'LOGNAME': 'cltbld', 11:17:27 INFO - 'MAIL': '/var/mail/cltbld', 11:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:27 INFO - 'MOZ_NO_REMOTE': '1', 11:17:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:27 INFO - 'NO_EM_RESTART': '1', 11:17:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:27 INFO - 'PWD': '/builds/slave/test', 11:17:27 INFO - 'SHELL': '/bin/bash', 11:17:27 INFO - 'SHLVL': '1', 11:17:27 INFO - 'TERM': 'linux', 11:17:27 INFO - 'TMOUT': '86400', 11:17:27 INFO - 'USER': 'cltbld', 11:17:27 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952', 11:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:27 INFO - '_': '/tools/buildbot/bin/python'} 11:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:27 INFO - Downloading/unpacking jsonschema==2.5.1 11:17: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 11:17: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 11:17: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 11:17: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 11:17:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:17:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:28 INFO - Downloading functools32-3.2.3-2.tar.gz 11:17:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:17:28 INFO - warning: no files found matching '*.txt' 11:17:28 INFO - no previously-included directories found matching 'build' 11:17:28 INFO - no previously-included directories found matching 'dist' 11:17:28 INFO - no previously-included directories found matching '.git*' 11:17:28 INFO - Installing collected packages: jsonschema, functools32 11:17:28 INFO - Running setup.py install for functools32 11:17:28 INFO - warning: no files found matching '*.txt' 11:17:28 INFO - no previously-included directories found matching 'build' 11:17:28 INFO - no previously-included directories found matching 'dist' 11:17:28 INFO - no previously-included directories found matching '.git*' 11:17:28 INFO - Successfully installed jsonschema functools32 11:17:28 INFO - Cleaning up... 11:17:28 INFO - Return code: 0 11:17:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:28 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 0x1d741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e3b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e0580>, '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 0x20e1480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e1910>, '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': 'af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:17:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:17:28 INFO - Using env: {'DISPLAY': ':0', 11:17:28 INFO - 'HOME': '/home/cltbld', 11:17:28 INFO - 'LANG': 'en_US.UTF-8', 11:17:28 INFO - 'LANGUAGE': 'en_US:en', 11:17:28 INFO - 'LOGNAME': 'cltbld', 11:17:28 INFO - 'MAIL': '/var/mail/cltbld', 11:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:28 INFO - 'MOZ_NO_REMOTE': '1', 11:17:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:28 INFO - 'NO_EM_RESTART': '1', 11:17:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:28 INFO - 'PWD': '/builds/slave/test', 11:17:28 INFO - 'SHELL': '/bin/bash', 11:17:28 INFO - 'SHLVL': '1', 11:17:28 INFO - 'TERM': 'linux', 11:17:28 INFO - 'TMOUT': '86400', 11:17:28 INFO - 'USER': 'cltbld', 11:17:28 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952', 11:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:28 INFO - '_': '/tools/buildbot/bin/python'} 11:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:17:28 INFO - Cleaning up... 11:17:28 INFO - Return code: 0 11:17:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:28 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 0x1d741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e3b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e0580>, '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 0x20e1480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e1910>, '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': 'af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:17:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:17:28 INFO - Using env: {'DISPLAY': ':0', 11:17:28 INFO - 'HOME': '/home/cltbld', 11:17:28 INFO - 'LANG': 'en_US.UTF-8', 11:17:28 INFO - 'LANGUAGE': 'en_US:en', 11:17:28 INFO - 'LOGNAME': 'cltbld', 11:17:28 INFO - 'MAIL': '/var/mail/cltbld', 11:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:28 INFO - 'MOZ_NO_REMOTE': '1', 11:17:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:28 INFO - 'NO_EM_RESTART': '1', 11:17:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:28 INFO - 'PWD': '/builds/slave/test', 11:17:28 INFO - 'SHELL': '/bin/bash', 11:17:28 INFO - 'SHLVL': '1', 11:17:28 INFO - 'TERM': 'linux', 11:17:28 INFO - 'TMOUT': '86400', 11:17:28 INFO - 'USER': 'cltbld', 11:17:28 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952', 11:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:28 INFO - '_': '/tools/buildbot/bin/python'} 11:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:29 INFO - Downloading/unpacking blobuploader==1.2.4 11:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:30 INFO - Downloading blobuploader-1.2.4.tar.gz 11:17:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:17:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:17:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:31 INFO - Downloading docopt-0.6.1.tar.gz 11:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:17:31 INFO - Installing collected packages: blobuploader, requests, docopt 11:17:31 INFO - Running setup.py install for blobuploader 11:17:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:17:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:17:31 INFO - Running setup.py install for requests 11:17:31 INFO - Running setup.py install for docopt 11:17:31 INFO - Successfully installed blobuploader requests docopt 11:17:31 INFO - Cleaning up... 11:17:31 INFO - Return code: 0 11:17:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17: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')]} 11:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17: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')]} 11:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:31 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 0x1d741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e3b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e0580>, '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 0x20e1480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e1910>, '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': 'af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:17:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:17:31 INFO - Using env: {'DISPLAY': ':0', 11:17:31 INFO - 'HOME': '/home/cltbld', 11:17:31 INFO - 'LANG': 'en_US.UTF-8', 11:17:31 INFO - 'LANGUAGE': 'en_US:en', 11:17:31 INFO - 'LOGNAME': 'cltbld', 11:17:31 INFO - 'MAIL': '/var/mail/cltbld', 11:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:31 INFO - 'MOZ_NO_REMOTE': '1', 11:17:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:31 INFO - 'NO_EM_RESTART': '1', 11:17:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:31 INFO - 'PWD': '/builds/slave/test', 11:17:31 INFO - 'SHELL': '/bin/bash', 11:17:31 INFO - 'SHLVL': '1', 11:17:31 INFO - 'TERM': 'linux', 11:17:31 INFO - 'TMOUT': '86400', 11:17:31 INFO - 'USER': 'cltbld', 11:17:31 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952', 11:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:31 INFO - '_': '/tools/buildbot/bin/python'} 11:17:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:17:31 INFO - Running setup.py (path:/tmp/pip-qEwK9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:17:31 INFO - Running setup.py (path:/tmp/pip-81j8NI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:17:32 INFO - Running setup.py (path:/tmp/pip-FBdboF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:17:32 INFO - Running setup.py (path:/tmp/pip-uD1_oC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:17:32 INFO - Running setup.py (path:/tmp/pip-OVLTTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:17:32 INFO - Running setup.py (path:/tmp/pip-PhggNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:17:32 INFO - Running setup.py (path:/tmp/pip-LWoJRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:17:32 INFO - Running setup.py (path:/tmp/pip-KKPGTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:17:32 INFO - Running setup.py (path:/tmp/pip-CQHwqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:17:32 INFO - Running setup.py (path:/tmp/pip-nSFL8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:17:32 INFO - Running setup.py (path:/tmp/pip-xO3K06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:17:32 INFO - Running setup.py (path:/tmp/pip-iYCp_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:17:32 INFO - Running setup.py (path:/tmp/pip-5ecQVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:17:32 INFO - Running setup.py (path:/tmp/pip-eFyD4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:32 INFO - Running setup.py (path:/tmp/pip-hwEmO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:17:32 INFO - Running setup.py (path:/tmp/pip-Gd56iP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:17:33 INFO - Running setup.py (path:/tmp/pip-WuIdJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:17:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:17:33 INFO - Running setup.py install for manifestparser 11:17:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:17:33 INFO - Running setup.py install for mozcrash 11:17:33 INFO - Running setup.py install for mozdebug 11:17:33 INFO - Running setup.py install for mozdevice 11:17:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:17:33 INFO - Running setup.py install for mozfile 11:17:33 INFO - Running setup.py install for mozhttpd 11:17:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:17:33 INFO - Running setup.py install for mozinfo 11:17:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:17:33 INFO - Running setup.py install for mozInstall 11:17:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:17:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:17:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:17:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:17:33 INFO - Running setup.py install for mozleak 11:17:33 INFO - Running setup.py install for mozlog 11:17:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:17:34 INFO - Running setup.py install for moznetwork 11:17:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:17:34 INFO - Running setup.py install for mozprocess 11:17:34 INFO - Running setup.py install for mozprofile 11:17:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:17:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:17:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:17:34 INFO - Running setup.py install for mozrunner 11:17:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:17:34 INFO - Running setup.py install for mozscreenshot 11:17:34 INFO - Running setup.py install for moztest 11:17:34 INFO - Running setup.py install for mozversion 11:17:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:17:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:17:34 INFO - Cleaning up... 11:17:34 INFO - Return code: 0 11:17:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:34 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 0x1d741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e3b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e0580>, '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 0x20e1480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e1910>, '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': 'af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:17:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:17:34 INFO - Using env: {'DISPLAY': ':0', 11:17:34 INFO - 'HOME': '/home/cltbld', 11:17:34 INFO - 'LANG': 'en_US.UTF-8', 11:17:34 INFO - 'LANGUAGE': 'en_US:en', 11:17:34 INFO - 'LOGNAME': 'cltbld', 11:17:34 INFO - 'MAIL': '/var/mail/cltbld', 11:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:34 INFO - 'MOZ_NO_REMOTE': '1', 11:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:34 INFO - 'NO_EM_RESTART': '1', 11:17:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:34 INFO - 'PWD': '/builds/slave/test', 11:17:34 INFO - 'SHELL': '/bin/bash', 11:17:34 INFO - 'SHLVL': '1', 11:17:34 INFO - 'TERM': 'linux', 11:17:34 INFO - 'TMOUT': '86400', 11:17:34 INFO - 'USER': 'cltbld', 11:17:34 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952', 11:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:34 INFO - '_': '/tools/buildbot/bin/python'} 11:17:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:17:35 INFO - Running setup.py (path:/tmp/pip-Zdx9t7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:17:35 INFO - Running setup.py (path:/tmp/pip-Og1kQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:17:35 INFO - Running setup.py (path:/tmp/pip-WnSRUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:17:35 INFO - Running setup.py (path:/tmp/pip-9oH6dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:17:35 INFO - Running setup.py (path:/tmp/pip-xnAevY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:17:35 INFO - Running setup.py (path:/tmp/pip-xE1Cf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:17:35 INFO - Running setup.py (path:/tmp/pip-05Yvu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:17:35 INFO - Running setup.py (path:/tmp/pip-w8w2St-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:17:35 INFO - Running setup.py (path:/tmp/pip-oNPsHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:17:35 INFO - Running setup.py (path:/tmp/pip-pz3ImP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:17:35 INFO - Running setup.py (path:/tmp/pip-aC5J6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:17:35 INFO - Running setup.py (path:/tmp/pip-LC39bE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:17:35 INFO - Running setup.py (path:/tmp/pip-6sjcF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:17:36 INFO - Running setup.py (path:/tmp/pip-ynhF0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:36 INFO - Running setup.py (path:/tmp/pip-EA7nHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:17:36 INFO - Running setup.py (path:/tmp/pip-2Us2N3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:17:36 INFO - Running setup.py (path:/tmp/pip-EsY9r_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:17:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:17: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 11:17: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 11:17: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 11:17: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 11:17:37 INFO - Downloading blessings-1.6.tar.gz 11:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:17:37 INFO - Installing collected packages: blessings 11:17:37 INFO - Running setup.py install for blessings 11:17:37 INFO - Successfully installed blessings 11:17:37 INFO - Cleaning up... 11:17:37 INFO - Return code: 0 11:17:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:17:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:37 INFO - Reading from file tmpfile_stdout 11:17:37 INFO - Current package versions: 11:17:37 INFO - argparse == 1.2.1 11:17:37 INFO - blessings == 1.6 11:17:37 INFO - blobuploader == 1.2.4 11:17:37 INFO - docopt == 0.6.1 11:17:37 INFO - functools32 == 3.2.3-2 11:17:37 INFO - jsonschema == 2.5.1 11:17:37 INFO - manifestparser == 1.1 11:17:37 INFO - mozInstall == 1.13 11:17:37 INFO - mozcrash == 1.0 11:17:37 INFO - mozdebug == 0.1 11:17:37 INFO - mozdevice == 0.51 11:17:37 INFO - mozfile == 1.2 11:17:37 INFO - mozhttpd == 0.7 11:17:37 INFO - mozinfo == 0.10 11:17:37 INFO - mozleak == 0.1 11:17:37 INFO - mozlog == 3.5 11:17:37 INFO - moznetwork == 0.27 11:17:37 INFO - mozprocess == 0.25 11:17:37 INFO - mozprofile == 0.28 11:17:37 INFO - mozrunner == 6.13 11:17:37 INFO - mozscreenshot == 0.1 11:17:37 INFO - mozsystemmonitor == 0.3 11:17:37 INFO - moztest == 0.8 11:17:37 INFO - mozversion == 1.4 11:17:37 INFO - psutil == 3.1.1 11:17:37 INFO - requests == 1.2.3 11:17:37 INFO - wsgiref == 0.1.2 11:17:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17: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')]} 11:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17: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')]} 11:17:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:37 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 0x1d741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e3b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e0580>, '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 0x20e1480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e1910>, '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': 'af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:17:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:17:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:17:37 INFO - Using env: {'DISPLAY': ':0', 11:17:37 INFO - 'HOME': '/home/cltbld', 11:17:37 INFO - 'LANG': 'en_US.UTF-8', 11:17:37 INFO - 'LANGUAGE': 'en_US:en', 11:17:37 INFO - 'LOGNAME': 'cltbld', 11:17:37 INFO - 'MAIL': '/var/mail/cltbld', 11:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:37 INFO - 'MOZ_NO_REMOTE': '1', 11:17:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:37 INFO - 'NO_EM_RESTART': '1', 11:17:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:37 INFO - 'PWD': '/builds/slave/test', 11:17:37 INFO - 'SHELL': '/bin/bash', 11:17:37 INFO - 'SHLVL': '1', 11:17:37 INFO - 'TERM': 'linux', 11:17:37 INFO - 'TMOUT': '86400', 11:17:37 INFO - 'USER': 'cltbld', 11:17:37 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952', 11:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:37 INFO - '_': '/tools/buildbot/bin/python'} 11:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:17:38 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:17:39 INFO - Installing collected packages: simplejson 11:17:39 INFO - Running setup.py install for simplejson 11:17:39 INFO - building 'simplejson._speedups' extension 11:17:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:17:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:17:40 INFO - Successfully installed simplejson 11:17:40 INFO - Cleaning up... 11:17:40 INFO - Return code: 0 11:17:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:17: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')]} 11:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17: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')]} 11:17:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:40 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 0x1d741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e3b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e0580>, '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 0x20e1480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e1910>, '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': 'af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:17:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:17:40 INFO - Using env: {'DISPLAY': ':0', 11:17:40 INFO - 'HOME': '/home/cltbld', 11:17:40 INFO - 'LANG': 'en_US.UTF-8', 11:17:40 INFO - 'LANGUAGE': 'en_US:en', 11:17:40 INFO - 'LOGNAME': 'cltbld', 11:17:40 INFO - 'MAIL': '/var/mail/cltbld', 11:17:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:40 INFO - 'MOZ_NO_REMOTE': '1', 11:17:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:40 INFO - 'NO_EM_RESTART': '1', 11:17:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:40 INFO - 'PWD': '/builds/slave/test', 11:17:40 INFO - 'SHELL': '/bin/bash', 11:17:40 INFO - 'SHLVL': '1', 11:17:40 INFO - 'TERM': 'linux', 11:17:40 INFO - 'TMOUT': '86400', 11:17:40 INFO - 'USER': 'cltbld', 11:17:40 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952', 11:17:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:40 INFO - '_': '/tools/buildbot/bin/python'} 11:17:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:17:40 INFO - Cleaning up... 11:17:40 INFO - Return code: 0 11:17:40 INFO - Running post-action listener: _resource_record_post_action 11:17:40 INFO - Running post-action listener: _start_resource_monitoring 11:17:40 INFO - Starting resource monitoring. 11:17:40 INFO - [mozharness: 2017-08-31 18:17:40.551506Z] Finished create-virtualenv step (success) 11:17:40 INFO - [mozharness: 2017-08-31 18:17:40.552117Z] Running install step. 11:17:40 INFO - Running pre-action listener: _resource_record_pre_action 11:17:40 INFO - Running main action method: install 11:17:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:40 INFO - Reading from file tmpfile_stdout 11:17:40 INFO - Detecting whether we're running mozinstall >=1.0... 11:17:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:17:40 INFO - Reading from file tmpfile_stdout 11:17:40 INFO - Output received: 11:17:40 INFO - Usage: mozinstall [options] installer 11:17:40 INFO - Options: 11:17:40 INFO - -h, --help show this help message and exit 11:17:40 INFO - -d DEST, --destination=DEST 11:17:40 INFO - Directory to install application into. [default: 11:17:40 INFO - "/builds/slave/test"] 11:17:40 INFO - --app=APP Application being installed. [default: firefox] 11:17:40 INFO - mkdir: /builds/slave/test/build/application 11:17:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:17:57 INFO - Reading from file tmpfile_stdout 11:17:57 INFO - Output received: 11:17:57 INFO - /builds/slave/test/build/application/firefox/firefox 11:17:57 INFO - Running post-action listener: _resource_record_post_action 11:17:57 INFO - [mozharness: 2017-08-31 18:17:57.401679Z] Finished install step (success) 11:17:57 INFO - [mozharness: 2017-08-31 18:17:57.401962Z] Running setup-mitmproxy step. 11:17:57 INFO - Running pre-action listener: _resource_record_pre_action 11:17:57 INFO - Running main action method: setup_mitmproxy 11:17:57 INFO - Skipping: mitmproxy is not required 11:17:57 INFO - Running post-action listener: _resource_record_post_action 11:17:57 INFO - [mozharness: 2017-08-31 18:17:57.403095Z] Finished setup-mitmproxy step (success) 11:17:57 INFO - [mozharness: 2017-08-31 18:17:57.403314Z] Running run-tests step. 11:17:57 INFO - Running pre-action listener: _resource_record_pre_action 11:17:57 INFO - Running pre-action listener: _set_gcov_prefix 11:17:57 INFO - Running main action method: run_tests 11:17:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:17:57 INFO - Python 2.7.3 11:17:57 INFO - Return code: 0 11:17:57 INFO - grabbing minidump binary from tooltool 11:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:57 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 0x20e0580>, '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 0x20e1480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e1910>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:17:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:17:57 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:17:57 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:17:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:17:57 INFO - Return code: 0 11:17:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:17:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:17:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:17:57 INFO - ENV: RUST_BACKTRACE is now full 11:17:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:17:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:17:57 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/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:17:57 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/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:17:57 INFO - Using env: {'DISPLAY': ':0', 11:17:57 INFO - 'HOME': '/home/cltbld', 11:17:57 INFO - 'LANG': 'en_US.UTF-8', 11:17:57 INFO - 'LANGUAGE': 'en_US:en', 11:17:57 INFO - 'LOGNAME': 'cltbld', 11:17:57 INFO - 'MAIL': '/var/mail/cltbld', 11:17:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:17:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:57 INFO - 'MOZ_NO_REMOTE': '1', 11:17:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:57 INFO - 'NO_EM_RESTART': '1', 11:17:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:57 INFO - 'PWD': '/builds/slave/test', 11:17:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:17:57 INFO - 'RUST_BACKTRACE': 'full', 11:17:57 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:17:57 INFO - 'SHELL': '/bin/bash', 11:17:57 INFO - 'SHLVL': '1', 11:17:57 INFO - 'STYLO_FORCE_ENABLED': '1', 11:17:57 INFO - 'TERM': 'linux', 11:17:57 INFO - 'TMOUT': '86400', 11:17:57 INFO - 'USER': 'cltbld', 11:17:57 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952', 11:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:57 INFO - '_': '/tools/buildbot/bin/python'} 11:17:57 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/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:17:57 INFO - mozversion application_buildid: 20170831172745 11:17:57 INFO - mozversion application_changeset: 4984da22242841a5d84c4e5fd866e93a450d9723 11:17:57 INFO - mozversion application_display_name: Nightly 11:17:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:17:57 INFO - mozversion application_name: Firefox 11:17:57 INFO - mozversion application_remotingname: firefox 11:17:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:17:57 INFO - mozversion application_vendor: Mozilla 11:17:57 INFO - mozversion application_version: 57.0a1 11:17:57 INFO - mozversion platform_buildid: 20170831172745 11:17:57 INFO - mozversion platform_changeset: 4984da22242841a5d84c4e5fd866e93a450d9723 11:17:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:17:57 INFO - mozversion platform_version: 57.0a1 11:17:57 INFO - using testdate: 1504203477 11:17:57 INFO - actual date: 1504203477 11:17:57 INFO - starting webserver on 'localhost:48577' 11:17:57 INFO - SUITE-START | Running 2 tests 11:17:57 INFO - TEST-START | dromaeo_css 11:17:57 INFO - Initialising browser for dromaeo_css test... 11:17:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48577/getInfo.html -profile /tmp/tmpoPtzjx/profile 11:17:57 INFO - TEST-INFO | started process 20427 (/builds/slave/test/build/application/firefox/firefox http://localhost:48577/getInfo.html) 11:18:04 INFO - TEST-INFO | 20427: exit 0 11:18:04 INFO - Browser initialized. 11:18:04 INFO - Running cycle 1/1 for dromaeo_css test... 11:18:04 INFO - Using env: {'DISPLAY': ':0', 11:18:04 INFO - 'HOME': '/home/cltbld', 11:18:04 INFO - 'JSGC_DISABLE_POISONING': '1', 11:18:04 INFO - 'LANG': 'en_US.UTF-8', 11:18:04 INFO - 'LANGUAGE': 'en_US:en', 11:18:04 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:18:04 INFO - 'LOGNAME': 'cltbld', 11:18:04 INFO - 'MAIL': '/var/mail/cltbld', 11:18:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:18:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:18:04 INFO - 'MOZ_CRASHREPORTER': '1', 11:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:04 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:18:04 INFO - 'MOZ_NO_REMOTE': '1', 11:18:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:04 INFO - 'NO_EM_RESTART': '1', 11:18:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:04 INFO - 'PWD': '/builds/slave/test', 11:18:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:18:04 INFO - 'RUST_BACKTRACE': 'full', 11:18:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:18:04 INFO - 'SHELL': '/bin/bash', 11:18:04 INFO - 'SHLVL': '1', 11:18:04 INFO - 'STYLO_FORCE_ENABLED': '1', 11:18:04 INFO - 'TERM': 'linux', 11:18:04 INFO - 'TMOUT': '86400', 11:18:04 INFO - 'USER': 'cltbld', 11:18:04 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952', 11:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:04 INFO - '_': '/tools/buildbot/bin/python'} 11:18:04 INFO - TEST-INFO | started process 20629 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoPtzjx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:18:05 INFO - PID 20629 | 11:18:05 INFO - PID 20629 | (/builds/slave/test/build/application/firefox/firefox:20681): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:18:05 INFO - PID 20629 | 11:18:15 INFO - PID 20629 | RSS: Main: 171249664 11:18:15 INFO - PID 20629 | 11:21:14 INFO - PID 20629 | Cycle 1(1): loaded http://localhost:48577/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48577/tests/dromaeo/cssquery-ext.html) 11:21:15 INFO - PID 20629 | RSS: Main: 173998080 11:21:15 INFO - PID 20629 | 11:24:17 INFO - PID 20629 | Cycle 1(1): loaded http://localhost:48577/tests/dromaeo/cssquery-ext.html (next: http://localhost:48577/tests/dromaeo/cssquery-jquery.html) 11:24:17 INFO - PID 20629 | RSS: Main: 170504192 11:24:17 INFO - PID 20629 | 11:27:19 INFO - PID 20629 | Cycle 1(1): loaded http://localhost:48577/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48577/tests/dromaeo/cssquery-mootools.html) 11:27:19 INFO - PID 20629 | RSS: Main: 172650496 11:27:19 INFO - PID 20629 | 11:30:21 INFO - PID 20629 | Cycle 1(1): loaded http://localhost:48577/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48577/tests/dromaeo/cssquery-prototype.html) 11:30:22 INFO - PID 20629 | RSS: Main: 171057152 11:30:22 INFO - PID 20629 | 11:33:25 INFO - PID 20629 | Cycle 1(1): loaded http://localhost:48577/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48577/tests/dromaeo/cssquery-yui.html) 11:33:26 INFO - PID 20629 | RSS: Main: 171925504 11:33:26 INFO - PID 20629 | 11:36:28 INFO - PID 20629 | Cycle 1(1): loaded http://localhost:48577/tests/dromaeo/cssquery-yui.html (next: http://localhost:48577/tests/dromaeo/cssquery-dojo.html) 11:36:28 INFO - PID 20629 | RSS: Main: 173309952 11:36:28 INFO - PID 20629 | 11:36:28 INFO - PID 20629 | __start_tp_report 11:36:28 INFO - PID 20629 | _x_x_mozilla_page_load 11:36:28 INFO - PID 20629 | _x_x_mozilla_page_load_details 11:36:28 INFO - PID 20629 | |i|pagename|runs| 11:36:28 INFO - PID 20629 | |0;dojo.html;3268.4280250956076;3309.817960012199;3330.3172849565835;3332.233586275155;3367.7810942288747;6239.812805615833;6305.054241863717;6400.871982560346;6434.420902118803;6437.0988061671405;6137.41694539018;6224.470919971808;6235.251769787632;6254.562180647356;6307.3692630736905;5777.768889244446;5792.7972520961775;5824.446677565625;5861;5925.140854576084;5915.822525324247;5922.289325280973;5932.9703351483395;5934.525237980951;5938.52491800657;5800.4489573490455;5822.7088645567765;5875.88248235035;5878.970605146968;5969.731362088716;5430.945690543083;5820.708964551798;5878.647281163144;5948.672822994734;5969.373215812364;5703.030484817591;5762.654240745569;5774.797882074149;5798.449147330997;5807.970960145214;6211.223597050369;6251.906221406683;6263.24841019076;6272.1219029335925;6277.246730392382;6688.86622267552;6777.322267773233;6786.4570834333135;6790.3888650021245;6801.931980680229;6781.728730850809;6785.898211526782;6789.490788190906;6857.177138743333;6883.0019647151385;6180.81457556274;6266.342034086447;6269.686515674198;6275.7489700411925;6283;6949.235584085746;6983.615901125385;7045.154581450259;7074.823129421703;7094.148702155671;6666.866662666816;6691.498137639696;6700.564463309869;6750.696218670171;6772.255051944282;6788.626625535643;6800.625965571842;6826.931730682729;6856.177258728885;6890.2420733719255;6690;6776.220734615484;6808.659567021629;6815.079964204868;6855.7600483983815;6505.4795616350575;6808.08090907731;6886.621235832077;6888.173419189729;6889.793306200822;5257;5276.366835979707;5278.630495865329;5294.364676238876;5344.465553444625;4656.32483289921;4698.412698412699;4702.177119004161;4702.177119004161;4704;5899.970500147472;5911.645301281937;5972.581919265696;5999.5800293979;6001.4298641628975;6560;6643.136392269071;6751.763688270887;6859.588424694434;6891.620960847101;5797.449242321973;5821;5831.650100993954;5846.327672317653;5930.813837232485;5745.052066409079;5746.9712651436475;5748.425157484218;5769.336526299529;5771.711414429262;6345.460635846005;6442.033694945796;6524.641144737085;6528.836779080466;6542.084108224853;6636.037774522763;6663.966680166568;6730.528862979544;6746.123004009545;6751.93248067513;6407.8398040047505;6538.051982462612;6548.574342667712;6657.800265992028;6673.799786006428;6708.765193218214;6792.117024786746;6810.216825065181;6815.829604259933;6820.420264277592;6818.147731533559;6824.761133360308;6841.931580684329;6933.445324374139;6939.340762627542;6518.967405162944;6559.967200163968;6588.934110659024;6648.0360347750275;6683.264840867598;6558.770443034471;6654.933450665431;6670.866582668223;6686.297938716365;6692.732290708512;6341.841453963688;6464.127342808661;6550.934490655223;6556.8360790978695;6557.573757705733;6419;6586.209654841449;6642.236142843635;6662.766803161866;6704.765333213314;6333.493320534254;6375.362463753588;6452.935470645233;6476.676166191577;6489.837754055998 11:36:28 INFO - PID 20629 | |1;ext.html;812.8821320908469;852.76122685648;872.9083446238143;879.1823604048233;1129.5143088471964;30160.849195754017;30664.540031899538;40338.798306008466;41093;41197.38203926943;40696;41033;41116.17767644645;41146.17707645845;41214.58785412153;7519.210482899299;7624.970628965074;7834.05991281047;7875.960620196891;7884.921150788476;7628.771136865875;7758.728444504443;7760.844783104363;7765.06819181699;7774.883376749353;7732.381409487228;7790.80522986927;7795;7799.5710235937;7822.139564647884;7767.145613982458;7810.9609451952665;7813.531188128731;7813.570253636048;7816.72641457552;7625.961870190669;7686.039245094364;7686.1160966489015;7688.1543030267185;7693.115291741466;36865.63134368649;36968.44547331792;37098.62901371006;37109;37189.25621487582;3526.1713497328105;3563.073600863768;3563.9109022274392;3564.376234159012;3565.5186549815962;31197.064088077394;31214.53178202329;31224.375512489623;31253.53119703206;31339.686603133905;5010.0981823271795;5156.587473002151;5197.454267301917;5198.662086964335;5230.241614965808;193468;193964;194069.2075777341;194586;195449;46828.7658561705;46852;47001;47027.52972470231;48268.27597586039;50979;51151.23273150906;51291.23063154056;51345.486545134816;51370.14723895648;15063.397464101314;15200.391984320724;15209.391624335123;15216.239188040554;15367.692646147014;12159.756804863853;12195.512179512898;12209.816852747215;12231.082668799698;12244.326562039174;14483.203423811581;14491.710165796625;14589.12465252067;14606.634834129232;14676.926615366854;5722.141678748138;5730.19777231188;5808.970955145197;5853.151293062482;5902.527797776168;987.1855719031828;1009.5305682857506;1027.8406846938738;1031.6750223679667;1033.9327943683636;22808.20171293997;22888.65667014996;22920.541589168122;23074.538509229722;23601.29196124119;1093.830456279278;1106.1537923488538;1108.6563165418745;1113.5156207049797;1121.0527104596604;12053.939730301292;12140.514379424902;12431.937840310922;15455.012699537356;15745.897787154789;233895;235531;235594;235889;236187;55288.17067743987;55783;56003.43996559982;56006.719966399905;56041.439585604436;1403.39653948803;1442.2212005516903;1449.3622805965342;1464.1215270837624;1471.0805746408494;26741.06406275771;26834.194974150807;27148.592771108844;27388.589171162846;27454.5881811769;37899.24201515899;37976;37999.62000379961;38000.42999355067;47315.76342118267;209669;211084;211312;211898;212172;35228.11929701778;35467.29065418729;35611.465828012086;35633.28733425369;35656.64343356533;42447;42547.787261063495;42785.358219626105;42858.571414285456;43122.353164703185;32257.51613725843;32391;33249.833750831094;34423;34633.826830865684;33109.17227069246;33454.4981825268;33757.83121084379;33766;34213;37515.249695006496;37543.43684844675;37901.24197516089;38063.61936380601;38272.42591361076;32645.836770816943;32781.83609081939;32891.34217315688;33591.83204083964;33843.3231335367;24017.27948161558;24022;24778.752212478365;24962;25045 11:36:28 INFO - PID 20629 | |2;jquery.html;562.280281240013;563.7801257509572;567.9346875109363;579.0995002770693;584.4885724990634;21535.461613459673;22161;22325.44186395339;22363.10547578099;22386.664200037012;24948;25480.490390192186;25534.48931021383;25550.488990220183;25563.36091597711;6366.204224471941;6506.219253689564;6513.772017979371;6514.7719829805965;6515.0553169790355;6027.09593560965;6482.902756458633;6528.869422611545;6562.278149403562;6599.472042236634;6568.211814582257;6570.080188773575;6571.638559879205;6574.967125164368;6582;6539.77110801122;6548.377904099127;6561.081448597224;6571.3757193066585;6581.670916454158;6082;6082.60463069899;6088.269407671108;6100.847478813021;6105.053716673922;27411.86294068537;27973.72026279752;28532;28989.56515652267;29078.563821542695;1991.8306943909786;2019.8081182287658;2022.4539374368985;2024.7772744998038;2029.4824819671037;18742.531436714056;19365.4190374289;19405.61188776231;19426.4172074838;19429.319973800848;2180.7274090738656;2210.7015552900475;2241.5965126277265;2250.909963601454;2262.5248697773486;128543;134949.3252533741;135384;135636;136359;13617.727645447234;14237.85762142386;14506.709865802624;14527.564173074825;14674.633134171518;22299.77700222977;22375.440613984454;22881.88559057194;22976.540469190524;23048.539029219322;9765.658201962897;9829.80340393188;9895.455749933823;9900;10045.095941365313;8916.777080572907;8940.41887277338;9005.05446928063;9041.593128309241;9134.497602631785;8771.254443372258;8961.193492585568;9022.954885225532;9108.134727200906;9176.678816241532;2558.260382939619;2562.2441379793004;2632.552466080771;2667.7198894116227;2732.9502872845364;972.2950860626131;980.9362391444533;986.8223719730518;989.5794287427815;996.9551370188359;19217.90391048036;19514.414567562995;19851.30520431778;19887.204511819655;20040.098195581235;987.9209663226925;1027.2809033676456;1039.927205095651;1047.4134484688598;1048.7954848804409;10736.94631526853;10858.782824343627;10900.50947707355;10929.289596176222;11098.944505277583;444136;444274;462485;469067;472922;108031.45984270185;111107;112067;112321;115148;1155.6764106050318;1168.4449886304108;1195.229077245172;1195.503865895661;1205.0841360565857;17139.91430042842;17579.736303955706;17733.11334433299;17775.822241777416;17793.37723179734;50599.241011384125;52323.47676523186;52835.735821320646;53300.200496993355;53467.4653253478;62280.377196227455;62693.37306627058;63448;63587.682061589396;66771;13901.37443815051;14301.713965720419;14315;14321.57035288943;14343.641408964859;20064.59870802605;20415.897920510302;20443.182272708924;20478;21107.155713771892;15938.442154524537;15946.88371813962;16256.837431625532;16261.105639189958;16266.918665406598;14268.928655356656;14413.423463061361;14433.35049922777;15022;15430.151341676315;16627.50117496477;16891.239894204544;16997.660046799243;17001.744973825156;17002.14989250557;14196.92901535527;14216.431342746175;14221.928890355483;14227.07524010936;14245.358958847084;16780.748288775434;17343.306267749653;17361.392351267645;17364.826351736825;17394.73907891408 11:36:28 INFO - PID 20629 | |3;mootools.html;1339.4173534512486;1381.9654508637284;1388.8958328125393;1393.0527241475795;1394.623451668049;15228.467003654874;15493.690126197469;15908.204589770508;15908.84091159088;15918.124503152321;15956.76064859028;16179.110148941803;16193.433229836928;16199.676006479864;16237.83762162378;2761.295869553261;2797.5384061629907;2799.1042866282796;2803.887844486218;2807.7332653397893;2701.0951331304036;2714.9592756108673;2742.3555464465835;2793.553031514958;2798;2730.494858451193;2757.4485102979384;2757.806953513255;2759.4205216904475;2759.558470644697;2638.736126387365;2662.773664238542;2673.652425184723;2680.142354446578;2681.3698780786403;2670.9332266693295;2687.0058078511074;2690.6636670416196;2704.1752265559;2713.131797824697;15346.386144554204;15686.529404117895;15694.450694225647;15743.527694169194;15759.842401575952;7987.440879138463;8273.048599411024;8278.213569710868;8282.213189746964;8298.796674482226;5275.182346736262;5475.945240547623;5534.640248383883;5630.887382252332;5675.801346952878;1833.1292635997927;1853.6848735714825;1855.2486243071578;1888.9716654250196;1896.9525761856064;27106.45787084267;27345.31636709078;27367.04215352473;27381.86309068482;27413.86293068542;6921.550099243533;6934.167899851949;6966.895496567556;7085.397741191953;7092.361687448051;17414.303427862742;17419.129043548026;17447.127643618023;17470.912645436692;17512.21195046226;7775.4168437367425;8035.437519373588;8036.316913062338;8040.115587285394;8042.758717238492;7381.261873812576;7400.481966262418;7435.85128297431;7529.322360987538;7537.660805263777;4989.401271847401;5241.633085683966;5248.58011359098;5269.262303277545;5286.9471305287225;1293.6313150751992;1325.6288239293012;1510.2524250496074;1517.87856971442;1553.937842486288;870.3950754225752;875.3172525430175;887.2768693514765;896.050186801992;903.3495882964255;8675.56622168889;8878.600462979182;8884.067172946876;8884.955575222211;8955.238804701674;945.7541039329824;983.955721992512;989.9851502227473;1005.6882366466418;1026.5226669598671;4810.182269014276;5356.250124982427;5470.425605311465;5623.3533143689;5647.717614119278;21633.13467461284;21833.781662183494;22785.088596455957;22800.771992279864;22827.771722282898;22261.888690556767;22451.663225051638;22719.545609087727;22745.886270568873;22775.658365124535;11200.831987520194;11567.88432115685;11780.528778848922;11854.822177667342;11889.940550297366;8533.786655333419;8981.775455613662;9128.406653567497;9137.269018478373;9275;18809.24763009519;19076.236950521823;19191.32830350931;19417.70873436928;19719.802801971797;19388.4183474496;19522.20606108854;19840.305589304306;19860.304889328803;20316;11629.825552616549;11947.283163010246;11962.222455540363;11963.461644225858;11967.760644786882;14327.212003339917;14385.85614143887;14446.711065778416;14465.566033019026;14627.853721462649;11565.132615053737;11744.412779361168;11789.056875450115;11959.641210763692;12021.939890300493;11127.833082503606;11218.607348742755;11249.156313276373;11447.771044579229;11529.1929564933;9146.176844083799;9163.496007719372;9280.303977201871;9301.441913485212;9411.152996230372;6830.453563714792;6842.623655698984;6906.516543842084;6943.785312145702;7049.929500704928;7017.7192912282935;7057.36483716468;7074.610896400747;7095.148582170173;7187 11:36:28 INFO - PID 20629 | |4;prototype.html;490.9633914240422;503.93448851649305;527.5963887625965;528.197140346673;529.7192487981368;6354.968225158879;6389.680515974206;6394.7761828336015;6404.391582799638;6407.711652975616;6079.817605471843;6248.84377890553;6255.186825712651;6260.154879091321;6265.780697675582;4974.651774375795;4992.975035124819;4998.825041123561;5004.799808007684;5040.445550989388;4935.679180853251;4967.652264341479;4994.500549945013;5000.874978125557;5023.572996295301;4825.782839772201;4935.6545041847085;4938.80244790208;4939.50604939505;4951.232558953368;4941.50584941503;4942.406911170665;4942.752862356868;4964.982178653368;4996.575291100243;4442.73343599385;4460.933086003713;4462.910741785178;4477.574630410106;4490.685652004361;6214.720337584774;6261.937380626181;6263.937360626426;6265.373462653698;6279.147651442835;5648.43515648436;5648.830535083954;5654.943450565483;5662.263905692274;5701.4013528579735;6526.90209646851;6546.770863019819;6570.441512471398;6632.966835165793;6652.634105124216;4798.832040878552;4813.422389313269;4815.686980346301;4820.783064762094;4839.153148199051;6784.219814721321;6870.828229294258;6900.965495172542;6915.481338899603;6981.371676549084;4904.215325547895;4950.9009819803405;4955.306257124005;4972.085746987436;5009.148444764399;4947.35684361038;4972.825951091694;4974.552290293891;4995.275685025651;5034.647574669812;5579.302587176603;5595.076812326002;5617.494425501724;5626.915596266059;5640.407757185519;6593.901091483632;6598.175228096488;6607.810594093109;6656.933430665728;6660.70026848793;1618.9395945655615;1669.7912760904887;1684.1242553871919;1700.0649642696715;1708.2569082449174;1155.751513424601;1195.8445402097673;1218.2325135164967;1219.5426714981882;1228.3182833527478;5659.349174844946;5755.107958266475;5762.538996880239;5803.970980145073;5811.970940145272;6602.86794264112;6648.800535983928;6728.9570116632;6757.526973111933;6792.150981127359;5761.9135712964335;5768.826935191951;5787.189793428924;5827.970860145672;5846.883062338729;3492.161881148557;3537.25717599307;3578.624244454347;3589.1924317028984;3592.4611308303442;6473.37828179588;6507.772227972093;6543.0185472179555;6558.639274839834;6562.80311590653;6861.210960739479;6971.58170509771;7003.7548685795755;7059.6117213552725;7105.75129870452;6653.434458070925;6660.700268488026;6675.833104172338;6701.597904125768;6703.12859328294;6680.231773346128;6719.664016799238;6728.932710672831;6761.661916904037;6828.975653651793;6585.835354116185;6722.697478613376;6740.056392105012;6778.694958726967;6801.829954251183;6636.469082473487;6640.335966403321;6661.500387470862;6663.267040625624;6673.366030227121;4815.422149342101;4920.483349248278;4934.161192597196;4935.925961110514;4992.375953005874;6684.364985326386;6726.7981960541265;6782.491313151632;6793.456523478011;6853.984246931334;6497.610143391223;6579.2104947404705;6594.109795177781;6622.701978410887;6636.170478690164;6629.4696424284975;6635.270120286861;6636.469082473487;6644.136262286065;6680.6993685283305;6284;6461.61230326182;6482.2869484357625;6497.415232629086;6578.276389597045;6437.388448097423;6617.31258529072;6640.468762498892;6674.332566743286;6688.565243259172;6367.93632063692;6395.552311338348;6396.872062558629;6422.743090276524;6435.839104022437 11:36:28 INFO - PID 20629 | |5;yui.html;904.8416527107754;908.9636414543419;926.7544100813284;934.472023306832;935.5228833295017;17464.214110365032;20611.69082463764;22522.32433027012;22587.435314117156;22595.54808903821;20734.896325518388;21208.787912120875;21284;21314.147434102655;21333.893330533363;898.2409863665209;963.0610155098793;971.8445048792195;971.9319647624669;972.1736523954653;951.048951048951;970.3595626886256;976.9853452198223;985.3348989432104;988.184747583243;1037.8443233514959;1039.1478987230473;1039.469870366111;1041.208681402136;1041.9687409377693;1035.5236591168073;1036.424784244744;1037.7820657661862;1038.5326603028668;1038.5482315192878;753.2730914667318;753.3746989998289;753.6231884057971;753.7776355975001;759.1876691939627;18268.725969110474;18342.816571834377;19459;19604.117814698373;19639.509012274808;21954;22110.115595376166;22157.556848862932;22857.19999799999;22894.54210915789;17272.30910763568;17317.913410432993;17450.65098698019;17459.825401745948;17508;3690.852365905361;3694.4827724118645;3713.387291096966;3714;3716.572594151653;130988.34505827409;131817;132165;133859.33070334585;135179.32410337983;16598.419055333005;16729.330826767036;17107.91446042762;17289.3948711797;17302.740458893128;30259.394812103634;31288;31411.37177256442;31730.524042139386;31845.681543184273;8335.333173346118;8426.283765879969;8524.616392262364;8525.488470691778;8545.188207120314;4211.768352740567;4282.35764635301;4282.421873047098;4288.849890253826;4301.333293339538;5193.324867767166;5289;5289.47105289468;5298.523132917979;5320.148776195868;1081.4376524207369;1111.6220485035126;1119.9328040317607;1123.9943800280946;1127.1208457403238;678.6369292428527;694.1635329428027;697.7941507255372;707.904432901562;717.5551158281899;11208.887911120948;12382.380880955916;12496.937515312366;12656.240625562496;13174.934125329504;650.2716957008087;658.7253664159866;661.7584581627672;665.3280187011154;672.9938741581367;5391.838244852661;5392.352917649907;5408.432114627986;5473.2063850741415;5499.230107784913;107084;107887;108938.45530772295;109248;110406;93694.53152734193;94052.52973735088;96897.5155124234;98963.01036989682;99411;80791.19208807954;83006;83767.16232837715;84415.57792211123;86981.5650921754;11867.525298987945;12092.274463532216;12149.574764883188;12254.20347677398;12498.43757030954;40638.79680601578;41094.1781164381;41186.79406602948;41408.171836563706;41496.1700765989;69826.65086674535;70067.64966175136;73206.63396682983;73527.63236183785;76193.61903190448;17149.71377146744;18165.909170454062;18211.635767284846;18216.089195540437;18286.908565457088;20333.389998300074;20523;20801.271955481487;21315.46711332167;21377.144914203258;17662.823371766633;18084.276628935222;18502.167402467192;18749.250029998646;18917.527061823566;17123.743143852604;17768.55578610545;18799.342023029127;18870.150843211813;19090.427287181406;15599.220038998232;15610.141442220787;15754;18270;18299.90850045741;11994.460249288628;12363.196392234477;12378.381080946097;12403.25580465139;12645.430955607204;13517.121387109806;13849.16904985704;13876.861231387556;13933.651658708613;14008.859911400756 11:36:28 INFO - PID 20629 | __end_tp_report 11:36:28 INFO - PID 20629 | __start_cc_report 11:36:28 INFO - PID 20629 | _x_x_mozilla_cycle_collect,378 11:36:28 INFO - PID 20629 | __end_cc_report 11:36:28 INFO - PID 20629 | __startTimestamp1504204588487__endTimestamp 11:36:28 INFO - PID 20629 | 11:36:28 INFO - PID 20629 | ------- Summary: start ------- 11:36:28 INFO - PID 20629 | Number of tests: 6 11:36:28 INFO - PID 20629 | 11:36:28 INFO - PID 20629 | [#0] dojo.html Cycles:165 Average:6238.16 Median:6452.94 stddev:731.53 (11.3%) stddev-sans-first:695.69 11:36:28 INFO - PID 20629 | Values: 3268.4 3309.8 3330.3 3332.2 3367.8 6239.8 6305.1 6400.9 6434.4 6437.1 6137.4 6224.5 6235.3 6254.6 6307.4 5777.8 5792.8 5824.4 5861.0 5925.1 5915.8 5922.3 5933.0 5934.5 5938.5 5800.4 5822.7 5875.9 5879.0 5969.7 5430.9 5820.7 5878.6 5948.7 5969.4 5703.0 5762.7 5774.8 5798.4 5808.0 6211.2 6251.9 6263.2 6272.1 6277.2 6688.9 6777.3 6786.5 6790.4 6801.9 6781.7 6785.9 6789.5 6857.2 6883.0 6180.8 6266.3 6269.7 6275.7 6283.0 6949.2 6983.6 7045.2 7074.8 7094.1 6666.9 6691.5 6700.6 6750.7 6772.3 6788.6 6800.6 6826.9 6856.2 6890.2 6690.0 6776.2 6808.7 6815.1 6855.8 6505.5 6808.1 6886.6 6888.2 6889.8 5257.0 5276.4 5278.6 5294.4 5344.5 4656.3 4698.4 4702.2 4702.2 4704.0 5900.0 5911.6 5972.6 5999.6 6001.4 6560.0 6643.1 6751.8 6859.6 6891.6 5797.4 5821.0 5831.7 5846.3 5930.8 5745.1 5747.0 5748.4 5769.3 5771.7 6345.5 6442.0 6524.6 6528.8 6542.1 6636.0 6664.0 6730.5 6746.1 6751.9 6407.8 6538.1 6548.6 6657.8 6673.8 6708.8 6792.1 6810.2 6815.8 6820.4 6818.1 6824.8 6841.9 6933.4 6939.3 6519.0 6560.0 6588.9 6648.0 6683.3 6558.8 6654.9 6670.9 6686.3 6692.7 6341.8 6464.1 6550.9 6556.8 6557.6 6419.0 6586.2 6642.2 6662.8 6704.8 6333.5 6375.4 6452.9 6476.7 6489.8 11:36:28 INFO - PID 20629 | 11:36:28 INFO - PID 20629 | [#1] ext.html Cycles:180 Average:38484.50 Median:19587.27 stddev:55520.21 (283.5%) stddev-sans-first:55603.90 11:36:28 INFO - PID 20629 | Values: 812.9 852.8 872.9 879.2 1129.5 30160.8 30664.5 40338.8 41093.0 41197.4 40696.0 41033.0 41116.2 41146.2 41214.6 7519.2 7625.0 7834.1 7876.0 7884.9 7628.8 7758.7 7760.8 7765.1 7774.9 7732.4 7790.8 7795.0 7799.6 7822.1 7767.1 7811.0 7813.5 7813.6 7816.7 7626.0 7686.0 7686.1 7688.2 7693.1 36865.6 36968.4 37098.6 37109.0 37189.3 3526.2 3563.1 3563.9 3564.4 3565.5 31197.1 31214.5 31224.4 31253.5 31339.7 5010.1 5156.6 5197.5 5198.7 5230.2 193468.0 193964.0 194069.2 194586.0 195449.0 46828.8 46852.0 47001.0 47027.5 48268.3 50979.0 51151.2 51291.2 51345.5 51370.1 15063.4 15200.4 15209.4 15216.2 15367.7 12159.8 12195.5 12209.8 12231.1 12244.3 14483.2 14491.7 14589.1 14606.6 14676.9 5722.1 5730.2 5809.0 5853.2 5902.5 987.2 1009.5 1027.8 1031.7 1033.9 22808.2 22888.7 22920.5 23074.5 23601.3 1093.8 1106.2 1108.7 1113.5 1121.1 12053.9 12140.5 12431.9 15455.0 15745.9 233895.0 235531.0 235594.0 235889.0 236187.0 55288.2 55783.0 56003.4 56006.7 56041.4 1403.4 1442.2 1449.4 1464.1 1471.1 26741.1 26834.2 27148.6 27388.6 27454.6 37899.2 37976.0 37999.6 38000.4 47315.8 209669.0 211084.0 211312.0 211898.0 212172.0 35228.1 35467.3 35611.5 35633.3 35656.6 42447.0 42547.8 42785.4 42858.6 43122.4 32257.5 32391.0 33249.8 34423.0 34633.8 33109.2 33454.5 33757.8 33766.0 34213.0 37515.2 37543.4 37901.2 38063.6 38272.4 32645.8 32781.8 32891.3 33591.8 33843.3 24017.3 24022.0 24778.8 24962.0 25045.0 11:36:28 INFO - PID 20629 | 11:36:28 INFO - PID 20629 | [#2] jquery.html Cycles:180 Average:32941.39 Median:22344.27 stddev:77482.87 (346.8%) stddev-sans-first:77662.09 11:36:28 INFO - PID 20629 | Values: 562.3 563.8 567.9 579.1 584.5 21535.5 22161.0 22325.4 22363.1 22386.7 24948.0 25480.5 25534.5 25550.5 25563.4 6366.2 6506.2 6513.8 6514.8 6515.1 6027.1 6482.9 6528.9 6562.3 6599.5 6568.2 6570.1 6571.6 6575.0 6582.0 6539.8 6548.4 6561.1 6571.4 6581.7 6082.0 6082.6 6088.3 6100.8 6105.1 27411.9 27973.7 28532.0 28989.6 29078.6 1991.8 2019.8 2022.5 2024.8 2029.5 18742.5 19365.4 19405.6 19426.4 19429.3 2180.7 2210.7 2241.6 2250.9 2262.5 128543.0 134949.3 135384.0 135636.0 136359.0 13617.7 14237.9 14506.7 14527.6 14674.6 22299.8 22375.4 22881.9 22976.5 23048.5 9765.7 9829.8 9895.5 9900.0 10045.1 8916.8 8940.4 9005.1 9041.6 9134.5 8771.3 8961.2 9023.0 9108.1 9176.7 2558.3 2562.2 2632.6 2667.7 2733.0 972.3 980.9 986.8 989.6 997.0 19217.9 19514.4 19851.3 19887.2 20040.1 987.9 1027.3 1039.9 1047.4 1048.8 10736.9 10858.8 10900.5 10929.3 11098.9 444136.0 444274.0 462485.0 469067.0 472922.0 108031.5 111107.0 112067.0 112321.0 115148.0 1155.7 1168.4 1195.2 1195.5 1205.1 17139.9 17579.7 17733.1 17775.8 17793.4 50599.2 52323.5 52835.7 53300.2 53467.5 62280.4 62693.4 63448.0 63587.7 66771.0 13901.4 14301.7 14315.0 14321.6 14343.6 20064.6 20415.9 20443.2 20478.0 21107.2 15938.4 15946.9 16256.8 16261.1 16266.9 14268.9 14413.4 14433.4 15022.0 15430.2 16627.5 16891.2 16997.7 17001.7 17002.1 14196.9 14216.4 14221.9 14227.1 14245.4 16780.7 17343.3 17361.4 17364.8 17394.7 11:36:28 INFO - PID 20629 | 11:36:28 INFO - PID 20629 | [#3] mootools.html Cycles:180 Average:9597.73 Median:2702.64 stddev:6945.72 (257.0%) stddev-sans-first:6937.49 11:36:28 INFO - PID 20629 | Values: 1339.4 1382.0 1388.9 1393.1 1394.6 15228.5 15493.7 15908.2 15908.8 15918.1 15956.8 16179.1 16193.4 16199.7 16237.8 2761.3 2797.5 2799.1 2803.9 2807.7 2701.1 2715.0 2742.4 2793.6 2798.0 2730.5 2757.4 2757.8 2759.4 2759.6 2638.7 2662.8 2673.7 2680.1 2681.4 2670.9 2687.0 2690.7 2704.2 2713.1 15346.4 15686.5 15694.5 15743.5 15759.8 7987.4 8273.0 8278.2 8282.2 8298.8 5275.2 5475.9 5534.6 5630.9 5675.8 1833.1 1853.7 1855.2 1889.0 1897.0 27106.5 27345.3 27367.0 27381.9 27413.9 6921.6 6934.2 6966.9 7085.4 7092.4 17414.3 17419.1 17447.1 17470.9 17512.2 7775.4 8035.4 8036.3 8040.1 8042.8 7381.3 7400.5 7435.9 7529.3 7537.7 4989.4 5241.6 5248.6 5269.3 5286.9 1293.6 1325.6 1510.3 1517.9 1553.9 870.4 875.3 887.3 896.1 903.3 8675.6 8878.6 8884.1 8885.0 8955.2 945.8 984.0 990.0 1005.7 1026.5 4810.2 5356.3 5470.4 5623.4 5647.7 21633.1 21833.8 22785.1 22800.8 22827.8 22261.9 22451.7 22719.5 22745.9 22775.7 11200.8 11567.9 11780.5 11854.8 11889.9 8533.8 8981.8 9128.4 9137.3 9275.0 18809.2 19076.2 19191.3 19417.7 19719.8 19388.4 19522.2 19840.3 19860.3 20316.0 11629.8 11947.3 11962.2 11963.5 11967.8 14327.2 14385.9 14446.7 14465.6 14627.9 11565.1 11744.4 11789.1 11959.6 12021.9 11127.8 11218.6 11249.2 11447.8 11529.2 9146.2 9163.5 9280.3 9301.4 9411.2 6830.5 6842.6 6906.5 6943.8 7049.9 7017.7 7057.4 7074.6 7095.1 7187.0 11:36:28 INFO - PID 20629 | 11:36:28 INFO - PID 20629 | [#4] prototype.html Cycles:180 Average:5535.56 Median:6262.94 stddev:1579.98 (25.2%) stddev-sans-first:1538.37 11:36:28 INFO - PID 20629 | Values: 491.0 503.9 527.6 528.2 529.7 6355.0 6389.7 6394.8 6404.4 6407.7 6079.8 6248.8 6255.2 6260.2 6265.8 4974.7 4993.0 4998.8 5004.8 5040.4 4935.7 4967.7 4994.5 5000.9 5023.6 4825.8 4935.7 4938.8 4939.5 4951.2 4941.5 4942.4 4942.8 4965.0 4996.6 4442.7 4460.9 4462.9 4477.6 4490.7 6214.7 6261.9 6263.9 6265.4 6279.1 5648.4 5648.8 5654.9 5662.3 5701.4 6526.9 6546.8 6570.4 6633.0 6652.6 4798.8 4813.4 4815.7 4820.8 4839.2 6784.2 6870.8 6901.0 6915.5 6981.4 4904.2 4950.9 4955.3 4972.1 5009.1 4947.4 4972.8 4974.6 4995.3 5034.6 5579.3 5595.1 5617.5 5626.9 5640.4 6593.9 6598.2 6607.8 6656.9 6660.7 1618.9 1669.8 1684.1 1700.1 1708.3 1155.8 1195.8 1218.2 1219.5 1228.3 5659.3 5755.1 5762.5 5804.0 5812.0 6602.9 6648.8 6729.0 6757.5 6792.2 5761.9 5768.8 5787.2 5828.0 5846.9 3492.2 3537.3 3578.6 3589.2 3592.5 6473.4 6507.8 6543.0 6558.6 6562.8 6861.2 6971.6 7003.8 7059.6 7105.8 6653.4 6660.7 6675.8 6701.6 6703.1 6680.2 6719.7 6728.9 6761.7 6829.0 6585.8 6722.7 6740.1 6778.7 6801.8 6636.5 6640.3 6661.5 6663.3 6673.4 4815.4 4920.5 4934.2 4935.9 4992.4 6684.4 6726.8 6782.5 6793.5 6854.0 6497.6 6579.2 6594.1 6622.7 6636.2 6629.5 6635.3 6636.5 6644.1 6680.7 6284.0 6461.6 6482.3 6497.4 6578.3 6437.4 6617.3 6640.5 6674.3 6688.6 6367.9 6395.6 6396.9 6422.7 6435.8 11:36:28 INFO - PID 20629 | 11:36:28 INFO - PID 20629 | [#5] yui.html Cycles:180 Average:23986.37 Median:21355.52 stddev:32555.75 (152.4%) stddev-sans-first:32600.94 11:36:28 INFO - PID 20629 | Values: 904.8 909.0 926.8 934.5 935.5 17464.2 20611.7 22522.3 22587.4 22595.5 20734.9 21208.8 21284.0 21314.1 21333.9 898.2 963.1 971.8 971.9 972.2 951.0 970.4 977.0 985.3 988.2 1037.8 1039.1 1039.5 1041.2 1042.0 1035.5 1036.4 1037.8 1038.5 1038.5 753.3 753.4 753.6 753.8 759.2 18268.7 18342.8 19459.0 19604.1 19639.5 21954.0 22110.1 22157.6 22857.2 22894.5 17272.3 17317.9 17450.7 17459.8 17508.0 3690.9 3694.5 3713.4 3714.0 3716.6 130988.3 131817.0 132165.0 133859.3 135179.3 16598.4 16729.3 17107.9 17289.4 17302.7 30259.4 31288.0 31411.4 31730.5 31845.7 8335.3 8426.3 8524.6 8525.5 8545.2 4211.8 4282.4 4282.4 4288.8 4301.3 5193.3 5289.0 5289.5 5298.5 5320.1 1081.4 1111.6 1119.9 1124.0 1127.1 678.6 694.2 697.8 707.9 717.6 11208.9 12382.4 12496.9 12656.2 13174.9 650.3 658.7 661.8 665.3 673.0 5391.8 5392.4 5408.4 5473.2 5499.2 107084.0 107887.0 108938.5 109248.0 110406.0 93694.5 94052.5 96897.5 98963.0 99411.0 80791.2 83006.0 83767.2 84415.6 86981.6 11867.5 12092.3 12149.6 12254.2 12498.4 40638.8 41094.2 41186.8 41408.2 41496.2 69826.7 70067.6 73206.6 73527.6 76193.6 17149.7 18165.9 18211.6 18216.1 18286.9 20333.4 20523.0 20801.3 21315.5 21377.1 17662.8 18084.3 18502.2 18749.3 18917.5 17123.7 17768.6 18799.3 18870.2 19090.4 15599.2 15610.1 15754.0 18270.0 18299.9 11994.5 12363.2 12378.4 12403.3 12645.4 13517.1 13849.2 13876.9 13933.7 14008.9 11:36:28 INFO - PID 20629 | -------- Summary: end -------- 11:36:28 INFO - PID 20629 | 11:36:29 INFO - TEST-INFO | 20629: exit 0 11:36:29 INFO - TEST-OK | dromaeo_css | took 1111436ms 11:36:29 INFO - TEST-START | kraken 11:36:29 INFO - Initialising browser for kraken test... 11:36:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48577/getInfo.html -profile /tmp/tmp0SOQO1/profile 11:36:29 INFO - TEST-INFO | started process 21008 (/builds/slave/test/build/application/firefox/firefox http://localhost:48577/getInfo.html) 11:36:34 INFO - TEST-INFO | 21008: exit 0 11:36:35 INFO - Browser initialized. 11:36:35 INFO - Running cycle 1/1 for kraken test... 11:36:35 INFO - Using env: {'DISPLAY': ':0', 11:36:35 INFO - 'HOME': '/home/cltbld', 11:36:35 INFO - 'JSGC_DISABLE_POISONING': '1', 11:36:35 INFO - 'LANG': 'en_US.UTF-8', 11:36:35 INFO - 'LANGUAGE': 'en_US:en', 11:36:35 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:36:35 INFO - 'LOGNAME': 'cltbld', 11:36:35 INFO - 'MAIL': '/var/mail/cltbld', 11:36:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:36:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:36:35 INFO - 'MOZ_CRASHREPORTER': '1', 11:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:35 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:36:35 INFO - 'MOZ_NO_REMOTE': '1', 11:36:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:35 INFO - 'NO_EM_RESTART': '1', 11:36:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:35 INFO - 'PWD': '/builds/slave/test', 11:36:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:36:35 INFO - 'RUST_BACKTRACE': 'full', 11:36:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:36:35 INFO - 'SHELL': '/bin/bash', 11:36:35 INFO - 'SHLVL': '1', 11:36:35 INFO - 'STYLO_FORCE_ENABLED': '1', 11:36:35 INFO - 'TERM': 'linux', 11:36:35 INFO - 'TMOUT': '86400', 11:36:35 INFO - 'USER': 'cltbld', 11:36:35 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952', 11:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:35 INFO - '_': '/tools/buildbot/bin/python'} 11:36:35 INFO - TEST-INFO | started process 21202 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0SOQO1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:36:36 INFO - PID 21202 | 11:36:36 INFO - PID 21202 | (/builds/slave/test/build/application/firefox/firefox:21253): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:36:36 INFO - PID 21202 | 11:36:46 INFO - PID 21202 | RSS: Main: 173068288 11:36:46 INFO - PID 21202 | 11:36:48 INFO - PID 21202 | Cycle 1(1): loaded http://localhost:48577/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48577/tests/kraken/driver.html?testName=audio-beat-detection) 11:36:49 INFO - PID 21202 | RSS: Main: 177586176 11:36:49 INFO - PID 21202 | 11:36:52 INFO - PID 21202 | Cycle 1(1): loaded http://localhost:48577/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48577/tests/kraken/driver.html?testName=audio-dft) 11:36:53 INFO - PID 21202 | RSS: Main: 177819648 11:36:53 INFO - PID 21202 | 11:36:56 INFO - PID 21202 | Cycle 1(1): loaded http://localhost:48577/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48577/tests/kraken/driver.html?testName=audio-fft) 11:36:56 INFO - PID 21202 | RSS: Main: 172486656 11:36:56 INFO - PID 21202 | 11:36:58 INFO - PID 21202 | Cycle 1(1): loaded http://localhost:48577/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48577/tests/kraken/driver.html?testName=audio-oscillator) 11:36:59 INFO - PID 21202 | RSS: Main: 173088768 11:36:59 INFO - PID 21202 | 11:37:01 INFO - PID 21202 | Cycle 1(1): loaded http://localhost:48577/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48577/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:37:02 INFO - PID 21202 | RSS: Main: 173268992 11:37:02 INFO - PID 21202 | 11:37:05 INFO - PID 21202 | Cycle 1(1): loaded http://localhost:48577/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48577/tests/kraken/driver.html?testName=imaging-darkroom) 11:37:06 INFO - PID 21202 | RSS: Main: 175734784 11:37:06 INFO - PID 21202 | 11:37:09 INFO - PID 21202 | Cycle 1(1): loaded http://localhost:48577/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48577/tests/kraken/driver.html?testName=imaging-desaturate) 11:37:10 INFO - PID 21202 | RSS: Main: 175710208 11:37:10 INFO - PID 21202 | 11:37:12 INFO - PID 21202 | Cycle 1(1): loaded http://localhost:48577/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48577/tests/kraken/driver.html?testName=json-parse-financial) 11:37:13 INFO - PID 21202 | RSS: Main: 175800320 11:37:13 INFO - PID 21202 | 11:37:15 INFO - PID 21202 | Cycle 1(1): loaded http://localhost:48577/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48577/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:37:15 INFO - PID 21202 | RSS: Main: 176267264 11:37:15 INFO - PID 21202 | 11:37:17 INFO - PID 21202 | Cycle 1(1): loaded http://localhost:48577/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48577/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:37:18 INFO - PID 21202 | RSS: Main: 175562752 11:37:18 INFO - PID 21202 | 11:37:20 INFO - PID 21202 | Cycle 1(1): loaded http://localhost:48577/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48577/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:37:20 INFO - PID 21202 | RSS: Main: 173318144 11:37:20 INFO - PID 21202 | 11:37:23 INFO - PID 21202 | Cycle 1(1): loaded http://localhost:48577/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48577/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:37:24 INFO - PID 21202 | RSS: Main: 173084672 11:37:24 INFO - PID 21202 | 11:37:27 INFO - PID 21202 | Cycle 1(1): loaded http://localhost:48577/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48577/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:37:27 INFO - PID 21202 | RSS: Main: 174022656 11:37:27 INFO - PID 21202 | 11:37:29 INFO - PID 21202 | Cycle 1(1): loaded http://localhost:48577/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48577/tests/kraken/driver.html?testName=ai-astar) 11:37:29 INFO - PID 21202 | RSS: Main: 174854144 11:37:29 INFO - PID 21202 | 11:37:29 INFO - PID 21202 | __start_tp_report 11:37:29 INFO - PID 21202 | _x_x_mozilla_page_load 11:37:29 INFO - PID 21202 | _x_x_mozilla_page_load_details 11:37:29 INFO - PID 21202 | |i|pagename|runs| 11:37:29 INFO - PID 21202 | |0;ai-astar;98;107;100;108;108;108;108;98;108;109 11:37:29 INFO - PID 21202 | |1;audio-beat-detection;152;115;140;175;119;149;144;119;171;120 11:37:29 INFO - PID 21202 | |2;audio-dft;164;162;162;162;169;162;162;163;166;169 11:37:29 INFO - PID 21202 | |3;audio-fft;77;77;74;186;74;77;73;88;97;75 11:37:29 INFO - PID 21202 | |4;audio-oscillator;79;81;132;80;79;79;123;79;79;129 11:37:29 INFO - PID 21202 | |5;imaging-gaussian-blur;114;113;113;114;114;114;114;114;113;115 11:37:29 INFO - PID 21202 | |6;imaging-darkroom;148;148;148;148;148;148;148;147;148;148 11:37:29 INFO - PID 21202 | |7;imaging-desaturate;98;99;94;95;94;94;95;94;94;93 11:37:29 INFO - PID 21202 | |8;json-parse-financial;52;52;54;51;51;51;52;52;51;52 11:37:29 INFO - PID 21202 | |9;json-stringify-tinderbox;38;37;38;37;37;38;37;38;37;38 11:37:29 INFO - PID 21202 | |10;stanford-crypto-aes;76;76;74;77;75;74;73;75;74;75 11:37:29 INFO - PID 21202 | |11;stanford-crypto-ccm;120;131;130;116;116;126;130;116;118;153 11:37:29 INFO - PID 21202 | |12;stanford-crypto-pbkdf2;172;177;170;177;174;173;169;165;168;171 11:37:29 INFO - PID 21202 | |13;stanford-crypto-sha256-iterative;64;66;65;64;65;65;64;69;64;64 11:37:29 INFO - PID 21202 | __end_tp_report 11:37:29 INFO - PID 21202 | __start_cc_report 11:37:29 INFO - PID 21202 | _x_x_mozilla_cycle_collect,939 11:37:29 INFO - PID 21202 | __end_cc_report 11:37:29 INFO - PID 21202 | __startTimestamp1504204649802__endTimestamp 11:37:29 INFO - PID 21202 | 11:37:29 INFO - PID 21202 | ------- Summary: start ------- 11:37:29 INFO - PID 21202 | Number of tests: 14 11:37:29 INFO - PID 21202 | 11:37:29 INFO - PID 21202 | [#0] ai-astar Cycles:10 Average:105.20 Median:108.00 stddev:4.57 (4.2%) stddev-sans-first:4.03 11:37:29 INFO - PID 21202 | Values: 98.0 107.0 100.0 108.0 108.0 108.0 108.0 98.0 108.0 109.0 11:37:29 INFO - PID 21202 | 11:37:29 INFO - PID 21202 | [#1] audio-beat-detection Cycles:10 Average:140.40 Median:146.50 stddev:21.94 (15.0%) stddev-sans-first:22.87 11:37:29 INFO - PID 21202 | Values: 152.0 115.0 140.0 175.0 119.0 149.0 144.0 119.0 171.0 120.0 11:37:29 INFO - PID 21202 | 11:37:29 INFO - PID 21202 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:2.88 (1.8%) stddev-sans-first:3.06 11:37:29 INFO - PID 21202 | Values: 164.0 162.0 162.0 162.0 169.0 162.0 162.0 163.0 166.0 169.0 11:37:29 INFO - PID 21202 | 11:37:29 INFO - PID 21202 | [#3] audio-fft Cycles:10 Average:89.80 Median:77.00 stddev:34.64 (45.0%) stddev-sans-first:36.43 11:37:29 INFO - PID 21202 | Values: 77.0 77.0 74.0 186.0 74.0 77.0 73.0 88.0 97.0 75.0 11:37:29 INFO - PID 21202 | 11:37:29 INFO - PID 21202 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:79.00 stddev:23.57 (29.8%) stddev-sans-first:24.37 11:37:29 INFO - PID 21202 | Values: 79.0 81.0 132.0 80.0 79.0 79.0 123.0 79.0 79.0 129.0 11:37:29 INFO - PID 21202 | 11:37:29 INFO - PID 21202 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 11:37:29 INFO - PID 21202 | Values: 114.0 113.0 113.0 114.0 114.0 114.0 114.0 114.0 113.0 115.0 11:37:29 INFO - PID 21202 | 11:37:29 INFO - PID 21202 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 11:37:29 INFO - PID 21202 | Values: 148.0 148.0 148.0 148.0 148.0 148.0 148.0 147.0 148.0 148.0 11:37:29 INFO - PID 21202 | 11:37:29 INFO - PID 21202 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:94.50 stddev:1.94 (2.1%) stddev-sans-first:1.73 11:37:29 INFO - PID 21202 | Values: 98.0 99.0 94.0 95.0 94.0 94.0 95.0 94.0 94.0 93.0 11:37:29 INFO - PID 21202 | 11:37:29 INFO - PID 21202 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:0.92 (1.8%) stddev-sans-first:0.97 11:37:29 INFO - PID 21202 | Values: 52.0 52.0 54.0 51.0 51.0 51.0 52.0 52.0 51.0 52.0 11:37:29 INFO - PID 21202 | 11:37:29 INFO - PID 21202 | [#9] json-stringify-tinderbox Cycles:10 Average:37.50 Median:38.00 stddev:0.53 (1.4%) stddev-sans-first:0.53 11:37:29 INFO - PID 21202 | Values: 38.0 37.0 38.0 37.0 37.0 38.0 37.0 38.0 37.0 38.0 11:37:29 INFO - PID 21202 | 11:37:29 INFO - PID 21202 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:75.00 stddev:1.20 (1.6%) stddev-sans-first:1.20 11:37:29 INFO - PID 21202 | Values: 76.0 76.0 74.0 77.0 75.0 74.0 73.0 75.0 74.0 75.0 11:37:29 INFO - PID 21202 | 11:37:29 INFO - PID 21202 | [#11] stanford-crypto-ccm Cycles:10 Average:125.60 Median:128.00 stddev:11.47 (9.0%) stddev-sans-first:11.99 11:37:29 INFO - PID 21202 | Values: 120.0 131.0 130.0 116.0 116.0 126.0 130.0 116.0 118.0 153.0 11:37:29 INFO - PID 21202 | 11:37:29 INFO - PID 21202 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:172.50 stddev:3.84 (2.2%) stddev-sans-first:4.07 11:37:29 INFO - PID 21202 | Values: 172.0 177.0 170.0 177.0 174.0 173.0 169.0 165.0 168.0 171.0 11:37:29 INFO - PID 21202 | 11:37:29 INFO - PID 21202 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:1.56 (2.4%) stddev-sans-first:1.62 11:37:29 INFO - PID 21202 | Values: 64.0 66.0 65.0 64.0 65.0 65.0 64.0 69.0 64.0 64.0 11:37:29 INFO - PID 21202 | -------- Summary: end -------- 11:37:29 INFO - PID 21202 | 11:37:30 INFO - PID 21202 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:37:30 INFO - TEST-INFO | 21202: exit 0 11:37:30 INFO - TEST-OK | kraken | took 61367ms 11:37:30 INFO - SUITE-END | took 1172s 11:37:30 INFO - Completed test suite (00:19:33) 11:37:30 INFO - javascript benchmark 11:37:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8562.50702190219, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3268.4280250956076, 3309.817960012199, 3330.3172849565835, 3332.233586275155, 3367.7810942288747, 6239.812805615833, 6305.054241863717, 6400.871982560346, 6434.420902118803, 6437.0988061671405, 6137.41694539018, 6224.470919971808, 6235.251769787632, 6254.562180647356, 6307.3692630736905, 5777.768889244446, 5792.7972520961775, 5824.446677565625, 5861.0, 5925.140854576084, 5915.822525324247, 5922.289325280973, 5932.9703351483395, 5934.525237980951, 5938.52491800657, 5800.4489573490455, 5822.7088645567765, 5875.88248235035, 5878.970605146968, 5969.731362088716, 5430.945690543083, 5820.708964551798, 5878.647281163144, 5948.672822994734, 5969.373215812364, 5703.030484817591, 5762.654240745569, 5774.797882074149, 5798.449147330997, 5807.970960145214, 6211.223597050369, 6251.906221406683, 6263.24841019076, 6272.1219029335925, 6277.246730392382, 6688.86622267552, 6777.322267773233, 6786.4570834333135, 6790.3888650021245, 6801.931980680229, 6781.728730850809, 6785.898211526782, 6789.490788190906, 6857.177138743333, 6883.0019647151385, 6180.81457556274, 6266.342034086447, 6269.686515674198, 6275.7489700411925, 6283.0, 6949.235584085746, 6983.615901125385, 7045.154581450259, 7074.823129421703, 7094.148702155671, 6666.866662666816, 6691.498137639696, 6700.564463309869, 6750.696218670171, 6772.255051944282, 6788.626625535643, 6800.625965571842, 6826.931730682729, 6856.177258728885, 6890.2420733719255, 6690.0, 6776.220734615484, 6808.659567021629, 6815.079964204868, 6855.7600483983815, 6505.4795616350575, 6808.08090907731, 6886.621235832077, 6888.173419189729, 6889.793306200822, 5257.0, 5276.366835979707, 5278.630495865329, 5294.364676238876, 5344.465553444625, 4656.32483289921, 4698.412698412699, 4702.177119004161, 4702.177119004161, 4704.0, 5899.970500147472, 5911.645301281937, 5972.581919265696, 5999.5800293979, 6001.4298641628975, 6560.0, 6643.136392269071, 6751.763688270887, 6859.588424694434, 6891.620960847101, 5797.449242321973, 5821.0, 5831.650100993954, 5846.327672317653, 5930.813837232485, 5745.052066409079, 5746.9712651436475, 5748.425157484218, 5769.336526299529, 5771.711414429262, 6345.460635846005, 6442.033694945796, 6524.641144737085, 6528.836779080466, 6542.084108224853, 6636.037774522763, 6663.966680166568, 6730.528862979544, 6746.123004009545, 6751.93248067513, 6407.8398040047505, 6538.051982462612, 6548.574342667712, 6657.800265992028, 6673.799786006428, 6708.765193218214, 6792.117024786746, 6810.216825065181, 6815.829604259933, 6820.420264277592, 6818.147731533559, 6824.761133360308, 6841.931580684329, 6933.445324374139, 6939.340762627542, 6518.967405162944, 6559.967200163968, 6588.934110659024, 6648.0360347750275, 6683.264840867598, 6558.770443034471, 6654.933450665431, 6670.866582668223, 6686.297938716365, 6692.732290708512, 6341.841453963688, 6464.127342808661, 6550.934490655223, 6556.8360790978695, 6557.573757705733, 6419.0, 6586.209654841449, 6642.236142843635, 6662.766803161866, 6704.765333213314, 6333.493320534254, 6375.362463753588, 6452.935470645233, 6476.676166191577, 6489.837754055998], "value": 6185.0710663804075, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [812.8821320908469, 852.76122685648, 872.9083446238143, 879.1823604048233, 1129.5143088471964, 30160.849195754017, 30664.540031899538, 40338.798306008466, 41093.0, 41197.38203926943, 40696.0, 41033.0, 41116.17767644645, 41146.17707645845, 41214.58785412153, 7519.210482899299, 7624.970628965074, 7834.05991281047, 7875.960620196891, 7884.921150788476, 7628.771136865875, 7758.728444504443, 7760.844783104363, 7765.06819181699, 7774.883376749353, 7732.381409487228, 7790.80522986927, 7795.0, 7799.5710235937, 7822.139564647884, 7767.145613982458, 7810.9609451952665, 7813.531188128731, 7813.570253636048, 7816.72641457552, 7625.961870190669, 7686.039245094364, 7686.1160966489015, 7688.1543030267185, 7693.115291741466, 36865.63134368649, 36968.44547331792, 37098.62901371006, 37109.0, 37189.25621487582, 3526.1713497328105, 3563.073600863768, 3563.9109022274392, 3564.376234159012, 3565.5186549815962, 31197.064088077394, 31214.53178202329, 31224.375512489623, 31253.53119703206, 31339.686603133905, 5010.0981823271795, 5156.587473002151, 5197.454267301917, 5198.662086964335, 5230.241614965808, 193468.0, 193964.0, 194069.2075777341, 194586.0, 195449.0, 46828.7658561705, 46852.0, 47001.0, 47027.52972470231, 48268.27597586039, 50979.0, 51151.23273150906, 51291.23063154056, 51345.486545134816, 51370.14723895648, 15063.397464101314, 15200.391984320724, 15209.391624335123, 15216.239188040554, 15367.692646147014, 12159.756804863853, 12195.512179512898, 12209.816852747215, 12231.082668799698, 12244.326562039174, 14483.203423811581, 14491.710165796625, 14589.12465252067, 14606.634834129232, 14676.926615366854, 5722.141678748138, 5730.19777231188, 5808.970955145197, 5853.151293062482, 5902.527797776168, 987.1855719031828, 1009.5305682857506, 1027.8406846938738, 1031.6750223679667, 1033.9327943683636, 22808.20171293997, 22888.65667014996, 22920.541589168122, 23074.538509229722, 23601.29196124119, 1093.830456279278, 1106.1537923488538, 1108.6563165418745, 1113.5156207049797, 1121.0527104596604, 12053.939730301292, 12140.514379424902, 12431.937840310922, 15455.012699537356, 15745.897787154789, 233895.0, 235531.0, 235594.0, 235889.0, 236187.0, 55288.17067743987, 55783.0, 56003.43996559982, 56006.719966399905, 56041.439585604436, 1403.39653948803, 1442.2212005516903, 1449.3622805965342, 1464.1215270837624, 1471.0805746408494, 26741.06406275771, 26834.194974150807, 27148.592771108844, 27388.589171162846, 27454.5881811769, 37899.24201515899, 37976.0, 37999.62000379961, 38000.42999355067, 47315.76342118267, 209669.0, 211084.0, 211312.0, 211898.0, 212172.0, 35228.11929701778, 35467.29065418729, 35611.465828012086, 35633.28733425369, 35656.64343356533, 42447.0, 42547.787261063495, 42785.358219626105, 42858.571414285456, 43122.353164703185, 32257.51613725843, 32391.0, 33249.833750831094, 34423.0, 34633.826830865684, 33109.17227069246, 33454.4981825268, 33757.83121084379, 33766.0, 34213.0, 37515.249695006496, 37543.43684844675, 37901.24197516089, 38063.61936380601, 38272.42591361076, 32645.836770816943, 32781.83609081939, 32891.34217315688, 33591.83204083964, 33843.3231335367, 24017.27948161558, 24022.0, 24778.752212478365, 24962.0, 25045.0], "value": 17429.028882553837, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.280281240013, 563.7801257509572, 567.9346875109363, 579.0995002770693, 584.4885724990634, 21535.461613459673, 22161.0, 22325.44186395339, 22363.10547578099, 22386.664200037012, 24948.0, 25480.490390192186, 25534.48931021383, 25550.488990220183, 25563.36091597711, 6366.204224471941, 6506.219253689564, 6513.772017979371, 6514.7719829805965, 6515.0553169790355, 6027.09593560965, 6482.902756458633, 6528.869422611545, 6562.278149403562, 6599.472042236634, 6568.211814582257, 6570.080188773575, 6571.638559879205, 6574.967125164368, 6582.0, 6539.77110801122, 6548.377904099127, 6561.081448597224, 6571.3757193066585, 6581.670916454158, 6082.0, 6082.60463069899, 6088.269407671108, 6100.847478813021, 6105.053716673922, 27411.86294068537, 27973.72026279752, 28532.0, 28989.56515652267, 29078.563821542695, 1991.8306943909786, 2019.8081182287658, 2022.4539374368985, 2024.7772744998038, 2029.4824819671037, 18742.531436714056, 19365.4190374289, 19405.61188776231, 19426.4172074838, 19429.319973800848, 2180.7274090738656, 2210.7015552900475, 2241.5965126277265, 2250.909963601454, 2262.5248697773486, 128543.0, 134949.3252533741, 135384.0, 135636.0, 136359.0, 13617.727645447234, 14237.85762142386, 14506.709865802624, 14527.564173074825, 14674.633134171518, 22299.77700222977, 22375.440613984454, 22881.88559057194, 22976.540469190524, 23048.539029219322, 9765.658201962897, 9829.80340393188, 9895.455749933823, 9900.0, 10045.095941365313, 8916.777080572907, 8940.41887277338, 9005.05446928063, 9041.593128309241, 9134.497602631785, 8771.254443372258, 8961.193492585568, 9022.954885225532, 9108.134727200906, 9176.678816241532, 2558.260382939619, 2562.2441379793004, 2632.552466080771, 2667.7198894116227, 2732.9502872845364, 972.2950860626131, 980.9362391444533, 986.8223719730518, 989.5794287427815, 996.9551370188359, 19217.90391048036, 19514.414567562995, 19851.30520431778, 19887.204511819655, 20040.098195581235, 987.9209663226925, 1027.2809033676456, 1039.927205095651, 1047.4134484688598, 1048.7954848804409, 10736.94631526853, 10858.782824343627, 10900.50947707355, 10929.289596176222, 11098.944505277583, 444136.0, 444274.0, 462485.0, 469067.0, 472922.0, 108031.45984270185, 111107.0, 112067.0, 112321.0, 115148.0, 1155.6764106050318, 1168.4449886304108, 1195.229077245172, 1195.503865895661, 1205.0841360565857, 17139.91430042842, 17579.736303955706, 17733.11334433299, 17775.822241777416, 17793.37723179734, 50599.241011384125, 52323.47676523186, 52835.735821320646, 53300.200496993355, 53467.4653253478, 62280.377196227455, 62693.37306627058, 63448.0, 63587.682061589396, 66771.0, 13901.37443815051, 14301.713965720419, 14315.0, 14321.57035288943, 14343.641408964859, 20064.59870802605, 20415.897920510302, 20443.182272708924, 20478.0, 21107.155713771892, 15938.442154524537, 15946.88371813962, 16256.837431625532, 16261.105639189958, 16266.918665406598, 14268.928655356656, 14413.423463061361, 14433.35049922777, 15022.0, 15430.151341676315, 16627.50117496477, 16891.239894204544, 16997.660046799243, 17001.744973825156, 17002.14989250557, 14196.92901535527, 14216.431342746175, 14221.928890355483, 14227.07524010936, 14245.358958847084, 16780.748288775434, 17343.306267749653, 17361.392351267645, 17364.826351736825, 17394.73907891408], "value": 11551.923075287243, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.4173534512486, 1381.9654508637284, 1388.8958328125393, 1393.0527241475795, 1394.623451668049, 15228.467003654874, 15493.690126197469, 15908.204589770508, 15908.84091159088, 15918.124503152321, 15956.76064859028, 16179.110148941803, 16193.433229836928, 16199.676006479864, 16237.83762162378, 2761.295869553261, 2797.5384061629907, 2799.1042866282796, 2803.887844486218, 2807.7332653397893, 2701.0951331304036, 2714.9592756108673, 2742.3555464465835, 2793.553031514958, 2798.0, 2730.494858451193, 2757.4485102979384, 2757.806953513255, 2759.4205216904475, 2759.558470644697, 2638.736126387365, 2662.773664238542, 2673.652425184723, 2680.142354446578, 2681.3698780786403, 2670.9332266693295, 2687.0058078511074, 2690.6636670416196, 2704.1752265559, 2713.131797824697, 15346.386144554204, 15686.529404117895, 15694.450694225647, 15743.527694169194, 15759.842401575952, 7987.440879138463, 8273.048599411024, 8278.213569710868, 8282.213189746964, 8298.796674482226, 5275.182346736262, 5475.945240547623, 5534.640248383883, 5630.887382252332, 5675.801346952878, 1833.1292635997927, 1853.6848735714825, 1855.2486243071578, 1888.9716654250196, 1896.9525761856064, 27106.45787084267, 27345.31636709078, 27367.04215352473, 27381.86309068482, 27413.86293068542, 6921.550099243533, 6934.167899851949, 6966.895496567556, 7085.397741191953, 7092.361687448051, 17414.303427862742, 17419.129043548026, 17447.127643618023, 17470.912645436692, 17512.21195046226, 7775.4168437367425, 8035.437519373588, 8036.316913062338, 8040.115587285394, 8042.758717238492, 7381.261873812576, 7400.481966262418, 7435.85128297431, 7529.322360987538, 7537.660805263777, 4989.401271847401, 5241.633085683966, 5248.58011359098, 5269.262303277545, 5286.9471305287225, 1293.6313150751992, 1325.6288239293012, 1510.2524250496074, 1517.87856971442, 1553.937842486288, 870.3950754225752, 875.3172525430175, 887.2768693514765, 896.050186801992, 903.3495882964255, 8675.56622168889, 8878.600462979182, 8884.067172946876, 8884.955575222211, 8955.238804701674, 945.7541039329824, 983.955721992512, 989.9851502227473, 1005.6882366466418, 1026.5226669598671, 4810.182269014276, 5356.250124982427, 5470.425605311465, 5623.3533143689, 5647.717614119278, 21633.13467461284, 21833.781662183494, 22785.088596455957, 22800.771992279864, 22827.771722282898, 22261.888690556767, 22451.663225051638, 22719.545609087727, 22745.886270568873, 22775.658365124535, 11200.831987520194, 11567.88432115685, 11780.528778848922, 11854.822177667342, 11889.940550297366, 8533.786655333419, 8981.775455613662, 9128.406653567497, 9137.269018478373, 9275.0, 18809.24763009519, 19076.236950521823, 19191.32830350931, 19417.70873436928, 19719.802801971797, 19388.4183474496, 19522.20606108854, 19840.305589304306, 19860.304889328803, 20316.0, 11629.825552616549, 11947.283163010246, 11962.222455540363, 11963.461644225858, 11967.760644786882, 14327.212003339917, 14385.85614143887, 14446.711065778416, 14465.566033019026, 14627.853721462649, 11565.132615053737, 11744.412779361168, 11789.056875450115, 11959.641210763692, 12021.939890300493, 11127.833082503606, 11218.607348742755, 11249.156313276373, 11447.771044579229, 11529.1929564933, 9146.176844083799, 9163.496007719372, 9280.303977201871, 9301.441913485212, 9411.152996230372, 6830.453563714792, 6842.623655698984, 6906.516543842084, 6943.785312145702, 7049.929500704928, 7017.7192912282935, 7057.36483716468, 7074.610896400747, 7095.148582170173, 7187.0], "value": 6798.922052554347, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.9633914240422, 503.93448851649305, 527.5963887625965, 528.197140346673, 529.7192487981368, 6354.968225158879, 6389.680515974206, 6394.7761828336015, 6404.391582799638, 6407.711652975616, 6079.817605471843, 6248.84377890553, 6255.186825712651, 6260.154879091321, 6265.780697675582, 4974.651774375795, 4992.975035124819, 4998.825041123561, 5004.799808007684, 5040.445550989388, 4935.679180853251, 4967.652264341479, 4994.500549945013, 5000.874978125557, 5023.572996295301, 4825.782839772201, 4935.6545041847085, 4938.80244790208, 4939.50604939505, 4951.232558953368, 4941.50584941503, 4942.406911170665, 4942.752862356868, 4964.982178653368, 4996.575291100243, 4442.73343599385, 4460.933086003713, 4462.910741785178, 4477.574630410106, 4490.685652004361, 6214.720337584774, 6261.937380626181, 6263.937360626426, 6265.373462653698, 6279.147651442835, 5648.43515648436, 5648.830535083954, 5654.943450565483, 5662.263905692274, 5701.4013528579735, 6526.90209646851, 6546.770863019819, 6570.441512471398, 6632.966835165793, 6652.634105124216, 4798.832040878552, 4813.422389313269, 4815.686980346301, 4820.783064762094, 4839.153148199051, 6784.219814721321, 6870.828229294258, 6900.965495172542, 6915.481338899603, 6981.371676549084, 4904.215325547895, 4950.9009819803405, 4955.306257124005, 4972.085746987436, 5009.148444764399, 4947.35684361038, 4972.825951091694, 4974.552290293891, 4995.275685025651, 5034.647574669812, 5579.302587176603, 5595.076812326002, 5617.494425501724, 5626.915596266059, 5640.407757185519, 6593.901091483632, 6598.175228096488, 6607.810594093109, 6656.933430665728, 6660.70026848793, 1618.9395945655615, 1669.7912760904887, 1684.1242553871919, 1700.0649642696715, 1708.2569082449174, 1155.751513424601, 1195.8445402097673, 1218.2325135164967, 1219.5426714981882, 1228.3182833527478, 5659.349174844946, 5755.107958266475, 5762.538996880239, 5803.970980145073, 5811.970940145272, 6602.86794264112, 6648.800535983928, 6728.9570116632, 6757.526973111933, 6792.150981127359, 5761.9135712964335, 5768.826935191951, 5787.189793428924, 5827.970860145672, 5846.883062338729, 3492.161881148557, 3537.25717599307, 3578.624244454347, 3589.1924317028984, 3592.4611308303442, 6473.37828179588, 6507.772227972093, 6543.0185472179555, 6558.639274839834, 6562.80311590653, 6861.210960739479, 6971.58170509771, 7003.7548685795755, 7059.6117213552725, 7105.75129870452, 6653.434458070925, 6660.700268488026, 6675.833104172338, 6701.597904125768, 6703.12859328294, 6680.231773346128, 6719.664016799238, 6728.932710672831, 6761.661916904037, 6828.975653651793, 6585.835354116185, 6722.697478613376, 6740.056392105012, 6778.694958726967, 6801.829954251183, 6636.469082473487, 6640.335966403321, 6661.500387470862, 6663.267040625624, 6673.366030227121, 4815.422149342101, 4920.483349248278, 4934.161192597196, 4935.925961110514, 4992.375953005874, 6684.364985326386, 6726.7981960541265, 6782.491313151632, 6793.456523478011, 6853.984246931334, 6497.610143391223, 6579.2104947404705, 6594.109795177781, 6622.701978410887, 6636.170478690164, 6629.4696424284975, 6635.270120286861, 6636.469082473487, 6644.136262286065, 6680.6993685283305, 6284.0, 6461.61230326182, 6482.2869484357625, 6497.415232629086, 6578.276389597045, 6437.388448097423, 6617.31258529072, 6640.468762498892, 6674.332566743286, 6688.565243259172, 6367.93632063692, 6395.552311338348, 6396.872062558629, 6422.743090276524, 6435.839104022437], "value": 5066.785112231644, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [904.8416527107754, 908.9636414543419, 926.7544100813284, 934.472023306832, 935.5228833295017, 17464.214110365032, 20611.69082463764, 22522.32433027012, 22587.435314117156, 22595.54808903821, 20734.896325518388, 21208.787912120875, 21284.0, 21314.147434102655, 21333.893330533363, 898.2409863665209, 963.0610155098793, 971.8445048792195, 971.9319647624669, 972.1736523954653, 951.048951048951, 970.3595626886256, 976.9853452198223, 985.3348989432104, 988.184747583243, 1037.8443233514959, 1039.1478987230473, 1039.469870366111, 1041.208681402136, 1041.9687409377693, 1035.5236591168073, 1036.424784244744, 1037.7820657661862, 1038.5326603028668, 1038.5482315192878, 753.2730914667318, 753.3746989998289, 753.6231884057971, 753.7776355975001, 759.1876691939627, 18268.725969110474, 18342.816571834377, 19459.0, 19604.117814698373, 19639.509012274808, 21954.0, 22110.115595376166, 22157.556848862932, 22857.19999799999, 22894.54210915789, 17272.30910763568, 17317.913410432993, 17450.65098698019, 17459.825401745948, 17508.0, 3690.852365905361, 3694.4827724118645, 3713.387291096966, 3714.0, 3716.572594151653, 130988.34505827409, 131817.0, 132165.0, 133859.33070334585, 135179.32410337983, 16598.419055333005, 16729.330826767036, 17107.91446042762, 17289.3948711797, 17302.740458893128, 30259.394812103634, 31288.0, 31411.37177256442, 31730.524042139386, 31845.681543184273, 8335.333173346118, 8426.283765879969, 8524.616392262364, 8525.488470691778, 8545.188207120314, 4211.768352740567, 4282.35764635301, 4282.421873047098, 4288.849890253826, 4301.333293339538, 5193.324867767166, 5289.0, 5289.47105289468, 5298.523132917979, 5320.148776195868, 1081.4376524207369, 1111.6220485035126, 1119.9328040317607, 1123.9943800280946, 1127.1208457403238, 678.6369292428527, 694.1635329428027, 697.7941507255372, 707.904432901562, 717.5551158281899, 11208.887911120948, 12382.380880955916, 12496.937515312366, 12656.240625562496, 13174.934125329504, 650.2716957008087, 658.7253664159866, 661.7584581627672, 665.3280187011154, 672.9938741581367, 5391.838244852661, 5392.352917649907, 5408.432114627986, 5473.2063850741415, 5499.230107784913, 107084.0, 107887.0, 108938.45530772295, 109248.0, 110406.0, 93694.53152734193, 94052.52973735088, 96897.5155124234, 98963.01036989682, 99411.0, 80791.19208807954, 83006.0, 83767.16232837715, 84415.57792211123, 86981.5650921754, 11867.525298987945, 12092.274463532216, 12149.574764883188, 12254.20347677398, 12498.43757030954, 40638.79680601578, 41094.1781164381, 41186.79406602948, 41408.171836563706, 41496.1700765989, 69826.65086674535, 70067.64966175136, 73206.63396682983, 73527.63236183785, 76193.61903190448, 17149.71377146744, 18165.909170454062, 18211.635767284846, 18216.089195540437, 18286.908565457088, 20333.389998300074, 20523.0, 20801.271955481487, 21315.46711332167, 21377.144914203258, 17662.823371766633, 18084.276628935222, 18502.167402467192, 18749.250029998646, 18917.527061823566, 17123.743143852604, 17768.55578610545, 18799.342023029127, 18870.150843211813, 19090.427287181406, 15599.220038998232, 15610.141442220787, 15754.0, 18270.0, 18299.90850045741, 11994.460249288628, 12363.196392234477, 12378.381080946097, 12403.25580465139, 12645.430955607204, 13517.121387109806, 13849.16904985704, 13876.861231387556, 13933.651658708613, 14008.859911400756], "value": 9186.194905280143, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1476.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 107.0, 100.0, 108.0, 108.0, 108.0, 108.0, 98.0, 108.0, 109.0], "value": 105.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 115.0, 140.0, 175.0, 119.0, 149.0, 144.0, 119.0, 171.0, 120.0], "value": 140.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 162.0, 162.0, 169.0, 162.0, 162.0, 163.0, 166.0, 169.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 74.0, 186.0, 74.0, 77.0, 73.0, 88.0, 97.0, 75.0], "value": 89.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 132.0, 80.0, 79.0, 79.0, 123.0, 79.0, 79.0, 129.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 115.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 148.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 99.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 93.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 54.0, 51.0, 51.0, 51.0, 52.0, 52.0, 51.0, 52.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 37.0, 38.0, 37.0, 37.0, 38.0, 37.0, 38.0, 37.0, 38.0], "value": 37.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 77.0, 75.0, 74.0, 73.0, 75.0, 74.0, 75.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 131.0, 130.0, 116.0, 116.0, 126.0, 130.0, 116.0, 118.0, 153.0], "value": 125.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 177.0, 170.0, 177.0, 174.0, 173.0, 169.0, 165.0, 168.0, 171.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 64.0, 65.0, 65.0, 64.0, 69.0, 64.0, 64.0], "value": 65.0, "unit": "score"}]}]} 11:37:31 INFO - Return code: 0 11:37:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:37:31 INFO - # TBPL SUCCESS # 11:37:31 INFO - Running post-action listener: _package_coverage_data 11:37:31 INFO - Running post-action listener: _resource_record_post_action 11:37:31 INFO - [mozharness: 2017-08-31 18:37:31.082628Z] Finished run-tests step (success) 11:37:31 INFO - Running post-run listener: _resource_record_post_run 11:37:31 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 16384; Write bytes: 390152192; Read time: 220; Write time: 417352 11:37:31 INFO - TinderboxPrint: CPU usage
13.1% 11:37:31 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 220 11:37:31 INFO - TinderboxPrint: I/O write bytes / time
390,152,192 / 417,352 11:37:31 INFO - TinderboxPrint: CPU idle
8,243.7 (86.9%) 11:37:31 INFO - TinderboxPrint: CPU user
1,192.5 (12.6%) 11:37:31 INFO - TinderboxPrint: Swap in / out
0 / 0 11:37:31 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 68726784; Read time: 44; Write time: 44876 11:37:31 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:37:31 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 12288; Write bytes: 282902528; Read time: 176; Write time: 240572 11:37:31 INFO - Running post-run listener: _upload_blobber_files 11:37:31 INFO - Blob upload gear active. 11:37:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:37:31 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:37:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:37:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:37:32 INFO - (blobuploader) - INFO - Open directory for files ... 11:37:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:37:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:37:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:35 INFO - (blobuploader) - INFO - Done attempting. 11:37:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:37:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:37:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:36 INFO - (blobuploader) - INFO - Done attempting. 11:37:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:37:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:37:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:37 INFO - (blobuploader) - INFO - Done attempting. 11:37:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:37:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:37:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:38 INFO - (blobuploader) - INFO - Done attempting. 11:37:38 INFO - (blobuploader) - INFO - Iteration through files over. 11:37:38 INFO - Return code: 0 11:37:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:37:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:37:38 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f948d64c3a0a50e5ca0b10ed0ecbe06cee28d5635946c0462a30760baeb73a290c9f39ee6df9bde122c80863fee6879df9e4fb07a66ab8198ddaee1d4049b3a3", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa47f25c1089295b702a6f523db9478c166eca0144c5eabb29d89d4841aff65d75ed77ee4fb8271ba60c351c0f4ed6ff646315fac713d017d9bf6780e6cf61a7", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1e2a914f8d0344094cde8270e9f90e63eb36cc64bbe7ca85febfc0fb34b10167e7d212ca05fece54dd1377c0c49eceae1212facb09091362ae9214e3d885f64", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efd126128dbcae7ea5dd7745b04b097900a6d419db7deb02986a8fa681a378853f493c15c816be862cef9dd4e52d1d27038ec72f91b758386de0fa9cc16e5869"} 11:37:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:37:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:37:38 INFO - Contents: 11:37:38 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f948d64c3a0a50e5ca0b10ed0ecbe06cee28d5635946c0462a30760baeb73a290c9f39ee6df9bde122c80863fee6879df9e4fb07a66ab8198ddaee1d4049b3a3", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa47f25c1089295b702a6f523db9478c166eca0144c5eabb29d89d4841aff65d75ed77ee4fb8271ba60c351c0f4ed6ff646315fac713d017d9bf6780e6cf61a7", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1e2a914f8d0344094cde8270e9f90e63eb36cc64bbe7ca85febfc0fb34b10167e7d212ca05fece54dd1377c0c49eceae1212facb09091362ae9214e3d885f64", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efd126128dbcae7ea5dd7745b04b097900a6d419db7deb02986a8fa681a378853f493c15c816be862cef9dd4e52d1d27038ec72f91b758386de0fa9cc16e5869"} 11:37:38 INFO - Running post-run listener: copy_logs_to_upload_dir 11:37:38 INFO - Copying logs to upload dir... 11:37:38 INFO - mkdir: /builds/slave/test/build/upload/logs 11:37:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.285373 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-08-31 11:37:38.429104) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-31 11:37:38.433526) ========= 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=af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952 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/f948d64c3a0a50e5ca0b10ed0ecbe06cee28d5635946c0462a30760baeb73a290c9f39ee6df9bde122c80863fee6879df9e4fb07a66ab8198ddaee1d4049b3a3", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa47f25c1089295b702a6f523db9478c166eca0144c5eabb29d89d4841aff65d75ed77ee4fb8271ba60c351c0f4ed6ff646315fac713d017d9bf6780e6cf61a7", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1e2a914f8d0344094cde8270e9f90e63eb36cc64bbe7ca85febfc0fb34b10167e7d212ca05fece54dd1377c0c49eceae1212facb09091362ae9214e3d885f64", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efd126128dbcae7ea5dd7745b04b097900a6d419db7deb02986a8fa681a378853f493c15c816be862cef9dd4e52d1d27038ec72f91b758386de0fa9cc16e5869"} build_url:https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011399 build_url: 'https://queue.taskcluster.net/v1/task/JlZ4lx7RTwaSgq5fLFMGvQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f948d64c3a0a50e5ca0b10ed0ecbe06cee28d5635946c0462a30760baeb73a290c9f39ee6df9bde122c80863fee6879df9e4fb07a66ab8198ddaee1d4049b3a3", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa47f25c1089295b702a6f523db9478c166eca0144c5eabb29d89d4841aff65d75ed77ee4fb8271ba60c351c0f4ed6ff646315fac713d017d9bf6780e6cf61a7", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1e2a914f8d0344094cde8270e9f90e63eb36cc64bbe7ca85febfc0fb34b10167e7d212ca05fece54dd1377c0c49eceae1212facb09091362ae9214e3d885f64", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efd126128dbcae7ea5dd7745b04b097900a6d419db7deb02986a8fa681a378853f493c15c816be862cef9dd4e52d1d27038ec72f91b758386de0fa9cc16e5869"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-31 11:37:38.463734) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 11:37:38.464142) ========= 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=af724c981e2a0f424dbabf99000001e7-1504203407.376159-775435952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 11:37:38.543973) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-31 11:37:38.547309) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-31 11:37:38.547627) ========= ========= Total master_lag: 0.23 =========