builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-071 starttime: 1505335769.72 results: success (0) revision: e5f80a639bfe68b68693a5be610f9d36b6c5ad00 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 13:49:29.721050) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 13:49:29.721502) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 13:49:29.721783) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 13:49:29.736070) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 13:49:29.736356) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-13 13:49:29-- 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% 54.4M=0s 2017-09-13 13:49:29 (54.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.102306 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 13:49:29.855440) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 13:49:29.855748) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015759 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 13:49:29.905217) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 13:49:29.905550) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e5f80a639bfe68b68693a5be610f9d36b6c5ad00 --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 e5f80a639bfe68b68693a5be610f9d36b6c5ad00 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-13 13:49:29,958 truncating revision to first 12 chars 2017-09-13 13:49:29,958 Setting DEBUG logging. 2017-09-13 13:49:29,958 attempt 1/10 2017-09-13 13:49:29,959 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e5f80a639bfe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-13 13:49:30,546 unpacking tar archive at: mozilla-central-e5f80a639bfe/testing/mozharness/ program finished with exit code 0 elapsedTime=0.863421 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 13:49:30.785584) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 13:49:30.785905) ========= script_repo_revision: e5f80a639bfe68b68693a5be610f9d36b6c5ad00 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 13:49:30.786295) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 13:49:30.786560) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 13:49:30.799627) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-09-13 13:49:30.800011) ========= /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=dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:49:30 INFO - MultiFileLogger online at 20170913 13:49:30 in /builds/slave/test 13:49:30 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 13:49:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:49:30 INFO - {'append_to_log': False, 13:49:30 INFO - 'base_work_dir': '/builds/slave/test', 13:49:30 INFO - 'blob_upload_branch': 'Firefox', 13:49:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:49:30 INFO - 'branch': 'Firefox', 13:49:30 INFO - 'buildbot_json_path': 'buildprops.json', 13:49:30 INFO - 'code_coverage': False, 13:49:30 INFO - 'config_files': ('talos/linux_config.py',), 13:49:30 INFO - 'default_actions': ('clobber', 13:49:30 INFO - 'read-buildbot-config', 13:49:30 INFO - 'download-and-extract', 13:49:30 INFO - 'populate-webroot', 13:49:30 INFO - 'create-virtualenv', 13:49:30 INFO - 'install', 13:49:30 INFO - 'setup-mitmproxy', 13:49:30 INFO - 'run-tests'), 13:49:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:49:30 INFO - 'disable_ccov_upload': False, 13:49:30 INFO - 'disable_stylo': False, 13:49:30 INFO - 'download_minidump_stackwalk': True, 13:49:30 INFO - 'download_symbols': 'ondemand', 13:49:30 INFO - 'enable_stylo': False, 13:49:30 INFO - 'enable_webrender': False, 13:49:30 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 13:49:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:49:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:49:30 INFO - 'gecko_profile': False, 13:49:30 INFO - 'gecko_profile_interval': 0, 13:49:30 INFO - 'installer_path': 'installer.exe', 13:49:30 INFO - 'log_level': 'info', 13:49:30 INFO - 'log_name': 'talos', 13:49:30 INFO - 'log_to_console': True, 13:49:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:49:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:49:30 INFO - 'opt_config_files': (), 13:49:30 INFO - 'pip_index': False, 13:49:30 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 13:49:30 INFO - 'system_bits': '32', 13:49:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:49:30 INFO - 'title': 'talos-linux64-ix-071', 13:49:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:49:30 INFO - 'use_talos_json': True, 13:49:30 INFO - 'verify': 'False', 13:49:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:49:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:49:30 INFO - 'work_dir': 'build'} 13:49:30 INFO - [mozharness: 2017-09-13 20:49:30.994455Z] Running clobber step. 13:49:30 INFO - Running pre-action listener: _resource_record_pre_action 13:49:30 INFO - Running main action method: clobber 13:49:30 INFO - rmtree: /builds/slave/test/build 13:49:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:49:32 INFO - Running post-action listener: _resource_record_post_action 13:49:32 INFO - [mozharness: 2017-09-13 20:49:32.118737Z] Finished clobber step (success) 13:49:32 INFO - [mozharness: 2017-09-13 20:49:32.118835Z] Running read-buildbot-config step. 13:49:32 INFO - Running pre-action listener: _resource_record_pre_action 13:49:32 INFO - Running main action method: read_buildbot_config 13:49:32 INFO - Using buildbot properties: 13:49:32 INFO - { 13:49:32 INFO - "project": "", 13:49:32 INFO - "product": "firefox", 13:49:32 INFO - "who": "ffxbld@noreply.mozilla.org", 13:49:32 INFO - "installer_path": "public/build/target.tar.bz2", 13:49:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 13:49:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 13:49:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 13:49:32 INFO - "stage_platform": "linux64-pgo", 13:49:32 INFO - "basedir": "/builds/slave/test", 13:49:32 INFO - "buildnumber": 13, 13:49:32 INFO - "platform": "ubuntu64_hw", 13:49:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:49:32 INFO - "slavebuilddir": "test", 13:49:32 INFO - "taskId": "Xf3cAQ9GSfeva668zFjLTA", 13:49:32 INFO - "branch": "mozilla-central", 13:49:32 INFO - "script_repo_revision": "production", 13:49:32 INFO - "revision": "e5f80a639bfe68b68693a5be610f9d36b6c5ad00", 13:49:32 INFO - "slavename": "talos-linux64-ix-071", 13:49:32 INFO - "repo_path": "mozilla-central" 13:49:32 INFO - } 13:49:32 INFO - Finding installer, test and symbols from parent task. 13:49:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xf3cAQ9GSfeva668zFjLTA'}, attempt #1 13:49:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xf3cAQ9GSfeva668zFjLTA'}, attempt #1 13:49:33 INFO - Task dependencies: TlUtrqtwTDi4uaR6ssJI8w 13:49:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TlUtrqtwTDi4uaR6ssJI8w'}, attempt #1 13:49:33 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TlUtrqtwTDi4uaR6ssJI8w/artifacts/public/build/target.tar.bz2 13:49:33 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/TlUtrqtwTDi4uaR6ssJI8w/artifacts/public/build/target.test_packages.json 13:49:33 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TlUtrqtwTDi4uaR6ssJI8w/artifacts/public/build/target.crashreporter-symbols.zip 13:49:33 INFO - Running post-action listener: _resource_record_post_action 13:49:33 INFO - [mozharness: 2017-09-13 20:49:33.496479Z] Finished read-buildbot-config step (success) 13:49:33 INFO - [mozharness: 2017-09-13 20:49:33.496695Z] Running download-and-extract step. 13:49:33 INFO - Running pre-action listener: _resource_record_pre_action 13:49:33 INFO - Running main action method: download_and_extract 13:49:33 INFO - mkdir: /builds/slave/test/build/tests 13:49:33 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')]} 13:49:33 INFO - trying https://queue.taskcluster.net/v1/task/TlUtrqtwTDi4uaR6ssJI8w/artifacts/public/build/target.test_packages.json 13:49:33 INFO - Downloading https://queue.taskcluster.net/v1/task/TlUtrqtwTDi4uaR6ssJI8w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:49:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TlUtrqtwTDi4uaR6ssJI8w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:49:34 INFO - Downloaded 989 bytes. 13:49:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:49:34 INFO - Using the following test package requirements: 13:49:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:49:34 INFO - u'common': [u'target.common.tests.zip'], 13:49:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:49:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:49:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:49:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:49:34 INFO - u'mozbase': [u'target.common.tests.zip'], 13:49:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:49:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:49:34 INFO - u'web-platform': [u'target.common.tests.zip', 13:49:34 INFO - u'target.web-platform.tests.tar.gz'], 13:49:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:49:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 13:49:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TlUtrqtwTDi4uaR6ssJI8w/artifacts/public/build/target.common.tests.zip 13:49:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TlUtrqtwTDi4uaR6ssJI8w/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:49:34 INFO - Fetch https://queue.taskcluster.net/v1/task/TlUtrqtwTDi4uaR6ssJI8w/artifacts/public/build/target.common.tests.zip into memory 13:49:35 INFO - Content-Length response header: 55168945 13:49:35 INFO - Bytes received: 55168945 13:49:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TlUtrqtwTDi4uaR6ssJI8w/artifacts/public/build/target.talos.tests.zip 13:49:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TlUtrqtwTDi4uaR6ssJI8w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:49:45 INFO - Fetch https://queue.taskcluster.net/v1/task/TlUtrqtwTDi4uaR6ssJI8w/artifacts/public/build/target.talos.tests.zip into memory 13:49:46 INFO - Content-Length response header: 14499226 13:49:46 INFO - Bytes received: 14499226 13:49:47 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')]} 13:49:47 INFO - trying https://queue.taskcluster.net/v1/task/TlUtrqtwTDi4uaR6ssJI8w/artifacts/public/build/target.tar.bz2 13:49:47 INFO - Downloading https://queue.taskcluster.net/v1/task/TlUtrqtwTDi4uaR6ssJI8w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:49:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TlUtrqtwTDi4uaR6ssJI8w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:49:48 INFO - Downloaded 62126938 bytes. 13:49:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TlUtrqtwTDi4uaR6ssJI8w/artifacts/public/build/target.tar.bz2 13:49:48 INFO - mkdir: /builds/slave/test/properties 13:49:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:49:48 INFO - Writing to file /builds/slave/test/properties/build_url 13:49:48 INFO - Contents: 13:49:48 INFO - build_url:https://queue.taskcluster.net/v1/task/TlUtrqtwTDi4uaR6ssJI8w/artifacts/public/build/target.tar.bz2 13:49:48 INFO - Running post-action listener: _resource_record_post_action 13:49:48 INFO - Running post-action listener: find_tests_for_verification 13:49:48 INFO - Running post-action listener: set_extra_try_arguments 13:49:48 INFO - [mozharness: 2017-09-13 20:49:48.110171Z] Finished download-and-extract step (success) 13:49:48 INFO - [mozharness: 2017-09-13 20:49:48.110266Z] Running populate-webroot step. 13:49:48 INFO - Running pre-action listener: _resource_record_pre_action 13:49:48 INFO - Running main action method: populate_webroot 13:49:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:49:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:49:48 INFO - 'tests': ['tresize', 13:49:48 INFO - 'tcanvasmark']}, 13:49:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:49:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:49:48 INFO - 'tests': ['dromaeo_css', 13:49:48 INFO - 'kraken']}, 13:49:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:49:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:49:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:49:48 INFO - 'talos_options': ['--disable-stylo'], 13:49:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:49:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:49:48 INFO - 'tests': ['damp', 'tps']}, 13:49:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:49:48 INFO - 'talos_options': ['--disable-stylo'], 13:49:48 INFO - 'tests': ['damp', 'tps']}, 13:49:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:49:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:49:48 INFO - 'tests': ['dromaeo_dom']}, 13:49:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:49:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:49:48 INFO - 'tests': ['basic_compositor_video', 13:49:48 INFO - 'glvideo']}, 13:49:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 13:49:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:49:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:49:48 INFO - 'talos_options': ['--disable-stylo'], 13:49:48 INFO - 'tests': ['ts_paint_webext', 13:49:48 INFO - 'tp5o_webext']}, 13:49:48 INFO - 'other-e10s': {'tests': ['a11yr', 13:49:48 INFO - 'ts_paint', 13:49:48 INFO - 'tpaint', 13:49:48 INFO - 'sessionrestore', 13:49:48 INFO - 'sessionrestore_many_windows', 13:49:48 INFO - 'sessionrestore_no_auto_restore', 13:49:48 INFO - 'tabpaint']}, 13:49:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:49:48 INFO - 'tests': ['a11yr', 13:49:48 INFO - 'ts_paint', 13:49:48 INFO - 'tpaint', 13:49:48 INFO - 'sessionrestore', 13:49:48 INFO - 'sessionrestore_many_windows', 13:49:48 INFO - 'sessionrestore_no_auto_restore', 13:49:48 INFO - 'tabpaint']}, 13:49:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 13:49:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 13:49:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:49:48 INFO - 'tests': ['bloom_basic_singleton']}, 13:49:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:49:48 INFO - 'tests': ['bloom_basic']}, 13:49:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:49:48 INFO - 'tsvgr_opacity', 13:49:48 INFO - 'tart', 13:49:48 INFO - 'tscrollx', 13:49:48 INFO - 'tsvg_static']}, 13:49:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:49:48 INFO - 'tests': ['tsvgx', 13:49:48 INFO - 'tsvgr_opacity', 13:49:48 INFO - 'tart', 13:49:48 INFO - 'tscrollx', 13:49:48 INFO - 'tsvg_static']}, 13:49:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:49:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:49:48 INFO - 'talos_options': ['--disable-stylo'], 13:49:48 INFO - 'tests': ['tp5o']}, 13:49:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:49:48 INFO - 'talos_options': ['--mitmproxy', 13:49:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:49:48 INFO - '--firstNonBlankPaint'], 13:49:48 INFO - 'tests': ['tp6_google', 13:49:48 INFO - 'tp6_youtube', 13:49:48 INFO - 'tp6_amazon', 13:49:48 INFO - 'tp6_facebook']}, 13:49:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:49:48 INFO - 'talos_options': ['--disable-stylo', 13:49:48 INFO - '--mitmproxy', 13:49:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:49:48 INFO - '--firstNonBlankPaint'], 13:49:48 INFO - 'tests': ['tp6_google', 13:49:48 INFO - 'tp6_youtube', 13:49:48 INFO - 'tp6_amazon', 13:49:48 INFO - 'tp6_facebook']}, 13:49:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:49:48 INFO - 'talos_options': ['--stylo-threads=1', 13:49:48 INFO - '--mitmproxy', 13:49:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:49:48 INFO - '--firstNonBlankPaint'], 13:49:48 INFO - 'tests': ['tp6_google', 13:49:48 INFO - 'tp6_youtube', 13:49:48 INFO - 'tp6_amazon', 13:49:48 INFO - 'tp6_facebook']}, 13:49:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:49:48 INFO - 'talos_options': ['--xperf_path', 13:49:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:49:48 INFO - 'tests': ['tp5n']}, 13:49:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:49:48 INFO - 'talos_options': ['--disable-stylo', 13:49:48 INFO - '--xperf_path', 13:49:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:49:48 INFO - 'tests': ['tp5n']}}} 13:49:48 INFO - Running post-action listener: _resource_record_post_action 13:49:48 INFO - [mozharness: 2017-09-13 20:49:48.125252Z] Finished populate-webroot step (success) 13:49:48 INFO - [mozharness: 2017-09-13 20:49:48.125342Z] Running create-virtualenv step. 13:49:48 INFO - Running pre-action listener: _resource_record_pre_action 13:49:48 INFO - Running main action method: create_virtualenv 13:49:48 INFO - Creating virtualenv /builds/slave/test/build/venv 13:49:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:49:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 13:49:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 13:49:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:49:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:49:48 INFO - Installing distribute.............................................................................................................................................................................................done. 13:49:48 INFO - Installing pip...............done. 13:49:48 INFO - Return code: 0 13:49:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:49:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:49:49 INFO - Reading from file tmpfile_stdout 13:49:49 INFO - Output received: 13:49:49 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 13:49:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:49 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 0x19c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b89a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d30090>, '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 0x1d30d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2af90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081', '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 13:49:49 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 13:49:49 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 13:49:49 INFO - Using env: {'DISPLAY': ':0', 13:49:49 INFO - 'HOME': '/home/cltbld', 13:49:49 INFO - 'LANG': 'en_US.UTF-8', 13:49:49 INFO - 'LANGUAGE': 'en_US:en', 13:49:49 INFO - 'LOGNAME': 'cltbld', 13:49:49 INFO - 'MAIL': '/var/mail/cltbld', 13:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:49 INFO - 'MOZ_NO_REMOTE': '1', 13:49:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:49 INFO - 'NO_EM_RESTART': '1', 13:49:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:49 INFO - 'PWD': '/builds/slave/test', 13:49:49 INFO - 'SHELL': '/bin/bash', 13:49:49 INFO - 'SHLVL': '1', 13:49:49 INFO - 'TERM': 'linux', 13:49:49 INFO - 'TMOUT': '86400', 13:49:49 INFO - 'USER': 'cltbld', 13:49:49 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081', 13:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:49 INFO - '_': '/tools/buildbot/bin/python'} 13:49:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 13:49:50 INFO - Downloading/unpacking pip>=1.5 13:49:50 INFO - Running setup.py egg_info for package pip 13:49:50 INFO - warning: no files found matching 'pip/cacert.pem' 13:49:50 INFO - warning: no files found matching '*.html' under directory 'docs' 13:49:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:49:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:49:50 INFO - Installing collected packages: pip 13:49:50 INFO - Found existing installation: pip 1.1 13:49:50 INFO - Uninstalling pip: 13:49:50 INFO - Successfully uninstalled pip 13:49:50 INFO - Running setup.py install for pip 13:49:50 INFO - warning: no files found matching 'pip/cacert.pem' 13:49:50 INFO - warning: no files found matching '*.html' under directory 'docs' 13:49:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:49:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:49:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 13:49:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 13:49:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 13:49:50 INFO - Successfully installed pip 13:49:50 INFO - Cleaning up... 13:49:50 INFO - Return code: 0 13:49:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:49: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')]} 13:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49: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')]} 13:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49: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', '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 0x19c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b89a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d30090>, '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 0x1d30d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2af90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081', '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 13:49: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', 'psutil>=3.1.1'] in /builds/slave/test/build 13:49: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 psutil>=3.1.1 13:49:50 INFO - Using env: {'DISPLAY': ':0', 13:49:50 INFO - 'HOME': '/home/cltbld', 13:49:50 INFO - 'LANG': 'en_US.UTF-8', 13:49:50 INFO - 'LANGUAGE': 'en_US:en', 13:49:50 INFO - 'LOGNAME': 'cltbld', 13:49:50 INFO - 'MAIL': '/var/mail/cltbld', 13:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:50 INFO - 'MOZ_NO_REMOTE': '1', 13:49:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:50 INFO - 'NO_EM_RESTART': '1', 13:49:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:50 INFO - 'PWD': '/builds/slave/test', 13:49:50 INFO - 'SHELL': '/bin/bash', 13:49:50 INFO - 'SHLVL': '1', 13:49:50 INFO - 'TERM': 'linux', 13:49:50 INFO - 'TMOUT': '86400', 13:49:50 INFO - 'USER': 'cltbld', 13:49:50 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081', 13:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:50 INFO - '_': '/tools/buildbot/bin/python'} 13:49:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:50 INFO - Downloading/unpacking psutil>=3.1.1 13:49: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 13:49: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 13:49: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 13:49: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 13:49:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:49:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:49:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:49:51 INFO - Installing collected packages: psutil 13:49:51 INFO - Running setup.py install for psutil 13:49:51 INFO - building 'psutil._psutil_linux' extension 13:49:51 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 13:49:52 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 13:49:52 INFO - building 'psutil._psutil_posix' extension 13:49:52 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 13:49:52 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 13:49:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:49:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:49:52 INFO - Successfully installed psutil 13:49:52 INFO - Cleaning up... 13:49:52 INFO - Return code: 0 13:49:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:49: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')]} 13:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49: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')]} 13:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b89a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d30090>, '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 0x1d30d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2af90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081', '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 13:49: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:49: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 mozsystemmonitor==0.3 13:49:52 INFO - Using env: {'DISPLAY': ':0', 13:49:52 INFO - 'HOME': '/home/cltbld', 13:49:52 INFO - 'LANG': 'en_US.UTF-8', 13:49:52 INFO - 'LANGUAGE': 'en_US:en', 13:49:52 INFO - 'LOGNAME': 'cltbld', 13:49:52 INFO - 'MAIL': '/var/mail/cltbld', 13:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:52 INFO - 'MOZ_NO_REMOTE': '1', 13:49:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:52 INFO - 'NO_EM_RESTART': '1', 13:49:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:52 INFO - 'PWD': '/builds/slave/test', 13:49:52 INFO - 'SHELL': '/bin/bash', 13:49:52 INFO - 'SHLVL': '1', 13:49:52 INFO - 'TERM': 'linux', 13:49:52 INFO - 'TMOUT': '86400', 13:49:52 INFO - 'USER': 'cltbld', 13:49:52 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081', 13:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:52 INFO - '_': '/tools/buildbot/bin/python'} 13:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:49: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 13:49: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 13:49: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 13:49: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 13:49:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:49:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:49:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:49:53 INFO - Installing collected packages: mozsystemmonitor 13:49:53 INFO - Running setup.py install for mozsystemmonitor 13:49:53 INFO - Successfully installed mozsystemmonitor 13:49:53 INFO - Cleaning up... 13:49:54 INFO - Return code: 0 13:49:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:49: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')]} 13:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49: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')]} 13:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x19c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b89a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d30090>, '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 0x1d30d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2af90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081', '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 13:49:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:49:54 INFO - Using env: {'DISPLAY': ':0', 13:49:54 INFO - 'HOME': '/home/cltbld', 13:49:54 INFO - 'LANG': 'en_US.UTF-8', 13:49:54 INFO - 'LANGUAGE': 'en_US:en', 13:49:54 INFO - 'LOGNAME': 'cltbld', 13:49:54 INFO - 'MAIL': '/var/mail/cltbld', 13:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:54 INFO - 'MOZ_NO_REMOTE': '1', 13:49:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:54 INFO - 'NO_EM_RESTART': '1', 13:49:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:54 INFO - 'PWD': '/builds/slave/test', 13:49:54 INFO - 'SHELL': '/bin/bash', 13:49:54 INFO - 'SHLVL': '1', 13:49:54 INFO - 'TERM': 'linux', 13:49:54 INFO - 'TMOUT': '86400', 13:49:54 INFO - 'USER': 'cltbld', 13:49:54 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081', 13:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:54 INFO - '_': '/tools/buildbot/bin/python'} 13:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:54 INFO - Downloading/unpacking jsonschema==2.5.1 13:49: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 13:49: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 13:49: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 13:49: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 13:49:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:49:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:56 INFO - Downloading functools32-3.2.3-2.tar.gz 13:49:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:49:56 INFO - warning: no files found matching '*.txt' 13:49:56 INFO - no previously-included directories found matching 'build' 13:49:56 INFO - no previously-included directories found matching 'dist' 13:49:56 INFO - no previously-included directories found matching '.git*' 13:49:56 INFO - Installing collected packages: jsonschema, functools32 13:49:56 INFO - Running setup.py install for functools32 13:49:56 INFO - warning: no files found matching '*.txt' 13:49:56 INFO - no previously-included directories found matching 'build' 13:49:56 INFO - no previously-included directories found matching 'dist' 13:49:56 INFO - no previously-included directories found matching '.git*' 13:49:56 INFO - Successfully installed jsonschema functools32 13:49:56 INFO - Cleaning up... 13:49:56 INFO - Return code: 0 13:49:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x19c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b89a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d30090>, '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 0x1d30d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2af90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081', '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 13:49:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:49:56 INFO - Using env: {'DISPLAY': ':0', 13:49:56 INFO - 'HOME': '/home/cltbld', 13:49:56 INFO - 'LANG': 'en_US.UTF-8', 13:49:56 INFO - 'LANGUAGE': 'en_US:en', 13:49:56 INFO - 'LOGNAME': 'cltbld', 13:49:56 INFO - 'MAIL': '/var/mail/cltbld', 13:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:56 INFO - 'MOZ_NO_REMOTE': '1', 13:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:56 INFO - 'NO_EM_RESTART': '1', 13:49:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:56 INFO - 'PWD': '/builds/slave/test', 13:49:56 INFO - 'SHELL': '/bin/bash', 13:49:56 INFO - 'SHLVL': '1', 13:49:56 INFO - 'TERM': 'linux', 13:49:56 INFO - 'TMOUT': '86400', 13:49:56 INFO - 'USER': 'cltbld', 13:49:56 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081', 13:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:56 INFO - '_': '/tools/buildbot/bin/python'} 13:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:49:56 INFO - Cleaning up... 13:49:56 INFO - Return code: 0 13:49:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x19c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b89a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d30090>, '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 0x1d30d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2af90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081', '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 13:49:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:49:56 INFO - Using env: {'DISPLAY': ':0', 13:49:56 INFO - 'HOME': '/home/cltbld', 13:49:56 INFO - 'LANG': 'en_US.UTF-8', 13:49:56 INFO - 'LANGUAGE': 'en_US:en', 13:49:56 INFO - 'LOGNAME': 'cltbld', 13:49:56 INFO - 'MAIL': '/var/mail/cltbld', 13:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:56 INFO - 'MOZ_NO_REMOTE': '1', 13:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:56 INFO - 'NO_EM_RESTART': '1', 13:49:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:56 INFO - 'PWD': '/builds/slave/test', 13:49:56 INFO - 'SHELL': '/bin/bash', 13:49:56 INFO - 'SHLVL': '1', 13:49:56 INFO - 'TERM': 'linux', 13:49:56 INFO - 'TMOUT': '86400', 13:49:56 INFO - 'USER': 'cltbld', 13:49:56 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081', 13:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:56 INFO - '_': '/tools/buildbot/bin/python'} 13:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:56 INFO - Downloading/unpacking blobuploader==1.2.4 13:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:59 INFO - Downloading blobuploader-1.2.4.tar.gz 13:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:49:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:49: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 13:49: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 13:49: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 13:49: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 13:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:49:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:49: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 13:49: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 13:49: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 13:49: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 13:49:59 INFO - Downloading docopt-0.6.1.tar.gz 13:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:49:59 INFO - Installing collected packages: blobuploader, requests, docopt 13:49:59 INFO - Running setup.py install for blobuploader 13:49:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:49:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:49:59 INFO - Running setup.py install for requests 13:50:00 INFO - Running setup.py install for docopt 13:50:00 INFO - Successfully installed blobuploader requests docopt 13:50:00 INFO - Cleaning up... 13:50:00 INFO - Return code: 0 13:50:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:00 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 0x19c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b89a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d30090>, '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 0x1d30d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2af90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081', '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 13:50:00 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 13:50:00 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 13:50:00 INFO - Using env: {'DISPLAY': ':0', 13:50:00 INFO - 'HOME': '/home/cltbld', 13:50:00 INFO - 'LANG': 'en_US.UTF-8', 13:50:00 INFO - 'LANGUAGE': 'en_US:en', 13:50:00 INFO - 'LOGNAME': 'cltbld', 13:50:00 INFO - 'MAIL': '/var/mail/cltbld', 13:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:00 INFO - 'MOZ_NO_REMOTE': '1', 13:50:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:00 INFO - 'NO_EM_RESTART': '1', 13:50:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:00 INFO - 'PWD': '/builds/slave/test', 13:50:00 INFO - 'SHELL': '/bin/bash', 13:50:00 INFO - 'SHLVL': '1', 13:50:00 INFO - 'TERM': 'linux', 13:50:00 INFO - 'TMOUT': '86400', 13:50:00 INFO - 'USER': 'cltbld', 13:50:00 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081', 13:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:00 INFO - '_': '/tools/buildbot/bin/python'} 13:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:50:00 INFO - Running setup.py (path:/tmp/pip-KsBKh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:50:00 INFO - Running setup.py (path:/tmp/pip-TAM2_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:50:00 INFO - Running setup.py (path:/tmp/pip-TfGLF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:50:00 INFO - Running setup.py (path:/tmp/pip-atOqIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:50:00 INFO - Running setup.py (path:/tmp/pip-wH1DXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:50:00 INFO - Running setup.py (path:/tmp/pip-H5Ldfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:50:00 INFO - Running setup.py (path:/tmp/pip-Ad0kRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:50:00 INFO - Running setup.py (path:/tmp/pip-P0uld_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:50:00 INFO - Running setup.py (path:/tmp/pip-YjvMRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:50:01 INFO - Running setup.py (path:/tmp/pip-xCFslE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:50:01 INFO - Running setup.py (path:/tmp/pip-h6aTv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:50:01 INFO - Running setup.py (path:/tmp/pip-xfiDpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:50:01 INFO - Running setup.py (path:/tmp/pip-QVWEPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:50:01 INFO - Running setup.py (path:/tmp/pip-153Z7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:50:01 INFO - Running setup.py (path:/tmp/pip-kr4udt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:50:01 INFO - Running setup.py (path:/tmp/pip-8wrY0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:50:01 INFO - Running setup.py (path:/tmp/pip-YxJ9Zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:50:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:50:01 INFO - Running setup.py install for manifestparser 13:50:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:50:01 INFO - Running setup.py install for mozcrash 13:50:01 INFO - Running setup.py install for mozdebug 13:50:01 INFO - Running setup.py install for mozdevice 13:50:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:50:02 INFO - Running setup.py install for mozfile 13:50:02 INFO - Running setup.py install for mozhttpd 13:50:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:50:02 INFO - Running setup.py install for mozinfo 13:50:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:50:02 INFO - Running setup.py install for mozInstall 13:50:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:50:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:50:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:50:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:50:02 INFO - Running setup.py install for mozleak 13:50:02 INFO - Running setup.py install for mozlog 13:50:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:50:02 INFO - Running setup.py install for moznetwork 13:50:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:50:02 INFO - Running setup.py install for mozprocess 13:50:02 INFO - Running setup.py install for mozprofile 13:50:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:50:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:50:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:50:02 INFO - Running setup.py install for mozrunner 13:50:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:50:03 INFO - Running setup.py install for mozscreenshot 13:50:03 INFO - Running setup.py install for moztest 13:50:03 INFO - Running setup.py install for mozversion 13:50:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:50:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:50:03 INFO - Cleaning up... 13:50:03 INFO - Return code: 0 13:50:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:50: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')]} 13:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50: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')]} 13:50:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:03 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 0x19c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b89a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d30090>, '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 0x1d30d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2af90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081', '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 13:50:03 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 13:50:03 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 13:50:03 INFO - Using env: {'DISPLAY': ':0', 13:50:03 INFO - 'HOME': '/home/cltbld', 13:50:03 INFO - 'LANG': 'en_US.UTF-8', 13:50:03 INFO - 'LANGUAGE': 'en_US:en', 13:50:03 INFO - 'LOGNAME': 'cltbld', 13:50:03 INFO - 'MAIL': '/var/mail/cltbld', 13:50:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:03 INFO - 'MOZ_NO_REMOTE': '1', 13:50:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:03 INFO - 'NO_EM_RESTART': '1', 13:50:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:03 INFO - 'PWD': '/builds/slave/test', 13:50:03 INFO - 'SHELL': '/bin/bash', 13:50:03 INFO - 'SHLVL': '1', 13:50:03 INFO - 'TERM': 'linux', 13:50:03 INFO - 'TMOUT': '86400', 13:50:03 INFO - 'USER': 'cltbld', 13:50:03 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081', 13:50:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:03 INFO - '_': '/tools/buildbot/bin/python'} 13:50:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:50:03 INFO - Running setup.py (path:/tmp/pip-jzP84L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:50:03 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)) 13:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:50:03 INFO - Running setup.py (path:/tmp/pip-xFow3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:50:03 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)) 13:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:50:03 INFO - Running setup.py (path:/tmp/pip-6b4NxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:50:03 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)) 13:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:50:03 INFO - Running setup.py (path:/tmp/pip-bGcaQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:50:03 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)) 13:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:50:03 INFO - Running setup.py (path:/tmp/pip-WF25s9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:50:03 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)) 13:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:50:03 INFO - Running setup.py (path:/tmp/pip-F1vDM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:50:04 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)) 13:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:50:04 INFO - Running setup.py (path:/tmp/pip-k4EiAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:50:04 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)) 13:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:50:04 INFO - Running setup.py (path:/tmp/pip-rFs3FE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:50:04 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)) 13:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:50:04 INFO - Running setup.py (path:/tmp/pip-ihlJC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:50:04 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)) 13:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:50:04 INFO - Running setup.py (path:/tmp/pip-dusYhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:50:04 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)) 13:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:50:04 INFO - Running setup.py (path:/tmp/pip-d_Gbhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:50:04 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)) 13:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:50:04 INFO - Running setup.py (path:/tmp/pip-vEClbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:50:04 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)) 13:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:50:04 INFO - Running setup.py (path:/tmp/pip-epmnXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:50:04 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)) 13:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:50:04 INFO - Running setup.py (path:/tmp/pip-E9284G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:50:04 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)) 13:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:50:04 INFO - Running setup.py (path:/tmp/pip-uSH40B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:50:04 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)) 13:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:50:04 INFO - Running setup.py (path:/tmp/pip-OcgKka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:50:04 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)) 13:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:50:04 INFO - Running setup.py (path:/tmp/pip-xg5DK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:50:04 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)) 13:50:04 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)) 13:50:04 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)) 13:50:04 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)) 13:50:04 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)) 13:50:04 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)) 13:50:04 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)) 13:50:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:50:04 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 13:50:04 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 13:50:04 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 13:50:04 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 13:50:05 INFO - Downloading blessings-1.6.tar.gz 13:50:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:50:06 INFO - Installing collected packages: blessings 13:50:06 INFO - Running setup.py install for blessings 13:50:06 INFO - Successfully installed blessings 13:50:06 INFO - Cleaning up... 13:50:06 INFO - Return code: 0 13:50:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:50:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:50:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:50:06 INFO - Reading from file tmpfile_stdout 13:50:06 INFO - Current package versions: 13:50:06 INFO - argparse == 1.2.1 13:50:06 INFO - blessings == 1.6 13:50:06 INFO - blobuploader == 1.2.4 13:50:06 INFO - docopt == 0.6.1 13:50:06 INFO - functools32 == 3.2.3-2 13:50:06 INFO - jsonschema == 2.5.1 13:50:06 INFO - manifestparser == 1.1 13:50:06 INFO - mozInstall == 1.13 13:50:06 INFO - mozcrash == 1.0 13:50:06 INFO - mozdebug == 0.1 13:50:06 INFO - mozdevice == 0.51 13:50:06 INFO - mozfile == 1.2 13:50:06 INFO - mozhttpd == 0.7 13:50:06 INFO - mozinfo == 0.10 13:50:06 INFO - mozleak == 0.1 13:50:06 INFO - mozlog == 3.5 13:50:06 INFO - moznetwork == 0.27 13:50:06 INFO - mozprocess == 0.25 13:50:06 INFO - mozprofile == 0.28 13:50:06 INFO - mozrunner == 6.13 13:50:06 INFO - mozscreenshot == 0.1 13:50:06 INFO - mozsystemmonitor == 0.3 13:50:06 INFO - moztest == 0.8 13:50:06 INFO - mozversion == 1.4 13:50:06 INFO - psutil == 3.1.1 13:50:06 INFO - requests == 1.2.3 13:50:06 INFO - wsgiref == 0.1.2 13:50:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:06 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 0x19c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b89a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d30090>, '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 0x1d30d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2af90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081', '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 13:50:06 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 13:50:06 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 13:50:06 INFO - Using env: {'DISPLAY': ':0', 13:50:06 INFO - 'HOME': '/home/cltbld', 13:50:06 INFO - 'LANG': 'en_US.UTF-8', 13:50:06 INFO - 'LANGUAGE': 'en_US:en', 13:50:06 INFO - 'LOGNAME': 'cltbld', 13:50:06 INFO - 'MAIL': '/var/mail/cltbld', 13:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:06 INFO - 'MOZ_NO_REMOTE': '1', 13:50:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:06 INFO - 'NO_EM_RESTART': '1', 13:50:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:06 INFO - 'PWD': '/builds/slave/test', 13:50:06 INFO - 'SHELL': '/bin/bash', 13:50:06 INFO - 'SHLVL': '1', 13:50:06 INFO - 'TERM': 'linux', 13:50:06 INFO - 'TMOUT': '86400', 13:50:06 INFO - 'USER': 'cltbld', 13:50:06 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081', 13:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:06 INFO - '_': '/tools/buildbot/bin/python'} 13:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:06 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)) 13:50:06 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)) 13:50:06 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)) 13:50:06 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)) 13:50:06 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)) 13:50:06 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)) 13:50:06 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)) 13:50:06 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)) 13:50:06 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)) 13:50:06 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 13:50:07 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)) 13:50:07 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)) 13:50:07 INFO - Installing collected packages: simplejson 13:50:07 INFO - Running setup.py install for simplejson 13:50:07 INFO - building 'simplejson._speedups' extension 13:50:07 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 13:50:08 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 13:50:08 INFO - Successfully installed simplejson 13:50:08 INFO - Cleaning up... 13:50:08 INFO - Return code: 0 13:50:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:08 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 0x19c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b89a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d30090>, '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 0x1d30d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2af90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081', '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 13:50:08 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 13:50:08 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 13:50:08 INFO - Using env: {'DISPLAY': ':0', 13:50:08 INFO - 'HOME': '/home/cltbld', 13:50:08 INFO - 'LANG': 'en_US.UTF-8', 13:50:08 INFO - 'LANGUAGE': 'en_US:en', 13:50:08 INFO - 'LOGNAME': 'cltbld', 13:50:08 INFO - 'MAIL': '/var/mail/cltbld', 13:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:08 INFO - 'MOZ_NO_REMOTE': '1', 13:50:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:08 INFO - 'NO_EM_RESTART': '1', 13:50:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:08 INFO - 'PWD': '/builds/slave/test', 13:50:08 INFO - 'SHELL': '/bin/bash', 13:50:08 INFO - 'SHLVL': '1', 13:50:08 INFO - 'TERM': 'linux', 13:50:08 INFO - 'TMOUT': '86400', 13:50:08 INFO - 'USER': 'cltbld', 13:50:08 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081', 13:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:08 INFO - '_': '/tools/buildbot/bin/python'} 13:50:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:50:09 INFO - Cleaning up... 13:50:09 INFO - Return code: 0 13:50:09 INFO - Running post-action listener: _resource_record_post_action 13:50:09 INFO - Running post-action listener: _start_resource_monitoring 13:50:09 INFO - Starting resource monitoring. 13:50:09 INFO - [mozharness: 2017-09-13 20:50:09.094502Z] Finished create-virtualenv step (success) 13:50:09 INFO - [mozharness: 2017-09-13 20:50:09.095017Z] Running install step. 13:50:09 INFO - Running pre-action listener: _resource_record_pre_action 13:50:09 INFO - Running main action method: install 13:50:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:50:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:50:09 INFO - Reading from file tmpfile_stdout 13:50:09 INFO - Detecting whether we're running mozinstall >=1.0... 13:50:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:50:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:50:09 INFO - Reading from file tmpfile_stdout 13:50:09 INFO - Output received: 13:50:09 INFO - Usage: mozinstall [options] installer 13:50:09 INFO - Options: 13:50:09 INFO - -h, --help show this help message and exit 13:50:09 INFO - -d DEST, --destination=DEST 13:50:09 INFO - Directory to install application into. [default: 13:50:09 INFO - "/builds/slave/test"] 13:50:09 INFO - --app=APP Application being installed. [default: firefox] 13:50:09 INFO - mkdir: /builds/slave/test/build/application 13:50:09 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'] 13:50:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:50:27 INFO - Reading from file tmpfile_stdout 13:50:27 INFO - Output received: 13:50:27 INFO - /builds/slave/test/build/application/firefox/firefox 13:50:27 INFO - Running post-action listener: _resource_record_post_action 13:50:27 INFO - [mozharness: 2017-09-13 20:50:27.451361Z] Finished install step (success) 13:50:27 INFO - [mozharness: 2017-09-13 20:50:27.451613Z] Running setup-mitmproxy step. 13:50:27 INFO - Running pre-action listener: _resource_record_pre_action 13:50:27 INFO - Running main action method: setup_mitmproxy 13:50:27 INFO - Skipping: mitmproxy is not required 13:50:27 INFO - Running post-action listener: _resource_record_post_action 13:50:27 INFO - [mozharness: 2017-09-13 20:50:27.452756Z] Finished setup-mitmproxy step (success) 13:50:27 INFO - [mozharness: 2017-09-13 20:50:27.453048Z] Running run-tests step. 13:50:27 INFO - Running pre-action listener: _resource_record_pre_action 13:50:27 INFO - Running pre-action listener: _set_gcov_prefix 13:50:27 INFO - Running main action method: run_tests 13:50:27 WARNING - Try message not found. 13:50:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:50:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:50:27 INFO - Python 2.7.3 13:50:27 INFO - Return code: 0 13:50:27 INFO - grabbing minidump binary from tooltool 13:50:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:27 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 0x1d30090>, '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 0x1d30d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2af90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:50:27 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 13:50:27 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 13:50:27 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 13:50:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:50:27 INFO - Return code: 0 13:50:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:50:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:50:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:50:27 INFO - ENV: RUST_BACKTRACE is now full 13:50:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:50:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:50:27 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/TlUtrqtwTDi4uaR6ssJI8w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-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 13:50:27 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/TlUtrqtwTDi4uaR6ssJI8w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-071 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 13:50:27 INFO - Using env: {'DISPLAY': ':0', 13:50:27 INFO - 'HOME': '/home/cltbld', 13:50:27 INFO - 'LANG': 'en_US.UTF-8', 13:50:27 INFO - 'LANGUAGE': 'en_US:en', 13:50:27 INFO - 'LOGNAME': 'cltbld', 13:50:27 INFO - 'MAIL': '/var/mail/cltbld', 13:50:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:50:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:50:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:27 INFO - 'MOZ_NO_REMOTE': '1', 13:50:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:50:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:27 INFO - 'NO_EM_RESTART': '1', 13:50:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:27 INFO - 'PWD': '/builds/slave/test', 13:50:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:50:27 INFO - 'RUST_BACKTRACE': 'full', 13:50:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:50:27 INFO - 'SHELL': '/bin/bash', 13:50:27 INFO - 'SHLVL': '1', 13:50:27 INFO - 'TERM': 'linux', 13:50:27 INFO - 'TMOUT': '86400', 13:50:27 INFO - 'USER': 'cltbld', 13:50:27 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081', 13:50:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:27 INFO - '_': '/tools/buildbot/bin/python'} 13:50:27 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/TlUtrqtwTDi4uaR6ssJI8w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 13:50:27 INFO - mozversion application_buildid: 20170913172324 13:50:27 INFO - mozversion application_changeset: e5f80a639bfe68b68693a5be610f9d36b6c5ad00 13:50:27 INFO - mozversion application_display_name: Nightly 13:50:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:50:27 INFO - mozversion application_name: Firefox 13:50:27 INFO - mozversion application_remotingname: firefox 13:50:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:50:27 INFO - mozversion application_vendor: Mozilla 13:50:27 INFO - mozversion application_version: 57.0a1 13:50:27 INFO - mozversion platform_buildid: 20170913172324 13:50:27 INFO - mozversion platform_changeset: e5f80a639bfe68b68693a5be610f9d36b6c5ad00 13:50:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:50:27 INFO - mozversion platform_version: 57.0a1 13:50:27 INFO - using testdate: 1505335827 13:50:27 INFO - actual date: 1505335827 13:50:27 INFO - starting webserver on 'localhost:39807' 13:50:27 INFO - SUITE-START | Running 2 tests 13:50:27 INFO - TEST-START | dromaeo_css 13:50:27 INFO - Initialising browser for dromaeo_css test... 13:50:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39807/getInfo.html -profile /tmp/tmpu1_fA6/profile 13:50:27 INFO - TEST-INFO | started process 16205 (/builds/slave/test/build/application/firefox/firefox http://localhost:39807/getInfo.html) 13:50:33 INFO - TEST-INFO | 16205: exit 0 13:50:33 INFO - Browser initialized. 13:50:33 INFO - Running cycle 1/1 for dromaeo_css test... 13:50:33 INFO - Using env: {'DISPLAY': ':0', 13:50:33 INFO - 'HOME': '/home/cltbld', 13:50:33 INFO - 'JSGC_DISABLE_POISONING': '1', 13:50:33 INFO - 'LANG': 'en_US.UTF-8', 13:50:33 INFO - 'LANGUAGE': 'en_US:en', 13:50:33 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:50:33 INFO - 'LOGNAME': 'cltbld', 13:50:33 INFO - 'MAIL': '/var/mail/cltbld', 13:50:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:50:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:50:33 INFO - 'MOZ_CRASHREPORTER': '1', 13:50:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:33 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:50:33 INFO - 'MOZ_NO_REMOTE': '1', 13:50:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:50:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:33 INFO - 'NO_EM_RESTART': '1', 13:50:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:33 INFO - 'PWD': '/builds/slave/test', 13:50:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:50:33 INFO - 'RUST_BACKTRACE': 'full', 13:50:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:50:33 INFO - 'SHELL': '/bin/bash', 13:50:33 INFO - 'SHLVL': '1', 13:50:33 INFO - 'STYLO_FORCE_DISABLED': '1', 13:50:33 INFO - 'TERM': 'linux', 13:50:33 INFO - 'TMOUT': '86400', 13:50:33 INFO - 'USER': 'cltbld', 13:50:33 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081', 13:50:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:33 INFO - '_': '/tools/buildbot/bin/python'} 13:50:33 INFO - TEST-INFO | started process 16392 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu1_fA6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:50:34 INFO - PID 16392 | 13:50:34 INFO - PID 16392 | (/builds/slave/test/build/application/firefox/firefox:16443): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:50:34 INFO - PID 16392 | 13:50:44 INFO - PID 16392 | RSS: Main: 166354944 13:50:44 INFO - PID 16392 | 13:53:41 INFO - PID 16392 | Cycle 1(1): loaded http://localhost:39807/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39807/tests/dromaeo/cssquery-ext.html) 13:53:42 INFO - PID 16392 | RSS: Main: 169824256 13:53:42 INFO - PID 16392 | 13:56:43 INFO - PID 16392 | Cycle 1(1): loaded http://localhost:39807/tests/dromaeo/cssquery-ext.html (next: http://localhost:39807/tests/dromaeo/cssquery-jquery.html) 13:56:44 INFO - PID 16392 | RSS: Main: 165978112 13:56:44 INFO - PID 16392 | 13:59:46 INFO - PID 16392 | Cycle 1(1): loaded http://localhost:39807/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39807/tests/dromaeo/cssquery-mootools.html) 13:59:46 INFO - PID 16392 | RSS: Main: 168173568 13:59:46 INFO - PID 16392 | 14:02:48 INFO - PID 16392 | Cycle 1(1): loaded http://localhost:39807/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39807/tests/dromaeo/cssquery-prototype.html) 14:02:48 INFO - PID 16392 | RSS: Main: 167211008 14:02:48 INFO - PID 16392 | 14:05:51 INFO - PID 16392 | Cycle 1(1): loaded http://localhost:39807/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39807/tests/dromaeo/cssquery-yui.html) 14:05:52 INFO - PID 16392 | RSS: Main: 168009728 14:05:52 INFO - PID 16392 | 14:08:53 INFO - PID 16392 | Cycle 1(1): loaded http://localhost:39807/tests/dromaeo/cssquery-yui.html (next: http://localhost:39807/tests/dromaeo/cssquery-dojo.html) 14:08:54 INFO - PID 16392 | RSS: Main: 171180032 14:08:54 INFO - PID 16392 | 14:08:54 INFO - PID 16392 | __start_tp_report 14:08:54 INFO - PID 16392 | _x_x_mozilla_page_load 14:08:54 INFO - PID 16392 | _x_x_mozilla_page_load_details 14:08:54 INFO - PID 16392 | |i|pagename|runs| 14:08:54 INFO - PID 16392 | |0;dojo.html;3751.5685696144933;3777.6788972937293;3798.2213646202513;3832.8083595820235;3834.233153369327;6165.106059621352;6201.348858369874;6241.875162496747;6253.687315634223;6283.246010478743;6125.264968203822;6243.781467648633;6258.436740693337;6277.435030847223;6368.936310636892;99.6398871077606;5613.578981576377;5656.038473459501;5672.5178359839465;5716.28546431696;5604.439556044384;5609.887802243953;5647.378788333301;5703.942960570404;5704.48659620634;5607.80372686954;5639.746211420475;5702.885942281173;5707.77168913243;5721.027425337703;5625.043742563774;5633.492985631272;5651.2935883014625;5659.037963546207;5706.600537962344;5631.267935168443;5635.633683810539;5654.9151762723595;5711.685857277848;5719.59962802604;6177.62934223948;6190.133381326618;6254.6247225166635;6354.3963323484195;6357.49140068798;6613.140291762088;6758.324167583251;6763.492738044666;6769.52613317068;6772.255051944282;6934.167899851999;6951;6966.268541803089;6971.477139214579;6981.616011119387;6387.1377364055725;6391;6448.580842245239;6468.191476065492;6478.611283323015;6893.0694356261265;6949.409300209539;6997.965010174917;7085.929140708527;7099.96450017757;6672.199336079701;6745.59526428406;6750.898736518956;6769.695363708645;6786.423154031864;6787.389134977777;6810.284920083419;6822.181338239443;6883.965580172167;6912.688928998106;6697.598144111369;6709.630970296681;6719.260881303053;6730.226024007302;6744.5616034957575;6675.46596272297;6758.493113016543;6759.493038022168;6774.051632771416;6782.898256526156;4897.902041959141;4916.5820905222745;4976.029674213493;4990.6257030722845;4999.400071991385;4424.380586717862;4483.349914262414;4486.977565112219;4549.613282870927;4613.423322084739;6219.564630475823;6259.71831267594;6261.436470717657;6270.561060725797;6272.40412160844;6775.898361524581;6786.321367863175;6798.150231221098;6873.415759660485;6873.5875847449315;6050.42520960508;6142.508599312045;6159.476444502267;6171.9691401543605;6239.064140378889;5423.050966080999;5508.20131080991;5515.586331025189;5519.69641669712;5530.5299049580435;6887.621180835102;6897.241303456616;6898.310168983062;6985.615791131435;7007.299270072952;6713.160854893138;6746.628935408599;6817.386435220755;6876.69054892521;6889.862202755817;7000.964995174992;7065.258147894397;7088.822779430349;7093.645317733989;7117.67970441321;6722.495812813961;6735.730570777114;6812.284710105566;6820.3861652451515;6835.316468353125;6767.627780472121;6807.795766127024;6874.931250687429;6895.310468953065;6903.413209877016;6512.05575191604;6546.672666366568;6558.967205163944;6563.671816409256;6572.80281591553;6505.544611877123;6513.576617519846;6540.967295163684;6613.173353330833;6620.668966551557;6372.490200783834;6434.40971479455;6436.195475565554;6448.387403196689;6475;6524.641144737085;6577.736890524517;6669.199696036507;6695.363940425652;6710.530262881552;6348.682565871595;6352.9047064295;6438.3883531064475;6449.9355006451215;6468.676566171766 14:08:54 INFO - PID 16392 | |1;ext.html;938.1087966431887;969.6218474794829;993.0466751918159;1010.5301035018715;1016.0702956794534;45172;46013.53986460134;46014.07971840565;46260.76869615651;46275.30587041189;43891.56108438915;44253.336199956946;44299.11401771963;44327;44351;7509.061367329097;7588.430867684918;7588.747856603653;7602.771916842504;7638.54168749874;7463.067116610424;7532.623368831564;7548.471606987513;7555.886661700079;7579.431542634297;7512.436567257478;8104.837903241932;8314.542700151489;8322.084570697249;8343.123971982945;8221.630026648785;8248.587570621445;8269.875951860697;8285.58572071394;8288.83422331553;8028.47814892036;8126.228008339198;8208.917910820875;8212.507249565046;8229;42926;43339.56660433387;43407;43451.13097738059;43586.12827743459;3716.9814150929074;3766.736328457009;3766.9811650941842;3771.6039815819495;3780.810959452044;34308.31383372319;34341.31317373639;34469.13827154316;34473.827630861684;34496;5520.1443776214755;5527.309086364205;5574;5581.246531718207;5608.298962629671;214239;216338;218028;219330;234074.8296258525;55545.72227138838;55655.165172522444;55832.16251756227;55885.720571397695;56051.15923261154;58429.70785146047;58548.41451585515;58573;58584.70707646434;58661.70669146627;17040.57398565046;17097.658046838995;17150.656986860195;17173.828261717223;17279.74080388795;14004.579862604138;14014.789778153336;14016.719665606835;14019.579412617637;14019.789703154462;15586.298616562282;15633.3746650135;15666;15708.764368534481;15740.527784166494;6047.909281360783;6050.939490605126;6078.179445774764;6125.356837532084;6425.1968503937005;1089.2647462962468;1093.2238110941162;1093.9726506837233;1095.6986828622194;1102.2945314998408;25433.491330173292;25714.228573142835;25817.48365032689;25915.22254332373;25990.35024124412;1199.7180662544295;1205.4997176171792;1207.1248344950016;1211.3398197982121;1223.614561413152;13620.795688064687;13672.248026358646;13726.107802992774;13776.862231377558;13805.309734513234;262111;264227;264921;264984;265776;58726.11910821341;58730;58842.7057864708;58997.70501147467;59147;1504.7065822164573;1521.1101505619115;1521.764126560385;1536.185821514599;1545.7140429020442;24957.251282461555;25057.624135637616;25156.24531264065;25192.622110668723;25266.74733252644;41097.794511027256;41114.79442602768;41252.1749565001;41331.380029300184;41393.37909931414;164810;165439;165594;165716;166026;37595.24809503849;38526.45894164202;40336;40490.39264411095;40492.797536012135;50172.247416289516;50656;50894.745526272134;51661;51688.224676630634;37142.25715485729;37143;37321.0669733248;37393.6260637401;37628.24743505169;36901.26197476089;37231;37239.25521489609;37257.254854903294;37499.25001500009;43633.34549981816;43642.34536481892;43655.56344436515;43656;43713.12573748571;35381.82309088541;35593.82203089072;35848.283034338645;36076.0158191302;36194;26178.73821261839;26607.20178394651;26781;26856.731432685425;27088.1873543794 14:08:54 INFO - PID 16392 | |2;jquery.html;583.9153322768201;594.5006194796371;596.5496050481886;603.381533927724;607.3835057416721;23181.072757089718;23818.5236295274;23860.403489912762;23921.641175382385;23947.281581552583;24438.75561244387;25724.099656512026;25782.226533204033;25853.224403267886;25856.87071564644;6613.603183808963;6765.898511522331;6781.491388145884;6786.151731033621;6789.966050169743;6496.4802815774865;6619.271880093186;6710.42961348286;6767.69545370457;6789.3210678931955;6717.429018533406;6724.663766811665;6727.0918426012595;6727.226368967558;6727.260001399842;6279.215098112736;6533.93466065338;6562.44219241365;6701.2963638817955;6703.865922681543;6028.457438830526;6088.878222435526;6092.847678808021;6094.177286066369;6097;30237.244068898235;30970.690293097006;30985.69014309873;30999.38001239985;31002;2053.876767393961;2077.37678696392;2086.0821238654944;2087.3633541769755;2090.4982804127053;20207.494812629655;21249.893750531148;21331.253406130865;21338.35984920455;21496.140154393805;2504.361387846106;2525.873706314677;2571.614257861317;2583.547879121165;2588.3658503666534;139467;146623;158076;164024;164714.1764291183;15577.532674019798;16021.919890400473;16210;16486.587835303973;16736.24686889093;24693.753062469146;24715.752842471706;24734.381640458774;24814;24839.50320993606;10559.208059395576;10832.919192923106;10893.237473376788;10948.835767463494;11029.83455248172;9892.307538472238;9948.651797187063;10008.849867251996;10056.245781566411;10096.545655445523;9797.118259356692;9899.802003960025;9945.602175912882;9985.500724963722;9994.250431217688;2961.9703802962126;2963.4665760162948;2968.39147974669;2981.120569432023;3070.988502530846;1038.7091614347994;1052.8210204265292;1056.2922841696081;1057.8942105789513;1074.5433190893839;20505.589888202154;20661.17355305801;20820.895895520727;20875.164993400398;21347.893260533598;1111.8499002634703;1121.254365846719;1122.0798944865132;1127.7067962329854;1127.7969965406141;11404.657860264206;11579.421028948518;11602.94198529002;11682.182247242781;11776.234544754563;611491;626098;627814;644635;647205;122498;125692;127089;127882.16353509223;128484.35757821338;1217.3548019549653;1223.2904915149193;1245.2466257914014;1254.2975933477464;1258.282778816066;18223.179956901706;18414;18559.628807424047;18684;18732.06339682983;60069.39930600813;60847;62081.68959155175;62193.512259509116;63374.36625633685;76090.61954690191;76251.61874190594;76257;76730;76746.61626691831;14554.854451455774;15068.321925513159;15088;15132.394704211709;15228;23341.533169336857;23415.180468683513;23702.28893133209;23750.168744093873;23892.163774267818;19153.904230478758;19326;19576.11907464196;19584.11871465759;19611.215551377783;15190.696186076437;15378.769318460008;15550.144742039296;16114.194290285674;17577.648447031243;19639.70540441923;19955.301564445173;20105.698414524086;20164.79835201688;20227.39317820468;14871;14878.553643390716;14966.102033878002;14976.625584360043;14984.550463486114;19263.614727705088;19374.418767437;19560.902195488932;19620.117094731057;19638.705419418435 14:08:54 INFO - PID 16392 | |3;mootools.html;1401.3903951780974;1440.1431148466659;1452.8038714773509;1457.7230326238014;1458.1907041591912;16513.009219446827;17143.485695429143;17156.142192890336;17168.570785730364;17172.91413542932;16528.173591320447;16528.173591320447;16567.91716041418;16627;16720.41478548251;2606.778423833972;2728.4679487499943;2732.508148533263;2732.8770205340707;2733.221032005879;2744.4511097780423;2755.6830964439046;2805.3547684032683;2807;2831.603575499432;2731;2768.29408500833;2768.9030883919067;2769.404578015726;2770.542860428027;2708.485387776326;2747.2719729271657;2756.104266113511;2810.7470327670403;2811.690714021456;2736.4390299988454;2762.185155379168;2763.3644261819695;2763.7424971637856;2765.363966287745;16337.428190013412;16420.261088251056;16425.1787410629;16481.835181648148;16569;8290;8532.146785321418;8554.743357699279;8554.743357699279;8557.144285571392;5154.53609175176;5290.947090529084;5522.585806064561;5570.080936645449;5615.410381909882;1921.5580416504283;1937.1670181821812;1949.9122539485757;1997.500624843789;2019.4345583236718;30538.69461305381;30762.692373076206;30834;30867.536986945215;30879.76480940782;6958.3041695831025;7046.1544614645545;7172;7190.137183538009;7223.566586004857;18895.338663146726;19244.23023079061;19318.71021934672;20042.89978550098;20128.19487220495;8198.68820988639;8389.161083891684;8389.454685445426;8423.199796019368;8449.36629752771;7480.027596412431;7640.426967977424;7712.113106992655;7732.536047837148;7734.92265077342;5403.756830942617;5536.806211782568;5551.555875529948;5600.887982240414;5679.574031947621;1612.5081850035851;1613.3465946291772;1618.1423845361976;1618.5953511622095;1621.8540331369998;968.1770495079268;971.7279161834698;973.2262851033446;996.9003099689972;1003.3277703938379;8462.24700639792;8531.360147988926;8711.21599056088;8746.91253087461;8761.342899282452;771.7916162636169;780.1691198873182;789.3093543149744;791.386675326615;795.8527672380628;5670.432956704297;5952.49965102597;6143.32423433422;6143.32423433422;6284.748610055638;24069.51860962806;24413.755862441147;24515.509689806106;25252;25319;24040.639390408807;24115.276541703424;24696.876515617307;24784.752152478606;25114.748852511606;12380.257184568954;12559.686007849878;12711.237325760483;12721.109522333349;12728.363581820871;8739.21347078766;8815.338849586435;8840.381173317806;8854.557272136497;8962.372633915824;20459.488512786706;20821.167153313698;21535.676964845854;21677.132914683236;21954.560908782056;21603.675944860526;21690.2408415711;21881.343559693236;22175.889120554293;22814.885925570266;11841.46713397882;11958.701032474257;12088.093392995384;12089;12096.395180241128;15168.620784480476;15264.923675381551;15296.617584560476;15333.233338332815;15334.693306133591;12474.06444516683;12745.17156384832;12773.23360598367;12885.806712899126;12919.806202907152;12144.817827732768;12147.514099435924;12395.380230988594;12420.875791241971;12648.747025059263;10689.51897164645;10880.564777409132;10883.564657413615;10884.836727448936;10924.126069914546;7637.809054773675;7788.532688038736;7801.1808760079375;7831.256030677305;7854.921450785648;8447.45091569046;8459.788505287172;8467.49195048299;8472.279856212292;8540.957295213733 14:08:54 INFO - PID 16392 | |4;prototype.html;546.6610701365153;546.8004178474857;562.1904457581082;580.5529742098587;583.361219464686;6320.115183874262;6353.459955903753;6366.172397588312;6377.585456945301;6391.808245752623;6243.158268310848;6273.2472103347545;6285.811425657238;6301.384925256025;6309.1482649842255;5143.948560514403;5167.199084141964;5212.5665442003565;5215.4523775003645;5216.24364467153;4903.436104847952;5148.407933087687;5187.974060129694;5189.636725429222;5195.142801437777;4969.577585905203;5008.6744361616375;5009.499050094998;5024.547790698836;5024.6536745714875;4985.277134815467;4995.775190116454;4998.6750861193905;5008.248762685626;5036.471170527078;4523.457185137771;4525.389072475206;4537.523560026183;4538.205813982539;4550.453945526558;6134.77304539094;6240.875182496325;6244.875102497925;6249.125122482856;6262.906056409158;5878.382769809151;5899.203607512974;5903.763849446017;5912.758320752647;5927.614705044201;6578.76974305897;6581.769638062645;6610.305917878602;6618.536702430832;6622.1722284714415;5015.874603134915;5030.8239211627415;5035.8489245322335;5042.974785126087;5055.873603159914;6630.436412904909;6738.326167383271;6860.725570977155;6937.791866244021;6948.409385202213;5128;5164.948350516522;5166.509181627739;5185.148168507306;5204.7918083277;5213.6350455467755;5216.295800067019;5218.191180367049;5236.476352364809;5240.161574148118;5799.3040835100055;5835;5840.620359676607;5850.098717916694;5858.94141058584;6676.696539693798;6687.598744075273;6707.765228216989;6719.260881303053;6719.294474080151;1779.128227168678;1795.2370242646823;1801.7477553142571;1816.4096668582763;1820.7906090799463;1235.9073069519823;1254.5483625894672;1304.3673818198167;1305.5887395470586;1308.5943357559188;6117.571769976059;6130.570860039844;6132.816015519542;6134.8159555213415;6174.691265436711;6587.122670039112;6613.636250006296;6690.765823196165;6700.899486507707;6709.664516774142;6048.123022161762;6111.882939700785;6120.969395153084;6130;6149.2313460817395;3531.258435728526;3544.255706301654;3544.379733546619;3554.3779838528153;3565.5721313442036;6867.381935625817;6885.555627752176;6921.2696825793555;6922.2731613180895;6944.51388402807;6927.653617319113;6932.618705971119;6954.374106330353;6971.442284617218;6981.441484681213;6901.965490172617;6943.479239057192;6950.0964874567;6967.82580435483;7006.4394848412;6729.73081076771;6738.056672066013;6776.424003959719;6779.694913728796;6786.185657721105;6729.2934241903895;6732.158480189976;6741.258461569321;6751.358620931003;6757.0944493866145;6942.791716248521;6950.652467376712;6950.860982780215;6976.930230697831;6989.301069893173;5181;5181.92227116586;5190.6107041971245;5193.974030129825;5199.818006369759;6629.403353698191;6773.966130169318;6794;6815.522913396015;6832.462695893384;6454.548181627241;6545.803625891041;6556;6567.605943643397;6577.243616983917;6520.510961677988;6523.53220525378;6552.57408268461;6562.80311590653;6610.206775187008;6446.806595802133;6478.902816457663;6490.675466226576;6524.739010439529;6539.70571324282;6459.257185423737;6643.734250630114;6649.933500664932;6651.43462805667;6678.929531845143;6423.582467139621;6439.3238709934785;6456.612603243821;6465.482761379172;6487.772927947499 14:08:54 INFO - PID 16392 | |5;yui.html;969.2730452160874;986.5954958467029;989.787195752913;1005.2360206243255;1009.1976878381686;19865.602687946233;20257;20403.183872645077;20460.69308960367;20518.589628207428;18808.529786755338;18810.905945470287;18844.246230150777;18893.905530472362;19062.809371906278;1065.0308219520239;1078.5092782783815;1082.3938594387168;1084.4306738962048;1084.7559299157706;1072.0565902006224;1074.570171931226;1074.8011617850684;1076.0745758647597;1077.1113831089344;1008.878934527854;1010.8173437078599;1087.8422628718831;1091.737982884106;1125.1280257800188;1085.90769784568;1086.6739978006606;1093.2511229807528;1096.030013438109;1096.7916095941746;819.1644522586928;819.332244220958;819.3486178488116;819.5246756880995;819.5656302159865;20884.269050583156;21110.155593776384;21131.154753809828;21165.047572859257;21170.470738231514;22053.669194962087;22537.323880283617;22544.210952616744;22548.210812621644;22548.887255563783;18269.177886994985;18500.444986650422;18502.259909603734;18515.81484185168;18523.44429667112;3876.7673939563433;3956.3867600521967;3959.5248570171766;3973.9602603974167;3982.2234664240486;122618.38690806578;133726;154049.22975385052;156708.21645891812;157641.2117939403;17425.65148697019;18088.819111808978;18089;18108.094595270184;18135.55678858662;34367.828160859535;34816.30367392689;34900;35004.12489687778;35013.29973400518;9504.95247523758;9768.658096966572;9842.65550705722;9844.212463002943;9857.753556161153;4495.348174514677;4542.636589072867;4557.977210113928;4559.794809233593;4574.6340292776495;6136.846578835475;6228.723111762078;6245.281792593819;6248.4688801452385;6268.811935641938;1165.7551914097965;1175.3183153770792;1180.9527618895147;1194.486370860521;1199.6041306368877;719.9604021778748;721.974730884427;723.7322190789441;741.8145463634091;758.962051897403;12151.027917766558;12544.996400287955;12861.485540578458;12875;13223.537176198786;717.2074857282731;725.5066554742825;727.1092911183863;727.8471520980653;745.7129005332986;5858.648481091148;5948.553858460633;5950.285965684059;5981.132735753292;6059.333473317932;142618;144951.27524362522;146272;147775;153094;101208;101650.49174754079;123058;130547;135432;108047.45976270226;111198.44400778106;111657;112343;113902;12757.681057973625;12905.612831615066;12988.675283117998;13003.414846331749;13273.800892986807;52425.7378713104;54886.72556637191;55015.724921375135;55665;55798;70330;70704.64647676729;71196;71225.64387178031;72311;18605.441836744918;19329;19359.90320048447;19370;19488.707669385254;22840.65739013883;22860.88569557208;23102.537949241258;23164.420889477897;23202;20112.899435502728;20243.493912652302;20330.695039574715;20517;20538.691919621517;19851.503712407306;20004.099815508627;20018.69971950393;20076;20227.696584551537;18598.44204673862;18851.340203092826;18931.90534047321;19012.524686882938;19027.904860476163;14568.271586420424;14613.196274204596;14642.707145857235;14662.34019469105;14682.339294731977;13866.098703584235;13920.164790112625;13997.300134993413;14002.299885005912;14012.369443374868 14:08:54 INFO - PID 16392 | __end_tp_report 14:08:54 INFO - PID 16392 | __start_cc_report 14:08:54 INFO - PID 16392 | _x_x_mozilla_cycle_collect,344 14:08:54 INFO - PID 16392 | __end_cc_report 14:08:54 INFO - PID 16392 | __startTimestamp1505336934203__endTimestamp 14:08:54 INFO - PID 16392 | 14:08:54 INFO - PID 16392 | ------- Summary: start ------- 14:08:54 INFO - PID 16392 | Number of tests: 6 14:08:54 INFO - PID 16392 | 14:08:54 INFO - PID 16392 | [#0] dojo.html Cycles:165 Average:6217.94 Median:6475.00 stddev:886.49 (13.7%) stddev-sans-first:867.84 14:08:54 INFO - PID 16392 | Values: 3751.6 3777.7 3798.2 3832.8 3834.2 6165.1 6201.3 6241.9 6253.7 6283.2 6125.3 6243.8 6258.4 6277.4 6368.9 99.6 5613.6 5656.0 5672.5 5716.3 5604.4 5609.9 5647.4 5703.9 5704.5 5607.8 5639.7 5702.9 5707.8 5721.0 5625.0 5633.5 5651.3 5659.0 5706.6 5631.3 5635.6 5654.9 5711.7 5719.6 6177.6 6190.1 6254.6 6354.4 6357.5 6613.1 6758.3 6763.5 6769.5 6772.3 6934.2 6951.0 6966.3 6971.5 6981.6 6387.1 6391.0 6448.6 6468.2 6478.6 6893.1 6949.4 6998.0 7085.9 7100.0 6672.2 6745.6 6750.9 6769.7 6786.4 6787.4 6810.3 6822.2 6884.0 6912.7 6697.6 6709.6 6719.3 6730.2 6744.6 6675.5 6758.5 6759.5 6774.1 6782.9 4897.9 4916.6 4976.0 4990.6 4999.4 4424.4 4483.3 4487.0 4549.6 4613.4 6219.6 6259.7 6261.4 6270.6 6272.4 6775.9 6786.3 6798.2 6873.4 6873.6 6050.4 6142.5 6159.5 6172.0 6239.1 5423.1 5508.2 5515.6 5519.7 5530.5 6887.6 6897.2 6898.3 6985.6 7007.3 6713.2 6746.6 6817.4 6876.7 6889.9 7001.0 7065.3 7088.8 7093.6 7117.7 6722.5 6735.7 6812.3 6820.4 6835.3 6767.6 6807.8 6874.9 6895.3 6903.4 6512.1 6546.7 6559.0 6563.7 6572.8 6505.5 6513.6 6541.0 6613.2 6620.7 6372.5 6434.4 6436.2 6448.4 6475.0 6524.6 6577.7 6669.2 6695.4 6710.5 6348.7 6352.9 6438.4 6449.9 6468.7 14:08:54 INFO - PID 16392 | 14:08:54 INFO - PID 16392 | [#1] ext.html Cycles:180 Average:40982.47 Median:3769.29 stddev:57357.86 (1521.7%) stddev-sans-first:57439.95 14:08:54 INFO - PID 16392 | Values: 938.1 969.6 993.0 1010.5 1016.1 45172.0 46013.5 46014.1 46260.8 46275.3 43891.6 44253.3 44299.1 44327.0 44351.0 7509.1 7588.4 7588.7 7602.8 7638.5 7463.1 7532.6 7548.5 7555.9 7579.4 7512.4 8104.8 8314.5 8322.1 8343.1 8221.6 8248.6 8269.9 8285.6 8288.8 8028.5 8126.2 8208.9 8212.5 8229.0 42926.0 43339.6 43407.0 43451.1 43586.1 3717.0 3766.7 3767.0 3771.6 3780.8 34308.3 34341.3 34469.1 34473.8 34496.0 5520.1 5527.3 5574.0 5581.2 5608.3 214239.0 216338.0 218028.0 219330.0 234074.8 55545.7 55655.2 55832.2 55885.7 56051.2 58429.7 58548.4 58573.0 58584.7 58661.7 17040.6 17097.7 17150.7 17173.8 17279.7 14004.6 14014.8 14016.7 14019.6 14019.8 15586.3 15633.4 15666.0 15708.8 15740.5 6047.9 6050.9 6078.2 6125.4 6425.2 1089.3 1093.2 1094.0 1095.7 1102.3 25433.5 25714.2 25817.5 25915.2 25990.4 1199.7 1205.5 1207.1 1211.3 1223.6 13620.8 13672.2 13726.1 13776.9 13805.3 262111.0 264227.0 264921.0 264984.0 265776.0 58726.1 58730.0 58842.7 58997.7 59147.0 1504.7 1521.1 1521.8 1536.2 1545.7 24957.3 25057.6 25156.2 25192.6 25266.7 41097.8 41114.8 41252.2 41331.4 41393.4 164810.0 165439.0 165594.0 165716.0 166026.0 37595.2 38526.5 40336.0 40490.4 40492.8 50172.2 50656.0 50894.7 51661.0 51688.2 37142.3 37143.0 37321.1 37393.6 37628.2 36901.3 37231.0 37239.3 37257.3 37499.3 43633.3 43642.3 43655.6 43656.0 43713.1 35381.8 35593.8 35848.3 36076.0 36194.0 26178.7 26607.2 26781.0 26856.7 27088.2 14:08:54 INFO - PID 16392 | 14:08:54 INFO - PID 16392 | [#2] jquery.html Cycles:180 Average:40204.47 Median:21343.13 stddev:105398.33 (493.8%) stddev-sans-first:105652.02 14:08:54 INFO - PID 16392 | Values: 583.9 594.5 596.5 603.4 607.4 23181.1 23818.5 23860.4 23921.6 23947.3 24438.8 25724.1 25782.2 25853.2 25856.9 6613.6 6765.9 6781.5 6786.2 6790.0 6496.5 6619.3 6710.4 6767.7 6789.3 6717.4 6724.7 6727.1 6727.2 6727.3 6279.2 6533.9 6562.4 6701.3 6703.9 6028.5 6088.9 6092.8 6094.2 6097.0 30237.2 30970.7 30985.7 30999.4 31002.0 2053.9 2077.4 2086.1 2087.4 2090.5 20207.5 21249.9 21331.3 21338.4 21496.1 2504.4 2525.9 2571.6 2583.5 2588.4 139467.0 146623.0 158076.0 164024.0 164714.2 15577.5 16021.9 16210.0 16486.6 16736.2 24693.8 24715.8 24734.4 24814.0 24839.5 10559.2 10832.9 10893.2 10948.8 11029.8 9892.3 9948.7 10008.8 10056.2 10096.5 9797.1 9899.8 9945.6 9985.5 9994.3 2962.0 2963.5 2968.4 2981.1 3071.0 1038.7 1052.8 1056.3 1057.9 1074.5 20505.6 20661.2 20820.9 20875.2 21347.9 1111.8 1121.3 1122.1 1127.7 1127.8 11404.7 11579.4 11602.9 11682.2 11776.2 611491.0 626098.0 627814.0 644635.0 647205.0 122498.0 125692.0 127089.0 127882.2 128484.4 1217.4 1223.3 1245.2 1254.3 1258.3 18223.2 18414.0 18559.6 18684.0 18732.1 60069.4 60847.0 62081.7 62193.5 63374.4 76090.6 76251.6 76257.0 76730.0 76746.6 14554.9 15068.3 15088.0 15132.4 15228.0 23341.5 23415.2 23702.3 23750.2 23892.2 19153.9 19326.0 19576.1 19584.1 19611.2 15190.7 15378.8 15550.1 16114.2 17577.6 19639.7 19955.3 20105.7 20164.8 20227.4 14871.0 14878.6 14966.1 14976.6 14984.6 19263.6 19374.4 19560.9 19620.1 19638.7 14:08:54 INFO - PID 16392 | 14:08:54 INFO - PID 16392 | [#3] mootools.html Cycles:180 Average:10328.60 Median:2732.69 stddev:7712.92 (282.2%) stddev-sans-first:7705.40 14:08:54 INFO - PID 16392 | Values: 1401.4 1440.1 1452.8 1457.7 1458.2 16513.0 17143.5 17156.1 17168.6 17172.9 16528.2 16528.2 16567.9 16627.0 16720.4 2606.8 2728.5 2732.5 2732.9 2733.2 2744.5 2755.7 2805.4 2807.0 2831.6 2731.0 2768.3 2768.9 2769.4 2770.5 2708.5 2747.3 2756.1 2810.7 2811.7 2736.4 2762.2 2763.4 2763.7 2765.4 16337.4 16420.3 16425.2 16481.8 16569.0 8290.0 8532.1 8554.7 8554.7 8557.1 5154.5 5290.9 5522.6 5570.1 5615.4 1921.6 1937.2 1949.9 1997.5 2019.4 30538.7 30762.7 30834.0 30867.5 30879.8 6958.3 7046.2 7172.0 7190.1 7223.6 18895.3 19244.2 19318.7 20042.9 20128.2 8198.7 8389.2 8389.5 8423.2 8449.4 7480.0 7640.4 7712.1 7732.5 7734.9 5403.8 5536.8 5551.6 5600.9 5679.6 1612.5 1613.3 1618.1 1618.6 1621.9 968.2 971.7 973.2 996.9 1003.3 8462.2 8531.4 8711.2 8746.9 8761.3 771.8 780.2 789.3 791.4 795.9 5670.4 5952.5 6143.3 6143.3 6284.7 24069.5 24413.8 24515.5 25252.0 25319.0 24040.6 24115.3 24696.9 24784.8 25114.7 12380.3 12559.7 12711.2 12721.1 12728.4 8739.2 8815.3 8840.4 8854.6 8962.4 20459.5 20821.2 21535.7 21677.1 21954.6 21603.7 21690.2 21881.3 22175.9 22814.9 11841.5 11958.7 12088.1 12089.0 12096.4 15168.6 15264.9 15296.6 15333.2 15334.7 12474.1 12745.2 12773.2 12885.8 12919.8 12144.8 12147.5 12395.4 12420.9 12648.7 10689.5 10880.6 10883.6 10884.8 10924.1 7637.8 7788.5 7801.2 7831.3 7854.9 8447.5 8459.8 8467.5 8472.3 8541.0 14:08:54 INFO - PID 16392 | 14:08:54 INFO - PID 16392 | [#4] prototype.html Cycles:180 Average:5640.08 Median:6268.08 stddev:1570.32 (25.1%) stddev-sans-first:1527.48 14:08:54 INFO - PID 16392 | Values: 546.7 546.8 562.2 580.6 583.4 6320.1 6353.5 6366.2 6377.6 6391.8 6243.2 6273.2 6285.8 6301.4 6309.1 5143.9 5167.2 5212.6 5215.5 5216.2 4903.4 5148.4 5188.0 5189.6 5195.1 4969.6 5008.7 5009.5 5024.5 5024.7 4985.3 4995.8 4998.7 5008.2 5036.5 4523.5 4525.4 4537.5 4538.2 4550.5 6134.8 6240.9 6244.9 6249.1 6262.9 5878.4 5899.2 5903.8 5912.8 5927.6 6578.8 6581.8 6610.3 6618.5 6622.2 5015.9 5030.8 5035.8 5043.0 5055.9 6630.4 6738.3 6860.7 6937.8 6948.4 5128.0 5164.9 5166.5 5185.1 5204.8 5213.6 5216.3 5218.2 5236.5 5240.2 5799.3 5835.0 5840.6 5850.1 5858.9 6676.7 6687.6 6707.8 6719.3 6719.3 1779.1 1795.2 1801.7 1816.4 1820.8 1235.9 1254.5 1304.4 1305.6 1308.6 6117.6 6130.6 6132.8 6134.8 6174.7 6587.1 6613.6 6690.8 6700.9 6709.7 6048.1 6111.9 6121.0 6130.0 6149.2 3531.3 3544.3 3544.4 3554.4 3565.6 6867.4 6885.6 6921.3 6922.3 6944.5 6927.7 6932.6 6954.4 6971.4 6981.4 6902.0 6943.5 6950.1 6967.8 7006.4 6729.7 6738.1 6776.4 6779.7 6786.2 6729.3 6732.2 6741.3 6751.4 6757.1 6942.8 6950.7 6950.9 6976.9 6989.3 5181.0 5181.9 5190.6 5194.0 5199.8 6629.4 6774.0 6794.0 6815.5 6832.5 6454.5 6545.8 6556.0 6567.6 6577.2 6520.5 6523.5 6552.6 6562.8 6610.2 6446.8 6478.9 6490.7 6524.7 6539.7 6459.3 6643.7 6649.9 6651.4 6678.9 6423.6 6439.3 6456.6 6465.5 6487.8 14:08:54 INFO - PID 16392 | 14:08:54 INFO - PID 16392 | [#5] yui.html Cycles:180 Average:27684.51 Median:19429.35 stddev:39744.13 (204.6%) stddev-sans-first:39805.00 14:08:54 INFO - PID 16392 | Values: 969.3 986.6 989.8 1005.2 1009.2 19865.6 20257.0 20403.2 20460.7 20518.6 18808.5 18810.9 18844.2 18893.9 19062.8 1065.0 1078.5 1082.4 1084.4 1084.8 1072.1 1074.6 1074.8 1076.1 1077.1 1008.9 1010.8 1087.8 1091.7 1125.1 1085.9 1086.7 1093.3 1096.0 1096.8 819.2 819.3 819.3 819.5 819.6 20884.3 21110.2 21131.2 21165.0 21170.5 22053.7 22537.3 22544.2 22548.2 22548.9 18269.2 18500.4 18502.3 18515.8 18523.4 3876.8 3956.4 3959.5 3974.0 3982.2 122618.4 133726.0 154049.2 156708.2 157641.2 17425.7 18088.8 18089.0 18108.1 18135.6 34367.8 34816.3 34900.0 35004.1 35013.3 9505.0 9768.7 9842.7 9844.2 9857.8 4495.3 4542.6 4558.0 4559.8 4574.6 6136.8 6228.7 6245.3 6248.5 6268.8 1165.8 1175.3 1181.0 1194.5 1199.6 720.0 722.0 723.7 741.8 759.0 12151.0 12545.0 12861.5 12875.0 13223.5 717.2 725.5 727.1 727.8 745.7 5858.6 5948.6 5950.3 5981.1 6059.3 142618.0 144951.3 146272.0 147775.0 153094.0 101208.0 101650.5 123058.0 130547.0 135432.0 108047.5 111198.4 111657.0 112343.0 113902.0 12757.7 12905.6 12988.7 13003.4 13273.8 52425.7 54886.7 55015.7 55665.0 55798.0 70330.0 70704.6 71196.0 71225.6 72311.0 18605.4 19329.0 19359.9 19370.0 19488.7 22840.7 22860.9 23102.5 23164.4 23202.0 20112.9 20243.5 20330.7 20517.0 20538.7 19851.5 20004.1 20018.7 20076.0 20227.7 18598.4 18851.3 18931.9 19012.5 19027.9 14568.3 14613.2 14642.7 14662.3 14682.3 13866.1 13920.2 13997.3 14002.3 14012.4 14:08:54 INFO - PID 16392 | -------- Summary: end -------- 14:08:54 INFO - PID 16392 | 14:08:54 INFO - PID 16392 | 14:08:54 INFO - PID 16392 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 14:08:54 INFO - PID 16392 | 14:08:54 INFO - TEST-INFO | 16392: exit 0 14:08:54 INFO - TEST-OK | dromaeo_css | took 1107099ms 14:08:54 INFO - TEST-START | kraken 14:08:54 INFO - Initialising browser for kraken test... 14:08:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39807/getInfo.html -profile /tmp/tmplvtoCk/profile 14:08:54 INFO - TEST-INFO | started process 16765 (/builds/slave/test/build/application/firefox/firefox http://localhost:39807/getInfo.html) 14:09:00 INFO - TEST-INFO | 16765: exit 0 14:09:00 INFO - Browser initialized. 14:09:00 INFO - Running cycle 1/1 for kraken test... 14:09:00 INFO - Using env: {'DISPLAY': ':0', 14:09:00 INFO - 'HOME': '/home/cltbld', 14:09:00 INFO - 'JSGC_DISABLE_POISONING': '1', 14:09:00 INFO - 'LANG': 'en_US.UTF-8', 14:09:00 INFO - 'LANGUAGE': 'en_US:en', 14:09:00 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:09:00 INFO - 'LOGNAME': 'cltbld', 14:09:00 INFO - 'MAIL': '/var/mail/cltbld', 14:09:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:09:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:09:00 INFO - 'MOZ_CRASHREPORTER': '1', 14:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:00 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:09:00 INFO - 'MOZ_NO_REMOTE': '1', 14:09:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:00 INFO - 'NO_EM_RESTART': '1', 14:09:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:00 INFO - 'PWD': '/builds/slave/test', 14:09:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:09:00 INFO - 'RUST_BACKTRACE': 'full', 14:09:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:09:00 INFO - 'SHELL': '/bin/bash', 14:09:00 INFO - 'SHLVL': '1', 14:09:00 INFO - 'STYLO_FORCE_DISABLED': '1', 14:09:00 INFO - 'TERM': 'linux', 14:09:00 INFO - 'TMOUT': '86400', 14:09:00 INFO - 'USER': 'cltbld', 14:09:00 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081', 14:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:00 INFO - '_': '/tools/buildbot/bin/python'} 14:09:00 INFO - TEST-INFO | started process 16955 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplvtoCk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:09:01 INFO - PID 16955 | 14:09:01 INFO - PID 16955 | (/builds/slave/test/build/application/firefox/firefox:17006): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:09:01 INFO - PID 16955 | 14:09:11 INFO - PID 16955 | RSS: Main: 166400000 14:09:11 INFO - PID 16955 | 14:09:13 INFO - PID 16955 | Cycle 1(1): loaded http://localhost:39807/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39807/tests/kraken/driver.html?testName=audio-beat-detection) 14:09:14 INFO - PID 16955 | RSS: Main: 171507712 14:09:14 INFO - PID 16955 | 14:09:17 INFO - PID 16955 | Cycle 1(1): loaded http://localhost:39807/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39807/tests/kraken/driver.html?testName=audio-dft) 14:09:18 INFO - PID 16955 | RSS: Main: 172482560 14:09:18 INFO - PID 16955 | 14:09:20 INFO - PID 16955 | Cycle 1(1): loaded http://localhost:39807/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39807/tests/kraken/driver.html?testName=audio-fft) 14:09:21 INFO - PID 16955 | RSS: Main: 167530496 14:09:21 INFO - PID 16955 | 14:09:23 INFO - PID 16955 | Cycle 1(1): loaded http://localhost:39807/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39807/tests/kraken/driver.html?testName=audio-oscillator) 14:09:24 INFO - PID 16955 | RSS: Main: 168370176 14:09:24 INFO - PID 16955 | 14:09:26 INFO - PID 16955 | Cycle 1(1): loaded http://localhost:39807/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39807/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:09:26 INFO - PID 16955 | RSS: Main: 168112128 14:09:26 INFO - PID 16955 | 14:09:30 INFO - PID 16955 | Cycle 1(1): loaded http://localhost:39807/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39807/tests/kraken/driver.html?testName=imaging-darkroom) 14:09:30 INFO - PID 16955 | RSS: Main: 168382464 14:09:30 INFO - PID 16955 | 14:09:34 INFO - PID 16955 | Cycle 1(1): loaded http://localhost:39807/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39807/tests/kraken/driver.html?testName=imaging-desaturate) 14:09:34 INFO - PID 16955 | RSS: Main: 170725376 14:09:34 INFO - PID 16955 | 14:09:37 INFO - PID 16955 | Cycle 1(1): loaded http://localhost:39807/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39807/tests/kraken/driver.html?testName=json-parse-financial) 14:09:38 INFO - PID 16955 | RSS: Main: 170733568 14:09:38 INFO - PID 16955 | 14:09:39 INFO - PID 16955 | Cycle 1(1): loaded http://localhost:39807/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39807/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:09:40 INFO - PID 16955 | RSS: Main: 170909696 14:09:40 INFO - PID 16955 | 14:09:42 INFO - PID 16955 | Cycle 1(1): loaded http://localhost:39807/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39807/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:09:42 INFO - PID 16955 | RSS: Main: 171520000 14:09:42 INFO - PID 16955 | 14:09:44 INFO - PID 16955 | Cycle 1(1): loaded http://localhost:39807/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39807/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:09:45 INFO - PID 16955 | RSS: Main: 168247296 14:09:45 INFO - PID 16955 | 14:09:47 INFO - PID 16955 | Cycle 1(1): loaded http://localhost:39807/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39807/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:09:48 INFO - PID 16955 | RSS: Main: 168321024 14:09:48 INFO - PID 16955 | 14:09:51 INFO - PID 16955 | Cycle 1(1): loaded http://localhost:39807/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39807/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:09:51 INFO - PID 16955 | RSS: Main: 168955904 14:09:51 INFO - PID 16955 | 14:09:53 INFO - PID 16955 | Cycle 1(1): loaded http://localhost:39807/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39807/tests/kraken/driver.html?testName=ai-astar) 14:09:53 INFO - PID 16955 | RSS: Main: 170524672 14:09:53 INFO - PID 16955 | 14:09:53 INFO - PID 16955 | __start_tp_report 14:09:53 INFO - PID 16955 | _x_x_mozilla_page_load 14:09:53 INFO - PID 16955 | _x_x_mozilla_page_load_details 14:09:53 INFO - PID 16955 | |i|pagename|runs| 14:09:53 INFO - PID 16955 | |0;ai-astar;107;105;106;106;107;112;107;107;104;105 14:09:53 INFO - PID 16955 | |1;audio-beat-detection;113;118;111;118;117;114;114;112;112;116 14:09:53 INFO - PID 16955 | |2;audio-dft;164;163;165;165;165;164;162;169;173;172 14:09:53 INFO - PID 16955 | |3;audio-fft;74;73;73;73;73;73;73;75;73;72 14:09:53 INFO - PID 16955 | |4;audio-oscillator;77;78;78;78;77;77;78;77;79;80 14:09:53 INFO - PID 16955 | |5;imaging-gaussian-blur;113;114;115;114;113;111;114;117;114;114 14:09:53 INFO - PID 16955 | |6;imaging-darkroom;148;149;148;148;148;149;148;148;149;150 14:09:53 INFO - PID 16955 | |7;imaging-desaturate;94;99;98;98;98;98;99;93;95;94 14:09:53 INFO - PID 16955 | |8;json-parse-financial;49;45;45;45;48;45;45;44;46;52 14:09:53 INFO - PID 16955 | |9;json-stringify-tinderbox;38;41;39;37;38;38;38;38;38;40 14:09:53 INFO - PID 16955 | |10;stanford-crypto-aes;71;71;76;71;72;76;72;73;76;72 14:09:53 INFO - PID 16955 | |11;stanford-crypto-ccm;107;104;107;102;110;109;112;112;106;111 14:09:53 INFO - PID 16955 | |12;stanford-crypto-pbkdf2;162;156;151;153;150;151;163;153;155;156 14:09:53 INFO - PID 16955 | |13;stanford-crypto-sha256-iterative;60;61;61;58;59;63;62;63;61;60 14:09:53 INFO - PID 16955 | __end_tp_report 14:09:53 INFO - PID 16955 | __start_cc_report 14:09:53 INFO - PID 16955 | _x_x_mozilla_cycle_collect,913 14:09:53 INFO - PID 16955 | __end_cc_report 14:09:53 INFO - PID 16955 | __startTimestamp1505336993757__endTimestamp 14:09:53 INFO - PID 16955 | 14:09:53 INFO - PID 16955 | ------- Summary: start ------- 14:09:53 INFO - PID 16955 | Number of tests: 14 14:09:53 INFO - PID 16955 | 14:09:53 INFO - PID 16955 | [#0] ai-astar Cycles:10 Average:106.60 Median:107.00 stddev:2.17 (2.0%) stddev-sans-first:2.30 14:09:53 INFO - PID 16955 | Values: 107.0 105.0 106.0 106.0 107.0 112.0 107.0 107.0 104.0 105.0 14:09:53 INFO - PID 16955 | 14:09:53 INFO - PID 16955 | [#1] audio-beat-detection Cycles:10 Average:114.50 Median:115.00 stddev:2.59 (2.3%) stddev-sans-first:2.69 14:09:53 INFO - PID 16955 | Values: 113.0 118.0 111.0 118.0 117.0 114.0 114.0 112.0 112.0 116.0 14:09:53 INFO - PID 16955 | 14:09:53 INFO - PID 16955 | [#2] audio-dft Cycles:10 Average:166.20 Median:165.00 stddev:3.79 (2.3%) stddev-sans-first:3.94 14:09:53 INFO - PID 16955 | Values: 164.0 163.0 165.0 165.0 165.0 164.0 162.0 169.0 173.0 172.0 14:09:53 INFO - PID 16955 | 14:09:53 INFO - PID 16955 | [#3] audio-fft Cycles:10 Average:73.20 Median:73.00 stddev:0.79 (1.1%) stddev-sans-first:0.78 14:09:53 INFO - PID 16955 | Values: 74.0 73.0 73.0 73.0 73.0 73.0 73.0 75.0 73.0 72.0 14:09:53 INFO - PID 16955 | 14:09:53 INFO - PID 16955 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:78.00 stddev:0.99 (1.3%) stddev-sans-first:1.00 14:09:53 INFO - PID 16955 | Values: 77.0 78.0 78.0 78.0 77.0 77.0 78.0 77.0 79.0 80.0 14:09:53 INFO - PID 16955 | 14:09:53 INFO - PID 16955 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:1.52 (1.3%) stddev-sans-first:1.58 14:09:53 INFO - PID 16955 | Values: 113.0 114.0 115.0 114.0 113.0 111.0 114.0 117.0 114.0 114.0 14:09:53 INFO - PID 16955 | 14:09:53 INFO - PID 16955 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 14:09:53 INFO - PID 16955 | Values: 148.0 149.0 148.0 148.0 148.0 149.0 148.0 148.0 149.0 150.0 14:09:53 INFO - PID 16955 | 14:09:53 INFO - PID 16955 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:98.00 stddev:2.32 (2.4%) stddev-sans-first:2.26 14:09:53 INFO - PID 16955 | Values: 94.0 99.0 98.0 98.0 98.0 98.0 99.0 93.0 95.0 94.0 14:09:53 INFO - PID 16955 | 14:09:53 INFO - PID 16955 | [#8] json-parse-financial Cycles:10 Average:46.40 Median:45.50 stddev:2.50 (5.5%) stddev-sans-first:2.47 14:09:53 INFO - PID 16955 | Values: 49.0 45.0 45.0 45.0 48.0 45.0 45.0 44.0 46.0 52.0 14:09:53 INFO - PID 16955 | 14:09:53 INFO - PID 16955 | [#9] json-stringify-tinderbox Cycles:10 Average:38.50 Median:38.00 stddev:1.18 (3.1%) stddev-sans-first:1.24 14:09:53 INFO - PID 16955 | Values: 38.0 41.0 39.0 37.0 38.0 38.0 38.0 38.0 38.0 40.0 14:09:53 INFO - PID 16955 | 14:09:53 INFO - PID 16955 | [#10] stanford-crypto-aes Cycles:10 Average:73.00 Median:72.50 stddev:2.16 (3.0%) stddev-sans-first:2.17 14:09:53 INFO - PID 16955 | Values: 71.0 71.0 76.0 71.0 72.0 76.0 72.0 73.0 76.0 72.0 14:09:53 INFO - PID 16955 | 14:09:53 INFO - PID 16955 | [#11] stanford-crypto-ccm Cycles:10 Average:108.00 Median:109.50 stddev:3.40 (3.1%) stddev-sans-first:3.59 14:09:53 INFO - PID 16955 | Values: 107.0 104.0 107.0 102.0 110.0 109.0 112.0 112.0 106.0 111.0 14:09:53 INFO - PID 16955 | 14:09:53 INFO - PID 16955 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.00 Median:155.50 stddev:4.47 (2.9%) stddev-sans-first:3.96 14:09:53 INFO - PID 16955 | Values: 162.0 156.0 151.0 153.0 150.0 151.0 163.0 153.0 155.0 156.0 14:09:53 INFO - PID 16955 | 14:09:53 INFO - PID 16955 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.80 Median:61.00 stddev:1.62 (2.7%) stddev-sans-first:1.69 14:09:53 INFO - PID 16955 | Values: 60.0 61.0 61.0 58.0 59.0 63.0 62.0 63.0 61.0 60.0 14:09:53 INFO - PID 16955 | -------- Summary: end -------- 14:09:53 INFO - PID 16955 | 14:09:53 INFO - PID 16955 | 14:09:53 INFO - PID 16955 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 14:09:53 INFO - PID 16955 | 14:09:54 INFO - PID 16955 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 14:09:54 INFO - TEST-INFO | 16955: exit 0 14:09:54 INFO - TEST-OK | kraken | took 59506ms 14:09:54 INFO - SUITE-END | took 1166s 14:09:54 INFO - Completed test suite (00:19:27) 14:09:54 INFO - javascript benchmark 14:09:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9045.430851674117, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3751.5685696144933, 3777.6788972937293, 3798.2213646202513, 3832.8083595820235, 3834.233153369327, 6165.106059621352, 6201.348858369874, 6241.875162496747, 6253.687315634223, 6283.246010478743, 6125.264968203822, 6243.781467648633, 6258.436740693337, 6277.435030847223, 6368.936310636892, 99.6398871077606, 5613.578981576377, 5656.038473459501, 5672.5178359839465, 5716.28546431696, 5604.439556044384, 5609.887802243953, 5647.378788333301, 5703.942960570404, 5704.48659620634, 5607.80372686954, 5639.746211420475, 5702.885942281173, 5707.77168913243, 5721.027425337703, 5625.043742563774, 5633.492985631272, 5651.2935883014625, 5659.037963546207, 5706.600537962344, 5631.267935168443, 5635.633683810539, 5654.9151762723595, 5711.685857277848, 5719.59962802604, 6177.62934223948, 6190.133381326618, 6254.6247225166635, 6354.3963323484195, 6357.49140068798, 6613.140291762088, 6758.324167583251, 6763.492738044666, 6769.52613317068, 6772.255051944282, 6934.167899851999, 6951.0, 6966.268541803089, 6971.477139214579, 6981.616011119387, 6387.1377364055725, 6391.0, 6448.580842245239, 6468.191476065492, 6478.611283323015, 6893.0694356261265, 6949.409300209539, 6997.965010174917, 7085.929140708527, 7099.96450017757, 6672.199336079701, 6745.59526428406, 6750.898736518956, 6769.695363708645, 6786.423154031864, 6787.389134977777, 6810.284920083419, 6822.181338239443, 6883.965580172167, 6912.688928998106, 6697.598144111369, 6709.630970296681, 6719.260881303053, 6730.226024007302, 6744.5616034957575, 6675.46596272297, 6758.493113016543, 6759.493038022168, 6774.051632771416, 6782.898256526156, 4897.902041959141, 4916.5820905222745, 4976.029674213493, 4990.6257030722845, 4999.400071991385, 4424.380586717862, 4483.349914262414, 4486.977565112219, 4549.613282870927, 4613.423322084739, 6219.564630475823, 6259.71831267594, 6261.436470717657, 6270.561060725797, 6272.40412160844, 6775.898361524581, 6786.321367863175, 6798.150231221098, 6873.415759660485, 6873.5875847449315, 6050.42520960508, 6142.508599312045, 6159.476444502267, 6171.9691401543605, 6239.064140378889, 5423.050966080999, 5508.20131080991, 5515.586331025189, 5519.69641669712, 5530.5299049580435, 6887.621180835102, 6897.241303456616, 6898.310168983062, 6985.615791131435, 7007.299270072952, 6713.160854893138, 6746.628935408599, 6817.386435220755, 6876.69054892521, 6889.862202755817, 7000.964995174992, 7065.258147894397, 7088.822779430349, 7093.645317733989, 7117.67970441321, 6722.495812813961, 6735.730570777114, 6812.284710105566, 6820.3861652451515, 6835.316468353125, 6767.627780472121, 6807.795766127024, 6874.931250687429, 6895.310468953065, 6903.413209877016, 6512.05575191604, 6546.672666366568, 6558.967205163944, 6563.671816409256, 6572.80281591553, 6505.544611877123, 6513.576617519846, 6540.967295163684, 6613.173353330833, 6620.668966551557, 6372.490200783834, 6434.40971479455, 6436.195475565554, 6448.387403196689, 6475.0, 6524.641144737085, 6577.736890524517, 6669.199696036507, 6695.363940425652, 6710.530262881552, 6348.682565871595, 6352.9047064295, 6438.3883531064475, 6449.9355006451215, 6468.676566171766], "value": 6159.232493852853, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [938.1087966431887, 969.6218474794829, 993.0466751918159, 1010.5301035018715, 1016.0702956794534, 45172.0, 46013.53986460134, 46014.07971840565, 46260.76869615651, 46275.30587041189, 43891.56108438915, 44253.336199956946, 44299.11401771963, 44327.0, 44351.0, 7509.061367329097, 7588.430867684918, 7588.747856603653, 7602.771916842504, 7638.54168749874, 7463.067116610424, 7532.623368831564, 7548.471606987513, 7555.886661700079, 7579.431542634297, 7512.436567257478, 8104.837903241932, 8314.542700151489, 8322.084570697249, 8343.123971982945, 8221.630026648785, 8248.587570621445, 8269.875951860697, 8285.58572071394, 8288.83422331553, 8028.47814892036, 8126.228008339198, 8208.917910820875, 8212.507249565046, 8229.0, 42926.0, 43339.56660433387, 43407.0, 43451.13097738059, 43586.12827743459, 3716.9814150929074, 3766.736328457009, 3766.9811650941842, 3771.6039815819495, 3780.810959452044, 34308.31383372319, 34341.31317373639, 34469.13827154316, 34473.827630861684, 34496.0, 5520.1443776214755, 5527.309086364205, 5574.0, 5581.246531718207, 5608.298962629671, 214239.0, 216338.0, 218028.0, 219330.0, 234074.8296258525, 55545.72227138838, 55655.165172522444, 55832.16251756227, 55885.720571397695, 56051.15923261154, 58429.70785146047, 58548.41451585515, 58573.0, 58584.70707646434, 58661.70669146627, 17040.57398565046, 17097.658046838995, 17150.656986860195, 17173.828261717223, 17279.74080388795, 14004.579862604138, 14014.789778153336, 14016.719665606835, 14019.579412617637, 14019.789703154462, 15586.298616562282, 15633.3746650135, 15666.0, 15708.764368534481, 15740.527784166494, 6047.909281360783, 6050.939490605126, 6078.179445774764, 6125.356837532084, 6425.1968503937005, 1089.2647462962468, 1093.2238110941162, 1093.9726506837233, 1095.6986828622194, 1102.2945314998408, 25433.491330173292, 25714.228573142835, 25817.48365032689, 25915.22254332373, 25990.35024124412, 1199.7180662544295, 1205.4997176171792, 1207.1248344950016, 1211.3398197982121, 1223.614561413152, 13620.795688064687, 13672.248026358646, 13726.107802992774, 13776.862231377558, 13805.309734513234, 262111.0, 264227.0, 264921.0, 264984.0, 265776.0, 58726.11910821341, 58730.0, 58842.7057864708, 58997.70501147467, 59147.0, 1504.7065822164573, 1521.1101505619115, 1521.764126560385, 1536.185821514599, 1545.7140429020442, 24957.251282461555, 25057.624135637616, 25156.24531264065, 25192.622110668723, 25266.74733252644, 41097.794511027256, 41114.79442602768, 41252.1749565001, 41331.380029300184, 41393.37909931414, 164810.0, 165439.0, 165594.0, 165716.0, 166026.0, 37595.24809503849, 38526.45894164202, 40336.0, 40490.39264411095, 40492.797536012135, 50172.247416289516, 50656.0, 50894.745526272134, 51661.0, 51688.224676630634, 37142.25715485729, 37143.0, 37321.0669733248, 37393.6260637401, 37628.24743505169, 36901.26197476089, 37231.0, 37239.25521489609, 37257.254854903294, 37499.25001500009, 43633.34549981816, 43642.34536481892, 43655.56344436515, 43656.0, 43713.12573748571, 35381.82309088541, 35593.82203089072, 35848.283034338645, 36076.0158191302, 36194.0, 26178.73821261839, 26607.20178394651, 26781.0, 26856.731432685425, 27088.1873543794], "value": 18791.848790083746, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.9153322768201, 594.5006194796371, 596.5496050481886, 603.381533927724, 607.3835057416721, 23181.072757089718, 23818.5236295274, 23860.403489912762, 23921.641175382385, 23947.281581552583, 24438.75561244387, 25724.099656512026, 25782.226533204033, 25853.224403267886, 25856.87071564644, 6613.603183808963, 6765.898511522331, 6781.491388145884, 6786.151731033621, 6789.966050169743, 6496.4802815774865, 6619.271880093186, 6710.42961348286, 6767.69545370457, 6789.3210678931955, 6717.429018533406, 6724.663766811665, 6727.0918426012595, 6727.226368967558, 6727.260001399842, 6279.215098112736, 6533.93466065338, 6562.44219241365, 6701.2963638817955, 6703.865922681543, 6028.457438830526, 6088.878222435526, 6092.847678808021, 6094.177286066369, 6097.0, 30237.244068898235, 30970.690293097006, 30985.69014309873, 30999.38001239985, 31002.0, 2053.876767393961, 2077.37678696392, 2086.0821238654944, 2087.3633541769755, 2090.4982804127053, 20207.494812629655, 21249.893750531148, 21331.253406130865, 21338.35984920455, 21496.140154393805, 2504.361387846106, 2525.873706314677, 2571.614257861317, 2583.547879121165, 2588.3658503666534, 139467.0, 146623.0, 158076.0, 164024.0, 164714.1764291183, 15577.532674019798, 16021.919890400473, 16210.0, 16486.587835303973, 16736.24686889093, 24693.753062469146, 24715.752842471706, 24734.381640458774, 24814.0, 24839.50320993606, 10559.208059395576, 10832.919192923106, 10893.237473376788, 10948.835767463494, 11029.83455248172, 9892.307538472238, 9948.651797187063, 10008.849867251996, 10056.245781566411, 10096.545655445523, 9797.118259356692, 9899.802003960025, 9945.602175912882, 9985.500724963722, 9994.250431217688, 2961.9703802962126, 2963.4665760162948, 2968.39147974669, 2981.120569432023, 3070.988502530846, 1038.7091614347994, 1052.8210204265292, 1056.2922841696081, 1057.8942105789513, 1074.5433190893839, 20505.589888202154, 20661.17355305801, 20820.895895520727, 20875.164993400398, 21347.893260533598, 1111.8499002634703, 1121.254365846719, 1122.0798944865132, 1127.7067962329854, 1127.7969965406141, 11404.657860264206, 11579.421028948518, 11602.94198529002, 11682.182247242781, 11776.234544754563, 611491.0, 626098.0, 627814.0, 644635.0, 647205.0, 122498.0, 125692.0, 127089.0, 127882.16353509223, 128484.35757821338, 1217.3548019549653, 1223.2904915149193, 1245.2466257914014, 1254.2975933477464, 1258.282778816066, 18223.179956901706, 18414.0, 18559.628807424047, 18684.0, 18732.06339682983, 60069.39930600813, 60847.0, 62081.68959155175, 62193.512259509116, 63374.36625633685, 76090.61954690191, 76251.61874190594, 76257.0, 76730.0, 76746.61626691831, 14554.854451455774, 15068.321925513159, 15088.0, 15132.394704211709, 15228.0, 23341.533169336857, 23415.180468683513, 23702.28893133209, 23750.168744093873, 23892.163774267818, 19153.904230478758, 19326.0, 19576.11907464196, 19584.11871465759, 19611.215551377783, 15190.696186076437, 15378.769318460008, 15550.144742039296, 16114.194290285674, 17577.648447031243, 19639.70540441923, 19955.301564445173, 20105.698414524086, 20164.79835201688, 20227.39317820468, 14871.0, 14878.553643390716, 14966.102033878002, 14976.625584360043, 14984.550463486114, 19263.614727705088, 19374.418767437, 19560.902195488932, 19620.117094731057, 19638.705419418435], "value": 12656.58117960166, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1401.3903951780974, 1440.1431148466659, 1452.8038714773509, 1457.7230326238014, 1458.1907041591912, 16513.009219446827, 17143.485695429143, 17156.142192890336, 17168.570785730364, 17172.91413542932, 16528.173591320447, 16528.173591320447, 16567.91716041418, 16627.0, 16720.41478548251, 2606.778423833972, 2728.4679487499943, 2732.508148533263, 2732.8770205340707, 2733.221032005879, 2744.4511097780423, 2755.6830964439046, 2805.3547684032683, 2807.0, 2831.603575499432, 2731.0, 2768.29408500833, 2768.9030883919067, 2769.404578015726, 2770.542860428027, 2708.485387776326, 2747.2719729271657, 2756.104266113511, 2810.7470327670403, 2811.690714021456, 2736.4390299988454, 2762.185155379168, 2763.3644261819695, 2763.7424971637856, 2765.363966287745, 16337.428190013412, 16420.261088251056, 16425.1787410629, 16481.835181648148, 16569.0, 8290.0, 8532.146785321418, 8554.743357699279, 8554.743357699279, 8557.144285571392, 5154.53609175176, 5290.947090529084, 5522.585806064561, 5570.080936645449, 5615.410381909882, 1921.5580416504283, 1937.1670181821812, 1949.9122539485757, 1997.500624843789, 2019.4345583236718, 30538.69461305381, 30762.692373076206, 30834.0, 30867.536986945215, 30879.76480940782, 6958.3041695831025, 7046.1544614645545, 7172.0, 7190.137183538009, 7223.566586004857, 18895.338663146726, 19244.23023079061, 19318.71021934672, 20042.89978550098, 20128.19487220495, 8198.68820988639, 8389.161083891684, 8389.454685445426, 8423.199796019368, 8449.36629752771, 7480.027596412431, 7640.426967977424, 7712.113106992655, 7732.536047837148, 7734.92265077342, 5403.756830942617, 5536.806211782568, 5551.555875529948, 5600.887982240414, 5679.574031947621, 1612.5081850035851, 1613.3465946291772, 1618.1423845361976, 1618.5953511622095, 1621.8540331369998, 968.1770495079268, 971.7279161834698, 973.2262851033446, 996.9003099689972, 1003.3277703938379, 8462.24700639792, 8531.360147988926, 8711.21599056088, 8746.91253087461, 8761.342899282452, 771.7916162636169, 780.1691198873182, 789.3093543149744, 791.386675326615, 795.8527672380628, 5670.432956704297, 5952.49965102597, 6143.32423433422, 6143.32423433422, 6284.748610055638, 24069.51860962806, 24413.755862441147, 24515.509689806106, 25252.0, 25319.0, 24040.639390408807, 24115.276541703424, 24696.876515617307, 24784.752152478606, 25114.748852511606, 12380.257184568954, 12559.686007849878, 12711.237325760483, 12721.109522333349, 12728.363581820871, 8739.21347078766, 8815.338849586435, 8840.381173317806, 8854.557272136497, 8962.372633915824, 20459.488512786706, 20821.167153313698, 21535.676964845854, 21677.132914683236, 21954.560908782056, 21603.675944860526, 21690.2408415711, 21881.343559693236, 22175.889120554293, 22814.885925570266, 11841.46713397882, 11958.701032474257, 12088.093392995384, 12089.0, 12096.395180241128, 15168.620784480476, 15264.923675381551, 15296.617584560476, 15333.233338332815, 15334.693306133591, 12474.06444516683, 12745.17156384832, 12773.23360598367, 12885.806712899126, 12919.806202907152, 12144.817827732768, 12147.514099435924, 12395.380230988594, 12420.875791241971, 12648.747025059263, 10689.51897164645, 10880.564777409132, 10883.564657413615, 10884.836727448936, 10924.126069914546, 7637.809054773675, 7788.532688038736, 7801.1808760079375, 7831.256030677305, 7854.921450785648, 8447.45091569046, 8459.788505287172, 8467.49195048299, 8472.279856212292, 8540.957295213733], "value": 7171.445068782621, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.6610701365153, 546.8004178474857, 562.1904457581082, 580.5529742098587, 583.361219464686, 6320.115183874262, 6353.459955903753, 6366.172397588312, 6377.585456945301, 6391.808245752623, 6243.158268310848, 6273.2472103347545, 6285.811425657238, 6301.384925256025, 6309.1482649842255, 5143.948560514403, 5167.199084141964, 5212.5665442003565, 5215.4523775003645, 5216.24364467153, 4903.436104847952, 5148.407933087687, 5187.974060129694, 5189.636725429222, 5195.142801437777, 4969.577585905203, 5008.6744361616375, 5009.499050094998, 5024.547790698836, 5024.6536745714875, 4985.277134815467, 4995.775190116454, 4998.6750861193905, 5008.248762685626, 5036.471170527078, 4523.457185137771, 4525.389072475206, 4537.523560026183, 4538.205813982539, 4550.453945526558, 6134.77304539094, 6240.875182496325, 6244.875102497925, 6249.125122482856, 6262.906056409158, 5878.382769809151, 5899.203607512974, 5903.763849446017, 5912.758320752647, 5927.614705044201, 6578.76974305897, 6581.769638062645, 6610.305917878602, 6618.536702430832, 6622.1722284714415, 5015.874603134915, 5030.8239211627415, 5035.8489245322335, 5042.974785126087, 5055.873603159914, 6630.436412904909, 6738.326167383271, 6860.725570977155, 6937.791866244021, 6948.409385202213, 5128.0, 5164.948350516522, 5166.509181627739, 5185.148168507306, 5204.7918083277, 5213.6350455467755, 5216.295800067019, 5218.191180367049, 5236.476352364809, 5240.161574148118, 5799.3040835100055, 5835.0, 5840.620359676607, 5850.098717916694, 5858.94141058584, 6676.696539693798, 6687.598744075273, 6707.765228216989, 6719.260881303053, 6719.294474080151, 1779.128227168678, 1795.2370242646823, 1801.7477553142571, 1816.4096668582763, 1820.7906090799463, 1235.9073069519823, 1254.5483625894672, 1304.3673818198167, 1305.5887395470586, 1308.5943357559188, 6117.571769976059, 6130.570860039844, 6132.816015519542, 6134.8159555213415, 6174.691265436711, 6587.122670039112, 6613.636250006296, 6690.765823196165, 6700.899486507707, 6709.664516774142, 6048.123022161762, 6111.882939700785, 6120.969395153084, 6130.0, 6149.2313460817395, 3531.258435728526, 3544.255706301654, 3544.379733546619, 3554.3779838528153, 3565.5721313442036, 6867.381935625817, 6885.555627752176, 6921.2696825793555, 6922.2731613180895, 6944.51388402807, 6927.653617319113, 6932.618705971119, 6954.374106330353, 6971.442284617218, 6981.441484681213, 6901.965490172617, 6943.479239057192, 6950.0964874567, 6967.82580435483, 7006.4394848412, 6729.73081076771, 6738.056672066013, 6776.424003959719, 6779.694913728796, 6786.185657721105, 6729.2934241903895, 6732.158480189976, 6741.258461569321, 6751.358620931003, 6757.0944493866145, 6942.791716248521, 6950.652467376712, 6950.860982780215, 6976.930230697831, 6989.301069893173, 5181.0, 5181.92227116586, 5190.6107041971245, 5193.974030129825, 5199.818006369759, 6629.403353698191, 6773.966130169318, 6794.0, 6815.522913396015, 6832.462695893384, 6454.548181627241, 6545.803625891041, 6556.0, 6567.605943643397, 6577.243616983917, 6520.510961677988, 6523.53220525378, 6552.57408268461, 6562.80311590653, 6610.206775187008, 6446.806595802133, 6478.902816457663, 6490.675466226576, 6524.739010439529, 6539.70571324282, 6459.257185423737, 6643.734250630114, 6649.933500664932, 6651.43462805667, 6678.929531845143, 6423.582467139621, 6439.3238709934785, 6456.612603243821, 6465.482761379172, 6487.772927947499], "value": 5187.0532182383895, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [969.2730452160874, 986.5954958467029, 989.787195752913, 1005.2360206243255, 1009.1976878381686, 19865.602687946233, 20257.0, 20403.183872645077, 20460.69308960367, 20518.589628207428, 18808.529786755338, 18810.905945470287, 18844.246230150777, 18893.905530472362, 19062.809371906278, 1065.0308219520239, 1078.5092782783815, 1082.3938594387168, 1084.4306738962048, 1084.7559299157706, 1072.0565902006224, 1074.570171931226, 1074.8011617850684, 1076.0745758647597, 1077.1113831089344, 1008.878934527854, 1010.8173437078599, 1087.8422628718831, 1091.737982884106, 1125.1280257800188, 1085.90769784568, 1086.6739978006606, 1093.2511229807528, 1096.030013438109, 1096.7916095941746, 819.1644522586928, 819.332244220958, 819.3486178488116, 819.5246756880995, 819.5656302159865, 20884.269050583156, 21110.155593776384, 21131.154753809828, 21165.047572859257, 21170.470738231514, 22053.669194962087, 22537.323880283617, 22544.210952616744, 22548.210812621644, 22548.887255563783, 18269.177886994985, 18500.444986650422, 18502.259909603734, 18515.81484185168, 18523.44429667112, 3876.7673939563433, 3956.3867600521967, 3959.5248570171766, 3973.9602603974167, 3982.2234664240486, 122618.38690806578, 133726.0, 154049.22975385052, 156708.21645891812, 157641.2117939403, 17425.65148697019, 18088.819111808978, 18089.0, 18108.094595270184, 18135.55678858662, 34367.828160859535, 34816.30367392689, 34900.0, 35004.12489687778, 35013.29973400518, 9504.95247523758, 9768.658096966572, 9842.65550705722, 9844.212463002943, 9857.753556161153, 4495.348174514677, 4542.636589072867, 4557.977210113928, 4559.794809233593, 4574.6340292776495, 6136.846578835475, 6228.723111762078, 6245.281792593819, 6248.4688801452385, 6268.811935641938, 1165.7551914097965, 1175.3183153770792, 1180.9527618895147, 1194.486370860521, 1199.6041306368877, 719.9604021778748, 721.974730884427, 723.7322190789441, 741.8145463634091, 758.962051897403, 12151.027917766558, 12544.996400287955, 12861.485540578458, 12875.0, 13223.537176198786, 717.2074857282731, 725.5066554742825, 727.1092911183863, 727.8471520980653, 745.7129005332986, 5858.648481091148, 5948.553858460633, 5950.285965684059, 5981.132735753292, 6059.333473317932, 142618.0, 144951.27524362522, 146272.0, 147775.0, 153094.0, 101208.0, 101650.49174754079, 123058.0, 130547.0, 135432.0, 108047.45976270226, 111198.44400778106, 111657.0, 112343.0, 113902.0, 12757.681057973625, 12905.612831615066, 12988.675283117998, 13003.414846331749, 13273.800892986807, 52425.7378713104, 54886.72556637191, 55015.724921375135, 55665.0, 55798.0, 70330.0, 70704.64647676729, 71196.0, 71225.64387178031, 72311.0, 18605.441836744918, 19329.0, 19359.90320048447, 19370.0, 19488.707669385254, 22840.65739013883, 22860.88569557208, 23102.537949241258, 23164.420889477897, 23202.0, 20112.899435502728, 20243.493912652302, 20330.695039574715, 20517.0, 20538.691919621517, 19851.503712407306, 20004.099815508627, 20018.69971950393, 20076.0, 20227.696584551537, 18598.44204673862, 18851.340203092826, 18931.90534047321, 19012.524686882938, 19027.904860476163, 14568.271586420424, 14613.196274204596, 14642.707145857235, 14662.34019469105, 14682.339294731977, 13866.098703584235, 13920.164790112625, 13997.300134993413, 14002.299885005912, 14012.369443374868], "value": 10050.977557544727, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1379.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 105.0, 106.0, 106.0, 107.0, 112.0, 107.0, 107.0, 104.0, 105.0], "value": 106.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 118.0, 111.0, 118.0, 117.0, 114.0, 114.0, 112.0, 112.0, 116.0], "value": 114.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 165.0, 165.0, 165.0, 164.0, 162.0, 169.0, 173.0, 172.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 73.0, 73.0, 73.0, 73.0, 75.0, 73.0, 72.0], "value": 73.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 78.0, 77.0, 77.0, 78.0, 77.0, 79.0, 80.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 115.0, 114.0, 113.0, 111.0, 114.0, 117.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 148.0, 148.0, 149.0, 148.0, 148.0, 149.0, 150.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 99.0, 98.0, 98.0, 98.0, 98.0, 99.0, 93.0, 95.0, 94.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 45.0, 45.0, 45.0, 48.0, 45.0, 45.0, 44.0, 46.0, 52.0], "value": 46.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 41.0, 39.0, 37.0, 38.0, 38.0, 38.0, 38.0, 38.0, 40.0], "value": 38.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 76.0, 71.0, 72.0, 76.0, 72.0, 73.0, 76.0, 72.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 104.0, 107.0, 102.0, 110.0, 109.0, 112.0, 112.0, 106.0, 111.0], "value": 108.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 156.0, 151.0, 153.0, 150.0, 151.0, 163.0, 153.0, 155.0, 156.0], "value": 155.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 58.0, 59.0, 63.0, 62.0, 63.0, 61.0, 60.0], "value": 60.8, "unit": "score"}]}]} 14:09:54 INFO - Return code: 0 14:09:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:09:55 INFO - # TBPL SUCCESS # 14:09:55 INFO - Running post-action listener: _package_coverage_data 14:09:55 INFO - Running post-action listener: _resource_record_post_action 14:09:55 INFO - [mozharness: 2017-09-13 21:09:55.045739Z] Finished run-tests step (success) 14:09:55 INFO - Running post-run listener: _resource_record_post_run 14:09:55 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 335060992; Read time: 8; Write time: 160192 14:09:55 INFO - TinderboxPrint: CPU usage
13.1% 14:09:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 14:09:55 INFO - TinderboxPrint: I/O write bytes / time
335,060,992 / 160,192 14:09:55 INFO - TinderboxPrint: CPU idle
8,214.0 (86.9%) 14:09:55 INFO - TinderboxPrint: CPU user
1,185.6 (12.5%) 14:09:55 INFO - TinderboxPrint: Swap in / out
0 / 0 14:09:55 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10010624; Read time: 0; Write time: 720 14:09:55 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:09:55 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 0; Write bytes: 325050368; Read time: 0; Write time: 159472 14:09:55 INFO - Running post-run listener: _upload_blobber_files 14:09:55 INFO - Blob upload gear active. 14:09:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:09:55 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 14:09:55 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'] 14:09:55 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 14:09:56 INFO - (blobuploader) - INFO - Open directory for files ... 14:09:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 14:09:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:09:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 14:09:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:09:56 INFO - (blobuploader) - INFO - Done attempting. 14:09:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:09:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:09:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:09:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:09:58 INFO - (blobuploader) - INFO - Done attempting. 14:09:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:09:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:10:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:10:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:10:04 INFO - (blobuploader) - INFO - Done attempting. 14:10:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 14:10:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:10:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:10:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 14:10:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:10:05 INFO - (blobuploader) - INFO - Done attempting. 14:10:05 INFO - (blobuploader) - INFO - Iteration through files over. 14:10:05 INFO - Return code: 0 14:10:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:10:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:10:05 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d818ec2ccec84fdd69c70b358a7eed0f5260ad61eca7f81b4a01e779c144fe3fed88f574e0c8a67be00435fc0a2437732ffa944f95ad8b155cc861f943e5337", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd818b0c2b5640747d2c3882da0eec45e5c02f1184ac1836892868f09311f8dffef230ff366426f484b0afad2c0a1a1047bcbb91b1d44c4edd0d89a79852dbd5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c6c98f18f378cd2c7fa687195dba952aa46da66cd8e444b8566bf2632f1d0c7e5e76e1a79e1efc6804e7cf059a4822621a45ac8bbac29b3ac587473f7652c9c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/506830afc7a903a907701a96a61a5c733d448c787b84a97903e8456288e1cbad71e9032bf9a61a7e8f51f2eab8519620794494954d689fb22b84d946dfa03f7d"} 14:10:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:10:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:10:05 INFO - Contents: 14:10:05 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d818ec2ccec84fdd69c70b358a7eed0f5260ad61eca7f81b4a01e779c144fe3fed88f574e0c8a67be00435fc0a2437732ffa944f95ad8b155cc861f943e5337", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd818b0c2b5640747d2c3882da0eec45e5c02f1184ac1836892868f09311f8dffef230ff366426f484b0afad2c0a1a1047bcbb91b1d44c4edd0d89a79852dbd5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c6c98f18f378cd2c7fa687195dba952aa46da66cd8e444b8566bf2632f1d0c7e5e76e1a79e1efc6804e7cf059a4822621a45ac8bbac29b3ac587473f7652c9c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/506830afc7a903a907701a96a61a5c733d448c787b84a97903e8456288e1cbad71e9032bf9a61a7e8f51f2eab8519620794494954d689fb22b84d946dfa03f7d"} 14:10:05 INFO - Running post-run listener: copy_logs_to_upload_dir 14:10:05 INFO - Copying logs to upload dir... 14:10:05 INFO - mkdir: /builds/slave/test/build/upload/logs 14:10:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.966022 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-09-13 14:10:05.800669) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 14:10:05.804816) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081 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/6d818ec2ccec84fdd69c70b358a7eed0f5260ad61eca7f81b4a01e779c144fe3fed88f574e0c8a67be00435fc0a2437732ffa944f95ad8b155cc861f943e5337", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd818b0c2b5640747d2c3882da0eec45e5c02f1184ac1836892868f09311f8dffef230ff366426f484b0afad2c0a1a1047bcbb91b1d44c4edd0d89a79852dbd5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c6c98f18f378cd2c7fa687195dba952aa46da66cd8e444b8566bf2632f1d0c7e5e76e1a79e1efc6804e7cf059a4822621a45ac8bbac29b3ac587473f7652c9c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/506830afc7a903a907701a96a61a5c733d448c787b84a97903e8456288e1cbad71e9032bf9a61a7e8f51f2eab8519620794494954d689fb22b84d946dfa03f7d"} build_url:https://queue.taskcluster.net/v1/task/TlUtrqtwTDi4uaR6ssJI8w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011399 build_url: 'https://queue.taskcluster.net/v1/task/TlUtrqtwTDi4uaR6ssJI8w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d818ec2ccec84fdd69c70b358a7eed0f5260ad61eca7f81b4a01e779c144fe3fed88f574e0c8a67be00435fc0a2437732ffa944f95ad8b155cc861f943e5337", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd818b0c2b5640747d2c3882da0eec45e5c02f1184ac1836892868f09311f8dffef230ff366426f484b0afad2c0a1a1047bcbb91b1d44c4edd0d89a79852dbd5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c6c98f18f378cd2c7fa687195dba952aa46da66cd8e444b8566bf2632f1d0c7e5e76e1a79e1efc6804e7cf059a4822621a45ac8bbac29b3ac587473f7652c9c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/506830afc7a903a907701a96a61a5c733d448c787b84a97903e8456288e1cbad71e9032bf9a61a7e8f51f2eab8519620794494954d689fb22b84d946dfa03f7d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 14:10:05.838011) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 14:10:05.838348) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dbb0bb31bf4a4c7db9ba1648000001b6-1505335768.940239-707170081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 14:10:05.922465) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 14:10:05.922821) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 14:10:05.923227) ========= ========= Total master_lag: 0.20 =========