builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-087 starttime: 1506537742.56 results: success (0) revision: 6100472d3aa833dff22a4edb0934fe600f43ddb8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 11:42:22.565238) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 11:42:22.565662) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 11:42:22.565931) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 11:42:22.612696) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:42:22.613005) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-27 11:42:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 229M=0s 2017-09-27 11:42:22 (229 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.191127 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:42:22.853234) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:42:22.854524) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020139 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:42:22.904532) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-27 11:42:22.904886) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6100472d3aa833dff22a4edb0934fe600f43ddb8 --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 6100472d3aa833dff22a4edb0934fe600f43ddb8 --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=ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-27 11:42:22,988 truncating revision to first 12 chars 2017-09-27 11:42:22,988 Setting DEBUG logging. 2017-09-27 11:42:22,988 attempt 1/10 2017-09-27 11:42:22,988 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6100472d3aa8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-27 11:42:23,682 unpacking tar archive at: mozilla-central-6100472d3aa8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.005333 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-27 11:42:23.928213) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 11:42:23.931578) ========= script_repo_revision: 6100472d3aa833dff22a4edb0934fe600f43ddb8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 11:42:23.931948) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 11:42:23.932211) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 11:42:23.947356) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-27 11:42:23.947644) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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-stylo-disabled-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=ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:42:24 INFO - MultiFileLogger online at 20170927 11:42:24 in /builds/slave/test 11:42:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:42:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:42:24 INFO - {'append_to_log': False, 11:42:24 INFO - 'base_work_dir': '/builds/slave/test', 11:42:24 INFO - 'blob_upload_branch': 'Firefox', 11:42:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:42:24 INFO - 'branch': 'Firefox', 11:42:24 INFO - 'buildbot_json_path': 'buildprops.json', 11:42:24 INFO - 'code_coverage': False, 11:42:24 INFO - 'config_files': ('talos/linux_config.py',), 11:42:24 INFO - 'default_actions': ('clobber', 11:42:24 INFO - 'read-buildbot-config', 11:42:24 INFO - 'download-and-extract', 11:42:24 INFO - 'populate-webroot', 11:42:24 INFO - 'create-virtualenv', 11:42:24 INFO - 'install', 11:42:24 INFO - 'setup-mitmproxy', 11:42:24 INFO - 'run-tests'), 11:42:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:42:24 INFO - 'disable_ccov_upload': False, 11:42:24 INFO - 'disable_stylo': False, 11:42:24 INFO - 'download_minidump_stackwalk': True, 11:42:24 INFO - 'download_symbols': 'ondemand', 11:42:24 INFO - 'enable_stylo': False, 11:42:24 INFO - 'enable_webrender': False, 11:42:24 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:42:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:42:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:42:24 INFO - 'gecko_profile': False, 11:42:24 INFO - 'gecko_profile_interval': 0, 11:42:24 INFO - 'installer_path': 'installer.exe', 11:42:24 INFO - 'log_level': 'info', 11:42:24 INFO - 'log_name': 'talos', 11:42:24 INFO - 'log_to_console': True, 11:42:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:42:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:42:24 INFO - 'opt_config_files': (), 11:42:24 INFO - 'pip_index': False, 11:42:24 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 11:42:24 INFO - 'system_bits': '32', 11:42:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:42:24 INFO - 'title': 'talos-linux64-ix-087', 11:42:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:42:24 INFO - 'use_talos_json': True, 11:42:24 INFO - 'verify': 'False', 11:42:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:42:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:42:24 INFO - 'work_dir': 'build'} 11:42:24 INFO - [mozharness: 2017-09-27 18:42:24.273031Z] Running clobber step. 11:42:24 INFO - Running pre-action listener: _resource_record_pre_action 11:42:24 INFO - Running main action method: clobber 11:42:24 INFO - rmtree: /builds/slave/test/build 11:42:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:42:25 INFO - Running post-action listener: _resource_record_post_action 11:42:25 INFO - [mozharness: 2017-09-27 18:42:25.227913Z] Finished clobber step (success) 11:42:25 INFO - [mozharness: 2017-09-27 18:42:25.228010Z] Running read-buildbot-config step. 11:42:25 INFO - Running pre-action listener: _resource_record_pre_action 11:42:25 INFO - Running main action method: read_buildbot_config 11:42:25 INFO - Using buildbot properties: 11:42:25 INFO - { 11:42:25 INFO - "project": "", 11:42:25 INFO - "product": "firefox", 11:42:25 INFO - "who": "ryanvm@gmail.com", 11:42:25 INFO - "installer_path": "public/build/target.tar.bz2", 11:42:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 11:42:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:42:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 11:42:25 INFO - "stage_platform": "linux64-pgo", 11:42:25 INFO - "basedir": "/builds/slave/test", 11:42:25 INFO - "buildnumber": 45, 11:42:25 INFO - "platform": "ubuntu64_hw", 11:42:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:42:25 INFO - "slavebuilddir": "test", 11:42:25 INFO - "taskId": "FhQgNT3RSBWTBaZQbaUugw", 11:42:25 INFO - "branch": "mozilla-central", 11:42:25 INFO - "script_repo_revision": "production", 11:42:25 INFO - "revision": "6100472d3aa833dff22a4edb0934fe600f43ddb8", 11:42:25 INFO - "slavename": "talos-linux64-ix-087", 11:42:25 INFO - "repo_path": "mozilla-central" 11:42:25 INFO - } 11:42:25 INFO - Finding installer, test and symbols from parent task. 11:42:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FhQgNT3RSBWTBaZQbaUugw'}, attempt #1 11:42:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FhQgNT3RSBWTBaZQbaUugw'}, attempt #1 11:42:26 INFO - Task dependencies: SjP9pZd8TymPHLMi-QrYag 11:42:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag'}, attempt #1 11:42:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.tar.bz2 11:42:26 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.test_packages.json 11:42:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.crashreporter-symbols.zip 11:42:26 INFO - Running post-action listener: _resource_record_post_action 11:42:26 INFO - [mozharness: 2017-09-27 18:42:26.568583Z] Finished read-buildbot-config step (success) 11:42:26 INFO - [mozharness: 2017-09-27 18:42:26.568798Z] Running download-and-extract step. 11:42:26 INFO - Running pre-action listener: _resource_record_pre_action 11:42:26 INFO - Running main action method: download_and_extract 11:42:26 INFO - mkdir: /builds/slave/test/build/tests 11:42:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:26 INFO - trying https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.test_packages.json 11:42:26 INFO - Downloading https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:42:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:42:27 INFO - Downloaded 989 bytes. 11:42:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:42:27 INFO - Using the following test package requirements: 11:42:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:42:27 INFO - u'common': [u'target.common.tests.zip'], 11:42:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:42:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:42:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:42:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:42:27 INFO - u'mozbase': [u'target.common.tests.zip'], 11:42:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:42:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:42:27 INFO - u'web-platform': [u'target.common.tests.zip', 11:42:27 INFO - u'target.web-platform.tests.tar.gz'], 11:42:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:42:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:42:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.common.tests.zip 11:42:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:42:27 INFO - Fetch https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.common.tests.zip into memory 11:42:28 INFO - Content-Length response header: 55350197 11:42:28 INFO - Bytes received: 55350197 11:42:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.talos.tests.zip 11:42:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:42:38 INFO - Fetch https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.talos.tests.zip into memory 11:42:39 INFO - Content-Length response header: 14513665 11:42:39 INFO - Bytes received: 14513665 11:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:39 INFO - trying https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.tar.bz2 11:42:39 INFO - Downloading https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:42:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:42:41 INFO - Downloaded 62312035 bytes. 11:42:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.tar.bz2 11:42:41 INFO - mkdir: /builds/slave/test/properties 11:42:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:42:41 INFO - Writing to file /builds/slave/test/properties/build_url 11:42:41 INFO - Contents: 11:42:41 INFO - build_url:https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.tar.bz2 11:42:41 INFO - Running post-action listener: _resource_record_post_action 11:42:41 INFO - Running post-action listener: find_tests_for_verification 11:42:41 INFO - Running post-action listener: set_extra_try_arguments 11:42:41 INFO - [mozharness: 2017-09-27 18:42:41.035958Z] Finished download-and-extract step (success) 11:42:41 INFO - [mozharness: 2017-09-27 18:42:41.036055Z] Running populate-webroot step. 11:42:41 INFO - Running pre-action listener: _resource_record_pre_action 11:42:41 INFO - Running main action method: populate_webroot 11:42:41 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:42:41 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:42:41 INFO - 'tests': ['tresize', 11:42:41 INFO - 'tcanvasmark']}, 11:42:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:42:41 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:42:41 INFO - 'tests': ['dromaeo_css', 11:42:41 INFO - 'kraken']}, 11:42:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:42:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:42:41 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:42:41 INFO - 'talos_options': ['--disable-stylo'], 11:42:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:42:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:42:41 INFO - 'tests': ['damp', 'tps']}, 11:42:41 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:42:41 INFO - 'talos_options': ['--disable-stylo'], 11:42:41 INFO - 'tests': ['damp', 'tps']}, 11:42:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:42:41 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:42:41 INFO - 'tests': ['dromaeo_dom']}, 11:42:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:42:41 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:42:41 INFO - 'tests': ['basic_compositor_video', 11:42:41 INFO - 'glvideo']}, 11:42:41 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:42:41 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:42:41 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:42:41 INFO - 'talos_options': ['--disable-stylo'], 11:42:41 INFO - 'tests': ['ts_paint_webext', 11:42:41 INFO - 'tp5o_webext']}, 11:42:41 INFO - 'other-e10s': {'tests': ['a11yr', 11:42:41 INFO - 'ts_paint', 11:42:41 INFO - 'tpaint', 11:42:41 INFO - 'sessionrestore', 11:42:41 INFO - 'sessionrestore_many_windows', 11:42:41 INFO - 'sessionrestore_no_auto_restore', 11:42:41 INFO - 'tabpaint']}, 11:42:41 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:42:41 INFO - 'tests': ['a11yr', 11:42:41 INFO - 'ts_paint', 11:42:41 INFO - 'tpaint', 11:42:41 INFO - 'sessionrestore', 11:42:41 INFO - 'sessionrestore_many_windows', 11:42:41 INFO - 'sessionrestore_no_auto_restore', 11:42:41 INFO - 'tabpaint']}, 11:42:41 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 11:42:41 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:42:41 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:42:41 INFO - 'tests': ['perf_reftest_singletons']}, 11:42:41 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:42:41 INFO - 'tests': ['perf_reftest']}, 11:42:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:42:41 INFO - 'tsvgr_opacity', 11:42:41 INFO - 'tart', 11:42:41 INFO - 'tscrollx', 11:42:41 INFO - 'tsvg_static']}, 11:42:41 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:42:41 INFO - 'tests': ['tsvgx', 11:42:41 INFO - 'tsvgr_opacity', 11:42:41 INFO - 'tart', 11:42:41 INFO - 'tscrollx', 11:42:41 INFO - 'tsvg_static']}, 11:42:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:42:41 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:42:41 INFO - 'talos_options': ['--disable-stylo'], 11:42:41 INFO - 'tests': ['tp5o']}, 11:42:41 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:42:41 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:42:41 INFO - 'talos_options': ['--mitmproxy', 11:42:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:42:41 INFO - '--firstNonBlankPaint'], 11:42:41 INFO - 'tests': ['tp6_google', 11:42:41 INFO - 'tp6_youtube', 11:42:41 INFO - 'tp6_amazon', 11:42:41 INFO - 'tp6_facebook']}, 11:42:41 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:42:41 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:42:41 INFO - 'talos_options': ['--disable-stylo', 11:42:41 INFO - '--mitmproxy', 11:42:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:42:41 INFO - '--firstNonBlankPaint'], 11:42:41 INFO - 'tests': ['tp6_google', 11:42:41 INFO - 'tp6_youtube', 11:42:41 INFO - 'tp6_amazon', 11:42:41 INFO - 'tp6_facebook']}, 11:42:41 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:42:41 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:42:41 INFO - 'talos_options': ['--stylo-threads=1', 11:42:41 INFO - '--mitmproxy', 11:42:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:42:41 INFO - '--firstNonBlankPaint'], 11:42:41 INFO - 'tests': ['tp6_google', 11:42:41 INFO - 'tp6_youtube', 11:42:41 INFO - 'tp6_amazon', 11:42:41 INFO - 'tp6_facebook']}, 11:42:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:42:41 INFO - 'talos_options': ['--xperf_path', 11:42:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:42:41 INFO - 'tests': ['tp5n']}, 11:42:41 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:42:41 INFO - 'talos_options': ['--disable-stylo', 11:42:41 INFO - '--xperf_path', 11:42:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:42:41 INFO - 'tests': ['tp5n']}}} 11:42:41 INFO - Running post-action listener: _resource_record_post_action 11:42:41 INFO - [mozharness: 2017-09-27 18:42:41.051506Z] Finished populate-webroot step (success) 11:42:41 INFO - [mozharness: 2017-09-27 18:42:41.051595Z] Running create-virtualenv step. 11:42:41 INFO - Running pre-action listener: _resource_record_pre_action 11:42:41 INFO - Running main action method: create_virtualenv 11:42:41 INFO - Creating virtualenv /builds/slave/test/build/venv 11:42:41 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:42:41 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:42:41 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:42:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:42:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:42:41 INFO - Installing distribute.............................................................................................................................................................................................done. 11:42:42 INFO - Installing pip...............done. 11:42:43 INFO - Return code: 0 11:42:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:42:44 INFO - Reading from file tmpfile_stdout 11:42:44 INFO - Output received: 11:42:44 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:42:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:42:44 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:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:44 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:42:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:44 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 0xd281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10959c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092d60>, '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 0x1093a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093ef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521', '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:42:44 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:42:44 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:42:44 INFO - Using env: {'DISPLAY': ':0', 11:42:44 INFO - 'HOME': '/home/cltbld', 11:42:44 INFO - 'LANG': 'en_US.UTF-8', 11:42:44 INFO - 'LANGUAGE': 'en_US:en', 11:42:44 INFO - 'LOGNAME': 'cltbld', 11:42:44 INFO - 'MAIL': '/var/mail/cltbld', 11:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:44 INFO - 'MOZ_NO_REMOTE': '1', 11:42:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:44 INFO - 'NO_EM_RESTART': '1', 11:42:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:44 INFO - 'PWD': '/builds/slave/test', 11:42:44 INFO - 'SHELL': '/bin/bash', 11:42:44 INFO - 'SHLVL': '1', 11:42:44 INFO - 'TERM': 'linux', 11:42:44 INFO - 'TMOUT': '86400', 11:42:44 INFO - 'USER': 'cltbld', 11:42:44 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521', 11:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:44 INFO - '_': '/tools/buildbot/bin/python'} 11:42:45 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:42:45 INFO - Downloading/unpacking pip>=1.5 11:42:45 INFO - Running setup.py egg_info for package pip 11:42:45 INFO - warning: no files found matching 'pip/cacert.pem' 11:42:45 INFO - warning: no files found matching '*.html' under directory 'docs' 11:42:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:42:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:42:45 INFO - Installing collected packages: pip 11:42:45 INFO - Found existing installation: pip 1.1 11:42:45 INFO - Uninstalling pip: 11:42:45 INFO - Successfully uninstalled pip 11:42:45 INFO - Running setup.py install for pip 11:42:45 INFO - warning: no files found matching 'pip/cacert.pem' 11:42:45 INFO - warning: no files found matching '*.html' under directory 'docs' 11:42:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:42:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:42:45 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:42:45 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:42:45 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:42:45 INFO - Successfully installed pip 11:42:45 INFO - Cleaning up... 11:42:45 INFO - Return code: 0 11:42:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10959c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092d60>, '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 0x1093a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093ef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521', '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:42:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:42:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:42:45 INFO - Using env: {'DISPLAY': ':0', 11:42:45 INFO - 'HOME': '/home/cltbld', 11:42:45 INFO - 'LANG': 'en_US.UTF-8', 11:42:45 INFO - 'LANGUAGE': 'en_US:en', 11:42:45 INFO - 'LOGNAME': 'cltbld', 11:42:45 INFO - 'MAIL': '/var/mail/cltbld', 11:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:45 INFO - 'MOZ_NO_REMOTE': '1', 11:42:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:45 INFO - 'NO_EM_RESTART': '1', 11:42:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:45 INFO - 'PWD': '/builds/slave/test', 11:42:45 INFO - 'SHELL': '/bin/bash', 11:42:45 INFO - 'SHLVL': '1', 11:42:45 INFO - 'TERM': 'linux', 11:42:45 INFO - 'TMOUT': '86400', 11:42:45 INFO - 'USER': 'cltbld', 11:42:45 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521', 11:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:45 INFO - '_': '/tools/buildbot/bin/python'} 11:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:45 INFO - Downloading/unpacking psutil>=3.1.1 11:42:45 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:42:45 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:42:45 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:42:45 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:42:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:42:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:42:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:42:47 INFO - Installing collected packages: psutil 11:42:47 INFO - Running setup.py install for psutil 11:42:47 INFO - building 'psutil._psutil_linux' extension 11:42:47 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:42:48 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:42:48 INFO - building 'psutil._psutil_posix' extension 11:42:48 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:42:48 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:42:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:42:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:42:48 INFO - Successfully installed psutil 11:42:48 INFO - Cleaning up... 11:42:48 INFO - Return code: 0 11:42:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:42:48 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:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:48 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:42:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:48 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 0xd281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10959c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092d60>, '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 0x1093a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093ef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521', '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:42:48 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:42:48 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:42:48 INFO - Using env: {'DISPLAY': ':0', 11:42:48 INFO - 'HOME': '/home/cltbld', 11:42:48 INFO - 'LANG': 'en_US.UTF-8', 11:42:48 INFO - 'LANGUAGE': 'en_US:en', 11:42:48 INFO - 'LOGNAME': 'cltbld', 11:42:48 INFO - 'MAIL': '/var/mail/cltbld', 11:42:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:48 INFO - 'MOZ_NO_REMOTE': '1', 11:42:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:48 INFO - 'NO_EM_RESTART': '1', 11:42:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:48 INFO - 'PWD': '/builds/slave/test', 11:42:48 INFO - 'SHELL': '/bin/bash', 11:42:48 INFO - 'SHLVL': '1', 11:42:48 INFO - 'TERM': 'linux', 11:42:48 INFO - 'TMOUT': '86400', 11:42:48 INFO - 'USER': 'cltbld', 11:42:48 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521', 11:42:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:48 INFO - '_': '/tools/buildbot/bin/python'} 11:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:42:49 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:42:49 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:42:49 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:42:49 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:42:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:42:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:42:50 INFO - Installing collected packages: mozsystemmonitor 11:42:50 INFO - Running setup.py install for mozsystemmonitor 11:42:50 INFO - Successfully installed mozsystemmonitor 11:42:50 INFO - Cleaning up... 11:42:50 INFO - Return code: 0 11:42:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:50 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 0xd281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10959c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092d60>, '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 0x1093a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093ef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521', '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:42:50 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:42:50 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:42:50 INFO - Using env: {'DISPLAY': ':0', 11:42:50 INFO - 'HOME': '/home/cltbld', 11:42:50 INFO - 'LANG': 'en_US.UTF-8', 11:42:50 INFO - 'LANGUAGE': 'en_US:en', 11:42:50 INFO - 'LOGNAME': 'cltbld', 11:42:50 INFO - 'MAIL': '/var/mail/cltbld', 11:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:50 INFO - 'MOZ_NO_REMOTE': '1', 11:42:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:50 INFO - 'NO_EM_RESTART': '1', 11:42:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:50 INFO - 'PWD': '/builds/slave/test', 11:42:50 INFO - 'SHELL': '/bin/bash', 11:42:50 INFO - 'SHLVL': '1', 11:42:50 INFO - 'TERM': 'linux', 11:42:50 INFO - 'TMOUT': '86400', 11:42:50 INFO - 'USER': 'cltbld', 11:42:50 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521', 11:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:50 INFO - '_': '/tools/buildbot/bin/python'} 11:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:50 INFO - Downloading/unpacking jsonschema==2.5.1 11:42:50 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:42:50 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:42:50 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:42:50 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:42:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:42:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:42:51 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:42:51 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:42:51 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:42:51 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:42:51 INFO - Downloading functools32-3.2.3-2.tar.gz 11:42:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:42:51 INFO - warning: no files found matching '*.txt' 11:42:51 INFO - no previously-included directories found matching 'build' 11:42:51 INFO - no previously-included directories found matching 'dist' 11:42:51 INFO - no previously-included directories found matching '.git*' 11:42:51 INFO - Installing collected packages: jsonschema, functools32 11:42:51 INFO - Running setup.py install for functools32 11:42:52 INFO - warning: no files found matching '*.txt' 11:42:52 INFO - no previously-included directories found matching 'build' 11:42:52 INFO - no previously-included directories found matching 'dist' 11:42:52 INFO - no previously-included directories found matching '.git*' 11:42:52 INFO - Successfully installed jsonschema functools32 11:42:52 INFO - Cleaning up... 11:42:52 INFO - Return code: 0 11:42:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10959c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092d60>, '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 0x1093a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093ef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521', '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:42:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:42:52 INFO - Using env: {'DISPLAY': ':0', 11:42:52 INFO - 'HOME': '/home/cltbld', 11:42:52 INFO - 'LANG': 'en_US.UTF-8', 11:42:52 INFO - 'LANGUAGE': 'en_US:en', 11:42:52 INFO - 'LOGNAME': 'cltbld', 11:42:52 INFO - 'MAIL': '/var/mail/cltbld', 11:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:52 INFO - 'MOZ_NO_REMOTE': '1', 11:42:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:52 INFO - 'NO_EM_RESTART': '1', 11:42:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:52 INFO - 'PWD': '/builds/slave/test', 11:42:52 INFO - 'SHELL': '/bin/bash', 11:42:52 INFO - 'SHLVL': '1', 11:42:52 INFO - 'TERM': 'linux', 11:42:52 INFO - 'TMOUT': '86400', 11:42:52 INFO - 'USER': 'cltbld', 11:42:52 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521', 11:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:52 INFO - '_': '/tools/buildbot/bin/python'} 11:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:42:52 INFO - Cleaning up... 11:42:52 INFO - Return code: 0 11:42:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10959c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092d60>, '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 0x1093a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093ef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521', '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:42:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:42:52 INFO - Using env: {'DISPLAY': ':0', 11:42:52 INFO - 'HOME': '/home/cltbld', 11:42:52 INFO - 'LANG': 'en_US.UTF-8', 11:42:52 INFO - 'LANGUAGE': 'en_US:en', 11:42:52 INFO - 'LOGNAME': 'cltbld', 11:42:52 INFO - 'MAIL': '/var/mail/cltbld', 11:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:52 INFO - 'MOZ_NO_REMOTE': '1', 11:42:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:52 INFO - 'NO_EM_RESTART': '1', 11:42:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:52 INFO - 'PWD': '/builds/slave/test', 11:42:52 INFO - 'SHELL': '/bin/bash', 11:42:52 INFO - 'SHLVL': '1', 11:42:52 INFO - 'TERM': 'linux', 11:42:52 INFO - 'TMOUT': '86400', 11:42:52 INFO - 'USER': 'cltbld', 11:42:52 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521', 11:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:52 INFO - '_': '/tools/buildbot/bin/python'} 11:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:52 INFO - Downloading/unpacking blobuploader==1.2.4 11:42:52 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:42:52 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:42:52 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:42:52 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:42:53 INFO - Downloading blobuploader-1.2.4.tar.gz 11:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:42:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:42:53 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:42:53 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:42:53 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:42:53 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:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:42:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:54 INFO - Downloading docopt-0.6.1.tar.gz 11:42:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:42:54 INFO - Installing collected packages: blobuploader, requests, docopt 11:42:54 INFO - Running setup.py install for blobuploader 11:42:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:42:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:42:54 INFO - Running setup.py install for requests 11:42:54 INFO - Running setup.py install for docopt 11:42:54 INFO - Successfully installed blobuploader requests docopt 11:42:54 INFO - Cleaning up... 11:42:54 INFO - Return code: 0 11:42:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:54 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 0xd281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10959c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092d60>, '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 0x1093a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093ef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521', '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:42:54 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:42:54 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:42:54 INFO - Using env: {'DISPLAY': ':0', 11:42:54 INFO - 'HOME': '/home/cltbld', 11:42:54 INFO - 'LANG': 'en_US.UTF-8', 11:42:54 INFO - 'LANGUAGE': 'en_US:en', 11:42:54 INFO - 'LOGNAME': 'cltbld', 11:42:54 INFO - 'MAIL': '/var/mail/cltbld', 11:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:54 INFO - 'MOZ_NO_REMOTE': '1', 11:42:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:54 INFO - 'NO_EM_RESTART': '1', 11:42:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:54 INFO - 'PWD': '/builds/slave/test', 11:42:54 INFO - 'SHELL': '/bin/bash', 11:42:54 INFO - 'SHLVL': '1', 11:42:54 INFO - 'TERM': 'linux', 11:42:54 INFO - 'TMOUT': '86400', 11:42:54 INFO - 'USER': 'cltbld', 11:42:54 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521', 11:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:54 INFO - '_': '/tools/buildbot/bin/python'} 11:42:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:42:55 INFO - Running setup.py (path:/tmp/pip-S6PknF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:42:55 INFO - Running setup.py (path:/tmp/pip-jqTPaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:42:55 INFO - Running setup.py (path:/tmp/pip-TMKwzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:42:55 INFO - Running setup.py (path:/tmp/pip-EdWskc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:42:55 INFO - Running setup.py (path:/tmp/pip-0PXwX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:42:55 INFO - Running setup.py (path:/tmp/pip-7tyMaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:42:55 INFO - Running setup.py (path:/tmp/pip-6XnP3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:42:55 INFO - Running setup.py (path:/tmp/pip-QH5BrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:42:55 INFO - Running setup.py (path:/tmp/pip-LGVHGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:42:55 INFO - Running setup.py (path:/tmp/pip-FhtUAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:42:55 INFO - Running setup.py (path:/tmp/pip-0K9mIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:42:55 INFO - Running setup.py (path:/tmp/pip-EHIG1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:42:55 INFO - Running setup.py (path:/tmp/pip-iV2fk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:42:55 INFO - Running setup.py (path:/tmp/pip-2d5wTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:56 INFO - Running setup.py (path:/tmp/pip-6cWz9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:42:56 INFO - Running setup.py (path:/tmp/pip-U4_jt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:42:56 INFO - Running setup.py (path:/tmp/pip-bwSfNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:42:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:42:56 INFO - Running setup.py install for manifestparser 11:42:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:42:56 INFO - Running setup.py install for mozcrash 11:42:56 INFO - Running setup.py install for mozdebug 11:42:56 INFO - Running setup.py install for mozdevice 11:42:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:42:56 INFO - Running setup.py install for mozfile 11:42:56 INFO - Running setup.py install for mozhttpd 11:42:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:42:56 INFO - Running setup.py install for mozinfo 11:42:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:42:56 INFO - Running setup.py install for mozInstall 11:42:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:42:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:42:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:42:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:42:57 INFO - Running setup.py install for mozleak 11:42:57 INFO - Running setup.py install for mozlog 11:42:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:42:57 INFO - Running setup.py install for moznetwork 11:42:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:42:57 INFO - Running setup.py install for mozprocess 11:42:57 INFO - Running setup.py install for mozprofile 11:42:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:42:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:42:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:42:57 INFO - Running setup.py install for mozrunner 11:42:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:42:57 INFO - Running setup.py install for mozscreenshot 11:42:57 INFO - Running setup.py install for moztest 11:42:57 INFO - Running setup.py install for mozversion 11:42:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:42:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:42:57 INFO - Cleaning up... 11:42:57 INFO - Return code: 0 11:42:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42: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:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42: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:42:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:57 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 0xd281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10959c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092d60>, '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 0x1093a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093ef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521', '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:42:57 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:42:57 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:42:57 INFO - Using env: {'DISPLAY': ':0', 11:42:57 INFO - 'HOME': '/home/cltbld', 11:42:57 INFO - 'LANG': 'en_US.UTF-8', 11:42:57 INFO - 'LANGUAGE': 'en_US:en', 11:42:57 INFO - 'LOGNAME': 'cltbld', 11:42:57 INFO - 'MAIL': '/var/mail/cltbld', 11:42:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:57 INFO - 'MOZ_NO_REMOTE': '1', 11:42:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:57 INFO - 'NO_EM_RESTART': '1', 11:42:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:58 INFO - 'PWD': '/builds/slave/test', 11:42:58 INFO - 'SHELL': '/bin/bash', 11:42:58 INFO - 'SHLVL': '1', 11:42:58 INFO - 'TERM': 'linux', 11:42:58 INFO - 'TMOUT': '86400', 11:42:58 INFO - 'USER': 'cltbld', 11:42:58 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521', 11:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:58 INFO - '_': '/tools/buildbot/bin/python'} 11:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:42:58 INFO - Running setup.py (path:/tmp/pip-NgLW6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:42:58 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:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:42:58 INFO - Running setup.py (path:/tmp/pip-ZDtunV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:42:58 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:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:42:58 INFO - Running setup.py (path:/tmp/pip-1NRpDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:42:58 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:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:42:58 INFO - Running setup.py (path:/tmp/pip-9AKNkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:42:58 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:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:42:58 INFO - Running setup.py (path:/tmp/pip-PwpY7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:42:58 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:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:42:58 INFO - Running setup.py (path:/tmp/pip-ifesfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:42:58 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:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:42:58 INFO - Running setup.py (path:/tmp/pip-8TdxtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:42:58 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:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:42:58 INFO - Running setup.py (path:/tmp/pip-yVgtKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:42:58 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:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:42:58 INFO - Running setup.py (path:/tmp/pip-l1fmeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:42:58 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:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:42:58 INFO - Running setup.py (path:/tmp/pip-33tdsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:42:58 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:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:42:58 INFO - Running setup.py (path:/tmp/pip-Bse91T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:42:58 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:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:42:58 INFO - Running setup.py (path:/tmp/pip-dvsRfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:42:59 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:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:42:59 INFO - Running setup.py (path:/tmp/pip-56Y1cz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:42:59 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:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:42:59 INFO - Running setup.py (path:/tmp/pip-1DRzqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:42:59 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:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:59 INFO - Running setup.py (path:/tmp/pip-aE8GTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:59 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:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:42:59 INFO - Running setup.py (path:/tmp/pip-1FjsuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:42:59 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:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:42:59 INFO - Running setup.py (path:/tmp/pip-OYevEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:42:59 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:42:59 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:42:59 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:42:59 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:42:59 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:42:59 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:42:59 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:42:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:43:00 INFO - Downloading blessings-1.6.tar.gz 11:43:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:43:00 INFO - Installing collected packages: blessings 11:43:00 INFO - Running setup.py install for blessings 11:43:00 INFO - Successfully installed blessings 11:43:00 INFO - Cleaning up... 11:43:00 INFO - Return code: 0 11:43:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:43:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:43:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:43:01 INFO - Reading from file tmpfile_stdout 11:43:01 INFO - Current package versions: 11:43:01 INFO - argparse == 1.2.1 11:43:01 INFO - blessings == 1.6 11:43:01 INFO - blobuploader == 1.2.4 11:43:01 INFO - docopt == 0.6.1 11:43:01 INFO - functools32 == 3.2.3-2 11:43:01 INFO - jsonschema == 2.5.1 11:43:01 INFO - manifestparser == 1.1 11:43:01 INFO - mozInstall == 1.13 11:43:01 INFO - mozcrash == 1.0 11:43:01 INFO - mozdebug == 0.1 11:43:01 INFO - mozdevice == 0.51 11:43:01 INFO - mozfile == 1.2 11:43:01 INFO - mozhttpd == 0.7 11:43:01 INFO - mozinfo == 0.10 11:43:01 INFO - mozleak == 0.1 11:43:01 INFO - mozlog == 3.5 11:43:01 INFO - moznetwork == 0.27 11:43:01 INFO - mozprocess == 0.25 11:43:01 INFO - mozprofile == 0.28 11:43:01 INFO - mozrunner == 6.13 11:43:01 INFO - mozscreenshot == 0.1 11:43:01 INFO - mozsystemmonitor == 0.3 11:43:01 INFO - moztest == 0.8 11:43:01 INFO - mozversion == 1.4 11:43:01 INFO - psutil == 3.1.1 11:43:01 INFO - requests == 1.2.3 11:43:01 INFO - wsgiref == 0.1.2 11:43:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:43:01 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:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:01 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:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:01 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 0xd281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10959c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092d60>, '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 0x1093a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093ef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521', '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:43:01 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:43:01 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:43:01 INFO - Using env: {'DISPLAY': ':0', 11:43:01 INFO - 'HOME': '/home/cltbld', 11:43:01 INFO - 'LANG': 'en_US.UTF-8', 11:43:01 INFO - 'LANGUAGE': 'en_US:en', 11:43:01 INFO - 'LOGNAME': 'cltbld', 11:43:01 INFO - 'MAIL': '/var/mail/cltbld', 11:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:01 INFO - 'MOZ_NO_REMOTE': '1', 11:43:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:01 INFO - 'NO_EM_RESTART': '1', 11:43:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:01 INFO - 'PWD': '/builds/slave/test', 11:43:01 INFO - 'SHELL': '/bin/bash', 11:43:01 INFO - 'SHLVL': '1', 11:43:01 INFO - 'TERM': 'linux', 11:43:01 INFO - 'TMOUT': '86400', 11:43:01 INFO - 'USER': 'cltbld', 11:43:01 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521', 11:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:01 INFO - '_': '/tools/buildbot/bin/python'} 11:43:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:01 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:43:01 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:43:01 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:43:01 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:43:01 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:43:01 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:43:01 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:43:01 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:43:01 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:43:01 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:43:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:43:02 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:43:02 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:43:02 INFO - Installing collected packages: simplejson 11:43:02 INFO - Running setup.py install for simplejson 11:43:02 INFO - building 'simplejson._speedups' extension 11:43:02 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:43:03 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:43:03 INFO - Successfully installed simplejson 11:43:03 INFO - Cleaning up... 11:43:03 INFO - Return code: 0 11:43:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:43:03 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:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:03 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:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:03 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 0xd281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10959c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092d60>, '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 0x1093a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093ef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521', '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:43:03 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:43:03 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:43:03 INFO - Using env: {'DISPLAY': ':0', 11:43:03 INFO - 'HOME': '/home/cltbld', 11:43:03 INFO - 'LANG': 'en_US.UTF-8', 11:43:03 INFO - 'LANGUAGE': 'en_US:en', 11:43:03 INFO - 'LOGNAME': 'cltbld', 11:43:03 INFO - 'MAIL': '/var/mail/cltbld', 11:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:03 INFO - 'MOZ_NO_REMOTE': '1', 11:43:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:03 INFO - 'NO_EM_RESTART': '1', 11:43:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:03 INFO - 'PWD': '/builds/slave/test', 11:43:03 INFO - 'SHELL': '/bin/bash', 11:43:03 INFO - 'SHLVL': '1', 11:43:03 INFO - 'TERM': 'linux', 11:43:03 INFO - 'TMOUT': '86400', 11:43:03 INFO - 'USER': 'cltbld', 11:43:03 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521', 11:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:03 INFO - '_': '/tools/buildbot/bin/python'} 11:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:43:03 INFO - Cleaning up... 11:43:03 INFO - Return code: 0 11:43:03 INFO - Running post-action listener: _resource_record_post_action 11:43:03 INFO - Running post-action listener: _start_resource_monitoring 11:43:03 INFO - Starting resource monitoring. 11:43:03 INFO - [mozharness: 2017-09-27 18:43:03.763589Z] Finished create-virtualenv step (success) 11:43:03 INFO - [mozharness: 2017-09-27 18:43:03.764608Z] Running install step. 11:43:03 INFO - Running pre-action listener: _resource_record_pre_action 11:43:03 INFO - Running main action method: install 11:43:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:43:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:43:03 INFO - Reading from file tmpfile_stdout 11:43:03 INFO - Detecting whether we're running mozinstall >=1.0... 11:43:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:43:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:43:04 INFO - Reading from file tmpfile_stdout 11:43:04 INFO - Output received: 11:43:04 INFO - Usage: mozinstall [options] installer 11:43:04 INFO - Options: 11:43:04 INFO - -h, --help show this help message and exit 11:43:04 INFO - -d DEST, --destination=DEST 11:43:04 INFO - Directory to install application into. [default: 11:43:04 INFO - "/builds/slave/test"] 11:43:04 INFO - --app=APP Application being installed. [default: firefox] 11:43:04 INFO - mkdir: /builds/slave/test/build/application 11:43:04 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:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:43:21 INFO - Reading from file tmpfile_stdout 11:43:21 INFO - Output received: 11:43:21 INFO - /builds/slave/test/build/application/firefox/firefox 11:43:21 INFO - Running post-action listener: _resource_record_post_action 11:43:21 INFO - [mozharness: 2017-09-27 18:43:21.747915Z] Finished install step (success) 11:43:21 INFO - [mozharness: 2017-09-27 18:43:21.748059Z] Running setup-mitmproxy step. 11:43:21 INFO - Running pre-action listener: _resource_record_pre_action 11:43:21 INFO - Running main action method: setup_mitmproxy 11:43:21 INFO - Skipping: mitmproxy is not required 11:43:21 INFO - Running post-action listener: _resource_record_post_action 11:43:21 INFO - [mozharness: 2017-09-27 18:43:21.748589Z] Finished setup-mitmproxy step (success) 11:43:21 INFO - [mozharness: 2017-09-27 18:43:21.748692Z] Running run-tests step. 11:43:21 INFO - Running pre-action listener: _resource_record_pre_action 11:43:21 INFO - Running pre-action listener: _set_gcov_prefix 11:43:21 INFO - Running main action method: run_tests 11:43:21 WARNING - Try message not found. 11:43:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:43:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:43:21 INFO - Python 2.7.3 11:43:21 INFO - Return code: 0 11:43:21 INFO - grabbing minidump binary from tooltool 11:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:43:21 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 0x1092d60>, '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 0x1093a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:43:21 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:43:21 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:43:21 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:43:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:43:21 INFO - Return code: 0 11:43:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:43:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:43:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:43:21 INFO - ENV: RUST_BACKTRACE is now full 11:43:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:43:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:43:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 11:43:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-087 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 11:43:21 INFO - Using env: {'DISPLAY': ':0', 11:43:21 INFO - 'HOME': '/home/cltbld', 11:43:21 INFO - 'LANG': 'en_US.UTF-8', 11:43:21 INFO - 'LANGUAGE': 'en_US:en', 11:43:21 INFO - 'LOGNAME': 'cltbld', 11:43:21 INFO - 'MAIL': '/var/mail/cltbld', 11:43:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:43:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:43:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:21 INFO - 'MOZ_NO_REMOTE': '1', 11:43:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:43:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:21 INFO - 'NO_EM_RESTART': '1', 11:43:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:21 INFO - 'PWD': '/builds/slave/test', 11:43:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:43:21 INFO - 'RUST_BACKTRACE': 'full', 11:43:21 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:43:21 INFO - 'SHELL': '/bin/bash', 11:43:21 INFO - 'SHLVL': '1', 11:43:21 INFO - 'TERM': 'linux', 11:43:21 INFO - 'TMOUT': '86400', 11:43:21 INFO - 'USER': 'cltbld', 11:43:21 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521', 11:43:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:21 INFO - '_': '/tools/buildbot/bin/python'} 11:43:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 11:43:22 INFO - mozversion application_buildid: 20170927172229 11:43:22 INFO - mozversion application_changeset: 6100472d3aa833dff22a4edb0934fe600f43ddb8 11:43:22 INFO - mozversion application_display_name: Nightly 11:43:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:43:22 INFO - mozversion application_name: Firefox 11:43:22 INFO - mozversion application_remotingname: firefox 11:43:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:43:22 INFO - mozversion application_vendor: Mozilla 11:43:22 INFO - mozversion application_version: 58.0a1 11:43:22 INFO - mozversion platform_buildid: 20170927172229 11:43:22 INFO - mozversion platform_changeset: 6100472d3aa833dff22a4edb0934fe600f43ddb8 11:43:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:43:22 INFO - mozversion platform_version: 58.0a1 11:43:22 INFO - using testdate: 1506537802 11:43:22 INFO - actual date: 1506537802 11:43:22 INFO - starting webserver on 'localhost:40305' 11:43:22 INFO - SUITE-START | Running 2 tests 11:43:22 INFO - TEST-START | dromaeo_css 11:43:22 INFO - Initialising browser for dromaeo_css test... 11:43:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40305/getInfo.html -profile /tmp/tmp4km6TR/profile 11:43:22 INFO - TEST-INFO | started process 3588 (/builds/slave/test/build/application/firefox/firefox http://localhost:40305/getInfo.html) 11:43:30 INFO - TEST-INFO | 3588: exit 0 11:43:30 INFO - Browser initialized. 11:43:30 INFO - Running cycle 1/1 for dromaeo_css test... 11:43:31 INFO - Using env: {'DISPLAY': ':0', 11:43:31 INFO - 'HOME': '/home/cltbld', 11:43:31 INFO - 'JSGC_DISABLE_POISONING': '1', 11:43:31 INFO - 'LANG': 'en_US.UTF-8', 11:43:31 INFO - 'LANGUAGE': 'en_US:en', 11:43:31 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:43:31 INFO - 'LOGNAME': 'cltbld', 11:43:31 INFO - 'MAIL': '/var/mail/cltbld', 11:43:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:43:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:43:31 INFO - 'MOZ_CRASHREPORTER': '1', 11:43:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:31 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:43:31 INFO - 'MOZ_NO_REMOTE': '1', 11:43:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:43:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:31 INFO - 'NO_EM_RESTART': '1', 11:43:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:31 INFO - 'PWD': '/builds/slave/test', 11:43:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:43:31 INFO - 'RUST_BACKTRACE': 'full', 11:43:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:43:31 INFO - 'SHELL': '/bin/bash', 11:43:31 INFO - 'SHLVL': '1', 11:43:31 INFO - 'STYLO_FORCE_DISABLED': '1', 11:43:31 INFO - 'TERM': 'linux', 11:43:31 INFO - 'TMOUT': '86400', 11:43:31 INFO - 'USER': 'cltbld', 11:43:31 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521', 11:43:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:31 INFO - '_': '/tools/buildbot/bin/python'} 11:43:31 INFO - TEST-INFO | started process 3829 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4km6TR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:43:31 INFO - PID 3829 | 11:43:31 INFO - PID 3829 | (/builds/slave/test/build/application/firefox/firefox:3880): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:43:31 INFO - PID 3829 | 11:43:42 INFO - PID 3829 | RSS: Main: 144302080 11:43:42 INFO - PID 3829 | 11:46:38 INFO - PID 3829 | Cycle 1(1): loaded http://localhost:40305/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40305/tests/dromaeo/cssquery-ext.html) 11:46:40 INFO - PID 3829 | RSS: Main: 146653184 11:46:40 INFO - PID 3829 | 11:49:41 INFO - PID 3829 | Cycle 1(1): loaded http://localhost:40305/tests/dromaeo/cssquery-ext.html (next: http://localhost:40305/tests/dromaeo/cssquery-jquery.html) 11:49:42 INFO - PID 3829 | RSS: Main: 146362368 11:49:42 INFO - PID 3829 | 11:52:44 INFO - PID 3829 | Cycle 1(1): loaded http://localhost:40305/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40305/tests/dromaeo/cssquery-mootools.html) 11:52:44 INFO - PID 3829 | RSS: Main: 147959808 11:52:44 INFO - PID 3829 | 11:55:46 INFO - PID 3829 | Cycle 1(1): loaded http://localhost:40305/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40305/tests/dromaeo/cssquery-prototype.html) 11:55:46 INFO - PID 3829 | RSS: Main: 146628608 11:55:46 INFO - PID 3829 | 11:58:49 INFO - PID 3829 | Cycle 1(1): loaded http://localhost:40305/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40305/tests/dromaeo/cssquery-yui.html) 11:58:50 INFO - PID 3829 | RSS: Main: 148021248 11:58:50 INFO - PID 3829 | 12:01:52 INFO - PID 3829 | Cycle 1(1): loaded http://localhost:40305/tests/dromaeo/cssquery-yui.html (next: http://localhost:40305/tests/dromaeo/cssquery-dojo.html) 12:01:52 INFO - PID 3829 | RSS: Main: 150216704 12:01:52 INFO - PID 3829 | 12:01:52 INFO - PID 3829 | __start_tp_report 12:01:52 INFO - PID 3829 | _x_x_mozilla_page_load 12:01:52 INFO - PID 3829 | _x_x_mozilla_page_load_details 12:01:52 INFO - PID 3829 | |i|pagename|runs| 12:01:52 INFO - PID 3829 | |0;dojo.html;3905.433712111742;3913.843446262148;3914.1780226152505;3929.469521614583;3950.5456872459677;6172.9074063889075;6211.534134939875;6248.062790581415;6295.118683384324;6367.936320636786;6241.126242326078;6257.687115644211;6276.403741644548;6298.590591611542;6303.590266632677;5573.219749235111;5688.9146662799885;5691.601587888849;5691.7723291068305;5722.284714410699;200.5372055067223;5678.176664383662;5721.628094173865;5752.942470575304;5767.971160144193;5291.312129423189;5568.888622227553;5601.971990140044;5687.345955215162;5731.684757338345;5595.328560572717;5635.915461268084;5712.771489140429;5725.599208055438;5735.942640573582;5600.691961942091;5630.211770352154;5664.773409063632;5667.688277144755;5703.686297253649;6234.438900498932;6251.812445626639;6257.843553911143;6264.27960784511;6301.117843501914;6671.899921501182;6693.163354580677;6784.932150678479;6807.3873351398615;6880.277570855038;6767.830804229884;6793;6856.965715171392;6886.896696549556;6907.551009184437;6279.654618995954;6294.244690637107;6352.7141278642575;6374.936250637481;6385.138006369127;6954.721811127498;7000.719971201095;7001.229864714877;7078.893816592756;7102.644867756591;6606.504512161607;6669.533132680763;6709.5303328767495;6711.6979735912;6757.966210168917;6745.696443659949;6791.320867913169;6802;6807.863842723217;6822.556533825285;6743.629100399525;6828.658567071627;6839.897401538881;6842.897356539655;6846.178458585002;6712.328767123248;6715.227748808852;6736.629485378351;6809.795706128824;6823;4884.3650325458175;4888.9755551222015;4917.28699338601;4982.377202849644;4984.152694042022;4464.799084041226;4521.615662668644;4529.9547004530195;4538.205813982539;4599.379083823708;6328.398802113792;6333.904991425133;6335.619862808247;6378.936210637927;6411.839704007437;6766.357196066366;6775.593464392152;6854.897176542356;6865.450763938873;6875.690593923186;6182.505399568024;6276.184096067574;6299.401556852092;6311.179546658905;6373.171487706569;5490.945090549123;5505.9174112387545;5517.393086760453;5521.3926468088475;5583.832485025456;7026.964865175743;7087.574745515182;7209;7210.387117095001;7239.131304243525;6697.263301036979;6776.864462710817;6780.864382712318;6871.862562748817;6878.931210687829;7053.0830991970715;7097.574145551283;7099.858002840017;7111.502194846311;7112.359887609933;6631;6690.431313338226;6758.222804377559;6791;6806.42145417645;6791.592504449749;6793.388595026471;6857.417119544894;6872;6882.002109693966;6434.806955791334;6507.707153178213;6509.1863517060365;6591.077249185022;6596.736130554724;6459.095726598186;6500.674966251763;6562.507811914221;6563.212414510289;6565.048068030013;6084.482818960438;6402.327755585783;6461.935380646321;6481.546291759531;6555.836104097245;6624.56940298879;6629.7679581214425;6666.83332916681;6712.2616512184595;6712.496562757715;6323.936760632335;6380.202474690664;6423.164988551458;6482.254540727877;6494.577852439576 12:01:52 INFO - PID 3829 | |1;ext.html;956.8708224389705;970.3644113105918;985.9745864301127;987.6592575561431;1022.0392830739105;41731.79134104329;42371.36442953358;42398.15203695924;42455.57544424555;42573.36139957903;39037;39145.21709565807;39339.21321573567;39549.209015819666;39677.60322396775;7294.343509084181;7404.740834070809;7419.962900185492;7430.851382972337;7457.962710186469;7292.12494500658;7401.0748656417945;7439.962800185992;7443.404527637803;7447.553146811181;8057.274845263925;8213.507189568616;8216.548089855085;8219.630116644765;8224.958875205615;8133.349332053422;8147.226013528705;8153.551554664491;8166.060902996172;8173.386995975296;7902.091259505173;8045.557494337809;8050.758477245692;8078.959605201936;8081.070676872177;38563.42154867679;38842;39052.218955621014;39060.41409378862;39105.60894391077;3623;3685.4840322354894;3685.63143685632;3687.1519550503267;3707.4624179494094;32695.50956735651;32821.343573128644;32879.178020549436;33024.17439564006;33152.6684733152;5317.9202311965355;5364.7317634118135;5378.085725426687;5384.838454846361;5394.73026348681;206655;208129;208180;209099;209972.95013524988;50232;50409.495905041214;50476.74761626168;50491.24263136056;50577;52825.471745282826;52945;53175;53198;53205;16381;16609.501714948572;16623.251953662115;16645.750313745302;16650.250738716786;13485.393157307944;13546.796798048037;13558.254296013616;13567.321633918265;13574.117682350616;14676.192809395585;14685.486007989883;14761;14799.408023679147;14940.178290193926;5923.378045305267;5954;5981.970090149608;6036.309833246698;6091.695415229221;1079.082779637302;1086.462201210406;1092.7377429416883;1109.046220250584;1125.5329038448951;25004.62493062569;25360.36599085001;25512.872435637702;25533.872330638227;25703.614445782954;1207.1791181996152;1209.8850609192114;1210.2798834693344;1219.896308813743;1233.808759642257;13260.403281852146;13347.998900082339;13468.461261549624;13587.252701101337;13670;287028;289083;289274;289865;291389;47969.28046079312;48366.27450588244;54880;55145.724271379186;55251;1508.8415716349625;1533.8082739657543;1534.1945478623588;1543.7684347347988;1560.641052557918;29981.85009075028;30546.389072218877;30561.23596910006;30610.84694576513;30981.690183097882;40203.59796401999;40222.59777402306;40530;40561.391579125746;40649;246754;247103;247139;247218;248026;33291.66708332886;34192.65807341895;35225.29549409049;35231.647683523865;35313.64686353104;43486.34770478508;44982.10035799331;44990;45468.77265613783;45563.08873822571;33431.49852752162;33438.83280583582;33569.328613427104;33606.66393336035;33807.66192338045;33781.493277601345;33819.830900845336;33827.15432114217;34241.31517369689;34563.481547776304;38993.41509877297;39211.6078839208;39235.80382098071;39498.60501394949;39743.60256397399;30844;30909.381812363175;30950.916717914766;30953.535696964114;31646.208844779063;24488.87755561282;24573.754262457147;24741.752582473946;24939;25441.745582544678 12:01:52 INFO - PID 3829 | |2;jquery.html;605.2797171366071;606.5238787551773;620.8075496596056;628.4563852267789;640.5612155673363;23401.531969360603;23475.765242347614;24187.75812241877;24236.636450453214;24267.63598546021;26503.337416564547;27337.043203487832;27442;27498;27598.172054838386;6353.841153971153;6453.677316134174;6490.902636460457;6500.024996250577;6520.608763474183;6387.169667943161;6546;6850.349216824394;6867.3476019778045;6867.725290988379;6797.558158719692;6802.591844489347;6805.319468053204;6805.387515123638;6810.455163586901;6196.566240363199;6403.519736019817;6412.102305677209;6812.761553345634;6840.589564626139;5906.350301466835;5923.703814809242;6007.429294217042;6027.126066720345;6038.2150320458495;31340.529892051636;31558.684413155803;31603.367932641217;31798.682013179805;31804.20489487758;2146.6028784674886;2146.8711877287415;2153.881536515491;2158.5467051919118;2164.5779073080757;20351;21464.785352146435;21640.783592164033;21672.783272167235;21759.34721958328;2397.7961873240797;2525.1414519063424;2525.3181640957023;2607.6610040694586;2628.395469042112;159299.2035039829;162081;162498;162646;162874.18562907228;16791.328346866234;16884;17126.657466850593;17328.220230089675;17571.472855814347;26760;26768.866155669097;26795.196144115707;26900.192994210203;26941.865290673813;10207.642732504475;10290.485475726184;10327.225458090523;10405.9479702601;10554.525046372932;9216.493092879957;9334.299927505464;9341.673041443517;9348.345615806827;9433.858492122623;10196.796064078677;10385.532651030722;10466.476676166161;10495.422751748574;10569.894301056891;2954.5568164775455;2960.763138948879;2986.89545865898;3001.0996700989617;3027.8031927924612;1041.4740556019162;1041.5521325829966;1046.863907691995;1050.8686414198226;1062.697131317571;21961.78038219629;22413.55172896533;22443.88778056099;22576.548469030527;22818.31545053651;1104.536094840153;1109.546494092741;1109.7724966382034;1113.582406597526;1119.9328040317607;12197.268163910016;12228.388580570936;12380.195287306296;12407.44166512509;12448.253104813559;621628;622389;625728;630951;634135;120167;122771.3861430705;123570.38214808868;123893;124518;1111.8721347045193;1158.368689064462;1213.9817902731465;1231.6489800406841;1256.8114782782657;23082.422939426648;23524.41188970221;23561.29316120519;23806.88096559506;23848.880755596805;60523.69738151281;60541.394586055336;60703.089453659115;60773;62391.37608623855;74647.62676186585;75531.24468755242;75791;76253;76616;16370.263338149574;16400;16665.750013750046;16766.826322157332;16776.412825551048;25133.371665708502;25251.368715782253;25270.620940685538;25476.2357129279;25492.107776227742;20498.590028199054;20666;20785.376438706862;20805.791942080385;20904.16383344649;18149.18328675239;18418.539536511693;18621.255149794397;18682.34611788581;18903.149358279185;20769.58460830805;20923.26768563093;21116.260930867345;21177.470563236042;21579.784202157778;16271.105089219733;16411.507654770376;16460.75308870344;16474.670506590042;16548.58628534248;20501.17995280172;20568.897155514125;20749.1700331985;20943.685844712036;20950.37148885536 12:01:52 INFO - PID 3829 | |3;mootools.html;1384.8199734034577;1436.8275806903173;1442.718669859377;1443.689606734552;1450.550329397887;16651.084190369525;17291.740623890637;17316.653666926653;17339.133043347847;17344.132793360346;16702.49892503224;16716.498505044838;16762.58093547662;16868.156592170402;16898.83101168988;2538.3907862113097;2613.8170328077044;2623.3179373362873;2624;2626.7898568114506;2467.962980555293;2574.7296533863955;2587.107447930461;2587.62479440481;2591.727868573801;2526.60837570176;2597.2338160242775;2598.7141414444395;2603.232046546264;2610.0864697355964;2555.029088946207;2576.2142546523305;2590.456004239112;2595.169545745362;2596.195179494363;2477.9504409911883;2560.756728110845;2659.095907391496;2663.9344262295044;2668.1328568215213;16773.580660483465;16895.57761055971;16937.491875243762;16938;16942.06818624975;8240.340772738167;8549.871751923725;8582.22759951601;8602.612882420306;8609.655613775441;5400.351957765093;5574.58190635704;5755.107958266475;5773.538116950634;5788.855278618026;2013.496625843539;2040.4694779357474;2044.9897750511152;2075.6575165097743;2095.3923362224937;30276.243093922607;30772.230694232825;30787;30802.38395232083;30823.2294192647;6851.554648947803;6995.825104372329;7049.859002820018;7099.112610923635;7127.82180445493;19760.110795014258;19773;19845;19913.60172796536;19943.900280498503;7990;8259.21537453941;8329.416940814084;8343.874841877378;8374;7603.391728661693;7606.23937606246;7686;7745.109312429143;7751.883721744179;5109.441620305768;5177.705573606599;5230.163173892235;5259.921101183485;5292.417834038252;1542.8688561472177;1550.5735922621143;1555.1602134847055;1564.8043994500688;1579.8736101112113;880.335346813152;894.7584152278848;901.9774505637412;906.3836591117971;919.1360121485782;7812;7820.983272174694;7841.333486653584;7849.529028258323;7925.643346049326;775.8331958628922;789.1161898673407;791.7743443118799;791.9128895821455;797.7447216890539;5453.645513041719;5591.965486385032;5774.797882074191;5822.243108395882;5829.09649004405;25269;25867.61198581985;25882.74117258841;25892;26204.60693089605;24059.639105413433;25830.095946641777;25927.870360648078;25943;25943.22170334893;11986.501687289088;12788.872111278954;12860.549880754315;12892.162009469355;12988.545400910923;8827.826954245107;8931.776705582412;8980.595873185592;8982.595783189641;8988;20751.896240519305;21663.675044874024;21736.891315543322;21890.23384181546;21902.561948761253;21739.673904891122;22235.555288893807;22550.774492254866;22551;22557.774422255567;11904;11963.042956563628;11990.820137698116;11992.400379980792;11997.040236781211;14767.261636917896;15134.091954482767;15348.923255384098;15398.230088495306;15398.846011539741;11986.520539178684;12057.457414416196;12130.090243231969;12328.50685972551;12449.875501244871;11438.142139339749;11439.256448330832;11469.483873225558;11491.367974761468;11775.293482391084;10665.573377064831;10835.079018283534;10847.45762711877;10848.945755271488;10880.945595271973;7878.212178782076;8000.639971201426;8050.718224862102;8079.474834135763;8102.716404925799;7835.804104897423;8018.037835459549;8053.83892322162;8074.677012919652;8117.878231826646 12:01:52 INFO - PID 3829 | |4;prototype.html;553.1260608238982;584.1879787095936;584.6608966799257;587.9853003674906;594.3046635436536;6248.937510624893;6286.434220920116;6298.842528936779;6367.33143019982;6376.394242546962;6130.846728831771;6181.6600086995195;6211.440970312671;6227.782027629034;6232.719527621257;5082.567981721558;5120.487951204887;5123.436421993578;5130.923036154442;5186.3257776489;4787.784549695272;5027.09512287788;5132.435432102485;5133.383993920735;5200.257913598949;4946.1838796598695;4961.131801934665;4961.404631444232;5019.272205530196;5036.899262014757;4955.5044495550155;4967.627427942901;4972.850814475535;4977.328060711794;5034.395872495287;4519.163954668397;4549.135664223787;4550.862284428893;4587.839425620087;4597.42532183477;6159.35326790685;6178.941423995107;6222.96888515559;6245.281792593864;6248.78129265478;5838.5037271831525;5870.412958704095;5879.32387775407;5923.851903702399;5926.496247818941;6610.966945165292;6623.337666233387;6670.499712521531;6686.699098540577;6690.966545167292;5042.697438153723;5061.822836200752;5072.467390923974;5073.315102461157;5087.287779710843;6811.2167100783545;6844.691988860463;6891.724331026753;6972.1284839395075;6997.720091196397;5253.317068781111;5268.9736551317;5270.472952704776;5278.894422111536;5281.573975026721;5327;5341.412444631087;5350.919736203882;5361.624686271924;5378.13949768043;5938.743277554501;5947.375525569752;5947.881042379128;5962.688208594189;5976.970115149396;6630.602163870183;6683.766068187688;6708.262091169968;6748.426383757337;6761.966190169018;1797.2476835085686;1809.5295223242051;1813.238439855264;1825.8082901295438;1833.4316361927845;1262.1291308996947;1312.1798875702686;1317.808917706927;1325.5360623781792;1330.1553513518986;6089.386312627157;6110.26676798787;6130.356312587114;6192.969035154795;6264;6600.174978127734;6642;6658;6807.787469072571;6839.213490448563;6166.568340216231;6194.690265486708;6201.162843016225;6211.937880621226;6293.1504246927;3508.8421021054114;3510.9110079502657;3547.2196116854766;3606.8376923038527;3626.4560315952817;6957.060796792368;7009.684564194624;7047.92952070483;7054.576725396492;7087.574745515286;6821.761238356634;6832.760853370109;6846.863062738817;6872.312768723088;6937;7087.89368159478;7110.537815042006;7118.252583478868;7121.145462544528;7192.280771922975;6770.830729231611;6806.659667016728;6817.352351526597;6820;6851.040854280305;6569.9014514783275;6675.866482670416;6680.231773346128;6689.866202676017;6750.831229219112;6960.8955865663065;7042.83793174141;7066.646667666699;7077.858442831011;7148.499605027599;5198.2202669599865;5244.527992480543;5260.368755749335;5260.789568417374;5272.815451459181;6851.623160726208;6855.383015528626;6864.279250678607;6871.4502839773695;6878.174619045746;6394.58435201729;6504.707288172138;6567.376099270562;6598.670066496752;6599.690108461999;6465.547411681137;6469.77355792545;6501.414872661483;6507.739690412331;6534.640594767143;6421.229452465734;6442.935570644421;6475.611463312216;6533.575317604341;6544.509161812788;6436.613803171825;6582.934170658424;6653.9667301663185;6654.567453115726;6681.5656982296;6303.951215854957;6356.141920840627;6370.426661600478;6453.967730161319;6458.773942911976 12:01:52 INFO - PID 3829 | |5;yui.html;970.3886551472572;975.5853762151085;991.6033586565371;997.3018886779256;1007.2697294461516;19071.904640476812;19532.707009394835;19535.316263930767;19536.804631953677;19548.120334584943;18381.724274135897;18433.354832580862;18517.629647407044;18533.629327413444;18548.165332560035;1055.530289021386;1066.3122286125445;1070.7644318249972;1071.839224116385;1073.2969904712386;1056.9471526423686;1058.4178701714065;1058.8570542976715;1062.049465728173;1067.781104873503;1087.0922779479145;1108.1245815805544;1111.727626731452;1114.849495318134;1129.170060005895;1092.8032954068265;1106.1427393769852;1106.8007758603449;1107.8781334053247;1111.8054340490423;790.0992868130336;799.1129845871078;818.9631466584018;823.3618945317367;824.9092599814015;21333.67999480009;21487.67768483474;21516;21534.89232553843;21650.458738531663;23064.308070757903;23393.415164620852;23690.7630923692;23951.880240598686;24032.279031629078;17713.38003169896;17948.192331345123;17968.640627187382;18216.817831821645;18305.267789288413;4007.699422543321;4037.253108174997;4038.8586399475876;4040.1919616076902;4042.939355909664;133219;155406;157842;158390;161617.38382616141;18769.624607508045;19189.520261993563;19202.51993700141;19217.32739354116;19466.70799938002;34125.48811767826;34198.48702269468;34301.313973720884;34388.82805585956;34950.12624684352;9820.459874706818;9824.950875245579;9864.408135511892;9878;9895.455749933823;4610.2623580227;4694.2254528002495;4705.058988202373;4715.316279139574;4722.763861806896;6072.392760723892;6185.072239164161;6187.566870319034;6196.752129914753;6223.097650840603;1303.7718399280277;1315.4540865540885;1332.380443093966;1333.9266340351373;1334.8398192216996;676.5669971218326;697.4315932514984;702.4029574861327;707.4658632732254;708.3907839258234;12773.61679149627;13420.060595758203;13596.660083497794;13688.178709277476;13800;729.2088084428349;733.8002366131414;737.7233537423466;748.3638906929067;751.4326683354033;5645;5848.61983971049;5887.35239123696;5888.175655408247;5904.143899134601;151673;153372;153433;155446;157262;129238;134068;134393;134731;135284;113196;114060.42969785264;116162.41918790352;116588.9999999983;117161;11135.387553684624;11254.718632033937;11335.036521895401;11342.716432089264;11363.488643010918;56232.718836405555;56650.43349566452;56843.14735278892;57585.136222957524;58051.70974145102;69972.30027699658;70186;70963.29036709567;71302.64348678224;73540.63229683817;18120.456386308433;18163.636727265646;18199.909000454914;18273.543161421072;18597.44207673772;18863.90568047151;19582.608347833248;19655.312064077687;19733.901330493256;19965.800341996393;18457.984810835533;18501.90749046246;18729;18794.71807922855;18900.527486812938;17644.647107058045;17702.29190832352;17744.11279435997;17795.73306400379;17821.465356039338;18123.909380453013;18259.54351141232;18372.632547349247;18380.264789408273;18415.81584184141;13542.322883855964;13589.32053397346;13763.79354309666;13770.449182032606;13955.162690238618;11994.160408771651;12137.150399471951;12191.817122742988;12212.694682633006;12429.627111186317 12:01:52 INFO - PID 3829 | __end_tp_report 12:01:52 INFO - PID 3829 | __start_cc_report 12:01:52 INFO - PID 3829 | _x_x_mozilla_cycle_collect,267 12:01:52 INFO - PID 3829 | __end_cc_report 12:01:52 INFO - PID 3829 | __startTimestamp1506538912334__endTimestamp 12:01:52 INFO - PID 3829 | 12:01:52 INFO - PID 3829 | ------- Summary: start ------- 12:01:52 INFO - PID 3829 | Number of tests: 6 12:01:52 INFO - PID 3829 | 12:01:52 INFO - PID 3829 | [#0] dojo.html Cycles:165 Average:6230.24 Median:6461.94 stddev:876.64 (13.6%) stddev-sans-first:860.14 12:01:52 INFO - PID 3829 | Values: 3905.4 3913.8 3914.2 3929.5 3950.5 6172.9 6211.5 6248.1 6295.1 6367.9 6241.1 6257.7 6276.4 6298.6 6303.6 5573.2 5688.9 5691.6 5691.8 5722.3 200.5 5678.2 5721.6 5752.9 5768.0 5291.3 5568.9 5602.0 5687.3 5731.7 5595.3 5635.9 5712.8 5725.6 5735.9 5600.7 5630.2 5664.8 5667.7 5703.7 6234.4 6251.8 6257.8 6264.3 6301.1 6671.9 6693.2 6784.9 6807.4 6880.3 6767.8 6793.0 6857.0 6886.9 6907.6 6279.7 6294.2 6352.7 6374.9 6385.1 6954.7 7000.7 7001.2 7078.9 7102.6 6606.5 6669.5 6709.5 6711.7 6758.0 6745.7 6791.3 6802.0 6807.9 6822.6 6743.6 6828.7 6839.9 6842.9 6846.2 6712.3 6715.2 6736.6 6809.8 6823.0 4884.4 4889.0 4917.3 4982.4 4984.2 4464.8 4521.6 4530.0 4538.2 4599.4 6328.4 6333.9 6335.6 6378.9 6411.8 6766.4 6775.6 6854.9 6865.5 6875.7 6182.5 6276.2 6299.4 6311.2 6373.2 5490.9 5505.9 5517.4 5521.4 5583.8 7027.0 7087.6 7209.0 7210.4 7239.1 6697.3 6776.9 6780.9 6871.9 6878.9 7053.1 7097.6 7099.9 7111.5 7112.4 6631.0 6690.4 6758.2 6791.0 6806.4 6791.6 6793.4 6857.4 6872.0 6882.0 6434.8 6507.7 6509.2 6591.1 6596.7 6459.1 6500.7 6562.5 6563.2 6565.0 6084.5 6402.3 6461.9 6481.5 6555.8 6624.6 6629.8 6666.8 6712.3 6712.5 6323.9 6380.2 6423.2 6482.3 6494.6 12:01:52 INFO - PID 3829 | 12:01:52 INFO - PID 3829 | [#1] ext.html Cycles:180 Average:41959.08 Median:19468.32 stddev:65168.97 (334.7%) stddev-sans-first:65279.07 12:01:52 INFO - PID 3829 | Values: 956.9 970.4 986.0 987.7 1022.0 41731.8 42371.4 42398.2 42455.6 42573.4 39037.0 39145.2 39339.2 39549.2 39677.6 7294.3 7404.7 7420.0 7430.9 7458.0 7292.1 7401.1 7440.0 7443.4 7447.6 8057.3 8213.5 8216.5 8219.6 8225.0 8133.3 8147.2 8153.6 8166.1 8173.4 7902.1 8045.6 8050.8 8079.0 8081.1 38563.4 38842.0 39052.2 39060.4 39105.6 3623.0 3685.5 3685.6 3687.2 3707.5 32695.5 32821.3 32879.2 33024.2 33152.7 5317.9 5364.7 5378.1 5384.8 5394.7 206655.0 208129.0 208180.0 209099.0 209973.0 50232.0 50409.5 50476.7 50491.2 50577.0 52825.5 52945.0 53175.0 53198.0 53205.0 16381.0 16609.5 16623.3 16645.8 16650.3 13485.4 13546.8 13558.3 13567.3 13574.1 14676.2 14685.5 14761.0 14799.4 14940.2 5923.4 5954.0 5982.0 6036.3 6091.7 1079.1 1086.5 1092.7 1109.0 1125.5 25004.6 25360.4 25512.9 25533.9 25703.6 1207.2 1209.9 1210.3 1219.9 1233.8 13260.4 13348.0 13468.5 13587.3 13670.0 287028.0 289083.0 289274.0 289865.0 291389.0 47969.3 48366.3 54880.0 55145.7 55251.0 1508.8 1533.8 1534.2 1543.8 1560.6 29981.9 30546.4 30561.2 30610.8 30981.7 40203.6 40222.6 40530.0 40561.4 40649.0 246754.0 247103.0 247139.0 247218.0 248026.0 33291.7 34192.7 35225.3 35231.6 35313.6 43486.3 44982.1 44990.0 45468.8 45563.1 33431.5 33438.8 33569.3 33606.7 33807.7 33781.5 33819.8 33827.2 34241.3 34563.5 38993.4 39211.6 39235.8 39498.6 39743.6 30844.0 30909.4 30950.9 30953.5 31646.2 24488.9 24573.8 24741.8 24939.0 25441.7 12:01:52 INFO - PID 3829 | 12:01:52 INFO - PID 3829 | [#2] jquery.html Cycles:180 Average:40800.98 Median:23241.98 stddev:104687.62 (450.4%) stddev-sans-first:104937.79 12:01:52 INFO - PID 3829 | Values: 605.3 606.5 620.8 628.5 640.6 23401.5 23475.8 24187.8 24236.6 24267.6 26503.3 27337.0 27442.0 27498.0 27598.2 6353.8 6453.7 6490.9 6500.0 6520.6 6387.2 6546.0 6850.3 6867.3 6867.7 6797.6 6802.6 6805.3 6805.4 6810.5 6196.6 6403.5 6412.1 6812.8 6840.6 5906.4 5923.7 6007.4 6027.1 6038.2 31340.5 31558.7 31603.4 31798.7 31804.2 2146.6 2146.9 2153.9 2158.5 2164.6 20351.0 21464.8 21640.8 21672.8 21759.3 2397.8 2525.1 2525.3 2607.7 2628.4 159299.2 162081.0 162498.0 162646.0 162874.2 16791.3 16884.0 17126.7 17328.2 17571.5 26760.0 26768.9 26795.2 26900.2 26941.9 10207.6 10290.5 10327.2 10405.9 10554.5 9216.5 9334.3 9341.7 9348.3 9433.9 10196.8 10385.5 10466.5 10495.4 10569.9 2954.6 2960.8 2986.9 3001.1 3027.8 1041.5 1041.6 1046.9 1050.9 1062.7 21961.8 22413.6 22443.9 22576.5 22818.3 1104.5 1109.5 1109.8 1113.6 1119.9 12197.3 12228.4 12380.2 12407.4 12448.3 621628.0 622389.0 625728.0 630951.0 634135.0 120167.0 122771.4 123570.4 123893.0 124518.0 1111.9 1158.4 1214.0 1231.6 1256.8 23082.4 23524.4 23561.3 23806.9 23848.9 60523.7 60541.4 60703.1 60773.0 62391.4 74647.6 75531.2 75791.0 76253.0 76616.0 16370.3 16400.0 16665.8 16766.8 16776.4 25133.4 25251.4 25270.6 25476.2 25492.1 20498.6 20666.0 20785.4 20805.8 20904.2 18149.2 18418.5 18621.3 18682.3 18903.1 20769.6 20923.3 21116.3 21177.5 21579.8 16271.1 16411.5 16460.8 16474.7 16548.6 20501.2 20568.9 20749.2 20943.7 20950.4 12:01:52 INFO - PID 3829 | 12:01:52 INFO - PID 3829 | [#3] mootools.html Cycles:180 Average:10324.00 Median:14241.23 stddev:7902.75 (55.5%) stddev-sans-first:7896.38 12:01:52 INFO - PID 3829 | Values: 1384.8 1436.8 1442.7 1443.7 1450.6 16651.1 17291.7 17316.7 17339.1 17344.1 16702.5 16716.5 16762.6 16868.2 16898.8 2538.4 2613.8 2623.3 2624.0 2626.8 2468.0 2574.7 2587.1 2587.6 2591.7 2526.6 2597.2 2598.7 2603.2 2610.1 2555.0 2576.2 2590.5 2595.2 2596.2 2478.0 2560.8 2659.1 2663.9 2668.1 16773.6 16895.6 16937.5 16938.0 16942.1 8240.3 8549.9 8582.2 8602.6 8609.7 5400.4 5574.6 5755.1 5773.5 5788.9 2013.5 2040.5 2045.0 2075.7 2095.4 30276.2 30772.2 30787.0 30802.4 30823.2 6851.6 6995.8 7049.9 7099.1 7127.8 19760.1 19773.0 19845.0 19913.6 19943.9 7990.0 8259.2 8329.4 8343.9 8374.0 7603.4 7606.2 7686.0 7745.1 7751.9 5109.4 5177.7 5230.2 5259.9 5292.4 1542.9 1550.6 1555.2 1564.8 1579.9 880.3 894.8 902.0 906.4 919.1 7812.0 7821.0 7841.3 7849.5 7925.6 775.8 789.1 791.8 791.9 797.7 5453.6 5592.0 5774.8 5822.2 5829.1 25269.0 25867.6 25882.7 25892.0 26204.6 24059.6 25830.1 25927.9 25943.0 25943.2 11986.5 12788.9 12860.5 12892.2 12988.5 8827.8 8931.8 8980.6 8982.6 8988.0 20751.9 21663.7 21736.9 21890.2 21902.6 21739.7 22235.6 22550.8 22551.0 22557.8 11904.0 11963.0 11990.8 11992.4 11997.0 14767.3 15134.1 15348.9 15398.2 15398.8 11986.5 12057.5 12130.1 12328.5 12449.9 11438.1 11439.3 11469.5 11491.4 11775.3 10665.6 10835.1 10847.5 10848.9 10880.9 7878.2 8000.6 8050.7 8079.5 8102.7 7835.8 8018.0 8053.8 8074.7 8117.9 12:01:52 INFO - PID 3829 | 12:01:52 INFO - PID 3829 | [#4] prototype.html Cycles:180 Average:5660.04 Median:6239.00 stddev:1574.85 (25.2%) stddev-sans-first:1531.91 12:01:52 INFO - PID 3829 | Values: 553.1 584.2 584.7 588.0 594.3 6248.9 6286.4 6298.8 6367.3 6376.4 6130.8 6181.7 6211.4 6227.8 6232.7 5082.6 5120.5 5123.4 5130.9 5186.3 4787.8 5027.1 5132.4 5133.4 5200.3 4946.2 4961.1 4961.4 5019.3 5036.9 4955.5 4967.6 4972.9 4977.3 5034.4 4519.2 4549.1 4550.9 4587.8 4597.4 6159.4 6178.9 6223.0 6245.3 6248.8 5838.5 5870.4 5879.3 5923.9 5926.5 6611.0 6623.3 6670.5 6686.7 6691.0 5042.7 5061.8 5072.5 5073.3 5087.3 6811.2 6844.7 6891.7 6972.1 6997.7 5253.3 5269.0 5270.5 5278.9 5281.6 5327.0 5341.4 5350.9 5361.6 5378.1 5938.7 5947.4 5947.9 5962.7 5977.0 6630.6 6683.8 6708.3 6748.4 6762.0 1797.2 1809.5 1813.2 1825.8 1833.4 1262.1 1312.2 1317.8 1325.5 1330.2 6089.4 6110.3 6130.4 6193.0 6264.0 6600.2 6642.0 6658.0 6807.8 6839.2 6166.6 6194.7 6201.2 6211.9 6293.2 3508.8 3510.9 3547.2 3606.8 3626.5 6957.1 7009.7 7047.9 7054.6 7087.6 6821.8 6832.8 6846.9 6872.3 6937.0 7087.9 7110.5 7118.3 7121.1 7192.3 6770.8 6806.7 6817.4 6820.0 6851.0 6569.9 6675.9 6680.2 6689.9 6750.8 6960.9 7042.8 7066.6 7077.9 7148.5 5198.2 5244.5 5260.4 5260.8 5272.8 6851.6 6855.4 6864.3 6871.5 6878.2 6394.6 6504.7 6567.4 6598.7 6599.7 6465.5 6469.8 6501.4 6507.7 6534.6 6421.2 6442.9 6475.6 6533.6 6544.5 6436.6 6582.9 6654.0 6654.6 6681.6 6304.0 6356.1 6370.4 6454.0 6458.8 12:01:52 INFO - PID 3829 | 12:01:52 INFO - PID 3829 | [#5] yui.html Cycles:180 Average:28392.73 Median:18540.90 stddev:42302.16 (228.2%) stddev-sans-first:42370.71 12:01:52 INFO - PID 3829 | Values: 970.4 975.6 991.6 997.3 1007.3 19071.9 19532.7 19535.3 19536.8 19548.1 18381.7 18433.4 18517.6 18533.6 18548.2 1055.5 1066.3 1070.8 1071.8 1073.3 1056.9 1058.4 1058.9 1062.0 1067.8 1087.1 1108.1 1111.7 1114.8 1129.2 1092.8 1106.1 1106.8 1107.9 1111.8 790.1 799.1 819.0 823.4 824.9 21333.7 21487.7 21516.0 21534.9 21650.5 23064.3 23393.4 23690.8 23951.9 24032.3 17713.4 17948.2 17968.6 18216.8 18305.3 4007.7 4037.3 4038.9 4040.2 4042.9 133219.0 155406.0 157842.0 158390.0 161617.4 18769.6 19189.5 19202.5 19217.3 19466.7 34125.5 34198.5 34301.3 34388.8 34950.1 9820.5 9825.0 9864.4 9878.0 9895.5 4610.3 4694.2 4705.1 4715.3 4722.8 6072.4 6185.1 6187.6 6196.8 6223.1 1303.8 1315.5 1332.4 1333.9 1334.8 676.6 697.4 702.4 707.5 708.4 12773.6 13420.1 13596.7 13688.2 13800.0 729.2 733.8 737.7 748.4 751.4 5645.0 5848.6 5887.4 5888.2 5904.1 151673.0 153372.0 153433.0 155446.0 157262.0 129238.0 134068.0 134393.0 134731.0 135284.0 113196.0 114060.4 116162.4 116589.0 117161.0 11135.4 11254.7 11335.0 11342.7 11363.5 56232.7 56650.4 56843.1 57585.1 58051.7 69972.3 70186.0 70963.3 71302.6 73540.6 18120.5 18163.6 18199.9 18273.5 18597.4 18863.9 19582.6 19655.3 19733.9 19965.8 18458.0 18501.9 18729.0 18794.7 18900.5 17644.6 17702.3 17744.1 17795.7 17821.5 18123.9 18259.5 18372.6 18380.3 18415.8 13542.3 13589.3 13763.8 13770.4 13955.2 11994.2 12137.2 12191.8 12212.7 12429.6 12:01:52 INFO - PID 3829 | -------- Summary: end -------- 12:01:52 INFO - PID 3829 | 12:01:53 INFO - TEST-INFO | 3829: exit 0 12:01:53 INFO - TEST-OK | dromaeo_css | took 1110951ms 12:01:53 INFO - TEST-START | kraken 12:01:53 INFO - Initialising browser for kraken test... 12:01:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40305/getInfo.html -profile /tmp/tmpcywPyg/profile 12:01:53 INFO - TEST-INFO | started process 4195 (/builds/slave/test/build/application/firefox/firefox http://localhost:40305/getInfo.html) 12:01:58 INFO - TEST-INFO | 4195: exit 0 12:01:58 INFO - Browser initialized. 12:01:58 INFO - Running cycle 1/1 for kraken test... 12:01:58 INFO - Using env: {'DISPLAY': ':0', 12:01:58 INFO - 'HOME': '/home/cltbld', 12:01:58 INFO - 'JSGC_DISABLE_POISONING': '1', 12:01:58 INFO - 'LANG': 'en_US.UTF-8', 12:01:58 INFO - 'LANGUAGE': 'en_US:en', 12:01:58 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:01:58 INFO - 'LOGNAME': 'cltbld', 12:01:58 INFO - 'MAIL': '/var/mail/cltbld', 12:01:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:01:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:01:58 INFO - 'MOZ_CRASHREPORTER': '1', 12:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:58 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:01:58 INFO - 'MOZ_NO_REMOTE': '1', 12:01:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:58 INFO - 'NO_EM_RESTART': '1', 12:01:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:58 INFO - 'PWD': '/builds/slave/test', 12:01:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:01:58 INFO - 'RUST_BACKTRACE': 'full', 12:01:58 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:01:58 INFO - 'SHELL': '/bin/bash', 12:01:58 INFO - 'SHLVL': '1', 12:01:58 INFO - 'STYLO_FORCE_DISABLED': '1', 12:01:58 INFO - 'TERM': 'linux', 12:01:58 INFO - 'TMOUT': '86400', 12:01:58 INFO - 'USER': 'cltbld', 12:01:58 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521', 12:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:58 INFO - '_': '/tools/buildbot/bin/python'} 12:01:58 INFO - TEST-INFO | started process 4437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcywPyg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:01:59 INFO - PID 4437 | 12:01:59 INFO - PID 4437 | (/builds/slave/test/build/application/firefox/firefox:4488): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:01:59 INFO - PID 4437 | 12:02:09 INFO - PID 4437 | RSS: Main: 144584704 12:02:09 INFO - PID 4437 | 12:02:12 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:40305/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40305/tests/kraken/driver.html?testName=audio-beat-detection) 12:02:13 INFO - PID 4437 | RSS: Main: 150077440 12:02:13 INFO - PID 4437 | 12:02:15 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:40305/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40305/tests/kraken/driver.html?testName=audio-dft) 12:02:16 INFO - PID 4437 | RSS: Main: 150372352 12:02:16 INFO - PID 4437 | 12:02:19 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:40305/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40305/tests/kraken/driver.html?testName=audio-fft) 12:02:19 INFO - PID 4437 | RSS: Main: 147202048 12:02:19 INFO - PID 4437 | 12:02:21 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:40305/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40305/tests/kraken/driver.html?testName=audio-oscillator) 12:02:22 INFO - PID 4437 | RSS: Main: 148074496 12:02:22 INFO - PID 4437 | 12:02:24 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:40305/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40305/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:02:25 INFO - PID 4437 | RSS: Main: 148336640 12:02:25 INFO - PID 4437 | 12:02:28 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:40305/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40305/tests/kraken/driver.html?testName=imaging-darkroom) 12:02:28 INFO - PID 4437 | RSS: Main: 148209664 12:02:28 INFO - PID 4437 | 12:02:32 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:40305/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40305/tests/kraken/driver.html?testName=imaging-desaturate) 12:02:33 INFO - PID 4437 | RSS: Main: 149127168 12:02:33 INFO - PID 4437 | 12:02:35 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:40305/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40305/tests/kraken/driver.html?testName=json-parse-financial) 12:02:36 INFO - PID 4437 | RSS: Main: 150405120 12:02:36 INFO - PID 4437 | 12:02:38 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:40305/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40305/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:02:38 INFO - PID 4437 | RSS: Main: 151076864 12:02:38 INFO - PID 4437 | 12:02:40 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:40305/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40305/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:02:40 INFO - PID 4437 | RSS: Main: 150437888 12:02:40 INFO - PID 4437 | 12:02:42 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:40305/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40305/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:02:43 INFO - PID 4437 | RSS: Main: 147357696 12:02:43 INFO - PID 4437 | 12:02:45 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:40305/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40305/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:02:46 INFO - PID 4437 | RSS: Main: 147447808 12:02:46 INFO - PID 4437 | 12:02:49 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:40305/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40305/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:02:49 INFO - PID 4437 | RSS: Main: 147779584 12:02:49 INFO - PID 4437 | 12:02:51 INFO - PID 4437 | Cycle 1(1): loaded http://localhost:40305/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40305/tests/kraken/driver.html?testName=ai-astar) 12:02:51 INFO - PID 4437 | RSS: Main: 149618688 12:02:51 INFO - PID 4437 | 12:02:51 INFO - PID 4437 | __start_tp_report 12:02:51 INFO - PID 4437 | _x_x_mozilla_page_load 12:02:51 INFO - PID 4437 | _x_x_mozilla_page_load_details 12:02:51 INFO - PID 4437 | |i|pagename|runs| 12:02:51 INFO - PID 4437 | |0;ai-astar;107;105;106;105;106;106;108;106;107;105 12:02:51 INFO - PID 4437 | |1;audio-beat-detection;113;113;116;113;140;111;141;114;116;113 12:02:51 INFO - PID 4437 | |2;audio-dft;162;163;162;162;162;161;161;164;164;167 12:02:51 INFO - PID 4437 | |3;audio-fft;78;73;73;73;75;73;82;74;74;74 12:02:51 INFO - PID 4437 | |4;audio-oscillator;77;78;78;79;79;79;78;78;78;77 12:02:51 INFO - PID 4437 | |5;imaging-gaussian-blur;113;113;113;116;117;117;117;116;116;115 12:02:51 INFO - PID 4437 | |6;imaging-darkroom;151;151;150;150;149;150;149;150;151;150 12:02:51 INFO - PID 4437 | |7;imaging-desaturate;94;95;95;94;94;94;94;94;94;94 12:02:51 INFO - PID 4437 | |8;json-parse-financial;44;44;45;47;45;45;44;48;43;46 12:02:51 INFO - PID 4437 | |9;json-stringify-tinderbox;37;36;36;37;37;37;38;37;37;36 12:02:51 INFO - PID 4437 | |10;stanford-crypto-aes;72;72;74;71;69;72;70;70;71;74 12:02:51 INFO - PID 4437 | |11;stanford-crypto-ccm;107;103;104;107;105;113;108;102;107;108 12:02:51 INFO - PID 4437 | |12;stanford-crypto-pbkdf2;158;162;157;155;152;157;151;148;156;155 12:02:51 INFO - PID 4437 | |13;stanford-crypto-sha256-iterative;65;63;59;59;60;59;60;69;58;58 12:02:51 INFO - PID 4437 | __end_tp_report 12:02:51 INFO - PID 4437 | __start_cc_report 12:02:51 INFO - PID 4437 | _x_x_mozilla_cycle_collect,702 12:02:51 INFO - PID 4437 | __end_cc_report 12:02:51 INFO - PID 4437 | __startTimestamp1506538971803__endTimestamp 12:02:51 INFO - PID 4437 | 12:02:51 INFO - PID 4437 | ------- Summary: start ------- 12:02:51 INFO - PID 4437 | Number of tests: 14 12:02:51 INFO - PID 4437 | 12:02:51 INFO - PID 4437 | [#0] ai-astar Cycles:10 Average:106.10 Median:106.00 stddev:0.99 (0.9%) stddev-sans-first:1.00 12:02:51 INFO - PID 4437 | Values: 107.0 105.0 106.0 105.0 106.0 106.0 108.0 106.0 107.0 105.0 12:02:51 INFO - PID 4437 | 12:02:51 INFO - PID 4437 | [#1] audio-beat-detection Cycles:10 Average:119.00 Median:115.00 stddev:11.43 (9.9%) stddev-sans-first:11.92 12:02:51 INFO - PID 4437 | Values: 113.0 113.0 116.0 113.0 140.0 111.0 141.0 114.0 116.0 113.0 12:02:51 INFO - PID 4437 | 12:02:51 INFO - PID 4437 | [#2] audio-dft Cycles:10 Average:162.80 Median:162.50 stddev:1.81 (1.1%) stddev-sans-first:1.90 12:02:51 INFO - PID 4437 | Values: 162.0 163.0 162.0 162.0 162.0 161.0 161.0 164.0 164.0 167.0 12:02:51 INFO - PID 4437 | 12:02:51 INFO - PID 4437 | [#3] audio-fft Cycles:10 Average:74.90 Median:74.00 stddev:2.92 (4.0%) stddev-sans-first:2.88 12:02:51 INFO - PID 4437 | Values: 78.0 73.0 73.0 73.0 75.0 73.0 82.0 74.0 74.0 74.0 12:02:51 INFO - PID 4437 | 12:02:51 INFO - PID 4437 | [#4] audio-oscillator Cycles:10 Average:78.10 Median:78.00 stddev:0.74 (0.9%) stddev-sans-first:0.67 12:02:51 INFO - PID 4437 | Values: 77.0 78.0 78.0 79.0 79.0 79.0 78.0 78.0 78.0 77.0 12:02:51 INFO - PID 4437 | 12:02:51 INFO - PID 4437 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:116.00 stddev:1.70 (1.5%) stddev-sans-first:1.59 12:02:51 INFO - PID 4437 | Values: 113.0 113.0 113.0 116.0 117.0 117.0 117.0 116.0 116.0 115.0 12:02:51 INFO - PID 4437 | 12:02:51 INFO - PID 4437 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:150.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 12:02:51 INFO - PID 4437 | Values: 151.0 151.0 150.0 150.0 149.0 150.0 149.0 150.0 151.0 150.0 12:02:51 INFO - PID 4437 | 12:02:51 INFO - PID 4437 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:02:51 INFO - PID 4437 | Values: 94.0 95.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 12:02:51 INFO - PID 4437 | 12:02:51 INFO - PID 4437 | [#8] json-parse-financial Cycles:10 Average:45.10 Median:45.00 stddev:1.52 (3.4%) stddev-sans-first:1.56 12:02:51 INFO - PID 4437 | Values: 44.0 44.0 45.0 47.0 45.0 45.0 44.0 48.0 43.0 46.0 12:02:51 INFO - PID 4437 | 12:02:51 INFO - PID 4437 | [#9] json-stringify-tinderbox Cycles:10 Average:36.80 Median:37.00 stddev:0.63 (1.7%) stddev-sans-first:0.67 12:02:51 INFO - PID 4437 | Values: 37.0 36.0 36.0 37.0 37.0 37.0 38.0 37.0 37.0 36.0 12:02:51 INFO - PID 4437 | 12:02:51 INFO - PID 4437 | [#10] stanford-crypto-aes Cycles:10 Average:71.50 Median:72.00 stddev:1.65 (2.3%) stddev-sans-first:1.74 12:02:51 INFO - PID 4437 | Values: 72.0 72.0 74.0 71.0 69.0 72.0 70.0 70.0 71.0 74.0 12:02:51 INFO - PID 4437 | 12:02:51 INFO - PID 4437 | [#11] stanford-crypto-ccm Cycles:10 Average:106.40 Median:107.00 stddev:3.13 (2.9%) stddev-sans-first:3.32 12:02:51 INFO - PID 4437 | Values: 107.0 103.0 104.0 107.0 105.0 113.0 108.0 102.0 107.0 108.0 12:02:51 INFO - PID 4437 | 12:02:51 INFO - PID 4437 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.10 Median:156.50 stddev:3.96 (2.5%) stddev-sans-first:4.06 12:02:51 INFO - PID 4437 | Values: 158.0 162.0 157.0 155.0 152.0 157.0 151.0 148.0 156.0 155.0 12:02:51 INFO - PID 4437 | 12:02:51 INFO - PID 4437 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.00 Median:60.00 stddev:3.59 (6.0%) stddev-sans-first:3.50 12:02:51 INFO - PID 4437 | Values: 65.0 63.0 59.0 59.0 60.0 59.0 60.0 69.0 58.0 58.0 12:02:51 INFO - PID 4437 | -------- Summary: end -------- 12:02:51 INFO - PID 4437 | 12:02:52 INFO - PID 4437 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:02:52 INFO - TEST-INFO | 4437: exit 0 12:02:52 INFO - TEST-OK | kraken | took 59394ms 12:02:52 INFO - SUITE-END | took 1170s 12:02:52 INFO - Completed test suite (00:19:30) 12:02:52 INFO - javascript benchmark 12:02:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9020.57750183559, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3905.433712111742, 3913.843446262148, 3914.1780226152505, 3929.469521614583, 3950.5456872459677, 6172.9074063889075, 6211.534134939875, 6248.062790581415, 6295.118683384324, 6367.936320636786, 6241.126242326078, 6257.687115644211, 6276.403741644548, 6298.590591611542, 6303.590266632677, 5573.219749235111, 5688.9146662799885, 5691.601587888849, 5691.7723291068305, 5722.284714410699, 200.5372055067223, 5678.176664383662, 5721.628094173865, 5752.942470575304, 5767.971160144193, 5291.312129423189, 5568.888622227553, 5601.971990140044, 5687.345955215162, 5731.684757338345, 5595.328560572717, 5635.915461268084, 5712.771489140429, 5725.599208055438, 5735.942640573582, 5600.691961942091, 5630.211770352154, 5664.773409063632, 5667.688277144755, 5703.686297253649, 6234.438900498932, 6251.812445626639, 6257.843553911143, 6264.27960784511, 6301.117843501914, 6671.899921501182, 6693.163354580677, 6784.932150678479, 6807.3873351398615, 6880.277570855038, 6767.830804229884, 6793.0, 6856.965715171392, 6886.896696549556, 6907.551009184437, 6279.654618995954, 6294.244690637107, 6352.7141278642575, 6374.936250637481, 6385.138006369127, 6954.721811127498, 7000.719971201095, 7001.229864714877, 7078.893816592756, 7102.644867756591, 6606.504512161607, 6669.533132680763, 6709.5303328767495, 6711.6979735912, 6757.966210168917, 6745.696443659949, 6791.320867913169, 6802.0, 6807.863842723217, 6822.556533825285, 6743.629100399525, 6828.658567071627, 6839.897401538881, 6842.897356539655, 6846.178458585002, 6712.328767123248, 6715.227748808852, 6736.629485378351, 6809.795706128824, 6823.0, 4884.3650325458175, 4888.9755551222015, 4917.28699338601, 4982.377202849644, 4984.152694042022, 4464.799084041226, 4521.615662668644, 4529.9547004530195, 4538.205813982539, 4599.379083823708, 6328.398802113792, 6333.904991425133, 6335.619862808247, 6378.936210637927, 6411.839704007437, 6766.357196066366, 6775.593464392152, 6854.897176542356, 6865.450763938873, 6875.690593923186, 6182.505399568024, 6276.184096067574, 6299.401556852092, 6311.179546658905, 6373.171487706569, 5490.945090549123, 5505.9174112387545, 5517.393086760453, 5521.3926468088475, 5583.832485025456, 7026.964865175743, 7087.574745515182, 7209.0, 7210.387117095001, 7239.131304243525, 6697.263301036979, 6776.864462710817, 6780.864382712318, 6871.862562748817, 6878.931210687829, 7053.0830991970715, 7097.574145551283, 7099.858002840017, 7111.502194846311, 7112.359887609933, 6631.0, 6690.431313338226, 6758.222804377559, 6791.0, 6806.42145417645, 6791.592504449749, 6793.388595026471, 6857.417119544894, 6872.0, 6882.002109693966, 6434.806955791334, 6507.707153178213, 6509.1863517060365, 6591.077249185022, 6596.736130554724, 6459.095726598186, 6500.674966251763, 6562.507811914221, 6563.212414510289, 6565.048068030013, 6084.482818960438, 6402.327755585783, 6461.935380646321, 6481.546291759531, 6555.836104097245, 6624.56940298879, 6629.7679581214425, 6666.83332916681, 6712.2616512184595, 6712.496562757715, 6323.936760632335, 6380.202474690664, 6423.164988551458, 6482.254540727877, 6494.577852439576], "value": 6173.907316552538, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [956.8708224389705, 970.3644113105918, 985.9745864301127, 987.6592575561431, 1022.0392830739105, 41731.79134104329, 42371.36442953358, 42398.15203695924, 42455.57544424555, 42573.36139957903, 39037.0, 39145.21709565807, 39339.21321573567, 39549.209015819666, 39677.60322396775, 7294.343509084181, 7404.740834070809, 7419.962900185492, 7430.851382972337, 7457.962710186469, 7292.12494500658, 7401.0748656417945, 7439.962800185992, 7443.404527637803, 7447.553146811181, 8057.274845263925, 8213.507189568616, 8216.548089855085, 8219.630116644765, 8224.958875205615, 8133.349332053422, 8147.226013528705, 8153.551554664491, 8166.060902996172, 8173.386995975296, 7902.091259505173, 8045.557494337809, 8050.758477245692, 8078.959605201936, 8081.070676872177, 38563.42154867679, 38842.0, 39052.218955621014, 39060.41409378862, 39105.60894391077, 3623.0, 3685.4840322354894, 3685.63143685632, 3687.1519550503267, 3707.4624179494094, 32695.50956735651, 32821.343573128644, 32879.178020549436, 33024.17439564006, 33152.6684733152, 5317.9202311965355, 5364.7317634118135, 5378.085725426687, 5384.838454846361, 5394.73026348681, 206655.0, 208129.0, 208180.0, 209099.0, 209972.95013524988, 50232.0, 50409.495905041214, 50476.74761626168, 50491.24263136056, 50577.0, 52825.471745282826, 52945.0, 53175.0, 53198.0, 53205.0, 16381.0, 16609.501714948572, 16623.251953662115, 16645.750313745302, 16650.250738716786, 13485.393157307944, 13546.796798048037, 13558.254296013616, 13567.321633918265, 13574.117682350616, 14676.192809395585, 14685.486007989883, 14761.0, 14799.408023679147, 14940.178290193926, 5923.378045305267, 5954.0, 5981.970090149608, 6036.309833246698, 6091.695415229221, 1079.082779637302, 1086.462201210406, 1092.7377429416883, 1109.046220250584, 1125.5329038448951, 25004.62493062569, 25360.36599085001, 25512.872435637702, 25533.872330638227, 25703.614445782954, 1207.1791181996152, 1209.8850609192114, 1210.2798834693344, 1219.896308813743, 1233.808759642257, 13260.403281852146, 13347.998900082339, 13468.461261549624, 13587.252701101337, 13670.0, 287028.0, 289083.0, 289274.0, 289865.0, 291389.0, 47969.28046079312, 48366.27450588244, 54880.0, 55145.724271379186, 55251.0, 1508.8415716349625, 1533.8082739657543, 1534.1945478623588, 1543.7684347347988, 1560.641052557918, 29981.85009075028, 30546.389072218877, 30561.23596910006, 30610.84694576513, 30981.690183097882, 40203.59796401999, 40222.59777402306, 40530.0, 40561.391579125746, 40649.0, 246754.0, 247103.0, 247139.0, 247218.0, 248026.0, 33291.66708332886, 34192.65807341895, 35225.29549409049, 35231.647683523865, 35313.64686353104, 43486.34770478508, 44982.10035799331, 44990.0, 45468.77265613783, 45563.08873822571, 33431.49852752162, 33438.83280583582, 33569.328613427104, 33606.66393336035, 33807.66192338045, 33781.493277601345, 33819.830900845336, 33827.15432114217, 34241.31517369689, 34563.481547776304, 38993.41509877297, 39211.6078839208, 39235.80382098071, 39498.60501394949, 39743.60256397399, 30844.0, 30909.381812363175, 30950.916717914766, 30953.535696964114, 31646.208844779063, 24488.87755561282, 24573.754262457147, 24741.752582473946, 24939.0, 25441.745582544678], "value": 18215.977421384796, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.2797171366071, 606.5238787551773, 620.8075496596056, 628.4563852267789, 640.5612155673363, 23401.531969360603, 23475.765242347614, 24187.75812241877, 24236.636450453214, 24267.63598546021, 26503.337416564547, 27337.043203487832, 27442.0, 27498.0, 27598.172054838386, 6353.841153971153, 6453.677316134174, 6490.902636460457, 6500.024996250577, 6520.608763474183, 6387.169667943161, 6546.0, 6850.349216824394, 6867.3476019778045, 6867.725290988379, 6797.558158719692, 6802.591844489347, 6805.319468053204, 6805.387515123638, 6810.455163586901, 6196.566240363199, 6403.519736019817, 6412.102305677209, 6812.761553345634, 6840.589564626139, 5906.350301466835, 5923.703814809242, 6007.429294217042, 6027.126066720345, 6038.2150320458495, 31340.529892051636, 31558.684413155803, 31603.367932641217, 31798.682013179805, 31804.20489487758, 2146.6028784674886, 2146.8711877287415, 2153.881536515491, 2158.5467051919118, 2164.5779073080757, 20351.0, 21464.785352146435, 21640.783592164033, 21672.783272167235, 21759.34721958328, 2397.7961873240797, 2525.1414519063424, 2525.3181640957023, 2607.6610040694586, 2628.395469042112, 159299.2035039829, 162081.0, 162498.0, 162646.0, 162874.18562907228, 16791.328346866234, 16884.0, 17126.657466850593, 17328.220230089675, 17571.472855814347, 26760.0, 26768.866155669097, 26795.196144115707, 26900.192994210203, 26941.865290673813, 10207.642732504475, 10290.485475726184, 10327.225458090523, 10405.9479702601, 10554.525046372932, 9216.493092879957, 9334.299927505464, 9341.673041443517, 9348.345615806827, 9433.858492122623, 10196.796064078677, 10385.532651030722, 10466.476676166161, 10495.422751748574, 10569.894301056891, 2954.5568164775455, 2960.763138948879, 2986.89545865898, 3001.0996700989617, 3027.8031927924612, 1041.4740556019162, 1041.5521325829966, 1046.863907691995, 1050.8686414198226, 1062.697131317571, 21961.78038219629, 22413.55172896533, 22443.88778056099, 22576.548469030527, 22818.31545053651, 1104.536094840153, 1109.546494092741, 1109.7724966382034, 1113.582406597526, 1119.9328040317607, 12197.268163910016, 12228.388580570936, 12380.195287306296, 12407.44166512509, 12448.253104813559, 621628.0, 622389.0, 625728.0, 630951.0, 634135.0, 120167.0, 122771.3861430705, 123570.38214808868, 123893.0, 124518.0, 1111.8721347045193, 1158.368689064462, 1213.9817902731465, 1231.6489800406841, 1256.8114782782657, 23082.422939426648, 23524.41188970221, 23561.29316120519, 23806.88096559506, 23848.880755596805, 60523.69738151281, 60541.394586055336, 60703.089453659115, 60773.0, 62391.37608623855, 74647.62676186585, 75531.24468755242, 75791.0, 76253.0, 76616.0, 16370.263338149574, 16400.0, 16665.750013750046, 16766.826322157332, 16776.412825551048, 25133.371665708502, 25251.368715782253, 25270.620940685538, 25476.2357129279, 25492.107776227742, 20498.590028199054, 20666.0, 20785.376438706862, 20805.791942080385, 20904.16383344649, 18149.18328675239, 18418.539536511693, 18621.255149794397, 18682.34611788581, 18903.149358279185, 20769.58460830805, 20923.26768563093, 21116.260930867345, 21177.470563236042, 21579.784202157778, 16271.105089219733, 16411.507654770376, 16460.75308870344, 16474.670506590042, 16548.58628534248, 20501.17995280172, 20568.897155514125, 20749.1700331985, 20943.685844712036, 20950.37148885536], "value": 13051.75494721613, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1384.8199734034577, 1436.8275806903173, 1442.718669859377, 1443.689606734552, 1450.550329397887, 16651.084190369525, 17291.740623890637, 17316.653666926653, 17339.133043347847, 17344.132793360346, 16702.49892503224, 16716.498505044838, 16762.58093547662, 16868.156592170402, 16898.83101168988, 2538.3907862113097, 2613.8170328077044, 2623.3179373362873, 2624.0, 2626.7898568114506, 2467.962980555293, 2574.7296533863955, 2587.107447930461, 2587.62479440481, 2591.727868573801, 2526.60837570176, 2597.2338160242775, 2598.7141414444395, 2603.232046546264, 2610.0864697355964, 2555.029088946207, 2576.2142546523305, 2590.456004239112, 2595.169545745362, 2596.195179494363, 2477.9504409911883, 2560.756728110845, 2659.095907391496, 2663.9344262295044, 2668.1328568215213, 16773.580660483465, 16895.57761055971, 16937.491875243762, 16938.0, 16942.06818624975, 8240.340772738167, 8549.871751923725, 8582.22759951601, 8602.612882420306, 8609.655613775441, 5400.351957765093, 5574.58190635704, 5755.107958266475, 5773.538116950634, 5788.855278618026, 2013.496625843539, 2040.4694779357474, 2044.9897750511152, 2075.6575165097743, 2095.3923362224937, 30276.243093922607, 30772.230694232825, 30787.0, 30802.38395232083, 30823.2294192647, 6851.554648947803, 6995.825104372329, 7049.859002820018, 7099.112610923635, 7127.82180445493, 19760.110795014258, 19773.0, 19845.0, 19913.60172796536, 19943.900280498503, 7990.0, 8259.21537453941, 8329.416940814084, 8343.874841877378, 8374.0, 7603.391728661693, 7606.23937606246, 7686.0, 7745.109312429143, 7751.883721744179, 5109.441620305768, 5177.705573606599, 5230.163173892235, 5259.921101183485, 5292.417834038252, 1542.8688561472177, 1550.5735922621143, 1555.1602134847055, 1564.8043994500688, 1579.8736101112113, 880.335346813152, 894.7584152278848, 901.9774505637412, 906.3836591117971, 919.1360121485782, 7812.0, 7820.983272174694, 7841.333486653584, 7849.529028258323, 7925.643346049326, 775.8331958628922, 789.1161898673407, 791.7743443118799, 791.9128895821455, 797.7447216890539, 5453.645513041719, 5591.965486385032, 5774.797882074191, 5822.243108395882, 5829.09649004405, 25269.0, 25867.61198581985, 25882.74117258841, 25892.0, 26204.60693089605, 24059.639105413433, 25830.095946641777, 25927.870360648078, 25943.0, 25943.22170334893, 11986.501687289088, 12788.872111278954, 12860.549880754315, 12892.162009469355, 12988.545400910923, 8827.826954245107, 8931.776705582412, 8980.595873185592, 8982.595783189641, 8988.0, 20751.896240519305, 21663.675044874024, 21736.891315543322, 21890.23384181546, 21902.561948761253, 21739.673904891122, 22235.555288893807, 22550.774492254866, 22551.0, 22557.774422255567, 11904.0, 11963.042956563628, 11990.820137698116, 11992.400379980792, 11997.040236781211, 14767.261636917896, 15134.091954482767, 15348.923255384098, 15398.230088495306, 15398.846011539741, 11986.520539178684, 12057.457414416196, 12130.090243231969, 12328.50685972551, 12449.875501244871, 11438.142139339749, 11439.256448330832, 11469.483873225558, 11491.367974761468, 11775.293482391084, 10665.573377064831, 10835.079018283534, 10847.45762711877, 10848.945755271488, 10880.945595271973, 7878.212178782076, 8000.639971201426, 8050.718224862102, 8079.474834135763, 8102.716404925799, 7835.804104897423, 8018.037835459549, 8053.83892322162, 8074.677012919652, 8117.878231826646], "value": 7061.282399597813, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.1260608238982, 584.1879787095936, 584.6608966799257, 587.9853003674906, 594.3046635436536, 6248.937510624893, 6286.434220920116, 6298.842528936779, 6367.33143019982, 6376.394242546962, 6130.846728831771, 6181.6600086995195, 6211.440970312671, 6227.782027629034, 6232.719527621257, 5082.567981721558, 5120.487951204887, 5123.436421993578, 5130.923036154442, 5186.3257776489, 4787.784549695272, 5027.09512287788, 5132.435432102485, 5133.383993920735, 5200.257913598949, 4946.1838796598695, 4961.131801934665, 4961.404631444232, 5019.272205530196, 5036.899262014757, 4955.5044495550155, 4967.627427942901, 4972.850814475535, 4977.328060711794, 5034.395872495287, 4519.163954668397, 4549.135664223787, 4550.862284428893, 4587.839425620087, 4597.42532183477, 6159.35326790685, 6178.941423995107, 6222.96888515559, 6245.281792593864, 6248.78129265478, 5838.5037271831525, 5870.412958704095, 5879.32387775407, 5923.851903702399, 5926.496247818941, 6610.966945165292, 6623.337666233387, 6670.499712521531, 6686.699098540577, 6690.966545167292, 5042.697438153723, 5061.822836200752, 5072.467390923974, 5073.315102461157, 5087.287779710843, 6811.2167100783545, 6844.691988860463, 6891.724331026753, 6972.1284839395075, 6997.720091196397, 5253.317068781111, 5268.9736551317, 5270.472952704776, 5278.894422111536, 5281.573975026721, 5327.0, 5341.412444631087, 5350.919736203882, 5361.624686271924, 5378.13949768043, 5938.743277554501, 5947.375525569752, 5947.881042379128, 5962.688208594189, 5976.970115149396, 6630.602163870183, 6683.766068187688, 6708.262091169968, 6748.426383757337, 6761.966190169018, 1797.2476835085686, 1809.5295223242051, 1813.238439855264, 1825.8082901295438, 1833.4316361927845, 1262.1291308996947, 1312.1798875702686, 1317.808917706927, 1325.5360623781792, 1330.1553513518986, 6089.386312627157, 6110.26676798787, 6130.356312587114, 6192.969035154795, 6264.0, 6600.174978127734, 6642.0, 6658.0, 6807.787469072571, 6839.213490448563, 6166.568340216231, 6194.690265486708, 6201.162843016225, 6211.937880621226, 6293.1504246927, 3508.8421021054114, 3510.9110079502657, 3547.2196116854766, 3606.8376923038527, 3626.4560315952817, 6957.060796792368, 7009.684564194624, 7047.92952070483, 7054.576725396492, 7087.574745515286, 6821.761238356634, 6832.760853370109, 6846.863062738817, 6872.312768723088, 6937.0, 7087.89368159478, 7110.537815042006, 7118.252583478868, 7121.145462544528, 7192.280771922975, 6770.830729231611, 6806.659667016728, 6817.352351526597, 6820.0, 6851.040854280305, 6569.9014514783275, 6675.866482670416, 6680.231773346128, 6689.866202676017, 6750.831229219112, 6960.8955865663065, 7042.83793174141, 7066.646667666699, 7077.858442831011, 7148.499605027599, 5198.2202669599865, 5244.527992480543, 5260.368755749335, 5260.789568417374, 5272.815451459181, 6851.623160726208, 6855.383015528626, 6864.279250678607, 6871.4502839773695, 6878.174619045746, 6394.58435201729, 6504.707288172138, 6567.376099270562, 6598.670066496752, 6599.690108461999, 6465.547411681137, 6469.77355792545, 6501.414872661483, 6507.739690412331, 6534.640594767143, 6421.229452465734, 6442.935570644421, 6475.611463312216, 6533.575317604341, 6544.509161812788, 6436.613803171825, 6582.934170658424, 6653.9667301663185, 6654.567453115726, 6681.5656982296, 6303.951215854957, 6356.141920840627, 6370.426661600478, 6453.967730161319, 6458.773942911976], "value": 5210.718086002655, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [970.3886551472572, 975.5853762151085, 991.6033586565371, 997.3018886779256, 1007.2697294461516, 19071.904640476812, 19532.707009394835, 19535.316263930767, 19536.804631953677, 19548.120334584943, 18381.724274135897, 18433.354832580862, 18517.629647407044, 18533.629327413444, 18548.165332560035, 1055.530289021386, 1066.3122286125445, 1070.7644318249972, 1071.839224116385, 1073.2969904712386, 1056.9471526423686, 1058.4178701714065, 1058.8570542976715, 1062.049465728173, 1067.781104873503, 1087.0922779479145, 1108.1245815805544, 1111.727626731452, 1114.849495318134, 1129.170060005895, 1092.8032954068265, 1106.1427393769852, 1106.8007758603449, 1107.8781334053247, 1111.8054340490423, 790.0992868130336, 799.1129845871078, 818.9631466584018, 823.3618945317367, 824.9092599814015, 21333.67999480009, 21487.67768483474, 21516.0, 21534.89232553843, 21650.458738531663, 23064.308070757903, 23393.415164620852, 23690.7630923692, 23951.880240598686, 24032.279031629078, 17713.38003169896, 17948.192331345123, 17968.640627187382, 18216.817831821645, 18305.267789288413, 4007.699422543321, 4037.253108174997, 4038.8586399475876, 4040.1919616076902, 4042.939355909664, 133219.0, 155406.0, 157842.0, 158390.0, 161617.38382616141, 18769.624607508045, 19189.520261993563, 19202.51993700141, 19217.32739354116, 19466.70799938002, 34125.48811767826, 34198.48702269468, 34301.313973720884, 34388.82805585956, 34950.12624684352, 9820.459874706818, 9824.950875245579, 9864.408135511892, 9878.0, 9895.455749933823, 4610.2623580227, 4694.2254528002495, 4705.058988202373, 4715.316279139574, 4722.763861806896, 6072.392760723892, 6185.072239164161, 6187.566870319034, 6196.752129914753, 6223.097650840603, 1303.7718399280277, 1315.4540865540885, 1332.380443093966, 1333.9266340351373, 1334.8398192216996, 676.5669971218326, 697.4315932514984, 702.4029574861327, 707.4658632732254, 708.3907839258234, 12773.61679149627, 13420.060595758203, 13596.660083497794, 13688.178709277476, 13800.0, 729.2088084428349, 733.8002366131414, 737.7233537423466, 748.3638906929067, 751.4326683354033, 5645.0, 5848.61983971049, 5887.35239123696, 5888.175655408247, 5904.143899134601, 151673.0, 153372.0, 153433.0, 155446.0, 157262.0, 129238.0, 134068.0, 134393.0, 134731.0, 135284.0, 113196.0, 114060.42969785264, 116162.41918790352, 116588.9999999983, 117161.0, 11135.387553684624, 11254.718632033937, 11335.036521895401, 11342.716432089264, 11363.488643010918, 56232.718836405555, 56650.43349566452, 56843.14735278892, 57585.136222957524, 58051.70974145102, 69972.30027699658, 70186.0, 70963.29036709567, 71302.64348678224, 73540.63229683817, 18120.456386308433, 18163.636727265646, 18199.909000454914, 18273.543161421072, 18597.44207673772, 18863.90568047151, 19582.608347833248, 19655.312064077687, 19733.901330493256, 19965.800341996393, 18457.984810835533, 18501.90749046246, 18729.0, 18794.71807922855, 18900.527486812938, 17644.647107058045, 17702.29190832352, 17744.11279435997, 17795.73306400379, 17821.465356039338, 18123.909380453013, 18259.54351141232, 18372.632547349247, 18380.264789408273, 18415.81584184141, 13542.322883855964, 13589.32053397346, 13763.79354309666, 13770.449182032606, 13955.162690238618, 11994.160408771651, 12137.150399471951, 12191.817122742988, 12212.694682633006, 12429.627111186317], "value": 9975.080910950433, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1376.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 105.0, 106.0, 105.0, 106.0, 106.0, 108.0, 106.0, 107.0, 105.0], "value": 106.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 116.0, 113.0, 140.0, 111.0, 141.0, 114.0, 116.0, 113.0], "value": 119.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 162.0, 162.0, 161.0, 161.0, 164.0, 164.0, 167.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 73.0, 73.0, 73.0, 75.0, 73.0, 82.0, 74.0, 74.0, 74.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 79.0, 79.0, 79.0, 78.0, 78.0, 78.0, 77.0], "value": 78.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 115.0], "value": 115.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 150.0, 150.0, 149.0, 150.0, 149.0, 150.0, 151.0, 150.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 44.0, 45.0, 47.0, 45.0, 45.0, 44.0, 48.0, 43.0, 46.0], "value": 45.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 36.0, 36.0, 37.0, 37.0, 37.0, 38.0, 37.0, 37.0, 36.0], "value": 36.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 74.0, 71.0, 69.0, 72.0, 70.0, 70.0, 71.0, 74.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 103.0, 104.0, 107.0, 105.0, 113.0, 108.0, 102.0, 107.0, 108.0], "value": 106.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 162.0, 157.0, 155.0, 152.0, 157.0, 151.0, 148.0, 156.0, 155.0], "value": 155.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 59.0, 59.0, 60.0, 59.0, 60.0, 69.0, 58.0, 58.0], "value": 61.0, "unit": "score"}]}]} 12:02:53 INFO - Return code: 0 12:02:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:02:53 INFO - # TBPL SUCCESS # 12:02:53 INFO - Running post-action listener: _package_coverage_data 12:02:53 INFO - Running post-action listener: _resource_record_post_action 12:02:53 INFO - [mozharness: 2017-09-27 19:02:53.095242Z] Finished run-tests step (success) 12:02:53 INFO - Running post-run listener: _resource_record_post_run 12:02:53 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 10211328; Write bytes: 459206656; Read time: 4060; Write time: 338672 12:02:53 INFO - TinderboxPrint: CPU usage
13.1% 12:02:53 INFO - TinderboxPrint: I/O read bytes / time
10,211,328 / 4,060 12:02:53 INFO - TinderboxPrint: I/O write bytes / time
459,206,656 / 338,672 12:02:53 INFO - TinderboxPrint: CPU idle
8,236.0 (86.9%) 12:02:53 INFO - TinderboxPrint: CPU user
1,188.8 (12.5%) 12:02:53 INFO - TinderboxPrint: Swap in / out
0 / 0 12:02:53 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12988416; Read time: 0; Write time: 3780 12:02:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:02:53 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 10211328; Write bytes: 445816832; Read time: 4060; Write time: 334868 12:02:53 INFO - Running post-run listener: _upload_blobber_files 12:02:53 INFO - Blob upload gear active. 12:02:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:02:53 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 12:02:53 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'] 12:02:53 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 12:02:54 INFO - (blobuploader) - INFO - Open directory for files ... 12:02:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:02:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:02:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:02:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:02:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:02:55 INFO - (blobuploader) - INFO - Done attempting. 12:02:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:02:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:02:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:03:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:03:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:03:02 INFO - (blobuploader) - INFO - Done attempting. 12:03:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 12:03:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:03:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:03:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 12:03:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:03:03 INFO - (blobuploader) - INFO - Done attempting. 12:03:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 12:03:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:03:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:03:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 12:03:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:03:04 INFO - (blobuploader) - INFO - Done attempting. 12:03:04 INFO - (blobuploader) - INFO - Iteration through files over. 12:03:04 INFO - Return code: 0 12:03:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:03:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:03:04 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3992819334a267fb412a75a6f721b5974bda1ece6c94968fff7eceb7a5e98ce544213c53a177eec24bf5295dc69abdb6ff9bbfa21e0616d2d5c306bf8fa1b8db", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0433fad93a228037a50617704ae600b2cc9638b62d7dadaf89f0f80f4ec330d908c291f393b018636f2d86a38174c7b49edf9fa2929797bdbbf3caa7363ccaf1", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7a478ef703a727922e0739ef8dab67fe8daffa13b9e2caf5a5c170e2a2a08e7a48a25eec2a1c9a2db503381a1669e2f071f917133dd463d80d9bf8c37bd20ff", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5a6908a6d826c338a5d0c8de310273deed29612643632a6dc1fc5e297e339026d46fed76a210cf8267562e9ee81177767be551b32549c7673b87a5cfa00901c"} 12:03:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:03:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:03:04 INFO - Contents: 12:03:04 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3992819334a267fb412a75a6f721b5974bda1ece6c94968fff7eceb7a5e98ce544213c53a177eec24bf5295dc69abdb6ff9bbfa21e0616d2d5c306bf8fa1b8db", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0433fad93a228037a50617704ae600b2cc9638b62d7dadaf89f0f80f4ec330d908c291f393b018636f2d86a38174c7b49edf9fa2929797bdbbf3caa7363ccaf1", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7a478ef703a727922e0739ef8dab67fe8daffa13b9e2caf5a5c170e2a2a08e7a48a25eec2a1c9a2db503381a1669e2f071f917133dd463d80d9bf8c37bd20ff", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5a6908a6d826c338a5d0c8de310273deed29612643632a6dc1fc5e297e339026d46fed76a210cf8267562e9ee81177767be551b32549c7673b87a5cfa00901c"} 12:03:04 INFO - Running post-run listener: copy_logs_to_upload_dir 12:03:04 INFO - Copying logs to upload dir... 12:03:04 INFO - mkdir: /builds/slave/test/build/upload/logs 12:03:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.150587 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-27 12:03:04.127105) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 12:03:04.131293) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521 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/3992819334a267fb412a75a6f721b5974bda1ece6c94968fff7eceb7a5e98ce544213c53a177eec24bf5295dc69abdb6ff9bbfa21e0616d2d5c306bf8fa1b8db", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0433fad93a228037a50617704ae600b2cc9638b62d7dadaf89f0f80f4ec330d908c291f393b018636f2d86a38174c7b49edf9fa2929797bdbbf3caa7363ccaf1", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7a478ef703a727922e0739ef8dab67fe8daffa13b9e2caf5a5c170e2a2a08e7a48a25eec2a1c9a2db503381a1669e2f071f917133dd463d80d9bf8c37bd20ff", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5a6908a6d826c338a5d0c8de310273deed29612643632a6dc1fc5e297e339026d46fed76a210cf8267562e9ee81177767be551b32549c7673b87a5cfa00901c"} build_url:https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011414 build_url: 'https://queue.taskcluster.net/v1/task/SjP9pZd8TymPHLMi-QrYag/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3992819334a267fb412a75a6f721b5974bda1ece6c94968fff7eceb7a5e98ce544213c53a177eec24bf5295dc69abdb6ff9bbfa21e0616d2d5c306bf8fa1b8db", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0433fad93a228037a50617704ae600b2cc9638b62d7dadaf89f0f80f4ec330d908c291f393b018636f2d86a38174c7b49edf9fa2929797bdbbf3caa7363ccaf1", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7a478ef703a727922e0739ef8dab67fe8daffa13b9e2caf5a5c170e2a2a08e7a48a25eec2a1c9a2db503381a1669e2f071f917133dd463d80d9bf8c37bd20ff", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5a6908a6d826c338a5d0c8de310273deed29612643632a6dc1fc5e297e339026d46fed76a210cf8267562e9ee81177767be551b32549c7673b87a5cfa00901c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 12:03:04.164104) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 12:03:04.164460) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1506537521.484369-964037521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 12:03:04.248847) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 12:03:04.249223) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 12:03:04.249695) ========= ========= Total master_lag: 0.23 =========