builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-046 starttime: 1496419549.28 results: success (0) revision: 87c745019518b1d6cd782534f2553721e5735657 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-02 09:05:49.277091) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-02 09:05:49.277873) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-02 09:05:49.278166) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-02 09:05:49.437030) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 09:05:49.437318) ========= 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=652eb03db935cfc1c15ebda0000001ad-1496414264.41676-2066923055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-02 09:05:50-- 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% 69.2M=0s 2017-06-02 09:05:50 (69.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.100521 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 09:05:49.556735) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 09:05:49.560106) ========= 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=652eb03db935cfc1c15ebda0000001ad-1496414264.41676-2066923055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020426 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 09:05:49.629575) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-02 09:05:49.632967) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 87c745019518b1d6cd782534f2553721e5735657 --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 87c745019518b1d6cd782534f2553721e5735657 --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=652eb03db935cfc1c15ebda0000001ad-1496414264.41676-2066923055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-02 09:05:50,557 truncating revision to first 12 chars 2017-06-02 09:05:50,558 Setting DEBUG logging. 2017-06-02 09:05:50,558 attempt 1/10 2017-06-02 09:05:50,558 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/87c745019518?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-02 09:05:51,663 unpacking tar archive at: mozilla-central-87c745019518/testing/mozharness/ program finished with exit code 0 elapsedTime=1.446232 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-02 09:05:51.103714) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-02 09:05:51.107119) ========= script_repo_revision: 87c745019518b1d6cd782534f2553721e5735657 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-02 09:05:51.107574) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-02 09:05:51.107855) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-02 09:05:51.116605) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 1 secs) (at 2017-06-02 09:05:51.116982) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1496414264.41676-2066923055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:05:52 INFO - MultiFileLogger online at 20170602 09:05:52 in /builds/slave/test 09:05:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:05:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:05:52 INFO - {'append_to_log': False, 09:05:52 INFO - 'base_work_dir': '/builds/slave/test', 09:05:52 INFO - 'blob_upload_branch': 'Firefox', 09:05:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:05:52 INFO - 'branch': 'Firefox', 09:05:52 INFO - 'buildbot_json_path': 'buildprops.json', 09:05:52 INFO - 'config_files': ('talos/linux_config.py',), 09:05:52 INFO - 'default_actions': ('clobber', 09:05:52 INFO - 'read-buildbot-config', 09:05:52 INFO - 'download-and-extract', 09:05:52 INFO - 'populate-webroot', 09:05:52 INFO - 'create-virtualenv', 09:05:52 INFO - 'install', 09:05:52 INFO - 'setup-mitmproxy', 09:05:52 INFO - 'run-tests'), 09:05:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:05:52 INFO - 'download_minidump_stackwalk': True, 09:05:52 INFO - 'download_symbols': 'ondemand', 09:05:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:05:52 INFO - 'tooltool.py': '/tools/tooltool.py', 09:05:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:05:52 INFO - '/tools/misc-python/virtualenv.py')}, 09:05:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:05:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:05:52 INFO - 'gecko_profile': False, 09:05:52 INFO - 'gecko_profile_interval': 0, 09:05:52 INFO - 'installer_path': 'installer.exe', 09:05:52 INFO - 'log_level': 'info', 09:05:52 INFO - 'log_name': 'talos', 09:05:52 INFO - 'log_to_console': True, 09:05:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:05:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:05:52 INFO - 'opt_config_files': (), 09:05:52 INFO - 'pip_index': False, 09:05:52 INFO - 'suite': 'dromaeojs-e10s', 09:05:52 INFO - 'system_bits': '32', 09:05:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:05:52 INFO - 'title': 'talos-linux64-ix-046', 09:05:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:05:52 INFO - 'use_talos_json': True, 09:05:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:05:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:05:52 INFO - 'work_dir': 'build'} 09:05:52 INFO - [mozharness: 2017-06-02 16:05:52.131405Z] Running clobber step. 09:05:52 INFO - Running pre-action listener: _resource_record_pre_action 09:05:52 INFO - Running main action method: clobber 09:05:52 INFO - rmtree: /builds/slave/test/build 09:05:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:05:53 INFO - Running post-action listener: _resource_record_post_action 09:05:53 INFO - [mozharness: 2017-06-02 16:05:53.050668Z] Finished clobber step (success) 09:05:53 INFO - [mozharness: 2017-06-02 16:05:53.050769Z] Running read-buildbot-config step. 09:05:53 INFO - Running pre-action listener: _resource_record_pre_action 09:05:53 INFO - Running main action method: read_buildbot_config 09:05:53 INFO - Using buildbot properties: 09:05:53 INFO - { 09:05:53 INFO - "project": "", 09:05:53 INFO - "product": "firefox", 09:05:53 INFO - "who": "ffxbld@noreply.mozilla.org", 09:05:53 INFO - "installer_path": "public/build/target.tar.bz2", 09:05:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 09:05:53 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:05:53 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 09:05:53 INFO - "stage_platform": "linux64-stylo", 09:05:53 INFO - "basedir": "/builds/slave/test", 09:05:53 INFO - "buildnumber": 135, 09:05:53 INFO - "platform": "ubuntu64_hw_stylo", 09:05:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:05:53 INFO - "slavebuilddir": "test", 09:05:53 INFO - "taskId": "L2MRZ3HeSzuSCmIAIE3f5w", 09:05:53 INFO - "branch": "mozilla-central", 09:05:53 INFO - "script_repo_revision": "production", 09:05:53 INFO - "revision": "87c745019518b1d6cd782534f2553721e5735657", 09:05:53 INFO - "slavename": "talos-linux64-ix-046", 09:05:53 INFO - "repo_path": "mozilla-central" 09:05:53 INFO - } 09:05:53 INFO - Finding installer, test and symbols from parent task. 09:05:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L2MRZ3HeSzuSCmIAIE3f5w'}, attempt #1 09:05:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L2MRZ3HeSzuSCmIAIE3f5w'}, attempt #1 09:05:53 INFO - Task dependencies: Rr3ks4M4TnOJbo_UN4UqNg 09:05:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rr3ks4M4TnOJbo_UN4UqNg'}, attempt #1 09:05:54 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Rr3ks4M4TnOJbo_UN4UqNg/artifacts/public/build/target.tar.bz2 09:05:54 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Rr3ks4M4TnOJbo_UN4UqNg/artifacts/public/build/test_packages.json 09:05:54 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Rr3ks4M4TnOJbo_UN4UqNg/artifacts/public/build/target.crashreporter-symbols.zip 09:05:54 INFO - Running post-action listener: _resource_record_post_action 09:05:54 INFO - [mozharness: 2017-06-02 16:05:54.408874Z] Finished read-buildbot-config step (success) 09:05:54 INFO - [mozharness: 2017-06-02 16:05:54.409094Z] Running download-and-extract step. 09:05:54 INFO - Running pre-action listener: _resource_record_pre_action 09:05:54 INFO - Running main action method: download_and_extract 09:05:54 INFO - mkdir: /builds/slave/test/build/tests 09:05: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')]} 09:05:54 INFO - trying https://queue.taskcluster.net/v1/task/Rr3ks4M4TnOJbo_UN4UqNg/artifacts/public/build/target.test_packages.json 09:05:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Rr3ks4M4TnOJbo_UN4UqNg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:05:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rr3ks4M4TnOJbo_UN4UqNg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:05:55 INFO - Downloaded 989 bytes. 09:05:55 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:05:55 INFO - Using the following test package requirements: 09:05:55 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:05:55 INFO - u'common': [u'target.common.tests.zip'], 09:05:55 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:05:55 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:05:55 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:05:55 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:05:55 INFO - u'mozbase': [u'target.common.tests.zip'], 09:05:55 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:05:55 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:05:55 INFO - u'web-platform': [u'target.common.tests.zip', 09:05:55 INFO - u'target.web-platform.tests.tar.gz'], 09:05:55 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:05:55 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:05:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rr3ks4M4TnOJbo_UN4UqNg/artifacts/public/build/target.common.tests.zip 09:05:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rr3ks4M4TnOJbo_UN4UqNg/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:05:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Rr3ks4M4TnOJbo_UN4UqNg/artifacts/public/build/target.common.tests.zip into memory 09:05:58 INFO - Content-Length response header: 65102508 09:05:58 INFO - Bytes received: 65102508 09:06:09 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:06:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rr3ks4M4TnOJbo_UN4UqNg/artifacts/public/build/target.common.tests.zip 09:06:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rr3ks4M4TnOJbo_UN4UqNg/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:06:09 INFO - Fetch https://queue.taskcluster.net/v1/task/Rr3ks4M4TnOJbo_UN4UqNg/artifacts/public/build/target.common.tests.zip into memory 09:06:12 INFO - Content-Length response header: 65102508 09:06:12 INFO - Bytes received: 65102508 09:06:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rr3ks4M4TnOJbo_UN4UqNg/artifacts/public/build/target.talos.tests.zip 09:06:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rr3ks4M4TnOJbo_UN4UqNg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:06:24 INFO - Fetch https://queue.taskcluster.net/v1/task/Rr3ks4M4TnOJbo_UN4UqNg/artifacts/public/build/target.talos.tests.zip into memory 09:06:26 INFO - Content-Length response header: 14447425 09:06:26 INFO - Bytes received: 14447425 09:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:26 INFO - trying https://queue.taskcluster.net/v1/task/Rr3ks4M4TnOJbo_UN4UqNg/artifacts/public/build/target.tar.bz2 09:06:26 INFO - Downloading https://queue.taskcluster.net/v1/task/Rr3ks4M4TnOJbo_UN4UqNg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:06:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rr3ks4M4TnOJbo_UN4UqNg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:06:31 INFO - Downloaded 60441198 bytes. 09:06:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Rr3ks4M4TnOJbo_UN4UqNg/artifacts/public/build/target.tar.bz2 09:06:31 INFO - mkdir: /builds/slave/test/properties 09:06:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:06:31 INFO - Writing to file /builds/slave/test/properties/build_url 09:06:31 INFO - Contents: 09:06:31 INFO - build_url:https://queue.taskcluster.net/v1/task/Rr3ks4M4TnOJbo_UN4UqNg/artifacts/public/build/target.tar.bz2 09:06:31 INFO - Running post-action listener: _resource_record_post_action 09:06:31 INFO - Running post-action listener: set_extra_try_arguments 09:06:31 INFO - [mozharness: 2017-06-02 16:06:31.597877Z] Finished download-and-extract step (success) 09:06:31 INFO - [mozharness: 2017-06-02 16:06:31.598105Z] Running populate-webroot step. 09:06:31 INFO - Running pre-action listener: _resource_record_pre_action 09:06:31 INFO - Running main action method: populate_webroot 09:06:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:06:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:06:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:06:31 INFO - '--tppagecycles', 09:06:31 INFO - '7'], 09:06:31 INFO - 'tests': ['tsvgm']}}, 09:06:31 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:06:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:06:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:06:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:06:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:06:31 INFO - 'talos_options': ['--disable-e10s'], 09:06:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:06:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:06:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:06:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:06:31 INFO - 'talos_options': ['--disable-e10s'], 09:06:31 INFO - 'tests': ['damp', 'tps']}, 09:06:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:06:31 INFO - 'tests': ['damp', 'tps']}, 09:06:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:06:31 INFO - 'tests': ['dromaeo_dom']}, 09:06:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:06:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:06:31 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:06:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:06:31 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:06:31 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:06:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:06:31 INFO - 'tests': ['a11yr', 09:06:31 INFO - 'ts_paint', 09:06:31 INFO - 'tpaint', 09:06:31 INFO - 'sessionrestore', 09:06:31 INFO - 'sessionrestore_no_auto_restore', 09:06:31 INFO - 'tabpaint']}, 09:06:31 INFO - 'other-e10s': {'tests': ['a11yr', 09:06:31 INFO - 'ts_paint', 09:06:31 INFO - 'tpaint', 09:06:31 INFO - 'sessionrestore', 09:06:31 INFO - 'sessionrestore_no_auto_restore', 09:06:31 INFO - 'tabpaint']}, 09:06:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:06:31 INFO - 'ts_paint', 09:06:31 INFO - 'tpaint', 09:06:31 INFO - 'sessionrestore', 09:06:31 INFO - 'sessionrestore_no_auto_restore', 09:06:31 INFO - 'tabpaint']}, 09:06:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:06:31 INFO - 'ts_paint', 09:06:31 INFO - 'tpaint', 09:06:31 INFO - 'sessionrestore', 09:06:31 INFO - 'sessionrestore_no_auto_restore', 09:06:31 INFO - 'tabpaint']}, 09:06:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:06:31 INFO - 'tests': ['a11yr', 09:06:31 INFO - 'ts_paint', 09:06:31 INFO - 'tpaint', 09:06:31 INFO - 'sessionrestore', 09:06:31 INFO - 'sessionrestore_no_auto_restore', 09:06:31 INFO - 'tabpaint']}, 09:06:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:06:31 INFO - 'tests': ['a11yr', 09:06:31 INFO - 'ts_paint', 09:06:31 INFO - 'tpaint', 09:06:31 INFO - 'sessionrestore', 09:06:31 INFO - 'sessionrestore_no_auto_restore', 09:06:31 INFO - 'tabpaint']}, 09:06:31 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:06:31 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:06:31 INFO - 'bloom_basic_ref']}, 09:06:31 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 09:06:31 INFO - 'talos_options': ['--mitmproxy', 09:06:31 INFO - 'mitmproxy-recording-1.mp', 09:06:31 INFO - '--firstNonBlankPaint'], 09:06:31 INFO - 'tests': ['Quantum_1']}, 09:06:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:06:31 INFO - 'tests': ['tsvgx', 09:06:31 INFO - 'tsvgr_opacity', 09:06:31 INFO - 'tart', 09:06:31 INFO - 'tscrollx', 09:06:31 INFO - 'cart', 09:06:31 INFO - 'tsvg_static']}, 09:06:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:06:31 INFO - 'tsvgr_opacity', 09:06:31 INFO - 'tart', 09:06:31 INFO - 'tscrollx', 09:06:31 INFO - 'cart', 09:06:31 INFO - 'tsvg_static']}, 09:06:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:06:31 INFO - 'talos_options': ['--disable-e10s'], 09:06:31 INFO - 'tests': ['tp5o']}, 09:06:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:06:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:06:31 INFO - 'talos_options': ['--disable-e10s', 09:06:31 INFO - '--xperf_path', 09:06:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:06:31 INFO - 'tests': ['tp5n']}, 09:06:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:06:31 INFO - 'talos_options': ['--xperf_path', 09:06:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:06:31 INFO - 'tests': ['tp5n']}}, 09:06:31 INFO - 'talos.zip': {'path': '', 09:06:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:06:31 INFO - Running post-action listener: _resource_record_post_action 09:06:31 INFO - [mozharness: 2017-06-02 16:06:31.619369Z] Finished populate-webroot step (success) 09:06:31 INFO - [mozharness: 2017-06-02 16:06:31.619464Z] Running create-virtualenv step. 09:06:31 INFO - Running pre-action listener: _resource_record_pre_action 09:06:31 INFO - Running main action method: create_virtualenv 09:06:31 INFO - Creating virtualenv /builds/slave/test/build/venv 09:06:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:06:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:06:31 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:06:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:06:31 INFO - Using real prefix '/usr' 09:06:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:06:32 INFO - Installing distribute.............................................................................................................................................................................................done. 09:06:34 INFO - Installing pip.................done. 09:06:34 INFO - Return code: 0 09:06:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:06:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:06:34 INFO - Reading from file tmpfile_stdout 09:06:34 INFO - Output received: 09:06:34 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:06:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25343b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28af840>, '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 0x28b0740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b0bd0>, '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': '652eb03db935cfc1c15ebda0000001ad-1496414264.41676-2066923055', '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 09:06:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:06:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:06:34 INFO - Using env: {'DISPLAY': ':0', 09:06:34 INFO - 'HOME': '/home/cltbld', 09:06:34 INFO - 'LANG': 'en_US.UTF-8', 09:06:34 INFO - 'LANGUAGE': 'en_US:en', 09:06:34 INFO - 'LOGNAME': 'cltbld', 09:06:34 INFO - 'MAIL': '/var/mail/cltbld', 09:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:34 INFO - 'MOZ_NO_REMOTE': '1', 09:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:34 INFO - 'NO_EM_RESTART': '1', 09:06:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:34 INFO - 'PWD': '/builds/slave/test', 09:06:34 INFO - 'SHELL': '/bin/bash', 09:06:34 INFO - 'SHLVL': '1', 09:06:34 INFO - 'TERM': 'linux', 09:06:34 INFO - 'TMOUT': '86400', 09:06:34 INFO - 'USER': 'cltbld', 09:06:34 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1496414264.41676-2066923055', 09:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:34 INFO - '_': '/tools/buildbot/bin/python'} 09:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:06:34 INFO - Cleaning up... 09:06:34 INFO - Return code: 0 09:06:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25343b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28af840>, '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 0x28b0740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b0bd0>, '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': '652eb03db935cfc1c15ebda0000001ad-1496414264.41676-2066923055', '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 09:06:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:06:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:06:34 INFO - Using env: {'DISPLAY': ':0', 09:06:34 INFO - 'HOME': '/home/cltbld', 09:06:34 INFO - 'LANG': 'en_US.UTF-8', 09:06:34 INFO - 'LANGUAGE': 'en_US:en', 09:06:34 INFO - 'LOGNAME': 'cltbld', 09:06:34 INFO - 'MAIL': '/var/mail/cltbld', 09:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:34 INFO - 'MOZ_NO_REMOTE': '1', 09:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:34 INFO - 'NO_EM_RESTART': '1', 09:06:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:34 INFO - 'PWD': '/builds/slave/test', 09:06:34 INFO - 'SHELL': '/bin/bash', 09:06:34 INFO - 'SHLVL': '1', 09:06:34 INFO - 'TERM': 'linux', 09:06:34 INFO - 'TMOUT': '86400', 09:06:34 INFO - 'USER': 'cltbld', 09:06:34 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1496414264.41676-2066923055', 09:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:34 INFO - '_': '/tools/buildbot/bin/python'} 09:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:34 INFO - Downloading/unpacking psutil>=3.1.1 09:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:06:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:06:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:06:36 INFO - Installing collected packages: psutil 09:06:36 INFO - Running setup.py install for psutil 09:06:36 INFO - building 'psutil._psutil_linux' extension 09:06:36 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 09:06:36 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 09:06:36 INFO - building 'psutil._psutil_posix' extension 09:06:36 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 09:06:36 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 09:06:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:06:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:06:36 INFO - Successfully installed psutil 09:06:36 INFO - Cleaning up... 09:06:36 INFO - Return code: 0 09:06:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:06:36 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')]} 09:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:36 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')]} 09:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:36 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 0x25343b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28af840>, '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 0x28b0740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b0bd0>, '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': '652eb03db935cfc1c15ebda0000001ad-1496414264.41676-2066923055', '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 09:06:36 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 09:06:36 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 09:06:36 INFO - Using env: {'DISPLAY': ':0', 09:06:36 INFO - 'HOME': '/home/cltbld', 09:06:36 INFO - 'LANG': 'en_US.UTF-8', 09:06:36 INFO - 'LANGUAGE': 'en_US:en', 09:06:36 INFO - 'LOGNAME': 'cltbld', 09:06:36 INFO - 'MAIL': '/var/mail/cltbld', 09:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:36 INFO - 'MOZ_NO_REMOTE': '1', 09:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:36 INFO - 'NO_EM_RESTART': '1', 09:06:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:36 INFO - 'PWD': '/builds/slave/test', 09:06:36 INFO - 'SHELL': '/bin/bash', 09:06:36 INFO - 'SHLVL': '1', 09:06:36 INFO - 'TERM': 'linux', 09:06:36 INFO - 'TMOUT': '86400', 09:06:36 INFO - 'USER': 'cltbld', 09:06:36 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1496414264.41676-2066923055', 09:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:36 INFO - '_': '/tools/buildbot/bin/python'} 09:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:06:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:06:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:06:37 INFO - Installing collected packages: mozsystemmonitor 09:06:37 INFO - Running setup.py install for mozsystemmonitor 09:06:38 INFO - Successfully installed mozsystemmonitor 09:06:38 INFO - Cleaning up... 09:06:38 INFO - Return code: 0 09:06:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:06:38 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')]} 09:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:38 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')]} 09:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:38 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 0x25343b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28af840>, '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 0x28b0740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b0bd0>, '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': '652eb03db935cfc1c15ebda0000001ad-1496414264.41676-2066923055', '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 09:06:38 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 09:06:38 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 09:06:38 INFO - Using env: {'DISPLAY': ':0', 09:06:38 INFO - 'HOME': '/home/cltbld', 09:06:38 INFO - 'LANG': 'en_US.UTF-8', 09:06:38 INFO - 'LANGUAGE': 'en_US:en', 09:06:38 INFO - 'LOGNAME': 'cltbld', 09:06:38 INFO - 'MAIL': '/var/mail/cltbld', 09:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:38 INFO - 'MOZ_NO_REMOTE': '1', 09:06:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:38 INFO - 'NO_EM_RESTART': '1', 09:06:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:38 INFO - 'PWD': '/builds/slave/test', 09:06:38 INFO - 'SHELL': '/bin/bash', 09:06:38 INFO - 'SHLVL': '1', 09:06:38 INFO - 'TERM': 'linux', 09:06:38 INFO - 'TMOUT': '86400', 09:06:38 INFO - 'USER': 'cltbld', 09:06:38 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1496414264.41676-2066923055', 09:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:38 INFO - '_': '/tools/buildbot/bin/python'} 09:06:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:38 INFO - Downloading/unpacking jsonschema==2.5.1 09:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:06:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:06:39 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 09:06:39 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 09:06:39 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 09:06:39 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 09:06:39 INFO - Downloading functools32-3.2.3-2.tar.gz 09:06:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:06:39 INFO - warning: no files found matching '*.txt' 09:06:39 INFO - no previously-included directories found matching 'build' 09:06:39 INFO - no previously-included directories found matching 'dist' 09:06:39 INFO - no previously-included directories found matching '.git*' 09:06:39 INFO - Installing collected packages: jsonschema, functools32 09:06:39 INFO - Running setup.py install for functools32 09:06:39 INFO - warning: no files found matching '*.txt' 09:06:39 INFO - no previously-included directories found matching 'build' 09:06:39 INFO - no previously-included directories found matching 'dist' 09:06:39 INFO - no previously-included directories found matching '.git*' 09:06:39 INFO - Successfully installed jsonschema functools32 09:06:39 INFO - Cleaning up... 09:06:39 INFO - Return code: 0 09:06:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:39 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 0x25343b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28af840>, '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 0x28b0740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b0bd0>, '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': '652eb03db935cfc1c15ebda0000001ad-1496414264.41676-2066923055', '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 09:06:39 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 09:06:39 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 09:06:39 INFO - Using env: {'DISPLAY': ':0', 09:06:39 INFO - 'HOME': '/home/cltbld', 09:06:39 INFO - 'LANG': 'en_US.UTF-8', 09:06:39 INFO - 'LANGUAGE': 'en_US:en', 09:06:39 INFO - 'LOGNAME': 'cltbld', 09:06:39 INFO - 'MAIL': '/var/mail/cltbld', 09:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:39 INFO - 'MOZ_NO_REMOTE': '1', 09:06:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:39 INFO - 'NO_EM_RESTART': '1', 09:06:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:39 INFO - 'PWD': '/builds/slave/test', 09:06:39 INFO - 'SHELL': '/bin/bash', 09:06:39 INFO - 'SHLVL': '1', 09:06:39 INFO - 'TERM': 'linux', 09:06:39 INFO - 'TMOUT': '86400', 09:06:39 INFO - 'USER': 'cltbld', 09:06:39 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1496414264.41676-2066923055', 09:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:39 INFO - '_': '/tools/buildbot/bin/python'} 09:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:06:39 INFO - Cleaning up... 09:06:39 INFO - Return code: 0 09:06:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:39 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 0x25343b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28af840>, '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 0x28b0740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b0bd0>, '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': '652eb03db935cfc1c15ebda0000001ad-1496414264.41676-2066923055', '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 09:06:39 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 09:06:39 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 09:06:39 INFO - Using env: {'DISPLAY': ':0', 09:06:39 INFO - 'HOME': '/home/cltbld', 09:06:39 INFO - 'LANG': 'en_US.UTF-8', 09:06:39 INFO - 'LANGUAGE': 'en_US:en', 09:06:39 INFO - 'LOGNAME': 'cltbld', 09:06:39 INFO - 'MAIL': '/var/mail/cltbld', 09:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:39 INFO - 'MOZ_NO_REMOTE': '1', 09:06:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:39 INFO - 'NO_EM_RESTART': '1', 09:06:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:39 INFO - 'PWD': '/builds/slave/test', 09:06:39 INFO - 'SHELL': '/bin/bash', 09:06:39 INFO - 'SHLVL': '1', 09:06:39 INFO - 'TERM': 'linux', 09:06:39 INFO - 'TMOUT': '86400', 09:06:39 INFO - 'USER': 'cltbld', 09:06:39 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1496414264.41676-2066923055', 09:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:39 INFO - '_': '/tools/buildbot/bin/python'} 09:06:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:40 INFO - Downloading/unpacking blobuploader==1.2.4 09:06:40 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 09:06:40 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 09:06:40 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 09:06:40 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 09:06:41 INFO - Downloading blobuploader-1.2.4.tar.gz 09:06:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:06:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:06:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:41 INFO - Downloading docopt-0.6.1.tar.gz 09:06:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:06:41 INFO - Installing collected packages: blobuploader, requests, docopt 09:06:41 INFO - Running setup.py install for blobuploader 09:06:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:06:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:06:41 INFO - Running setup.py install for requests 09:06:42 INFO - Running setup.py install for docopt 09:06:42 INFO - Successfully installed blobuploader requests docopt 09:06:42 INFO - Cleaning up... 09:06:42 INFO - Return code: 0 09:06:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:06:42 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')]} 09:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:42 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')]} 09:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:42 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 0x25343b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28af840>, '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 0x28b0740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b0bd0>, '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': '652eb03db935cfc1c15ebda0000001ad-1496414264.41676-2066923055', '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 09:06:42 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 09:06:42 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 09:06:42 INFO - Using env: {'DISPLAY': ':0', 09:06:42 INFO - 'HOME': '/home/cltbld', 09:06:42 INFO - 'LANG': 'en_US.UTF-8', 09:06:42 INFO - 'LANGUAGE': 'en_US:en', 09:06:42 INFO - 'LOGNAME': 'cltbld', 09:06:42 INFO - 'MAIL': '/var/mail/cltbld', 09:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:42 INFO - 'MOZ_NO_REMOTE': '1', 09:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:42 INFO - 'NO_EM_RESTART': '1', 09:06:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:42 INFO - 'PWD': '/builds/slave/test', 09:06:42 INFO - 'SHELL': '/bin/bash', 09:06:42 INFO - 'SHLVL': '1', 09:06:42 INFO - 'TERM': 'linux', 09:06:42 INFO - 'TMOUT': '86400', 09:06:42 INFO - 'USER': 'cltbld', 09:06:42 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1496414264.41676-2066923055', 09:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:42 INFO - '_': '/tools/buildbot/bin/python'} 09:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:06:42 INFO - Running setup.py (path:/tmp/pip-2z0fn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:06:42 INFO - Running setup.py (path:/tmp/pip-puMET9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:06:42 INFO - Running setup.py (path:/tmp/pip-FX7bwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:06:42 INFO - Running setup.py (path:/tmp/pip-2bjIsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:06:42 INFO - Running setup.py (path:/tmp/pip-WSecsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:06:43 INFO - Running setup.py (path:/tmp/pip-Kfuux8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:06:43 INFO - Running setup.py (path:/tmp/pip-TCwAex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:06:43 INFO - Running setup.py (path:/tmp/pip-XPvW4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:06:43 INFO - Running setup.py (path:/tmp/pip-C6ds4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:06:43 INFO - Running setup.py (path:/tmp/pip-WB3SvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:06:43 INFO - Running setup.py (path:/tmp/pip-bBBAhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:06:43 INFO - Running setup.py (path:/tmp/pip-jIJjfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:06:43 INFO - Running setup.py (path:/tmp/pip-aCJeCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:06:43 INFO - Running setup.py (path:/tmp/pip-n0yrrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:43 INFO - Running setup.py (path:/tmp/pip-JktcGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:06:43 INFO - Running setup.py (path:/tmp/pip-BRj2iI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:06:43 INFO - Running setup.py (path:/tmp/pip-LCr2QN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:06:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:06:43 INFO - Running setup.py install for manifestparser 09:06:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:06:44 INFO - Running setup.py install for mozcrash 09:06:44 INFO - Running setup.py install for mozdebug 09:06:44 INFO - Running setup.py install for mozdevice 09:06:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:06:44 INFO - Running setup.py install for mozfile 09:06:44 INFO - Running setup.py install for mozhttpd 09:06:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:06:44 INFO - Running setup.py install for mozinfo 09:06:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:06:44 INFO - Running setup.py install for mozInstall 09:06:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:06:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:06:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:06:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:06:44 INFO - Running setup.py install for mozleak 09:06:44 INFO - Running setup.py install for mozlog 09:06:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:06:44 INFO - Running setup.py install for moznetwork 09:06:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:06:45 INFO - Running setup.py install for mozprocess 09:06:45 INFO - Running setup.py install for mozprofile 09:06:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:06:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:06:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:06:45 INFO - Running setup.py install for mozrunner 09:06:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:06:45 INFO - Running setup.py install for mozscreenshot 09:06:45 INFO - Running setup.py install for moztest 09:06:45 INFO - Running setup.py install for mozversion 09:06:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:06:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:06:45 INFO - Cleaning up... 09:06:45 INFO - Return code: 0 09:06:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:45 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 0x25343b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28af840>, '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 0x28b0740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b0bd0>, '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': '652eb03db935cfc1c15ebda0000001ad-1496414264.41676-2066923055', '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 09:06:45 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 09:06:45 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 09:06:45 INFO - Using env: {'DISPLAY': ':0', 09:06:45 INFO - 'HOME': '/home/cltbld', 09:06:45 INFO - 'LANG': 'en_US.UTF-8', 09:06:45 INFO - 'LANGUAGE': 'en_US:en', 09:06:45 INFO - 'LOGNAME': 'cltbld', 09:06:45 INFO - 'MAIL': '/var/mail/cltbld', 09:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:45 INFO - 'MOZ_NO_REMOTE': '1', 09:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:45 INFO - 'NO_EM_RESTART': '1', 09:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:45 INFO - 'PWD': '/builds/slave/test', 09:06:45 INFO - 'SHELL': '/bin/bash', 09:06:45 INFO - 'SHLVL': '1', 09:06:45 INFO - 'TERM': 'linux', 09:06:45 INFO - 'TMOUT': '86400', 09:06:45 INFO - 'USER': 'cltbld', 09:06:45 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1496414264.41676-2066923055', 09:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:45 INFO - '_': '/tools/buildbot/bin/python'} 09:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:06:45 INFO - Running setup.py (path:/tmp/pip-X3RZOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:06:46 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)) 09:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:06:46 INFO - Running setup.py (path:/tmp/pip-aAiJ02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:06:46 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)) 09:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:06:46 INFO - Running setup.py (path:/tmp/pip-RtqWsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:06:46 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)) 09:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:06:46 INFO - Running setup.py (path:/tmp/pip-0Ti_Dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:06:46 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)) 09:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:06:46 INFO - Running setup.py (path:/tmp/pip-Fawsof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:06:46 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)) 09:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:06:46 INFO - Running setup.py (path:/tmp/pip-SsCVHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:06:46 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)) 09:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:06:46 INFO - Running setup.py (path:/tmp/pip-1z9Jg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 09:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:06:46 INFO - Running setup.py (path:/tmp/pip-71IY8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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)) 09:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:06:46 INFO - Running setup.py (path:/tmp/pip-a4Aokk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:06:46 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)) 09:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:06:46 INFO - Running setup.py (path:/tmp/pip-MpP7os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 09:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:06:46 INFO - Running setup.py (path:/tmp/pip-eRfQH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:06:46 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)) 09:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:06:46 INFO - Running setup.py (path:/tmp/pip-uU9jwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:06:46 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)) 09:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:06:46 INFO - Running setup.py (path:/tmp/pip-EjQPnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:06:46 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)) 09:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:06:46 INFO - Running setup.py (path:/tmp/pip-_b1cFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:06:46 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)) 09:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:46 INFO - Running setup.py (path:/tmp/pip-CxqRSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:47 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)) 09:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:06:47 INFO - Running setup.py (path:/tmp/pip-9wU4Ib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:06:47 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)) 09:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:06:47 INFO - Running setup.py (path:/tmp/pip-GpNYV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:06:47 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)) 09:06:47 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)) 09:06:47 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)) 09:06:47 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)) 09:06:47 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)) 09:06:47 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)) 09:06:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:06:47 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 09:06:47 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 09:06:47 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 09:06:47 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 09:06:48 INFO - Downloading blessings-1.6.tar.gz 09:06:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:06:48 INFO - Installing collected packages: blessings 09:06:48 INFO - Running setup.py install for blessings 09:06:48 INFO - Successfully installed blessings 09:06:48 INFO - Cleaning up... 09:06:48 INFO - Return code: 0 09:06:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:06:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:06:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:06:48 INFO - Reading from file tmpfile_stdout 09:06:48 INFO - Current package versions: 09:06:48 INFO - argparse == 1.2.1 09:06:48 INFO - blessings == 1.6 09:06:48 INFO - blobuploader == 1.2.4 09:06:48 INFO - docopt == 0.6.1 09:06:48 INFO - functools32 == 3.2.3-2 09:06:48 INFO - jsonschema == 2.5.1 09:06:48 INFO - manifestparser == 1.1 09:06:48 INFO - mozInstall == 1.12 09:06:48 INFO - mozcrash == 1.0 09:06:48 INFO - mozdebug == 0.1 09:06:48 INFO - mozdevice == 0.51 09:06:48 INFO - mozfile == 1.2 09:06:48 INFO - mozhttpd == 0.7 09:06:48 INFO - mozinfo == 0.9 09:06:48 INFO - mozleak == 0.1 09:06:48 INFO - mozlog == 3.4 09:06:48 INFO - moznetwork == 0.27 09:06:48 INFO - mozprocess == 0.25 09:06:48 INFO - mozprofile == 0.28 09:06:48 INFO - mozrunner == 6.13 09:06:48 INFO - mozscreenshot == 0.1 09:06:48 INFO - mozsystemmonitor == 0.3 09:06:48 INFO - moztest == 0.8 09:06:48 INFO - mozversion == 1.4 09:06:48 INFO - psutil == 3.1.1 09:06:48 INFO - requests == 1.2.3 09:06:48 INFO - wsgiref == 0.1.2 09:06:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:48 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 0x25343b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28af840>, '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 0x28b0740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b0bd0>, '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': '652eb03db935cfc1c15ebda0000001ad-1496414264.41676-2066923055', '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 09:06:48 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 09:06:48 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 09:06:48 INFO - Using env: {'DISPLAY': ':0', 09:06:48 INFO - 'HOME': '/home/cltbld', 09:06:48 INFO - 'LANG': 'en_US.UTF-8', 09:06:48 INFO - 'LANGUAGE': 'en_US:en', 09:06:48 INFO - 'LOGNAME': 'cltbld', 09:06:48 INFO - 'MAIL': '/var/mail/cltbld', 09:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:48 INFO - 'MOZ_NO_REMOTE': '1', 09:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:48 INFO - 'NO_EM_RESTART': '1', 09:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:48 INFO - 'PWD': '/builds/slave/test', 09:06:48 INFO - 'SHELL': '/bin/bash', 09:06:48 INFO - 'SHLVL': '1', 09:06:48 INFO - 'TERM': 'linux', 09:06:48 INFO - 'TMOUT': '86400', 09:06:48 INFO - 'USER': 'cltbld', 09:06:48 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1496414264.41676-2066923055', 09:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:48 INFO - '_': '/tools/buildbot/bin/python'} 09:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:48 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)) 09:06:48 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)) 09:06:48 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)) 09:06:48 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)) 09:06:48 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)) 09:06:48 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)) 09:06:48 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)) 09:06:48 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)) 09:06:48 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)) 09:06:48 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:06:48 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 09:06:48 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 09:06:48 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 09:06:48 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 09:06:50 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:06:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:06:50 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)) 09:06:50 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)) 09:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:06:50 INFO - Installing collected packages: marionette-driver 09:06:50 INFO - Running setup.py install for marionette-driver 09:06:50 INFO - Successfully installed marionette-driver 09:06:50 INFO - Cleaning up... 09:06:50 INFO - Return code: 0 09:06:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:06: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')]} 09:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06: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')]} 09:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25343b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28af840>, '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 0x28b0740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b0bd0>, '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': '652eb03db935cfc1c15ebda0000001ad-1496414264.41676-2066923055', '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 09:06:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:06:50 INFO - Using env: {'DISPLAY': ':0', 09:06:50 INFO - 'HOME': '/home/cltbld', 09:06:50 INFO - 'LANG': 'en_US.UTF-8', 09:06:50 INFO - 'LANGUAGE': 'en_US:en', 09:06:50 INFO - 'LOGNAME': 'cltbld', 09:06:50 INFO - 'MAIL': '/var/mail/cltbld', 09:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:50 INFO - 'MOZ_NO_REMOTE': '1', 09:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:50 INFO - 'NO_EM_RESTART': '1', 09:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:50 INFO - 'PWD': '/builds/slave/test', 09:06:50 INFO - 'SHELL': '/bin/bash', 09:06:50 INFO - 'SHLVL': '1', 09:06:50 INFO - 'TERM': 'linux', 09:06:50 INFO - 'TMOUT': '86400', 09:06:50 INFO - 'USER': 'cltbld', 09:06:50 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1496414264.41676-2066923055', 09:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:50 INFO - '_': '/tools/buildbot/bin/python'} 09:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:06:50 INFO - Cleaning up... 09:06:50 INFO - Return code: 0 09:06:50 INFO - Running post-action listener: _resource_record_post_action 09:06:50 INFO - Running post-action listener: _start_resource_monitoring 09:06:50 INFO - Starting resource monitoring. 09:06:50 INFO - [mozharness: 2017-06-02 16:06:50.511000Z] Finished create-virtualenv step (success) 09:06:50 INFO - [mozharness: 2017-06-02 16:06:50.511525Z] Running install step. 09:06:50 INFO - Running pre-action listener: _resource_record_pre_action 09:06:50 INFO - Running main action method: install 09:06:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:06:50 INFO - Reading from file tmpfile_stdout 09:06:50 INFO - Detecting whether we're running mozinstall >=1.0... 09:06:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:06:50 INFO - Reading from file tmpfile_stdout 09:06:50 INFO - Output received: 09:06:50 INFO - Usage: mozinstall [options] installer 09:06:50 INFO - Options: 09:06:50 INFO - -h, --help show this help message and exit 09:06:50 INFO - -d DEST, --destination=DEST 09:06:50 INFO - Directory to install application into. [default: 09:06:50 INFO - "/builds/slave/test"] 09:06:50 INFO - --app=APP Application being installed. [default: firefox] 09:06:50 INFO - mkdir: /builds/slave/test/build/application 09:06:50 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'] 09:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:07:08 INFO - Reading from file tmpfile_stdout 09:07:08 INFO - Output received: 09:07:08 INFO - /builds/slave/test/build/application/firefox/firefox 09:07:08 INFO - Running post-action listener: _resource_record_post_action 09:07:08 INFO - [mozharness: 2017-06-02 16:07:08.238631Z] Finished install step (success) 09:07:08 INFO - [mozharness: 2017-06-02 16:07:08.238906Z] Running setup-mitmproxy step. 09:07:08 INFO - Running pre-action listener: _resource_record_pre_action 09:07:08 INFO - Running main action method: setup_mitmproxy 09:07:08 INFO - Skipping: mitmproxy is not required 09:07:08 INFO - Running post-action listener: _resource_record_post_action 09:07:08 INFO - [mozharness: 2017-06-02 16:07:08.240039Z] Finished setup-mitmproxy step (success) 09:07:08 INFO - [mozharness: 2017-06-02 16:07:08.240258Z] Running run-tests step. 09:07:08 INFO - Running pre-action listener: _resource_record_pre_action 09:07:08 INFO - Running main action method: run_tests 09:07:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:07:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:07:08 INFO - Python 2.7.3 09:07:08 INFO - Return code: 0 09:07:08 INFO - grabbing minidump binary from tooltool 09:07: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')]} 09:07:08 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0x28af840>, '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 0x28b0740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b0bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:07:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 09:07:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:07:08 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 09:07:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:07:08 INFO - Return code: 0 09:07:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:07:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:07:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:07:08 INFO - ENV: RUST_BACKTRACE is now 1 09:07:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:07:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:07:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rr3ks4M4TnOJbo_UN4UqNg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:07:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Rr3ks4M4TnOJbo_UN4UqNg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:07:08 INFO - Using env: {'DISPLAY': ':0', 09:07:08 INFO - 'HOME': '/home/cltbld', 09:07:08 INFO - 'LANG': 'en_US.UTF-8', 09:07:08 INFO - 'LANGUAGE': 'en_US:en', 09:07:08 INFO - 'LOGNAME': 'cltbld', 09:07:08 INFO - 'MAIL': '/var/mail/cltbld', 09:07:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:07:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:07:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:08 INFO - 'MOZ_NO_REMOTE': '1', 09:07:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:07:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:08 INFO - 'NO_EM_RESTART': '1', 09:07:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:08 INFO - 'PWD': '/builds/slave/test', 09:07:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:07:08 INFO - 'RUST_BACKTRACE': '1', 09:07:08 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:07:08 INFO - 'SHELL': '/bin/bash', 09:07:08 INFO - 'SHLVL': '1', 09:07:08 INFO - 'TERM': 'linux', 09:07:08 INFO - 'TMOUT': '86400', 09:07:08 INFO - 'USER': 'cltbld', 09:07:08 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1496414264.41676-2066923055', 09:07:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:08 INFO - '_': '/tools/buildbot/bin/python'} 09:07:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rr3ks4M4TnOJbo_UN4UqNg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:07:08 INFO - mozversion application_buildid: 20170602152329 09:07:08 INFO - mozversion application_changeset: 87c745019518b1d6cd782534f2553721e5735657 09:07:08 INFO - mozversion application_display_name: Nightly 09:07:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:07:08 INFO - mozversion application_name: Firefox 09:07:08 INFO - mozversion application_remotingname: firefox 09:07:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:07:08 INFO - mozversion application_vendor: Mozilla 09:07:08 INFO - mozversion application_version: 55.0a1 09:07:08 INFO - mozversion platform_buildid: 20170602152329 09:07:08 INFO - mozversion platform_changeset: 87c745019518b1d6cd782534f2553721e5735657 09:07:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:07:08 INFO - mozversion platform_version: 55.0a1 09:07:08 INFO - using testdate: 1496419628 09:07:08 INFO - actual date: 1496419628 09:07:08 INFO - starting webserver on 'localhost:59867' 09:07:08 INFO - SUITE-START | Running 2 tests 09:07:08 INFO - TEST-START | dromaeo_css 09:07:08 INFO - operating with platform_type : linux_ 09:07:08 INFO - Initialising browser for dromaeo_css test... 09:07:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59867/getInfo.html -profile /tmp/tmpOoGiaT/profile 09:07:08 INFO - TEST-INFO | started process 12602 (/builds/slave/test/build/application/firefox/firefox http://localhost:59867/getInfo.html) 09:07:43 INFO - TEST-INFO | 12602: killed by SIGTERM 09:07:43 INFO - Browser initialized. 09:07:43 INFO - Running cycle 1/1 for dromaeo_css test... 09:07:43 INFO - TEST-INFO | started process 12833 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOoGiaT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:07:55 INFO - PID 12833 | RSS: Main: 192262144 09:07:55 INFO - PID 12833 | 09:10:56 INFO - PID 12833 | Cycle 1(1): loaded http://localhost:59867/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59867/tests/dromaeo/cssquery-ext.html) 09:10:57 INFO - PID 12833 | RSS: Main: 186466304 09:10:57 INFO - PID 12833 | 09:13:59 INFO - PID 12833 | Cycle 1(1): loaded http://localhost:59867/tests/dromaeo/cssquery-ext.html (next: http://localhost:59867/tests/dromaeo/cssquery-jquery.html) 09:14:00 INFO - PID 12833 | RSS: Main: 193843200 09:14:00 INFO - PID 12833 | 09:17:02 INFO - PID 12833 | Cycle 1(1): loaded http://localhost:59867/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59867/tests/dromaeo/cssquery-mootools.html) 09:17:02 INFO - PID 12833 | RSS: Main: 189247488 09:17:02 INFO - PID 12833 | 09:20:04 INFO - PID 12833 | Cycle 1(1): loaded http://localhost:59867/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59867/tests/dromaeo/cssquery-prototype.html) 09:20:05 INFO - PID 12833 | RSS: Main: 195743744 09:20:05 INFO - PID 12833 | 09:23:07 INFO - PID 12833 | Cycle 1(1): loaded http://localhost:59867/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59867/tests/dromaeo/cssquery-yui.html) 09:23:08 INFO - PID 12833 | RSS: Main: 192864256 09:23:08 INFO - PID 12833 | 09:26:10 INFO - PID 12833 | Cycle 1(1): loaded http://localhost:59867/tests/dromaeo/cssquery-yui.html (next: http://localhost:59867/tests/dromaeo/cssquery-dojo.html) 09:26:10 INFO - PID 12833 | RSS: Main: 191717376 09:26:10 INFO - PID 12833 | 09:26:10 INFO - PID 12833 | __start_tp_report 09:26:10 INFO - PID 12833 | _x_x_mozilla_page_load 09:26:10 INFO - PID 12833 | _x_x_mozilla_page_load_details 09:26:10 INFO - PID 12833 | |i|pagename|runs| 09:26:10 INFO - PID 12833 | |0;dojo.html;3075.7539396848256;3086.197588626957;3101.286704058067;3129.3115514586784;3130.389574033063;5788.82633520994;5795.4784069433745;5835.5915085944;5836.182934389183;5860.23816903803;5841.53267738581;5845.09401042839;5852.268466441695;5853.268341457318;5860.5311575074;5374.677519348832;5392.649477783942;5438.945610543903;5485.61600687952;5499.3675727291275;5309.389420216667;5450.591205659572;5520.530754885839;5533.6403133796375;5552.167174923753;5513.3108361454815;5518.944810551883;5520.089185284423;5588.105903055512;5594.58040646951;5361.919571206435;5373.731313434313;5441.047816632074;5444.373897001856;5457.781688732446;5407.837764867021;5434.266374039494;5447.073997420448;5452.372977107644;5472.699001554913;5808.925348810483;5811.535077193815;5843.065109582489;5865.413458654143;5869.941300586982;6139.584134579375;6219.689015549205;6267.4986001119805;6297.559170858041;6308.495320374359;6335.334789847092;6387.712552935082;6463.6768161591735;6470.352964703492;6480.384363485461;5880.500157486662;5886.20536227608;5900.144479050557;5918.2898052234;5942.940570594325;6309.337519560472;6394.392532709385;6435.678216089177;6490.156279683611;6505.381988711065;6124.319907527392;6160.691965401712;6169.383061693885;6176.135341052256;6176.8764624707255;6118.710550942845;6180.258368995749;6217.253929528486;6220.564560480813;6265.4361107500545;6325.936740632626;6379.74481020754;6380.074889141141;6383.648899310582;6406.8718625627225;6226.221722284715;6307.211598550181;6402.679866006681;6420.935790642034;6426;5170.482951704799;5199.298094757235;5210.739463026834;5218.556422704112;5218.712970786567;4453.287474004143;4466.3523789050405;4471.06107717383;4505.053938672915;4572.977135114304;5413.296271484761;5515.503604675599;5518.641288316247;5523.088690366125;5526.944730552724;6267.2165979252595;6307.463865571386;6357.713902874381;6396.9360306397275;6417.326180751047;5533.889322213533;5534.75093620788;5547.528460080857;5553.305836770403;5578.86052848682;5635;5654.604177707603;5656.943430565641;5659.236003139606;5660.660360378308;6028.577999540078;6068.848278793065;6100.359462256488;6145.156453064153;6156.384361563987;6363.809085727436;6390.041493775971;6403.903941440975;6404.327545607831;6431.260405053292;6118.847028824315;6179.660118693335;6183.3816618337805;6195.287541932736;6211.627302361872;6050.42520960508;6136.815895523141;6141.232345956755;6226.688665566794;6256.155419018374;6311.873762524816;6390.073439351361;6397.904031439439;6402.743890244338;6416.935830641633;6151.753929842756;6157.230346206724;6162.753489860355;6166.260048794174;6193.071039344134;6070.1501789750355;6078.240219972504;6088.330283668704;6105.793350785129;6142.253225532511;6063.514918806573;6110.892920173631;6120.816375508742;6133.6319820810895;6166.2600487939935;6221.354270455456;6289.96855015722;6298.559100862895;6302.180716506825;6306.2747784003595;5871.853203669943;5952.077427998494;5963.493103086286;6078.331383547895;6083.7870674526175 09:26:10 INFO - PID 12833 | |1;ext.html;690.5649440852262;723.2911746488442;755.4938191411753;1130.9660710178698;1147.4778975566119;35397.99117075049;36295;36371.818140909294;36415.81792091043;36421;37522.62477375226;37589.24821503568;37664.623353766525;37979.81010094946;37988.81005594975;7127.216006239335;7275.054242948409;7286.599237041961;7399.778006659809;7402.481826272163;7231.3130252625915;7287.380572651305;7300.853982920365;7321.231270716578;7322.71852425826;7318.1949985501815;7320.267973202664;7327.596982165979;7336.7798966031105;7385.039944807168;7293.416526677853;7294.343509084208;7310.2689731027;7324.853502929912;7330.047093877815;7171.605561694105;7197.820054498627;7231.674574644101;7233.348998590152;7246.855062898765;35311.64688353135;35335.82332088323;35652.64347356519;35672;35689.46465803015;3402.3535528249554;3433.5021421893935;3439.8624055037767;3443.8278086095597;3452.913677158066;27935.30161745952;28007.159785206273;28030.439391212265;28045.298867528272;28072.71927280742;3610.3140403323287;3630.8366123524506;3640.0717816956508;3647.1793846384617;3664.1755604988666;137139;138555.30722346425;154308.22845885812;162772;162905;42148.57851421447;42369.364459533135;42476.15047699029;42505.14989700189;42533;44971.100577988254;44998.77500612541;45050.09899802051;45055.77472112684;45163.77418112889;14472.204028778518;14517.564473065824;14519.491817786327;14534.563963081124;14539.418423263163;11990.580329688419;12070.155089143676;12098.637040888787;12109.091818113677;12109.212901161396;13153.60539183826;13247.933760331136;13340.266285354399;13346.399412026482;13555.186688798703;5620.297462817148;5787.189793428924;5804.245448091806;5879.559033072451;5883.088121341113;962.4417837654283;1000.9599616015423;1003.8393856982848;1014.5593257574262;1026.697124348319;23065.308040758468;23607.40981475477;23710.644340334908;23774.881125594606;23844.7615523846;1093.6937657455926;1099.9450027498754;1105.3478447715725;1117.871444783844;1129.8700649425257;12221.450034748457;12446.564370246997;12584.244945303128;12650.304233267074;12666.80999785004;193744;194326;194403;194773;196234;47376.76311618489;47383;47789.28316075262;47821;47872.760636196595;1388.2295326093913;1426.9571912842632;1446.2624061728595;1453.396840311259;1457.2203870929213;21582.568348633253;21941.122355105617;23141.07435702553;23209.535809284058;23280.6507902385;35003.47494787529;35154;35202.47196292006;35225;35275.64724352724;164009;164310;164484;165635;165923;29490.410191796473;30062.24844378908;30699.2325191872;31304.53043204308;32161.517577235893;38538.421923670605;39511.407328890666;39750;40006.39990400088;40709.79645101756;30241.546376804807;30695.2326191847;31030.379392411574;31209;31278.53082203723;29105.093167701863;29641.110766677033;30029;30096.548551771302;30926.536101958038;33293.50059749057;33913.83043084769;33921.660783392836;33974.3205135891;34034;29346.266343341587;29569.704302956696;29598.260043498223;30051.549226762054;30797.692023079482;23017;23054.538909222058;23639.763602363757;23961.880190599633;24093.187997306268 09:26:10 INFO - PID 12833 | |2;jquery.html;412.82454956643437;416.5272415808057;428.21850123524575;428.94209281746953;433.9435873336466;19495.317663881768;20341.49146271344;20397.694034589495;21519.24682636108;22444.102235910545;23201.3039608812;23808.642870356915;23824.76175238247;23826.5234695306;23847.284581462583;5847.532197424217;5932.406759324054;6001.459868611824;6008.399160083978;6020.608660437079;5960.970195149018;5962.701864906759;6016.187814645033;6031.065184896348;6037.909431358533;5798.782255726282;5848.912266315988;5934.347221805598;5949.167116603679;5967.552433567478;5878.118282257653;5945.88108237835;5951.018082016484;5951.880962380771;5957.314908785458;5345.198220266952;5349.170878513836;5361.169018802053;5363.678179309215;5372.973135134338;25468.745312546824;25714;25732.228033159034;25780.74219257802;25797.871010644827;1787.3922866225546;1847.7136043913215;1862.9161687724086;1862.962740745191;1868.9065546722745;16912.661746764996;17193.82806171935;17229.655406891918;17252.39616613425;17258.827411725848;2207.260567709819;2247.224707475918;2270.829687773407;2272.4773302140434;2279.8290128240446;111971.44014279958;112003;114969.4251528737;118591;118756.40621796923;11504.884951150549;11522.942385288188;11955.88044119565;11970.099734175577;11988.820167697491;16713.164341782864;16796.748048779278;16877.286996860672;16890.915545422195;16911.661766764595;8756.25571826402;8821.735347939572;8926.330525210506;9034.774130646787;9191.264698824212;8280.296174825087;8336.874946875801;8493.830123397498;8524.445911015764;8568;7426.960225568425;7675.577843218565;7683.692652293846;7724.7682569523;7789.454738168387;2105.147415296807;2135.775743546936;2143.699882016519;2149.322963266566;2295.1049090854244;931.990680093204;982.9066238707311;988.6935050134481;989.7674046599044;1000.8148492528906;19230.807691923183;20143.0935607898;20202.595948080954;20206.696899546518;20428.18287268522;1003.3027046202819;1003.7340104872214;1006.6225165562914;1018.7758693087509;1021.9693409197736;10844.457777111113;10987.61543345979;11129.332240065622;11152.163587730953;11170.329780213213;409270;412178;415076;422304;422422;96297.5185124084;97207;97292;97811;98464.50767746115;1025.3027941000043;1098.5770478365887;1158.3050169897995;1179.2983175010854;1194.0089725527791;19650;19682.90158549198;20550.897245513675;20618.07218675133;20994.160233590486;45945.77027114843;46099.3085103717;46445;47154.76422618002;47267.29099063448;57222.713886431964;57540.42459575518;58215.70892145512;58503.4149658498;58622.7068864653;10168.796624067625;10343.586256549654;10354.844677329695;10360.792784144425;10378.117859981685;17222.311107555557;17534.386296479563;17600.119994000506;17608.38370657021;17665.205065772327;14596;14706;14810.333534990736;14815.111093334435;14860.256987150815;12686.555970540987;12833.550825721428;13344.199348039148;13596.86403135956;13810.723785524435;14657.70684586281;14955.775663365275;15133.167675777497;15153.090814551162;15387;10231.795364092528;10319.896801032193;10327.586896524055;10349.793004140025;10356.30736008628;14734.926325368304;14891.255437228312;14907.031042982171;14975.925120374328;15053.397864085751 09:26:10 INFO - PID 12833 | |3;mootools.html;1268.2263819070365;1302.069020650235;1323.4507679313085;1329.6808765896183;1332.3937608388185;10827.729306767325;11056.447177641126;11367.886321136786;11375.374354410504;11431.54273829048;11114.11087113029;11305.434728263595;11340.489677964491;11359.886401135986;11399.772004559904;2293.8279629027807;2353.2704861492994;2355.564220619191;2363.09021026905;2365.06579900939;2268.9092436302526;2303.6544518322216;2315.235972129193;2326.499802542453;2336.6144586143264;2234.430220293823;2257.2325409360815;2269.7389800172946;2272.5114100468395;2277.089164334263;2186.365953873375;2207.1171531387413;2212.4911270407815;2214.3799736073843;2219.922302719397;2047.0890453748088;2169.609470295346;2184.5084855907453;2186.2238905188747;2187.3984654220217;10950;11048.171387145996;11054.060404865597;11057.944710276477;11063.502142403611;5997.850053748692;6164.4143806338325;6199.132121502948;6234.563580549363;6240.563160578761;3614.5301110855685;3716.2567486502808;3742.4760533525327;3751.6998640108727;3759.924801503982;1205.6684411786741;1219.5731493977037;1249.5813902342727;1263.387257180267;1272.249372870011;15638.13990230537;15647.217639117998;15791.131487768052;15817.209139543093;15867;5125.077486052472;5133.486651334837;5183.844484665466;5256.842294731164;5289.338832645919;11913.761724765456;11939.283642981449;11939.403029848472;11947.641570752892;11951.04391648666;5836.649801011953;5887.76448942046;5893.086571581412;5897.64614123154;5923.555733320019;5474.233607294982;5545.639533430314;5547.195656629847;5556.472135147154;5564.8330550083565;4140.855070072533;4166.23758734829;4212.073343864345;4241.406203131564;4242.321228603409;1174.5243176513525;1195.7728031673955;1196.3121205306984;1211.1340391620033;1211.95152193913;762.5386641082176;792.0811858244409;796;799.2726618776885;840.1514470384956;6453.612783233021;6792.558483698544;7018.719251229996;7078.292170782984;7351.0963169548795;953.6519170502717;990.5938565188238;1006.8238058339762;1007.2697294461603;1011;4308.18144552534;4529.252673308933;4551.7710218241555;4567.063751930847;4676.719396836201;13848.723025539433;13881.167129972033;14065;14133.15201087938;14613.707725845636;13284;13743.862561374459;13807.102538334975;13819;13839.654008649864;8583.227509524173;8979.730608081769;8997.505137217386;9000.729978100668;9005.954970225106;6381.521385896169;6516.152900122954;6537.248216455168;6607;6624.900626490703;12435.637228926475;12641.683957901127;12719.300438475973;12902;12916.418761155583;12736.872631273569;12847.421866015864;12861;12998;13076.476940922257;9862.063104005108;10272.743181420525;10349.379037257788;10405.895941040493;10574.682759517227;10520.579176833147;10587.36475811423;10604.310719803496;10639;10673.839892401465;8599.140085991601;8628.439151455135;8894.955525222333;9057.09429057089;9064.773380665272;8022.759317220492;8059.395545334006;8085.272325490734;8175.918240817516;8182.7545173644885;7290.9635451822405;7433.368163706145;7472.589007604416;7476.850462990818;7483;5491.341039075336;5648.293963254593;5659.292588426447;5752.108423194244;5846.093855452412;5626.130673356536;5763.4812866842185;5796.159556864147;5841.883162336644;5870.354261031198 09:26:10 INFO - PID 12833 | |4;prototype.html;393.4354201720531;394.4359565820876;398.23340070364543;402.9294873397155;406.5121853775469;6099.969500152493;6115.541334399915;6121.846953826151;6140.416660417259;6265.686715664221;5952.494038006775;6044.909326360097;6048.637081775097;6056.970315046442;6106.206193194889;4660.324252983315;4781.282807578857;4781.999999999991;4799.832005879794;4799.976000119995;4807.509672001674;4820.566149046585;4830.686005409655;4840;4847.733374664392;4750.76246187691;4754.762261886892;4759.5240475952305;4768.094062128202;4774.618030557564;4746.335513028179;4764.523547645243;4768.499307572724;4772.16487114757;4780.713157210578;4218.831246750126;4219.11398606293;4222.809973551167;4224.260754367973;4228.9788551057045;6045.153678484971;6076.422739839708;6079.939200607982;6080.179175811298;6096.298925623521;5407.459254074601;5438.53772429344;5456;5470;5483.643563168382;6427.7465894150655;6427.935720642828;6472.546921715481;6477.578957367756;6484.383983521558;4535.659825513099;4554.203014472487;4556.04323092151;4559.658025648089;4565.885852853672;6463.385978332051;6678.866422671519;6810.182778066664;6845.931540684579;6892.483063770187;4352.412424322739;4576.748278844696;4601.907961840744;4606.769661516911;4624.745638989821;4639.211334073216;4653.395058642355;4667.61951404786;4669.34629151919;4679.81280748773;5224.346956630421;5315.04329220744;5360.544353729899;5380;5385.6230063895155;6407.327230640809;6475.805725828139;6489.935100649028;6508.869822603521;6515;1620.6953402511092;1621;1625.4635970130066;1627.4466681328406;1632.6816270827076;1054.3779170289565;1082.9729256768644;1096.7203363142348;1098.6319582939805;1102.5038732570376;5664.461876121762;5742.856428589319;5744.195812586241;5761.3950535194035;5772.913406298909;6592.846251905898;6673.165854268216;6674.332566743286;6676.132102826601;6711.6979735912;5632.4930756231315;5710.143478478261;5721.284839395075;5730.111832665943;5730.856728581819;3545.397282461936;3554.3424466473784;3574.4995700601935;3586.5875424326014;3608.0979755061235;6388.201474815648;6403.423691867754;6440.194975628046;6492.902606460907;6504.577202481823;6793.660316984131;6821.522493425512;6848.760293389708;6853.554518956252;6884.759033433806;6402.8719425611225;6415.871682566322;6432.260290066609;6464.709088090953;6524.117056505433;6599.4720422365135;6665.100211471389;6708.563943343667;6713.395794378529;6747.831304217434;6647.434968027772;6682.131322927989;6690.297518760654;6696.59820410777;6704.262531121671;6264.31092579825;6300.653464059521;6459.547831651739;6488.935110648833;6542.8364290893105;4610.815567377267;4617.607503362117;4618.538146185355;4626.37543931565;4632.72203667781;6672.266050734513;6680.63256520896;6681.5656982296;6688.531802773759;6718.630475323904;6450.774222902176;6491.902621460587;6497.350264973654;6510.153680021567;6526.543141980016;6455.225372955276;6474.1907261592305;6480.125183100221;6483.643399613066;6491.935080649133;6315.873682526416;6437.25971513282;6438.8390290243115;6465.806025819233;6477.708503117466;6519.478441724746;6532.346765323429;6538.705758240795;6540.444062254572;6550.8362290943105;6327.746890124527;6338.65137417428;6355.841103972438;6359.109724638647;6362.363763623601 09:26:10 INFO - PID 12833 | |5;yui.html;808.6563210635478;834.9666013359466;835.319214839905;846.2003406780591;858.5020688000958;15588.22058897055;15965.201739913002;15994.60013499663;17423.651526969454;19061.237550497965;18312.725309120342;18410.907945460254;18697.532561685966;18709.34517291895;18722.157502912367;974.5663179884954;997.1823105053859;997.546116516983;997.5511020040974;1002.0630710285869;892.3040028777532;991.861139440479;1007.8840933292655;1013.4527355228167;1015.1320620869161;1064.5369264369986;1067.9572817087308;1068.7167900506372;1069.1286601419818;1073.9463026848666;1041.8333066709329;1042.8175069362908;1042.989570104297;1044.269011691815;1048.030571721155;763.4999075605488;763.5647680821934;764.6253335865441;767.301755402581;767.5049593012476;16007;16901.154942252837;17041.7443738344;17152.22814973329;17168.14159292043;18938.81061189384;18996.770549006702;19390.612187756167;19399;19541.218351265932;15248.085114893142;15428.768568471482;15457.304421301069;15464.922675386664;15480.458183963507;3357.1103657530775;3444.621091679913;3455.533502977091;3532.3994920863515;3533.6819686228364;83555.5822220885;86058;86271;86610;87105.56447217724;13678.316084195949;13979.440822367194;14118.505852295326;14136.575902722934;14204;23832.64251036236;23838.642420363707;24587.87706061458;26512.60231096535;26997.730022699914;7801.102873169544;7810.57041862703;8110.959445202854;8139.064007639197;8213.301869341172;3813.694904407641;3892.143728379752;3934.429507721364;3947.9013024674614;3948.2498325318097;4006.8597599084474;4018.0557568971267;4055.2903241932545;4075.2664520386024;4189.706720529533;788.9723859664999;798.2935102434387;806.1736719862188;809.3201710563037;809.5466538738325;667.259342130235;677.6340775980915;691.2707094015861;707.8478127202676;710.6944014073998;10794.082502987178;11425.542978280775;11566.47950842214;11670.824937625943;12238.449269782881;682.8361193313569;684.2404930527111;687.3367200651395;698.3261152987392;700.184285307621;5432.266644003009;5641.210230567724;5698.458646428583;5750.108733146369;5776.797812076557;91160.54419727992;91961;92005.53997230105;95107.52446237725;96915;81051.59474202592;84160.57919710362;84217.57891210627;84367;86038.13961860427;72645.27354726491;72757.63621181861;72913.6354318225;73067;73340.5658349286;10633.308834925705;10651.147908167482;11284.774304514029;11430.085593152362;11621.6513504595;28167.859160704065;28650.856745716137;30710.69289307168;31627.841860790548;31981.200469988435;51806.74096629493;51992;53108.468915311896;53837.73081134569;55076;16608.66782664316;16864.494065178063;16998.915005424893;17311.56721081983;17562.912185438992;16565.668686626443;19058.237670493025;19801.801981979996;19835.702464463335;19996.20015199376;17411.564710881823;17673.91163044228;17724.6304271336;17735.82264177342;18125.184366703266;17256.482305530855;17278.22247998818;17596.29614815393;17687.469375918743;17701.203445845225;16131;16389.508314750576;16540.503784886474;16830.242639081516;16910.830891690926;11150.330980141218;11248.918949994277;11377.374244416305;11564.94217528907;12116.21244619097;12391.93804030974;12800.871991279968;12819.551315703906;12947.093703441045;12971.740565188833 09:26:10 INFO - PID 12833 | __end_tp_report 09:26:10 INFO - PID 12833 | __start_cc_report 09:26:10 INFO - PID 12833 | _x_x_mozilla_cycle_collect,375 09:26:10 INFO - PID 12833 | __end_cc_report 09:26:10 INFO - PID 12833 | __startTimestamp1496420770889__endTimestamp 09:26:10 INFO - PID 12833 | 09:26:10 INFO - PID 12833 | ------- Summary: start ------- 09:26:10 INFO - PID 12833 | Number of tests: 6 09:26:10 INFO - PID 12833 | 09:26:10 INFO - PID 12833 | [#0] dojo.html Cycles:165 Average:5838.28 Median:6070.15 stddev:653.05 (10.8%) stddev-sans-first:618.05 09:26:10 INFO - PID 12833 | Values: 3075.8 3086.2 3101.3 3129.3 3130.4 5788.8 5795.5 5835.6 5836.2 5860.2 5841.5 5845.1 5852.3 5853.3 5860.5 5374.7 5392.6 5438.9 5485.6 5499.4 5309.4 5450.6 5520.5 5533.6 5552.2 5513.3 5518.9 5520.1 5588.1 5594.6 5361.9 5373.7 5441.0 5444.4 5457.8 5407.8 5434.3 5447.1 5452.4 5472.7 5808.9 5811.5 5843.1 5865.4 5869.9 6139.6 6219.7 6267.5 6297.6 6308.5 6335.3 6387.7 6463.7 6470.4 6480.4 5880.5 5886.2 5900.1 5918.3 5942.9 6309.3 6394.4 6435.7 6490.2 6505.4 6124.3 6160.7 6169.4 6176.1 6176.9 6118.7 6180.3 6217.3 6220.6 6265.4 6325.9 6379.7 6380.1 6383.6 6406.9 6226.2 6307.2 6402.7 6420.9 6426.0 5170.5 5199.3 5210.7 5218.6 5218.7 4453.3 4466.4 4471.1 4505.1 4573.0 5413.3 5515.5 5518.6 5523.1 5526.9 6267.2 6307.5 6357.7 6396.9 6417.3 5533.9 5534.8 5547.5 5553.3 5578.9 5635.0 5654.6 5656.9 5659.2 5660.7 6028.6 6068.8 6100.4 6145.2 6156.4 6363.8 6390.0 6403.9 6404.3 6431.3 6118.8 6179.7 6183.4 6195.3 6211.6 6050.4 6136.8 6141.2 6226.7 6256.2 6311.9 6390.1 6397.9 6402.7 6416.9 6151.8 6157.2 6162.8 6166.3 6193.1 6070.2 6078.2 6088.3 6105.8 6142.3 6063.5 6110.9 6120.8 6133.6 6166.3 6221.4 6290.0 6298.6 6302.2 6306.3 5871.9 5952.1 5963.5 6078.3 6083.8 09:26:10 INFO - PID 12833 | 09:26:10 INFO - PID 12833 | [#1] ext.html Cycles:180 Average:33039.84 Median:32727.51 stddev:44198.62 (135.1%) stddev-sans-first:44255.86 09:26:10 INFO - PID 12833 | Values: 690.6 723.3 755.5 1131.0 1147.5 35398.0 36295.0 36371.8 36415.8 36421.0 37522.6 37589.2 37664.6 37979.8 37988.8 7127.2 7275.1 7286.6 7399.8 7402.5 7231.3 7287.4 7300.9 7321.2 7322.7 7318.2 7320.3 7327.6 7336.8 7385.0 7293.4 7294.3 7310.3 7324.9 7330.0 7171.6 7197.8 7231.7 7233.3 7246.9 35311.6 35335.8 35652.6 35672.0 35689.5 3402.4 3433.5 3439.9 3443.8 3452.9 27935.3 28007.2 28030.4 28045.3 28072.7 3610.3 3630.8 3640.1 3647.2 3664.2 137139.0 138555.3 154308.2 162772.0 162905.0 42148.6 42369.4 42476.2 42505.1 42533.0 44971.1 44998.8 45050.1 45055.8 45163.8 14472.2 14517.6 14519.5 14534.6 14539.4 11990.6 12070.2 12098.6 12109.1 12109.2 13153.6 13247.9 13340.3 13346.4 13555.2 5620.3 5787.2 5804.2 5879.6 5883.1 962.4 1001.0 1003.8 1014.6 1026.7 23065.3 23607.4 23710.6 23774.9 23844.8 1093.7 1099.9 1105.3 1117.9 1129.9 12221.5 12446.6 12584.2 12650.3 12666.8 193744.0 194326.0 194403.0 194773.0 196234.0 47376.8 47383.0 47789.3 47821.0 47872.8 1388.2 1427.0 1446.3 1453.4 1457.2 21582.6 21941.1 23141.1 23209.5 23280.7 35003.5 35154.0 35202.5 35225.0 35275.6 164009.0 164310.0 164484.0 165635.0 165923.0 29490.4 30062.2 30699.2 31304.5 32161.5 38538.4 39511.4 39750.0 40006.4 40709.8 30241.5 30695.2 31030.4 31209.0 31278.5 29105.1 29641.1 30029.0 30096.5 30926.5 33293.5 33913.8 33921.7 33974.3 34034.0 29346.3 29569.7 29598.3 30051.5 30797.7 23017.0 23054.5 23639.8 23961.9 24093.2 09:26:10 INFO - PID 12833 | 09:26:10 INFO - PID 12833 | [#2] jquery.html Cycles:180 Average:29475.68 Median:2139.74 stddev:69997.38 (3271.3%) stddev-sans-first:70159.73 09:26:10 INFO - PID 12833 | Values: 412.8 416.5 428.2 428.9 433.9 19495.3 20341.5 20397.7 21519.2 22444.1 23201.3 23808.6 23824.8 23826.5 23847.3 5847.5 5932.4 6001.5 6008.4 6020.6 5961.0 5962.7 6016.2 6031.1 6037.9 5798.8 5848.9 5934.3 5949.2 5967.6 5878.1 5945.9 5951.0 5951.9 5957.3 5345.2 5349.2 5361.2 5363.7 5373.0 25468.7 25714.0 25732.2 25780.7 25797.9 1787.4 1847.7 1862.9 1863.0 1868.9 16912.7 17193.8 17229.7 17252.4 17258.8 2207.3 2247.2 2270.8 2272.5 2279.8 111971.4 112003.0 114969.4 118591.0 118756.4 11504.9 11522.9 11955.9 11970.1 11988.8 16713.2 16796.7 16877.3 16890.9 16911.7 8756.3 8821.7 8926.3 9034.8 9191.3 8280.3 8336.9 8493.8 8524.4 8568.0 7427.0 7675.6 7683.7 7724.8 7789.5 2105.1 2135.8 2143.7 2149.3 2295.1 932.0 982.9 988.7 989.8 1000.8 19230.8 20143.1 20202.6 20206.7 20428.2 1003.3 1003.7 1006.6 1018.8 1022.0 10844.5 10987.6 11129.3 11152.2 11170.3 409270.0 412178.0 415076.0 422304.0 422422.0 96297.5 97207.0 97292.0 97811.0 98464.5 1025.3 1098.6 1158.3 1179.3 1194.0 19650.0 19682.9 20550.9 20618.1 20994.2 45945.8 46099.3 46445.0 47154.8 47267.3 57222.7 57540.4 58215.7 58503.4 58622.7 10168.8 10343.6 10354.8 10360.8 10378.1 17222.3 17534.4 17600.1 17608.4 17665.2 14596.0 14706.0 14810.3 14815.1 14860.3 12686.6 12833.6 13344.2 13596.9 13810.7 14657.7 14955.8 15133.2 15153.1 15387.0 10231.8 10319.9 10327.6 10349.8 10356.3 14734.9 14891.3 14907.0 14975.9 15053.4 09:26:10 INFO - PID 12833 | 09:26:10 INFO - PID 12833 | [#3] mootools.html Cycles:180 Average:6829.51 Median:2320.87 stddev:4326.46 (186.4%) stddev-sans-first:4318.42 09:26:10 INFO - PID 12833 | Values: 1268.2 1302.1 1323.5 1329.7 1332.4 10827.7 11056.4 11367.9 11375.4 11431.5 11114.1 11305.4 11340.5 11359.9 11399.8 2293.8 2353.3 2355.6 2363.1 2365.1 2268.9 2303.7 2315.2 2326.5 2336.6 2234.4 2257.2 2269.7 2272.5 2277.1 2186.4 2207.1 2212.5 2214.4 2219.9 2047.1 2169.6 2184.5 2186.2 2187.4 10950.0 11048.2 11054.1 11057.9 11063.5 5997.9 6164.4 6199.1 6234.6 6240.6 3614.5 3716.3 3742.5 3751.7 3759.9 1205.7 1219.6 1249.6 1263.4 1272.2 15638.1 15647.2 15791.1 15817.2 15867.0 5125.1 5133.5 5183.8 5256.8 5289.3 11913.8 11939.3 11939.4 11947.6 11951.0 5836.6 5887.8 5893.1 5897.6 5923.6 5474.2 5545.6 5547.2 5556.5 5564.8 4140.9 4166.2 4212.1 4241.4 4242.3 1174.5 1195.8 1196.3 1211.1 1212.0 762.5 792.1 796.0 799.3 840.2 6453.6 6792.6 7018.7 7078.3 7351.1 953.7 990.6 1006.8 1007.3 1011.0 4308.2 4529.3 4551.8 4567.1 4676.7 13848.7 13881.2 14065.0 14133.2 14613.7 13284.0 13743.9 13807.1 13819.0 13839.7 8583.2 8979.7 8997.5 9000.7 9006.0 6381.5 6516.2 6537.2 6607.0 6624.9 12435.6 12641.7 12719.3 12902.0 12916.4 12736.9 12847.4 12861.0 12998.0 13076.5 9862.1 10272.7 10349.4 10405.9 10574.7 10520.6 10587.4 10604.3 10639.0 10673.8 8599.1 8628.4 8895.0 9057.1 9064.8 8022.8 8059.4 8085.3 8175.9 8182.8 7291.0 7433.4 7472.6 7476.9 7483.0 5491.3 5648.3 5659.3 5752.1 5846.1 5626.1 5763.5 5796.2 5841.9 5870.4 09:26:10 INFO - PID 12833 | 09:26:10 INFO - PID 12833 | [#4] prototype.html Cycles:180 Average:5381.76 Median:6078.18 stddev:1585.11 (26.1%) stddev-sans-first:1544.71 09:26:10 INFO - PID 12833 | Values: 393.4 394.4 398.2 402.9 406.5 6100.0 6115.5 6121.8 6140.4 6265.7 5952.5 6044.9 6048.6 6057.0 6106.2 4660.3 4781.3 4782.0 4799.8 4800.0 4807.5 4820.6 4830.7 4840.0 4847.7 4750.8 4754.8 4759.5 4768.1 4774.6 4746.3 4764.5 4768.5 4772.2 4780.7 4218.8 4219.1 4222.8 4224.3 4229.0 6045.2 6076.4 6079.9 6080.2 6096.3 5407.5 5438.5 5456.0 5470.0 5483.6 6427.7 6427.9 6472.5 6477.6 6484.4 4535.7 4554.2 4556.0 4559.7 4565.9 6463.4 6678.9 6810.2 6845.9 6892.5 4352.4 4576.7 4601.9 4606.8 4624.7 4639.2 4653.4 4667.6 4669.3 4679.8 5224.3 5315.0 5360.5 5380.0 5385.6 6407.3 6475.8 6489.9 6508.9 6515.0 1620.7 1621.0 1625.5 1627.4 1632.7 1054.4 1083.0 1096.7 1098.6 1102.5 5664.5 5742.9 5744.2 5761.4 5772.9 6592.8 6673.2 6674.3 6676.1 6711.7 5632.5 5710.1 5721.3 5730.1 5730.9 3545.4 3554.3 3574.5 3586.6 3608.1 6388.2 6403.4 6440.2 6492.9 6504.6 6793.7 6821.5 6848.8 6853.6 6884.8 6402.9 6415.9 6432.3 6464.7 6524.1 6599.5 6665.1 6708.6 6713.4 6747.8 6647.4 6682.1 6690.3 6696.6 6704.3 6264.3 6300.7 6459.5 6488.9 6542.8 4610.8 4617.6 4618.5 4626.4 4632.7 6672.3 6680.6 6681.6 6688.5 6718.6 6450.8 6491.9 6497.4 6510.2 6526.5 6455.2 6474.2 6480.1 6483.6 6491.9 6315.9 6437.3 6438.8 6465.8 6477.7 6519.5 6532.3 6538.7 6540.4 6550.8 6327.7 6338.7 6355.8 6359.1 6362.4 09:26:10 INFO - PID 12833 | 09:26:10 INFO - PID 12833 | [#5] yui.html Cycles:180 Average:19821.78 Median:24213.26 stddev:25178.61 (104.0%) stddev-sans-first:25208.76 09:26:10 INFO - PID 12833 | Values: 808.7 835.0 835.3 846.2 858.5 15588.2 15965.2 15994.6 17423.7 19061.2 18312.7 18410.9 18697.5 18709.3 18722.2 974.6 997.2 997.5 997.6 1002.1 892.3 991.9 1007.9 1013.5 1015.1 1064.5 1068.0 1068.7 1069.1 1073.9 1041.8 1042.8 1043.0 1044.3 1048.0 763.5 763.6 764.6 767.3 767.5 16007.0 16901.2 17041.7 17152.2 17168.1 18938.8 18996.8 19390.6 19399.0 19541.2 15248.1 15428.8 15457.3 15464.9 15480.5 3357.1 3444.6 3455.5 3532.4 3533.7 83555.6 86058.0 86271.0 86610.0 87105.6 13678.3 13979.4 14118.5 14136.6 14204.0 23832.6 23838.6 24587.9 26512.6 26997.7 7801.1 7810.6 8111.0 8139.1 8213.3 3813.7 3892.1 3934.4 3947.9 3948.2 4006.9 4018.1 4055.3 4075.3 4189.7 789.0 798.3 806.2 809.3 809.5 667.3 677.6 691.3 707.8 710.7 10794.1 11425.5 11566.5 11670.8 12238.4 682.8 684.2 687.3 698.3 700.2 5432.3 5641.2 5698.5 5750.1 5776.8 91160.5 91961.0 92005.5 95107.5 96915.0 81051.6 84160.6 84217.6 84367.0 86038.1 72645.3 72757.6 72913.6 73067.0 73340.6 10633.3 10651.1 11284.8 11430.1 11621.7 28167.9 28650.9 30710.7 31627.8 31981.2 51806.7 51992.0 53108.5 53837.7 55076.0 16608.7 16864.5 16998.9 17311.6 17562.9 16565.7 19058.2 19801.8 19835.7 19996.2 17411.6 17673.9 17724.6 17735.8 18125.2 17256.5 17278.2 17596.3 17687.5 17701.2 16131.0 16389.5 16540.5 16830.2 16910.8 11150.3 11248.9 11377.4 11564.9 12116.2 12391.9 12800.9 12819.6 12947.1 12971.7 09:26:10 INFO - PID 12833 | -------- Summary: end -------- 09:26:10 INFO - PID 12833 | 09:26:11 INFO - TEST-INFO | 12833: exit 0 09:26:11 INFO - TEST-OK | dromaeo_css | took 1143270ms 09:26:11 INFO - TEST-START | kraken 09:26:11 INFO - operating with platform_type : linux_ 09:26:11 INFO - Initialising browser for kraken test... 09:26:11 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59867/getInfo.html -profile /tmp/tmpf8UJOX/profile 09:26:11 INFO - TEST-INFO | started process 13257 (/builds/slave/test/build/application/firefox/firefox http://localhost:59867/getInfo.html) 09:26:46 INFO - TEST-INFO | 13257: killed by SIGTERM 09:26:46 INFO - Browser initialized. 09:26:46 INFO - Running cycle 1/1 for kraken test... 09:26:46 INFO - TEST-INFO | started process 13486 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf8UJOX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:26:58 INFO - PID 13486 | RSS: Main: 192368640 09:26:58 INFO - PID 13486 | 09:27:01 INFO - PID 13486 | Cycle 1(1): loaded http://localhost:59867/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59867/tests/kraken/driver.html?testName=audio-beat-detection) 09:27:02 INFO - PID 13486 | RSS: Main: 196861952 09:27:02 INFO - PID 13486 | 09:27:04 INFO - PID 13486 | Cycle 1(1): loaded http://localhost:59867/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59867/tests/kraken/driver.html?testName=audio-dft) 09:27:05 INFO - PID 13486 | RSS: Main: 195194880 09:27:05 INFO - PID 13486 | 09:27:08 INFO - PID 13486 | Cycle 1(1): loaded http://localhost:59867/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59867/tests/kraken/driver.html?testName=audio-fft) 09:27:09 INFO - PID 13486 | RSS: Main: 190398464 09:27:09 INFO - PID 13486 | 09:27:11 INFO - PID 13486 | Cycle 1(1): loaded http://localhost:59867/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59867/tests/kraken/driver.html?testName=audio-oscillator) 09:27:11 INFO - PID 13486 | RSS: Main: 191135744 09:27:11 INFO - PID 13486 | 09:27:13 INFO - PID 13486 | Cycle 1(1): loaded http://localhost:59867/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59867/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:27:14 INFO - PID 13486 | RSS: Main: 191643648 09:27:14 INFO - PID 13486 | 09:27:17 INFO - PID 13486 | Cycle 1(1): loaded http://localhost:59867/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59867/tests/kraken/driver.html?testName=imaging-darkroom) 09:27:18 INFO - PID 13486 | RSS: Main: 192364544 09:27:18 INFO - PID 13486 | 09:27:21 INFO - PID 13486 | Cycle 1(1): loaded http://localhost:59867/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59867/tests/kraken/driver.html?testName=imaging-desaturate) 09:27:22 INFO - PID 13486 | RSS: Main: 191668224 09:27:22 INFO - PID 13486 | 09:27:25 INFO - PID 13486 | Cycle 1(1): loaded http://localhost:59867/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59867/tests/kraken/driver.html?testName=json-parse-financial) 09:27:25 INFO - PID 13486 | RSS: Main: 192434176 09:27:25 INFO - PID 13486 | 09:27:27 INFO - PID 13486 | Cycle 1(1): loaded http://localhost:59867/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59867/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:27:28 INFO - PID 13486 | RSS: Main: 192651264 09:27:28 INFO - PID 13486 | 09:27:29 INFO - PID 13486 | Cycle 1(1): loaded http://localhost:59867/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59867/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:27:30 INFO - PID 13486 | RSS: Main: 192307200 09:27:30 INFO - PID 13486 | 09:27:32 INFO - PID 13486 | Cycle 1(1): loaded http://localhost:59867/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59867/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:27:33 INFO - PID 13486 | RSS: Main: 192401408 09:27:33 INFO - PID 13486 | 09:27:36 INFO - PID 13486 | Cycle 1(1): loaded http://localhost:59867/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59867/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:27:36 INFO - PID 13486 | RSS: Main: 192307200 09:27:36 INFO - PID 13486 | 09:27:39 INFO - PID 13486 | Cycle 1(1): loaded http://localhost:59867/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59867/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:27:40 INFO - PID 13486 | RSS: Main: 192155648 09:27:40 INFO - PID 13486 | 09:27:42 INFO - PID 13486 | Cycle 1(1): loaded http://localhost:59867/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59867/tests/kraken/driver.html?testName=ai-astar) 09:27:42 INFO - PID 13486 | RSS: Main: 193708032 09:27:42 INFO - PID 13486 | 09:27:42 INFO - PID 13486 | __start_tp_report 09:27:42 INFO - PID 13486 | _x_x_mozilla_page_load 09:27:42 INFO - PID 13486 | _x_x_mozilla_page_load_details 09:27:42 INFO - PID 13486 | |i|pagename|runs| 09:27:42 INFO - PID 13486 | |0;ai-astar;102;111;111;111;110;111;110;110;110;110 09:27:42 INFO - PID 13486 | |1;audio-beat-detection;153;121;122;162;131;122;131;129;145;122 09:27:42 INFO - PID 13486 | |2;audio-dft;163;164;164;162;164;164;168;171;166;162 09:27:42 INFO - PID 13486 | |3;audio-fft;72;74;74;111;78;74;76;74;96;76 09:27:42 INFO - PID 13486 | |4;audio-oscillator;83;83;101;82;82;82;106;82;83;108 09:27:42 INFO - PID 13486 | |5;imaging-gaussian-blur;113;114;113;114;114;114;113;114;118;115 09:27:42 INFO - PID 13486 | |6;imaging-darkroom;150;151;151;150;155;155;152;149;150;151 09:27:42 INFO - PID 13486 | |7;imaging-desaturate;94;95;94;94;94;94;94;97;99;97 09:27:42 INFO - PID 13486 | |8;json-parse-financial;57;54;54;56;57;61;60;57;56;55 09:27:42 INFO - PID 13486 | |9;json-stringify-tinderbox;56;56;56;58;60;57;56;56;56;56 09:27:42 INFO - PID 13486 | |10;stanford-crypto-aes;87;89;88;88;98;88;88;89;121;90 09:27:42 INFO - PID 13486 | |11;stanford-crypto-ccm;132;143;137;140;130;136;133;132;137;141 09:27:42 INFO - PID 13486 | |12;stanford-crypto-pbkdf2;188;192;188;204;198;199;202;197;194;194 09:27:42 INFO - PID 13486 | |13;stanford-crypto-sha256-iterative;72;72;74;78;74;73;75;71;73;79 09:27:42 INFO - PID 13486 | __end_tp_report 09:27:42 INFO - PID 13486 | __start_cc_report 09:27:42 INFO - PID 13486 | _x_x_mozilla_cycle_collect,1012 09:27:42 INFO - PID 13486 | __end_cc_report 09:27:42 INFO - PID 13486 | __startTimestamp1496420862620__endTimestamp 09:27:42 INFO - PID 13486 | 09:27:42 INFO - PID 13486 | ------- Summary: start ------- 09:27:42 INFO - PID 13486 | Number of tests: 14 09:27:42 INFO - PID 13486 | 09:27:42 INFO - PID 13486 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.50 stddev:2.72 (2.5%) stddev-sans-first:0.53 09:27:42 INFO - PID 13486 | Values: 102.0 111.0 111.0 111.0 110.0 111.0 110.0 110.0 110.0 110.0 09:27:42 INFO - PID 13486 | 09:27:42 INFO - PID 13486 | [#1] audio-beat-detection Cycles:10 Average:133.80 Median:131.00 stddev:14.57 (11.1%) stddev-sans-first:13.69 09:27:42 INFO - PID 13486 | Values: 153.0 121.0 122.0 162.0 131.0 122.0 131.0 129.0 145.0 122.0 09:27:42 INFO - PID 13486 | 09:27:42 INFO - PID 13486 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.00 stddev:2.82 (1.7%) stddev-sans-first:2.92 09:27:42 INFO - PID 13486 | Values: 163.0 164.0 164.0 162.0 164.0 164.0 168.0 171.0 166.0 162.0 09:27:42 INFO - PID 13486 | 09:27:42 INFO - PID 13486 | [#3] audio-fft Cycles:10 Average:80.50 Median:75.00 stddev:12.73 (17.0%) stddev-sans-first:13.13 09:27:42 INFO - PID 13486 | Values: 72.0 74.0 74.0 111.0 78.0 74.0 76.0 74.0 96.0 76.0 09:27:42 INFO - PID 13486 | 09:27:42 INFO - PID 13486 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:82.00 stddev:11.04 (13.5%) stddev-sans-first:11.48 09:27:42 INFO - PID 13486 | Values: 83.0 83.0 101.0 82.0 82.0 82.0 106.0 82.0 83.0 108.0 09:27:42 INFO - PID 13486 | 09:27:42 INFO - PID 13486 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:1.48 (1.3%) stddev-sans-first:1.50 09:27:42 INFO - PID 13486 | Values: 113.0 114.0 113.0 114.0 114.0 114.0 113.0 114.0 118.0 115.0 09:27:42 INFO - PID 13486 | 09:27:42 INFO - PID 13486 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:151.00 stddev:2.07 (1.4%) stddev-sans-first:2.13 09:27:42 INFO - PID 13486 | Values: 150.0 151.0 151.0 150.0 155.0 155.0 152.0 149.0 150.0 151.0 09:27:42 INFO - PID 13486 | 09:27:42 INFO - PID 13486 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:94.50 stddev:1.81 (1.9%) stddev-sans-first:1.87 09:27:42 INFO - PID 13486 | Values: 94.0 95.0 94.0 94.0 94.0 94.0 94.0 97.0 99.0 97.0 09:27:42 INFO - PID 13486 | 09:27:42 INFO - PID 13486 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:2.31 (4.1%) stddev-sans-first:2.45 09:27:42 INFO - PID 13486 | Values: 57.0 54.0 54.0 56.0 57.0 61.0 60.0 57.0 56.0 55.0 09:27:42 INFO - PID 13486 | 09:27:42 INFO - PID 13486 | [#9] json-stringify-tinderbox Cycles:10 Average:56.70 Median:56.00 stddev:1.34 (2.4%) stddev-sans-first:1.39 09:27:42 INFO - PID 13486 | Values: 56.0 56.0 56.0 58.0 60.0 57.0 56.0 56.0 56.0 56.0 09:27:42 INFO - PID 13486 | 09:27:42 INFO - PID 13486 | [#10] stanford-crypto-aes Cycles:10 Average:92.60 Median:88.50 stddev:10.46 (11.8%) stddev-sans-first:10.89 09:27:42 INFO - PID 13486 | Values: 87.0 89.0 88.0 88.0 98.0 88.0 88.0 89.0 121.0 90.0 09:27:42 INFO - PID 13486 | 09:27:42 INFO - PID 13486 | [#11] stanford-crypto-ccm Cycles:10 Average:136.10 Median:137.00 stddev:4.33 (3.2%) stddev-sans-first:4.33 09:27:42 INFO - PID 13486 | Values: 132.0 143.0 137.0 140.0 130.0 136.0 133.0 132.0 137.0 141.0 09:27:42 INFO - PID 13486 | 09:27:42 INFO - PID 13486 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.60 Median:197.50 stddev:5.42 (2.7%) stddev-sans-first:5.00 09:27:42 INFO - PID 13486 | Values: 188.0 192.0 188.0 204.0 198.0 199.0 202.0 197.0 194.0 194.0 09:27:42 INFO - PID 13486 | 09:27:42 INFO - PID 13486 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.10 Median:74.00 stddev:2.60 (3.5%) stddev-sans-first:2.65 09:27:42 INFO - PID 13486 | Values: 72.0 72.0 74.0 78.0 74.0 73.0 75.0 71.0 73.0 79.0 09:27:42 INFO - PID 13486 | -------- Summary: end -------- 09:27:42 INFO - PID 13486 | 09:27:43 INFO - TEST-INFO | 13486: exit 0 09:27:43 INFO - TEST-OK | kraken | took 91997ms 09:27:43 INFO - SUITE-END | took 1235s 09:27:43 INFO - Completed test suite (00:20:35) 09:27:43 INFO - javascript benchmark 09:27:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7632.38183463767, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3075.7539396848256, 3086.197588626957, 3101.286704058067, 3129.3115514586784, 3130.389574033063, 5788.82633520994, 5795.4784069433745, 5835.5915085944, 5836.182934389183, 5860.23816903803, 5841.53267738581, 5845.09401042839, 5852.268466441695, 5853.268341457318, 5860.5311575074, 5374.677519348832, 5392.649477783942, 5438.945610543903, 5485.61600687952, 5499.3675727291275, 5309.389420216667, 5450.591205659572, 5520.530754885839, 5533.6403133796375, 5552.167174923753, 5513.3108361454815, 5518.944810551883, 5520.089185284423, 5588.105903055512, 5594.58040646951, 5361.919571206435, 5373.731313434313, 5441.047816632074, 5444.373897001856, 5457.781688732446, 5407.837764867021, 5434.266374039494, 5447.073997420448, 5452.372977107644, 5472.699001554913, 5808.925348810483, 5811.535077193815, 5843.065109582489, 5865.413458654143, 5869.941300586982, 6139.584134579375, 6219.689015549205, 6267.4986001119805, 6297.559170858041, 6308.495320374359, 6335.334789847092, 6387.712552935082, 6463.6768161591735, 6470.352964703492, 6480.384363485461, 5880.500157486662, 5886.20536227608, 5900.144479050557, 5918.2898052234, 5942.940570594325, 6309.337519560472, 6394.392532709385, 6435.678216089177, 6490.156279683611, 6505.381988711065, 6124.319907527392, 6160.691965401712, 6169.383061693885, 6176.135341052256, 6176.8764624707255, 6118.710550942845, 6180.258368995749, 6217.253929528486, 6220.564560480813, 6265.4361107500545, 6325.936740632626, 6379.74481020754, 6380.074889141141, 6383.648899310582, 6406.8718625627225, 6226.221722284715, 6307.211598550181, 6402.679866006681, 6420.935790642034, 6426.0, 5170.482951704799, 5199.298094757235, 5210.739463026834, 5218.556422704112, 5218.712970786567, 4453.287474004143, 4466.3523789050405, 4471.06107717383, 4505.053938672915, 4572.977135114304, 5413.296271484761, 5515.503604675599, 5518.641288316247, 5523.088690366125, 5526.944730552724, 6267.2165979252595, 6307.463865571386, 6357.713902874381, 6396.9360306397275, 6417.326180751047, 5533.889322213533, 5534.75093620788, 5547.528460080857, 5553.305836770403, 5578.86052848682, 5635.0, 5654.604177707603, 5656.943430565641, 5659.236003139606, 5660.660360378308, 6028.577999540078, 6068.848278793065, 6100.359462256488, 6145.156453064153, 6156.384361563987, 6363.809085727436, 6390.041493775971, 6403.903941440975, 6404.327545607831, 6431.260405053292, 6118.847028824315, 6179.660118693335, 6183.3816618337805, 6195.287541932736, 6211.627302361872, 6050.42520960508, 6136.815895523141, 6141.232345956755, 6226.688665566794, 6256.155419018374, 6311.873762524816, 6390.073439351361, 6397.904031439439, 6402.743890244338, 6416.935830641633, 6151.753929842756, 6157.230346206724, 6162.753489860355, 6166.260048794174, 6193.071039344134, 6070.1501789750355, 6078.240219972504, 6088.330283668704, 6105.793350785129, 6142.253225532511, 6063.514918806573, 6110.892920173631, 6120.816375508742, 6133.6319820810895, 6166.2600487939935, 6221.354270455456, 6289.96855015722, 6298.559100862895, 6302.180716506825, 6306.2747784003595, 5871.853203669943, 5952.077427998494, 5963.493103086286, 6078.331383547895, 6083.7870674526175], "value": 5792.212780610537, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.5649440852262, 723.2911746488442, 755.4938191411753, 1130.9660710178698, 1147.4778975566119, 35397.99117075049, 36295.0, 36371.818140909294, 36415.81792091043, 36421.0, 37522.62477375226, 37589.24821503568, 37664.623353766525, 37979.81010094946, 37988.81005594975, 7127.216006239335, 7275.054242948409, 7286.599237041961, 7399.778006659809, 7402.481826272163, 7231.3130252625915, 7287.380572651305, 7300.853982920365, 7321.231270716578, 7322.71852425826, 7318.1949985501815, 7320.267973202664, 7327.596982165979, 7336.7798966031105, 7385.039944807168, 7293.416526677853, 7294.343509084208, 7310.2689731027, 7324.853502929912, 7330.047093877815, 7171.605561694105, 7197.820054498627, 7231.674574644101, 7233.348998590152, 7246.855062898765, 35311.64688353135, 35335.82332088323, 35652.64347356519, 35672.0, 35689.46465803015, 3402.3535528249554, 3433.5021421893935, 3439.8624055037767, 3443.8278086095597, 3452.913677158066, 27935.30161745952, 28007.159785206273, 28030.439391212265, 28045.298867528272, 28072.71927280742, 3610.3140403323287, 3630.8366123524506, 3640.0717816956508, 3647.1793846384617, 3664.1755604988666, 137139.0, 138555.30722346425, 154308.22845885812, 162772.0, 162905.0, 42148.57851421447, 42369.364459533135, 42476.15047699029, 42505.14989700189, 42533.0, 44971.100577988254, 44998.77500612541, 45050.09899802051, 45055.77472112684, 45163.77418112889, 14472.204028778518, 14517.564473065824, 14519.491817786327, 14534.563963081124, 14539.418423263163, 11990.580329688419, 12070.155089143676, 12098.637040888787, 12109.091818113677, 12109.212901161396, 13153.60539183826, 13247.933760331136, 13340.266285354399, 13346.399412026482, 13555.186688798703, 5620.297462817148, 5787.189793428924, 5804.245448091806, 5879.559033072451, 5883.088121341113, 962.4417837654283, 1000.9599616015423, 1003.8393856982848, 1014.5593257574262, 1026.697124348319, 23065.308040758468, 23607.40981475477, 23710.644340334908, 23774.881125594606, 23844.7615523846, 1093.6937657455926, 1099.9450027498754, 1105.3478447715725, 1117.871444783844, 1129.8700649425257, 12221.450034748457, 12446.564370246997, 12584.244945303128, 12650.304233267074, 12666.80999785004, 193744.0, 194326.0, 194403.0, 194773.0, 196234.0, 47376.76311618489, 47383.0, 47789.28316075262, 47821.0, 47872.760636196595, 1388.2295326093913, 1426.9571912842632, 1446.2624061728595, 1453.396840311259, 1457.2203870929213, 21582.568348633253, 21941.122355105617, 23141.07435702553, 23209.535809284058, 23280.6507902385, 35003.47494787529, 35154.0, 35202.47196292006, 35225.0, 35275.64724352724, 164009.0, 164310.0, 164484.0, 165635.0, 165923.0, 29490.410191796473, 30062.24844378908, 30699.2325191872, 31304.53043204308, 32161.517577235893, 38538.421923670605, 39511.407328890666, 39750.0, 40006.39990400088, 40709.79645101756, 30241.546376804807, 30695.2326191847, 31030.379392411574, 31209.0, 31278.53082203723, 29105.093167701863, 29641.110766677033, 30029.0, 30096.548551771302, 30926.536101958038, 33293.50059749057, 33913.83043084769, 33921.660783392836, 33974.3205135891, 34034.0, 29346.266343341587, 29569.704302956696, 29598.260043498223, 30051.549226762054, 30797.692023079482, 23017.0, 23054.538909222058, 23639.763602363757, 23961.880190599633, 24093.187997306268], "value": 15924.95876642588, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.82454956643437, 416.5272415808057, 428.21850123524575, 428.94209281746953, 433.9435873336466, 19495.317663881768, 20341.49146271344, 20397.694034589495, 21519.24682636108, 22444.102235910545, 23201.3039608812, 23808.642870356915, 23824.76175238247, 23826.5234695306, 23847.284581462583, 5847.532197424217, 5932.406759324054, 6001.459868611824, 6008.399160083978, 6020.608660437079, 5960.970195149018, 5962.701864906759, 6016.187814645033, 6031.065184896348, 6037.909431358533, 5798.782255726282, 5848.912266315988, 5934.347221805598, 5949.167116603679, 5967.552433567478, 5878.118282257653, 5945.88108237835, 5951.018082016484, 5951.880962380771, 5957.314908785458, 5345.198220266952, 5349.170878513836, 5361.169018802053, 5363.678179309215, 5372.973135134338, 25468.745312546824, 25714.0, 25732.228033159034, 25780.74219257802, 25797.871010644827, 1787.3922866225546, 1847.7136043913215, 1862.9161687724086, 1862.962740745191, 1868.9065546722745, 16912.661746764996, 17193.82806171935, 17229.655406891918, 17252.39616613425, 17258.827411725848, 2207.260567709819, 2247.224707475918, 2270.829687773407, 2272.4773302140434, 2279.8290128240446, 111971.44014279958, 112003.0, 114969.4251528737, 118591.0, 118756.40621796923, 11504.884951150549, 11522.942385288188, 11955.88044119565, 11970.099734175577, 11988.820167697491, 16713.164341782864, 16796.748048779278, 16877.286996860672, 16890.915545422195, 16911.661766764595, 8756.25571826402, 8821.735347939572, 8926.330525210506, 9034.774130646787, 9191.264698824212, 8280.296174825087, 8336.874946875801, 8493.830123397498, 8524.445911015764, 8568.0, 7426.960225568425, 7675.577843218565, 7683.692652293846, 7724.7682569523, 7789.454738168387, 2105.147415296807, 2135.775743546936, 2143.699882016519, 2149.322963266566, 2295.1049090854244, 931.990680093204, 982.9066238707311, 988.6935050134481, 989.7674046599044, 1000.8148492528906, 19230.807691923183, 20143.0935607898, 20202.595948080954, 20206.696899546518, 20428.18287268522, 1003.3027046202819, 1003.7340104872214, 1006.6225165562914, 1018.7758693087509, 1021.9693409197736, 10844.457777111113, 10987.61543345979, 11129.332240065622, 11152.163587730953, 11170.329780213213, 409270.0, 412178.0, 415076.0, 422304.0, 422422.0, 96297.5185124084, 97207.0, 97292.0, 97811.0, 98464.50767746115, 1025.3027941000043, 1098.5770478365887, 1158.3050169897995, 1179.2983175010854, 1194.0089725527791, 19650.0, 19682.90158549198, 20550.897245513675, 20618.07218675133, 20994.160233590486, 45945.77027114843, 46099.3085103717, 46445.0, 47154.76422618002, 47267.29099063448, 57222.713886431964, 57540.42459575518, 58215.70892145512, 58503.4149658498, 58622.7068864653, 10168.796624067625, 10343.586256549654, 10354.844677329695, 10360.792784144425, 10378.117859981685, 17222.311107555557, 17534.386296479563, 17600.119994000506, 17608.38370657021, 17665.205065772327, 14596.0, 14706.0, 14810.333534990736, 14815.111093334435, 14860.256987150815, 12686.555970540987, 12833.550825721428, 13344.199348039148, 13596.86403135956, 13810.723785524435, 14657.70684586281, 14955.775663365275, 15133.167675777497, 15153.090814551162, 15387.0, 10231.795364092528, 10319.896801032193, 10327.586896524055, 10349.793004140025, 10356.30736008628, 14734.926325368304, 14891.255437228312, 14907.031042982171, 14975.925120374328, 15053.397864085751], "value": 10343.123744616456, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1268.2263819070365, 1302.069020650235, 1323.4507679313085, 1329.6808765896183, 1332.3937608388185, 10827.729306767325, 11056.447177641126, 11367.886321136786, 11375.374354410504, 11431.54273829048, 11114.11087113029, 11305.434728263595, 11340.489677964491, 11359.886401135986, 11399.772004559904, 2293.8279629027807, 2353.2704861492994, 2355.564220619191, 2363.09021026905, 2365.06579900939, 2268.9092436302526, 2303.6544518322216, 2315.235972129193, 2326.499802542453, 2336.6144586143264, 2234.430220293823, 2257.2325409360815, 2269.7389800172946, 2272.5114100468395, 2277.089164334263, 2186.365953873375, 2207.1171531387413, 2212.4911270407815, 2214.3799736073843, 2219.922302719397, 2047.0890453748088, 2169.609470295346, 2184.5084855907453, 2186.2238905188747, 2187.3984654220217, 10950.0, 11048.171387145996, 11054.060404865597, 11057.944710276477, 11063.502142403611, 5997.850053748692, 6164.4143806338325, 6199.132121502948, 6234.563580549363, 6240.563160578761, 3614.5301110855685, 3716.2567486502808, 3742.4760533525327, 3751.6998640108727, 3759.924801503982, 1205.6684411786741, 1219.5731493977037, 1249.5813902342727, 1263.387257180267, 1272.249372870011, 15638.13990230537, 15647.217639117998, 15791.131487768052, 15817.209139543093, 15867.0, 5125.077486052472, 5133.486651334837, 5183.844484665466, 5256.842294731164, 5289.338832645919, 11913.761724765456, 11939.283642981449, 11939.403029848472, 11947.641570752892, 11951.04391648666, 5836.649801011953, 5887.76448942046, 5893.086571581412, 5897.64614123154, 5923.555733320019, 5474.233607294982, 5545.639533430314, 5547.195656629847, 5556.472135147154, 5564.8330550083565, 4140.855070072533, 4166.23758734829, 4212.073343864345, 4241.406203131564, 4242.321228603409, 1174.5243176513525, 1195.7728031673955, 1196.3121205306984, 1211.1340391620033, 1211.95152193913, 762.5386641082176, 792.0811858244409, 796.0, 799.2726618776885, 840.1514470384956, 6453.612783233021, 6792.558483698544, 7018.719251229996, 7078.292170782984, 7351.0963169548795, 953.6519170502717, 990.5938565188238, 1006.8238058339762, 1007.2697294461603, 1011.0, 4308.18144552534, 4529.252673308933, 4551.7710218241555, 4567.063751930847, 4676.719396836201, 13848.723025539433, 13881.167129972033, 14065.0, 14133.15201087938, 14613.707725845636, 13284.0, 13743.862561374459, 13807.102538334975, 13819.0, 13839.654008649864, 8583.227509524173, 8979.730608081769, 8997.505137217386, 9000.729978100668, 9005.954970225106, 6381.521385896169, 6516.152900122954, 6537.248216455168, 6607.0, 6624.900626490703, 12435.637228926475, 12641.683957901127, 12719.300438475973, 12902.0, 12916.418761155583, 12736.872631273569, 12847.421866015864, 12861.0, 12998.0, 13076.476940922257, 9862.063104005108, 10272.743181420525, 10349.379037257788, 10405.895941040493, 10574.682759517227, 10520.579176833147, 10587.36475811423, 10604.310719803496, 10639.0, 10673.839892401465, 8599.140085991601, 8628.439151455135, 8894.955525222333, 9057.09429057089, 9064.773380665272, 8022.759317220492, 8059.395545334006, 8085.272325490734, 8175.918240817516, 8182.7545173644885, 7290.9635451822405, 7433.368163706145, 7472.589007604416, 7476.850462990818, 7483.0, 5491.341039075336, 5648.293963254593, 5659.292588426447, 5752.108423194244, 5846.093855452412, 5626.130673356536, 5763.4812866842185, 5796.159556864147, 5841.883162336644, 5870.354261031198], "value": 5153.058422584516, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.4354201720531, 394.4359565820876, 398.23340070364543, 402.9294873397155, 406.5121853775469, 6099.969500152493, 6115.541334399915, 6121.846953826151, 6140.416660417259, 6265.686715664221, 5952.494038006775, 6044.909326360097, 6048.637081775097, 6056.970315046442, 6106.206193194889, 4660.324252983315, 4781.282807578857, 4781.999999999991, 4799.832005879794, 4799.976000119995, 4807.509672001674, 4820.566149046585, 4830.686005409655, 4840.0, 4847.733374664392, 4750.76246187691, 4754.762261886892, 4759.5240475952305, 4768.094062128202, 4774.618030557564, 4746.335513028179, 4764.523547645243, 4768.499307572724, 4772.16487114757, 4780.713157210578, 4218.831246750126, 4219.11398606293, 4222.809973551167, 4224.260754367973, 4228.9788551057045, 6045.153678484971, 6076.422739839708, 6079.939200607982, 6080.179175811298, 6096.298925623521, 5407.459254074601, 5438.53772429344, 5456.0, 5470.0, 5483.643563168382, 6427.7465894150655, 6427.935720642828, 6472.546921715481, 6477.578957367756, 6484.383983521558, 4535.659825513099, 4554.203014472487, 4556.04323092151, 4559.658025648089, 4565.885852853672, 6463.385978332051, 6678.866422671519, 6810.182778066664, 6845.931540684579, 6892.483063770187, 4352.412424322739, 4576.748278844696, 4601.907961840744, 4606.769661516911, 4624.745638989821, 4639.211334073216, 4653.395058642355, 4667.61951404786, 4669.34629151919, 4679.81280748773, 5224.346956630421, 5315.04329220744, 5360.544353729899, 5380.0, 5385.6230063895155, 6407.327230640809, 6475.805725828139, 6489.935100649028, 6508.869822603521, 6515.0, 1620.6953402511092, 1621.0, 1625.4635970130066, 1627.4466681328406, 1632.6816270827076, 1054.3779170289565, 1082.9729256768644, 1096.7203363142348, 1098.6319582939805, 1102.5038732570376, 5664.461876121762, 5742.856428589319, 5744.195812586241, 5761.3950535194035, 5772.913406298909, 6592.846251905898, 6673.165854268216, 6674.332566743286, 6676.132102826601, 6711.6979735912, 5632.4930756231315, 5710.143478478261, 5721.284839395075, 5730.111832665943, 5730.856728581819, 3545.397282461936, 3554.3424466473784, 3574.4995700601935, 3586.5875424326014, 3608.0979755061235, 6388.201474815648, 6403.423691867754, 6440.194975628046, 6492.902606460907, 6504.577202481823, 6793.660316984131, 6821.522493425512, 6848.760293389708, 6853.554518956252, 6884.759033433806, 6402.8719425611225, 6415.871682566322, 6432.260290066609, 6464.709088090953, 6524.117056505433, 6599.4720422365135, 6665.100211471389, 6708.563943343667, 6713.395794378529, 6747.831304217434, 6647.434968027772, 6682.131322927989, 6690.297518760654, 6696.59820410777, 6704.262531121671, 6264.31092579825, 6300.653464059521, 6459.547831651739, 6488.935110648833, 6542.8364290893105, 4610.815567377267, 4617.607503362117, 4618.538146185355, 4626.37543931565, 4632.72203667781, 6672.266050734513, 6680.63256520896, 6681.5656982296, 6688.531802773759, 6718.630475323904, 6450.774222902176, 6491.902621460587, 6497.350264973654, 6510.153680021567, 6526.543141980016, 6455.225372955276, 6474.1907261592305, 6480.125183100221, 6483.643399613066, 6491.935080649133, 6315.873682526416, 6437.25971513282, 6438.8390290243115, 6465.806025819233, 6477.708503117466, 6519.478441724746, 6532.346765323429, 6538.705758240795, 6540.444062254572, 6550.8362290943105, 6327.746890124527, 6338.65137417428, 6355.841103972438, 6359.109724638647, 6362.363763623601], "value": 4881.621864197463, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [808.6563210635478, 834.9666013359466, 835.319214839905, 846.2003406780591, 858.5020688000958, 15588.22058897055, 15965.201739913002, 15994.60013499663, 17423.651526969454, 19061.237550497965, 18312.725309120342, 18410.907945460254, 18697.532561685966, 18709.34517291895, 18722.157502912367, 974.5663179884954, 997.1823105053859, 997.546116516983, 997.5511020040974, 1002.0630710285869, 892.3040028777532, 991.861139440479, 1007.8840933292655, 1013.4527355228167, 1015.1320620869161, 1064.5369264369986, 1067.9572817087308, 1068.7167900506372, 1069.1286601419818, 1073.9463026848666, 1041.8333066709329, 1042.8175069362908, 1042.989570104297, 1044.269011691815, 1048.030571721155, 763.4999075605488, 763.5647680821934, 764.6253335865441, 767.301755402581, 767.5049593012476, 16007.0, 16901.154942252837, 17041.7443738344, 17152.22814973329, 17168.14159292043, 18938.81061189384, 18996.770549006702, 19390.612187756167, 19399.0, 19541.218351265932, 15248.085114893142, 15428.768568471482, 15457.304421301069, 15464.922675386664, 15480.458183963507, 3357.1103657530775, 3444.621091679913, 3455.533502977091, 3532.3994920863515, 3533.6819686228364, 83555.5822220885, 86058.0, 86271.0, 86610.0, 87105.56447217724, 13678.316084195949, 13979.440822367194, 14118.505852295326, 14136.575902722934, 14204.0, 23832.64251036236, 23838.642420363707, 24587.87706061458, 26512.60231096535, 26997.730022699914, 7801.102873169544, 7810.57041862703, 8110.959445202854, 8139.064007639197, 8213.301869341172, 3813.694904407641, 3892.143728379752, 3934.429507721364, 3947.9013024674614, 3948.2498325318097, 4006.8597599084474, 4018.0557568971267, 4055.2903241932545, 4075.2664520386024, 4189.706720529533, 788.9723859664999, 798.2935102434387, 806.1736719862188, 809.3201710563037, 809.5466538738325, 667.259342130235, 677.6340775980915, 691.2707094015861, 707.8478127202676, 710.6944014073998, 10794.082502987178, 11425.542978280775, 11566.47950842214, 11670.824937625943, 12238.449269782881, 682.8361193313569, 684.2404930527111, 687.3367200651395, 698.3261152987392, 700.184285307621, 5432.266644003009, 5641.210230567724, 5698.458646428583, 5750.108733146369, 5776.797812076557, 91160.54419727992, 91961.0, 92005.53997230105, 95107.52446237725, 96915.0, 81051.59474202592, 84160.57919710362, 84217.57891210627, 84367.0, 86038.13961860427, 72645.27354726491, 72757.63621181861, 72913.6354318225, 73067.0, 73340.5658349286, 10633.308834925705, 10651.147908167482, 11284.774304514029, 11430.085593152362, 11621.6513504595, 28167.859160704065, 28650.856745716137, 30710.69289307168, 31627.841860790548, 31981.200469988435, 51806.74096629493, 51992.0, 53108.468915311896, 53837.73081134569, 55076.0, 16608.66782664316, 16864.494065178063, 16998.915005424893, 17311.56721081983, 17562.912185438992, 16565.668686626443, 19058.237670493025, 19801.801981979996, 19835.702464463335, 19996.20015199376, 17411.564710881823, 17673.91163044228, 17724.6304271336, 17735.82264177342, 18125.184366703266, 17256.482305530855, 17278.22247998818, 17596.29614815393, 17687.469375918743, 17701.203445845225, 16131.0, 16389.508314750576, 16540.503784886474, 16830.242639081516, 16910.830891690926, 11150.330980141218, 11248.918949994277, 11377.374244416305, 11564.94217528907, 12116.21244619097, 12391.93804030974, 12800.871991279968, 12819.551315703906, 12947.093703441045, 12971.740565188833], "value": 8236.221026363539, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 111.0, 111.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 121.0, 122.0, 162.0, 131.0, 122.0, 131.0, 129.0, 145.0, 122.0], "value": 133.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 164.0, 162.0, 164.0, 164.0, 168.0, 171.0, 166.0, 162.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 74.0, 111.0, 78.0, 74.0, 76.0, 74.0, 96.0, 76.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 101.0, 82.0, 82.0, 82.0, 106.0, 82.0, 83.0, 108.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 114.0, 114.0, 114.0, 113.0, 114.0, 118.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 151.0, 150.0, 155.0, 155.0, 152.0, 149.0, 150.0, 151.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 97.0, 99.0, 97.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 54.0, 56.0, 57.0, 61.0, 60.0, 57.0, 56.0, 55.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 58.0, 60.0, 57.0, 56.0, 56.0, 56.0, 56.0], "value": 56.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 88.0, 88.0, 98.0, 88.0, 88.0, 89.0, 121.0, 90.0], "value": 92.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 143.0, 137.0, 140.0, 130.0, 136.0, 133.0, 132.0, 137.0, 141.0], "value": 136.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 192.0, 188.0, 204.0, 198.0, 199.0, 202.0, 197.0, 194.0, 194.0], "value": 195.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 74.0, 78.0, 74.0, 73.0, 75.0, 71.0, 73.0, 79.0], "value": 74.1, "unit": "score"}]}]} 09:27:43 INFO - Return code: 0 09:27:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:27:43 INFO - # TBPL SUCCESS # 09:27:43 INFO - Running post-action listener: _resource_record_post_action 09:27:43 INFO - [mozharness: 2017-06-02 16:27:43.999299Z] Finished run-tests step (success) 09:27:43 INFO - Running post-run listener: _resource_record_post_run 09:27:44 INFO - Total resource usage - Wall time: 1253s; CPU: 13.0%; Read bytes: 4096; Write bytes: 433987584; Read time: 12; Write time: 280852 09:27:44 INFO - TinderboxPrint: CPU usage
12.7% 09:27:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:27:44 INFO - TinderboxPrint: I/O write bytes / time
433,987,584 / 280,852 09:27:44 INFO - TinderboxPrint: CPU idle
8,731.4 (87.3%) 09:27:44 INFO - TinderboxPrint: CPU user
1,216.9 (12.2%) 09:27:44 INFO - TinderboxPrint: Swap in / out
0 / 0 09:27:44 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105242624; Read time: 0; Write time: 76896 09:27:44 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:27:44 INFO - run-tests - Wall time: 1236s; CPU: 13.0%; Read bytes: 4096; Write bytes: 328744960; Read time: 12; Write time: 203956 09:27:44 INFO - Running post-run listener: _upload_blobber_files 09:27:44 INFO - Blob upload gear active. 09:27:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:27:44 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 09:27:44 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'] 09:27:44 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 09:27:45 INFO - (blobuploader) - INFO - Open directory for files ... 09:27:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:27:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:27:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:45 INFO - (blobuploader) - INFO - Done attempting. 09:27:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:27:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:27:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:46 INFO - (blobuploader) - INFO - Done attempting. 09:27:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:27:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:27:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:47 INFO - (blobuploader) - INFO - Done attempting. 09:27:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:27:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:27:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:54 INFO - (blobuploader) - INFO - Done attempting. 09:27:54 INFO - (blobuploader) - INFO - Iteration through files over. 09:27:54 INFO - Return code: 0 09:27:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:27:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:27:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4711757bcf45efb0abd13527d160adb1825cba6461124f57f9a5fc07363b46fe3815d34ac238d00393ca744024258e95ea861e88b6b3c140bb3b03e638d0eeab", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5b293c3d6b4e553e3cc95db7e6f33fd41b448cbb947e7818589c3efe2b42b3a73eef97e4f472a71b60123cc3e31a5644f5bc49b482cd100cf65170035433fd1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54d10649dc7695323d944e0d128f502ecb44db65ed89b2a054cc6cb8475973f155f4e2f8ec5b630c2f3ec22bcc3c227cc51774563081403f54509531abe59cc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8bd709a7d29a4f814c5763304d9ff9e4d9bc23c3306b38909b69dc032b26f69cc34a95bf204a824452fbecdf39842c313c1f47c8e3540a27e9ff0089ed409514"} 09:27:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:27:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:27:54 INFO - Contents: 09:27:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4711757bcf45efb0abd13527d160adb1825cba6461124f57f9a5fc07363b46fe3815d34ac238d00393ca744024258e95ea861e88b6b3c140bb3b03e638d0eeab", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5b293c3d6b4e553e3cc95db7e6f33fd41b448cbb947e7818589c3efe2b42b3a73eef97e4f472a71b60123cc3e31a5644f5bc49b482cd100cf65170035433fd1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54d10649dc7695323d944e0d128f502ecb44db65ed89b2a054cc6cb8475973f155f4e2f8ec5b630c2f3ec22bcc3c227cc51774563081403f54509531abe59cc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8bd709a7d29a4f814c5763304d9ff9e4d9bc23c3306b38909b69dc032b26f69cc34a95bf204a824452fbecdf39842c313c1f47c8e3540a27e9ff0089ed409514"} 09:27:54 INFO - Running post-run listener: copy_logs_to_upload_dir 09:27:54 INFO - Copying logs to upload dir... 09:27:54 INFO - mkdir: /builds/slave/test/build/upload/logs 09:27:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1322.063168 ========= master_lag: -0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 1 secs) (at 2017-06-02 09:27:53.080195) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-02 09:27:53.088381) ========= 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=652eb03db935cfc1c15ebda0000001ad-1496414264.41676-2066923055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4711757bcf45efb0abd13527d160adb1825cba6461124f57f9a5fc07363b46fe3815d34ac238d00393ca744024258e95ea861e88b6b3c140bb3b03e638d0eeab", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5b293c3d6b4e553e3cc95db7e6f33fd41b448cbb947e7818589c3efe2b42b3a73eef97e4f472a71b60123cc3e31a5644f5bc49b482cd100cf65170035433fd1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54d10649dc7695323d944e0d128f502ecb44db65ed89b2a054cc6cb8475973f155f4e2f8ec5b630c2f3ec22bcc3c227cc51774563081403f54509531abe59cc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8bd709a7d29a4f814c5763304d9ff9e4d9bc23c3306b38909b69dc032b26f69cc34a95bf204a824452fbecdf39842c313c1f47c8e3540a27e9ff0089ed409514"} build_url:https://queue.taskcluster.net/v1/task/Rr3ks4M4TnOJbo_UN4UqNg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011456 build_url: 'https://queue.taskcluster.net/v1/task/Rr3ks4M4TnOJbo_UN4UqNg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4711757bcf45efb0abd13527d160adb1825cba6461124f57f9a5fc07363b46fe3815d34ac238d00393ca744024258e95ea861e88b6b3c140bb3b03e638d0eeab", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5b293c3d6b4e553e3cc95db7e6f33fd41b448cbb947e7818589c3efe2b42b3a73eef97e4f472a71b60123cc3e31a5644f5bc49b482cd100cf65170035433fd1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54d10649dc7695323d944e0d128f502ecb44db65ed89b2a054cc6cb8475973f155f4e2f8ec5b630c2f3ec22bcc3c227cc51774563081403f54509531abe59cc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8bd709a7d29a4f814c5763304d9ff9e4d9bc23c3306b38909b69dc032b26f69cc34a95bf204a824452fbecdf39842c313c1f47c8e3540a27e9ff0089ed409514"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-02 09:27:53.115653) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 09:27:53.115985) ========= 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=652eb03db935cfc1c15ebda0000001ad-1496414264.41676-2066923055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 09:27:53.196745) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-02 09:27:53.200074) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-02 09:27:53.200386) ========= ========= Total master_lag: 0.08 =========