builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-075 starttime: 1495948729.13 results: success (0) revision: 6a235092bda7c20cb83651d3404284fe36d04c1b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-27 22:18:49.131443) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-27 22:18:49.131829) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-27 22:18:49.132104) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-27 22:18:49.276472) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 22:18:49.279151) ========= 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=fcadb68e09dcf59683000ff6000001dc-1495936891.696796-806549916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-27 22:18: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% 40.7M=0s 2017-05-27 22:18:50 (40.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.150037 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 22:18:49.465872) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 22:18:49.466169) ========= 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=fcadb68e09dcf59683000ff6000001dc-1495936891.696796-806549916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014333 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 22:18:49.527416) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 22:18:49.527722) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6a235092bda7c20cb83651d3404284fe36d04c1b --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 6a235092bda7c20cb83651d3404284fe36d04c1b --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=fcadb68e09dcf59683000ff6000001dc-1495936891.696796-806549916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-27 22:18:50,404 truncating revision to first 12 chars 2017-05-27 22:18:50,404 Setting DEBUG logging. 2017-05-27 22:18:50,404 attempt 1/10 2017-05-27 22:18:50,404 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6a235092bda7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-27 22:18:50,915 unpacking tar archive at: mozilla-central-6a235092bda7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.811496 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 22:18:50.364572) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-27 22:18:50.364865) ========= script_repo_revision: 6a235092bda7c20cb83651d3404284fe36d04c1b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-27 22:18:50.365243) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-27 22:18:50.365535) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-27 22:18:50.378772) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 5 secs) (at 2017-05-27 22:18:50.379157) ========= /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=fcadb68e09dcf59683000ff6000001dc-1495936891.696796-806549916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:18:51 INFO - MultiFileLogger online at 20170527 22:18:51 in /builds/slave/test 22:18:51 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 22:18:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:18:51 INFO - {'append_to_log': False, 22:18:51 INFO - 'base_work_dir': '/builds/slave/test', 22:18:51 INFO - 'blob_upload_branch': 'Firefox', 22:18:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:18:51 INFO - 'branch': 'Firefox', 22:18:51 INFO - 'buildbot_json_path': 'buildprops.json', 22:18:51 INFO - 'config_files': ('talos/linux_config.py',), 22:18:51 INFO - 'default_actions': ('clobber', 22:18:51 INFO - 'read-buildbot-config', 22:18:51 INFO - 'download-and-extract', 22:18:51 INFO - 'populate-webroot', 22:18:51 INFO - 'create-virtualenv', 22:18:51 INFO - 'install', 22:18:51 INFO - 'setup-mitmproxy', 22:18:51 INFO - 'run-tests'), 22:18:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:18:51 INFO - 'download_minidump_stackwalk': True, 22:18:51 INFO - 'download_symbols': 'ondemand', 22:18:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:18:51 INFO - 'tooltool.py': '/tools/tooltool.py', 22:18:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:18:51 INFO - '/tools/misc-python/virtualenv.py')}, 22:18:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:18:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:18:51 INFO - 'gecko_profile': False, 22:18:51 INFO - 'gecko_profile_interval': 0, 22:18:51 INFO - 'installer_path': 'installer.exe', 22:18:51 INFO - 'log_level': 'info', 22:18:51 INFO - 'log_name': 'talos', 22:18:51 INFO - 'log_to_console': True, 22:18:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:18:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:18:51 INFO - 'opt_config_files': (), 22:18:51 INFO - 'pip_index': False, 22:18:51 INFO - 'suite': 'dromaeojs-e10s', 22:18:51 INFO - 'system_bits': '32', 22:18:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:18:51 INFO - 'title': 'talos-linux64-ix-075', 22:18:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:18:51 INFO - 'use_talos_json': True, 22:18:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:18:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:18:51 INFO - 'work_dir': 'build'} 22:18:51 INFO - [mozharness: 2017-05-28 05:18:51.345966Z] Running clobber step. 22:18:51 INFO - Running pre-action listener: _resource_record_pre_action 22:18:51 INFO - Running main action method: clobber 22:18:51 INFO - rmtree: /builds/slave/test/build 22:18:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:18:52 INFO - Running post-action listener: _resource_record_post_action 22:18:52 INFO - [mozharness: 2017-05-28 05:18:52.883019Z] Finished clobber step (success) 22:18:52 INFO - [mozharness: 2017-05-28 05:18:52.883120Z] Running read-buildbot-config step. 22:18:52 INFO - Running pre-action listener: _resource_record_pre_action 22:18:52 INFO - Running main action method: read_buildbot_config 22:18:52 INFO - Using buildbot properties: 22:18:52 INFO - { 22:18:52 INFO - "project": "", 22:18:52 INFO - "product": "firefox", 22:18:52 INFO - "who": "philringnalda@gmail.com", 22:18:52 INFO - "installer_path": "public/build/target.tar.bz2", 22:18:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 22:18:52 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 22:18:52 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 22:18:52 INFO - "stage_platform": "linux64-stylo", 22:18:52 INFO - "basedir": "/builds/slave/test", 22:18:52 INFO - "buildnumber": 125, 22:18:52 INFO - "platform": "ubuntu64_hw_stylo", 22:18:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:18:52 INFO - "slavebuilddir": "test", 22:18:52 INFO - "taskId": "OKtKEXq8Q4-OIx9POXStlw", 22:18:52 INFO - "branch": "mozilla-central", 22:18:52 INFO - "script_repo_revision": "production", 22:18:52 INFO - "revision": "6a235092bda7c20cb83651d3404284fe36d04c1b", 22:18:52 INFO - "slavename": "talos-linux64-ix-075", 22:18:52 INFO - "repo_path": "mozilla-central" 22:18:52 INFO - } 22:18:52 INFO - Finding installer, test and symbols from parent task. 22:18:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OKtKEXq8Q4-OIx9POXStlw'}, attempt #1 22:18:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OKtKEXq8Q4-OIx9POXStlw'}, attempt #1 22:18:53 INFO - Task dependencies: ZBc7qSKBRC-nGb-P0BBYsg 22:18:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZBc7qSKBRC-nGb-P0BBYsg'}, attempt #1 22:18:54 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZBc7qSKBRC-nGb-P0BBYsg/artifacts/public/build/target.tar.bz2 22:18:54 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ZBc7qSKBRC-nGb-P0BBYsg/artifacts/public/build/test_packages.json 22:18:54 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZBc7qSKBRC-nGb-P0BBYsg/artifacts/public/build/target.crashreporter-symbols.zip 22:18:54 INFO - Running post-action listener: _resource_record_post_action 22:18:54 INFO - [mozharness: 2017-05-28 05:18:54.224783Z] Finished read-buildbot-config step (success) 22:18:54 INFO - [mozharness: 2017-05-28 05:18:54.225003Z] Running download-and-extract step. 22:18:54 INFO - Running pre-action listener: _resource_record_pre_action 22:18:54 INFO - Running main action method: download_and_extract 22:18:54 INFO - mkdir: /builds/slave/test/build/tests 22:18: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')]} 22:18:54 INFO - trying https://queue.taskcluster.net/v1/task/ZBc7qSKBRC-nGb-P0BBYsg/artifacts/public/build/target.test_packages.json 22:18:54 INFO - Downloading https://queue.taskcluster.net/v1/task/ZBc7qSKBRC-nGb-P0BBYsg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 22:18:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZBc7qSKBRC-nGb-P0BBYsg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 22:18:54 INFO - Downloaded 986 bytes. 22:18:54 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 22:18:54 INFO - Using the following test package requirements: 22:18:54 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 22:18:54 INFO - u'common': [u'target.common.tests.zip'], 22:18:54 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 22:18:54 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 22:18:54 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 22:18:54 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 22:18:54 INFO - u'mozbase': [u'target.common.tests.zip'], 22:18:54 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 22:18:54 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 22:18:54 INFO - u'web-platform': [u'target.common.tests.zip', 22:18:54 INFO - u'target.web-platform.tests.zip'], 22:18:54 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 22:18:54 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 22:18:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZBc7qSKBRC-nGb-P0BBYsg/artifacts/public/build/target.common.tests.zip 22:18:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZBc7qSKBRC-nGb-P0BBYsg/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:18:54 INFO - Fetch https://queue.taskcluster.net/v1/task/ZBc7qSKBRC-nGb-P0BBYsg/artifacts/public/build/target.common.tests.zip into memory 22:18:57 INFO - Content-Length response header: 63527023 22:18:57 INFO - Bytes received: 63527023 22:19:08 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 22:19:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZBc7qSKBRC-nGb-P0BBYsg/artifacts/public/build/target.common.tests.zip 22:19:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZBc7qSKBRC-nGb-P0BBYsg/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:19:08 INFO - Fetch https://queue.taskcluster.net/v1/task/ZBc7qSKBRC-nGb-P0BBYsg/artifacts/public/build/target.common.tests.zip into memory 22:19:10 INFO - Content-Length response header: 63527023 22:19:10 INFO - Bytes received: 63527023 22:19:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZBc7qSKBRC-nGb-P0BBYsg/artifacts/public/build/target.talos.tests.zip 22:19:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZBc7qSKBRC-nGb-P0BBYsg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 22:19:22 INFO - Fetch https://queue.taskcluster.net/v1/task/ZBc7qSKBRC-nGb-P0BBYsg/artifacts/public/build/target.talos.tests.zip into memory 22:19:23 INFO - Content-Length response header: 14447425 22:19:23 INFO - Bytes received: 14447425 22:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:23 INFO - trying https://queue.taskcluster.net/v1/task/ZBc7qSKBRC-nGb-P0BBYsg/artifacts/public/build/target.tar.bz2 22:19:23 INFO - Downloading https://queue.taskcluster.net/v1/task/ZBc7qSKBRC-nGb-P0BBYsg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 22:19:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZBc7qSKBRC-nGb-P0BBYsg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 22:19:26 INFO - Downloaded 55969801 bytes. 22:19:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZBc7qSKBRC-nGb-P0BBYsg/artifacts/public/build/target.tar.bz2 22:19:26 INFO - mkdir: /builds/slave/test/properties 22:19:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:19:26 INFO - Writing to file /builds/slave/test/properties/build_url 22:19:26 INFO - Contents: 22:19:26 INFO - build_url:https://queue.taskcluster.net/v1/task/ZBc7qSKBRC-nGb-P0BBYsg/artifacts/public/build/target.tar.bz2 22:19:26 INFO - Running post-action listener: _resource_record_post_action 22:19:26 INFO - Running post-action listener: set_extra_try_arguments 22:19:26 INFO - [mozharness: 2017-05-28 05:19:26.503871Z] Finished download-and-extract step (success) 22:19:26 INFO - [mozharness: 2017-05-28 05:19:26.504099Z] Running populate-webroot step. 22:19:26 INFO - Running pre-action listener: _resource_record_pre_action 22:19:26 INFO - Running main action method: populate_webroot 22:19:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:19:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:19:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:19:26 INFO - '--tppagecycles', 22:19:26 INFO - '7'], 22:19:26 INFO - 'tests': ['tsvgm']}}, 22:19:26 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:19:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:19:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:19:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:19:26 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:19:26 INFO - 'talos_options': ['--disable-e10s'], 22:19:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:19:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:19:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:19:26 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:19:26 INFO - 'talos_options': ['--disable-e10s'], 22:19:26 INFO - 'tests': ['damp', 'tps']}, 22:19:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:19:26 INFO - 'tests': ['damp', 'tps']}, 22:19:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:19:26 INFO - 'tests': ['dromaeo_dom']}, 22:19:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:19:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:19:26 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 22:19:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 22:19:26 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 22:19:26 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 22:19:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:19:26 INFO - 'tests': ['a11yr', 22:19:26 INFO - 'ts_paint', 22:19:26 INFO - 'tpaint', 22:19:26 INFO - 'sessionrestore', 22:19:26 INFO - 'sessionrestore_no_auto_restore', 22:19:26 INFO - 'tabpaint']}, 22:19:26 INFO - 'other-e10s': {'tests': ['a11yr', 22:19:26 INFO - 'ts_paint', 22:19:26 INFO - 'tpaint', 22:19:26 INFO - 'sessionrestore', 22:19:26 INFO - 'sessionrestore_no_auto_restore', 22:19:26 INFO - 'tabpaint']}, 22:19:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:19:26 INFO - 'ts_paint', 22:19:26 INFO - 'tpaint', 22:19:26 INFO - 'sessionrestore', 22:19:26 INFO - 'sessionrestore_no_auto_restore', 22:19:26 INFO - 'tabpaint']}, 22:19:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:19:26 INFO - 'ts_paint', 22:19:26 INFO - 'tpaint', 22:19:26 INFO - 'sessionrestore', 22:19:26 INFO - 'sessionrestore_no_auto_restore', 22:19:26 INFO - 'tabpaint']}, 22:19:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:19:26 INFO - 'tests': ['a11yr', 22:19:26 INFO - 'ts_paint', 22:19:26 INFO - 'tpaint', 22:19:26 INFO - 'sessionrestore', 22:19:26 INFO - 'sessionrestore_no_auto_restore', 22:19:26 INFO - 'tabpaint']}, 22:19:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:19:26 INFO - 'tests': ['a11yr', 22:19:26 INFO - 'ts_paint', 22:19:26 INFO - 'tpaint', 22:19:26 INFO - 'sessionrestore', 22:19:26 INFO - 'sessionrestore_no_auto_restore', 22:19:26 INFO - 'tabpaint']}, 22:19:26 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 22:19:26 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 22:19:26 INFO - 'bloom_basic_ref']}, 22:19:26 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 22:19:26 INFO - 'talos_options': ['--mitmproxy', 22:19:26 INFO - 'mitmproxy-recording-1.mp', 22:19:26 INFO - '--firstNonBlankPaint'], 22:19:26 INFO - 'tests': ['Quantum_1']}, 22:19:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:19:26 INFO - 'tests': ['tsvgx', 22:19:26 INFO - 'tsvgr_opacity', 22:19:26 INFO - 'tart', 22:19:26 INFO - 'tscrollx', 22:19:26 INFO - 'cart', 22:19:26 INFO - 'tsvg_static']}, 22:19:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:19:26 INFO - 'tsvgr_opacity', 22:19:26 INFO - 'tart', 22:19:26 INFO - 'tscrollx', 22:19:26 INFO - 'cart', 22:19:26 INFO - 'tsvg_static']}, 22:19:26 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:19:26 INFO - 'talos_options': ['--disable-e10s'], 22:19:26 INFO - 'tests': ['tp5o']}, 22:19:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:19:26 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:19:26 INFO - 'talos_options': ['--disable-e10s', 22:19:26 INFO - '--xperf_path', 22:19:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:19:26 INFO - 'tests': ['tp5n']}, 22:19:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:19:26 INFO - 'talos_options': ['--xperf_path', 22:19:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:19:26 INFO - 'tests': ['tp5n']}}, 22:19:26 INFO - 'talos.zip': {'path': '', 22:19:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:19:26 INFO - Running post-action listener: _resource_record_post_action 22:19:26 INFO - [mozharness: 2017-05-28 05:19:26.524247Z] Finished populate-webroot step (success) 22:19:26 INFO - [mozharness: 2017-05-28 05:19:26.524341Z] Running create-virtualenv step. 22:19:26 INFO - Running pre-action listener: _resource_record_pre_action 22:19:26 INFO - Running main action method: create_virtualenv 22:19:26 INFO - Creating virtualenv /builds/slave/test/build/venv 22:19:26 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 22:19:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:19:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:19:26 INFO - Using real prefix '/usr' 22:19:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:19:27 INFO - Installing distribute.............................................................................................................................................................................................done. 22:19:29 INFO - Installing pip.................done. 22:19:29 INFO - Return code: 0 22:19:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:19:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:19:29 INFO - Reading from file tmpfile_stdout 22:19:29 INFO - Output received: 22:19:29 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) 22:19:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:19:29 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')]} 22:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:29 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')]} 22:19:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:29 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 0x227d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2457a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25faef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f7e40>, '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 0x25f8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f9440>, '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': 'fcadb68e09dcf59683000ff6000001dc-1495936891.696796-806549916', '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 22:19:29 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 22:19:29 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 22:19:29 INFO - Using env: {'DISPLAY': ':0', 22:19:29 INFO - 'HOME': '/home/cltbld', 22:19:29 INFO - 'LANG': 'en_US.UTF-8', 22:19:29 INFO - 'LANGUAGE': 'en_US:en', 22:19:29 INFO - 'LOGNAME': 'cltbld', 22:19:29 INFO - 'MAIL': '/var/mail/cltbld', 22:19:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:29 INFO - 'MOZ_NO_REMOTE': '1', 22:19:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:29 INFO - 'NO_EM_RESTART': '1', 22:19:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:29 INFO - 'PWD': '/builds/slave/test', 22:19:29 INFO - 'SHELL': '/bin/bash', 22:19:29 INFO - 'SHLVL': '1', 22:19:29 INFO - 'TERM': 'linux', 22:19:29 INFO - 'TMOUT': '86400', 22:19:29 INFO - 'USER': 'cltbld', 22:19:29 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1495936891.696796-806549916', 22:19:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:29 INFO - '_': '/tools/buildbot/bin/python'} 22:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:29 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 22:19:29 INFO - Cleaning up... 22:19:29 INFO - Return code: 0 22:19:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:19:29 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')]} 22:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:29 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')]} 22:19:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:29 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 0x227d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2457a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25faef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f7e40>, '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 0x25f8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f9440>, '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': 'fcadb68e09dcf59683000ff6000001dc-1495936891.696796-806549916', '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 22:19:29 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 22:19:29 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 22:19:29 INFO - Using env: {'DISPLAY': ':0', 22:19:29 INFO - 'HOME': '/home/cltbld', 22:19:29 INFO - 'LANG': 'en_US.UTF-8', 22:19:29 INFO - 'LANGUAGE': 'en_US:en', 22:19:29 INFO - 'LOGNAME': 'cltbld', 22:19:29 INFO - 'MAIL': '/var/mail/cltbld', 22:19:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:29 INFO - 'MOZ_NO_REMOTE': '1', 22:19:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:29 INFO - 'NO_EM_RESTART': '1', 22:19:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:29 INFO - 'PWD': '/builds/slave/test', 22:19:29 INFO - 'SHELL': '/bin/bash', 22:19:29 INFO - 'SHLVL': '1', 22:19:29 INFO - 'TERM': 'linux', 22:19:29 INFO - 'TMOUT': '86400', 22:19:29 INFO - 'USER': 'cltbld', 22:19:29 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1495936891.696796-806549916', 22:19:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:29 INFO - '_': '/tools/buildbot/bin/python'} 22:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:29 INFO - Downloading/unpacking psutil>=3.1.1 22:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:19:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:19:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:19:30 INFO - Installing collected packages: psutil 22:19:30 INFO - Running setup.py install for psutil 22:19:31 INFO - building 'psutil._psutil_linux' extension 22:19:31 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 22:19:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:19:31 INFO - building 'psutil._psutil_posix' extension 22:19:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:19:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:19:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:19:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:19:31 INFO - Successfully installed psutil 22:19:31 INFO - Cleaning up... 22:19:31 INFO - Return code: 0 22:19:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:19:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2457a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25faef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f7e40>, '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 0x25f8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f9440>, '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': 'fcadb68e09dcf59683000ff6000001dc-1495936891.696796-806549916', '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 22:19:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:19:31 INFO - Using env: {'DISPLAY': ':0', 22:19:31 INFO - 'HOME': '/home/cltbld', 22:19:31 INFO - 'LANG': 'en_US.UTF-8', 22:19:31 INFO - 'LANGUAGE': 'en_US:en', 22:19:31 INFO - 'LOGNAME': 'cltbld', 22:19:31 INFO - 'MAIL': '/var/mail/cltbld', 22:19:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:31 INFO - 'MOZ_NO_REMOTE': '1', 22:19:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:31 INFO - 'NO_EM_RESTART': '1', 22:19:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:31 INFO - 'PWD': '/builds/slave/test', 22:19:31 INFO - 'SHELL': '/bin/bash', 22:19:31 INFO - 'SHLVL': '1', 22:19:31 INFO - 'TERM': 'linux', 22:19:31 INFO - 'TMOUT': '86400', 22:19:31 INFO - 'USER': 'cltbld', 22:19:31 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1495936891.696796-806549916', 22:19:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:31 INFO - '_': '/tools/buildbot/bin/python'} 22:19:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:19:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:19:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:19:32 INFO - Installing collected packages: mozsystemmonitor 22:19:32 INFO - Running setup.py install for mozsystemmonitor 22:19:32 INFO - Successfully installed mozsystemmonitor 22:19:32 INFO - Cleaning up... 22:19:32 INFO - Return code: 0 22:19:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2457a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25faef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f7e40>, '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 0x25f8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f9440>, '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': 'fcadb68e09dcf59683000ff6000001dc-1495936891.696796-806549916', '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 22:19:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:19:32 INFO - Using env: {'DISPLAY': ':0', 22:19:32 INFO - 'HOME': '/home/cltbld', 22:19:32 INFO - 'LANG': 'en_US.UTF-8', 22:19:32 INFO - 'LANGUAGE': 'en_US:en', 22:19:32 INFO - 'LOGNAME': 'cltbld', 22:19:32 INFO - 'MAIL': '/var/mail/cltbld', 22:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:32 INFO - 'MOZ_NO_REMOTE': '1', 22:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:32 INFO - 'NO_EM_RESTART': '1', 22:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:32 INFO - 'PWD': '/builds/slave/test', 22:19:32 INFO - 'SHELL': '/bin/bash', 22:19:32 INFO - 'SHLVL': '1', 22:19:32 INFO - 'TERM': 'linux', 22:19:32 INFO - 'TMOUT': '86400', 22:19:32 INFO - 'USER': 'cltbld', 22:19:32 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1495936891.696796-806549916', 22:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:32 INFO - '_': '/tools/buildbot/bin/python'} 22:19:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:33 INFO - Downloading/unpacking jsonschema==2.5.1 22:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:19:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:19: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 22:19: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 22:19: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 22:19: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 22:19:34 INFO - Downloading functools32-3.2.3-2.tar.gz 22:19:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:19:34 INFO - warning: no files found matching '*.txt' 22:19:34 INFO - no previously-included directories found matching 'build' 22:19:34 INFO - no previously-included directories found matching 'dist' 22:19:34 INFO - no previously-included directories found matching '.git*' 22:19:34 INFO - Installing collected packages: jsonschema, functools32 22:19:34 INFO - Running setup.py install for functools32 22:19:34 INFO - warning: no files found matching '*.txt' 22:19:34 INFO - no previously-included directories found matching 'build' 22:19:34 INFO - no previously-included directories found matching 'dist' 22:19:34 INFO - no previously-included directories found matching '.git*' 22:19:34 INFO - Successfully installed jsonschema functools32 22:19:34 INFO - Cleaning up... 22:19:34 INFO - Return code: 0 22:19:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:19: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')]} 22:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19: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')]} 22:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2457a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25faef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f7e40>, '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 0x25f8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f9440>, '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': 'fcadb68e09dcf59683000ff6000001dc-1495936891.696796-806549916', '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 22:19:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:19:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:19:34 INFO - Using env: {'DISPLAY': ':0', 22:19:34 INFO - 'HOME': '/home/cltbld', 22:19:34 INFO - 'LANG': 'en_US.UTF-8', 22:19:34 INFO - 'LANGUAGE': 'en_US:en', 22:19:34 INFO - 'LOGNAME': 'cltbld', 22:19:34 INFO - 'MAIL': '/var/mail/cltbld', 22:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:34 INFO - 'MOZ_NO_REMOTE': '1', 22:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:34 INFO - 'NO_EM_RESTART': '1', 22:19:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:34 INFO - 'PWD': '/builds/slave/test', 22:19:34 INFO - 'SHELL': '/bin/bash', 22:19:34 INFO - 'SHLVL': '1', 22:19:34 INFO - 'TERM': 'linux', 22:19:34 INFO - 'TMOUT': '86400', 22:19:34 INFO - 'USER': 'cltbld', 22:19:34 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1495936891.696796-806549916', 22:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:34 INFO - '_': '/tools/buildbot/bin/python'} 22:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:19:34 INFO - Cleaning up... 22:19:34 INFO - Return code: 0 22:19:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:19: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')]} 22:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19: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')]} 22:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2457a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25faef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f7e40>, '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 0x25f8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f9440>, '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': 'fcadb68e09dcf59683000ff6000001dc-1495936891.696796-806549916', '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 22:19:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:19:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:19:34 INFO - Using env: {'DISPLAY': ':0', 22:19:34 INFO - 'HOME': '/home/cltbld', 22:19:34 INFO - 'LANG': 'en_US.UTF-8', 22:19:34 INFO - 'LANGUAGE': 'en_US:en', 22:19:34 INFO - 'LOGNAME': 'cltbld', 22:19:34 INFO - 'MAIL': '/var/mail/cltbld', 22:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:34 INFO - 'MOZ_NO_REMOTE': '1', 22:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:34 INFO - 'NO_EM_RESTART': '1', 22:19:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:34 INFO - 'PWD': '/builds/slave/test', 22:19:34 INFO - 'SHELL': '/bin/bash', 22:19:34 INFO - 'SHLVL': '1', 22:19:34 INFO - 'TERM': 'linux', 22:19:34 INFO - 'TMOUT': '86400', 22:19:34 INFO - 'USER': 'cltbld', 22:19:34 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1495936891.696796-806549916', 22:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:34 INFO - '_': '/tools/buildbot/bin/python'} 22:19:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:35 INFO - Downloading/unpacking blobuploader==1.2.4 22:19:35 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 22:19:35 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 22:19:35 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 22:19:35 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 22:19:36 INFO - Downloading blobuploader-1.2.4.tar.gz 22:19:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:19:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:19: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 22:19: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 22:19: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 22:19: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 22:19:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:19:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:19: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 22:19: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 22:19: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 22:19: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 22:19:36 INFO - Downloading docopt-0.6.1.tar.gz 22:19:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:19:36 INFO - Installing collected packages: blobuploader, requests, docopt 22:19:36 INFO - Running setup.py install for blobuploader 22:19:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:19:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:19:36 INFO - Running setup.py install for requests 22:19:37 INFO - Running setup.py install for docopt 22:19:37 INFO - Successfully installed blobuploader requests docopt 22:19:37 INFO - Cleaning up... 22:19:37 INFO - Return code: 0 22:19:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2457a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25faef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f7e40>, '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 0x25f8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f9440>, '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': 'fcadb68e09dcf59683000ff6000001dc-1495936891.696796-806549916', '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 22:19:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:19:37 INFO - Using env: {'DISPLAY': ':0', 22:19:37 INFO - 'HOME': '/home/cltbld', 22:19:37 INFO - 'LANG': 'en_US.UTF-8', 22:19:37 INFO - 'LANGUAGE': 'en_US:en', 22:19:37 INFO - 'LOGNAME': 'cltbld', 22:19:37 INFO - 'MAIL': '/var/mail/cltbld', 22:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:37 INFO - 'MOZ_NO_REMOTE': '1', 22:19:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:37 INFO - 'NO_EM_RESTART': '1', 22:19:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:37 INFO - 'PWD': '/builds/slave/test', 22:19:37 INFO - 'SHELL': '/bin/bash', 22:19:37 INFO - 'SHLVL': '1', 22:19:37 INFO - 'TERM': 'linux', 22:19:37 INFO - 'TMOUT': '86400', 22:19:37 INFO - 'USER': 'cltbld', 22:19:37 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1495936891.696796-806549916', 22:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:37 INFO - '_': '/tools/buildbot/bin/python'} 22:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:19:37 INFO - Running setup.py (path:/tmp/pip-DCC0q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:19:37 INFO - Running setup.py (path:/tmp/pip-fPbj48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:19:37 INFO - Running setup.py (path:/tmp/pip-KWkADn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:19:37 INFO - Running setup.py (path:/tmp/pip-0Urm21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:19:37 INFO - Running setup.py (path:/tmp/pip-X4y84i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:19:37 INFO - Running setup.py (path:/tmp/pip-0jFgqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:19:37 INFO - Running setup.py (path:/tmp/pip-70ol3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:19:38 INFO - Running setup.py (path:/tmp/pip-ePPN3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:19:38 INFO - Running setup.py (path:/tmp/pip-juNhwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:19:38 INFO - Running setup.py (path:/tmp/pip-d95uH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:19:38 INFO - Running setup.py (path:/tmp/pip-9DwV99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:19:38 INFO - Running setup.py (path:/tmp/pip-smZ4qh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:19:38 INFO - Running setup.py (path:/tmp/pip-hmXMRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:19:38 INFO - Running setup.py (path:/tmp/pip-r4_mg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:19:38 INFO - Running setup.py (path:/tmp/pip-2OlJ9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:19:38 INFO - Running setup.py (path:/tmp/pip-c9Q8DO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:19:38 INFO - Running setup.py (path:/tmp/pip-14IoPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:19:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:19:38 INFO - Running setup.py install for manifestparser 22:19:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:19:38 INFO - Running setup.py install for mozcrash 22:19:38 INFO - Running setup.py install for mozdebug 22:19:39 INFO - Running setup.py install for mozdevice 22:19:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:19:39 INFO - Running setup.py install for mozfile 22:19:39 INFO - Running setup.py install for mozhttpd 22:19:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:19:39 INFO - Running setup.py install for mozinfo 22:19:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:19:39 INFO - Running setup.py install for mozInstall 22:19:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:19:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:19:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:19:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:19:39 INFO - Running setup.py install for mozleak 22:19:39 INFO - Running setup.py install for mozlog 22:19:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:19:39 INFO - Running setup.py install for moznetwork 22:19:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:19:39 INFO - Running setup.py install for mozprocess 22:19:39 INFO - Running setup.py install for mozprofile 22:19:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:19:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:19:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:19:40 INFO - Running setup.py install for mozrunner 22:19:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:19:40 INFO - Running setup.py install for mozscreenshot 22:19:40 INFO - Running setup.py install for moztest 22:19:40 INFO - Running setup.py install for mozversion 22:19:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:19:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:19:40 INFO - Cleaning up... 22:19:40 INFO - Return code: 0 22:19:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2457a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25faef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f7e40>, '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 0x25f8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f9440>, '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': 'fcadb68e09dcf59683000ff6000001dc-1495936891.696796-806549916', '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 22:19:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:19:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:19:40 INFO - Using env: {'DISPLAY': ':0', 22:19:40 INFO - 'HOME': '/home/cltbld', 22:19:40 INFO - 'LANG': 'en_US.UTF-8', 22:19:40 INFO - 'LANGUAGE': 'en_US:en', 22:19:40 INFO - 'LOGNAME': 'cltbld', 22:19:40 INFO - 'MAIL': '/var/mail/cltbld', 22:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:40 INFO - 'MOZ_NO_REMOTE': '1', 22:19:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:40 INFO - 'NO_EM_RESTART': '1', 22:19:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:40 INFO - 'PWD': '/builds/slave/test', 22:19:40 INFO - 'SHELL': '/bin/bash', 22:19:40 INFO - 'SHLVL': '1', 22:19:40 INFO - 'TERM': 'linux', 22:19:40 INFO - 'TMOUT': '86400', 22:19:40 INFO - 'USER': 'cltbld', 22:19:40 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1495936891.696796-806549916', 22:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:40 INFO - '_': '/tools/buildbot/bin/python'} 22:19:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:19:40 INFO - Running setup.py (path:/tmp/pip-zKLbKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:19:40 INFO - Running setup.py (path:/tmp/pip-ZC881M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:19:40 INFO - Running setup.py (path:/tmp/pip-vDo3Ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:19:40 INFO - Running setup.py (path:/tmp/pip-FuYkrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:19:41 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)) 22:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:19:41 INFO - Running setup.py (path:/tmp/pip-xoyrDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:19:41 INFO - Running setup.py (path:/tmp/pip-QDPt_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:19:41 INFO - Running setup.py (path:/tmp/pip-vDZrCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:19:41 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)) 22:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:19:41 INFO - Running setup.py (path:/tmp/pip-14u5db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:19:41 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)) 22:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:19:41 INFO - Running setup.py (path:/tmp/pip-kysc_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:19:41 INFO - Running setup.py (path:/tmp/pip-dd81V7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:19:41 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)) 22:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:19:41 INFO - Running setup.py (path:/tmp/pip-CwNCAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:19:41 INFO - Running setup.py (path:/tmp/pip-rkhIM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:19:41 INFO - Running setup.py (path:/tmp/pip-uFBY5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 22:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:19:41 INFO - Running setup.py (path:/tmp/pip-rgBQm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:19:41 INFO - Running setup.py (path:/tmp/pip-J2qTJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:19:41 INFO - Running setup.py (path:/tmp/pip-xGFNC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:19:41 INFO - Running setup.py (path:/tmp/pip-mKJWij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:19:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:19: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 22:19: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 22:19: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 22:19: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 22:19:43 INFO - Downloading blessings-1.6.tar.gz 22:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:19:43 INFO - Installing collected packages: blessings 22:19:43 INFO - Running setup.py install for blessings 22:19:43 INFO - Successfully installed blessings 22:19:43 INFO - Cleaning up... 22:19:43 INFO - Return code: 0 22:19:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:19:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:19:43 INFO - Reading from file tmpfile_stdout 22:19:43 INFO - Current package versions: 22:19:43 INFO - argparse == 1.2.1 22:19:43 INFO - blessings == 1.6 22:19:43 INFO - blobuploader == 1.2.4 22:19:43 INFO - docopt == 0.6.1 22:19:43 INFO - functools32 == 3.2.3-2 22:19:43 INFO - jsonschema == 2.5.1 22:19:43 INFO - manifestparser == 1.1 22:19:43 INFO - mozInstall == 1.12 22:19:43 INFO - mozcrash == 1.0 22:19:43 INFO - mozdebug == 0.1 22:19:43 INFO - mozdevice == 0.51 22:19:43 INFO - mozfile == 1.2 22:19:43 INFO - mozhttpd == 0.7 22:19:43 INFO - mozinfo == 0.9 22:19:43 INFO - mozleak == 0.1 22:19:43 INFO - mozlog == 3.4 22:19:43 INFO - moznetwork == 0.27 22:19:43 INFO - mozprocess == 0.25 22:19:43 INFO - mozprofile == 0.28 22:19:43 INFO - mozrunner == 6.13 22:19:43 INFO - mozscreenshot == 0.1 22:19:43 INFO - mozsystemmonitor == 0.3 22:19:43 INFO - moztest == 0.8 22:19:43 INFO - mozversion == 1.4 22:19:43 INFO - psutil == 3.1.1 22:19:43 INFO - requests == 1.2.3 22:19:43 INFO - wsgiref == 0.1.2 22:19:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2457a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25faef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f7e40>, '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 0x25f8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f9440>, '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': 'fcadb68e09dcf59683000ff6000001dc-1495936891.696796-806549916', '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 22:19:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 22:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:19:43 INFO - Using env: {'DISPLAY': ':0', 22:19:43 INFO - 'HOME': '/home/cltbld', 22:19:43 INFO - 'LANG': 'en_US.UTF-8', 22:19:43 INFO - 'LANGUAGE': 'en_US:en', 22:19:43 INFO - 'LOGNAME': 'cltbld', 22:19:43 INFO - 'MAIL': '/var/mail/cltbld', 22:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:43 INFO - 'MOZ_NO_REMOTE': '1', 22:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:43 INFO - 'NO_EM_RESTART': '1', 22:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:43 INFO - 'PWD': '/builds/slave/test', 22:19:43 INFO - 'SHELL': '/bin/bash', 22:19:43 INFO - 'SHLVL': '1', 22:19:43 INFO - 'TERM': 'linux', 22:19:43 INFO - 'TMOUT': '86400', 22:19:43 INFO - 'USER': 'cltbld', 22:19:43 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1495936891.696796-806549916', 22:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:43 INFO - '_': '/tools/buildbot/bin/python'} 22:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 22:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 22:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 22:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 22:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 22:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 22:19:43 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 22:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:44 INFO - Downloading marionette_driver-1.4.0.tar.gz 22:19:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 22:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:19:44 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)) 22:19:44 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)) 22:19:44 INFO - Installing collected packages: marionette-driver 22:19:44 INFO - Running setup.py install for marionette-driver 22:19:44 INFO - Successfully installed marionette-driver 22:19:44 INFO - Cleaning up... 22:19:45 INFO - Return code: 0 22:19:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:19: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')]} 22:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19: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')]} 22:19:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2457a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25faef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f7e40>, '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 0x25f8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f9440>, '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': 'fcadb68e09dcf59683000ff6000001dc-1495936891.696796-806549916', '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 22:19:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:19:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:19:45 INFO - Using env: {'DISPLAY': ':0', 22:19:45 INFO - 'HOME': '/home/cltbld', 22:19:45 INFO - 'LANG': 'en_US.UTF-8', 22:19:45 INFO - 'LANGUAGE': 'en_US:en', 22:19:45 INFO - 'LOGNAME': 'cltbld', 22:19:45 INFO - 'MAIL': '/var/mail/cltbld', 22:19:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:45 INFO - 'MOZ_NO_REMOTE': '1', 22:19:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:45 INFO - 'NO_EM_RESTART': '1', 22:19:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:45 INFO - 'PWD': '/builds/slave/test', 22:19:45 INFO - 'SHELL': '/bin/bash', 22:19:45 INFO - 'SHLVL': '1', 22:19:45 INFO - 'TERM': 'linux', 22:19:45 INFO - 'TMOUT': '86400', 22:19:45 INFO - 'USER': 'cltbld', 22:19:45 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1495936891.696796-806549916', 22:19:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:45 INFO - '_': '/tools/buildbot/bin/python'} 22:19:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:19:45 INFO - Cleaning up... 22:19:45 INFO - Return code: 0 22:19:45 INFO - Running post-action listener: _resource_record_post_action 22:19:45 INFO - Running post-action listener: _start_resource_monitoring 22:19:45 INFO - Starting resource monitoring. 22:19:45 INFO - [mozharness: 2017-05-28 05:19:45.283640Z] Finished create-virtualenv step (success) 22:19:45 INFO - [mozharness: 2017-05-28 05:19:45.284111Z] Running install step. 22:19:45 INFO - Running pre-action listener: _resource_record_pre_action 22:19:45 INFO - Running main action method: install 22:19:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:19:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:19:45 INFO - Reading from file tmpfile_stdout 22:19:45 INFO - Detecting whether we're running mozinstall >=1.0... 22:19:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:19:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:19:45 INFO - Reading from file tmpfile_stdout 22:19:45 INFO - Output received: 22:19:45 INFO - Usage: mozinstall [options] installer 22:19:45 INFO - Options: 22:19:45 INFO - -h, --help show this help message and exit 22:19:45 INFO - -d DEST, --destination=DEST 22:19:45 INFO - Directory to install application into. [default: 22:19:45 INFO - "/builds/slave/test"] 22:19:45 INFO - --app=APP Application being installed. [default: firefox] 22:19:45 INFO - mkdir: /builds/slave/test/build/application 22:19:45 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'] 22:19:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 22:20:01 INFO - Reading from file tmpfile_stdout 22:20:01 INFO - Output received: 22:20:01 INFO - /builds/slave/test/build/application/firefox/firefox 22:20:01 INFO - Running post-action listener: _resource_record_post_action 22:20:01 INFO - [mozharness: 2017-05-28 05:20:01.669026Z] Finished install step (success) 22:20:01 INFO - [mozharness: 2017-05-28 05:20:01.669308Z] Running setup-mitmproxy step. 22:20:01 INFO - Running pre-action listener: _resource_record_pre_action 22:20:01 INFO - Running main action method: setup_mitmproxy 22:20:01 INFO - Skipping: mitmproxy is not required 22:20:01 INFO - Running post-action listener: _resource_record_post_action 22:20:01 INFO - [mozharness: 2017-05-28 05:20:01.670510Z] Finished setup-mitmproxy step (success) 22:20:01 INFO - [mozharness: 2017-05-28 05:20:01.670735Z] Running run-tests step. 22:20:01 INFO - Running pre-action listener: _resource_record_pre_action 22:20:01 INFO - Running main action method: run_tests 22:20:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:20:01 INFO - Python 2.7.3 22:20:01 INFO - Return code: 0 22:20:01 INFO - grabbing minidump binary from tooltool 22:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:20:01 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 0x25f7e40>, '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 0x25f8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f9440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:20:01 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 22:20:01 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 22:20:01 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 22:20:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:20:01 INFO - Return code: 0 22:20:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:20:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:20:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:20:01 INFO - ENV: RUST_BACKTRACE is now 1 22:20:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:20:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:20:01 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/ZBc7qSKBRC-nGb-P0BBYsg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--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 22:20:01 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/ZBc7qSKBRC-nGb-P0BBYsg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-075 --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 22:20:01 INFO - Using env: {'DISPLAY': ':0', 22:20:01 INFO - 'HOME': '/home/cltbld', 22:20:01 INFO - 'LANG': 'en_US.UTF-8', 22:20:01 INFO - 'LANGUAGE': 'en_US:en', 22:20:01 INFO - 'LOGNAME': 'cltbld', 22:20:01 INFO - 'MAIL': '/var/mail/cltbld', 22:20:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:20:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:20:01 INFO - 'MOZ_NO_REMOTE': '1', 22:20:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:20:01 INFO - 'NO_EM_RESTART': '1', 22:20:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:20:01 INFO - 'PWD': '/builds/slave/test', 22:20:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:20:01 INFO - 'RUST_BACKTRACE': '1', 22:20:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 22:20:01 INFO - 'SHELL': '/bin/bash', 22:20:01 INFO - 'SHLVL': '1', 22:20:01 INFO - 'TERM': 'linux', 22:20:01 INFO - 'TMOUT': '86400', 22:20:01 INFO - 'USER': 'cltbld', 22:20:01 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1495936891.696796-806549916', 22:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:20:01 INFO - '_': '/tools/buildbot/bin/python'} 22:20:01 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/ZBc7qSKBRC-nGb-P0BBYsg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--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 22:20:01 INFO - mozversion application_buildid: 20170528043016 22:20:01 INFO - mozversion application_changeset: 6a235092bda7c20cb83651d3404284fe36d04c1b 22:20:01 INFO - mozversion application_display_name: Nightly 22:20:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:20:01 INFO - mozversion application_name: Firefox 22:20:01 INFO - mozversion application_remotingname: firefox 22:20:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:20:01 INFO - mozversion application_vendor: Mozilla 22:20:01 INFO - mozversion application_version: 55.0a1 22:20:01 INFO - mozversion platform_buildid: 20170528043016 22:20:01 INFO - mozversion platform_changeset: 6a235092bda7c20cb83651d3404284fe36d04c1b 22:20:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:20:01 INFO - mozversion platform_version: 55.0a1 22:20:01 INFO - using testdate: 1495948801 22:20:01 INFO - actual date: 1495948801 22:20:01 INFO - starting webserver on 'localhost:44980' 22:20:01 INFO - SUITE-START | Running 2 tests 22:20:01 INFO - TEST-START | dromaeo_css 22:20:01 INFO - operating with platform_type : linux_ 22:20:01 INFO - Initialising browser for dromaeo_css test... 22:20:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44980/getInfo.html -profile /tmp/tmpyXQH_J/profile 22:20:02 INFO - TEST-INFO | started process 16403 (/builds/slave/test/build/application/firefox/firefox http://localhost:44980/getInfo.html) 22:20:37 INFO - TEST-INFO | 16403: killed by SIGTERM 22:20:37 INFO - Browser initialized. 22:20:37 INFO - Running cycle 1/1 for dromaeo_css test... 22:20:37 INFO - TEST-INFO | started process 16626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyXQH_J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:20:49 INFO - PID 16626 | RSS: Main: 187002880 22:20:49 INFO - PID 16626 | 22:23:54 INFO - PID 16626 | Cycle 1(1): loaded http://localhost:44980/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44980/tests/dromaeo/cssquery-ext.html) 22:23:56 INFO - PID 16626 | RSS: Main: 183066624 22:23:56 INFO - PID 16626 | 22:26:58 INFO - PID 16626 | Cycle 1(1): loaded http://localhost:44980/tests/dromaeo/cssquery-ext.html (next: http://localhost:44980/tests/dromaeo/cssquery-jquery.html) 22:26:59 INFO - PID 16626 | RSS: Main: 188301312 22:26:59 INFO - PID 16626 | 22:30:00 INFO - PID 16626 | Cycle 1(1): loaded http://localhost:44980/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44980/tests/dromaeo/cssquery-mootools.html) 22:30:01 INFO - PID 16626 | RSS: Main: 185131008 22:30:01 INFO - PID 16626 | 22:33:03 INFO - PID 16626 | Cycle 1(1): loaded http://localhost:44980/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44980/tests/dromaeo/cssquery-prototype.html) 22:33:04 INFO - PID 16626 | RSS: Main: 189624320 22:33:04 INFO - PID 16626 | 22:36:06 INFO - PID 16626 | Cycle 1(1): loaded http://localhost:44980/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44980/tests/dromaeo/cssquery-yui.html) 22:36:07 INFO - PID 16626 | RSS: Main: 187838464 22:36:07 INFO - PID 16626 | 22:39:09 INFO - PID 16626 | Cycle 1(1): loaded http://localhost:44980/tests/dromaeo/cssquery-yui.html (next: http://localhost:44980/tests/dromaeo/cssquery-dojo.html) 22:39:09 INFO - PID 16626 | RSS: Main: 185683968 22:39:09 INFO - PID 16626 | 22:39:09 INFO - PID 16626 | __start_tp_report 22:39:09 INFO - PID 16626 | _x_x_mozilla_page_load 22:39:09 INFO - PID 16626 | _x_x_mozilla_page_load_details 22:39:09 INFO - PID 16626 | |i|pagename|runs| 22:39:09 INFO - PID 16626 | |0;dojo.html;2756.1318184771794;2762.4337010912764;2763.5163846326886;2770.9584356234645;2777.20849557876;5125.179971204608;5191.299174611427;5236.89526209476;5289.127293996496;5304.575633949285;5154.433012368637;5213.218017297398;5220.164773636219;5353.197020446935;5364.490373414519;4659.836905708301;4665.2768820832825;4688.085823264456;4690.038542098861;4733.408323959505;4633.1891918914225;4705.552972467627;4734.479207287196;4735.408073990751;4757.952420475803;4598.770061496912;4633.374494443241;4671.85984420468;4681.602063824579;4728.314394412808;4598.908021839545;4677.158111539921;4677.602403795648;4697.03710739301;4707.929381059287;4662.53374662531;4672.57946784791;4676.883077923045;4699.036697477009;4711.151992641323;5186.429492755794;5226.660267082628;5239.449857764918;5257.316548848664;5266;5548.056830338852;5608.2428872102155;5608.747606357723;5672.17396918095;5681.829545113612;5715.685637289947;5717.914231286534;5732.971335143297;5745.482906538432;5752.626079304873;5281.366236051698;5283.498067683564;5287;5305;5308.389535203424;5682.886342273214;5742.511886489611;5845.503132233723;5848.64908105515;5912.438318359749;5503.6147469677535;5523.7238138092935;5533.3083364579425;5555.944440555623;5572.58205634579;5589.74846131925;5629.324481062299;5656.802011929645;5672.602917795714;5674.517665998354;5520.282363292747;5624.6625202487985;5649.6327738696855;5656.038473459522;5662.37713851476;5503.889922201613;5566.721663916869;5579.832605021856;5589.580781441408;5593.692346920959;4613.607843333354;4614.423197100363;4615.330777037378;4619.884502887455;4661.813527458931;4002.8198731057173;4004.0790618157985;4007.35882258843;4036.555978842325;4070.1249231415386;4703.365045718852;4715.882102947454;4736.218523943511;4744.715317080986;4829.323894654751;5650.576206784425;5663.178839068312;5696.914546281809;5714.685692286964;5735.0250457422335;4760.690555113906;4764.8332308369045;4780.713157210578;4783.617310615143;4811.9518804811505;4805.951940480621;4876.390451193601;4906.681065730716;4949.084419382426;4954.430240522314;5260.552853007537;5352.250684904038;5365.892682146413;5376.489233522809;5393.433689462707;5488.807891723771;5522.889542209053;5707.514861236841;5719.199312096393;5748.936446757363;5250.422453530032;5269.1832765921345;5333.839984800462;5338.4127745947135;5346.251524786455;5477.123660214346;5559.527440167631;5574.136008918624;5578.748956296895;5598.916016259678;5602.803901863578;5641.492265696107;5653.293338332708;5711.143328500758;5737.971310143423;5514.531264842533;5556.499915007668;5573.052581061148;5574.442555744393;5592.217089607377;5536.944630553643;5540.445955404427;5545.639533430314;5551.472610102034;5566.4990150885;5399.379071406682;5469.535089517435;5482.890342193054;5483.61614686984;5511.063119269814;5415.458454154553;5494.670319780826;5495.642783219078;5575.498205161555;5588.972055139861;5392.460753924576;5405.594580406407;5421.837344879502;5449.264349312951;5462.590305727007 22:39:09 INFO - PID 16626 | |1;ext.html;648.5246065201669;714.506990176778;731.6378392695615;1056.4453661827545;1074.656110044786;31136.688633113663;31948.20129496764;31982.36035279293;32035;32051.19872003198;33586.32827343452;33836.49245261323;33938.830305848496;33950.66049339506;34089.65910340896;6690.464762818963;6841.521093523455;6866.485013623973;6982.895256571155;6995.930040699604;6764.3573860483175;6770.119884415044;6865.519413641047;6871.862562748742;6879.724811007553;6834.179898412172;6876.656167191645;6887.242403335654;6889.069975553286;6910.5853648780985;6830.112085428863;6848.246692863781;6851.725930962781;6864.725410983555;6867.484938629623;6651.93348066518;6723.260441351447;6736.7642132525125;6739.427148692367;6741.764038258638;30857.228569285948;30862.22844428885;30960;31168.8441557793;31198.688013119805;2960.3043284828263;3002.9249268768235;3003.1591154476782;3005.023367405602;3005.2637103909683;24243.272701818973;24364;24478.877605612037;24479.632805507932;24490.755092449024;3057.2968217310145;3082.368114536537;3082.9845850770826;3089.0578373596045;3139.02690166047;128891;131210;146419.2679036598;147593.26203368916;147756;36568;37444.43833342502;37527.62472375296;37537.433943775846;37543.43684844675;38792.418113728316;39137.804310978834;39155.804220978716;39211.607883921366;39279.214415711525;11224.66326010221;11436.714082147846;11438.199326047263;11447.828282575769;11451.484683189277;9122.179003889682;9180.21968132703;9182.95408522953;9184.494852783027;9239;12110.455029523693;12154.696132596755;12221.877781222252;12261.632151035305;12291.234472243852;5070.670406423571;5094.1849304111165;5113.411957624847;5145.562627176657;5169.974150129226;825.5253229393123;857.7126662567985;873.24028095556;881.678187461572;883.3595643158787;19892.801071989095;20581.883623275404;20710.896445517676;20915.37253882386;20936.47658808542;896.9551522423983;917.7476194046691;922.2760133295465;935.1677007463363;939.0327962198946;10344;10843.969822866815;10862.837057444145;10891.400972946405;11033.117350611932;181779.09110454362;184405.07797460927;184431.0778446126;184657;184791;38342.616573834464;38668.61331386706;38674.80662596669;38759;38764;1136.142212629476;1170.6019953215778;1180.6340034589305;1181.4860535667012;1189.0725234317074;18635.254589816257;19329.8067019328;20019.199232031136;20229.79770202279;20360.59278814445;28272.15183544497;29956.101316960525;30495.237619059702;34433.48349774705;35139.64860351466;113996;114460;114643.42678286556;114879.42560287144;115534.33492488266;26438.867805660848;26469.60295595529;26503.867480662473;26572.601410979238;26841.865790670923;31348.52977205298;32112.35775284528;32499.512507311938;32590.674093258764;32889;24842.130525432247;25424.872875635505;25593.872030639726;25892;26020.609690854275;24866.751332486445;24926.75073249317;25175.37061573402;26015.21954341373;26159.607605886307;27422.72577274202;28061.298467538476;28180.43639127247;28283.15150545487;28459.715402846534;24296.635550466402;24408.51182976295;24475.143369981964;25001.499970000863;25688.8715556421;19852.60294794125;20310.59378812445;20773.480662983548;20783.688244676643;20907.686384704546 22:39:09 INFO - PID 16626 | |2;jquery.html;397.8925690063685;400.9830552321822;421.81229352937936;428.6913422335918;432.9588689074539;12454.937725311383;15609.297581608826;16898.915505422472;17543.38598149065;17560.73658895116;16660.66678666426;17131.057791821444;17211.13944302786;17318.220680069397;17417.91291043546;5258.290130832346;5386.461353864622;5561.5828812839;5563.721813909288;5573.665580065209;5263.131583288753;5375.569954403638;5389.083855744513;5410.458954104578;5410.783568657249;5039.344885164924;5310.230016647583;5313.867153321159;5320.733963301839;5328.440513746059;5115.079285728568;5127.359080114986;5128.999845030221;5142.100132476801;5157.149070403379;4674.368960190399;4745.667803253774;4798.7840547175465;4804;4822.782974766109;21178.152873885025;21479.140834366764;21500;21657.45856353588;21742.673859892115;1599.984000159995;1651.7604947282696;1657.527604632674;1662.25198660602;1662.393226472341;14181.14913105217;14513.274336283144;14659.853401465956;14670.166229221348;14706.55880323592;2035.8982050897396;2048.6517292060385;2110.883901385423;2116.5237821490196;2121.9787802121937;89488;90126.5493672534;91186.08813911842;94910;99712.50143749235;10753.784924301626;10856.565737370416;11052.602791493331;11080.944595276973;11370.943145284386;14059.929700351433;15135.848641513443;15157.166355850533;15186.620334491505;15203.31585078652;7436.107667079985;7436.962815185998;7586.772396828104;7713.807154821062;7718.961405192938;6790.11728475305;6823.080667110375;6880.862382752317;6946.895796563055;6970.163580370287;6573.342665733484;6675.599464032173;6707.865842683216;6721.328676569835;6737.562058466184;2022.48426651203;2031.7358743363268;2057.331367305632;2115.7672656007826;2164.599549083425;800.9038915330198;830.4394533689735;835.9038710548365;842.4987132656059;859.9269062129664;16190.976127984002;16320.694344452415;16406.09766462832;16512.66974660524;17153.914230429018;844.7254642241296;849.2526576612541;850.6682393866397;851.1871163039283;865.5845194306768;10783.13734901206;11585.362805045803;11655.1910220151;11722.827717228209;11792.41037948099;354527;356290;356580;356867;380536;77962;78842;79224;79330.81003784949;80818;1041.3335465302212;1053.1311667874033;1061.4374381577777;1061.9221490187313;1062.9681109566725;16657.333706652083;17204;17396.565085872448;17728.734068988717;18066.728999065286;38928.221435570566;38990.273413497685;39092.413613795245;39173.608263917;40526.18947620972;46920.29619555641;48286.75856620695;49059;49734;50142.498575013786;8004.479708818908;8013.4791238569305;8085.514869107637;8249.505029698237;8482.897223360924;11380.487878045673;11655.18413711032;12073.637790866289;12446.502139914302;12684.302363370103;10296;10628.734281642712;10859.07697845692;11012.724681883017;11068.730910163558;10045.447500387256;10128.392296462236;10207.438590877573;10245.385276883411;10357.378557286587;10544.57821687124;10574.682759517227;10646.680599582025;10849.132069434268;11159.665210043711;7895.447318687637;8005.759827205193;8075.434719569574;8077.515349079074;8189.099199087977;10456.58173673075;10539.367637941748;10664.946675266574;10744.355338679705;10757.677269681923 22:39:09 INFO - PID 16626 | |3;mootools.html;1147.9081673466121;1204.9096317776168;1218.1716432825674;1222.9510819567217;1224.185916365617;9684.854727179098;10043.849342259871;10052.346597471169;10264.692059238216;10551.73620659482;10260.333078349902;10395;10428.687139385811;10438.843417348728;10454.059134677878;2151.150295633224;2181.2474696229856;2182.181681869299;2186.2457452178974;2189.9562008759895;2118.8410869184795;2139.12295958657;2141.9785802142014;2145.903434345458;2148.602508535918;2111.345482900306;2122.1935664447487;2135.1993002624017;2135.5728854229137;2135.6689713094415;2059.4851287178208;2063.8555301128927;2066.2664754012335;2067.6795096760025;2068.441520789386;1887.9433616991512;1937.8740381875134;1948.2012374926353;2007.5081605006867;2082.8437867160023;9865.704028879145;9939.453330066915;9941;9947.850782238273;9949.403035817873;5296.126139187029;5522.723863806834;5543.029969755276;5543.445655434464;5556.111022236423;3227.483602623569;3321.1199032256472;3367.410703126943;3383.678550537695;3408.659134086596;1100.9119270458343;1103.7240689827543;1111;1125.4372813593204;1127.7575321305958;14446;14541.200233987127;14596;14641.780373294303;14654;4309.956900431018;4435.3125265583885;4606.907861842745;4633.2818413146015;4642.5821676048645;10218.540165692562;10272;10288.2798204125;10298.485075746183;10304.690859274233;5376.4085950545405;5510.779568817283;5522.061249587579;5526.834194974157;5529.972350138223;5085.771140298695;5099.59203263738;5109.233614957786;5127.97436012825;5138.049460849755;3863.459115723801;3928.5678575356687;3941.3496773032703;3975.8530393587716;4038.656714179269;1154.7113221694576;1165.0854079547514;1176.3823992403886;1191.2614179208772;1191.8331433599303;618.8421952402109;637.6078711592337;641.4643772450056;643.5077165968038;676.0298970976664;5206.245094461282;5433.972830135824;5492.423295553989;5566.332040155126;5643.830685079454;794.8171920458211;824.9275941276317;831.7338451695399;837.7319257837555;845.0662018469626;3092.9536056959164;3096.1949893027977;3149.2441813964483;3231.04684118181;3455.8963231103107;13043.739125217442;13506.59480215595;13518;13557.728845423037;13661.043726939217;13417.798733019012;13510.121842080232;13639.181649101085;13685.931570342284;13703.862961370458;7340.816479588053;7714;7800.804979875548;7824.139344672081;7824.452288339761;5108.846734597968;5374.892502149857;5381.838544843661;5502.559795216293;5794.333651629948;11848.881511184778;12360.196587221802;12413.813792793297;12586.811197832223;12587;12172.878271217529;12467.875321247035;12505.874941250471;12645.178063425848;12789.104762666524;7852.214778522102;8116.878246826184;8238.464499807733;8243.464174828618;8258.83482330338;9941.950290248502;10033.347832390871;10035.397876127456;10036.19710423179;10063.74840628961;8006.359491240803;8079.272865442138;8134.918650813416;8198.918010819816;8352.206540378655;7098.467614928798;7198.8920166198595;7224.385927196037;7261.346478816932;7310.817229569303;6747.763828265987;6861.210960739579;6911.3779759821855;6912.239653638197;6912.688928998307;5043.571296439697;5065.56942659878;5086.898262034664;5086.9745651271505;5164.741762911764;4871.464138944642;4954.058728841508;4975.253711943237;4986.102501549756;5020.071286811952 22:39:09 INFO - PID 16626 | |4;prototype.html;358.81341702314796;369.4790345612685;377.3208225194649;378.70839453620704;383.6738772043765;5343.438938911417;5488.890222195559;5491.725413729312;5527.143292789614;5532.1425179097305;5256.842294731155;5321.733913304339;5343.919841202385;5346.866328341794;5353.277307563478;4091.9795401023102;4104.733192342488;4106.1992911382295;4113.814878330468;4115;3952;4107.693306887954;4126.216018956404;4126.216018956404;4128.938065929014;4084.611961863633;4095.4061661059127;4097.979510102446;4100.876973690794;4104.240715467633;4071.104357041461;4073.307537718595;4078.9184216315803;4079.551759125512;4083.734557253769;3572.2676851245433;3578.481120237551;3581.4985901973746;3589.910252243689;3591.2278860045217;5103.23451482277;5222.112240919015;5292.047431462335;5295.867603309909;5299.947000530023;4789.712617242976;4798.616110711169;4828.324034635154;4837.436158835822;4849.684770489942;5427.62006659534;5702.460335709336;5720.71396430181;5723.685197314146;5726.656400615976;3993.4608827808456;4009.2382447334912;4013.0769922917602;4042.0097076216516;4046.615571520701;5884.382139875337;6005.969970150165;6059.151718759377;6059.909101363439;6091.208142941434;4061.147159096564;4062.7156099073372;4076.30702780528;4088.5298190707854;4090.1001779608437;4124.670026397881;4133.6693064554765;4135.58644135584;4136.607022332873;4144.8134833932545;4706.623470122382;4737.218358970731;4775.594074503637;4776.202918679658;4789;5774.913376299359;5776.620676904058;5793.768249270066;5803.390643982321;5805.593608447368;1422.6301161698034;1433.605758416423;1437.4537675683382;1442.8052212951327;1444.162385816245;916.5188276154938;940.8118376324762;974.6345120579782;978.7846673731767;982.7101005203482;5001.549860512571;5003.649744517922;5011.674241174312;5015.6489045767175;5040.747962601855;5972.761089556456;5977.79077732286;5991.58058935879;6008.459238668541;6027.126066720301;4700.529947005272;4906.190478571068;4958.9008219835405;4964.180910149785;5000.324956130876;3108.6114235720534;3150.023492717265;3159.210197450637;3159.620845498555;3178.4596618574897;5414.40441551429;5544.833654990357;5545.696761261101;5584.413636568183;5610.214569960209;6064.423879731418;6069.51443884497;6074.817755467343;6103.725332360054;6132.478739307209;5550.38945715979;5571.749271282802;5573.442655734394;5592.273004509388;5603.551715862721;5814.331351894586;5859.150423188699;5893.998020336639;5947.702614869153;5955;5832.825015249549;5861.853453663693;5867.882642347044;5868.413158684098;5868.970655146697;5354.250404943233;5438.918416223681;5494.532964698045;5585.720713964367;5599.524040456607;4494.528074552256;4524.5249248828395;4542.863714088583;4550.294704320836;4556.840510582114;5853.473187413153;5981.820545383645;6014.879702406015;6027.969860150672;6031.155638210566;5786.623869448473;5795.7391917362975;5796.275465566804;5798.768049277982;5832.533397328119;5739.540836733135;5742.885142297047;5776.162456443876;5784.884302313846;5788.334341550775;5589.972050139723;5647.858803529944;5683.431656834284;5689.260396148474;5711.171880077449;5765.4522820332;5810.68041257718;5813.244278243801;5815.6510609361885;5829.387914268941;5512.6692398456225;5567.137093750475;5601.943980560142;5613.522850557748;5672.914906276492 22:39:09 INFO - PID 16626 | |5;yui.html;680.9761658341959;696.2584847137799;702.5573888450275;719.7193094693071;724.7716969154716;12252;12757.234565926052;13591.79612305815;14480.782788258171;14506.419743210272;14673;15310.234488275597;15378.461753838617;15385.769213461806;15390.923045384785;774.1909704358944;782.8316911863948;783.2676447521557;783.8471498057881;784.7175016993878;782.4874707066851;782.5969625642798;783.4633276205789;784.2197013971078;785.2696991797626;835.9164083591622;837.7654256808104;838;838.9622466989;839.215333663024;778.6418247606108;796.3589310604932;811.3022800391717;812.7358608452276;833.754042557444;596.0463258785951;596.8627215740361;597.1699337920294;597.7101105963604;598.6767145741294;14233.217173055582;14250.501232456814;14283;14303.427862885575;14313.212773297464;14251.857481425157;14336.283185840666;14792.852071479363;14859.331330090172;14933.850661493354;12405.689857753538;12606.873931260754;12653.051021173449;12843.100982931199;13045.217286962812;2995.4009198160456;3001.564773107909;3007.1579957611903;3014.110837302979;3025.2890570715863;72588;72950.27049729488;73460;73643.63178184128;83558;12319.384030798425;12561.246325220516;12647.494100236072;12656.74686506283;12719.682007949876;22041.338759837232;22076.668849966944;22260.55478890413;22668.886655566945;22699.092036318692;6783.18601767791;6803.557768745016;6859.211190713132;6861.691223894937;6874.175098988154;3060.342026464321;3122.5160100184507;3126.1403114143336;3126.155937896755;3129.8435078246;3365.175531994628;3366.5118557808983;3418.9658103419147;3443.1564266754303;3446.1556918555116;636.0935666674969;657.6021506988299;684.9452043836482;697.1564407067403;699.9580025198504;557.760163129858;573.6357413042665;581.8545363659085;595.928488581373;608.5253502268238;9304;9935.254855885838;9989.650362237433;10278.588856445658;10334.896651033543;565.8500497368201;568.6133429268137;568.9857753556195;584.360125662399;598.9700514974234;4504.504504504502;4709;4747.643926705511;4809.278608208727;4933.407991041098;80559;82534.58732706298;84501.57749211215;85380;86246.56876715577;77626;78249.21750782533;78662.21337786548;78707;79226.6038669803;63333.36666633367;65343;65878;66292.33707662958;67612.66193669;8829.60266788009;9059.728208153765;9321.673741419017;9361.391509551857;9561.282903782105;27705.168844934684;27834.721652783213;28734.712652873204;29439.26401839971;30307.393852122394;51344.48655513397;51602.74198628983;52785.47214527806;52997;55135.72432137813;14619.269036548343;14849.331780069706;15003.624909377353;15012.849871501145;15050.698986020438;15676;15931.761023584888;16136.95109817905;16528.42150524774;16721.5819604506;12918.741625167257;14158.150510969375;15073.246337682853;15168.544943651708;15469.149196794284;14258.02519707103;14578.854211458174;15222.391104356144;15275.694486110438;15314.081155130281;12732.936335318635;12813.359332033175;13052.934735326262;13714.451421943011;13953.232572208626;9288.489133097744;9862.852057219005;10770.353778773298;10976.835347469634;11019.779604407706;10671.786564268827;10973.451327433757;11091.112710983263;11187.21689481761;11207.943960280147 22:39:09 INFO - PID 16626 | __end_tp_report 22:39:09 INFO - PID 16626 | __start_cc_report 22:39:09 INFO - PID 16626 | _x_x_mozilla_cycle_collect,391 22:39:09 INFO - PID 16626 | __end_cc_report 22:39:09 INFO - PID 16626 | __startTimestamp1495949949718__endTimestamp 22:39:09 INFO - PID 16626 | 22:39:09 INFO - PID 16626 | ------- Summary: start ------- 22:39:09 INFO - PID 16626 | Number of tests: 6 22:39:09 INFO - PID 16626 | 22:39:09 INFO - PID 16626 | [#0] dojo.html Cycles:165 Average:5168.10 Median:5365.89 stddev:610.84 (11.4%) stddev-sans-first:582.67 22:39:09 INFO - PID 16626 | Values: 2756.1 2762.4 2763.5 2771.0 2777.2 5125.2 5191.3 5236.9 5289.1 5304.6 5154.4 5213.2 5220.2 5353.2 5364.5 4659.8 4665.3 4688.1 4690.0 4733.4 4633.2 4705.6 4734.5 4735.4 4758.0 4598.8 4633.4 4671.9 4681.6 4728.3 4598.9 4677.2 4677.6 4697.0 4707.9 4662.5 4672.6 4676.9 4699.0 4711.2 5186.4 5226.7 5239.4 5257.3 5266.0 5548.1 5608.2 5608.7 5672.2 5681.8 5715.7 5717.9 5733.0 5745.5 5752.6 5281.4 5283.5 5287.0 5305.0 5308.4 5682.9 5742.5 5845.5 5848.6 5912.4 5503.6 5523.7 5533.3 5555.9 5572.6 5589.7 5629.3 5656.8 5672.6 5674.5 5520.3 5624.7 5649.6 5656.0 5662.4 5503.9 5566.7 5579.8 5589.6 5593.7 4613.6 4614.4 4615.3 4619.9 4661.8 4002.8 4004.1 4007.4 4036.6 4070.1 4703.4 4715.9 4736.2 4744.7 4829.3 5650.6 5663.2 5696.9 5714.7 5735.0 4760.7 4764.8 4780.7 4783.6 4812.0 4806.0 4876.4 4906.7 4949.1 4954.4 5260.6 5352.3 5365.9 5376.5 5393.4 5488.8 5522.9 5707.5 5719.2 5748.9 5250.4 5269.2 5333.8 5338.4 5346.3 5477.1 5559.5 5574.1 5578.7 5598.9 5602.8 5641.5 5653.3 5711.1 5738.0 5514.5 5556.5 5573.1 5574.4 5592.2 5536.9 5540.4 5545.6 5551.5 5566.5 5399.4 5469.5 5482.9 5483.6 5511.1 5415.5 5494.7 5495.6 5575.5 5589.0 5392.5 5405.6 5421.8 5449.3 5462.6 22:39:09 INFO - PID 16626 | 22:39:09 INFO - PID 16626 | [#1] ext.html Cycles:180 Average:28423.63 Median:3069.83 stddev:38586.82 (1257.0%) stddev-sans-first:38638.70 22:39:09 INFO - PID 16626 | Values: 648.5 714.5 731.6 1056.4 1074.7 31136.7 31948.2 31982.4 32035.0 32051.2 33586.3 33836.5 33938.8 33950.7 34089.7 6690.5 6841.5 6866.5 6982.9 6995.9 6764.4 6770.1 6865.5 6871.9 6879.7 6834.2 6876.7 6887.2 6889.1 6910.6 6830.1 6848.2 6851.7 6864.7 6867.5 6651.9 6723.3 6736.8 6739.4 6741.8 30857.2 30862.2 30960.0 31168.8 31198.7 2960.3 3002.9 3003.2 3005.0 3005.3 24243.3 24364.0 24478.9 24479.6 24490.8 3057.3 3082.4 3083.0 3089.1 3139.0 128891.0 131210.0 146419.3 147593.3 147756.0 36568.0 37444.4 37527.6 37537.4 37543.4 38792.4 39137.8 39155.8 39211.6 39279.2 11224.7 11436.7 11438.2 11447.8 11451.5 9122.2 9180.2 9183.0 9184.5 9239.0 12110.5 12154.7 12221.9 12261.6 12291.2 5070.7 5094.2 5113.4 5145.6 5170.0 825.5 857.7 873.2 881.7 883.4 19892.8 20581.9 20710.9 20915.4 20936.5 897.0 917.7 922.3 935.2 939.0 10344.0 10844.0 10862.8 10891.4 11033.1 181779.1 184405.1 184431.1 184657.0 184791.0 38342.6 38668.6 38674.8 38759.0 38764.0 1136.1 1170.6 1180.6 1181.5 1189.1 18635.3 19329.8 20019.2 20229.8 20360.6 28272.2 29956.1 30495.2 34433.5 35139.6 113996.0 114460.0 114643.4 114879.4 115534.3 26438.9 26469.6 26503.9 26572.6 26841.9 31348.5 32112.4 32499.5 32590.7 32889.0 24842.1 25424.9 25593.9 25892.0 26020.6 24866.8 24926.8 25175.4 26015.2 26159.6 27422.7 28061.3 28180.4 28283.2 28459.7 24296.6 24408.5 24475.1 25001.5 25688.9 19852.6 20310.6 20773.5 20783.7 20907.7 22:39:09 INFO - PID 16626 | 22:39:09 INFO - PID 16626 | [#2] jquery.html Cycles:180 Average:24689.35 Median:355408.50 stddev:60409.22 (17.0%) stddev-sans-first:60551.15 22:39:09 INFO - PID 16626 | Values: 397.9 401.0 421.8 428.7 433.0 12454.9 15609.3 16898.9 17543.4 17560.7 16660.7 17131.1 17211.1 17318.2 17417.9 5258.3 5386.5 5561.6 5563.7 5573.7 5263.1 5375.6 5389.1 5410.5 5410.8 5039.3 5310.2 5313.9 5320.7 5328.4 5115.1 5127.4 5129.0 5142.1 5157.1 4674.4 4745.7 4798.8 4804.0 4822.8 21178.2 21479.1 21500.0 21657.5 21742.7 1600.0 1651.8 1657.5 1662.3 1662.4 14181.1 14513.3 14659.9 14670.2 14706.6 2035.9 2048.7 2110.9 2116.5 2122.0 89488.0 90126.5 91186.1 94910.0 99712.5 10753.8 10856.6 11052.6 11080.9 11370.9 14059.9 15135.8 15157.2 15186.6 15203.3 7436.1 7437.0 7586.8 7713.8 7719.0 6790.1 6823.1 6880.9 6946.9 6970.2 6573.3 6675.6 6707.9 6721.3 6737.6 2022.5 2031.7 2057.3 2115.8 2164.6 800.9 830.4 835.9 842.5 859.9 16191.0 16320.7 16406.1 16512.7 17153.9 844.7 849.3 850.7 851.2 865.6 10783.1 11585.4 11655.2 11722.8 11792.4 354527.0 356290.0 356580.0 356867.0 380536.0 77962.0 78842.0 79224.0 79330.8 80818.0 1041.3 1053.1 1061.4 1061.9 1063.0 16657.3 17204.0 17396.6 17728.7 18066.7 38928.2 38990.3 39092.4 39173.6 40526.2 46920.3 48286.8 49059.0 49734.0 50142.5 8004.5 8013.5 8085.5 8249.5 8482.9 11380.5 11655.2 12073.6 12446.5 12684.3 10296.0 10628.7 10859.1 11012.7 11068.7 10045.4 10128.4 10207.4 10245.4 10357.4 10544.6 10574.7 10646.7 10849.1 11159.7 7895.4 8005.8 8075.4 8077.5 8189.1 10456.6 10539.4 10664.9 10744.4 10757.7 22:39:09 INFO - PID 16626 | 22:39:09 INFO - PID 16626 | [#3] mootools.html Cycles:180 Average:6190.15 Median:3396.17 stddev:4081.27 (120.2%) stddev-sans-first:4075.14 22:39:09 INFO - PID 16626 | Values: 1147.9 1204.9 1218.2 1223.0 1224.2 9684.9 10043.8 10052.3 10264.7 10551.7 10260.3 10395.0 10428.7 10438.8 10454.1 2151.2 2181.2 2182.2 2186.2 2190.0 2118.8 2139.1 2142.0 2145.9 2148.6 2111.3 2122.2 2135.2 2135.6 2135.7 2059.5 2063.9 2066.3 2067.7 2068.4 1887.9 1937.9 1948.2 2007.5 2082.8 9865.7 9939.5 9941.0 9947.9 9949.4 5296.1 5522.7 5543.0 5543.4 5556.1 3227.5 3321.1 3367.4 3383.7 3408.7 1100.9 1103.7 1111.0 1125.4 1127.8 14446.0 14541.2 14596.0 14641.8 14654.0 4310.0 4435.3 4606.9 4633.3 4642.6 10218.5 10272.0 10288.3 10298.5 10304.7 5376.4 5510.8 5522.1 5526.8 5530.0 5085.8 5099.6 5109.2 5128.0 5138.0 3863.5 3928.6 3941.3 3975.9 4038.7 1154.7 1165.1 1176.4 1191.3 1191.8 618.8 637.6 641.5 643.5 676.0 5206.2 5434.0 5492.4 5566.3 5643.8 794.8 824.9 831.7 837.7 845.1 3093.0 3096.2 3149.2 3231.0 3455.9 13043.7 13506.6 13518.0 13557.7 13661.0 13417.8 13510.1 13639.2 13685.9 13703.9 7340.8 7714.0 7800.8 7824.1 7824.5 5108.8 5374.9 5381.8 5502.6 5794.3 11848.9 12360.2 12413.8 12586.8 12587.0 12172.9 12467.9 12505.9 12645.2 12789.1 7852.2 8116.9 8238.5 8243.5 8258.8 9942.0 10033.3 10035.4 10036.2 10063.7 8006.4 8079.3 8134.9 8198.9 8352.2 7098.5 7198.9 7224.4 7261.3 7310.8 6747.8 6861.2 6911.4 6912.2 6912.7 5043.6 5065.6 5086.9 5087.0 5164.7 4871.5 4954.1 4975.3 4986.1 5020.1 22:39:09 INFO - PID 16626 | 22:39:09 INFO - PID 16626 | [#4] prototype.html Cycles:180 Average:4742.11 Median:5353.76 stddev:1402.75 (26.2%) stddev-sans-first:1367.56 22:39:09 INFO - PID 16626 | Values: 358.8 369.5 377.3 378.7 383.7 5343.4 5488.9 5491.7 5527.1 5532.1 5256.8 5321.7 5343.9 5346.9 5353.3 4092.0 4104.7 4106.2 4113.8 4115.0 3952.0 4107.7 4126.2 4126.2 4128.9 4084.6 4095.4 4098.0 4100.9 4104.2 4071.1 4073.3 4078.9 4079.6 4083.7 3572.3 3578.5 3581.5 3589.9 3591.2 5103.2 5222.1 5292.0 5295.9 5299.9 4789.7 4798.6 4828.3 4837.4 4849.7 5427.6 5702.5 5720.7 5723.7 5726.7 3993.5 4009.2 4013.1 4042.0 4046.6 5884.4 6006.0 6059.2 6059.9 6091.2 4061.1 4062.7 4076.3 4088.5 4090.1 4124.7 4133.7 4135.6 4136.6 4144.8 4706.6 4737.2 4775.6 4776.2 4789.0 5774.9 5776.6 5793.8 5803.4 5805.6 1422.6 1433.6 1437.5 1442.8 1444.2 916.5 940.8 974.6 978.8 982.7 5001.5 5003.6 5011.7 5015.6 5040.7 5972.8 5977.8 5991.6 6008.5 6027.1 4700.5 4906.2 4958.9 4964.2 5000.3 3108.6 3150.0 3159.2 3159.6 3178.5 5414.4 5544.8 5545.7 5584.4 5610.2 6064.4 6069.5 6074.8 6103.7 6132.5 5550.4 5571.7 5573.4 5592.3 5603.6 5814.3 5859.2 5894.0 5947.7 5955.0 5832.8 5861.9 5867.9 5868.4 5869.0 5354.3 5438.9 5494.5 5585.7 5599.5 4494.5 4524.5 4542.9 4550.3 4556.8 5853.5 5981.8 6014.9 6028.0 6031.2 5786.6 5795.7 5796.3 5798.8 5832.5 5739.5 5742.9 5776.2 5784.9 5788.3 5590.0 5647.9 5683.4 5689.3 5711.2 5765.5 5810.7 5813.2 5815.7 5829.4 5512.7 5567.1 5601.9 5613.5 5672.9 22:39:09 INFO - PID 16626 | 22:39:09 INFO - PID 16626 | [#5] yui.html Cycles:180 Average:17557.02 Median:4606.75 stddev:23025.66 (499.8%) stddev-sans-first:23055.38 22:39:09 INFO - PID 16626 | Values: 681.0 696.3 702.6 719.7 724.8 12252.0 12757.2 13591.8 14480.8 14506.4 14673.0 15310.2 15378.5 15385.8 15390.9 774.2 782.8 783.3 783.8 784.7 782.5 782.6 783.5 784.2 785.3 835.9 837.8 838.0 839.0 839.2 778.6 796.4 811.3 812.7 833.8 596.0 596.9 597.2 597.7 598.7 14233.2 14250.5 14283.0 14303.4 14313.2 14251.9 14336.3 14792.9 14859.3 14933.9 12405.7 12606.9 12653.1 12843.1 13045.2 2995.4 3001.6 3007.2 3014.1 3025.3 72588.0 72950.3 73460.0 73643.6 83558.0 12319.4 12561.2 12647.5 12656.7 12719.7 22041.3 22076.7 22260.6 22668.9 22699.1 6783.2 6803.6 6859.2 6861.7 6874.2 3060.3 3122.5 3126.1 3126.2 3129.8 3365.2 3366.5 3419.0 3443.2 3446.2 636.1 657.6 684.9 697.2 700.0 557.8 573.6 581.9 595.9 608.5 9304.0 9935.3 9989.7 10278.6 10334.9 565.9 568.6 569.0 584.4 599.0 4504.5 4709.0 4747.6 4809.3 4933.4 80559.0 82534.6 84501.6 85380.0 86246.6 77626.0 78249.2 78662.2 78707.0 79226.6 63333.4 65343.0 65878.0 66292.3 67612.7 8829.6 9059.7 9321.7 9361.4 9561.3 27705.2 27834.7 28734.7 29439.3 30307.4 51344.5 51602.7 52785.5 52997.0 55135.7 14619.3 14849.3 15003.6 15012.8 15050.7 15676.0 15931.8 16137.0 16528.4 16721.6 12918.7 14158.2 15073.2 15168.5 15469.1 14258.0 14578.9 15222.4 15275.7 15314.1 12732.9 12813.4 13052.9 13714.5 13953.2 9288.5 9862.9 10770.4 10976.8 11019.8 10671.8 10973.5 11091.1 11187.2 11207.9 22:39:09 INFO - PID 16626 | -------- Summary: end -------- 22:39:09 INFO - PID 16626 | 22:39:10 INFO - TEST-INFO | 16626: exit 0 22:39:10 INFO - TEST-OK | dromaeo_css | took 1148632ms 22:39:10 INFO - TEST-START | kraken 22:39:10 INFO - operating with platform_type : linux_ 22:39:10 INFO - Initialising browser for kraken test... 22:39:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44980/getInfo.html -profile /tmp/tmp0AKIuZ/profile 22:39:10 INFO - TEST-INFO | started process 17045 (/builds/slave/test/build/application/firefox/firefox http://localhost:44980/getInfo.html) 22:39:45 INFO - TEST-INFO | 17045: killed by SIGTERM 22:39:46 INFO - Browser initialized. 22:39:46 INFO - Running cycle 1/1 for kraken test... 22:39:46 INFO - TEST-INFO | started process 17268 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0AKIuZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:39:58 INFO - PID 17268 | RSS: Main: 187994112 22:39:58 INFO - PID 17268 | 22:40:00 INFO - PID 17268 | Cycle 1(1): loaded http://localhost:44980/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44980/tests/kraken/driver.html?testName=audio-beat-detection) 22:40:01 INFO - PID 17268 | RSS: Main: 191168512 22:40:01 INFO - PID 17268 | 22:40:04 INFO - PID 17268 | Cycle 1(1): loaded http://localhost:44980/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44980/tests/kraken/driver.html?testName=audio-dft) 22:40:05 INFO - PID 17268 | RSS: Main: 189833216 22:40:05 INFO - PID 17268 | 22:40:08 INFO - PID 17268 | Cycle 1(1): loaded http://localhost:44980/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44980/tests/kraken/driver.html?testName=audio-fft) 22:40:08 INFO - PID 17268 | RSS: Main: 186478592 22:40:08 INFO - PID 17268 | 22:40:10 INFO - PID 17268 | Cycle 1(1): loaded http://localhost:44980/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44980/tests/kraken/driver.html?testName=audio-oscillator) 22:40:11 INFO - PID 17268 | RSS: Main: 186875904 22:40:11 INFO - PID 17268 | 22:40:13 INFO - PID 17268 | Cycle 1(1): loaded http://localhost:44980/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44980/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:40:14 INFO - PID 17268 | RSS: Main: 186826752 22:40:14 INFO - PID 17268 | 22:40:17 INFO - PID 17268 | Cycle 1(1): loaded http://localhost:44980/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44980/tests/kraken/driver.html?testName=imaging-darkroom) 22:40:18 INFO - PID 17268 | RSS: Main: 191115264 22:40:18 INFO - PID 17268 | 22:40:21 INFO - PID 17268 | Cycle 1(1): loaded http://localhost:44980/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44980/tests/kraken/driver.html?testName=imaging-desaturate) 22:40:22 INFO - PID 17268 | RSS: Main: 187183104 22:40:22 INFO - PID 17268 | 22:40:25 INFO - PID 17268 | Cycle 1(1): loaded http://localhost:44980/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44980/tests/kraken/driver.html?testName=json-parse-financial) 22:40:25 INFO - PID 17268 | RSS: Main: 187572224 22:40:25 INFO - PID 17268 | 22:40:27 INFO - PID 17268 | Cycle 1(1): loaded http://localhost:44980/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44980/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:40:28 INFO - PID 17268 | RSS: Main: 187424768 22:40:28 INFO - PID 17268 | 22:40:29 INFO - PID 17268 | Cycle 1(1): loaded http://localhost:44980/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44980/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:40:30 INFO - PID 17268 | RSS: Main: 187043840 22:40:30 INFO - PID 17268 | 22:40:32 INFO - PID 17268 | Cycle 1(1): loaded http://localhost:44980/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44980/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:40:33 INFO - PID 17268 | RSS: Main: 187301888 22:40:33 INFO - PID 17268 | 22:40:36 INFO - PID 17268 | Cycle 1(1): loaded http://localhost:44980/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44980/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:40:36 INFO - PID 17268 | RSS: Main: 187891712 22:40:36 INFO - PID 17268 | 22:40:40 INFO - PID 17268 | Cycle 1(1): loaded http://localhost:44980/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44980/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:40:40 INFO - PID 17268 | RSS: Main: 187498496 22:40:40 INFO - PID 17268 | 22:40:42 INFO - PID 17268 | Cycle 1(1): loaded http://localhost:44980/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44980/tests/kraken/driver.html?testName=ai-astar) 22:40:42 INFO - PID 17268 | RSS: Main: 189140992 22:40:42 INFO - PID 17268 | 22:40:42 INFO - PID 17268 | __start_tp_report 22:40:42 INFO - PID 17268 | _x_x_mozilla_page_load 22:40:42 INFO - PID 17268 | _x_x_mozilla_page_load_details 22:40:42 INFO - PID 17268 | |i|pagename|runs| 22:40:42 INFO - PID 17268 | |0;ai-astar;102;109;111;111;110;117;110;110;112;115 22:40:42 INFO - PID 17268 | |1;audio-beat-detection;151;124;124;168;129;122;130;126;145;130 22:40:42 INFO - PID 17268 | |2;audio-dft;164;165;168;171;170;173;163;164;165;162 22:40:42 INFO - PID 17268 | |3;audio-fft;75;76;75;107;75;75;74;78;97;73 22:40:42 INFO - PID 17268 | |4;audio-oscillator;84;86;106;83;83;83;97;83;84;115 22:40:42 INFO - PID 17268 | |5;imaging-gaussian-blur;114;114;114;114;114;115;114;114;115;115 22:40:42 INFO - PID 17268 | |6;imaging-darkroom;151;152;150;150;151;151;152;150;152;151 22:40:42 INFO - PID 17268 | |7;imaging-desaturate;94;95;95;94;95;96;94;95;94;94 22:40:42 INFO - PID 17268 | |8;json-parse-financial;54;54;55;54;56;57;58;55;55;56 22:40:42 INFO - PID 17268 | |9;json-stringify-tinderbox;56;58;57;56;56;57;56;57;64;56 22:40:42 INFO - PID 17268 | |10;stanford-crypto-aes;86;88;86;89;87;86;87;89;113;87 22:40:42 INFO - PID 17268 | |11;stanford-crypto-ccm;144;141;139;142;136;136;132;139;134;132 22:40:42 INFO - PID 17268 | |12;stanford-crypto-pbkdf2;189;196;187;190;201;202;193;189;190;191 22:40:42 INFO - PID 17268 | |13;stanford-crypto-sha256-iterative;72;71;76;72;75;73;72;71;78;71 22:40:42 INFO - PID 17268 | __end_tp_report 22:40:42 INFO - PID 17268 | __start_cc_report 22:40:42 INFO - PID 17268 | _x_x_mozilla_cycle_collect,1036 22:40:42 INFO - PID 17268 | __end_cc_report 22:40:42 INFO - PID 17268 | __startTimestamp1495950042811__endTimestamp 22:40:42 INFO - PID 17268 | 22:40:42 INFO - PID 17268 | ------- Summary: start ------- 22:40:42 INFO - PID 17268 | Number of tests: 14 22:40:42 INFO - PID 17268 | 22:40:42 INFO - PID 17268 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:3.95 (3.6%) stddev-sans-first:2.65 22:40:42 INFO - PID 17268 | Values: 102.0 109.0 111.0 111.0 110.0 117.0 110.0 110.0 112.0 115.0 22:40:42 INFO - PID 17268 | 22:40:42 INFO - PID 17268 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:130.00 stddev:14.99 (11.5%) stddev-sans-first:14.73 22:40:42 INFO - PID 17268 | Values: 151.0 124.0 124.0 168.0 129.0 122.0 130.0 126.0 145.0 130.0 22:40:42 INFO - PID 17268 | 22:40:42 INFO - PID 17268 | [#2] audio-dft Cycles:10 Average:166.50 Median:166.50 stddev:3.75 (2.3%) stddev-sans-first:3.87 22:40:42 INFO - PID 17268 | Values: 164.0 165.0 168.0 171.0 170.0 173.0 163.0 164.0 165.0 162.0 22:40:42 INFO - PID 17268 | 22:40:42 INFO - PID 17268 | [#3] audio-fft Cycles:10 Average:80.50 Median:75.00 stddev:11.65 (15.5%) stddev-sans-first:12.18 22:40:42 INFO - PID 17268 | Values: 75.0 76.0 75.0 107.0 75.0 75.0 74.0 78.0 97.0 73.0 22:40:42 INFO - PID 17268 | 22:40:42 INFO - PID 17268 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:83.50 stddev:11.61 (13.9%) stddev-sans-first:12.08 22:40:42 INFO - PID 17268 | Values: 84.0 86.0 106.0 83.0 83.0 83.0 97.0 83.0 84.0 115.0 22:40:42 INFO - PID 17268 | 22:40:42 INFO - PID 17268 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 22:40:42 INFO - PID 17268 | Values: 114.0 114.0 114.0 114.0 114.0 115.0 114.0 114.0 115.0 115.0 22:40:42 INFO - PID 17268 | 22:40:42 INFO - PID 17268 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 22:40:42 INFO - PID 17268 | Values: 151.0 152.0 150.0 150.0 151.0 151.0 152.0 150.0 152.0 151.0 22:40:42 INFO - PID 17268 | 22:40:42 INFO - PID 17268 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 22:40:42 INFO - PID 17268 | Values: 94.0 95.0 95.0 94.0 95.0 96.0 94.0 95.0 94.0 94.0 22:40:42 INFO - PID 17268 | 22:40:42 INFO - PID 17268 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:1.35 (2.4%) stddev-sans-first:1.33 22:40:42 INFO - PID 17268 | Values: 54.0 54.0 55.0 54.0 56.0 57.0 58.0 55.0 55.0 56.0 22:40:42 INFO - PID 17268 | 22:40:42 INFO - PID 17268 | [#9] json-stringify-tinderbox Cycles:10 Average:57.30 Median:57.00 stddev:2.45 (4.3%) stddev-sans-first:2.55 22:40:42 INFO - PID 17268 | Values: 56.0 58.0 57.0 56.0 56.0 57.0 56.0 57.0 64.0 56.0 22:40:42 INFO - PID 17268 | 22:40:42 INFO - PID 17268 | [#10] stanford-crypto-aes Cycles:10 Average:89.80 Median:87.00 stddev:8.23 (9.5%) stddev-sans-first:8.61 22:40:42 INFO - PID 17268 | Values: 86.0 88.0 86.0 89.0 87.0 86.0 87.0 89.0 113.0 87.0 22:40:42 INFO - PID 17268 | 22:40:42 INFO - PID 17268 | [#11] stanford-crypto-ccm Cycles:10 Average:137.50 Median:139.00 stddev:4.17 (3.0%) stddev-sans-first:3.70 22:40:42 INFO - PID 17268 | Values: 144.0 141.0 139.0 142.0 136.0 136.0 132.0 139.0 134.0 132.0 22:40:42 INFO - PID 17268 | 22:40:42 INFO - PID 17268 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.80 Median:192.00 stddev:5.20 (2.7%) stddev-sans-first:5.33 22:40:42 INFO - PID 17268 | Values: 189.0 196.0 187.0 190.0 201.0 202.0 193.0 189.0 190.0 191.0 22:40:42 INFO - PID 17268 | 22:40:42 INFO - PID 17268 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:72.50 stddev:2.42 (3.3%) stddev-sans-first:2.54 22:40:42 INFO - PID 17268 | Values: 72.0 71.0 76.0 72.0 75.0 73.0 72.0 71.0 78.0 71.0 22:40:42 INFO - PID 17268 | -------- Summary: end -------- 22:40:42 INFO - PID 17268 | 22:40:44 INFO - TEST-INFO | 17268: exit 0 22:40:44 INFO - TEST-OK | kraken | took 93429ms 22:40:44 INFO - SUITE-END | took 1242s 22:40:44 INFO - Completed test suite (00:20:42) 22:40:44 INFO - javascript benchmark 22:40:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6637.072614004547, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2756.1318184771794, 2762.4337010912764, 2763.5163846326886, 2770.9584356234645, 2777.20849557876, 5125.179971204608, 5191.299174611427, 5236.89526209476, 5289.127293996496, 5304.575633949285, 5154.433012368637, 5213.218017297398, 5220.164773636219, 5353.197020446935, 5364.490373414519, 4659.836905708301, 4665.2768820832825, 4688.085823264456, 4690.038542098861, 4733.408323959505, 4633.1891918914225, 4705.552972467627, 4734.479207287196, 4735.408073990751, 4757.952420475803, 4598.770061496912, 4633.374494443241, 4671.85984420468, 4681.602063824579, 4728.314394412808, 4598.908021839545, 4677.158111539921, 4677.602403795648, 4697.03710739301, 4707.929381059287, 4662.53374662531, 4672.57946784791, 4676.883077923045, 4699.036697477009, 4711.151992641323, 5186.429492755794, 5226.660267082628, 5239.449857764918, 5257.316548848664, 5266.0, 5548.056830338852, 5608.2428872102155, 5608.747606357723, 5672.17396918095, 5681.829545113612, 5715.685637289947, 5717.914231286534, 5732.971335143297, 5745.482906538432, 5752.626079304873, 5281.366236051698, 5283.498067683564, 5287.0, 5305.0, 5308.389535203424, 5682.886342273214, 5742.511886489611, 5845.503132233723, 5848.64908105515, 5912.438318359749, 5503.6147469677535, 5523.7238138092935, 5533.3083364579425, 5555.944440555623, 5572.58205634579, 5589.74846131925, 5629.324481062299, 5656.802011929645, 5672.602917795714, 5674.517665998354, 5520.282363292747, 5624.6625202487985, 5649.6327738696855, 5656.038473459522, 5662.37713851476, 5503.889922201613, 5566.721663916869, 5579.832605021856, 5589.580781441408, 5593.692346920959, 4613.607843333354, 4614.423197100363, 4615.330777037378, 4619.884502887455, 4661.813527458931, 4002.8198731057173, 4004.0790618157985, 4007.35882258843, 4036.555978842325, 4070.1249231415386, 4703.365045718852, 4715.882102947454, 4736.218523943511, 4744.715317080986, 4829.323894654751, 5650.576206784425, 5663.178839068312, 5696.914546281809, 5714.685692286964, 5735.0250457422335, 4760.690555113906, 4764.8332308369045, 4780.713157210578, 4783.617310615143, 4811.9518804811505, 4805.951940480621, 4876.390451193601, 4906.681065730716, 4949.084419382426, 4954.430240522314, 5260.552853007537, 5352.250684904038, 5365.892682146413, 5376.489233522809, 5393.433689462707, 5488.807891723771, 5522.889542209053, 5707.514861236841, 5719.199312096393, 5748.936446757363, 5250.422453530032, 5269.1832765921345, 5333.839984800462, 5338.4127745947135, 5346.251524786455, 5477.123660214346, 5559.527440167631, 5574.136008918624, 5578.748956296895, 5598.916016259678, 5602.803901863578, 5641.492265696107, 5653.293338332708, 5711.143328500758, 5737.971310143423, 5514.531264842533, 5556.499915007668, 5573.052581061148, 5574.442555744393, 5592.217089607377, 5536.944630553643, 5540.445955404427, 5545.639533430314, 5551.472610102034, 5566.4990150885, 5399.379071406682, 5469.535089517435, 5482.890342193054, 5483.61614686984, 5511.063119269814, 5415.458454154553, 5494.670319780826, 5495.642783219078, 5575.498205161555, 5588.972055139861, 5392.460753924576, 5405.594580406407, 5421.837344879502, 5449.264349312951, 5462.590305727007], "value": 5123.916660592347, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.5246065201669, 714.506990176778, 731.6378392695615, 1056.4453661827545, 1074.656110044786, 31136.688633113663, 31948.20129496764, 31982.36035279293, 32035.0, 32051.19872003198, 33586.32827343452, 33836.49245261323, 33938.830305848496, 33950.66049339506, 34089.65910340896, 6690.464762818963, 6841.521093523455, 6866.485013623973, 6982.895256571155, 6995.930040699604, 6764.3573860483175, 6770.119884415044, 6865.519413641047, 6871.862562748742, 6879.724811007553, 6834.179898412172, 6876.656167191645, 6887.242403335654, 6889.069975553286, 6910.5853648780985, 6830.112085428863, 6848.246692863781, 6851.725930962781, 6864.725410983555, 6867.484938629623, 6651.93348066518, 6723.260441351447, 6736.7642132525125, 6739.427148692367, 6741.764038258638, 30857.228569285948, 30862.22844428885, 30960.0, 31168.8441557793, 31198.688013119805, 2960.3043284828263, 3002.9249268768235, 3003.1591154476782, 3005.023367405602, 3005.2637103909683, 24243.272701818973, 24364.0, 24478.877605612037, 24479.632805507932, 24490.755092449024, 3057.2968217310145, 3082.368114536537, 3082.9845850770826, 3089.0578373596045, 3139.02690166047, 128891.0, 131210.0, 146419.2679036598, 147593.26203368916, 147756.0, 36568.0, 37444.43833342502, 37527.62472375296, 37537.433943775846, 37543.43684844675, 38792.418113728316, 39137.804310978834, 39155.804220978716, 39211.607883921366, 39279.214415711525, 11224.66326010221, 11436.714082147846, 11438.199326047263, 11447.828282575769, 11451.484683189277, 9122.179003889682, 9180.21968132703, 9182.95408522953, 9184.494852783027, 9239.0, 12110.455029523693, 12154.696132596755, 12221.877781222252, 12261.632151035305, 12291.234472243852, 5070.670406423571, 5094.1849304111165, 5113.411957624847, 5145.562627176657, 5169.974150129226, 825.5253229393123, 857.7126662567985, 873.24028095556, 881.678187461572, 883.3595643158787, 19892.801071989095, 20581.883623275404, 20710.896445517676, 20915.37253882386, 20936.47658808542, 896.9551522423983, 917.7476194046691, 922.2760133295465, 935.1677007463363, 939.0327962198946, 10344.0, 10843.969822866815, 10862.837057444145, 10891.400972946405, 11033.117350611932, 181779.09110454362, 184405.07797460927, 184431.0778446126, 184657.0, 184791.0, 38342.616573834464, 38668.61331386706, 38674.80662596669, 38759.0, 38764.0, 1136.142212629476, 1170.6019953215778, 1180.6340034589305, 1181.4860535667012, 1189.0725234317074, 18635.254589816257, 19329.8067019328, 20019.199232031136, 20229.79770202279, 20360.59278814445, 28272.15183544497, 29956.101316960525, 30495.237619059702, 34433.48349774705, 35139.64860351466, 113996.0, 114460.0, 114643.42678286556, 114879.42560287144, 115534.33492488266, 26438.867805660848, 26469.60295595529, 26503.867480662473, 26572.601410979238, 26841.865790670923, 31348.52977205298, 32112.35775284528, 32499.512507311938, 32590.674093258764, 32889.0, 24842.130525432247, 25424.872875635505, 25593.872030639726, 25892.0, 26020.609690854275, 24866.751332486445, 24926.75073249317, 25175.37061573402, 26015.21954341373, 26159.607605886307, 27422.72577274202, 28061.298467538476, 28180.43639127247, 28283.15150545487, 28459.715402846534, 24296.635550466402, 24408.51182976295, 24475.143369981964, 25001.499970000863, 25688.8715556421, 19852.60294794125, 20310.59378812445, 20773.480662983548, 20783.688244676643, 20907.686384704546], "value": 13796.736564215247, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.8925690063685, 400.9830552321822, 421.81229352937936, 428.6913422335918, 432.9588689074539, 12454.937725311383, 15609.297581608826, 16898.915505422472, 17543.38598149065, 17560.73658895116, 16660.66678666426, 17131.057791821444, 17211.13944302786, 17318.220680069397, 17417.91291043546, 5258.290130832346, 5386.461353864622, 5561.5828812839, 5563.721813909288, 5573.665580065209, 5263.131583288753, 5375.569954403638, 5389.083855744513, 5410.458954104578, 5410.783568657249, 5039.344885164924, 5310.230016647583, 5313.867153321159, 5320.733963301839, 5328.440513746059, 5115.079285728568, 5127.359080114986, 5128.999845030221, 5142.100132476801, 5157.149070403379, 4674.368960190399, 4745.667803253774, 4798.7840547175465, 4804.0, 4822.782974766109, 21178.152873885025, 21479.140834366764, 21500.0, 21657.45856353588, 21742.673859892115, 1599.984000159995, 1651.7604947282696, 1657.527604632674, 1662.25198660602, 1662.393226472341, 14181.14913105217, 14513.274336283144, 14659.853401465956, 14670.166229221348, 14706.55880323592, 2035.8982050897396, 2048.6517292060385, 2110.883901385423, 2116.5237821490196, 2121.9787802121937, 89488.0, 90126.5493672534, 91186.08813911842, 94910.0, 99712.50143749235, 10753.784924301626, 10856.565737370416, 11052.602791493331, 11080.944595276973, 11370.943145284386, 14059.929700351433, 15135.848641513443, 15157.166355850533, 15186.620334491505, 15203.31585078652, 7436.107667079985, 7436.962815185998, 7586.772396828104, 7713.807154821062, 7718.961405192938, 6790.11728475305, 6823.080667110375, 6880.862382752317, 6946.895796563055, 6970.163580370287, 6573.342665733484, 6675.599464032173, 6707.865842683216, 6721.328676569835, 6737.562058466184, 2022.48426651203, 2031.7358743363268, 2057.331367305632, 2115.7672656007826, 2164.599549083425, 800.9038915330198, 830.4394533689735, 835.9038710548365, 842.4987132656059, 859.9269062129664, 16190.976127984002, 16320.694344452415, 16406.09766462832, 16512.66974660524, 17153.914230429018, 844.7254642241296, 849.2526576612541, 850.6682393866397, 851.1871163039283, 865.5845194306768, 10783.13734901206, 11585.362805045803, 11655.1910220151, 11722.827717228209, 11792.41037948099, 354527.0, 356290.0, 356580.0, 356867.0, 380536.0, 77962.0, 78842.0, 79224.0, 79330.81003784949, 80818.0, 1041.3335465302212, 1053.1311667874033, 1061.4374381577777, 1061.9221490187313, 1062.9681109566725, 16657.333706652083, 17204.0, 17396.565085872448, 17728.734068988717, 18066.728999065286, 38928.221435570566, 38990.273413497685, 39092.413613795245, 39173.608263917, 40526.18947620972, 46920.29619555641, 48286.75856620695, 49059.0, 49734.0, 50142.498575013786, 8004.479708818908, 8013.4791238569305, 8085.514869107637, 8249.505029698237, 8482.897223360924, 11380.487878045673, 11655.18413711032, 12073.637790866289, 12446.502139914302, 12684.302363370103, 10296.0, 10628.734281642712, 10859.07697845692, 11012.724681883017, 11068.730910163558, 10045.447500387256, 10128.392296462236, 10207.438590877573, 10245.385276883411, 10357.378557286587, 10544.57821687124, 10574.682759517227, 10646.680599582025, 10849.132069434268, 11159.665210043711, 7895.447318687637, 8005.759827205193, 8075.434719569574, 8077.515349079074, 8189.099199087977, 10456.58173673075, 10539.367637941748, 10664.946675266574, 10744.355338679705, 10757.677269681923], "value": 8714.636217327667, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1147.9081673466121, 1204.9096317776168, 1218.1716432825674, 1222.9510819567217, 1224.185916365617, 9684.854727179098, 10043.849342259871, 10052.346597471169, 10264.692059238216, 10551.73620659482, 10260.333078349902, 10395.0, 10428.687139385811, 10438.843417348728, 10454.059134677878, 2151.150295633224, 2181.2474696229856, 2182.181681869299, 2186.2457452178974, 2189.9562008759895, 2118.8410869184795, 2139.12295958657, 2141.9785802142014, 2145.903434345458, 2148.602508535918, 2111.345482900306, 2122.1935664447487, 2135.1993002624017, 2135.5728854229137, 2135.6689713094415, 2059.4851287178208, 2063.8555301128927, 2066.2664754012335, 2067.6795096760025, 2068.441520789386, 1887.9433616991512, 1937.8740381875134, 1948.2012374926353, 2007.5081605006867, 2082.8437867160023, 9865.704028879145, 9939.453330066915, 9941.0, 9947.850782238273, 9949.403035817873, 5296.126139187029, 5522.723863806834, 5543.029969755276, 5543.445655434464, 5556.111022236423, 3227.483602623569, 3321.1199032256472, 3367.410703126943, 3383.678550537695, 3408.659134086596, 1100.9119270458343, 1103.7240689827543, 1111.0, 1125.4372813593204, 1127.7575321305958, 14446.0, 14541.200233987127, 14596.0, 14641.780373294303, 14654.0, 4309.956900431018, 4435.3125265583885, 4606.907861842745, 4633.2818413146015, 4642.5821676048645, 10218.540165692562, 10272.0, 10288.2798204125, 10298.485075746183, 10304.690859274233, 5376.4085950545405, 5510.779568817283, 5522.061249587579, 5526.834194974157, 5529.972350138223, 5085.771140298695, 5099.59203263738, 5109.233614957786, 5127.97436012825, 5138.049460849755, 3863.459115723801, 3928.5678575356687, 3941.3496773032703, 3975.8530393587716, 4038.656714179269, 1154.7113221694576, 1165.0854079547514, 1176.3823992403886, 1191.2614179208772, 1191.8331433599303, 618.8421952402109, 637.6078711592337, 641.4643772450056, 643.5077165968038, 676.0298970976664, 5206.245094461282, 5433.972830135824, 5492.423295553989, 5566.332040155126, 5643.830685079454, 794.8171920458211, 824.9275941276317, 831.7338451695399, 837.7319257837555, 845.0662018469626, 3092.9536056959164, 3096.1949893027977, 3149.2441813964483, 3231.04684118181, 3455.8963231103107, 13043.739125217442, 13506.59480215595, 13518.0, 13557.728845423037, 13661.043726939217, 13417.798733019012, 13510.121842080232, 13639.181649101085, 13685.931570342284, 13703.862961370458, 7340.816479588053, 7714.0, 7800.804979875548, 7824.139344672081, 7824.452288339761, 5108.846734597968, 5374.892502149857, 5381.838544843661, 5502.559795216293, 5794.333651629948, 11848.881511184778, 12360.196587221802, 12413.813792793297, 12586.811197832223, 12587.0, 12172.878271217529, 12467.875321247035, 12505.874941250471, 12645.178063425848, 12789.104762666524, 7852.214778522102, 8116.878246826184, 8238.464499807733, 8243.464174828618, 8258.83482330338, 9941.950290248502, 10033.347832390871, 10035.397876127456, 10036.19710423179, 10063.74840628961, 8006.359491240803, 8079.272865442138, 8134.918650813416, 8198.918010819816, 8352.206540378655, 7098.467614928798, 7198.8920166198595, 7224.385927196037, 7261.346478816932, 7310.817229569303, 6747.763828265987, 6861.210960739579, 6911.3779759821855, 6912.239653638197, 6912.688928998307, 5043.571296439697, 5065.56942659878, 5086.898262034664, 5086.9745651271505, 5164.741762911764, 4871.464138944642, 4954.058728841508, 4975.253711943237, 4986.102501549756, 5020.071286811952], "value": 4620.259834960667, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.81341702314796, 369.4790345612685, 377.3208225194649, 378.70839453620704, 383.6738772043765, 5343.438938911417, 5488.890222195559, 5491.725413729312, 5527.143292789614, 5532.1425179097305, 5256.842294731155, 5321.733913304339, 5343.919841202385, 5346.866328341794, 5353.277307563478, 4091.9795401023102, 4104.733192342488, 4106.1992911382295, 4113.814878330468, 4115.0, 3952.0, 4107.693306887954, 4126.216018956404, 4126.216018956404, 4128.938065929014, 4084.611961863633, 4095.4061661059127, 4097.979510102446, 4100.876973690794, 4104.240715467633, 4071.104357041461, 4073.307537718595, 4078.9184216315803, 4079.551759125512, 4083.734557253769, 3572.2676851245433, 3578.481120237551, 3581.4985901973746, 3589.910252243689, 3591.2278860045217, 5103.23451482277, 5222.112240919015, 5292.047431462335, 5295.867603309909, 5299.947000530023, 4789.712617242976, 4798.616110711169, 4828.324034635154, 4837.436158835822, 4849.684770489942, 5427.62006659534, 5702.460335709336, 5720.71396430181, 5723.685197314146, 5726.656400615976, 3993.4608827808456, 4009.2382447334912, 4013.0769922917602, 4042.0097076216516, 4046.615571520701, 5884.382139875337, 6005.969970150165, 6059.151718759377, 6059.909101363439, 6091.208142941434, 4061.147159096564, 4062.7156099073372, 4076.30702780528, 4088.5298190707854, 4090.1001779608437, 4124.670026397881, 4133.6693064554765, 4135.58644135584, 4136.607022332873, 4144.8134833932545, 4706.623470122382, 4737.218358970731, 4775.594074503637, 4776.202918679658, 4789.0, 5774.913376299359, 5776.620676904058, 5793.768249270066, 5803.390643982321, 5805.593608447368, 1422.6301161698034, 1433.605758416423, 1437.4537675683382, 1442.8052212951327, 1444.162385816245, 916.5188276154938, 940.8118376324762, 974.6345120579782, 978.7846673731767, 982.7101005203482, 5001.549860512571, 5003.649744517922, 5011.674241174312, 5015.6489045767175, 5040.747962601855, 5972.761089556456, 5977.79077732286, 5991.58058935879, 6008.459238668541, 6027.126066720301, 4700.529947005272, 4906.190478571068, 4958.9008219835405, 4964.180910149785, 5000.324956130876, 3108.6114235720534, 3150.023492717265, 3159.210197450637, 3159.620845498555, 3178.4596618574897, 5414.40441551429, 5544.833654990357, 5545.696761261101, 5584.413636568183, 5610.214569960209, 6064.423879731418, 6069.51443884497, 6074.817755467343, 6103.725332360054, 6132.478739307209, 5550.38945715979, 5571.749271282802, 5573.442655734394, 5592.273004509388, 5603.551715862721, 5814.331351894586, 5859.150423188699, 5893.998020336639, 5947.702614869153, 5955.0, 5832.825015249549, 5861.853453663693, 5867.882642347044, 5868.413158684098, 5868.970655146697, 5354.250404943233, 5438.918416223681, 5494.532964698045, 5585.720713964367, 5599.524040456607, 4494.528074552256, 4524.5249248828395, 4542.863714088583, 4550.294704320836, 4556.840510582114, 5853.473187413153, 5981.820545383645, 6014.879702406015, 6027.969860150672, 6031.155638210566, 5786.623869448473, 5795.7391917362975, 5796.275465566804, 5798.768049277982, 5832.533397328119, 5739.540836733135, 5742.885142297047, 5776.162456443876, 5784.884302313846, 5788.334341550775, 5589.972050139723, 5647.858803529944, 5683.431656834284, 5689.260396148474, 5711.171880077449, 5765.4522820332, 5810.68041257718, 5813.244278243801, 5815.6510609361885, 5829.387914268941, 5512.6692398456225, 5567.137093750475, 5601.943980560142, 5613.522850557748, 5672.914906276492], "value": 4306.389740137748, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [680.9761658341959, 696.2584847137799, 702.5573888450275, 719.7193094693071, 724.7716969154716, 12252.0, 12757.234565926052, 13591.79612305815, 14480.782788258171, 14506.419743210272, 14673.0, 15310.234488275597, 15378.461753838617, 15385.769213461806, 15390.923045384785, 774.1909704358944, 782.8316911863948, 783.2676447521557, 783.8471498057881, 784.7175016993878, 782.4874707066851, 782.5969625642798, 783.4633276205789, 784.2197013971078, 785.2696991797626, 835.9164083591622, 837.7654256808104, 838.0, 838.9622466989, 839.215333663024, 778.6418247606108, 796.3589310604932, 811.3022800391717, 812.7358608452276, 833.754042557444, 596.0463258785951, 596.8627215740361, 597.1699337920294, 597.7101105963604, 598.6767145741294, 14233.217173055582, 14250.501232456814, 14283.0, 14303.427862885575, 14313.212773297464, 14251.857481425157, 14336.283185840666, 14792.852071479363, 14859.331330090172, 14933.850661493354, 12405.689857753538, 12606.873931260754, 12653.051021173449, 12843.100982931199, 13045.217286962812, 2995.4009198160456, 3001.564773107909, 3007.1579957611903, 3014.110837302979, 3025.2890570715863, 72588.0, 72950.27049729488, 73460.0, 73643.63178184128, 83558.0, 12319.384030798425, 12561.246325220516, 12647.494100236072, 12656.74686506283, 12719.682007949876, 22041.338759837232, 22076.668849966944, 22260.55478890413, 22668.886655566945, 22699.092036318692, 6783.18601767791, 6803.557768745016, 6859.211190713132, 6861.691223894937, 6874.175098988154, 3060.342026464321, 3122.5160100184507, 3126.1403114143336, 3126.155937896755, 3129.8435078246, 3365.175531994628, 3366.5118557808983, 3418.9658103419147, 3443.1564266754303, 3446.1556918555116, 636.0935666674969, 657.6021506988299, 684.9452043836482, 697.1564407067403, 699.9580025198504, 557.760163129858, 573.6357413042665, 581.8545363659085, 595.928488581373, 608.5253502268238, 9304.0, 9935.254855885838, 9989.650362237433, 10278.588856445658, 10334.896651033543, 565.8500497368201, 568.6133429268137, 568.9857753556195, 584.360125662399, 598.9700514974234, 4504.504504504502, 4709.0, 4747.643926705511, 4809.278608208727, 4933.407991041098, 80559.0, 82534.58732706298, 84501.57749211215, 85380.0, 86246.56876715577, 77626.0, 78249.21750782533, 78662.21337786548, 78707.0, 79226.6038669803, 63333.36666633367, 65343.0, 65878.0, 66292.33707662958, 67612.66193669, 8829.60266788009, 9059.728208153765, 9321.673741419017, 9361.391509551857, 9561.282903782105, 27705.168844934684, 27834.721652783213, 28734.712652873204, 29439.26401839971, 30307.393852122394, 51344.48655513397, 51602.74198628983, 52785.47214527806, 52997.0, 55135.72432137813, 14619.269036548343, 14849.331780069706, 15003.624909377353, 15012.849871501145, 15050.698986020438, 15676.0, 15931.761023584888, 16136.95109817905, 16528.42150524774, 16721.5819604506, 12918.741625167257, 14158.150510969375, 15073.246337682853, 15168.544943651708, 15469.149196794284, 14258.02519707103, 14578.854211458174, 15222.391104356144, 15275.694486110438, 15314.081155130281, 12732.936335318635, 12813.359332033175, 13052.934735326262, 13714.451421943011, 13953.232572208626, 9288.489133097744, 9862.852057219005, 10770.353778773298, 10976.835347469634, 11019.779604407706, 10671.786564268827, 10973.451327433757, 11091.112710983263, 11187.21689481761, 11207.943960280147], "value": 6973.027969904594, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 109.0, 111.0, 111.0, 110.0, 117.0, 110.0, 110.0, 112.0, 115.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 124.0, 168.0, 129.0, 122.0, 130.0, 126.0, 145.0, 130.0], "value": 134.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 168.0, 171.0, 170.0, 173.0, 163.0, 164.0, 165.0, 162.0], "value": 166.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 107.0, 75.0, 75.0, 74.0, 78.0, 97.0, 73.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 106.0, 83.0, 83.0, 83.0, 97.0, 83.0, 84.0, 115.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 115.0, 115.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 150.0, 150.0, 151.0, 151.0, 152.0, 150.0, 152.0, 151.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 96.0, 94.0, 95.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 54.0, 56.0, 57.0, 58.0, 55.0, 55.0, 56.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 57.0, 56.0, 56.0, 57.0, 56.0, 57.0, 64.0, 56.0], "value": 57.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 86.0, 89.0, 87.0, 86.0, 87.0, 89.0, 113.0, 87.0], "value": 89.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 141.0, 139.0, 142.0, 136.0, 136.0, 132.0, 139.0, 134.0, 132.0], "value": 137.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 196.0, 187.0, 190.0, 201.0, 202.0, 193.0, 189.0, 190.0, 191.0], "value": 192.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 76.0, 72.0, 75.0, 73.0, 72.0, 71.0, 78.0, 71.0], "value": 73.1, "unit": "score"}]}]} 22:40:44 INFO - Return code: 0 22:40:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:40:44 INFO - # TBPL SUCCESS # 22:40:44 INFO - Running post-action listener: _resource_record_post_action 22:40:44 INFO - [mozharness: 2017-05-28 05:40:44.614317Z] Finished run-tests step (success) 22:40:44 INFO - Running post-run listener: _resource_record_post_run 22:40:44 INFO - Total resource usage - Wall time: 1259s; CPU: 13.0%; Read bytes: 4096; Write bytes: 409251840; Read time: 12; Write time: 218892 22:40:44 INFO - TinderboxPrint: CPU usage
12.7% 22:40:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 22:40:44 INFO - TinderboxPrint: I/O write bytes / time
409,251,840 / 218,892 22:40:44 INFO - TinderboxPrint: CPU idle
8,772.0 (87.3%) 22:40:44 INFO - TinderboxPrint: CPU user
1,223.2 (12.2%) 22:40:44 INFO - TinderboxPrint: Swap in / out
0 / 0 22:40:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99577856; Read time: 0; Write time: 58512 22:40:44 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 22:40:44 INFO - run-tests - Wall time: 1243s; CPU: 13.0%; Read bytes: 0; Write bytes: 309673984; Read time: 0; Write time: 160380 22:40:45 INFO - Running post-run listener: _upload_blobber_files 22:40:45 INFO - Blob upload gear active. 22:40:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:40:45 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 22:40:45 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'] 22:40:45 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 22:40:45 INFO - (blobuploader) - INFO - Open directory for files ... 22:40:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:40:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:40:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:40:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:40:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:40:46 INFO - (blobuploader) - INFO - Done attempting. 22:40:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:40:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:40:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:40:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:40:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:40:47 INFO - (blobuploader) - INFO - Done attempting. 22:40:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:40:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:40:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:40:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:40:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:40:54 INFO - (blobuploader) - INFO - Done attempting. 22:40:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:40:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:40:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:40:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:40:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:40:56 INFO - (blobuploader) - INFO - Done attempting. 22:40:56 INFO - (blobuploader) - INFO - Iteration through files over. 22:40:56 INFO - Return code: 0 22:40:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:40:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:40:56 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25e21986712e1f859c6826bf268c196005dcaa34ce551644b2b68c8740e9a1c37831e2bf4e670feb87c01111cfa042fcafafff5e07b0a0f11a8342eda570b502", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd41455bbdbba1f1a276497fc32befb65a7d17c4f3324a8e0315549343029ed808d8471e758cc263cbe7ab3272dccd7611fe2d390caa7409bbf42a39bd2872cb", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ed3661d1febf7000551c44717ab5feaac1ddc76b5e590b13a4a57d7ee55a759077df51557ba017140224f6e51a225c7b26b57335d666f9ae156810b5e8bb0ac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d848d2673c69d6bd5e4e6ce917aa4f7c4f506c4596ffc9a12ffa7870c9e4785b67938e650c2f6c8677d6cc93f1c7db6f125102905fa57e3ad6d94e60f70b2242"} 22:40:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:40:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:40:56 INFO - Contents: 22:40:56 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25e21986712e1f859c6826bf268c196005dcaa34ce551644b2b68c8740e9a1c37831e2bf4e670feb87c01111cfa042fcafafff5e07b0a0f11a8342eda570b502", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd41455bbdbba1f1a276497fc32befb65a7d17c4f3324a8e0315549343029ed808d8471e758cc263cbe7ab3272dccd7611fe2d390caa7409bbf42a39bd2872cb", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ed3661d1febf7000551c44717ab5feaac1ddc76b5e590b13a4a57d7ee55a759077df51557ba017140224f6e51a225c7b26b57335d666f9ae156810b5e8bb0ac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d848d2673c69d6bd5e4e6ce917aa4f7c4f506c4596ffc9a12ffa7870c9e4785b67938e650c2f6c8677d6cc93f1c7db6f125102905fa57e3ad6d94e60f70b2242"} 22:40:56 INFO - Running post-run listener: copy_logs_to_upload_dir 22:40:56 INFO - Copying logs to upload dir... 22:40:56 INFO - mkdir: /builds/slave/test/build/upload/logs 22:40:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1325.722096 ========= master_lag: -0.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 5 secs) (at 2017-05-27 22:40:55.943508) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-27 22:40:55.952120) ========= 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=fcadb68e09dcf59683000ff6000001dc-1495936891.696796-806549916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25e21986712e1f859c6826bf268c196005dcaa34ce551644b2b68c8740e9a1c37831e2bf4e670feb87c01111cfa042fcafafff5e07b0a0f11a8342eda570b502", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd41455bbdbba1f1a276497fc32befb65a7d17c4f3324a8e0315549343029ed808d8471e758cc263cbe7ab3272dccd7611fe2d390caa7409bbf42a39bd2872cb", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ed3661d1febf7000551c44717ab5feaac1ddc76b5e590b13a4a57d7ee55a759077df51557ba017140224f6e51a225c7b26b57335d666f9ae156810b5e8bb0ac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d848d2673c69d6bd5e4e6ce917aa4f7c4f506c4596ffc9a12ffa7870c9e4785b67938e650c2f6c8677d6cc93f1c7db6f125102905fa57e3ad6d94e60f70b2242"} build_url:https://queue.taskcluster.net/v1/task/ZBc7qSKBRC-nGb-P0BBYsg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011463 build_url: 'https://queue.taskcluster.net/v1/task/ZBc7qSKBRC-nGb-P0BBYsg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25e21986712e1f859c6826bf268c196005dcaa34ce551644b2b68c8740e9a1c37831e2bf4e670feb87c01111cfa042fcafafff5e07b0a0f11a8342eda570b502", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd41455bbdbba1f1a276497fc32befb65a7d17c4f3324a8e0315549343029ed808d8471e758cc263cbe7ab3272dccd7611fe2d390caa7409bbf42a39bd2872cb", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ed3661d1febf7000551c44717ab5feaac1ddc76b5e590b13a4a57d7ee55a759077df51557ba017140224f6e51a225c7b26b57335d666f9ae156810b5e8bb0ac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d848d2673c69d6bd5e4e6ce917aa4f7c4f506c4596ffc9a12ffa7870c9e4785b67938e650c2f6c8677d6cc93f1c7db6f125102905fa57e3ad6d94e60f70b2242"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-27 22:40:55.975942) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 22:40:55.976603) ========= 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=fcadb68e09dcf59683000ff6000001dc-1495936891.696796-806549916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 22:40:56.060439) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-27 22:40:56.062767) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-27 22:40:56.063075) ========= ========= Total master_lag: 0.04 =========