builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-047 starttime: 1496319835.61 results: success (0) revision: d96110d766199d42524558fd83e6467906de4daf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-01 05:23:55.607197) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-01 05:23:55.607564) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-01 05:23:55.607831) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-01 05:23:55.644614) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 05:23:55.644886) ========= 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=03627c79f6bb3d1578c4a402000001ba-1496295146.881499-1967056701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-01 05:23:56-- 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% 215M=0s 2017-06-01 05:23:56 (215 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.142129 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 05:23:55.799566) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 05:23:55.799904) ========= 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=03627c79f6bb3d1578c4a402000001ba-1496295146.881499-1967056701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020852 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 05:23:55.849348) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-01 05:23:55.849640) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d96110d766199d42524558fd83e6467906de4daf --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 d96110d766199d42524558fd83e6467906de4daf --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=03627c79f6bb3d1578c4a402000001ba-1496295146.881499-1967056701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-01 05:23:56,376 truncating revision to first 12 chars 2017-06-01 05:23:56,376 Setting DEBUG logging. 2017-06-01 05:23:56,376 attempt 1/10 2017-06-01 05:23:56,376 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d96110d76619?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-01 05:23:57,812 unpacking tar archive at: mozilla-central-d96110d76619/testing/mozharness/ program finished with exit code 0 elapsedTime=1.784716 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-01 05:23:57.646373) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-01 05:23:57.646757) ========= script_repo_revision: d96110d766199d42524558fd83e6467906de4daf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-01 05:23:57.650174) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-01 05:23:57.650449) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-01 05:23:57.658788) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-06-01 05:23:57.659100) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=03627c79f6bb3d1578c4a402000001ba-1496295146.881499-1967056701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:23:58 INFO - MultiFileLogger online at 20170601 05:23:58 in /builds/slave/test 05:23:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 05:23:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:23:58 INFO - {'append_to_log': False, 05:23:58 INFO - 'base_work_dir': '/builds/slave/test', 05:23:58 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:23:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:23:58 INFO - 'branch': 'Firefox-Non-PGO', 05:23:58 INFO - 'buildbot_json_path': 'buildprops.json', 05:23:58 INFO - 'config_files': ('talos/linux_config.py',), 05:23:58 INFO - 'default_actions': ('clobber', 05:23:58 INFO - 'read-buildbot-config', 05:23:58 INFO - 'download-and-extract', 05:23:58 INFO - 'populate-webroot', 05:23:58 INFO - 'create-virtualenv', 05:23:58 INFO - 'install', 05:23:58 INFO - 'setup-mitmproxy', 05:23:58 INFO - 'run-tests'), 05:23:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:23:58 INFO - 'download_minidump_stackwalk': True, 05:23:58 INFO - 'download_symbols': 'ondemand', 05:23:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:23:58 INFO - 'tooltool.py': '/tools/tooltool.py', 05:23:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:23:58 INFO - '/tools/misc-python/virtualenv.py')}, 05:23:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:23:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:23:58 INFO - 'gecko_profile': False, 05:23:58 INFO - 'gecko_profile_interval': 0, 05:23:58 INFO - 'installer_path': 'installer.exe', 05:23:58 INFO - 'log_level': 'info', 05:23:58 INFO - 'log_name': 'talos', 05:23:58 INFO - 'log_to_console': True, 05:23:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:23:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:23:58 INFO - 'opt_config_files': (), 05:23:58 INFO - 'pip_index': False, 05:23:58 INFO - 'suite': 'dromaeojs-e10s', 05:23:58 INFO - 'system_bits': '32', 05:23:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:23:58 INFO - 'title': 'talos-linux64-ix-047', 05:23:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:23:58 INFO - 'use_talos_json': True, 05:23:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:23:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:23:58 INFO - 'work_dir': 'build'} 05:23:58 INFO - [mozharness: 2017-06-01 12:23:58.291167Z] Running clobber step. 05:23:58 INFO - Running pre-action listener: _resource_record_pre_action 05:23:58 INFO - Running main action method: clobber 05:23:58 INFO - rmtree: /builds/slave/test/build 05:23:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:23:59 INFO - Running post-action listener: _resource_record_post_action 05:23:59 INFO - [mozharness: 2017-06-01 12:23:59.322889Z] Finished clobber step (success) 05:23:59 INFO - [mozharness: 2017-06-01 12:23:59.322991Z] Running read-buildbot-config step. 05:23:59 INFO - Running pre-action listener: _resource_record_pre_action 05:23:59 INFO - Running main action method: read_buildbot_config 05:23:59 INFO - Using buildbot properties: 05:23:59 INFO - { 05:23:59 INFO - "project": "", 05:23:59 INFO - "product": "firefox", 05:23:59 INFO - "who": "cbook@mozilla.com", 05:23:59 INFO - "installer_path": "public/build/target.tar.bz2", 05:23:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:23:59 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:23:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:23:59 INFO - "stage_platform": "linux64", 05:23:59 INFO - "basedir": "/builds/slave/test", 05:23:59 INFO - "buildnumber": 647, 05:23:59 INFO - "platform": "ubuntu64_hw", 05:23:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:23:59 INFO - "slavebuilddir": "test", 05:23:59 INFO - "taskId": "CddgqQkJRdK9VCgIFI3SeA", 05:23:59 INFO - "branch": "mozilla-central", 05:23:59 INFO - "script_repo_revision": "production", 05:23:59 INFO - "revision": "d96110d766199d42524558fd83e6467906de4daf", 05:23:59 INFO - "slavename": "talos-linux64-ix-047", 05:23:59 INFO - "repo_path": "mozilla-central" 05:23:59 INFO - } 05:23:59 INFO - Finding installer, test and symbols from parent task. 05:23:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CddgqQkJRdK9VCgIFI3SeA'}, attempt #1 05:23:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CddgqQkJRdK9VCgIFI3SeA'}, attempt #1 05:24:00 INFO - Task dependencies: Ro0Rl2LfRSGgyEBMSucrag 05:24:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ro0Rl2LfRSGgyEBMSucrag'}, attempt #1 05:24:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Ro0Rl2LfRSGgyEBMSucrag/artifacts/public/build/target.tar.bz2 05:24:00 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Ro0Rl2LfRSGgyEBMSucrag/artifacts/public/build/test_packages.json 05:24:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Ro0Rl2LfRSGgyEBMSucrag/artifacts/public/build/target.crashreporter-symbols.zip 05:24:00 INFO - Running post-action listener: _resource_record_post_action 05:24:00 INFO - [mozharness: 2017-06-01 12:24:00.671929Z] Finished read-buildbot-config step (success) 05:24:00 INFO - [mozharness: 2017-06-01 12:24:00.672149Z] Running download-and-extract step. 05:24:00 INFO - Running pre-action listener: _resource_record_pre_action 05:24:00 INFO - Running main action method: download_and_extract 05:24:00 INFO - mkdir: /builds/slave/test/build/tests 05:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:00 INFO - trying https://queue.taskcluster.net/v1/task/Ro0Rl2LfRSGgyEBMSucrag/artifacts/public/build/target.test_packages.json 05:24:00 INFO - Downloading https://queue.taskcluster.net/v1/task/Ro0Rl2LfRSGgyEBMSucrag/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:24:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ro0Rl2LfRSGgyEBMSucrag/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:24:01 INFO - Downloaded 986 bytes. 05:24:01 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:24:01 INFO - Using the following test package requirements: 05:24:01 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:24:01 INFO - u'common': [u'target.common.tests.zip'], 05:24:01 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:24:01 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:24:01 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:24:01 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:24:01 INFO - u'mozbase': [u'target.common.tests.zip'], 05:24:01 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:24:01 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:24:01 INFO - u'web-platform': [u'target.common.tests.zip', 05:24:01 INFO - u'target.web-platform.tests.zip'], 05:24:01 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:24:01 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:24:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ro0Rl2LfRSGgyEBMSucrag/artifacts/public/build/target.common.tests.zip 05:24:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ro0Rl2LfRSGgyEBMSucrag/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:24:01 INFO - Fetch https://queue.taskcluster.net/v1/task/Ro0Rl2LfRSGgyEBMSucrag/artifacts/public/build/target.common.tests.zip into memory 05:24:02 INFO - Content-Length response header: 63535461 05:24:02 INFO - Bytes received: 63535461 05:24:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:24:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ro0Rl2LfRSGgyEBMSucrag/artifacts/public/build/target.common.tests.zip 05:24:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ro0Rl2LfRSGgyEBMSucrag/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:24:13 INFO - Fetch https://queue.taskcluster.net/v1/task/Ro0Rl2LfRSGgyEBMSucrag/artifacts/public/build/target.common.tests.zip into memory 05:24:14 INFO - Content-Length response header: 63535461 05:24:14 INFO - Bytes received: 63535461 05:24:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ro0Rl2LfRSGgyEBMSucrag/artifacts/public/build/target.talos.tests.zip 05:24:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ro0Rl2LfRSGgyEBMSucrag/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:24:26 INFO - Fetch https://queue.taskcluster.net/v1/task/Ro0Rl2LfRSGgyEBMSucrag/artifacts/public/build/target.talos.tests.zip into memory 05:24:27 INFO - Content-Length response header: 14447425 05:24:27 INFO - Bytes received: 14447425 05:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:27 INFO - trying https://queue.taskcluster.net/v1/task/Ro0Rl2LfRSGgyEBMSucrag/artifacts/public/build/target.tar.bz2 05:24:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Ro0Rl2LfRSGgyEBMSucrag/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:24:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ro0Rl2LfRSGgyEBMSucrag/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:24:28 INFO - Downloaded 54132321 bytes. 05:24:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ro0Rl2LfRSGgyEBMSucrag/artifacts/public/build/target.tar.bz2 05:24:28 INFO - mkdir: /builds/slave/test/properties 05:24:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:24:28 INFO - Writing to file /builds/slave/test/properties/build_url 05:24:28 INFO - Contents: 05:24:28 INFO - build_url:https://queue.taskcluster.net/v1/task/Ro0Rl2LfRSGgyEBMSucrag/artifacts/public/build/target.tar.bz2 05:24:28 INFO - Running post-action listener: _resource_record_post_action 05:24:28 INFO - Running post-action listener: set_extra_try_arguments 05:24:28 INFO - [mozharness: 2017-06-01 12:24:28.735914Z] Finished download-and-extract step (success) 05:24:28 INFO - [mozharness: 2017-06-01 12:24:28.736103Z] Running populate-webroot step. 05:24:28 INFO - Running pre-action listener: _resource_record_pre_action 05:24:28 INFO - Running main action method: populate_webroot 05:24:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:24:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:24:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:24:28 INFO - '--tppagecycles', 05:24:28 INFO - '7'], 05:24:28 INFO - 'tests': ['tsvgm']}}, 05:24:28 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:24:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:24:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:24:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:24:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:24:28 INFO - 'talos_options': ['--disable-e10s'], 05:24:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:24:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:24:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:24:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:24:28 INFO - 'talos_options': ['--disable-e10s'], 05:24:28 INFO - 'tests': ['damp', 'tps']}, 05:24:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:24:28 INFO - 'tests': ['damp', 'tps']}, 05:24:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:24:28 INFO - 'tests': ['dromaeo_dom']}, 05:24:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:24:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:24:28 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:24:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:24:28 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:24:28 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:24:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:24:28 INFO - 'tests': ['a11yr', 05:24:28 INFO - 'ts_paint', 05:24:28 INFO - 'tpaint', 05:24:28 INFO - 'sessionrestore', 05:24:28 INFO - 'sessionrestore_no_auto_restore', 05:24:28 INFO - 'tabpaint']}, 05:24:28 INFO - 'other-e10s': {'tests': ['a11yr', 05:24:28 INFO - 'ts_paint', 05:24:28 INFO - 'tpaint', 05:24:28 INFO - 'sessionrestore', 05:24:28 INFO - 'sessionrestore_no_auto_restore', 05:24:28 INFO - 'tabpaint']}, 05:24:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:24:28 INFO - 'ts_paint', 05:24:28 INFO - 'tpaint', 05:24:28 INFO - 'sessionrestore', 05:24:28 INFO - 'sessionrestore_no_auto_restore', 05:24:28 INFO - 'tabpaint']}, 05:24:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:24:28 INFO - 'ts_paint', 05:24:28 INFO - 'tpaint', 05:24:28 INFO - 'sessionrestore', 05:24:28 INFO - 'sessionrestore_no_auto_restore', 05:24:28 INFO - 'tabpaint']}, 05:24:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:24:28 INFO - 'tests': ['a11yr', 05:24:28 INFO - 'ts_paint', 05:24:28 INFO - 'tpaint', 05:24:28 INFO - 'sessionrestore', 05:24:28 INFO - 'sessionrestore_no_auto_restore', 05:24:28 INFO - 'tabpaint']}, 05:24:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:24:28 INFO - 'tests': ['a11yr', 05:24:28 INFO - 'ts_paint', 05:24:28 INFO - 'tpaint', 05:24:28 INFO - 'sessionrestore', 05:24:28 INFO - 'sessionrestore_no_auto_restore', 05:24:28 INFO - 'tabpaint']}, 05:24:28 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:24:28 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:24:28 INFO - 'bloom_basic_ref']}, 05:24:28 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 05:24:28 INFO - 'talos_options': ['--mitmproxy', 05:24:28 INFO - 'mitmproxy-recording-1.mp', 05:24:28 INFO - '--firstNonBlankPaint'], 05:24:28 INFO - 'tests': ['Quantum_1']}, 05:24:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:24:28 INFO - 'tests': ['tsvgx', 05:24:28 INFO - 'tsvgr_opacity', 05:24:28 INFO - 'tart', 05:24:28 INFO - 'tscrollx', 05:24:28 INFO - 'cart', 05:24:28 INFO - 'tsvg_static']}, 05:24:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:24:28 INFO - 'tsvgr_opacity', 05:24:28 INFO - 'tart', 05:24:28 INFO - 'tscrollx', 05:24:28 INFO - 'cart', 05:24:28 INFO - 'tsvg_static']}, 05:24:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:24:28 INFO - 'talos_options': ['--disable-e10s'], 05:24:28 INFO - 'tests': ['tp5o']}, 05:24:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:24:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:24:28 INFO - 'talos_options': ['--disable-e10s', 05:24:28 INFO - '--xperf_path', 05:24:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:24:28 INFO - 'tests': ['tp5n']}, 05:24:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:24:28 INFO - 'talos_options': ['--xperf_path', 05:24:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:24:28 INFO - 'tests': ['tp5n']}}, 05:24:28 INFO - 'talos.zip': {'path': '', 05:24:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:24:28 INFO - Running post-action listener: _resource_record_post_action 05:24:28 INFO - [mozharness: 2017-06-01 12:24:28.753402Z] Finished populate-webroot step (success) 05:24:28 INFO - [mozharness: 2017-06-01 12:24:28.753498Z] Running create-virtualenv step. 05:24:28 INFO - Running pre-action listener: _resource_record_pre_action 05:24:28 INFO - Running main action method: create_virtualenv 05:24:28 INFO - Creating virtualenv /builds/slave/test/build/venv 05:24:28 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 05:24:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:24:28 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:24:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:24:28 INFO - Using real prefix '/usr' 05:24:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:24:29 INFO - Installing distribute.............................................................................................................................................................................................done. 05:24:31 INFO - Installing pip.................done. 05:24:31 INFO - Return code: 0 05:24:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:24:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:24:31 INFO - Reading from file tmpfile_stdout 05:24:31 INFO - Output received: 05:24:31 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) 05:24:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:24: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')]} 05:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24: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')]} 05:24:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1235a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d6840>, '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 0x13d7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d7bd0>, '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': '03627c79f6bb3d1578c4a402000001ba-1496295146.881499-1967056701', '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 05:24: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', 'pip>=1.5'] in /builds/slave/test/build 05:24: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 pip>=1.5 05:24:31 INFO - Using env: {'DISPLAY': ':0', 05:24:31 INFO - 'HOME': '/home/cltbld', 05:24:31 INFO - 'LANG': 'en_US.UTF-8', 05:24:31 INFO - 'LANGUAGE': 'en_US:en', 05:24:31 INFO - 'LOGNAME': 'cltbld', 05:24:31 INFO - 'MAIL': '/var/mail/cltbld', 05:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:31 INFO - 'MOZ_NO_REMOTE': '1', 05:24:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:31 INFO - 'NO_EM_RESTART': '1', 05:24:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:31 INFO - 'PWD': '/builds/slave/test', 05:24:31 INFO - 'SHELL': '/bin/bash', 05:24:31 INFO - 'SHLVL': '1', 05:24:31 INFO - 'TERM': 'linux', 05:24:31 INFO - 'TMOUT': '86400', 05:24:31 INFO - 'USER': 'cltbld', 05:24:31 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1496295146.881499-1967056701', 05:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:31 INFO - '_': '/tools/buildbot/bin/python'} 05:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:31 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 05:24:31 INFO - Cleaning up... 05:24:31 INFO - Return code: 0 05:24:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:24: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')]} 05:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24: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')]} 05:24:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24: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', '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 0x105b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1235a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d6840>, '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 0x13d7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d7bd0>, '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': '03627c79f6bb3d1578c4a402000001ba-1496295146.881499-1967056701', '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 05:24: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:24: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 psutil>=3.1.1 05:24:31 INFO - Using env: {'DISPLAY': ':0', 05:24:31 INFO - 'HOME': '/home/cltbld', 05:24:31 INFO - 'LANG': 'en_US.UTF-8', 05:24:31 INFO - 'LANGUAGE': 'en_US:en', 05:24:31 INFO - 'LOGNAME': 'cltbld', 05:24:31 INFO - 'MAIL': '/var/mail/cltbld', 05:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:31 INFO - 'MOZ_NO_REMOTE': '1', 05:24:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:31 INFO - 'NO_EM_RESTART': '1', 05:24:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:31 INFO - 'PWD': '/builds/slave/test', 05:24:31 INFO - 'SHELL': '/bin/bash', 05:24:31 INFO - 'SHLVL': '1', 05:24:31 INFO - 'TERM': 'linux', 05:24:31 INFO - 'TMOUT': '86400', 05:24:31 INFO - 'USER': 'cltbld', 05:24:31 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1496295146.881499-1967056701', 05:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:31 INFO - '_': '/tools/buildbot/bin/python'} 05:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:31 INFO - Downloading/unpacking psutil>=3.1.1 05:24: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 05:24: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 05:24: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 05:24: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 05:24:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:24:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:24:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:24:34 INFO - Installing collected packages: psutil 05:24:34 INFO - Running setup.py install for psutil 05:24:34 INFO - building 'psutil._psutil_linux' extension 05:24:34 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 05:24:34 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 05:24:34 INFO - building 'psutil._psutil_posix' extension 05:24:34 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 05:24:34 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 05:24:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:24:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:24:34 INFO - Successfully installed psutil 05:24:34 INFO - Cleaning up... 05:24:34 INFO - Return code: 0 05:24:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:24: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')]} 05:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24: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')]} 05:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1235a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d6840>, '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 0x13d7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d7bd0>, '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': '03627c79f6bb3d1578c4a402000001ba-1496295146.881499-1967056701', '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 05:24: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:24: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 mozsystemmonitor==0.3 05:24:34 INFO - Using env: {'DISPLAY': ':0', 05:24:34 INFO - 'HOME': '/home/cltbld', 05:24:34 INFO - 'LANG': 'en_US.UTF-8', 05:24:34 INFO - 'LANGUAGE': 'en_US:en', 05:24:34 INFO - 'LOGNAME': 'cltbld', 05:24:34 INFO - 'MAIL': '/var/mail/cltbld', 05:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:34 INFO - 'MOZ_NO_REMOTE': '1', 05:24:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:34 INFO - 'NO_EM_RESTART': '1', 05:24:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:34 INFO - 'PWD': '/builds/slave/test', 05:24:34 INFO - 'SHELL': '/bin/bash', 05:24:34 INFO - 'SHLVL': '1', 05:24:34 INFO - 'TERM': 'linux', 05:24:34 INFO - 'TMOUT': '86400', 05:24:34 INFO - 'USER': 'cltbld', 05:24:34 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1496295146.881499-1967056701', 05:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:34 INFO - '_': '/tools/buildbot/bin/python'} 05:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:24: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 05:24: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 05:24: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 05:24: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 05:24:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:24:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:24:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:24:36 INFO - Installing collected packages: mozsystemmonitor 05:24:36 INFO - Running setup.py install for mozsystemmonitor 05:24:36 INFO - Successfully installed mozsystemmonitor 05:24:36 INFO - Cleaning up... 05:24:36 INFO - Return code: 0 05:24:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1235a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d6840>, '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 0x13d7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d7bd0>, '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': '03627c79f6bb3d1578c4a402000001ba-1496295146.881499-1967056701', '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 05:24:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:24:36 INFO - Using env: {'DISPLAY': ':0', 05:24:36 INFO - 'HOME': '/home/cltbld', 05:24:36 INFO - 'LANG': 'en_US.UTF-8', 05:24:36 INFO - 'LANGUAGE': 'en_US:en', 05:24:36 INFO - 'LOGNAME': 'cltbld', 05:24:36 INFO - 'MAIL': '/var/mail/cltbld', 05:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:36 INFO - 'MOZ_NO_REMOTE': '1', 05:24:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:36 INFO - 'NO_EM_RESTART': '1', 05:24:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:36 INFO - 'PWD': '/builds/slave/test', 05:24:36 INFO - 'SHELL': '/bin/bash', 05:24:36 INFO - 'SHLVL': '1', 05:24:36 INFO - 'TERM': 'linux', 05:24:36 INFO - 'TMOUT': '86400', 05:24:36 INFO - 'USER': 'cltbld', 05:24:36 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1496295146.881499-1967056701', 05:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:36 INFO - '_': '/tools/buildbot/bin/python'} 05:24:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:36 INFO - Downloading/unpacking jsonschema==2.5.1 05:24: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 05:24: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 05:24: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 05:24: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 05:24:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:24:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:24:37 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 05:24:37 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 05:24:37 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 05:24:37 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 05:24:37 INFO - Downloading functools32-3.2.3-2.tar.gz 05:24:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:24:37 INFO - warning: no files found matching '*.txt' 05:24:37 INFO - no previously-included directories found matching 'build' 05:24:37 INFO - no previously-included directories found matching 'dist' 05:24:37 INFO - no previously-included directories found matching '.git*' 05:24:37 INFO - Installing collected packages: jsonschema, functools32 05:24:37 INFO - Running setup.py install for functools32 05:24:37 INFO - warning: no files found matching '*.txt' 05:24:37 INFO - no previously-included directories found matching 'build' 05:24:37 INFO - no previously-included directories found matching 'dist' 05:24:37 INFO - no previously-included directories found matching '.git*' 05:24:37 INFO - Successfully installed jsonschema functools32 05:24:37 INFO - Cleaning up... 05:24:37 INFO - Return code: 0 05:24:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:24: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')]} 05:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24: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')]} 05:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:37 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 0x105b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1235a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d6840>, '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 0x13d7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d7bd0>, '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': '03627c79f6bb3d1578c4a402000001ba-1496295146.881499-1967056701', '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 05:24:37 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 05:24:37 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 05:24:37 INFO - Using env: {'DISPLAY': ':0', 05:24:37 INFO - 'HOME': '/home/cltbld', 05:24:37 INFO - 'LANG': 'en_US.UTF-8', 05:24:37 INFO - 'LANGUAGE': 'en_US:en', 05:24:37 INFO - 'LOGNAME': 'cltbld', 05:24:37 INFO - 'MAIL': '/var/mail/cltbld', 05:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:37 INFO - 'MOZ_NO_REMOTE': '1', 05:24:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:37 INFO - 'NO_EM_RESTART': '1', 05:24:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:37 INFO - 'PWD': '/builds/slave/test', 05:24:37 INFO - 'SHELL': '/bin/bash', 05:24:37 INFO - 'SHLVL': '1', 05:24:37 INFO - 'TERM': 'linux', 05:24:37 INFO - 'TMOUT': '86400', 05:24:37 INFO - 'USER': 'cltbld', 05:24:37 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1496295146.881499-1967056701', 05:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:37 INFO - '_': '/tools/buildbot/bin/python'} 05:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:24:38 INFO - Cleaning up... 05:24:38 INFO - Return code: 0 05:24:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1235a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d6840>, '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 0x13d7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d7bd0>, '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': '03627c79f6bb3d1578c4a402000001ba-1496295146.881499-1967056701', '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 05:24:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:24:38 INFO - Using env: {'DISPLAY': ':0', 05:24:38 INFO - 'HOME': '/home/cltbld', 05:24:38 INFO - 'LANG': 'en_US.UTF-8', 05:24:38 INFO - 'LANGUAGE': 'en_US:en', 05:24:38 INFO - 'LOGNAME': 'cltbld', 05:24:38 INFO - 'MAIL': '/var/mail/cltbld', 05:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:38 INFO - 'MOZ_NO_REMOTE': '1', 05:24:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:38 INFO - 'NO_EM_RESTART': '1', 05:24:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:38 INFO - 'PWD': '/builds/slave/test', 05:24:38 INFO - 'SHELL': '/bin/bash', 05:24:38 INFO - 'SHLVL': '1', 05:24:38 INFO - 'TERM': 'linux', 05:24:38 INFO - 'TMOUT': '86400', 05:24:38 INFO - 'USER': 'cltbld', 05:24:38 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1496295146.881499-1967056701', 05:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:38 INFO - '_': '/tools/buildbot/bin/python'} 05:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:38 INFO - Downloading/unpacking blobuploader==1.2.4 05:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:39 INFO - Downloading blobuploader-1.2.4.tar.gz 05:24:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:24:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:24:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:39 INFO - Downloading docopt-0.6.1.tar.gz 05:24:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:24:40 INFO - Installing collected packages: blobuploader, requests, docopt 05:24:40 INFO - Running setup.py install for blobuploader 05:24:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:24:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:24:40 INFO - Running setup.py install for requests 05:24:40 INFO - Running setup.py install for docopt 05:24:40 INFO - Successfully installed blobuploader requests docopt 05:24:40 INFO - Cleaning up... 05:24:40 INFO - Return code: 0 05:24:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24: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')]} 05:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24: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')]} 05:24:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:40 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 0x105b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1235a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d6840>, '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 0x13d7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d7bd0>, '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': '03627c79f6bb3d1578c4a402000001ba-1496295146.881499-1967056701', '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 05:24:40 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 05:24:40 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 05:24:40 INFO - Using env: {'DISPLAY': ':0', 05:24:40 INFO - 'HOME': '/home/cltbld', 05:24:40 INFO - 'LANG': 'en_US.UTF-8', 05:24:40 INFO - 'LANGUAGE': 'en_US:en', 05:24:40 INFO - 'LOGNAME': 'cltbld', 05:24:40 INFO - 'MAIL': '/var/mail/cltbld', 05:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:40 INFO - 'MOZ_NO_REMOTE': '1', 05:24:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:40 INFO - 'NO_EM_RESTART': '1', 05:24:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:40 INFO - 'PWD': '/builds/slave/test', 05:24:40 INFO - 'SHELL': '/bin/bash', 05:24:40 INFO - 'SHLVL': '1', 05:24:40 INFO - 'TERM': 'linux', 05:24:40 INFO - 'TMOUT': '86400', 05:24:40 INFO - 'USER': 'cltbld', 05:24:40 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1496295146.881499-1967056701', 05:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:40 INFO - '_': '/tools/buildbot/bin/python'} 05:24:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:24:40 INFO - Running setup.py (path:/tmp/pip-D13Nie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:24:40 INFO - Running setup.py (path:/tmp/pip-L8mIa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:24:41 INFO - Running setup.py (path:/tmp/pip-St30O5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:24:41 INFO - Running setup.py (path:/tmp/pip-SPysa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:24:41 INFO - Running setup.py (path:/tmp/pip-fU0T0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:24:41 INFO - Running setup.py (path:/tmp/pip-6VPYyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:24:41 INFO - Running setup.py (path:/tmp/pip-Jge8KZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:24:41 INFO - Running setup.py (path:/tmp/pip-4ef8BE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:24:41 INFO - Running setup.py (path:/tmp/pip-fY0vni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:24:41 INFO - Running setup.py (path:/tmp/pip-ZP99kb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:24:41 INFO - Running setup.py (path:/tmp/pip-tDs_Ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:24:41 INFO - Running setup.py (path:/tmp/pip-w9j4sQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:24:41 INFO - Running setup.py (path:/tmp/pip-YoRmHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:24:41 INFO - Running setup.py (path:/tmp/pip-sjlWZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:41 INFO - Running setup.py (path:/tmp/pip-hHdZQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:24:41 INFO - Running setup.py (path:/tmp/pip-dCcn7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:24:42 INFO - Running setup.py (path:/tmp/pip-gOnUGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:24:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:24:42 INFO - Running setup.py install for manifestparser 05:24:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:24:42 INFO - Running setup.py install for mozcrash 05:24:42 INFO - Running setup.py install for mozdebug 05:24:42 INFO - Running setup.py install for mozdevice 05:24:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:24:42 INFO - Running setup.py install for mozfile 05:24:42 INFO - Running setup.py install for mozhttpd 05:24:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:24:42 INFO - Running setup.py install for mozinfo 05:24:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:24:42 INFO - Running setup.py install for mozInstall 05:24:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:24:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:24:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:24:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:24:42 INFO - Running setup.py install for mozleak 05:24:42 INFO - Running setup.py install for mozlog 05:24:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:24:43 INFO - Running setup.py install for moznetwork 05:24:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:24:43 INFO - Running setup.py install for mozprocess 05:24:43 INFO - Running setup.py install for mozprofile 05:24:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:24:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:24:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:24:43 INFO - Running setup.py install for mozrunner 05:24:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:24:43 INFO - Running setup.py install for mozscreenshot 05:24:43 INFO - Running setup.py install for moztest 05:24:43 INFO - Running setup.py install for mozversion 05:24:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:24:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:24:43 INFO - Cleaning up... 05:24:43 INFO - Return code: 0 05:24:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24: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')]} 05:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24: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')]} 05:24:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:43 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 0x105b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1235a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d6840>, '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 0x13d7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d7bd0>, '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': '03627c79f6bb3d1578c4a402000001ba-1496295146.881499-1967056701', '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 05:24:43 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 05:24:43 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 05:24:43 INFO - Using env: {'DISPLAY': ':0', 05:24:43 INFO - 'HOME': '/home/cltbld', 05:24:43 INFO - 'LANG': 'en_US.UTF-8', 05:24:43 INFO - 'LANGUAGE': 'en_US:en', 05:24:43 INFO - 'LOGNAME': 'cltbld', 05:24:43 INFO - 'MAIL': '/var/mail/cltbld', 05:24:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:43 INFO - 'MOZ_NO_REMOTE': '1', 05:24:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:43 INFO - 'NO_EM_RESTART': '1', 05:24:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:43 INFO - 'PWD': '/builds/slave/test', 05:24:43 INFO - 'SHELL': '/bin/bash', 05:24:43 INFO - 'SHLVL': '1', 05:24:43 INFO - 'TERM': 'linux', 05:24:43 INFO - 'TMOUT': '86400', 05:24:43 INFO - 'USER': 'cltbld', 05:24:43 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1496295146.881499-1967056701', 05:24:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:43 INFO - '_': '/tools/buildbot/bin/python'} 05:24:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:24:44 INFO - Running setup.py (path:/tmp/pip-JA4gPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:24:44 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)) 05:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:24:44 INFO - Running setup.py (path:/tmp/pip-VpBsu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:24:44 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)) 05:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:24:44 INFO - Running setup.py (path:/tmp/pip-peWYq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:24:44 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)) 05:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:24:44 INFO - Running setup.py (path:/tmp/pip-SypWuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:24:44 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)) 05:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:24:44 INFO - Running setup.py (path:/tmp/pip-iSstWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:24:44 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)) 05:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:24:44 INFO - Running setup.py (path:/tmp/pip-KYIOcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:24:44 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)) 05:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:24:44 INFO - Running setup.py (path:/tmp/pip-TYAhTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:24:44 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)) 05:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:24:44 INFO - Running setup.py (path:/tmp/pip-THICk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:24:44 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)) 05:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:24:44 INFO - Running setup.py (path:/tmp/pip-fIaPBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:24:44 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)) 05:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:24:44 INFO - Running setup.py (path:/tmp/pip-Xtak2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:24:44 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)) 05:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:24:44 INFO - Running setup.py (path:/tmp/pip-RBZR50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:24:44 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)) 05:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:24:44 INFO - Running setup.py (path:/tmp/pip-0637t2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:24:44 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)) 05:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:24:44 INFO - Running setup.py (path:/tmp/pip-YT2Aew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:24:45 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)) 05:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:24:45 INFO - Running setup.py (path:/tmp/pip-6nXxuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:24:45 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)) 05:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:45 INFO - Running setup.py (path:/tmp/pip-w2Rhxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:45 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)) 05:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:24:45 INFO - Running setup.py (path:/tmp/pip-l9o3TI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:24:45 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)) 05:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:24:45 INFO - Running setup.py (path:/tmp/pip-IjzFdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:24:45 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)) 05:24:45 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)) 05:24:45 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)) 05:24:45 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)) 05:24:45 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)) 05:24:45 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)) 05:24:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:46 INFO - Downloading blessings-1.6.tar.gz 05:24:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:24:46 INFO - Installing collected packages: blessings 05:24:46 INFO - Running setup.py install for blessings 05:24:46 INFO - Successfully installed blessings 05:24:46 INFO - Cleaning up... 05:24:46 INFO - Return code: 0 05:24:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:24:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:24:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:24:46 INFO - Reading from file tmpfile_stdout 05:24:46 INFO - Current package versions: 05:24:46 INFO - argparse == 1.2.1 05:24:46 INFO - blessings == 1.6 05:24:46 INFO - blobuploader == 1.2.4 05:24:46 INFO - docopt == 0.6.1 05:24:46 INFO - functools32 == 3.2.3-2 05:24:46 INFO - jsonschema == 2.5.1 05:24:46 INFO - manifestparser == 1.1 05:24:46 INFO - mozInstall == 1.12 05:24:46 INFO - mozcrash == 1.0 05:24:46 INFO - mozdebug == 0.1 05:24:46 INFO - mozdevice == 0.51 05:24:46 INFO - mozfile == 1.2 05:24:46 INFO - mozhttpd == 0.7 05:24:46 INFO - mozinfo == 0.9 05:24:46 INFO - mozleak == 0.1 05:24:46 INFO - mozlog == 3.4 05:24:46 INFO - moznetwork == 0.27 05:24:46 INFO - mozprocess == 0.25 05:24:46 INFO - mozprofile == 0.28 05:24:46 INFO - mozrunner == 6.13 05:24:46 INFO - mozscreenshot == 0.1 05:24:46 INFO - mozsystemmonitor == 0.3 05:24:46 INFO - moztest == 0.8 05:24:46 INFO - mozversion == 1.4 05:24:46 INFO - psutil == 3.1.1 05:24:46 INFO - requests == 1.2.3 05:24:46 INFO - wsgiref == 0.1.2 05:24:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24:46 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')]} 05:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:46 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')]} 05:24:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:46 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 0x105b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1235a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d6840>, '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 0x13d7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d7bd0>, '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': '03627c79f6bb3d1578c4a402000001ba-1496295146.881499-1967056701', '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 05:24:46 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 05:24:46 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 05:24:46 INFO - Using env: {'DISPLAY': ':0', 05:24:46 INFO - 'HOME': '/home/cltbld', 05:24:46 INFO - 'LANG': 'en_US.UTF-8', 05:24:46 INFO - 'LANGUAGE': 'en_US:en', 05:24:46 INFO - 'LOGNAME': 'cltbld', 05:24:46 INFO - 'MAIL': '/var/mail/cltbld', 05:24:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:46 INFO - 'MOZ_NO_REMOTE': '1', 05:24:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:46 INFO - 'NO_EM_RESTART': '1', 05:24:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:46 INFO - 'PWD': '/builds/slave/test', 05:24:46 INFO - 'SHELL': '/bin/bash', 05:24:46 INFO - 'SHLVL': '1', 05:24:46 INFO - 'TERM': 'linux', 05:24:46 INFO - 'TMOUT': '86400', 05:24:46 INFO - 'USER': 'cltbld', 05:24:46 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1496295146.881499-1967056701', 05:24:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:46 INFO - '_': '/tools/buildbot/bin/python'} 05:24:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:47 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)) 05:24:47 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)) 05:24:47 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)) 05:24:47 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)) 05:24:47 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)) 05:24:47 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)) 05:24:47 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)) 05:24:47 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)) 05:24:47 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)) 05:24:47 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:48 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:24:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:24:48 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)) 05:24:48 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)) 05:24:48 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)) 05:24:48 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)) 05:24:48 INFO - Installing collected packages: marionette-driver 05:24:48 INFO - Running setup.py install for marionette-driver 05:24:48 INFO - Successfully installed marionette-driver 05:24:48 INFO - Cleaning up... 05:24:48 INFO - Return code: 0 05:24:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1235a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d6840>, '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 0x13d7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d7bd0>, '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': '03627c79f6bb3d1578c4a402000001ba-1496295146.881499-1967056701', '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 05:24:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:24:48 INFO - Using env: {'DISPLAY': ':0', 05:24:48 INFO - 'HOME': '/home/cltbld', 05:24:48 INFO - 'LANG': 'en_US.UTF-8', 05:24:48 INFO - 'LANGUAGE': 'en_US:en', 05:24:48 INFO - 'LOGNAME': 'cltbld', 05:24:48 INFO - 'MAIL': '/var/mail/cltbld', 05:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:48 INFO - 'MOZ_NO_REMOTE': '1', 05:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:48 INFO - 'NO_EM_RESTART': '1', 05:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:48 INFO - 'PWD': '/builds/slave/test', 05:24:48 INFO - 'SHELL': '/bin/bash', 05:24:48 INFO - 'SHLVL': '1', 05:24:48 INFO - 'TERM': 'linux', 05:24:48 INFO - 'TMOUT': '86400', 05:24:48 INFO - 'USER': 'cltbld', 05:24:48 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1496295146.881499-1967056701', 05:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:48 INFO - '_': '/tools/buildbot/bin/python'} 05:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:24:48 INFO - Cleaning up... 05:24:48 INFO - Return code: 0 05:24:48 INFO - Running post-action listener: _resource_record_post_action 05:24:48 INFO - Running post-action listener: _start_resource_monitoring 05:24:48 INFO - Starting resource monitoring. 05:24:48 INFO - [mozharness: 2017-06-01 12:24:48.699686Z] Finished create-virtualenv step (success) 05:24:48 INFO - [mozharness: 2017-06-01 12:24:48.700185Z] Running install step. 05:24:48 INFO - Running pre-action listener: _resource_record_pre_action 05:24:48 INFO - Running main action method: install 05:24:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:24:48 INFO - Reading from file tmpfile_stdout 05:24:48 INFO - Detecting whether we're running mozinstall >=1.0... 05:24:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:24:49 INFO - Reading from file tmpfile_stdout 05:24:49 INFO - Output received: 05:24:49 INFO - Usage: mozinstall [options] installer 05:24:49 INFO - Options: 05:24:49 INFO - -h, --help show this help message and exit 05:24:49 INFO - -d DEST, --destination=DEST 05:24:49 INFO - Directory to install application into. [default: 05:24:49 INFO - "/builds/slave/test"] 05:24:49 INFO - --app=APP Application being installed. [default: firefox] 05:24:49 INFO - mkdir: /builds/slave/test/build/application 05:24:49 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'] 05:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:25:04 INFO - Reading from file tmpfile_stdout 05:25:04 INFO - Output received: 05:25:04 INFO - /builds/slave/test/build/application/firefox/firefox 05:25:04 INFO - Running post-action listener: _resource_record_post_action 05:25:04 INFO - [mozharness: 2017-06-01 12:25:04.558743Z] Finished install step (success) 05:25:04 INFO - [mozharness: 2017-06-01 12:25:04.559022Z] Running setup-mitmproxy step. 05:25:04 INFO - Running pre-action listener: _resource_record_pre_action 05:25:04 INFO - Running main action method: setup_mitmproxy 05:25:04 INFO - Skipping: mitmproxy is not required 05:25:04 INFO - Running post-action listener: _resource_record_post_action 05:25:04 INFO - [mozharness: 2017-06-01 12:25:04.560153Z] Finished setup-mitmproxy step (success) 05:25:04 INFO - [mozharness: 2017-06-01 12:25:04.560373Z] Running run-tests step. 05:25:04 INFO - Running pre-action listener: _resource_record_pre_action 05:25:04 INFO - Running main action method: run_tests 05:25:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:25:04 INFO - Python 2.7.3 05:25:04 INFO - Return code: 0 05:25:04 INFO - grabbing minidump binary from tooltool 05:25:04 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')]} 05:25:04 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 0x13d6840>, '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 0x13d7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d7bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:25:04 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 05:25:04 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 05:25:04 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 05:25:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:25:04 INFO - Return code: 0 05:25:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:25:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:25:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:25:04 INFO - ENV: RUST_BACKTRACE is now 1 05:25:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:25:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:25:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ro0Rl2LfRSGgyEBMSucrag/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 05:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ro0Rl2LfRSGgyEBMSucrag/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 05:25:04 INFO - Using env: {'DISPLAY': ':0', 05:25:04 INFO - 'HOME': '/home/cltbld', 05:25:04 INFO - 'LANG': 'en_US.UTF-8', 05:25:04 INFO - 'LANGUAGE': 'en_US:en', 05:25:04 INFO - 'LOGNAME': 'cltbld', 05:25:04 INFO - 'MAIL': '/var/mail/cltbld', 05:25:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:25:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:04 INFO - 'MOZ_NO_REMOTE': '1', 05:25:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:04 INFO - 'NO_EM_RESTART': '1', 05:25:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:04 INFO - 'PWD': '/builds/slave/test', 05:25:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:25:04 INFO - 'RUST_BACKTRACE': '1', 05:25:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:25:04 INFO - 'SHELL': '/bin/bash', 05:25:04 INFO - 'SHLVL': '1', 05:25:04 INFO - 'TERM': 'linux', 05:25:04 INFO - 'TMOUT': '86400', 05:25:04 INFO - 'USER': 'cltbld', 05:25:04 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1496295146.881499-1967056701', 05:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:04 INFO - '_': '/tools/buildbot/bin/python'} 05:25:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ro0Rl2LfRSGgyEBMSucrag/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 05:25:04 INFO - mozversion application_buildid: 20170601114928 05:25:04 INFO - mozversion application_changeset: d96110d766199d42524558fd83e6467906de4daf 05:25:04 INFO - mozversion application_display_name: Nightly 05:25:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:25:04 INFO - mozversion application_name: Firefox 05:25:04 INFO - mozversion application_remotingname: firefox 05:25:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:25:04 INFO - mozversion application_vendor: Mozilla 05:25:04 INFO - mozversion application_version: 55.0a1 05:25:04 INFO - mozversion platform_buildid: 20170601114928 05:25:04 INFO - mozversion platform_changeset: d96110d766199d42524558fd83e6467906de4daf 05:25:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:25:04 INFO - mozversion platform_version: 55.0a1 05:25:04 INFO - using testdate: 1496319904 05:25:04 INFO - actual date: 1496319904 05:25:04 INFO - starting webserver on 'localhost:53789' 05:25:04 INFO - SUITE-START | Running 2 tests 05:25:04 INFO - TEST-START | dromaeo_css 05:25:04 INFO - operating with platform_type : linux_ 05:25:04 INFO - Initialising browser for dromaeo_css test... 05:25:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53789/getInfo.html -profile /tmp/tmpe_mxwX/profile 05:25:04 INFO - TEST-INFO | started process 14633 (/builds/slave/test/build/application/firefox/firefox http://localhost:53789/getInfo.html) 05:25:39 INFO - TEST-INFO | 14633: killed by SIGTERM 05:25:40 INFO - Browser initialized. 05:25:40 INFO - Running cycle 1/1 for dromaeo_css test... 05:25:40 INFO - TEST-INFO | started process 14838 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe_mxwX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:25:52 INFO - PID 14838 | RSS: Main: 184291328 05:25:52 INFO - PID 14838 | 05:28:56 INFO - PID 14838 | Cycle 1(1): loaded http://localhost:53789/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53789/tests/dromaeo/cssquery-ext.html) 05:28:57 INFO - PID 14838 | RSS: Main: 179671040 05:28:57 INFO - PID 14838 | 05:31:59 INFO - PID 14838 | Cycle 1(1): loaded http://localhost:53789/tests/dromaeo/cssquery-ext.html (next: http://localhost:53789/tests/dromaeo/cssquery-jquery.html) 05:32:00 INFO - PID 14838 | RSS: Main: 183402496 05:32:00 INFO - PID 14838 | 05:35:02 INFO - PID 14838 | Cycle 1(1): loaded http://localhost:53789/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53789/tests/dromaeo/cssquery-mootools.html) 05:35:02 INFO - PID 14838 | RSS: Main: 180850688 05:35:02 INFO - PID 14838 | 05:38:04 INFO - PID 14838 | Cycle 1(1): loaded http://localhost:53789/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53789/tests/dromaeo/cssquery-prototype.html) 05:38:05 INFO - PID 14838 | RSS: Main: 185597952 05:38:05 INFO - PID 14838 | 05:41:08 INFO - PID 14838 | Cycle 1(1): loaded http://localhost:53789/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53789/tests/dromaeo/cssquery-yui.html) 05:41:08 INFO - PID 14838 | RSS: Main: 183820288 05:41:08 INFO - PID 14838 | 05:44:10 INFO - PID 14838 | Cycle 1(1): loaded http://localhost:53789/tests/dromaeo/cssquery-yui.html (next: http://localhost:53789/tests/dromaeo/cssquery-dojo.html) 05:44:10 INFO - PID 14838 | RSS: Main: 180801536 05:44:10 INFO - PID 14838 | 05:44:10 INFO - PID 14838 | __start_tp_report 05:44:10 INFO - PID 14838 | _x_x_mozilla_page_load 05:44:10 INFO - PID 14838 | _x_x_mozilla_page_load_details 05:44:10 INFO - PID 14838 | |i|pagename|runs| 05:44:10 INFO - PID 14838 | |0;dojo.html;2679.1681212907088;2690.1794952539467;2703.837769733815;2734.9999999999995;2736.9178924632256;5115.335006449166;5188.844334669961;5241.685498870066;5241.983787884837;5273.6572122811995;5200.739963001844;5203.2975548300965;5214.556762675177;5305.973470132644;5336.67979921205;4426.936963542315;4603.194440972817;4664.370310008157;4690.413698287714;4694.225452800284;4693.976530117362;4714.905701885978;4729.716217026972;4745.881352966169;4750.168720473903;4563.634909207289;4578.885527861797;4637.165310244155;4680.976595117037;4705.223638099709;4639.953600463986;4681.063787242565;4687.9531204687855;4714.175019371631;4734.7452924974905;4612.423447069116;4613.308003799423;4653.139169253699;4677.228257337535;4682.8126874924965;5042.823501177441;5131.923021154686;5240.475952404767;5243.659162154448;5294.894102117974;5600.355959064719;5683.602147849652;5693.686847223443;5705.144228365778;5714.914276285859;5689.573282003867;5717.399673034313;5718.48533631971;5719.485246327808;5726.141078838207;5299.072662284085;5310.893782124336;5316.548093412026;5318.760655770499;5360.91958620621;5608.10270356741;5695.857603559944;5705.2012718219485;5760.193572899798;5834.5624078194305;5554.08357620988;5564.638298510584;5575.860603484945;5595.328560572757;5611.074172761449;5388.757505912244;5641.689707066151;5644.435556444323;5646.915296270559;5648.181013752983;5491.917621235684;5586.441355864462;5608.46719561641;5610.523105535994;5630.5495560355075;5555.72221388937;5568.025595520768;5579.721013949286;5585.357683866408;5638.04153293941;4673.415823022122;4707.082118986833;4718.811247550128;4718.882027949328;4749.95250047502;4021.0550520628212;4027.697922655754;4033;4054.351303791379;4085.264652362603;4613.792379342937;4688.742119183409;4726.88182795426;4760.381150450419;4777.737224452619;5646.20953066571;5652.971735141298;5658.773649053992;5675.744591493392;5703.914441283384;4746.359241502422;4746.976265118652;4753.643476739258;4759.524047595212;4793.640476964241;4856.805727770849;4907.558319751168;4915.4347250065985;4979.377577802775;4987.326710894055;5235.528802407802;5251.6323857331145;5255.605829562722;5261.184516399811;5285.286486324297;5532.3637781655625;5596.804111856066;5607.327120745536;5619.438056194348;5632.85917852057;5171.715555644476;5191.584673226208;5203.609729270395;5206.505381988705;5225.320708307896;5595.412481689364;5601.971990140023;5610.85972850682;5616.241807355955;5657.434256574475;5567.526760225264;5636.549076073986;5681.2330335404195;5692.2600061993335;5710.971445142748;5455.1271796512365;5472.124460086367;5512.3660779010925;5519.558435325084;5531.806386776443;5412.458754124556;5415.052365836042;5418.593605479684;5429.484199001088;5466.043442397644;5309.57523398135;5330.733463326741;5337.866553336197;5354.223637572608;5379.838604841861;5375.16684913839;5425.728713564385;5446.618736688552;5510.283663123768;5597.860053498533;5365.678059316453;5371.758270877742;5379.757910894097;5395.919061214006;5424.403315635356 05:44:10 INFO - PID 14838 | |1;ext.html;688.1363888320158;748.7154881145166;765.6669348833257;1089.6240796925058;1098.368438148065;32921.99999999997;34278.14304642385;34337;34366;34366.31267374651;36236;36510.08724781882;36579.4513082304;36653.26693466129;36680.26639467209;6658.600483970953;6830.863382732342;6837.65811709415;6839.829004274908;6973.198082220546;6864.656767161647;6919.169699636025;6984.3364880336285;6986.825329366781;6989.720411183546;6964.303569643046;7025.473089518281;7036.226015138331;7037.612931288777;7063.152421709402;6964.233934267227;6966.198887127995;7004.789856304319;7007.544509606859;7017.543859649132;6627.4366678831875;6711.463082953352;6740.191177058735;6744.291849355845;6756.290589488131;32515.6748432515;32823.83588082044;32853.17867053319;32889;32908.83545582281;2990.372021875409;3028.8485575721124;3041.6045914031033;3049.451098802215;3050.4051709916575;25149.24552263435;25192;25216.117435889657;25323.62014569783;25346.112886049083;2757.131503576367;2785.4986102501543;2801.2296618430096;2811.14260150654;2818.6053952446673;123593;124325;135202.32398837942;146839;147350;40085.198296033916;40297.95530670423;40386;40410.39384409236;40501.594984049785;41546;41878;42121.36817947733;42167;45694.771526142824;12905.09664323507;12981.286029268482;12987.41556629954;13020.544280950122;13071.803922941164;10346.586136554453;10360.430176340224;10372.688819335432;10384.636537721144;10399.94800025995;13099.541516046893;13184.769731415865;13226.537071202461;13261.602151935458;13335.1332163411;5409.459054094559;5476.123820188751;5490.423505531941;5491.505764481136;5505.862353441116;857.8841856349313;898.9910100899039;900.1673452056821;912.6303846942;943.7876477792441;20143.294984675467;20670.793292066886;21020.26429074975;21169.576608467745;21199.72801631907;973.9172170365598;976.6191185437685;990.6829814459448;1007.2747621712356;1007.6775431861734;10962.506687199095;11034.006939375495;11199.216054876244;11231.10151187903;11392.202545821712;164567;166164;166599;167402.16298918426;180266;46285;46969.295460568115;47150.76424617855;47376;47443.5255647446;1253.2355263289387;1279.2516377918835;1281.0968267371481;1285.4665313894816;1290.6966862787237;25052.49895002126;25338.366540836625;26218.475630487665;26507.867460662572;26541.60187597226;31397.372052559276;38401.4239786409;39098.80450597843;39218.215635687695;39352.803235983636;159967.20016399844;160175.19912400364;160658;160790;160890;31112.22219444532;31206;31370.372592548476;31415.21461963469;31734;37047;37477.4378384319;37755;38102.2379552413;38308.42537361886;28789.56815647725;29261.561076584294;29355.266118346357;29751;29916.551251730805;28003.299917501412;28588.285292867844;29219.269518262212;29852.850735746182;30094.548581771727;32223.35553288968;32229.35541289208;32448.675513244565;32519.51220731738;32802.67197327996;26733;27138.864305678344;27431;28030.579541306488;28484.43031139407;21721.782782171977;22476.213332533283;22712.205072822373;22843.200487982842;22989.425264368525 05:44:10 INFO - PID 14838 | |2;jquery.html;419.80269273441473;421.8607859406395;421.93038148705466;436.9563043695631;437.6039684085902;18006.549836254082;18709.906450467763;18755.812441875594;18758.155882985266;18855.245790168396;19627.803721962777;20305.289314873982;20342.288019919306;20368;20401;5474.452554744534;5609.1305847593685;5617.747201375948;5620.831375058755;5629.296337957755;5646.096624540074;5666;5687.146927960818;5693.430656934315;5694.202811606378;5678.091505359143;5688.317401911776;5689.0328644130595;5689.800856970007;5693.971530142344;5314.5748340132695;5511.283533140706;5541.362743284533;5641.661500309994;5693.572982026365;4893.4617192108835;4939.654224204307;4946.554810067075;4963.801447942078;4987.102321582114;24166.395840103964;24478.755212447824;24526.386840328956;24550.631740523906;24561.14036008749;1652.842979916906;1673.8493535581856;1681.9495415137565;1684.688332658462;1692.889962152456;15407.229638518142;15704.29330680122;15773.921130394388;16033.919830400773;16093;2005.959880802376;2008.457716416574;2013.3959812056326;2030.5634288628016;2038.6126635939124;102817;106575;107955;114074;114811.42594286976;10742.409167495864;11260.887391126147;11313.660590182308;11708.590199343153;11786.410679465993;16401.83598164027;16402.917985409997;16496.42262520806;16516.50450486487;16532.917335413247;7785.844283114306;7934.722284720123;7936.801579960547;7937.404694647925;8231.95884020576;7122.857542849114;7250.2024777274455;7267;7319.853602927911;7346.853062938711;7403.925960740324;7539.547627142389;7542.622868856535;7731.265529774662;7770.92229077702;1949.697796841492;1950.4538729155574;1989.44295597233;2003.2888324644541;2139.5399989002126;837.9036410812713;862.6333808131644;880.5377176982007;902.4765635931144;906.1482206725657;17799.288028478717;17807.46577602674;17830.732539011926;18289.542761431072;18632.813671863107;865.2385900407727;873.4497266722052;881.0792721605937;889.1375365895071;899.0919171636695;9800.90199098014;9832.950835245778;10070.798584028278;10105.29262951601;10175.44035078063;350645;351346;358712;358760;359907;83640;84112;84814;86806.56596716976;87129.56435217784;1031.7884833609091;1040.78143589847;1126.6507382711222;1129.2603344809163;1134.8070827959266;18115.909420452812;18426.631467370844;18713.719294210325;19166.616667666847;19171.137298821865;46029.76985115053;46269.53730462652;46424.53575464202;46698.76650616725;46792.298115527614;55016.72491637516;55394.72302638461;55578.16632750431;55856;56273.43726562682;9581.185599224144;9621.230301575997;9747.512624368896;9871.950640246752;9876.370398884392;15746.370145194063;15792;15915.761263581287;15932.203389830695;16097.839021609634;12831.165974211646;12860.871391286342;13092.738145237232;13115.081944264191;13117.278549679859;11100.389478578756;11195.328280303207;11786.705332366759;12183.817242741543;12231.327276999851;13446.058775885986;13462;13482.93258533701;13540.322983850965;13551.25468099264;9600.087991640783;9621.422714636865;9634.662786802428;9708.077732615391;9790.412575245507;13212;13296.135751176143;13364;13445.058845880694;13478.932605336911 05:44:10 INFO - PID 14838 | |3;mootools.html;1211.7031327324803;1293.8447386313644;1298.7727147749144;1298.8766067223623;1303.4264923433689;9652.85520717189;10022.14811741001;10061.798764024725;10110.494475276235;10353.430561319125;10182;10273.075423211909;10296;10312.278140530167;10378.948105259482;2013.6274789164015;2055.198472595689;2059.855810093294;2061.072517367191;2063.6698128299477;1875.9718604220948;1934.3133187718297;1935.312963897817;1937.9612407751836;1972.142118178597;1959.4023822734061;1981.276833955603;1982.0981453438724;1982.9305974290903;1987.6422243996076;1915.6360291544631;1928.113067988727;1929.604431091623;1930.94207173785;1942.660034493965;1873.4192400355796;1940.4372731907872;1958.8628795984287;1964.0965156028244;1983.345495986321;9700.126988571063;9959.900400996043;9960.252981026451;9962.900370996269;10007.199424046132;5167.173252279617;5323.707196104213;5349.3045904032615;5364.30264065669;5377.7580008899695;3020.4563178627836;3150.4801707718198;3204.8878289259997;3207.7754557181006;3221.500667396557;929.8512238041949;953.3040880157455;975.9512024398751;985.6993616946828;986.6891929042329;12507.624771256786;12876.291803950779;14357.210353430557;14521.709565808731;14537.345819438151;4713.599344055725;4780.760961951889;4923.384576927884;4969.776360063734;4980.452150263468;12044.39778011096;12148.271103733627;12165.33090680021;12193.39033048344;12260.509579616715;5222.55608273301;5365.463453654604;5365.651232669864;5384.488473595002;5390;4776.450708168605;4858.44127925286;4868.853934381974;4874.512548745168;4878.487758785276;4082.101937573729;4122.876313710593;4123.995588466976;4150.377443383517;4206.47419072616;1207.963761087169;1219.7377563823643;1237.4678888078033;1247.1394737631006;1247.5321754342121;723.9276072392719;744.8063503489132;757.3032809814983;762.4015148108818;763.9885401718979;5397.190421436816;5544.279243698294;5626.803061892814;5687.687177205211;5689.487946084872;529.1084522579466;542.6120323968303;545.4463719324889;545.950864422204;546.1098409592339;3455.7235421166247;4116.1767646470225;4129.545749967501;4142.502899652061;4311.1808756336195;12457.937710311391;13004.934975325252;13032.739345213042;13053.412596433183;13069.15050521713;12740.044496662787;12870.806937895939;12871.099023068295;12931.741365172831;12949.482020719066;7260.6732697028765;7396.778096657109;7401.703931842773;7481.588512631749;7495.1005879294835;5731.226284451545;6055.697215139314;6404.4876409886165;6417.903731444126;6497.642629655415;11482.483288252215;11690.941545292219;11711.414429278673;11861.466234019317;11878.406079696153;11803.23278986863;11997.700057498632;12073.517059317528;12120.515179393078;12166.627507635925;8434.831303374021;8600.483970961763;8673.30613550927;8683.782905427162;8690.478571285743;9039.276857851488;9251.121143491358;9400.764980875532;9439.905600943903;9463.574139163617;8099.311558517592;8203.917960820316;8208.630611622611;8243;8358.707445239388;7456.142543607554;7473.6263186841525;7634.541927484369;7638.618069096634;7760.84478310442;7319.5242309249725;7422.035135432359;7424.406047516078;7431.071116110486;7433.331000210007;4800.159972004955;4806.927896081492;4930.6795058321095;4986.775595098156;5074.543291103819;4831.975840120777;4835.274708793709;4869.926951095666;4949.505049495166;4964.776585053609 05:44:10 INFO - PID 14838 | |4;prototype.html;345.28050309458894;346.92887957968617;353.60926176574867;363.13573694606833;368.85983326336;5421.322334708161;5549.639273447223;5551;5613.101903695409;5658.688772117532;5319.723266416061;5410.971915336093;5412.161115027167;5416.8104116355935;5431.131019036955;4164.208800327943;4164.916701665965;4171.124063946575;4186.267403204442;4196.475440569929;4053.6149065838845;4179.638504245107;4192.601702838226;4194.119234960646;4200.306949353353;4142.130152667944;4147.937780933288;4166.83332666693;4174.833006679729;4182.4981002279765;4107.240160570289;4144.647704945083;4148.979255103735;4155.10665206979;4159.542450330461;3650.9634903651154;3654.3239500692457;3659.5608526976666;3660.0483874192637;3667.504886840269;5397.028534863723;5407.783688652449;5411.21537377082;5416.322959630046;5424.159255315432;4925.408950925912;4927.6550641455115;4932.80268789248;4938.950610493885;4951.232558953368;5809.1949772898815;5832.017114181156;5837.970810145965;5841.094630332305;5861.120831875252;4100.466939297872;4102.466679331667;4109.815058322382;4112.3420252759715;4123.092919557693;5830.708464576796;6148.784792532285;6182.69086545671;6222.377762223741;6260.968695156541;4145.8963525912095;4161.3549899765585;4206.221848957953;4208.431861698693;4212.831486740557;4219.54425723125;4231.830726770956;4235.661147108285;4245.596668316505;4251.44731184944;4845.854624361275;4852.078105160008;4855.223164293696;4861.482217682956;4866.464688884291;5762.193292938992;5763.164341170591;5768.567357448208;5789.739461724233;5829.59192856496;1441.149721664223;1465.8167729033871;1470.5441313192944;1471.27172049836;1475.7417451945867;946.9195118414874;987.7185002274317;987.8863930648067;1001.4592120255127;1005.2561104782409;4940.295598018678;4943.9258411123865;4955.380577427822;4987.301777751118;4992;5918.201042859159;5932.851678708067;5963.807238552306;5965.448983264382;6029.849253768691;4962.106820772296;4968.701877887266;4972.129877271463;4980.6341987555625;4989.351384320015;3157.715805577509;3178.631919220196;3183.920401989969;3191.441497737933;3203.599550056243;5447.754851031713;5529.972350138304;5553.583481238923;5559.082751346064;5569.721513924287;6114.633122012605;6123.540734444934;6142.754289828446;6145.508359331243;6151.3541078186145;5491.6979566122645;5538.86152846174;5549.5837812164245;5558.527525160407;5594.524465420403;6002.399760023963;6004.519638429003;6021;6042.335343112342;6045.460906419226;5905.940940590539;5927.407259274038;5946.672932988554;5954.434328738763;5955.880882382241;5508.697021663847;5536.114221724505;5536.861578460571;5549.972250138723;5551.139573366135;3888.1640447303967;4149.398337241144;4182.853600124103;4199.70602057853;4214.894627634211;5839.153322768259;5990.221271234712;6021.849453763691;6030.48740857032;6045.455908968038;5813.534917206529;5821.912671310019;5858.5898987072205;5875.441833025856;5875.970620146872;5835.241418615553;5840.415958404125;5851.736671849862;5858.853528661817;5880.676562789087;5475.397706252229;5696.8006119785605;5727.5417966561745;5727.599068065196;5758.2514273144225;5853.795117170878;5868.471837534642;5868.5305175585;5879.5002424794375;5895.263092113486;5703.657780533182;5704.317226418134;5708.229389032427;5735.483806457439;5741.5406767459335 05:44:10 INFO - PID 14838 | |5;yui.html;714.960677162756;731.9926800731992;739.3013602145968;742.4691345687836;747.1594456236737;13577.253251071186;14474.131552106868;14494.492692755743;15411.922940385282;16831.326746930106;16343.18284085797;16548.66902661946;16553;16553.83446165538;16576.254068566912;889.3996552327186;899.2760827533833;914.9176574108329;920.3741455810047;925.2875286029787;886.1315910407804;939.6194541210787;944.2021491839384;944.5985456181096;944.9888619177483;967.3083745122236;979.5249304087512;979.9265055120859;979.9461029643367;981.3130808434089;958.2382006305004;968.7529679931642;970.8689326940843;973.8295798235281;974.2936371130909;706.4489698035541;709.0640354731756;712.3873468816813;712.4336152758569;714.7998560403043;14063.2968351582;14271.286435678277;14303.642408939755;14317.140971541741;14334.139951602938;16035.599110022225;16998.3200671973;17014.319427222898;17020.148992550323;17058.402955896607;12379.504819807196;12592.811107833299;12649.747005059848;12726.300053497054;12726.68183295425;3057.908262752121;3102.5966624338694;3102.9844850775826;3104.9689503104905;3108.0675797260733;79176;79458.60270698667;80206;80956.59521702412;81218.78171827487;12437.875621243853;12504.3747812609;12572.4342404592;12621.558245461365;12730.80903786444;23396.298111056694;24161.15435959768;24389;24399;24411.389715256904;5976.940230597638;6247.156633854463;6288.874222515524;6338.873222535523;6367.108604795332;2835.688074311824;2933.1933718227233;2934.25176579975;2939.1035734101306;2944.558316252579;3578.320119177348;3667.2848794485353;3684.5394325709285;3688.151725103188;3697.574778900407;736.576468530597;745.0612228591905;750.93617042552;761.105700801567;765.3188662090744;563.5519761789387;574.8792753521724;595.1132812109925;597.3817099302288;604.7792555717132;10224.284300098921;10820.080293175168;10892.782144357068;10998.560057597606;11369.658910232707;565.9207710920474;567.5232804444287;570.922925405065;576.38326990121;582.1704071697814;4678.157931572349;4736.8578942631775;4806.519348065165;4988;5013;88366;88569;89226;90764.09235907557;91447.54276228577;74229;74713.25286747172;75546.24453755502;75653.62173189208;77694;67602;68581.65709171521;68652.656736716;68656.6567167161;70514;9159.908400916172;9908.207343412365;10008;10018.64934727281;10071.496425178566;30212.84893575518;30425.39149216959;30625.846870765505;30974.535381969738;31325.68674313319;36913.26173476569;37301.253974919804;37496.25007499889;37840.62159378481;38272;12707.87292127067;12964.740705185655;13137.802932955821;13196.472141114247;13265.933670331586;13665.726685466434;13879.236641984788;15350.462733804263;15747.44883929057;16031.278592463133;15266.923665381602;15672.216389180723;15722.528324150293;16028.919855400649;16080.035197888164;14389.42442302338;14800.703985920007;15042.097474151586;15200.011999220016;15385.538433847003;15346.539603811903;15626.765598516258;15876.444324448588;15904;16185.352585896433;10784.838227426439;10924.781504369708;11008.614698485835;11206.327620342805;11388.772224555629;12279.447424865724;12626.936865315614;12664.87335126637;12779.169353991962;12884 05:44:10 INFO - PID 14838 | __end_tp_report 05:44:10 INFO - PID 14838 | __start_cc_report 05:44:10 INFO - PID 14838 | _x_x_mozilla_cycle_collect,377 05:44:10 INFO - PID 14838 | __end_cc_report 05:44:10 INFO - PID 14838 | __startTimestamp1496321050879__endTimestamp 05:44:10 INFO - PID 14838 | 05:44:10 INFO - PID 14838 | ------- Summary: start ------- 05:44:10 INFO - PID 14838 | Number of tests: 6 05:44:10 INFO - PID 14838 | 05:44:10 INFO - PID 14838 | [#0] dojo.html Cycles:165 Average:5143.81 Median:5316.55 stddev:607.70 (11.4%) stddev-sans-first:577.99 05:44:10 INFO - PID 14838 | Values: 2679.2 2690.2 2703.8 2735.0 2736.9 5115.3 5188.8 5241.7 5242.0 5273.7 5200.7 5203.3 5214.6 5306.0 5336.7 4426.9 4603.2 4664.4 4690.4 4694.2 4694.0 4714.9 4729.7 4745.9 4750.2 4563.6 4578.9 4637.2 4681.0 4705.2 4640.0 4681.1 4688.0 4714.2 4734.7 4612.4 4613.3 4653.1 4677.2 4682.8 5042.8 5131.9 5240.5 5243.7 5294.9 5600.4 5683.6 5693.7 5705.1 5714.9 5689.6 5717.4 5718.5 5719.5 5726.1 5299.1 5310.9 5316.5 5318.8 5360.9 5608.1 5695.9 5705.2 5760.2 5834.6 5554.1 5564.6 5575.9 5595.3 5611.1 5388.8 5641.7 5644.4 5646.9 5648.2 5491.9 5586.4 5608.5 5610.5 5630.5 5555.7 5568.0 5579.7 5585.4 5638.0 4673.4 4707.1 4718.8 4718.9 4750.0 4021.1 4027.7 4033.0 4054.4 4085.3 4613.8 4688.7 4726.9 4760.4 4777.7 5646.2 5653.0 5658.8 5675.7 5703.9 4746.4 4747.0 4753.6 4759.5 4793.6 4856.8 4907.6 4915.4 4979.4 4987.3 5235.5 5251.6 5255.6 5261.2 5285.3 5532.4 5596.8 5607.3 5619.4 5632.9 5171.7 5191.6 5203.6 5206.5 5225.3 5595.4 5602.0 5610.9 5616.2 5657.4 5567.5 5636.5 5681.2 5692.3 5711.0 5455.1 5472.1 5512.4 5519.6 5531.8 5412.5 5415.1 5418.6 5429.5 5466.0 5309.6 5330.7 5337.9 5354.2 5379.8 5375.2 5425.7 5446.6 5510.3 5597.9 5365.7 5371.8 5379.8 5395.9 5424.4 05:44:10 INFO - PID 14838 | 05:44:10 INFO - PID 14838 | [#1] ext.html Cycles:180 Average:30993.27 Median:31288.19 stddev:40227.80 (128.6%) stddev-sans-first:40276.29 05:44:10 INFO - PID 14838 | Values: 688.1 748.7 765.7 1089.6 1098.4 32922.0 34278.1 34337.0 34366.0 34366.3 36236.0 36510.1 36579.5 36653.3 36680.3 6658.6 6830.9 6837.7 6839.8 6973.2 6864.7 6919.2 6984.3 6986.8 6989.7 6964.3 7025.5 7036.2 7037.6 7063.2 6964.2 6966.2 7004.8 7007.5 7017.5 6627.4 6711.5 6740.2 6744.3 6756.3 32515.7 32823.8 32853.2 32889.0 32908.8 2990.4 3028.8 3041.6 3049.5 3050.4 25149.2 25192.0 25216.1 25323.6 25346.1 2757.1 2785.5 2801.2 2811.1 2818.6 123593.0 124325.0 135202.3 146839.0 147350.0 40085.2 40298.0 40386.0 40410.4 40501.6 41546.0 41878.0 42121.4 42167.0 45694.8 12905.1 12981.3 12987.4 13020.5 13071.8 10346.6 10360.4 10372.7 10384.6 10399.9 13099.5 13184.8 13226.5 13261.6 13335.1 5409.5 5476.1 5490.4 5491.5 5505.9 857.9 899.0 900.2 912.6 943.8 20143.3 20670.8 21020.3 21169.6 21199.7 973.9 976.6 990.7 1007.3 1007.7 10962.5 11034.0 11199.2 11231.1 11392.2 164567.0 166164.0 166599.0 167402.2 180266.0 46285.0 46969.3 47150.8 47376.0 47443.5 1253.2 1279.3 1281.1 1285.5 1290.7 25052.5 25338.4 26218.5 26507.9 26541.6 31397.4 38401.4 39098.8 39218.2 39352.8 159967.2 160175.2 160658.0 160790.0 160890.0 31112.2 31206.0 31370.4 31415.2 31734.0 37047.0 37477.4 37755.0 38102.2 38308.4 28789.6 29261.6 29355.3 29751.0 29916.6 28003.3 28588.3 29219.3 29852.9 30094.5 32223.4 32229.4 32448.7 32519.5 32802.7 26733.0 27138.9 27431.0 28030.6 28484.4 21721.8 22476.2 22712.2 22843.2 22989.4 05:44:10 INFO - PID 14838 | 05:44:10 INFO - PID 14838 | [#2] jquery.html Cycles:180 Average:26453.02 Median:24538.51 stddev:60302.70 (245.7%) stddev-sans-first:60440.18 05:44:10 INFO - PID 14838 | Values: 419.8 421.9 421.9 437.0 437.6 18006.5 18709.9 18755.8 18758.2 18855.2 19627.8 20305.3 20342.3 20368.0 20401.0 5474.5 5609.1 5617.7 5620.8 5629.3 5646.1 5666.0 5687.1 5693.4 5694.2 5678.1 5688.3 5689.0 5689.8 5694.0 5314.6 5511.3 5541.4 5641.7 5693.6 4893.5 4939.7 4946.6 4963.8 4987.1 24166.4 24478.8 24526.4 24550.6 24561.1 1652.8 1673.8 1681.9 1684.7 1692.9 15407.2 15704.3 15773.9 16033.9 16093.0 2006.0 2008.5 2013.4 2030.6 2038.6 102817.0 106575.0 107955.0 114074.0 114811.4 10742.4 11260.9 11313.7 11708.6 11786.4 16401.8 16402.9 16496.4 16516.5 16532.9 7785.8 7934.7 7936.8 7937.4 8232.0 7122.9 7250.2 7267.0 7319.9 7346.9 7403.9 7539.5 7542.6 7731.3 7770.9 1949.7 1950.5 1989.4 2003.3 2139.5 837.9 862.6 880.5 902.5 906.1 17799.3 17807.5 17830.7 18289.5 18632.8 865.2 873.4 881.1 889.1 899.1 9800.9 9833.0 10070.8 10105.3 10175.4 350645.0 351346.0 358712.0 358760.0 359907.0 83640.0 84112.0 84814.0 86806.6 87129.6 1031.8 1040.8 1126.7 1129.3 1134.8 18115.9 18426.6 18713.7 19166.6 19171.1 46029.8 46269.5 46424.5 46698.8 46792.3 55016.7 55394.7 55578.2 55856.0 56273.4 9581.2 9621.2 9747.5 9872.0 9876.4 15746.4 15792.0 15915.8 15932.2 16097.8 12831.2 12860.9 13092.7 13115.1 13117.3 11100.4 11195.3 11786.7 12183.8 12231.3 13446.1 13462.0 13482.9 13540.3 13551.3 9600.1 9621.4 9634.7 9708.1 9790.4 13212.0 13296.1 13364.0 13445.1 13478.9 05:44:10 INFO - PID 14838 | 05:44:10 INFO - PID 14838 | [#3] mootools.html Cycles:180 Average:6173.04 Median:4745.03 stddev:3999.27 (84.3%) stddev-sans-first:3993.11 05:44:10 INFO - PID 14838 | Values: 1211.7 1293.8 1298.8 1298.9 1303.4 9652.9 10022.1 10061.8 10110.5 10353.4 10182.0 10273.1 10296.0 10312.3 10378.9 2013.6 2055.2 2059.9 2061.1 2063.7 1876.0 1934.3 1935.3 1938.0 1972.1 1959.4 1981.3 1982.1 1982.9 1987.6 1915.6 1928.1 1929.6 1930.9 1942.7 1873.4 1940.4 1958.9 1964.1 1983.3 9700.1 9959.9 9960.3 9962.9 10007.2 5167.2 5323.7 5349.3 5364.3 5377.8 3020.5 3150.5 3204.9 3207.8 3221.5 929.9 953.3 976.0 985.7 986.7 12507.6 12876.3 14357.2 14521.7 14537.3 4713.6 4780.8 4923.4 4969.8 4980.5 12044.4 12148.3 12165.3 12193.4 12260.5 5222.6 5365.5 5365.7 5384.5 5390.0 4776.5 4858.4 4868.9 4874.5 4878.5 4082.1 4122.9 4124.0 4150.4 4206.5 1208.0 1219.7 1237.5 1247.1 1247.5 723.9 744.8 757.3 762.4 764.0 5397.2 5544.3 5626.8 5687.7 5689.5 529.1 542.6 545.4 546.0 546.1 3455.7 4116.2 4129.5 4142.5 4311.2 12457.9 13004.9 13032.7 13053.4 13069.2 12740.0 12870.8 12871.1 12931.7 12949.5 7260.7 7396.8 7401.7 7481.6 7495.1 5731.2 6055.7 6404.5 6417.9 6497.6 11482.5 11690.9 11711.4 11861.5 11878.4 11803.2 11997.7 12073.5 12120.5 12166.6 8434.8 8600.5 8673.3 8683.8 8690.5 9039.3 9251.1 9400.8 9439.9 9463.6 8099.3 8203.9 8208.6 8243.0 8358.7 7456.1 7473.6 7634.5 7638.6 7760.8 7319.5 7422.0 7424.4 7431.1 7433.3 4800.2 4806.9 4930.7 4986.8 5074.5 4832.0 4835.3 4869.9 4949.5 4964.8 05:44:10 INFO - PID 14838 | 05:44:10 INFO - PID 14838 | [#4] prototype.html Cycles:180 Average:4789.77 Median:5422.74 stddev:1416.20 (26.1%) stddev-sans-first:1380.32 05:44:10 INFO - PID 14838 | Values: 345.3 346.9 353.6 363.1 368.9 5421.3 5549.6 5551.0 5613.1 5658.7 5319.7 5411.0 5412.2 5416.8 5431.1 4164.2 4164.9 4171.1 4186.3 4196.5 4053.6 4179.6 4192.6 4194.1 4200.3 4142.1 4147.9 4166.8 4174.8 4182.5 4107.2 4144.6 4149.0 4155.1 4159.5 3651.0 3654.3 3659.6 3660.0 3667.5 5397.0 5407.8 5411.2 5416.3 5424.2 4925.4 4927.7 4932.8 4939.0 4951.2 5809.2 5832.0 5838.0 5841.1 5861.1 4100.5 4102.5 4109.8 4112.3 4123.1 5830.7 6148.8 6182.7 6222.4 6261.0 4145.9 4161.4 4206.2 4208.4 4212.8 4219.5 4231.8 4235.7 4245.6 4251.4 4845.9 4852.1 4855.2 4861.5 4866.5 5762.2 5763.2 5768.6 5789.7 5829.6 1441.1 1465.8 1470.5 1471.3 1475.7 946.9 987.7 987.9 1001.5 1005.3 4940.3 4943.9 4955.4 4987.3 4992.0 5918.2 5932.9 5963.8 5965.4 6029.8 4962.1 4968.7 4972.1 4980.6 4989.4 3157.7 3178.6 3183.9 3191.4 3203.6 5447.8 5530.0 5553.6 5559.1 5569.7 6114.6 6123.5 6142.8 6145.5 6151.4 5491.7 5538.9 5549.6 5558.5 5594.5 6002.4 6004.5 6021.0 6042.3 6045.5 5905.9 5927.4 5946.7 5954.4 5955.9 5508.7 5536.1 5536.9 5550.0 5551.1 3888.2 4149.4 4182.9 4199.7 4214.9 5839.2 5990.2 6021.8 6030.5 6045.5 5813.5 5821.9 5858.6 5875.4 5876.0 5835.2 5840.4 5851.7 5858.9 5880.7 5475.4 5696.8 5727.5 5727.6 5758.3 5853.8 5868.5 5868.5 5879.5 5895.3 5703.7 5704.3 5708.2 5735.5 5741.5 05:44:10 INFO - PID 14838 | 05:44:10 INFO - PID 14838 | [#5] yui.html Cycles:180 Average:17811.91 Median:3106.52 stddev:23311.14 (750.4%) stddev-sans-first:23341.18 05:44:10 INFO - PID 14838 | Values: 715.0 732.0 739.3 742.5 747.2 13577.3 14474.1 14494.5 15411.9 16831.3 16343.2 16548.7 16553.0 16553.8 16576.3 889.4 899.3 914.9 920.4 925.3 886.1 939.6 944.2 944.6 945.0 967.3 979.5 979.9 979.9 981.3 958.2 968.8 970.9 973.8 974.3 706.4 709.1 712.4 712.4 714.8 14063.3 14271.3 14303.6 14317.1 14334.1 16035.6 16998.3 17014.3 17020.1 17058.4 12379.5 12592.8 12649.7 12726.3 12726.7 3057.9 3102.6 3103.0 3105.0 3108.1 79176.0 79458.6 80206.0 80956.6 81218.8 12437.9 12504.4 12572.4 12621.6 12730.8 23396.3 24161.2 24389.0 24399.0 24411.4 5976.9 6247.2 6288.9 6338.9 6367.1 2835.7 2933.2 2934.3 2939.1 2944.6 3578.3 3667.3 3684.5 3688.2 3697.6 736.6 745.1 750.9 761.1 765.3 563.6 574.9 595.1 597.4 604.8 10224.3 10820.1 10892.8 10998.6 11369.7 565.9 567.5 570.9 576.4 582.2 4678.2 4736.9 4806.5 4988.0 5013.0 88366.0 88569.0 89226.0 90764.1 91447.5 74229.0 74713.3 75546.2 75653.6 77694.0 67602.0 68581.7 68652.7 68656.7 70514.0 9159.9 9908.2 10008.0 10018.6 10071.5 30212.8 30425.4 30625.8 30974.5 31325.7 36913.3 37301.3 37496.3 37840.6 38272.0 12707.9 12964.7 13137.8 13196.5 13265.9 13665.7 13879.2 15350.5 15747.4 16031.3 15266.9 15672.2 15722.5 16028.9 16080.0 14389.4 14800.7 15042.1 15200.0 15385.5 15346.5 15626.8 15876.4 15904.0 16185.4 10784.8 10924.8 11008.6 11206.3 11388.8 12279.4 12626.9 12664.9 12779.2 12884.0 05:44:10 INFO - PID 14838 | -------- Summary: end -------- 05:44:10 INFO - PID 14838 | 05:44:11 INFO - TEST-INFO | 14838: exit 0 05:44:11 INFO - TEST-OK | dromaeo_css | took 1146930ms 05:44:11 INFO - TEST-START | kraken 05:44:11 INFO - operating with platform_type : linux_ 05:44:11 INFO - Initialising browser for kraken test... 05:44:11 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53789/getInfo.html -profile /tmp/tmpFuvON7/profile 05:44:11 INFO - TEST-INFO | started process 15247 (/builds/slave/test/build/application/firefox/firefox http://localhost:53789/getInfo.html) 05:44:46 INFO - TEST-INFO | 15247: killed by SIGTERM 05:44:46 INFO - Browser initialized. 05:44:46 INFO - Running cycle 1/1 for kraken test... 05:44:46 INFO - TEST-INFO | started process 15450 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFuvON7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:44:58 INFO - PID 15450 | RSS: Main: 183947264 05:44:58 INFO - PID 15450 | 05:45:01 INFO - PID 15450 | Cycle 1(1): loaded http://localhost:53789/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53789/tests/kraken/driver.html?testName=audio-beat-detection) 05:45:02 INFO - PID 15450 | RSS: Main: 188428288 05:45:02 INFO - PID 15450 | 05:45:05 INFO - PID 15450 | Cycle 1(1): loaded http://localhost:53789/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53789/tests/kraken/driver.html?testName=audio-dft) 05:45:05 INFO - PID 15450 | RSS: Main: 186589184 05:45:05 INFO - PID 15450 | 05:45:08 INFO - PID 15450 | Cycle 1(1): loaded http://localhost:53789/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53789/tests/kraken/driver.html?testName=audio-fft) 05:45:09 INFO - PID 15450 | RSS: Main: 182312960 05:45:09 INFO - PID 15450 | 05:45:11 INFO - PID 15450 | Cycle 1(1): loaded http://localhost:53789/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53789/tests/kraken/driver.html?testName=audio-oscillator) 05:45:12 INFO - PID 15450 | RSS: Main: 182439936 05:45:12 INFO - PID 15450 | 05:45:14 INFO - PID 15450 | Cycle 1(1): loaded http://localhost:53789/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53789/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:45:14 INFO - PID 15450 | RSS: Main: 182509568 05:45:14 INFO - PID 15450 | 05:45:18 INFO - PID 15450 | Cycle 1(1): loaded http://localhost:53789/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53789/tests/kraken/driver.html?testName=imaging-darkroom) 05:45:18 INFO - PID 15450 | RSS: Main: 183648256 05:45:18 INFO - PID 15450 | 05:45:22 INFO - PID 15450 | Cycle 1(1): loaded http://localhost:53789/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53789/tests/kraken/driver.html?testName=imaging-desaturate) 05:45:22 INFO - PID 15450 | RSS: Main: 182472704 05:45:22 INFO - PID 15450 | 05:45:25 INFO - PID 15450 | Cycle 1(1): loaded http://localhost:53789/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53789/tests/kraken/driver.html?testName=json-parse-financial) 05:45:26 INFO - PID 15450 | RSS: Main: 182996992 05:45:26 INFO - PID 15450 | 05:45:28 INFO - PID 15450 | Cycle 1(1): loaded http://localhost:53789/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53789/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:45:28 INFO - PID 15450 | RSS: Main: 183156736 05:45:28 INFO - PID 15450 | 05:45:30 INFO - PID 15450 | Cycle 1(1): loaded http://localhost:53789/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53789/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:45:31 INFO - PID 15450 | RSS: Main: 182943744 05:45:31 INFO - PID 15450 | 05:45:33 INFO - PID 15450 | Cycle 1(1): loaded http://localhost:53789/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53789/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:45:34 INFO - PID 15450 | RSS: Main: 183111680 05:45:34 INFO - PID 15450 | 05:45:36 INFO - PID 15450 | Cycle 1(1): loaded http://localhost:53789/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53789/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:45:37 INFO - PID 15450 | RSS: Main: 183296000 05:45:37 INFO - PID 15450 | 05:45:40 INFO - PID 15450 | Cycle 1(1): loaded http://localhost:53789/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53789/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:45:41 INFO - PID 15450 | RSS: Main: 183341056 05:45:41 INFO - PID 15450 | 05:45:43 INFO - PID 15450 | Cycle 1(1): loaded http://localhost:53789/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53789/tests/kraken/driver.html?testName=ai-astar) 05:45:43 INFO - PID 15450 | RSS: Main: 184582144 05:45:43 INFO - PID 15450 | 05:45:43 INFO - PID 15450 | __start_tp_report 05:45:43 INFO - PID 15450 | _x_x_mozilla_page_load 05:45:43 INFO - PID 15450 | _x_x_mozilla_page_load_details 05:45:43 INFO - PID 15450 | |i|pagename|runs| 05:45:43 INFO - PID 15450 | |0;ai-astar;104;113;112;109;112;110;111;111;110;109 05:45:43 INFO - PID 15450 | |1;audio-beat-detection;155;123;124;169;122;123;122;124;147;124 05:45:43 INFO - PID 15450 | |2;audio-dft;164;166;164;166;170;169;176;164;163;164 05:45:43 INFO - PID 15450 | |3;audio-fft;74;74;76;109;75;74;73;74;92;76 05:45:43 INFO - PID 15450 | |4;audio-oscillator;83;83;113;82;82;82;102;82;84;106 05:45:43 INFO - PID 15450 | |5;imaging-gaussian-blur;114;114;114;115;115;114;115;117;114;114 05:45:43 INFO - PID 15450 | |6;imaging-darkroom;150;149;150;149;149;151;150;152;151;150 05:45:43 INFO - PID 15450 | |7;imaging-desaturate;95;95;95;95;95;98;94;95;95;95 05:45:43 INFO - PID 15450 | |8;json-parse-financial;55;57;56;57;58;58;57;60;58;58 05:45:43 INFO - PID 15450 | |9;json-stringify-tinderbox;56;56;58;56;56;57;57;56;55;56 05:45:43 INFO - PID 15450 | |10;stanford-crypto-aes;95;87;88;85;85;87;98;88;123;86 05:45:43 INFO - PID 15450 | |11;stanford-crypto-ccm;132;137;143;132;129;140;143;131;130;140 05:45:43 INFO - PID 15450 | |12;stanford-crypto-pbkdf2;184;195;202;194;185;193;201;186;194;194 05:45:43 INFO - PID 15450 | |13;stanford-crypto-sha256-iterative;74;78;87;76;73;73;72;69;71;70 05:45:43 INFO - PID 15450 | __end_tp_report 05:45:43 INFO - PID 15450 | __start_cc_report 05:45:43 INFO - PID 15450 | _x_x_mozilla_cycle_collect,1054 05:45:43 INFO - PID 15450 | __end_cc_report 05:45:43 INFO - PID 15450 | __startTimestamp1496321143406__endTimestamp 05:45:43 INFO - PID 15450 | 05:45:43 INFO - PID 15450 | ------- Summary: start ------- 05:45:43 INFO - PID 15450 | Number of tests: 14 05:45:43 INFO - PID 15450 | 05:45:43 INFO - PID 15450 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.51 (2.3%) stddev-sans-first:1.39 05:45:43 INFO - PID 15450 | Values: 104.0 113.0 112.0 109.0 112.0 110.0 111.0 111.0 110.0 109.0 05:45:43 INFO - PID 15450 | 05:45:43 INFO - PID 15450 | [#1] audio-beat-detection Cycles:10 Average:133.30 Median:124.00 stddev:17.19 (13.9%) stddev-sans-first:16.34 05:45:43 INFO - PID 15450 | Values: 155.0 123.0 124.0 169.0 122.0 123.0 122.0 124.0 147.0 124.0 05:45:43 INFO - PID 15450 | 05:45:43 INFO - PID 15450 | [#2] audio-dft Cycles:10 Average:166.60 Median:166.00 stddev:4.03 (2.4%) stddev-sans-first:4.17 05:45:43 INFO - PID 15450 | Values: 164.0 166.0 164.0 166.0 170.0 169.0 176.0 164.0 163.0 164.0 05:45:43 INFO - PID 15450 | 05:45:43 INFO - PID 15450 | [#3] audio-fft Cycles:10 Average:79.70 Median:74.50 stddev:11.71 (15.7%) stddev-sans-first:12.24 05:45:43 INFO - PID 15450 | Values: 74.0 74.0 76.0 109.0 75.0 74.0 73.0 74.0 92.0 76.0 05:45:43 INFO - PID 15450 | 05:45:43 INFO - PID 15450 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:82.00 stddev:12.11 (14.8%) stddev-sans-first:12.58 05:45:43 INFO - PID 15450 | Values: 83.0 83.0 113.0 82.0 82.0 82.0 102.0 82.0 84.0 106.0 05:45:43 INFO - PID 15450 | 05:45:43 INFO - PID 15450 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.50 stddev:0.97 (0.8%) stddev-sans-first:1.00 05:45:43 INFO - PID 15450 | Values: 114.0 114.0 114.0 115.0 115.0 114.0 115.0 117.0 114.0 114.0 05:45:43 INFO - PID 15450 | 05:45:43 INFO - PID 15450 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:150.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 05:45:43 INFO - PID 15450 | Values: 150.0 149.0 150.0 149.0 149.0 151.0 150.0 152.0 151.0 150.0 05:45:43 INFO - PID 15450 | 05:45:43 INFO - PID 15450 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:1.03 (1.1%) stddev-sans-first:1.09 05:45:43 INFO - PID 15450 | Values: 95.0 95.0 95.0 95.0 95.0 98.0 94.0 95.0 95.0 95.0 05:45:43 INFO - PID 15450 | 05:45:43 INFO - PID 15450 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:58.00 stddev:1.35 (2.3%) stddev-sans-first:1.12 05:45:43 INFO - PID 15450 | Values: 55.0 57.0 56.0 57.0 58.0 58.0 57.0 60.0 58.0 58.0 05:45:43 INFO - PID 15450 | 05:45:43 INFO - PID 15450 | [#9] json-stringify-tinderbox Cycles:10 Average:56.30 Median:56.00 stddev:0.82 (1.5%) stddev-sans-first:0.87 05:45:43 INFO - PID 15450 | Values: 56.0 56.0 58.0 56.0 56.0 57.0 57.0 56.0 55.0 56.0 05:45:43 INFO - PID 15450 | 05:45:43 INFO - PID 15450 | [#10] stanford-crypto-aes Cycles:10 Average:92.20 Median:87.50 stddev:11.65 (13.3%) stddev-sans-first:12.31 05:45:43 INFO - PID 15450 | Values: 95.0 87.0 88.0 85.0 85.0 87.0 98.0 88.0 123.0 86.0 05:45:43 INFO - PID 15450 | 05:45:43 INFO - PID 15450 | [#11] stanford-crypto-ccm Cycles:10 Average:135.70 Median:138.50 stddev:5.50 (4.0%) stddev-sans-first:5.67 05:45:43 INFO - PID 15450 | Values: 132.0 137.0 143.0 132.0 129.0 140.0 143.0 131.0 130.0 140.0 05:45:43 INFO - PID 15450 | 05:45:43 INFO - PID 15450 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.80 Median:194.00 stddev:6.20 (3.2%) stddev-sans-first:5.70 05:45:43 INFO - PID 15450 | Values: 184.0 195.0 202.0 194.0 185.0 193.0 201.0 186.0 194.0 194.0 05:45:43 INFO - PID 15450 | 05:45:43 INFO - PID 15450 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.30 Median:73.50 stddev:5.21 (7.1%) stddev-sans-first:5.52 05:45:43 INFO - PID 15450 | Values: 74.0 78.0 87.0 76.0 73.0 73.0 72.0 69.0 71.0 70.0 05:45:43 INFO - PID 15450 | -------- Summary: end -------- 05:45:43 INFO - PID 15450 | 05:45:44 INFO - TEST-INFO | 15450: exit 0 05:45:44 INFO - TEST-OK | kraken | took 92792ms 05:45:44 INFO - SUITE-END | took 1239s 05:45:45 INFO - Completed test suite (00:20:40) 05:45:45 INFO - javascript benchmark 05:45:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6870.210953564672, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2679.1681212907088, 2690.1794952539467, 2703.837769733815, 2734.9999999999995, 2736.9178924632256, 5115.335006449166, 5188.844334669961, 5241.685498870066, 5241.983787884837, 5273.6572122811995, 5200.739963001844, 5203.2975548300965, 5214.556762675177, 5305.973470132644, 5336.67979921205, 4426.936963542315, 4603.194440972817, 4664.370310008157, 4690.413698287714, 4694.225452800284, 4693.976530117362, 4714.905701885978, 4729.716217026972, 4745.881352966169, 4750.168720473903, 4563.634909207289, 4578.885527861797, 4637.165310244155, 4680.976595117037, 4705.223638099709, 4639.953600463986, 4681.063787242565, 4687.9531204687855, 4714.175019371631, 4734.7452924974905, 4612.423447069116, 4613.308003799423, 4653.139169253699, 4677.228257337535, 4682.8126874924965, 5042.823501177441, 5131.923021154686, 5240.475952404767, 5243.659162154448, 5294.894102117974, 5600.355959064719, 5683.602147849652, 5693.686847223443, 5705.144228365778, 5714.914276285859, 5689.573282003867, 5717.399673034313, 5718.48533631971, 5719.485246327808, 5726.141078838207, 5299.072662284085, 5310.893782124336, 5316.548093412026, 5318.760655770499, 5360.91958620621, 5608.10270356741, 5695.857603559944, 5705.2012718219485, 5760.193572899798, 5834.5624078194305, 5554.08357620988, 5564.638298510584, 5575.860603484945, 5595.328560572757, 5611.074172761449, 5388.757505912244, 5641.689707066151, 5644.435556444323, 5646.915296270559, 5648.181013752983, 5491.917621235684, 5586.441355864462, 5608.46719561641, 5610.523105535994, 5630.5495560355075, 5555.72221388937, 5568.025595520768, 5579.721013949286, 5585.357683866408, 5638.04153293941, 4673.415823022122, 4707.082118986833, 4718.811247550128, 4718.882027949328, 4749.95250047502, 4021.0550520628212, 4027.697922655754, 4033.0, 4054.351303791379, 4085.264652362603, 4613.792379342937, 4688.742119183409, 4726.88182795426, 4760.381150450419, 4777.737224452619, 5646.20953066571, 5652.971735141298, 5658.773649053992, 5675.744591493392, 5703.914441283384, 4746.359241502422, 4746.976265118652, 4753.643476739258, 4759.524047595212, 4793.640476964241, 4856.805727770849, 4907.558319751168, 4915.4347250065985, 4979.377577802775, 4987.326710894055, 5235.528802407802, 5251.6323857331145, 5255.605829562722, 5261.184516399811, 5285.286486324297, 5532.3637781655625, 5596.804111856066, 5607.327120745536, 5619.438056194348, 5632.85917852057, 5171.715555644476, 5191.584673226208, 5203.609729270395, 5206.505381988705, 5225.320708307896, 5595.412481689364, 5601.971990140023, 5610.85972850682, 5616.241807355955, 5657.434256574475, 5567.526760225264, 5636.549076073986, 5681.2330335404195, 5692.2600061993335, 5710.971445142748, 5455.1271796512365, 5472.124460086367, 5512.3660779010925, 5519.558435325084, 5531.806386776443, 5412.458754124556, 5415.052365836042, 5418.593605479684, 5429.484199001088, 5466.043442397644, 5309.57523398135, 5330.733463326741, 5337.866553336197, 5354.223637572608, 5379.838604841861, 5375.16684913839, 5425.728713564385, 5446.618736688552, 5510.283663123768, 5597.860053498533, 5365.678059316453, 5371.758270877742, 5379.757910894097, 5395.919061214006, 5424.403315635356], "value": 5099.451207887735, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.1363888320158, 748.7154881145166, 765.6669348833257, 1089.6240796925058, 1098.368438148065, 32921.99999999997, 34278.14304642385, 34337.0, 34366.0, 34366.31267374651, 36236.0, 36510.08724781882, 36579.4513082304, 36653.26693466129, 36680.26639467209, 6658.600483970953, 6830.863382732342, 6837.65811709415, 6839.829004274908, 6973.198082220546, 6864.656767161647, 6919.169699636025, 6984.3364880336285, 6986.825329366781, 6989.720411183546, 6964.303569643046, 7025.473089518281, 7036.226015138331, 7037.612931288777, 7063.152421709402, 6964.233934267227, 6966.198887127995, 7004.789856304319, 7007.544509606859, 7017.543859649132, 6627.4366678831875, 6711.463082953352, 6740.191177058735, 6744.291849355845, 6756.290589488131, 32515.6748432515, 32823.83588082044, 32853.17867053319, 32889.0, 32908.83545582281, 2990.372021875409, 3028.8485575721124, 3041.6045914031033, 3049.451098802215, 3050.4051709916575, 25149.24552263435, 25192.0, 25216.117435889657, 25323.62014569783, 25346.112886049083, 2757.131503576367, 2785.4986102501543, 2801.2296618430096, 2811.14260150654, 2818.6053952446673, 123593.0, 124325.0, 135202.32398837942, 146839.0, 147350.0, 40085.198296033916, 40297.95530670423, 40386.0, 40410.39384409236, 40501.594984049785, 41546.0, 41878.0, 42121.36817947733, 42167.0, 45694.771526142824, 12905.09664323507, 12981.286029268482, 12987.41556629954, 13020.544280950122, 13071.803922941164, 10346.586136554453, 10360.430176340224, 10372.688819335432, 10384.636537721144, 10399.94800025995, 13099.541516046893, 13184.769731415865, 13226.537071202461, 13261.602151935458, 13335.1332163411, 5409.459054094559, 5476.123820188751, 5490.423505531941, 5491.505764481136, 5505.862353441116, 857.8841856349313, 898.9910100899039, 900.1673452056821, 912.6303846942, 943.7876477792441, 20143.294984675467, 20670.793292066886, 21020.26429074975, 21169.576608467745, 21199.72801631907, 973.9172170365598, 976.6191185437685, 990.6829814459448, 1007.2747621712356, 1007.6775431861734, 10962.506687199095, 11034.006939375495, 11199.216054876244, 11231.10151187903, 11392.202545821712, 164567.0, 166164.0, 166599.0, 167402.16298918426, 180266.0, 46285.0, 46969.295460568115, 47150.76424617855, 47376.0, 47443.5255647446, 1253.2355263289387, 1279.2516377918835, 1281.0968267371481, 1285.4665313894816, 1290.6966862787237, 25052.49895002126, 25338.366540836625, 26218.475630487665, 26507.867460662572, 26541.60187597226, 31397.372052559276, 38401.4239786409, 39098.80450597843, 39218.215635687695, 39352.803235983636, 159967.20016399844, 160175.19912400364, 160658.0, 160790.0, 160890.0, 31112.22219444532, 31206.0, 31370.372592548476, 31415.21461963469, 31734.0, 37047.0, 37477.4378384319, 37755.0, 38102.2379552413, 38308.42537361886, 28789.56815647725, 29261.561076584294, 29355.266118346357, 29751.0, 29916.551251730805, 28003.299917501412, 28588.285292867844, 29219.269518262212, 29852.850735746182, 30094.548581771727, 32223.35553288968, 32229.35541289208, 32448.675513244565, 32519.51220731738, 32802.67197327996, 26733.0, 27138.864305678344, 27431.0, 28030.579541306488, 28484.43031139407, 21721.782782171977, 22476.213332533283, 22712.205072822373, 22843.200487982842, 22989.425264368525], "value": 14931.371621116037, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.80269273441473, 421.8607859406395, 421.93038148705466, 436.9563043695631, 437.6039684085902, 18006.549836254082, 18709.906450467763, 18755.812441875594, 18758.155882985266, 18855.245790168396, 19627.803721962777, 20305.289314873982, 20342.288019919306, 20368.0, 20401.0, 5474.452554744534, 5609.1305847593685, 5617.747201375948, 5620.831375058755, 5629.296337957755, 5646.096624540074, 5666.0, 5687.146927960818, 5693.430656934315, 5694.202811606378, 5678.091505359143, 5688.317401911776, 5689.0328644130595, 5689.800856970007, 5693.971530142344, 5314.5748340132695, 5511.283533140706, 5541.362743284533, 5641.661500309994, 5693.572982026365, 4893.4617192108835, 4939.654224204307, 4946.554810067075, 4963.801447942078, 4987.102321582114, 24166.395840103964, 24478.755212447824, 24526.386840328956, 24550.631740523906, 24561.14036008749, 1652.842979916906, 1673.8493535581856, 1681.9495415137565, 1684.688332658462, 1692.889962152456, 15407.229638518142, 15704.29330680122, 15773.921130394388, 16033.919830400773, 16093.0, 2005.959880802376, 2008.457716416574, 2013.3959812056326, 2030.5634288628016, 2038.6126635939124, 102817.0, 106575.0, 107955.0, 114074.0, 114811.42594286976, 10742.409167495864, 11260.887391126147, 11313.660590182308, 11708.590199343153, 11786.410679465993, 16401.83598164027, 16402.917985409997, 16496.42262520806, 16516.50450486487, 16532.917335413247, 7785.844283114306, 7934.722284720123, 7936.801579960547, 7937.404694647925, 8231.95884020576, 7122.857542849114, 7250.2024777274455, 7267.0, 7319.853602927911, 7346.853062938711, 7403.925960740324, 7539.547627142389, 7542.622868856535, 7731.265529774662, 7770.92229077702, 1949.697796841492, 1950.4538729155574, 1989.44295597233, 2003.2888324644541, 2139.5399989002126, 837.9036410812713, 862.6333808131644, 880.5377176982007, 902.4765635931144, 906.1482206725657, 17799.288028478717, 17807.46577602674, 17830.732539011926, 18289.542761431072, 18632.813671863107, 865.2385900407727, 873.4497266722052, 881.0792721605937, 889.1375365895071, 899.0919171636695, 9800.90199098014, 9832.950835245778, 10070.798584028278, 10105.29262951601, 10175.44035078063, 350645.0, 351346.0, 358712.0, 358760.0, 359907.0, 83640.0, 84112.0, 84814.0, 86806.56596716976, 87129.56435217784, 1031.7884833609091, 1040.78143589847, 1126.6507382711222, 1129.2603344809163, 1134.8070827959266, 18115.909420452812, 18426.631467370844, 18713.719294210325, 19166.616667666847, 19171.137298821865, 46029.76985115053, 46269.53730462652, 46424.53575464202, 46698.76650616725, 46792.298115527614, 55016.72491637516, 55394.72302638461, 55578.16632750431, 55856.0, 56273.43726562682, 9581.185599224144, 9621.230301575997, 9747.512624368896, 9871.950640246752, 9876.370398884392, 15746.370145194063, 15792.0, 15915.761263581287, 15932.203389830695, 16097.839021609634, 12831.165974211646, 12860.871391286342, 13092.738145237232, 13115.081944264191, 13117.278549679859, 11100.389478578756, 11195.328280303207, 11786.705332366759, 12183.817242741543, 12231.327276999851, 13446.058775885986, 13462.0, 13482.93258533701, 13540.322983850965, 13551.25468099264, 9600.087991640783, 9621.422714636865, 9634.662786802428, 9708.077732615391, 9790.412575245507, 13212.0, 13296.135751176143, 13364.0, 13445.058845880694, 13478.932605336911], "value": 9525.898754001953, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1211.7031327324803, 1293.8447386313644, 1298.7727147749144, 1298.8766067223623, 1303.4264923433689, 9652.85520717189, 10022.14811741001, 10061.798764024725, 10110.494475276235, 10353.430561319125, 10182.0, 10273.075423211909, 10296.0, 10312.278140530167, 10378.948105259482, 2013.6274789164015, 2055.198472595689, 2059.855810093294, 2061.072517367191, 2063.6698128299477, 1875.9718604220948, 1934.3133187718297, 1935.312963897817, 1937.9612407751836, 1972.142118178597, 1959.4023822734061, 1981.276833955603, 1982.0981453438724, 1982.9305974290903, 1987.6422243996076, 1915.6360291544631, 1928.113067988727, 1929.604431091623, 1930.94207173785, 1942.660034493965, 1873.4192400355796, 1940.4372731907872, 1958.8628795984287, 1964.0965156028244, 1983.345495986321, 9700.126988571063, 9959.900400996043, 9960.252981026451, 9962.900370996269, 10007.199424046132, 5167.173252279617, 5323.707196104213, 5349.3045904032615, 5364.30264065669, 5377.7580008899695, 3020.4563178627836, 3150.4801707718198, 3204.8878289259997, 3207.7754557181006, 3221.500667396557, 929.8512238041949, 953.3040880157455, 975.9512024398751, 985.6993616946828, 986.6891929042329, 12507.624771256786, 12876.291803950779, 14357.210353430557, 14521.709565808731, 14537.345819438151, 4713.599344055725, 4780.760961951889, 4923.384576927884, 4969.776360063734, 4980.452150263468, 12044.39778011096, 12148.271103733627, 12165.33090680021, 12193.39033048344, 12260.509579616715, 5222.55608273301, 5365.463453654604, 5365.651232669864, 5384.488473595002, 5390.0, 4776.450708168605, 4858.44127925286, 4868.853934381974, 4874.512548745168, 4878.487758785276, 4082.101937573729, 4122.876313710593, 4123.995588466976, 4150.377443383517, 4206.47419072616, 1207.963761087169, 1219.7377563823643, 1237.4678888078033, 1247.1394737631006, 1247.5321754342121, 723.9276072392719, 744.8063503489132, 757.3032809814983, 762.4015148108818, 763.9885401718979, 5397.190421436816, 5544.279243698294, 5626.803061892814, 5687.687177205211, 5689.487946084872, 529.1084522579466, 542.6120323968303, 545.4463719324889, 545.950864422204, 546.1098409592339, 3455.7235421166247, 4116.1767646470225, 4129.545749967501, 4142.502899652061, 4311.1808756336195, 12457.937710311391, 13004.934975325252, 13032.739345213042, 13053.412596433183, 13069.15050521713, 12740.044496662787, 12870.806937895939, 12871.099023068295, 12931.741365172831, 12949.482020719066, 7260.6732697028765, 7396.778096657109, 7401.703931842773, 7481.588512631749, 7495.1005879294835, 5731.226284451545, 6055.697215139314, 6404.4876409886165, 6417.903731444126, 6497.642629655415, 11482.483288252215, 11690.941545292219, 11711.414429278673, 11861.466234019317, 11878.406079696153, 11803.23278986863, 11997.700057498632, 12073.517059317528, 12120.515179393078, 12166.627507635925, 8434.831303374021, 8600.483970961763, 8673.30613550927, 8683.782905427162, 8690.478571285743, 9039.276857851488, 9251.121143491358, 9400.764980875532, 9439.905600943903, 9463.574139163617, 8099.311558517592, 8203.917960820316, 8208.630611622611, 8243.0, 8358.707445239388, 7456.142543607554, 7473.6263186841525, 7634.541927484369, 7638.618069096634, 7760.84478310442, 7319.5242309249725, 7422.035135432359, 7424.406047516078, 7431.071116110486, 7433.331000210007, 4800.159972004955, 4806.927896081492, 4930.6795058321095, 4986.775595098156, 5074.543291103819, 4831.975840120777, 4835.274708793709, 4869.926951095666, 4949.505049495166, 4964.776585053609], "value": 4576.292949812571, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.28050309458894, 346.92887957968617, 353.60926176574867, 363.13573694606833, 368.85983326336, 5421.322334708161, 5549.639273447223, 5551.0, 5613.101903695409, 5658.688772117532, 5319.723266416061, 5410.971915336093, 5412.161115027167, 5416.8104116355935, 5431.131019036955, 4164.208800327943, 4164.916701665965, 4171.124063946575, 4186.267403204442, 4196.475440569929, 4053.6149065838845, 4179.638504245107, 4192.601702838226, 4194.119234960646, 4200.306949353353, 4142.130152667944, 4147.937780933288, 4166.83332666693, 4174.833006679729, 4182.4981002279765, 4107.240160570289, 4144.647704945083, 4148.979255103735, 4155.10665206979, 4159.542450330461, 3650.9634903651154, 3654.3239500692457, 3659.5608526976666, 3660.0483874192637, 3667.504886840269, 5397.028534863723, 5407.783688652449, 5411.21537377082, 5416.322959630046, 5424.159255315432, 4925.408950925912, 4927.6550641455115, 4932.80268789248, 4938.950610493885, 4951.232558953368, 5809.1949772898815, 5832.017114181156, 5837.970810145965, 5841.094630332305, 5861.120831875252, 4100.466939297872, 4102.466679331667, 4109.815058322382, 4112.3420252759715, 4123.092919557693, 5830.708464576796, 6148.784792532285, 6182.69086545671, 6222.377762223741, 6260.968695156541, 4145.8963525912095, 4161.3549899765585, 4206.221848957953, 4208.431861698693, 4212.831486740557, 4219.54425723125, 4231.830726770956, 4235.661147108285, 4245.596668316505, 4251.44731184944, 4845.854624361275, 4852.078105160008, 4855.223164293696, 4861.482217682956, 4866.464688884291, 5762.193292938992, 5763.164341170591, 5768.567357448208, 5789.739461724233, 5829.59192856496, 1441.149721664223, 1465.8167729033871, 1470.5441313192944, 1471.27172049836, 1475.7417451945867, 946.9195118414874, 987.7185002274317, 987.8863930648067, 1001.4592120255127, 1005.2561104782409, 4940.295598018678, 4943.9258411123865, 4955.380577427822, 4987.301777751118, 4992.0, 5918.201042859159, 5932.851678708067, 5963.807238552306, 5965.448983264382, 6029.849253768691, 4962.106820772296, 4968.701877887266, 4972.129877271463, 4980.6341987555625, 4989.351384320015, 3157.715805577509, 3178.631919220196, 3183.920401989969, 3191.441497737933, 3203.599550056243, 5447.754851031713, 5529.972350138304, 5553.583481238923, 5559.082751346064, 5569.721513924287, 6114.633122012605, 6123.540734444934, 6142.754289828446, 6145.508359331243, 6151.3541078186145, 5491.6979566122645, 5538.86152846174, 5549.5837812164245, 5558.527525160407, 5594.524465420403, 6002.399760023963, 6004.519638429003, 6021.0, 6042.335343112342, 6045.460906419226, 5905.940940590539, 5927.407259274038, 5946.672932988554, 5954.434328738763, 5955.880882382241, 5508.697021663847, 5536.114221724505, 5536.861578460571, 5549.972250138723, 5551.139573366135, 3888.1640447303967, 4149.398337241144, 4182.853600124103, 4199.70602057853, 4214.894627634211, 5839.153322768259, 5990.221271234712, 6021.849453763691, 6030.48740857032, 6045.455908968038, 5813.534917206529, 5821.912671310019, 5858.5898987072205, 5875.441833025856, 5875.970620146872, 5835.241418615553, 5840.415958404125, 5851.736671849862, 5858.853528661817, 5880.676562789087, 5475.397706252229, 5696.8006119785605, 5727.5417966561745, 5727.599068065196, 5758.2514273144225, 5853.795117170878, 5868.471837534642, 5868.5305175585, 5879.5002424794375, 5895.263092113486, 5703.657780533182, 5704.317226418134, 5708.229389032427, 5735.483806457439, 5741.5406767459335], "value": 4345.784001371183, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.960677162756, 731.9926800731992, 739.3013602145968, 742.4691345687836, 747.1594456236737, 13577.253251071186, 14474.131552106868, 14494.492692755743, 15411.922940385282, 16831.326746930106, 16343.18284085797, 16548.66902661946, 16553.0, 16553.83446165538, 16576.254068566912, 889.3996552327186, 899.2760827533833, 914.9176574108329, 920.3741455810047, 925.2875286029787, 886.1315910407804, 939.6194541210787, 944.2021491839384, 944.5985456181096, 944.9888619177483, 967.3083745122236, 979.5249304087512, 979.9265055120859, 979.9461029643367, 981.3130808434089, 958.2382006305004, 968.7529679931642, 970.8689326940843, 973.8295798235281, 974.2936371130909, 706.4489698035541, 709.0640354731756, 712.3873468816813, 712.4336152758569, 714.7998560403043, 14063.2968351582, 14271.286435678277, 14303.642408939755, 14317.140971541741, 14334.139951602938, 16035.599110022225, 16998.3200671973, 17014.319427222898, 17020.148992550323, 17058.402955896607, 12379.504819807196, 12592.811107833299, 12649.747005059848, 12726.300053497054, 12726.68183295425, 3057.908262752121, 3102.5966624338694, 3102.9844850775826, 3104.9689503104905, 3108.0675797260733, 79176.0, 79458.60270698667, 80206.0, 80956.59521702412, 81218.78171827487, 12437.875621243853, 12504.3747812609, 12572.4342404592, 12621.558245461365, 12730.80903786444, 23396.298111056694, 24161.15435959768, 24389.0, 24399.0, 24411.389715256904, 5976.940230597638, 6247.156633854463, 6288.874222515524, 6338.873222535523, 6367.108604795332, 2835.688074311824, 2933.1933718227233, 2934.25176579975, 2939.1035734101306, 2944.558316252579, 3578.320119177348, 3667.2848794485353, 3684.5394325709285, 3688.151725103188, 3697.574778900407, 736.576468530597, 745.0612228591905, 750.93617042552, 761.105700801567, 765.3188662090744, 563.5519761789387, 574.8792753521724, 595.1132812109925, 597.3817099302288, 604.7792555717132, 10224.284300098921, 10820.080293175168, 10892.782144357068, 10998.560057597606, 11369.658910232707, 565.9207710920474, 567.5232804444287, 570.922925405065, 576.38326990121, 582.1704071697814, 4678.157931572349, 4736.8578942631775, 4806.519348065165, 4988.0, 5013.0, 88366.0, 88569.0, 89226.0, 90764.09235907557, 91447.54276228577, 74229.0, 74713.25286747172, 75546.24453755502, 75653.62173189208, 77694.0, 67602.0, 68581.65709171521, 68652.656736716, 68656.6567167161, 70514.0, 9159.908400916172, 9908.207343412365, 10008.0, 10018.64934727281, 10071.496425178566, 30212.84893575518, 30425.39149216959, 30625.846870765505, 30974.535381969738, 31325.68674313319, 36913.26173476569, 37301.253974919804, 37496.25007499889, 37840.62159378481, 38272.0, 12707.87292127067, 12964.740705185655, 13137.802932955821, 13196.472141114247, 13265.933670331586, 13665.726685466434, 13879.236641984788, 15350.462733804263, 15747.44883929057, 16031.278592463133, 15266.923665381602, 15672.216389180723, 15722.528324150293, 16028.919855400649, 16080.035197888164, 14389.42442302338, 14800.703985920007, 15042.097474151586, 15200.011999220016, 15385.538433847003, 15346.539603811903, 15626.765598516258, 15876.444324448588, 15904.0, 16185.352585896433, 10784.838227426439, 10924.781504369708, 11008.614698485835, 11206.327620342805, 11388.772224555629, 12279.447424865724, 12626.936865315614, 12664.87335126637, 12779.169353991962, 12884.0], "value": 7289.108416660622, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 112.0, 109.0, 112.0, 110.0, 111.0, 111.0, 110.0, 109.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 123.0, 124.0, 169.0, 122.0, 123.0, 122.0, 124.0, 147.0, 124.0], "value": 133.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 164.0, 166.0, 170.0, 169.0, 176.0, 164.0, 163.0, 164.0], "value": 166.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 109.0, 75.0, 74.0, 73.0, 74.0, 92.0, 76.0], "value": 79.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 113.0, 82.0, 82.0, 82.0, 102.0, 82.0, 84.0, 106.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 115.0, 115.0, 114.0, 115.0, 117.0, 114.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 150.0, 149.0, 149.0, 151.0, 150.0, 152.0, 151.0, 150.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 98.0, 94.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 56.0, 57.0, 58.0, 58.0, 57.0, 60.0, 58.0, 58.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 58.0, 56.0, 56.0, 57.0, 57.0, 56.0, 55.0, 56.0], "value": 56.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 87.0, 88.0, 85.0, 85.0, 87.0, 98.0, 88.0, 123.0, 86.0], "value": 92.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 137.0, 143.0, 132.0, 129.0, 140.0, 143.0, 131.0, 130.0, 140.0], "value": 135.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 195.0, 202.0, 194.0, 185.0, 193.0, 201.0, 186.0, 194.0, 194.0], "value": 192.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 87.0, 76.0, 73.0, 73.0, 72.0, 69.0, 71.0, 70.0], "value": 74.3, "unit": "score"}]}]} 05:45:45 INFO - Return code: 0 05:45:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:45:45 INFO - # TBPL SUCCESS # 05:45:45 INFO - Running post-action listener: _resource_record_post_action 05:45:45 INFO - [mozharness: 2017-06-01 12:45:45.222728Z] Finished run-tests step (success) 05:45:45 INFO - Running post-run listener: _resource_record_post_run 05:45:45 INFO - Total resource usage - Wall time: 1256s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403316736; Read time: 20; Write time: 336792 05:45:45 INFO - TinderboxPrint: CPU usage
12.6% 05:45:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 05:45:45 INFO - TinderboxPrint: I/O write bytes / time
403,316,736 / 336,792 05:45:45 INFO - TinderboxPrint: CPU idle
8,756.2 (87.3%) 05:45:45 INFO - TinderboxPrint: CPU user
1,216.6 (12.1%) 05:45:45 INFO - TinderboxPrint: Swap in / out
0 / 0 05:45:45 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 97927168; Read time: 0; Write time: 118360 05:45:45 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:45:45 INFO - run-tests - Wall time: 1241s; CPU: 13.0%; Read bytes: 4096; Write bytes: 305389568; Read time: 20; Write time: 218432 05:45:45 INFO - Running post-run listener: _upload_blobber_files 05:45:45 INFO - Blob upload gear active. 05:45:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:45: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 05:45: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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:45: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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:45:46 INFO - (blobuploader) - INFO - Open directory for files ... 05:45:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:45:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:45:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:45:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:45:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:45:52 INFO - (blobuploader) - INFO - Done attempting. 05:45:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:45:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:45:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:45:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:45:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:45:53 INFO - (blobuploader) - INFO - Done attempting. 05:45:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:45:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:45:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:45:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:45:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:45:54 INFO - (blobuploader) - INFO - Done attempting. 05:45:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:45:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:45:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:45:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:45:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:45:55 INFO - (blobuploader) - INFO - Done attempting. 05:45:55 INFO - (blobuploader) - INFO - Iteration through files over. 05:45:55 INFO - Return code: 0 05:45:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:45:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:45:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c48d6d300debf5859df64428cd6cc00e9f4db66e1e3ccf9370a7aa3b2cbe5ca18ee059ecad4441fe07168ccacccba68b29136c45cfae2ee365916a696299526", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d5ff83d7eb58a77764448e062be95bca31f96cfe4ec2053ef14582fcc67f2c7b6b26b8782a0c38faf60502da14023da0e6f4042d07142bd7d3282af28b30b102", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/10143c2e4280e7ec4566082d1e064976e73e5bf5ed0d53e7436abef6e497591cb86d98358216955403a2900405e6d882300bf2ab5257281cf81bbd6f38d7c1bd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff72f9500286b6b51c5f1ab21d526dbd1dc9456113cda77352cbb16c017f491c5e7508b8693263d396c5e2a27a35c929f862b718d59d15474d47621c120e1d56"} 05:45:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:45:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:45:55 INFO - Contents: 05:45:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c48d6d300debf5859df64428cd6cc00e9f4db66e1e3ccf9370a7aa3b2cbe5ca18ee059ecad4441fe07168ccacccba68b29136c45cfae2ee365916a696299526", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d5ff83d7eb58a77764448e062be95bca31f96cfe4ec2053ef14582fcc67f2c7b6b26b8782a0c38faf60502da14023da0e6f4042d07142bd7d3282af28b30b102", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/10143c2e4280e7ec4566082d1e064976e73e5bf5ed0d53e7436abef6e497591cb86d98358216955403a2900405e6d882300bf2ab5257281cf81bbd6f38d7c1bd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff72f9500286b6b51c5f1ab21d526dbd1dc9456113cda77352cbb16c017f491c5e7508b8693263d396c5e2a27a35c929f862b718d59d15474d47621c120e1d56"} 05:45:55 INFO - Running post-run listener: copy_logs_to_upload_dir 05:45:55 INFO - Copying logs to upload dir... 05:45:55 INFO - mkdir: /builds/slave/test/build/upload/logs 05:45:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1317.450398 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-06-01 05:45:55.139025) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-01 05:45:55.146302) ========= 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=03627c79f6bb3d1578c4a402000001ba-1496295146.881499-1967056701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c48d6d300debf5859df64428cd6cc00e9f4db66e1e3ccf9370a7aa3b2cbe5ca18ee059ecad4441fe07168ccacccba68b29136c45cfae2ee365916a696299526", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d5ff83d7eb58a77764448e062be95bca31f96cfe4ec2053ef14582fcc67f2c7b6b26b8782a0c38faf60502da14023da0e6f4042d07142bd7d3282af28b30b102", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/10143c2e4280e7ec4566082d1e064976e73e5bf5ed0d53e7436abef6e497591cb86d98358216955403a2900405e6d882300bf2ab5257281cf81bbd6f38d7c1bd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff72f9500286b6b51c5f1ab21d526dbd1dc9456113cda77352cbb16c017f491c5e7508b8693263d396c5e2a27a35c929f862b718d59d15474d47621c120e1d56"} build_url:https://queue.taskcluster.net/v1/task/Ro0Rl2LfRSGgyEBMSucrag/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011347 build_url: 'https://queue.taskcluster.net/v1/task/Ro0Rl2LfRSGgyEBMSucrag/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c48d6d300debf5859df64428cd6cc00e9f4db66e1e3ccf9370a7aa3b2cbe5ca18ee059ecad4441fe07168ccacccba68b29136c45cfae2ee365916a696299526", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d5ff83d7eb58a77764448e062be95bca31f96cfe4ec2053ef14582fcc67f2c7b6b26b8782a0c38faf60502da14023da0e6f4042d07142bd7d3282af28b30b102", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/10143c2e4280e7ec4566082d1e064976e73e5bf5ed0d53e7436abef6e497591cb86d98358216955403a2900405e6d882300bf2ab5257281cf81bbd6f38d7c1bd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff72f9500286b6b51c5f1ab21d526dbd1dc9456113cda77352cbb16c017f491c5e7508b8693263d396c5e2a27a35c929f862b718d59d15474d47621c120e1d56"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-01 05:45:55.173016) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 05:45:55.173297) ========= 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=03627c79f6bb3d1578c4a402000001ba-1496295146.881499-1967056701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 05:45:55.254381) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-01 05:45:55.254673) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-01 05:45:55.257985) ========= ========= Total master_lag: 0.17 =========