builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-082 starttime: 1496793295.67 results: success (0) revision: fd04166b7114949ce63783e10a069b98d76df573 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-06 16:54:55.674459) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-06 16:54:55.674906) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-06 16:54:55.675190) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-06 16:54:55.823553) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 16:54:55.823815) ========= 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=51fc86400edbde9650d2781a000001d0-1496789206.354608-759288938 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-06 16:54:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.8M=0s 2017-06-06 16:54:57 (38.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.220871 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 16:54:56.077356) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 16:54:56.077689) ========= 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=51fc86400edbde9650d2781a000001d0-1496789206.354608-759288938 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018752 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 16:54:56.136395) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 16:54:56.136713) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fd04166b7114949ce63783e10a069b98d76df573 --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 fd04166b7114949ce63783e10a069b98d76df573 --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=51fc86400edbde9650d2781a000001d0-1496789206.354608-759288938 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-06 16:54:57,551 truncating revision to first 12 chars 2017-06-06 16:54:57,551 Setting DEBUG logging. 2017-06-06 16:54:57,552 attempt 1/10 2017-06-06 16:54:57,552 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fd04166b7114?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-06 16:54:57,993 unpacking tar archive at: mozilla-central-fd04166b7114/testing/mozharness/ program finished with exit code 0 elapsedTime=0.789368 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 16:54:56.940129) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-06 16:54:56.940436) ========= script_repo_revision: fd04166b7114949ce63783e10a069b98d76df573 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-06 16:54:56.940798) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-06 16:54:56.941088) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-06 16:54:56.950776) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2017-06-06 16:54:56.951091) ========= /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=51fc86400edbde9650d2781a000001d0-1496789206.354608-759288938 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:54:58 INFO - MultiFileLogger online at 20170606 16:54:58 in /builds/slave/test 16:54: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 16:54:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:54:58 INFO - {'append_to_log': False, 16:54:58 INFO - 'base_work_dir': '/builds/slave/test', 16:54:58 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:54:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:54:58 INFO - 'branch': 'Firefox-Non-PGO', 16:54:58 INFO - 'buildbot_json_path': 'buildprops.json', 16:54:58 INFO - 'config_files': ('talos/linux_config.py',), 16:54:58 INFO - 'default_actions': ('clobber', 16:54:58 INFO - 'read-buildbot-config', 16:54:58 INFO - 'download-and-extract', 16:54:58 INFO - 'populate-webroot', 16:54:58 INFO - 'create-virtualenv', 16:54:58 INFO - 'install', 16:54:58 INFO - 'setup-mitmproxy', 16:54:58 INFO - 'run-tests'), 16:54:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:54:58 INFO - 'download_minidump_stackwalk': True, 16:54:58 INFO - 'download_symbols': 'ondemand', 16:54:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:54:58 INFO - 'tooltool.py': '/tools/tooltool.py', 16:54:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:54:58 INFO - '/tools/misc-python/virtualenv.py')}, 16:54:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:54:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:54:58 INFO - 'gecko_profile': False, 16:54:58 INFO - 'gecko_profile_interval': 0, 16:54:58 INFO - 'installer_path': 'installer.exe', 16:54:58 INFO - 'log_level': 'info', 16:54:58 INFO - 'log_name': 'talos', 16:54:58 INFO - 'log_to_console': True, 16:54:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:54:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:54:58 INFO - 'opt_config_files': (), 16:54:58 INFO - 'pip_index': False, 16:54:58 INFO - 'suite': 'dromaeojs-e10s', 16:54:58 INFO - 'system_bits': '32', 16:54:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:54:58 INFO - 'title': 'talos-linux64-ix-082', 16:54:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:54:58 INFO - 'use_talos_json': True, 16:54:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:54:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:54:58 INFO - 'work_dir': 'build'} 16:54:58 INFO - [mozharness: 2017-06-06 23:54:58.467211Z] Running clobber step. 16:54:58 INFO - Running pre-action listener: _resource_record_pre_action 16:54:58 INFO - Running main action method: clobber 16:54:58 INFO - rmtree: /builds/slave/test/build 16:54:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:54:59 INFO - Running post-action listener: _resource_record_post_action 16:54:59 INFO - [mozharness: 2017-06-06 23:54:59.494697Z] Finished clobber step (success) 16:54:59 INFO - [mozharness: 2017-06-06 23:54:59.494797Z] Running read-buildbot-config step. 16:54:59 INFO - Running pre-action listener: _resource_record_pre_action 16:54:59 INFO - Running main action method: read_buildbot_config 16:54:59 INFO - Using buildbot properties: 16:54:59 INFO - { 16:54:59 INFO - "project": "", 16:54:59 INFO - "product": "firefox", 16:54:59 INFO - "who": "kwierso@gmail.com", 16:54:59 INFO - "installer_path": "public/build/target.tar.bz2", 16:54:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:54:59 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:54:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:54:59 INFO - "stage_platform": "linux64", 16:54:59 INFO - "basedir": "/builds/slave/test", 16:54:59 INFO - "buildnumber": 659, 16:54:59 INFO - "platform": "ubuntu64_hw", 16:54:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:54:59 INFO - "slavebuilddir": "test", 16:54:59 INFO - "taskId": "Zm6eKrtERaG5bNp6sr5m0Q", 16:54:59 INFO - "branch": "mozilla-central", 16:54:59 INFO - "script_repo_revision": "production", 16:54:59 INFO - "revision": "fd04166b7114949ce63783e10a069b98d76df573", 16:54:59 INFO - "slavename": "talos-linux64-ix-082", 16:54:59 INFO - "repo_path": "mozilla-central" 16:54:59 INFO - } 16:54:59 INFO - Finding installer, test and symbols from parent task. 16:54:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zm6eKrtERaG5bNp6sr5m0Q'}, attempt #1 16:54:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zm6eKrtERaG5bNp6sr5m0Q'}, attempt #1 16:55:00 INFO - Task dependencies: S83tIixKTre_UE7QzKwK7w 16:55:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S83tIixKTre_UE7QzKwK7w'}, attempt #1 16:55:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/S83tIixKTre_UE7QzKwK7w/artifacts/public/build/target.tar.bz2 16:55:00 INFO - Set test_url: https://queue.taskcluster.net/v1/task/S83tIixKTre_UE7QzKwK7w/artifacts/public/build/test_packages.json 16:55:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/S83tIixKTre_UE7QzKwK7w/artifacts/public/build/target.crashreporter-symbols.zip 16:55:00 INFO - Running post-action listener: _resource_record_post_action 16:55:00 INFO - [mozharness: 2017-06-06 23:55:00.858340Z] Finished read-buildbot-config step (success) 16:55:00 INFO - [mozharness: 2017-06-06 23:55:00.858560Z] Running download-and-extract step. 16:55:00 INFO - Running pre-action listener: _resource_record_pre_action 16:55:00 INFO - Running main action method: download_and_extract 16:55:00 INFO - mkdir: /builds/slave/test/build/tests 16:55: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')]} 16:55:00 INFO - trying https://queue.taskcluster.net/v1/task/S83tIixKTre_UE7QzKwK7w/artifacts/public/build/target.test_packages.json 16:55:00 INFO - Downloading https://queue.taskcluster.net/v1/task/S83tIixKTre_UE7QzKwK7w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:55:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S83tIixKTre_UE7QzKwK7w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:55:01 INFO - Downloaded 989 bytes. 16:55:01 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:55:01 INFO - Using the following test package requirements: 16:55:01 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:55:01 INFO - u'common': [u'target.common.tests.zip'], 16:55:01 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:55:01 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:55:01 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:55:01 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:55:01 INFO - u'mozbase': [u'target.common.tests.zip'], 16:55:01 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:55:01 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:55:01 INFO - u'web-platform': [u'target.common.tests.zip', 16:55:01 INFO - u'target.web-platform.tests.tar.gz'], 16:55:01 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:55:01 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:55:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S83tIixKTre_UE7QzKwK7w/artifacts/public/build/target.common.tests.zip 16:55:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S83tIixKTre_UE7QzKwK7w/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:55:01 INFO - Fetch https://queue.taskcluster.net/v1/task/S83tIixKTre_UE7QzKwK7w/artifacts/public/build/target.common.tests.zip into memory 16:55:06 INFO - Content-Length response header: 65103834 16:55:06 INFO - Bytes received: 65103834 16:55:17 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:55:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S83tIixKTre_UE7QzKwK7w/artifacts/public/build/target.common.tests.zip 16:55:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S83tIixKTre_UE7QzKwK7w/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:55:17 INFO - Fetch https://queue.taskcluster.net/v1/task/S83tIixKTre_UE7QzKwK7w/artifacts/public/build/target.common.tests.zip into memory 16:55:19 INFO - Content-Length response header: 65103834 16:55:19 INFO - Bytes received: 65103834 16:55:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S83tIixKTre_UE7QzKwK7w/artifacts/public/build/target.talos.tests.zip 16:55:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S83tIixKTre_UE7QzKwK7w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:55:31 INFO - Fetch https://queue.taskcluster.net/v1/task/S83tIixKTre_UE7QzKwK7w/artifacts/public/build/target.talos.tests.zip into memory 16:55:32 INFO - Content-Length response header: 14447523 16:55:32 INFO - Bytes received: 14447523 16:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:32 INFO - trying https://queue.taskcluster.net/v1/task/S83tIixKTre_UE7QzKwK7w/artifacts/public/build/target.tar.bz2 16:55:32 INFO - Downloading https://queue.taskcluster.net/v1/task/S83tIixKTre_UE7QzKwK7w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:55:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S83tIixKTre_UE7QzKwK7w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:55:36 INFO - Downloaded 58597340 bytes. 16:55:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S83tIixKTre_UE7QzKwK7w/artifacts/public/build/target.tar.bz2 16:55:36 INFO - mkdir: /builds/slave/test/properties 16:55:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:55:36 INFO - Writing to file /builds/slave/test/properties/build_url 16:55:36 INFO - Contents: 16:55:36 INFO - build_url:https://queue.taskcluster.net/v1/task/S83tIixKTre_UE7QzKwK7w/artifacts/public/build/target.tar.bz2 16:55:36 INFO - Running post-action listener: _resource_record_post_action 16:55:36 INFO - Running post-action listener: set_extra_try_arguments 16:55:36 INFO - [mozharness: 2017-06-06 23:55:36.509119Z] Finished download-and-extract step (success) 16:55:36 INFO - [mozharness: 2017-06-06 23:55:36.509347Z] Running populate-webroot step. 16:55:36 INFO - Running pre-action listener: _resource_record_pre_action 16:55:36 INFO - Running main action method: populate_webroot 16:55:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:55:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:55:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:55:36 INFO - '--tppagecycles', 16:55:36 INFO - '7'], 16:55:36 INFO - 'tests': ['tsvgm']}}, 16:55:36 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:55:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:55:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:55:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:55:36 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:55:36 INFO - 'talos_options': ['--disable-e10s'], 16:55:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:55:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:55:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:55:36 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:55:36 INFO - 'talos_options': ['--disable-e10s'], 16:55:36 INFO - 'tests': ['damp', 'tps']}, 16:55:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:55:36 INFO - 'tests': ['damp', 'tps']}, 16:55:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:55:36 INFO - 'tests': ['dromaeo_dom']}, 16:55:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:55:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:55:36 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:55:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:55:36 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:55:36 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:55:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:55:36 INFO - 'tests': ['a11yr', 16:55:36 INFO - 'ts_paint', 16:55:36 INFO - 'tpaint', 16:55:36 INFO - 'sessionrestore', 16:55:36 INFO - 'sessionrestore_no_auto_restore', 16:55:36 INFO - 'tabpaint']}, 16:55:36 INFO - 'other-e10s': {'tests': ['a11yr', 16:55:36 INFO - 'ts_paint', 16:55:36 INFO - 'tpaint', 16:55:36 INFO - 'sessionrestore', 16:55:36 INFO - 'sessionrestore_no_auto_restore', 16:55:36 INFO - 'tabpaint']}, 16:55:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:55:36 INFO - 'ts_paint', 16:55:36 INFO - 'tpaint', 16:55:36 INFO - 'sessionrestore', 16:55:36 INFO - 'sessionrestore_no_auto_restore', 16:55:36 INFO - 'tabpaint']}, 16:55:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:55:36 INFO - 'ts_paint', 16:55:36 INFO - 'tpaint', 16:55:36 INFO - 'sessionrestore', 16:55:36 INFO - 'sessionrestore_no_auto_restore', 16:55:36 INFO - 'tabpaint']}, 16:55:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:55:36 INFO - 'tests': ['a11yr', 16:55:36 INFO - 'ts_paint', 16:55:36 INFO - 'tpaint', 16:55:36 INFO - 'sessionrestore', 16:55:36 INFO - 'sessionrestore_no_auto_restore', 16:55:36 INFO - 'tabpaint']}, 16:55:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:55:36 INFO - 'tests': ['a11yr', 16:55:36 INFO - 'ts_paint', 16:55:36 INFO - 'tpaint', 16:55:36 INFO - 'sessionrestore', 16:55:36 INFO - 'sessionrestore_no_auto_restore', 16:55:36 INFO - 'tabpaint']}, 16:55:36 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 16:55:36 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 16:55:36 INFO - 'bloom_basic_ref']}, 16:55:36 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 16:55:36 INFO - 'talos_options': ['--mitmproxy', 16:55:36 INFO - 'mitmproxy-recording-1.mp', 16:55:36 INFO - '--firstNonBlankPaint'], 16:55:36 INFO - 'tests': ['Quantum_1']}, 16:55:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:55:36 INFO - 'tests': ['tsvgx', 16:55:36 INFO - 'tsvgr_opacity', 16:55:36 INFO - 'tart', 16:55:36 INFO - 'tscrollx', 16:55:36 INFO - 'cart', 16:55:36 INFO - 'tsvg_static']}, 16:55:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:55:36 INFO - 'tsvgr_opacity', 16:55:36 INFO - 'tart', 16:55:36 INFO - 'tscrollx', 16:55:36 INFO - 'cart', 16:55:36 INFO - 'tsvg_static']}, 16:55:36 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:55:36 INFO - 'talos_options': ['--disable-e10s'], 16:55:36 INFO - 'tests': ['tp5o']}, 16:55:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:55:36 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:55:36 INFO - 'talos_options': ['--disable-e10s', 16:55:36 INFO - '--xperf_path', 16:55:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:55:36 INFO - 'tests': ['tp5n']}, 16:55:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:55:36 INFO - 'talos_options': ['--xperf_path', 16:55:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:55:36 INFO - 'tests': ['tp5n']}}, 16:55:36 INFO - 'talos.zip': {'path': '', 16:55:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:55:36 INFO - Running post-action listener: _resource_record_post_action 16:55:36 INFO - [mozharness: 2017-06-06 23:55:36.527117Z] Finished populate-webroot step (success) 16:55:36 INFO - [mozharness: 2017-06-06 23:55:36.527211Z] Running create-virtualenv step. 16:55:36 INFO - Running pre-action listener: _resource_record_pre_action 16:55:36 INFO - Running main action method: create_virtualenv 16:55:36 INFO - Creating virtualenv /builds/slave/test/build/venv 16:55:36 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 16:55:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:55:36 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:55:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:55:36 INFO - Using real prefix '/usr' 16:55:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:55:37 INFO - Installing distribute.............................................................................................................................................................................................done. 16:55:39 INFO - Installing pip.................done. 16:55:39 INFO - Return code: 0 16:55:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:55:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:55:39 INFO - Reading from file tmpfile_stdout 16:55:39 INFO - Output received: 16:55:39 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) 16:55:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:55:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eda140>, '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 0x1edaa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edaed0>, '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': '51fc86400edbde9650d2781a000001d0-1496789206.354608-759288938', '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 16:55:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:55:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:55:39 INFO - Using env: {'DISPLAY': ':0', 16:55:39 INFO - 'HOME': '/home/cltbld', 16:55:39 INFO - 'LANG': 'en_US.UTF-8', 16:55:39 INFO - 'LANGUAGE': 'en_US:en', 16:55:39 INFO - 'LOGNAME': 'cltbld', 16:55:39 INFO - 'MAIL': '/var/mail/cltbld', 16:55:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:39 INFO - 'MOZ_NO_REMOTE': '1', 16:55:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:39 INFO - 'NO_EM_RESTART': '1', 16:55:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:39 INFO - 'PWD': '/builds/slave/test', 16:55:39 INFO - 'SHELL': '/bin/bash', 16:55:39 INFO - 'SHLVL': '1', 16:55:39 INFO - 'TERM': 'linux', 16:55:39 INFO - 'TMOUT': '86400', 16:55:39 INFO - 'USER': 'cltbld', 16:55:39 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496789206.354608-759288938', 16:55:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:39 INFO - '_': '/tools/buildbot/bin/python'} 16:55:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:39 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 16:55:39 INFO - Cleaning up... 16:55:39 INFO - Return code: 0 16:55:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:55:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b5e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eda140>, '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 0x1edaa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edaed0>, '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': '51fc86400edbde9650d2781a000001d0-1496789206.354608-759288938', '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 16:55:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:55:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:55:39 INFO - Using env: {'DISPLAY': ':0', 16:55:39 INFO - 'HOME': '/home/cltbld', 16:55:39 INFO - 'LANG': 'en_US.UTF-8', 16:55:39 INFO - 'LANGUAGE': 'en_US:en', 16:55:39 INFO - 'LOGNAME': 'cltbld', 16:55:39 INFO - 'MAIL': '/var/mail/cltbld', 16:55:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:39 INFO - 'MOZ_NO_REMOTE': '1', 16:55:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:39 INFO - 'NO_EM_RESTART': '1', 16:55:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:39 INFO - 'PWD': '/builds/slave/test', 16:55:39 INFO - 'SHELL': '/bin/bash', 16:55:39 INFO - 'SHLVL': '1', 16:55:39 INFO - 'TERM': 'linux', 16:55:39 INFO - 'TMOUT': '86400', 16:55:39 INFO - 'USER': 'cltbld', 16:55:39 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496789206.354608-759288938', 16:55:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:39 INFO - '_': '/tools/buildbot/bin/python'} 16:55:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:39 INFO - Downloading/unpacking psutil>=3.1.1 16:55: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 16:55: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 16:55: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 16:55: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 16:55:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:55:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:55:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:55:41 INFO - Installing collected packages: psutil 16:55:41 INFO - Running setup.py install for psutil 16:55:41 INFO - building 'psutil._psutil_linux' extension 16:55:41 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 16:55:41 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 16:55:41 INFO - building 'psutil._psutil_posix' extension 16:55:41 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 16:55:41 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 16:55:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:55:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:55:41 INFO - Successfully installed psutil 16:55:41 INFO - Cleaning up... 16:55:41 INFO - Return code: 0 16:55:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:55:41 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')]} 16:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:41 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')]} 16:55:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:41 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 0x1b5e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eda140>, '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 0x1edaa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edaed0>, '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': '51fc86400edbde9650d2781a000001d0-1496789206.354608-759288938', '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 16:55:41 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 16:55:41 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 16:55:41 INFO - Using env: {'DISPLAY': ':0', 16:55:41 INFO - 'HOME': '/home/cltbld', 16:55:41 INFO - 'LANG': 'en_US.UTF-8', 16:55:41 INFO - 'LANGUAGE': 'en_US:en', 16:55:41 INFO - 'LOGNAME': 'cltbld', 16:55:41 INFO - 'MAIL': '/var/mail/cltbld', 16:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:41 INFO - 'MOZ_NO_REMOTE': '1', 16:55:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:41 INFO - 'NO_EM_RESTART': '1', 16:55:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:41 INFO - 'PWD': '/builds/slave/test', 16:55:41 INFO - 'SHELL': '/bin/bash', 16:55:41 INFO - 'SHLVL': '1', 16:55:41 INFO - 'TERM': 'linux', 16:55:41 INFO - 'TMOUT': '86400', 16:55:41 INFO - 'USER': 'cltbld', 16:55:41 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496789206.354608-759288938', 16:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:41 INFO - '_': '/tools/buildbot/bin/python'} 16:55:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:55:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:55:43 INFO - Installing collected packages: mozsystemmonitor 16:55:43 INFO - Running setup.py install for mozsystemmonitor 16:55:43 INFO - Successfully installed mozsystemmonitor 16:55:43 INFO - Cleaning up... 16:55:43 INFO - Return code: 0 16:55:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:55: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')]} 16:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55: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')]} 16:55:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:43 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 0x1b5e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eda140>, '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 0x1edaa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edaed0>, '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': '51fc86400edbde9650d2781a000001d0-1496789206.354608-759288938', '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 16:55:43 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 16:55:43 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 16:55:43 INFO - Using env: {'DISPLAY': ':0', 16:55:43 INFO - 'HOME': '/home/cltbld', 16:55:43 INFO - 'LANG': 'en_US.UTF-8', 16:55:43 INFO - 'LANGUAGE': 'en_US:en', 16:55:43 INFO - 'LOGNAME': 'cltbld', 16:55:43 INFO - 'MAIL': '/var/mail/cltbld', 16:55:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:43 INFO - 'MOZ_NO_REMOTE': '1', 16:55:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:43 INFO - 'NO_EM_RESTART': '1', 16:55:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:43 INFO - 'PWD': '/builds/slave/test', 16:55:43 INFO - 'SHELL': '/bin/bash', 16:55:43 INFO - 'SHLVL': '1', 16:55:43 INFO - 'TERM': 'linux', 16:55:43 INFO - 'TMOUT': '86400', 16:55:43 INFO - 'USER': 'cltbld', 16:55:43 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496789206.354608-759288938', 16:55:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:43 INFO - '_': '/tools/buildbot/bin/python'} 16:55:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:43 INFO - Downloading/unpacking jsonschema==2.5.1 16:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:55:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:55:44 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 16:55:44 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 16:55:44 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 16:55:44 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 16:55:44 INFO - Downloading functools32-3.2.3-2.tar.gz 16:55:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:55:44 INFO - warning: no files found matching '*.txt' 16:55:44 INFO - no previously-included directories found matching 'build' 16:55:44 INFO - no previously-included directories found matching 'dist' 16:55:44 INFO - no previously-included directories found matching '.git*' 16:55:44 INFO - Installing collected packages: jsonschema, functools32 16:55:44 INFO - Running setup.py install for functools32 16:55:44 INFO - warning: no files found matching '*.txt' 16:55:44 INFO - no previously-included directories found matching 'build' 16:55:44 INFO - no previously-included directories found matching 'dist' 16:55:44 INFO - no previously-included directories found matching '.git*' 16:55:44 INFO - Successfully installed jsonschema functools32 16:55:44 INFO - Cleaning up... 16:55:44 INFO - Return code: 0 16:55:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b5e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eda140>, '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 0x1edaa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edaed0>, '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': '51fc86400edbde9650d2781a000001d0-1496789206.354608-759288938', '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 16:55:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:55:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:55:44 INFO - Using env: {'DISPLAY': ':0', 16:55:44 INFO - 'HOME': '/home/cltbld', 16:55:44 INFO - 'LANG': 'en_US.UTF-8', 16:55:44 INFO - 'LANGUAGE': 'en_US:en', 16:55:44 INFO - 'LOGNAME': 'cltbld', 16:55:44 INFO - 'MAIL': '/var/mail/cltbld', 16:55:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:44 INFO - 'MOZ_NO_REMOTE': '1', 16:55:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:44 INFO - 'NO_EM_RESTART': '1', 16:55:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:44 INFO - 'PWD': '/builds/slave/test', 16:55:44 INFO - 'SHELL': '/bin/bash', 16:55:44 INFO - 'SHLVL': '1', 16:55:44 INFO - 'TERM': 'linux', 16:55:44 INFO - 'TMOUT': '86400', 16:55:44 INFO - 'USER': 'cltbld', 16:55:44 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496789206.354608-759288938', 16:55:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:44 INFO - '_': '/tools/buildbot/bin/python'} 16:55:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:55:45 INFO - Cleaning up... 16:55:45 INFO - Return code: 0 16:55:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b5e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eda140>, '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 0x1edaa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edaed0>, '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': '51fc86400edbde9650d2781a000001d0-1496789206.354608-759288938', '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 16:55:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:55:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:55:45 INFO - Using env: {'DISPLAY': ':0', 16:55:45 INFO - 'HOME': '/home/cltbld', 16:55:45 INFO - 'LANG': 'en_US.UTF-8', 16:55:45 INFO - 'LANGUAGE': 'en_US:en', 16:55:45 INFO - 'LOGNAME': 'cltbld', 16:55:45 INFO - 'MAIL': '/var/mail/cltbld', 16:55:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:45 INFO - 'MOZ_NO_REMOTE': '1', 16:55:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:45 INFO - 'NO_EM_RESTART': '1', 16:55:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:45 INFO - 'PWD': '/builds/slave/test', 16:55:45 INFO - 'SHELL': '/bin/bash', 16:55:45 INFO - 'SHLVL': '1', 16:55:45 INFO - 'TERM': 'linux', 16:55:45 INFO - 'TMOUT': '86400', 16:55:45 INFO - 'USER': 'cltbld', 16:55:45 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496789206.354608-759288938', 16:55:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:45 INFO - '_': '/tools/buildbot/bin/python'} 16:55:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:45 INFO - Downloading/unpacking blobuploader==1.2.4 16:55: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 16:55: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 16:55: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 16:55: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 16:55:46 INFO - Downloading blobuploader-1.2.4.tar.gz 16:55:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:55:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:55:46 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 16:55:46 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 16:55:46 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 16:55:46 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 16:55:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:55:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:55:46 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 16:55:46 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 16:55:46 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 16:55:46 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 16:55:46 INFO - Downloading docopt-0.6.1.tar.gz 16:55:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:55:46 INFO - Installing collected packages: blobuploader, requests, docopt 16:55:46 INFO - Running setup.py install for blobuploader 16:55:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:55:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:55:47 INFO - Running setup.py install for requests 16:55:47 INFO - Running setup.py install for docopt 16:55:47 INFO - Successfully installed blobuploader requests docopt 16:55:47 INFO - Cleaning up... 16:55:47 INFO - Return code: 0 16:55:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:47 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 0x1b5e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eda140>, '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 0x1edaa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edaed0>, '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': '51fc86400edbde9650d2781a000001d0-1496789206.354608-759288938', '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 16:55:47 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 16:55:47 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 16:55:47 INFO - Using env: {'DISPLAY': ':0', 16:55:47 INFO - 'HOME': '/home/cltbld', 16:55:47 INFO - 'LANG': 'en_US.UTF-8', 16:55:47 INFO - 'LANGUAGE': 'en_US:en', 16:55:47 INFO - 'LOGNAME': 'cltbld', 16:55:47 INFO - 'MAIL': '/var/mail/cltbld', 16:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:47 INFO - 'MOZ_NO_REMOTE': '1', 16:55:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:47 INFO - 'NO_EM_RESTART': '1', 16:55:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:47 INFO - 'PWD': '/builds/slave/test', 16:55:47 INFO - 'SHELL': '/bin/bash', 16:55:47 INFO - 'SHLVL': '1', 16:55:47 INFO - 'TERM': 'linux', 16:55:47 INFO - 'TMOUT': '86400', 16:55:47 INFO - 'USER': 'cltbld', 16:55:47 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496789206.354608-759288938', 16:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:47 INFO - '_': '/tools/buildbot/bin/python'} 16:55:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:55:47 INFO - Running setup.py (path:/tmp/pip-rgDNZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:55:47 INFO - Running setup.py (path:/tmp/pip-rrtIah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:55:47 INFO - Running setup.py (path:/tmp/pip-Z5dG8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:55:47 INFO - Running setup.py (path:/tmp/pip-qBJEWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:55:48 INFO - Running setup.py (path:/tmp/pip-a6Tde2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:55:48 INFO - Running setup.py (path:/tmp/pip-S_pFcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:55:48 INFO - Running setup.py (path:/tmp/pip-U1UiAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:55:48 INFO - Running setup.py (path:/tmp/pip-d6ZEAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:55:48 INFO - Running setup.py (path:/tmp/pip-BiYCzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:55:48 INFO - Running setup.py (path:/tmp/pip-ZKMHPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:55:48 INFO - Running setup.py (path:/tmp/pip-7EdIGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:55:48 INFO - Running setup.py (path:/tmp/pip-syhTMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:55:48 INFO - Running setup.py (path:/tmp/pip-P7AYdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:55:48 INFO - Running setup.py (path:/tmp/pip-0_VIiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:55:48 INFO - Running setup.py (path:/tmp/pip-GpvSLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:55:48 INFO - Running setup.py (path:/tmp/pip-zMPkBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:55:48 INFO - Running setup.py (path:/tmp/pip-30P0S8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:55:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:55:49 INFO - Running setup.py install for manifestparser 16:55:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:55:49 INFO - Running setup.py install for mozcrash 16:55:49 INFO - Running setup.py install for mozdebug 16:55:49 INFO - Running setup.py install for mozdevice 16:55:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:55:49 INFO - Running setup.py install for mozfile 16:55:49 INFO - Running setup.py install for mozhttpd 16:55:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:55:49 INFO - Running setup.py install for mozinfo 16:55:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:55:49 INFO - Running setup.py install for mozInstall 16:55:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:55:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:55:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:55:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:55:49 INFO - Running setup.py install for mozleak 16:55:49 INFO - Running setup.py install for mozlog 16:55:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:55:50 INFO - Running setup.py install for moznetwork 16:55:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:55:50 INFO - Running setup.py install for mozprocess 16:55:50 INFO - Running setup.py install for mozprofile 16:55:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:55:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:55:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:55:50 INFO - Running setup.py install for mozrunner 16:55:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:55:50 INFO - Running setup.py install for mozscreenshot 16:55:50 INFO - Running setup.py install for moztest 16:55:50 INFO - Running setup.py install for mozversion 16:55:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:55:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:55:50 INFO - Cleaning up... 16:55:50 INFO - Return code: 0 16:55:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:50 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 0x1b5e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eda140>, '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 0x1edaa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edaed0>, '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': '51fc86400edbde9650d2781a000001d0-1496789206.354608-759288938', '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 16:55:50 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 16:55:50 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 16:55:50 INFO - Using env: {'DISPLAY': ':0', 16:55:50 INFO - 'HOME': '/home/cltbld', 16:55:50 INFO - 'LANG': 'en_US.UTF-8', 16:55:50 INFO - 'LANGUAGE': 'en_US:en', 16:55:50 INFO - 'LOGNAME': 'cltbld', 16:55:50 INFO - 'MAIL': '/var/mail/cltbld', 16:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:50 INFO - 'MOZ_NO_REMOTE': '1', 16:55:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:50 INFO - 'NO_EM_RESTART': '1', 16:55:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:50 INFO - 'PWD': '/builds/slave/test', 16:55:50 INFO - 'SHELL': '/bin/bash', 16:55:50 INFO - 'SHLVL': '1', 16:55:50 INFO - 'TERM': 'linux', 16:55:50 INFO - 'TMOUT': '86400', 16:55:50 INFO - 'USER': 'cltbld', 16:55:50 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496789206.354608-759288938', 16:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:50 INFO - '_': '/tools/buildbot/bin/python'} 16:55:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:55:51 INFO - Running setup.py (path:/tmp/pip-QvIouQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:55:51 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)) 16:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:55:51 INFO - Running setup.py (path:/tmp/pip-HgzikX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:55:51 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)) 16:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:55:51 INFO - Running setup.py (path:/tmp/pip-oyD2Sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:55:51 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)) 16:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:55:51 INFO - Running setup.py (path:/tmp/pip-X1hHxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:55:51 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)) 16:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:55:51 INFO - Running setup.py (path:/tmp/pip-i2E6xK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:55:51 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)) 16:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:55:51 INFO - Running setup.py (path:/tmp/pip-FFwkZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:55:51 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)) 16:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:55:51 INFO - Running setup.py (path:/tmp/pip-Usijfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:55:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:55:51 INFO - Running setup.py (path:/tmp/pip-1VnIf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:55:51 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)) 16:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:55:51 INFO - Running setup.py (path:/tmp/pip-tXUsBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:55:51 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)) 16:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:55:51 INFO - Running setup.py (path:/tmp/pip-JpV0Up-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:55:51 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)) 16:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:55:51 INFO - Running setup.py (path:/tmp/pip-l6idFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:55:51 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)) 16:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:55:51 INFO - Running setup.py (path:/tmp/pip-p9LESK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:55:51 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)) 16:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:55:51 INFO - Running setup.py (path:/tmp/pip-r0tkAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:55:51 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)) 16:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:55:51 INFO - Running setup.py (path:/tmp/pip-iUqoI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:55:51 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)) 16:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:55:51 INFO - Running setup.py (path:/tmp/pip-5lqv2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:55:52 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)) 16:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:55:52 INFO - Running setup.py (path:/tmp/pip-y_idQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:55:52 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)) 16:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:55:52 INFO - Running setup.py (path:/tmp/pip-Mkr3nX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:55:52 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)) 16:55:52 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)) 16:55:52 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)) 16:55:52 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)) 16:55:52 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)) 16:55:52 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)) 16:55:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:53 INFO - Downloading blessings-1.6.tar.gz 16:55:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:55:53 INFO - Installing collected packages: blessings 16:55:53 INFO - Running setup.py install for blessings 16:55:53 INFO - Successfully installed blessings 16:55:53 INFO - Cleaning up... 16:55:53 INFO - Return code: 0 16:55:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:55:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:55:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:55:53 INFO - Reading from file tmpfile_stdout 16:55:53 INFO - Current package versions: 16:55:53 INFO - argparse == 1.2.1 16:55:53 INFO - blessings == 1.6 16:55:53 INFO - blobuploader == 1.2.4 16:55:53 INFO - docopt == 0.6.1 16:55:53 INFO - functools32 == 3.2.3-2 16:55:53 INFO - jsonschema == 2.5.1 16:55:53 INFO - manifestparser == 1.1 16:55:53 INFO - mozInstall == 1.12 16:55:53 INFO - mozcrash == 1.0 16:55:53 INFO - mozdebug == 0.1 16:55:53 INFO - mozdevice == 0.51 16:55:53 INFO - mozfile == 1.2 16:55:53 INFO - mozhttpd == 0.7 16:55:53 INFO - mozinfo == 0.10 16:55:53 INFO - mozleak == 0.1 16:55:53 INFO - mozlog == 3.4 16:55:53 INFO - moznetwork == 0.27 16:55:53 INFO - mozprocess == 0.25 16:55:53 INFO - mozprofile == 0.28 16:55:53 INFO - mozrunner == 6.13 16:55:53 INFO - mozscreenshot == 0.1 16:55:53 INFO - mozsystemmonitor == 0.3 16:55:53 INFO - moztest == 0.8 16:55:53 INFO - mozversion == 1.4 16:55:53 INFO - psutil == 3.1.1 16:55:53 INFO - requests == 1.2.3 16:55:53 INFO - wsgiref == 0.1.2 16:55:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:55:53 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')]} 16:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:53 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')]} 16:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:53 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 0x1b5e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eda140>, '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 0x1edaa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edaed0>, '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': '51fc86400edbde9650d2781a000001d0-1496789206.354608-759288938', '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 16:55:53 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 16:55:53 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 16:55:53 INFO - Using env: {'DISPLAY': ':0', 16:55:53 INFO - 'HOME': '/home/cltbld', 16:55:53 INFO - 'LANG': 'en_US.UTF-8', 16:55:53 INFO - 'LANGUAGE': 'en_US:en', 16:55:53 INFO - 'LOGNAME': 'cltbld', 16:55:53 INFO - 'MAIL': '/var/mail/cltbld', 16:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:53 INFO - 'MOZ_NO_REMOTE': '1', 16:55:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:53 INFO - 'NO_EM_RESTART': '1', 16:55:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:53 INFO - 'PWD': '/builds/slave/test', 16:55:53 INFO - 'SHELL': '/bin/bash', 16:55:53 INFO - 'SHLVL': '1', 16:55:53 INFO - 'TERM': 'linux', 16:55:53 INFO - 'TMOUT': '86400', 16:55:53 INFO - 'USER': 'cltbld', 16:55:53 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496789206.354608-759288938', 16:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:53 INFO - '_': '/tools/buildbot/bin/python'} 16:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:53 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)) 16:55:53 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)) 16:55:53 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)) 16:55:53 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)) 16:55:53 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)) 16:55:53 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)) 16:55:53 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)) 16:55:53 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)) 16:55:53 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)) 16:55:53 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:55 INFO - Downloading marionette_driver-1.4.0.tar.gz 16:55:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 16:55:55 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)) 16:55:55 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)) 16:55:55 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)) 16:55:55 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)) 16:55:55 INFO - Installing collected packages: marionette-driver 16:55:55 INFO - Running setup.py install for marionette-driver 16:55:55 INFO - Successfully installed marionette-driver 16:55:55 INFO - Cleaning up... 16:55:55 INFO - Return code: 0 16:55:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:55:55 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')]} 16:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:55 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')]} 16:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:55 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 0x1b5e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eda140>, '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 0x1edaa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edaed0>, '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': '51fc86400edbde9650d2781a000001d0-1496789206.354608-759288938', '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 16:55:55 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 16:55:55 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 16:55:55 INFO - Using env: {'DISPLAY': ':0', 16:55:55 INFO - 'HOME': '/home/cltbld', 16:55:55 INFO - 'LANG': 'en_US.UTF-8', 16:55:55 INFO - 'LANGUAGE': 'en_US:en', 16:55:55 INFO - 'LOGNAME': 'cltbld', 16:55:55 INFO - 'MAIL': '/var/mail/cltbld', 16:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:55 INFO - 'MOZ_NO_REMOTE': '1', 16:55:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:55 INFO - 'NO_EM_RESTART': '1', 16:55:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:55 INFO - 'PWD': '/builds/slave/test', 16:55:55 INFO - 'SHELL': '/bin/bash', 16:55:55 INFO - 'SHLVL': '1', 16:55:55 INFO - 'TERM': 'linux', 16:55:55 INFO - 'TMOUT': '86400', 16:55:55 INFO - 'USER': 'cltbld', 16:55:55 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496789206.354608-759288938', 16:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:55 INFO - '_': '/tools/buildbot/bin/python'} 16:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:55:55 INFO - Cleaning up... 16:55:55 INFO - Return code: 0 16:55:55 INFO - Running post-action listener: _resource_record_post_action 16:55:55 INFO - Running post-action listener: _start_resource_monitoring 16:55:55 INFO - Starting resource monitoring. 16:55:55 INFO - [mozharness: 2017-06-06 23:55:55.545996Z] Finished create-virtualenv step (success) 16:55:55 INFO - [mozharness: 2017-06-06 23:55:55.546503Z] Running install step. 16:55:55 INFO - Running pre-action listener: _resource_record_pre_action 16:55:55 INFO - Running main action method: install 16:55:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:55:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:55:55 INFO - Reading from file tmpfile_stdout 16:55:55 INFO - Detecting whether we're running mozinstall >=1.0... 16:55:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:55:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:55:55 INFO - Reading from file tmpfile_stdout 16:55:55 INFO - Output received: 16:55:55 INFO - Usage: mozinstall [options] installer 16:55:55 INFO - Options: 16:55:55 INFO - -h, --help show this help message and exit 16:55:55 INFO - -d DEST, --destination=DEST 16:55:55 INFO - Directory to install application into. [default: 16:55:55 INFO - "/builds/slave/test"] 16:55:55 INFO - --app=APP Application being installed. [default: firefox] 16:55:55 INFO - mkdir: /builds/slave/test/build/application 16:55:55 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'] 16:55:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:56:12 INFO - Reading from file tmpfile_stdout 16:56:12 INFO - Output received: 16:56:12 INFO - /builds/slave/test/build/application/firefox/firefox 16:56:12 INFO - Running post-action listener: _resource_record_post_action 16:56:12 INFO - [mozharness: 2017-06-06 23:56:12.778480Z] Finished install step (success) 16:56:12 INFO - [mozharness: 2017-06-06 23:56:12.778732Z] Running setup-mitmproxy step. 16:56:12 INFO - Running pre-action listener: _resource_record_pre_action 16:56:12 INFO - Running main action method: setup_mitmproxy 16:56:12 INFO - Skipping: mitmproxy is not required 16:56:12 INFO - Running post-action listener: _resource_record_post_action 16:56:12 INFO - [mozharness: 2017-06-06 23:56:12.779897Z] Finished setup-mitmproxy step (success) 16:56:12 INFO - [mozharness: 2017-06-06 23:56:12.780117Z] Running run-tests step. 16:56:12 INFO - Running pre-action listener: _resource_record_pre_action 16:56:12 INFO - Running main action method: run_tests 16:56:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:56:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:56:12 INFO - Python 2.7.3 16:56:12 INFO - Return code: 0 16:56:12 INFO - grabbing minidump binary from tooltool 16:56:12 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')]} 16:56:12 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 0x1eda140>, '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 0x1edaa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edaed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:56:12 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 16:56:12 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 16:56:12 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 16:56:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:56:12 INFO - Return code: 0 16:56:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:56:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:56:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:56:12 INFO - ENV: RUST_BACKTRACE is now 1 16:56:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:56:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:56:12 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/S83tIixKTre_UE7QzKwK7w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--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 16:56:12 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/S83tIixKTre_UE7QzKwK7w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-082 --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 16:56:12 INFO - Using env: {'DISPLAY': ':0', 16:56:12 INFO - 'HOME': '/home/cltbld', 16:56:12 INFO - 'LANG': 'en_US.UTF-8', 16:56:12 INFO - 'LANGUAGE': 'en_US:en', 16:56:12 INFO - 'LOGNAME': 'cltbld', 16:56:12 INFO - 'MAIL': '/var/mail/cltbld', 16:56:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:56:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:56:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:12 INFO - 'MOZ_NO_REMOTE': '1', 16:56:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:56:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:12 INFO - 'NO_EM_RESTART': '1', 16:56:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:12 INFO - 'PWD': '/builds/slave/test', 16:56:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:56:12 INFO - 'RUST_BACKTRACE': '1', 16:56:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:56:12 INFO - 'SHELL': '/bin/bash', 16:56:12 INFO - 'SHLVL': '1', 16:56:12 INFO - 'TERM': 'linux', 16:56:12 INFO - 'TMOUT': '86400', 16:56:12 INFO - 'USER': 'cltbld', 16:56:12 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496789206.354608-759288938', 16:56:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:12 INFO - '_': '/tools/buildbot/bin/python'} 16:56:12 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/S83tIixKTre_UE7QzKwK7w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--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 16:56:13 INFO - mozversion application_buildid: 20170606231826 16:56:13 INFO - mozversion application_changeset: fd04166b7114949ce63783e10a069b98d76df573 16:56:13 INFO - mozversion application_display_name: Nightly 16:56:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:56:13 INFO - mozversion application_name: Firefox 16:56:13 INFO - mozversion application_remotingname: firefox 16:56:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:56:13 INFO - mozversion application_vendor: Mozilla 16:56:13 INFO - mozversion application_version: 55.0a1 16:56:13 INFO - mozversion platform_buildid: 20170606231826 16:56:13 INFO - mozversion platform_changeset: fd04166b7114949ce63783e10a069b98d76df573 16:56:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:56:13 INFO - mozversion platform_version: 55.0a1 16:56:13 INFO - using testdate: 1496793373 16:56:13 INFO - actual date: 1496793373 16:56:13 INFO - starting webserver on 'localhost:49934' 16:56:13 INFO - SUITE-START | Running 2 tests 16:56:13 INFO - TEST-START | dromaeo_css 16:56:13 INFO - operating with platform_type : linux_ 16:56:13 INFO - Initialising browser for dromaeo_css test... 16:56:13 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49934/getInfo.html -profile /tmp/tmp8T1QWh/profile 16:56:13 INFO - TEST-INFO | started process 15782 (/builds/slave/test/build/application/firefox/firefox http://localhost:49934/getInfo.html) 16:56:47 INFO - TEST-INFO | 15782: killed by SIGTERM 16:56:48 INFO - Browser initialized. 16:56:48 INFO - Running cycle 1/1 for dromaeo_css test... 16:56:48 INFO - TEST-INFO | started process 15987 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8T1QWh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:56:59 INFO - PID 15987 | RSS: Main: 187330560 16:56:59 INFO - PID 15987 | 17:00:00 INFO - PID 15987 | Cycle 1(1): loaded http://localhost:49934/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49934/tests/dromaeo/cssquery-ext.html) 17:00:02 INFO - PID 15987 | RSS: Main: 184135680 17:00:02 INFO - PID 15987 | 17:03:04 INFO - PID 15987 | Cycle 1(1): loaded http://localhost:49934/tests/dromaeo/cssquery-ext.html (next: http://localhost:49934/tests/dromaeo/cssquery-jquery.html) 17:03:04 INFO - PID 15987 | RSS: Main: 187883520 17:03:04 INFO - PID 15987 | 17:06:06 INFO - PID 15987 | Cycle 1(1): loaded http://localhost:49934/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49934/tests/dromaeo/cssquery-mootools.html) 17:06:07 INFO - PID 15987 | RSS: Main: 186535936 17:06:07 INFO - PID 15987 | 17:09:08 INFO - PID 15987 | Cycle 1(1): loaded http://localhost:49934/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49934/tests/dromaeo/cssquery-prototype.html) 17:09:09 INFO - PID 15987 | RSS: Main: 189415424 17:09:09 INFO - PID 15987 | 17:12:12 INFO - PID 15987 | Cycle 1(1): loaded http://localhost:49934/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49934/tests/dromaeo/cssquery-yui.html) 17:12:12 INFO - PID 15987 | RSS: Main: 187834368 17:12:12 INFO - PID 15987 | 17:15:14 INFO - PID 15987 | Cycle 1(1): loaded http://localhost:49934/tests/dromaeo/cssquery-yui.html (next: http://localhost:49934/tests/dromaeo/cssquery-dojo.html) 17:15:14 INFO - PID 15987 | RSS: Main: 187301888 17:15:14 INFO - PID 15987 | 17:15:14 INFO - PID 15987 | __start_tp_report 17:15:14 INFO - PID 15987 | _x_x_mozilla_page_load 17:15:14 INFO - PID 15987 | _x_x_mozilla_page_load_details 17:15:14 INFO - PID 15987 | |i|pagename|runs| 17:15:14 INFO - PID 15987 | |0;dojo.html;3015.8190508569487;3041.0268714011527;3046.7257946784785;3065.5861458703084;3067.6472205696336;5742.138679198122;5749.137629355589;5758.049921762915;5763.366029736726;5786.450287222712;5806.332271788746;5813.651180929137;5853.268341457318;5882.4705776480105;5950.404959504048;5314.282571852789;5402.297701298836;5427.891442171154;5436.238926550266;5438.8912221755545;5520.420355862617;5522.779088836442;5540.889182216353;5548.500634942854;5556.972215138919;5332.493413125747;5355.651882627656;5404.1083221268445;5437.8368648940595;5505.944940550583;5430.728463576806;5441.619086663935;5449.3188351456065;5471.616986810925;5481.780728770845;5354.839354819323;5373.81191658294;5374.516293533601;5377.7580008899695;5385.569154467633;5721.455207094103;5838.2118414013985;5842.824715258549;5857.794977175821;5922.3485416604135;6093.413838573129;6198.6280823150755;6234.438900498932;6264.1543391642;6304.211973503312;6305.8108256752375;6306.87386252277;6313.810585682391;6336.334684858116;6340.080688300217;5813.79651712188;5859.6777177255235;5865.35481097079;5876.294844618587;5888.5289176865745;6201.96899015502;6272.1219029335925;6304.968475157595;6311.526635502356;6347.52393570484;6044;6102.542309326729;6124.938750612437;6155.384461553809;6183.288921773964;6187.226596675416;6262.279837818618;6263.404976527223;6278.46633036197;6289.433950944437;6253.749850005949;6258.718357673915;6276.780312689034;6277.7175027123885;6298.590591611531;6105.4294214941465;6192.907106393408;6208.255009398811;6289.559730818799;6311.779087731908;5132.409772876167;5134.563562097189;5145.562627176657;5153.7165455900285;5175.4824517548695;4397.098594788061;4406.779661016936;4415.712978656377;4432.955670443319;4495.2582823834355;5360.785568577291;5519.2824932758485;5525.254090697785;5530.253415788817;5551.8889622208135;6156.507479401637;6174.073888916609;6207.503399728011;6270.216222972129;6285.182926219653;5477.534409575151;5479.808206712746;5486.149646804752;5490.56075513958;5516.862078448071;5484.067708489566;5525.254090697705;5572;5572.3870374258795;5591.496765291062;5988.251468566429;6028.276606807036;6066.332703402534;6091.208142941567;6093.512518998469;6314.684265786784;6322.715477803602;6331.5251356147555;6332.746690132343;6341.49268058545;6066.423689749467;6135.355787642234;6136;6139.416755408229;6150.938490615036;6081.84444955457;6165.84585385369;6170.413810687977;6211.782587609412;6229.501639868709;6217.098520714561;6219.751209951552;6278.686065696788;6291.591046582141;6311.842203944754;5952.5833191676165;6093.329733729375;6098.420650038417;6113.205283313141;6121.724522396414;6032.336442991355;6043.033114701627;6066.939330606638;6118.418750218722;6127.922628246779;5990.371011043778;6000.789972350947;6012.188354572252;6038.818835434944;6074.088886666858;6060.606060606046;6089.573729839046;6097.512199023979;6103.216452666749;6133.325334213144;5999.760009599741;6006.819795406145;6012.939870601238;6023.186869772525;6063.939360606338 17:15:14 INFO - PID 15987 | |1;ext.html;662.4236913884921;705.0904333409901;736.2012216744831;1227.6808029912227;1273.4651446392513;37728.62271377286;38786.418203726935;38877.80561097194;38906;38940.61059389405;37533.436998445046;37869.13028480583;37926.810365948135;37955.62044379555;37956.62043379565;6793.184817821856;7139.1433028036445;7269.200387957347;7289.161746399179;7300.525465844729;7294.234105418907;7381.077365329334;7394;7394.075740532434;7400.074990626172;7359.77920662381;7385.4830161888685;7412.851742965137;7436.925630743677;7444.8883266751045;7347.412207023425;7367;7416.7404140854815;7421.777346679582;7443.85112297751;7174.067371241757;7221.53060051095;7255.854882902365;7291.161516425573;7317.670704818296;35522.28955420903;35673.286534269166;35913.281734365424;35967.46048809244;35978.28043439116;3484.181217413906;3499.7550171488006;3518.47222916562;3524.0837382280533;3534.8586056557965;27782.3054423639;27976.580351294746;28070.859645701847;28074.157775266776;28161.43677126446;3484.9651503485147;3489.2672538766888;3525.7179425645886;3552.1652411683235;3555.235624340779;164269;165286.77705783508;165378;172059;176621.116894416;42564.78717606454;42693.57306426896;42763.35854962178;42890.78554607207;42930.14139717188;45193.32210016852;45483.35816194912;45502.31746523805;50680.746596266785;51378;14789;14930.40278388874;14938.850611493746;14953.476628317956;14965.326560304813;12210.816837747441;12281.140320177501;12288.447019884126;12346.382680865921;12366.752664946831;13844.723105537832;13904;13907.930460347836;14018.369173387018;14268.785968210484;5738.8278351649515;5748.856278593069;5760.769569217268;5813.302403711497;5839.708014599253;965.3483898368573;980.6910823090703;981.8723565936383;988.1403179234112;988.8467287570438;21647.89176054141;22277.44306392321;23591.11271098308;24479.510409791703;24584.262472125865;1063.9308444951052;1064.4571268653042;1084.8752393474695;1095.3427943234155;1124.2074337591978;11917.76164476723;11972.64082077539;12050.51797928073;12101;13031.543895963596;210519;214143;214559;215497;215500;48218.75890620524;48247.27629085567;48264;48401.51598484041;48949.265761013616;1362.5707902011034;1434.347371945783;1445.2412483446276;1445.898787084915;1456.0535651826397;20785.1685932561;22099.226527071474;23260.76739232586;23735.52528949377;24092.51814963726;34920.30159396747;45059.32411013903;46056.53943460523;46084;46143.76928115338;191532;192824;192949;193041;194096;32662.83668581642;33239.16902077467;33285.33429331448;33506;34505.79229726947;41043.384349235384;41295.7935210322;41509.79245103755;41694.79152604217;42629.36055959225;28227.15318540447;29521.85239073791;30193.69806301909;31181.376372472878;32193.839030804695;29086.56370154407;30185.69814301829;30275.848620756755;30929.381412371178;31845.840770795996;33663.495047573815;34606.30787384188;34688.306233874675;34731.13172170716;36000;28660.85669571639;29873;30304;30538.847305763327;31902.52146217762;21910.780892190873;24549.38626534351;24862.37844053913;24878.37804054913;24978 17:15:14 INFO - PID 15987 | |2;jquery.html;409.48813982521864;419.6474961032733;420.8358740091363;430.24921511961634;441.47244043368175;14424.855751442483;15095.320710568023;20056.29802956895;20817.06323215457;20857.895710521447;21594.676079858815;22377.10491580339;22405.66391504129;22413.43966400841;22446.102155913744;5776.104703770922;5941.405859414067;5947.226860508128;5948.286205655328;5952.613080149798;5763.3948435414095;5858.41415858415;5859.912101318484;5865.296164460271;5867.735951882154;5792;5819.214406055171;5819.82540523785;6155.846103847417;6474.352564743535;6500.4799616030605;6563.737450501974;6565.93434065658;6576.112224849632;6580.407763301278;6401.039844023434;6407.423331900105;6437.324080971524;6457.031445283245;6463;26891.193264202106;27700.584491232647;28029.439411211864;28071;28156.296092597644;1936.7094935759749;1985.2852972929734;1989.7612286525564;1991.6514609943201;1998.9505509607427;17887.642247155116;18475.983820889847;18480.53798655031;18501.629967400575;18505.537361565934;2291.690621766057;2363.8818059096975;2377.1679912030822;2391.8804059797117;2455;106495.46752266267;113116;113339.43330283379;113430;113926.43036784846;19345.806541934682;19504.783230204914;20208.19167233294;20661.896690516453;20774.480637984172;37478.25043499115;37558;37753;37767.93569543345;37882.810585947445;10366.118879895294;10545;10690.572377104983;10703.1437485001;10842.566297348176;8318;8780.868286975572;8793.956030219808;8874.689385871463;8879.112088791198;7576.4317676174505;7613.809654758676;7673.11759147694;7680.078390593165;7776.034222546429;2163.8268938484885;2174.8151407130254;2181.9127234910743;2194.4075099722986;2251.178319913253;923.9187310320024;933.9486328251876;960.4477425480377;973.7030205787303;983.4836710726782;17990.65070119746;18558.072096395128;18696.25214991385;18962.14670339838;18994;969.2730452160879;973.0707174648194;976.3848775271533;981.4209616326259;1027.291169093323;10080.596776128872;10183.643572474928;10379.429131397694;10637.68086957377;10933.781324373467;451709;470796;476400;477724;497739;97586.51206743921;101224;101279;101744.49127754314;101789.49105254427;1181.3148373943093;1186.1519013904926;1238.158052524292;1241.2986662535818;1241.85097788266;17410.47768566945;19200.327988520334;19647.11587978573;19861.503462413555;20247.19011239534;46604;47109;47404.76297618628;48399.75800120977;48993.285235018026;59568.851737791745;59697;59861.70069149626;59946.70026649839;60343.69828150831;10227.954409118058;10362.585496580052;10498.475076246004;10514.053735163872;10519.684409467729;16630.417935372203;17325.22036508335;17803.02083385426;17935.551611209303;18086.90956545209;13752.449902003807;14489.49286775;15181.772273416129;15326.923365383102;15502.302396391964;13065.608031759062;13199.67000824987;13355.732885342044;13411.32943352809;13584.32078396096;14460.783088253895;14912.94398567298;15002.774958375852;15041.323140458924;15062.548123556311;15683.764743528627;16198.757018644965;16250.187490625658;16345.591360216089;16458.75311870299;14320.355583998537;14338;14371.20958347301;14438.133711977314;14451.566453006426 17:15:14 INFO - PID 15987 | |3;mootools.html;1258.3519487463955;1311.90816642835;1315.4277889118227;1321.8803623448653;1333.5199328241833;10672.35965842049;10887.891121088787;11180.888191118087;11227.101831853453;11272.436378181079;10884.23810333275;11004.889951100487;11006.119510439166;11085.889141108586;11092.500837462314;2289.1301305503926;2339.30990357844;2339.883005849709;2343.156463673085;2350.71791385034;2233.70961774969;2313.9421514462106;2318.5247024359965;2320.8491448055906;2323.6166032604683;2263.8302127340435;2263.909443622253;2302.6200676888293;2316.8030717389042;2316.8494047886834;2280.9657855132186;2293.2203050962585;2299.310206937912;2318.4088057545387;2328.2549584133;2245.65192395179;2246.887655617229;2246.977625180539;2247.3932038349717;2248.6964259824877;10694.679159625224;10969.616063437821;10978.670639880816;10978.725531861768;10981.505832237568;5843.883122337572;6004.6997650117755;6014.428629280212;6053.848653783647;6067.089936509515;3399.7280217582534;3524.488949102366;3580.4092324766384;3589.569251689814;3615.8011309377976;1274.0953922714884;1276.9680757981032;1289.7098152915612;1300.9089363744542;1313.507434711983;15210.46763363277;15542.9222853885;15701.214939253106;15748.212589370485;15786.210689465595;4864.100141473838;4912.140375434356;4992.950070499322;5013.5989120870245;5031.77357018935;11752.94123529394;11844.881551184379;11866.762664746657;11909.047276217882;11950.820737688942;5769.74036168365;5820.88358232833;5868.413158684183;5877.089051197071;5958.582899197015;5476.288082549323;5500.669959802424;5553.861153471195;5601.131824567198;5631.465010823965;3891.1828516011387;3950.249452603996;4005.178938317638;4027.335489644176;4070.3487442009728;1195.4022988505747;1205.9095567832271;1206.258151236983;1225.185251807556;1225.8835410635975;798.3413683710962;827.4580150001758;838.6980686952692;848.4739461533889;869.3045563549135;5678.17530178039;5727.713614319267;5828.242328497268;5903.557233207526;5928.081147422156;607.0439058482907;610.7404353149893;615.559874689599;627.802242293676;628.2335550628226;3542.220711443478;4053.7162398632404;4090.2637525245145;4243.321068629066;4303.849365272201;12226.633201003984;12816.679583010313;12826.102172847812;12849.871501285055;12871.871281287067;12584.37078146089;12723.109382343147;12733.554325598745;12740.235585864877;12784.6803829905;7549.9245007549225;8249.422540422232;8638.654453821902;8643.740687779376;8648.1784230498;5830.9416905832095;6358.841028974312;6439.839004024937;6888.827779305558;6939.826504337432;12039.75920481603;12328;12387;12442.875571244173;12845.807312890502;12520.686982825138;12583.496660133858;12594.559190428292;12730.745385092432;12818.294993775058;9162.908370916206;9222.123898229658;9299.72100836976;9304.395214311047;9347.439153650803;9651.372660777308;9788.608455661693;9794.951025244829;9826;9830.655927042519;8785.51679657625;8842.557872106498;8886.422382545114;8918.375713700238;9189.954050229706;8376;8408.159184081544;8447.45091569046;8612.440191387539;8681.826363472821;6834.111565496453;6965.616891071039;6975.267596902252;6987.266337034538;6995.300469952964;5585.068198133525;5807.8548036299435;5817.360090390139;5916.763329466773;5974;5824.63121166534;5887.116932460165;5966;6178.814635560941;6291.748330066746 17:15:14 INFO - PID 15987 | |4;prototype.html;386.2198359314185;395.4246571238847;401.8633664554051;406.0255387071029;407.7227485309988;6202.627842329463;6232.127502149703;6275.874482510347;6291.779787707431;6347.650879201642;6043.277665865229;6117.816465506042;6164.684720695509;6164.722587483563;6168.105624684418;4702.365180700613;4809.855704328876;4819.710817350952;4847.175980083394;4850.199717046683;4829.855104346875;4842.00738848537;4850.126977144113;4850.151223535885;4852.636052296074;4769.356136921506;4769.475357710649;4802.087603355369;4804.399450068741;4812.32627432158;4806.3030860525205;4813.122882075993;4826.7827947742435;4838.403326902114;4842.685225460369;4216.156768646252;4216.936745948813;4219.11398606293;4220.3036498977635;4221.810018549173;6146.692665366714;6152.507799376039;6156.938430615682;6160.507159427235;6179.19670442844;5503.724813759296;5516.310461192351;5523.1163013917985;5526.723663816833;5530.092118219248;6521.217453905514;6562.67186640666;6566.113574667406;6573.342665733437;6574.520732835122;4585.931211031837;4589.105124500724;4590.449146102455;4594.65540084495;4608.239640459354;6553.2136143663065;6865.794026179223;6893.20728116268;6938.618375989318;6955.89566156508;4502.347159661831;4570.337301091389;4580.083983203373;4583.656225783079;4596.149712303235;4618.330342100377;4624.884377890579;4626.884327891829;4631.004334068191;4646.117237724821;5322.520973112439;5417.10617748075;5434.91847622286;5474.644148130438;5483.917741233885;6559.8032059038305;6590.736370545221;6609.702563384659;6615;6639.767608133692;1625.2117722904381;1643.8027436707432;1644.7121753693295;1648.4230519318144;1652.7851379320853;1072.1851392941421;1092.956281748737;1105.3257512917114;1109.5617231193633;1114.3481063577735;5853.180554722342;5859.150423188699;5871.148683440877;5884.6469211847425;5890.882182356415;6786.642671465726;6817.284185160487;6838.7264509420065;6864.897026544606;6879.449644028466;5798.797042103506;5830.280067380133;5850.561207909339;5852.268466441695;5863.179154918314;3585.0141211166615;3609.7653652513027;3610.422332426799;3632.4369722693023;3655.597884232732;6529.575577587537;6568.934310656928;6571.934280657228;6579.276279609239;6600.768973085919;6913.308669133147;6915.861682766316;6952.756653517103;6960.269171736996;6990.720371185197;6544.574602650812;6622.1722284714415;6622.933770662232;6649.833754156185;6664.566803157779;6755.594664320157;6783.4573234142135;6799.184097908283;6806.18325800907;6827.487938404739;6669.566478178903;6674.833129171615;6696.292445426385;6750.594964302158;6758.189017317954;6185.41238582334;6576.934230657632;6579.342065793382;6584.8024559263295;6618.900716489353;4524.9547504524535;4526;4539.954600453953;4546.272596384695;4559.202139625486;6658.766943156967;6829.4877884157895;6846;6853.4859885507785;6862.451003919575;6630.005499175162;6635.236947750877;6650.534462587766;6653.669266146693;6655.667216639052;6615.974523948796;6621.801345959629;6629.204495460575;6634.649502001458;6637.203535575762;6453.677316134268;6531;6539.444147247537;6564.409203171737;6582.934170658232;6626.376537748282;6644.10304608891;6671.733130674718;6674.365935236145;6717.227518835396;6425.9036114457385;6460.4508616766225;6465.030245463218;6477.546571739933;6482.319356467503 17:15:14 INFO - PID 15987 | |5;yui.html;817.8609636361817;838.9412741108121;841.3143288220101;851.8679604661276;854.8204876975835;16966.23651935663;17798.91100544497;17838.732419013708;19484.610307793835;20893.791062089374;18943.147558359873;19037.61924761504;19092.71360929587;19207.61584768304;19248.326308579166;928.0811996123839;960.8030353777493;965.9565319560602;967.4340510801154;970.7864269860619;962.821877952581;971.130837900079;974.6929717139114;982.346739418286;986.7779749556364;1026.712520494263;1030.0729343590754;1030.8608337874402;1032.6747074671455;1034.0900007992993;1019.093007223568;1030.8969103089669;1031.3760175094035;1033.7880734449495;1034.886162522122;753.3521171792254;757.3524636435878;759.4835511851938;760.627292626609;762.0740799928059;17210.655786884192;17773.555661108447;17864.821351786577;17901;18102.637947241114;18293.54266143344;18635.627287454176;18668.533286667807;18783.154758035922;18810.153543090593;14794.260286985715;15035.097894126278;15039.248037598076;15044.323005464781;15048.774268385983;3413.2490852012515;3438.6045604755523;3442.9311413771834;3578.5526809148855;3590.263995880838;83559;83892.58053709753;84366.57816710939;84969;85299;13984.160950343012;14778.852211477748;15158.166300853338;15297.770533442008;15326.386944522093;26405.47189056208;26921.92312307486;27631.861840690668;28212.43575128527;28379.57430638542;7712.575808330484;8092.069412017576;8113.675452981933;8122.309603683635;8250.298724608476;3807.428885667117;3870.632289932452;3877.922441551153;3892.2020985697864;3894.532656081232;3721.776693398405;3793.487879136281;3794.8102594870697;3809.923801523954;4218.535961044283;800.3477166109602;815.9265666090081;819.7458787775809;820;820.2986446588081;639.763287583597;655.9606423614598;660.8612191439755;661.1075048684334;667.4193451697055;10867.935092332431;12010.819837702267;12652.367381630882;12941.935290323489;12971.156874803108;686.4748467422426;704.7075463682514;707.8088915992653;715.1025463043846;715.7924201981472;5164.25118357836;5231.555317797954;5368.087425137736;5394.622376433612;5398.24424580559;90032.5498372504;92762.53618731863;93996;95257.52371238238;98284.69725981604;83355.58322208471;84504.57747711222;85313;85538.57230713931;85844;66738.66630666815;69216.38619751824;70535.64732176306;70805.2919470809;70898.30178020569;10709.143268538654;10801.621943231949;11483.25358851672;11636;12191.51233950632;28745;28987;29022;29398.11805645834;29682.10953671393;35974.460383094796;36193.63806361903;36406;37487.501499820195;43252;16242.025478470858;16712.74930876062;17066.232019559397;17191.226394812013;17480.82519174792;15579.221038948233;15599.610009749847;16188.190590470665;16225.51323460298;17397.826021740126;16739.497815065566;16813.327466901188;16848;18082.09589520545;18329.90835045816;17102.40141595088;17424.128793560525;17481.56404565969;17539.649207016042;18002.5499362517;15596.14221217844;16249;16270.755938660694;16332.591685207964;16693.332266709196;11742.823857641972;12359.134860559674;12481.750364992831;12720.554780582635;12745.769490338967;12756;13052.282124483245;13132.212067275994;13932.651683707989;13968.720625587635 17:15:14 INFO - PID 15987 | __end_tp_report 17:15:14 INFO - PID 15987 | __start_cc_report 17:15:14 INFO - PID 15987 | _x_x_mozilla_cycle_collect,367 17:15:14 INFO - PID 15987 | __end_cc_report 17:15:14 INFO - PID 15987 | __startTimestamp1496794514872__endTimestamp 17:15:14 INFO - PID 15987 | 17:15:14 INFO - PID 15987 | ------- Summary: start ------- 17:15:14 INFO - PID 15987 | Number of tests: 6 17:15:14 INFO - PID 15987 | 17:15:14 INFO - PID 15987 | [#0] dojo.html Cycles:165 Average:5782.27 Median:6012.94 stddev:643.54 (10.7%) stddev-sans-first:607.82 17:15:14 INFO - PID 15987 | Values: 3015.8 3041.0 3046.7 3065.6 3067.6 5742.1 5749.1 5758.0 5763.4 5786.5 5806.3 5813.7 5853.3 5882.5 5950.4 5314.3 5402.3 5427.9 5436.2 5438.9 5520.4 5522.8 5540.9 5548.5 5557.0 5332.5 5355.7 5404.1 5437.8 5505.9 5430.7 5441.6 5449.3 5471.6 5481.8 5354.8 5373.8 5374.5 5377.8 5385.6 5721.5 5838.2 5842.8 5857.8 5922.3 6093.4 6198.6 6234.4 6264.2 6304.2 6305.8 6306.9 6313.8 6336.3 6340.1 5813.8 5859.7 5865.4 5876.3 5888.5 6202.0 6272.1 6305.0 6311.5 6347.5 6044.0 6102.5 6124.9 6155.4 6183.3 6187.2 6262.3 6263.4 6278.5 6289.4 6253.7 6258.7 6276.8 6277.7 6298.6 6105.4 6192.9 6208.3 6289.6 6311.8 5132.4 5134.6 5145.6 5153.7 5175.5 4397.1 4406.8 4415.7 4433.0 4495.3 5360.8 5519.3 5525.3 5530.3 5551.9 6156.5 6174.1 6207.5 6270.2 6285.2 5477.5 5479.8 5486.1 5490.6 5516.9 5484.1 5525.3 5572.0 5572.4 5591.5 5988.3 6028.3 6066.3 6091.2 6093.5 6314.7 6322.7 6331.5 6332.7 6341.5 6066.4 6135.4 6136.0 6139.4 6150.9 6081.8 6165.8 6170.4 6211.8 6229.5 6217.1 6219.8 6278.7 6291.6 6311.8 5952.6 6093.3 6098.4 6113.2 6121.7 6032.3 6043.0 6066.9 6118.4 6127.9 5990.4 6000.8 6012.2 6038.8 6074.1 6060.6 6089.6 6097.5 6103.2 6133.3 5999.8 6006.8 6012.9 6023.2 6063.9 17:15:14 INFO - PID 15987 | 17:15:14 INFO - PID 15987 | [#1] ext.html Cycles:180 Average:35467.84 Median:19107.66 stddev:49895.34 (261.1%) stddev-sans-first:49966.86 17:15:14 INFO - PID 15987 | Values: 662.4 705.1 736.2 1227.7 1273.5 37728.6 38786.4 38877.8 38906.0 38940.6 37533.4 37869.1 37926.8 37955.6 37956.6 6793.2 7139.1 7269.2 7289.2 7300.5 7294.2 7381.1 7394.0 7394.1 7400.1 7359.8 7385.5 7412.9 7436.9 7444.9 7347.4 7367.0 7416.7 7421.8 7443.9 7174.1 7221.5 7255.9 7291.2 7317.7 35522.3 35673.3 35913.3 35967.5 35978.3 3484.2 3499.8 3518.5 3524.1 3534.9 27782.3 27976.6 28070.9 28074.2 28161.4 3485.0 3489.3 3525.7 3552.2 3555.2 164269.0 165286.8 165378.0 172059.0 176621.1 42564.8 42693.6 42763.4 42890.8 42930.1 45193.3 45483.4 45502.3 50680.7 51378.0 14789.0 14930.4 14938.9 14953.5 14965.3 12210.8 12281.1 12288.4 12346.4 12366.8 13844.7 13904.0 13907.9 14018.4 14268.8 5738.8 5748.9 5760.8 5813.3 5839.7 965.3 980.7 981.9 988.1 988.8 21647.9 22277.4 23591.1 24479.5 24584.3 1063.9 1064.5 1084.9 1095.3 1124.2 11917.8 11972.6 12050.5 12101.0 13031.5 210519.0 214143.0 214559.0 215497.0 215500.0 48218.8 48247.3 48264.0 48401.5 48949.3 1362.6 1434.3 1445.2 1445.9 1456.1 20785.2 22099.2 23260.8 23735.5 24092.5 34920.3 45059.3 46056.5 46084.0 46143.8 191532.0 192824.0 192949.0 193041.0 194096.0 32662.8 33239.2 33285.3 33506.0 34505.8 41043.4 41295.8 41509.8 41694.8 42629.4 28227.2 29521.9 30193.7 31181.4 32193.8 29086.6 30185.7 30275.8 30929.4 31845.8 33663.5 34606.3 34688.3 34731.1 36000.0 28660.9 29873.0 30304.0 30538.8 31902.5 21910.8 24549.4 24862.4 24878.4 24978.0 17:15:14 INFO - PID 15987 | 17:15:14 INFO - PID 15987 | [#2] jquery.html Cycles:180 Average:32154.52 Median:11879.25 stddev:79037.29 (665.3%) stddev-sans-first:79223.07 17:15:14 INFO - PID 15987 | Values: 409.5 419.6 420.8 430.2 441.5 14424.9 15095.3 20056.3 20817.1 20857.9 21594.7 22377.1 22405.7 22413.4 22446.1 5776.1 5941.4 5947.2 5948.3 5952.6 5763.4 5858.4 5859.9 5865.3 5867.7 5792.0 5819.2 5819.8 6155.8 6474.4 6500.5 6563.7 6565.9 6576.1 6580.4 6401.0 6407.4 6437.3 6457.0 6463.0 26891.2 27700.6 28029.4 28071.0 28156.3 1936.7 1985.3 1989.8 1991.7 1999.0 17887.6 18476.0 18480.5 18501.6 18505.5 2291.7 2363.9 2377.2 2391.9 2455.0 106495.5 113116.0 113339.4 113430.0 113926.4 19345.8 19504.8 20208.2 20661.9 20774.5 37478.3 37558.0 37753.0 37767.9 37882.8 10366.1 10545.0 10690.6 10703.1 10842.6 8318.0 8780.9 8794.0 8874.7 8879.1 7576.4 7613.8 7673.1 7680.1 7776.0 2163.8 2174.8 2181.9 2194.4 2251.2 923.9 933.9 960.4 973.7 983.5 17990.7 18558.1 18696.3 18962.1 18994.0 969.3 973.1 976.4 981.4 1027.3 10080.6 10183.6 10379.4 10637.7 10933.8 451709.0 470796.0 476400.0 477724.0 497739.0 97586.5 101224.0 101279.0 101744.5 101789.5 1181.3 1186.2 1238.2 1241.3 1241.9 17410.5 19200.3 19647.1 19861.5 20247.2 46604.0 47109.0 47404.8 48399.8 48993.3 59568.9 59697.0 59861.7 59946.7 60343.7 10228.0 10362.6 10498.5 10514.1 10519.7 16630.4 17325.2 17803.0 17935.6 18086.9 13752.4 14489.5 15181.8 15326.9 15502.3 13065.6 13199.7 13355.7 13411.3 13584.3 14460.8 14912.9 15002.8 15041.3 15062.5 15683.8 16198.8 16250.2 16345.6 16458.8 14320.4 14338.0 14371.2 14438.1 14451.6 17:15:14 INFO - PID 15987 | 17:15:14 INFO - PID 15987 | [#3] mootools.html Cycles:180 Average:6598.78 Median:3753.49 stddev:4154.20 (110.7%) stddev-sans-first:4146.46 17:15:14 INFO - PID 15987 | Values: 1258.4 1311.9 1315.4 1321.9 1333.5 10672.4 10887.9 11180.9 11227.1 11272.4 10884.2 11004.9 11006.1 11085.9 11092.5 2289.1 2339.3 2339.9 2343.2 2350.7 2233.7 2313.9 2318.5 2320.8 2323.6 2263.8 2263.9 2302.6 2316.8 2316.8 2281.0 2293.2 2299.3 2318.4 2328.3 2245.7 2246.9 2247.0 2247.4 2248.7 10694.7 10969.6 10978.7 10978.7 10981.5 5843.9 6004.7 6014.4 6053.8 6067.1 3399.7 3524.5 3580.4 3589.6 3615.8 1274.1 1277.0 1289.7 1300.9 1313.5 15210.5 15542.9 15701.2 15748.2 15786.2 4864.1 4912.1 4993.0 5013.6 5031.8 11752.9 11844.9 11866.8 11909.0 11950.8 5769.7 5820.9 5868.4 5877.1 5958.6 5476.3 5500.7 5553.9 5601.1 5631.5 3891.2 3950.2 4005.2 4027.3 4070.3 1195.4 1205.9 1206.3 1225.2 1225.9 798.3 827.5 838.7 848.5 869.3 5678.2 5727.7 5828.2 5903.6 5928.1 607.0 610.7 615.6 627.8 628.2 3542.2 4053.7 4090.3 4243.3 4303.8 12226.6 12816.7 12826.1 12849.9 12871.9 12584.4 12723.1 12733.6 12740.2 12784.7 7549.9 8249.4 8638.7 8643.7 8648.2 5830.9 6358.8 6439.8 6888.8 6939.8 12039.8 12328.0 12387.0 12442.9 12845.8 12520.7 12583.5 12594.6 12730.7 12818.3 9162.9 9222.1 9299.7 9304.4 9347.4 9651.4 9788.6 9795.0 9826.0 9830.7 8785.5 8842.6 8886.4 8918.4 9190.0 8376.0 8408.2 8447.5 8612.4 8681.8 6834.1 6965.6 6975.3 6987.3 6995.3 5585.1 5807.9 5817.4 5916.8 5974.0 5824.6 5887.1 5966.0 6178.8 6291.7 17:15:14 INFO - PID 15987 | 17:15:14 INFO - PID 15987 | [#4] prototype.html Cycles:180 Average:5459.23 Median:6162.60 stddev:1625.77 (26.4%) stddev-sans-first:1585.12 17:15:14 INFO - PID 15987 | Values: 386.2 395.4 401.9 406.0 407.7 6202.6 6232.1 6275.9 6291.8 6347.7 6043.3 6117.8 6164.7 6164.7 6168.1 4702.4 4809.9 4819.7 4847.2 4850.2 4829.9 4842.0 4850.1 4850.2 4852.6 4769.4 4769.5 4802.1 4804.4 4812.3 4806.3 4813.1 4826.8 4838.4 4842.7 4216.2 4216.9 4219.1 4220.3 4221.8 6146.7 6152.5 6156.9 6160.5 6179.2 5503.7 5516.3 5523.1 5526.7 5530.1 6521.2 6562.7 6566.1 6573.3 6574.5 4585.9 4589.1 4590.4 4594.7 4608.2 6553.2 6865.8 6893.2 6938.6 6955.9 4502.3 4570.3 4580.1 4583.7 4596.1 4618.3 4624.9 4626.9 4631.0 4646.1 5322.5 5417.1 5434.9 5474.6 5483.9 6559.8 6590.7 6609.7 6615.0 6639.8 1625.2 1643.8 1644.7 1648.4 1652.8 1072.2 1093.0 1105.3 1109.6 1114.3 5853.2 5859.2 5871.1 5884.6 5890.9 6786.6 6817.3 6838.7 6864.9 6879.4 5798.8 5830.3 5850.6 5852.3 5863.2 3585.0 3609.8 3610.4 3632.4 3655.6 6529.6 6568.9 6571.9 6579.3 6600.8 6913.3 6915.9 6952.8 6960.3 6990.7 6544.6 6622.2 6622.9 6649.8 6664.6 6755.6 6783.5 6799.2 6806.2 6827.5 6669.6 6674.8 6696.3 6750.6 6758.2 6185.4 6576.9 6579.3 6584.8 6618.9 4525.0 4526.0 4540.0 4546.3 4559.2 6658.8 6829.5 6846.0 6853.5 6862.5 6630.0 6635.2 6650.5 6653.7 6655.7 6616.0 6621.8 6629.2 6634.6 6637.2 6453.7 6531.0 6539.4 6564.4 6582.9 6626.4 6644.1 6671.7 6674.4 6717.2 6425.9 6460.5 6465.0 6477.5 6482.3 17:15:14 INFO - PID 15987 | 17:15:14 INFO - PID 15987 | [#5] yui.html Cycles:180 Average:19378.52 Median:28866.00 stddev:24550.51 (85.0%) stddev-sans-first:24579.82 17:15:14 INFO - PID 15987 | Values: 817.9 838.9 841.3 851.9 854.8 16966.2 17798.9 17838.7 19484.6 20893.8 18943.1 19037.6 19092.7 19207.6 19248.3 928.1 960.8 966.0 967.4 970.8 962.8 971.1 974.7 982.3 986.8 1026.7 1030.1 1030.9 1032.7 1034.1 1019.1 1030.9 1031.4 1033.8 1034.9 753.4 757.4 759.5 760.6 762.1 17210.7 17773.6 17864.8 17901.0 18102.6 18293.5 18635.6 18668.5 18783.2 18810.2 14794.3 15035.1 15039.2 15044.3 15048.8 3413.2 3438.6 3442.9 3578.6 3590.3 83559.0 83892.6 84366.6 84969.0 85299.0 13984.2 14778.9 15158.2 15297.8 15326.4 26405.5 26921.9 27631.9 28212.4 28379.6 7712.6 8092.1 8113.7 8122.3 8250.3 3807.4 3870.6 3877.9 3892.2 3894.5 3721.8 3793.5 3794.8 3809.9 4218.5 800.3 815.9 819.7 820.0 820.3 639.8 656.0 660.9 661.1 667.4 10867.9 12010.8 12652.4 12941.9 12971.2 686.5 704.7 707.8 715.1 715.8 5164.3 5231.6 5368.1 5394.6 5398.2 90032.5 92762.5 93996.0 95257.5 98284.7 83355.6 84504.6 85313.0 85538.6 85844.0 66738.7 69216.4 70535.6 70805.3 70898.3 10709.1 10801.6 11483.3 11636.0 12191.5 28745.0 28987.0 29022.0 29398.1 29682.1 35974.5 36193.6 36406.0 37487.5 43252.0 16242.0 16712.7 17066.2 17191.2 17480.8 15579.2 15599.6 16188.2 16225.5 17397.8 16739.5 16813.3 16848.0 18082.1 18329.9 17102.4 17424.1 17481.6 17539.6 18002.5 15596.1 16249.0 16270.8 16332.6 16693.3 11742.8 12359.1 12481.8 12720.6 12745.8 12756.0 13052.3 13132.2 13932.7 13968.7 17:15:14 INFO - PID 15987 | -------- Summary: end -------- 17:15:14 INFO - PID 15987 | 17:15:15 INFO - TEST-INFO | 15987: exit 0 17:15:15 INFO - TEST-OK | dromaeo_css | took 1142819ms 17:15:15 INFO - TEST-START | kraken 17:15:15 INFO - operating with platform_type : linux_ 17:15:15 INFO - Initialising browser for kraken test... 17:15:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49934/getInfo.html -profile /tmp/tmp3Yumlg/profile 17:15:15 INFO - TEST-INFO | started process 16394 (/builds/slave/test/build/application/firefox/firefox http://localhost:49934/getInfo.html) 17:15:50 INFO - TEST-INFO | 16394: killed by SIGTERM 17:15:50 INFO - Browser initialized. 17:15:50 INFO - Running cycle 1/1 for kraken test... 17:15:50 INFO - TEST-INFO | started process 16599 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3Yumlg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:16:02 INFO - PID 16599 | RSS: Main: 187232256 17:16:02 INFO - PID 16599 | 17:16:05 INFO - PID 16599 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49934/tests/kraken/driver.html?testName=audio-beat-detection) 17:16:06 INFO - PID 16599 | RSS: Main: 190971904 17:16:06 INFO - PID 16599 | 17:16:08 INFO - PID 16599 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49934/tests/kraken/driver.html?testName=audio-dft) 17:16:09 INFO - PID 16599 | RSS: Main: 189489152 17:16:09 INFO - PID 16599 | 17:16:12 INFO - PID 16599 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49934/tests/kraken/driver.html?testName=audio-fft) 17:16:12 INFO - PID 16599 | RSS: Main: 185298944 17:16:12 INFO - PID 16599 | 17:16:15 INFO - PID 16599 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49934/tests/kraken/driver.html?testName=audio-oscillator) 17:16:15 INFO - PID 16599 | RSS: Main: 185798656 17:16:15 INFO - PID 16599 | 17:16:17 INFO - PID 16599 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49934/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:16:18 INFO - PID 16599 | RSS: Main: 185823232 17:16:18 INFO - PID 16599 | 17:16:21 INFO - PID 16599 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49934/tests/kraken/driver.html?testName=imaging-darkroom) 17:16:22 INFO - PID 16599 | RSS: Main: 186830848 17:16:22 INFO - PID 16599 | 17:16:25 INFO - PID 16599 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49934/tests/kraken/driver.html?testName=imaging-desaturate) 17:16:26 INFO - PID 16599 | RSS: Main: 186617856 17:16:26 INFO - PID 16599 | 17:16:29 INFO - PID 16599 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49934/tests/kraken/driver.html?testName=json-parse-financial) 17:16:29 INFO - PID 16599 | RSS: Main: 187146240 17:16:29 INFO - PID 16599 | 17:16:31 INFO - PID 16599 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49934/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:16:31 INFO - PID 16599 | RSS: Main: 187379712 17:16:31 INFO - PID 16599 | 17:16:33 INFO - PID 16599 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49934/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:16:34 INFO - PID 16599 | RSS: Main: 187158528 17:16:34 INFO - PID 16599 | 17:16:36 INFO - PID 16599 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49934/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:16:37 INFO - PID 16599 | RSS: Main: 187387904 17:16:37 INFO - PID 16599 | 17:16:39 INFO - PID 16599 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49934/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:16:40 INFO - PID 16599 | RSS: Main: 186929152 17:16:40 INFO - PID 16599 | 17:16:43 INFO - PID 16599 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49934/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:16:44 INFO - PID 16599 | RSS: Main: 186941440 17:16:44 INFO - PID 16599 | 17:16:46 INFO - PID 16599 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49934/tests/kraken/driver.html?testName=ai-astar) 17:16:46 INFO - PID 16599 | RSS: Main: 188301312 17:16:46 INFO - PID 16599 | 17:16:46 INFO - PID 16599 | __start_tp_report 17:16:46 INFO - PID 16599 | _x_x_mozilla_page_load 17:16:46 INFO - PID 16599 | _x_x_mozilla_page_load_details 17:16:46 INFO - PID 16599 | |i|pagename|runs| 17:16:46 INFO - PID 16599 | |0;ai-astar;104;111;111;109;111;111;111;109;109;109 17:16:46 INFO - PID 16599 | |1;audio-beat-detection;154;126;131;189;126;120;128;128;157;121 17:16:46 INFO - PID 16599 | |2;audio-dft;163;165;164;167;162;166;168;173;165;161 17:16:46 INFO - PID 16599 | |3;audio-fft;78;78;75;121;73;74;74;73;94;74 17:16:46 INFO - PID 16599 | |4;audio-oscillator;82;82;107;84;81;82;111;83;81;98 17:16:46 INFO - PID 16599 | |5;imaging-gaussian-blur;118;119;116;115;117;117;118;114;113;121 17:16:46 INFO - PID 16599 | |6;imaging-darkroom;150;151;151;153;150;151;151;150;149;151 17:16:46 INFO - PID 16599 | |7;imaging-desaturate;95;94;94;94;95;94;95;97;99;100 17:16:46 INFO - PID 16599 | |8;json-parse-financial;57;53;54;54;55;55;55;55;55;61 17:16:46 INFO - PID 16599 | |9;json-stringify-tinderbox;57;56;57;57;56;56;58;57;56;57 17:16:46 INFO - PID 16599 | |10;stanford-crypto-aes;86;88;85;88;95;87;88;88;113;89 17:16:46 INFO - PID 16599 | |11;stanford-crypto-ccm;139;132;143;135;136;134;132;134;141;135 17:16:46 INFO - PID 16599 | |12;stanford-crypto-pbkdf2;193;201;199;197;201;192;184;196;196;194 17:16:46 INFO - PID 16599 | |13;stanford-crypto-sha256-iterative;74;73;71;70;75;72;72;72;70;70 17:16:46 INFO - PID 16599 | __end_tp_report 17:16:46 INFO - PID 16599 | __start_cc_report 17:16:46 INFO - PID 16599 | _x_x_mozilla_cycle_collect,989 17:16:46 INFO - PID 16599 | __end_cc_report 17:16:46 INFO - PID 16599 | __startTimestamp1496794606380__endTimestamp 17:16:46 INFO - PID 16599 | 17:16:46 INFO - PID 16599 | ------- Summary: start ------- 17:16:46 INFO - PID 16599 | Number of tests: 14 17:16:46 INFO - PID 16599 | 17:16:46 INFO - PID 16599 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:2.17 (2.0%) stddev-sans-first:1.05 17:16:46 INFO - PID 16599 | Values: 104.0 111.0 111.0 109.0 111.0 111.0 111.0 109.0 109.0 109.0 17:16:46 INFO - PID 16599 | 17:16:46 INFO - PID 16599 | [#1] audio-beat-detection Cycles:10 Average:138.00 Median:129.50 stddev:22.03 (17.0%) stddev-sans-first:22.59 17:16:46 INFO - PID 16599 | Values: 154.0 126.0 131.0 189.0 126.0 120.0 128.0 128.0 157.0 121.0 17:16:46 INFO - PID 16599 | 17:16:46 INFO - PID 16599 | [#2] audio-dft Cycles:10 Average:165.40 Median:165.50 stddev:3.44 (2.1%) stddev-sans-first:3.54 17:16:46 INFO - PID 16599 | Values: 163.0 165.0 164.0 167.0 162.0 166.0 168.0 173.0 165.0 161.0 17:16:46 INFO - PID 16599 | 17:16:46 INFO - PID 16599 | [#3] audio-fft Cycles:10 Average:81.40 Median:74.50 stddev:15.26 (20.5%) stddev-sans-first:16.14 17:16:46 INFO - PID 16599 | Values: 78.0 78.0 75.0 121.0 73.0 74.0 74.0 73.0 94.0 74.0 17:16:46 INFO - PID 16599 | 17:16:46 INFO - PID 16599 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:82.00 stddev:11.67 (14.2%) stddev-sans-first:12.09 17:16:46 INFO - PID 16599 | Values: 82.0 82.0 107.0 84.0 81.0 82.0 111.0 83.0 81.0 98.0 17:16:46 INFO - PID 16599 | 17:16:46 INFO - PID 16599 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.50 stddev:2.39 (2.0%) stddev-sans-first:2.50 17:16:46 INFO - PID 16599 | Values: 118.0 119.0 116.0 115.0 117.0 117.0 118.0 114.0 113.0 121.0 17:16:46 INFO - PID 16599 | 17:16:46 INFO - PID 16599 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:1.06 (0.7%) stddev-sans-first:1.09 17:16:46 INFO - PID 16599 | Values: 150.0 151.0 151.0 153.0 150.0 151.0 151.0 150.0 149.0 151.0 17:16:46 INFO - PID 16599 | 17:16:46 INFO - PID 16599 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:95.00 stddev:2.21 (2.3%) stddev-sans-first:2.33 17:16:46 INFO - PID 16599 | Values: 95.0 94.0 94.0 94.0 95.0 94.0 95.0 97.0 99.0 100.0 17:16:46 INFO - PID 16599 | 17:16:46 INFO - PID 16599 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:2.22 (4.0%) stddev-sans-first:2.28 17:16:46 INFO - PID 16599 | Values: 57.0 53.0 54.0 54.0 55.0 55.0 55.0 55.0 55.0 61.0 17:16:46 INFO - PID 16599 | 17:16:46 INFO - PID 16599 | [#9] json-stringify-tinderbox Cycles:10 Average:56.70 Median:57.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 17:16:46 INFO - PID 16599 | Values: 57.0 56.0 57.0 57.0 56.0 56.0 58.0 57.0 56.0 57.0 17:16:46 INFO - PID 16599 | 17:16:46 INFO - PID 16599 | [#10] stanford-crypto-aes Cycles:10 Average:90.70 Median:88.00 stddev:8.27 (9.4%) stddev-sans-first:8.60 17:16:46 INFO - PID 16599 | Values: 86.0 88.0 85.0 88.0 95.0 87.0 88.0 88.0 113.0 89.0 17:16:46 INFO - PID 16599 | 17:16:46 INFO - PID 16599 | [#11] stanford-crypto-ccm Cycles:10 Average:136.10 Median:135.50 stddev:3.73 (2.7%) stddev-sans-first:3.80 17:16:46 INFO - PID 16599 | Values: 139.0 132.0 143.0 135.0 136.0 134.0 132.0 134.0 141.0 135.0 17:16:46 INFO - PID 16599 | 17:16:46 INFO - PID 16599 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.30 Median:196.50 stddev:5.03 (2.6%) stddev-sans-first:5.27 17:16:46 INFO - PID 16599 | Values: 193.0 201.0 199.0 197.0 201.0 192.0 184.0 196.0 196.0 194.0 17:16:46 INFO - PID 16599 | 17:16:46 INFO - PID 16599 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:72.00 stddev:1.73 (2.4%) stddev-sans-first:1.66 17:16:46 INFO - PID 16599 | Values: 74.0 73.0 71.0 70.0 75.0 72.0 72.0 72.0 70.0 70.0 17:16:46 INFO - PID 16599 | -------- Summary: end -------- 17:16:46 INFO - PID 16599 | 17:16:47 INFO - TEST-INFO | 16599: exit 0 17:16:47 INFO - TEST-OK | kraken | took 91667ms 17:16:47 INFO - SUITE-END | took 1234s 17:16:47 INFO - Completed test suite (00:20:34) 17:16:47 INFO - javascript benchmark 17:16:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7697.6886128719825, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3015.8190508569487, 3041.0268714011527, 3046.7257946784785, 3065.5861458703084, 3067.6472205696336, 5742.138679198122, 5749.137629355589, 5758.049921762915, 5763.366029736726, 5786.450287222712, 5806.332271788746, 5813.651180929137, 5853.268341457318, 5882.4705776480105, 5950.404959504048, 5314.282571852789, 5402.297701298836, 5427.891442171154, 5436.238926550266, 5438.8912221755545, 5520.420355862617, 5522.779088836442, 5540.889182216353, 5548.500634942854, 5556.972215138919, 5332.493413125747, 5355.651882627656, 5404.1083221268445, 5437.8368648940595, 5505.944940550583, 5430.728463576806, 5441.619086663935, 5449.3188351456065, 5471.616986810925, 5481.780728770845, 5354.839354819323, 5373.81191658294, 5374.516293533601, 5377.7580008899695, 5385.569154467633, 5721.455207094103, 5838.2118414013985, 5842.824715258549, 5857.794977175821, 5922.3485416604135, 6093.413838573129, 6198.6280823150755, 6234.438900498932, 6264.1543391642, 6304.211973503312, 6305.8108256752375, 6306.87386252277, 6313.810585682391, 6336.334684858116, 6340.080688300217, 5813.79651712188, 5859.6777177255235, 5865.35481097079, 5876.294844618587, 5888.5289176865745, 6201.96899015502, 6272.1219029335925, 6304.968475157595, 6311.526635502356, 6347.52393570484, 6044.0, 6102.542309326729, 6124.938750612437, 6155.384461553809, 6183.288921773964, 6187.226596675416, 6262.279837818618, 6263.404976527223, 6278.46633036197, 6289.433950944437, 6253.749850005949, 6258.718357673915, 6276.780312689034, 6277.7175027123885, 6298.590591611531, 6105.4294214941465, 6192.907106393408, 6208.255009398811, 6289.559730818799, 6311.779087731908, 5132.409772876167, 5134.563562097189, 5145.562627176657, 5153.7165455900285, 5175.4824517548695, 4397.098594788061, 4406.779661016936, 4415.712978656377, 4432.955670443319, 4495.2582823834355, 5360.785568577291, 5519.2824932758485, 5525.254090697785, 5530.253415788817, 5551.8889622208135, 6156.507479401637, 6174.073888916609, 6207.503399728011, 6270.216222972129, 6285.182926219653, 5477.534409575151, 5479.808206712746, 5486.149646804752, 5490.56075513958, 5516.862078448071, 5484.067708489566, 5525.254090697705, 5572.0, 5572.3870374258795, 5591.496765291062, 5988.251468566429, 6028.276606807036, 6066.332703402534, 6091.208142941567, 6093.512518998469, 6314.684265786784, 6322.715477803602, 6331.5251356147555, 6332.746690132343, 6341.49268058545, 6066.423689749467, 6135.355787642234, 6136.0, 6139.416755408229, 6150.938490615036, 6081.84444955457, 6165.84585385369, 6170.413810687977, 6211.782587609412, 6229.501639868709, 6217.098520714561, 6219.751209951552, 6278.686065696788, 6291.591046582141, 6311.842203944754, 5952.5833191676165, 6093.329733729375, 6098.420650038417, 6113.205283313141, 6121.724522396414, 6032.336442991355, 6043.033114701627, 6066.939330606638, 6118.418750218722, 6127.922628246779, 5990.371011043778, 6000.789972350947, 6012.188354572252, 6038.818835434944, 6074.088886666858, 6060.606060606046, 6089.573729839046, 6097.512199023979, 6103.216452666749, 6133.325334213144, 5999.760009599741, 6006.819795406145, 6012.939870601238, 6023.186869772525, 6063.939360606338], "value": 5736.5463589662795, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.4236913884921, 705.0904333409901, 736.2012216744831, 1227.6808029912227, 1273.4651446392513, 37728.62271377286, 38786.418203726935, 38877.80561097194, 38906.0, 38940.61059389405, 37533.436998445046, 37869.13028480583, 37926.810365948135, 37955.62044379555, 37956.62043379565, 6793.184817821856, 7139.1433028036445, 7269.200387957347, 7289.161746399179, 7300.525465844729, 7294.234105418907, 7381.077365329334, 7394.0, 7394.075740532434, 7400.074990626172, 7359.77920662381, 7385.4830161888685, 7412.851742965137, 7436.925630743677, 7444.8883266751045, 7347.412207023425, 7367.0, 7416.7404140854815, 7421.777346679582, 7443.85112297751, 7174.067371241757, 7221.53060051095, 7255.854882902365, 7291.161516425573, 7317.670704818296, 35522.28955420903, 35673.286534269166, 35913.281734365424, 35967.46048809244, 35978.28043439116, 3484.181217413906, 3499.7550171488006, 3518.47222916562, 3524.0837382280533, 3534.8586056557965, 27782.3054423639, 27976.580351294746, 28070.859645701847, 28074.157775266776, 28161.43677126446, 3484.9651503485147, 3489.2672538766888, 3525.7179425645886, 3552.1652411683235, 3555.235624340779, 164269.0, 165286.77705783508, 165378.0, 172059.0, 176621.116894416, 42564.78717606454, 42693.57306426896, 42763.35854962178, 42890.78554607207, 42930.14139717188, 45193.32210016852, 45483.35816194912, 45502.31746523805, 50680.746596266785, 51378.0, 14789.0, 14930.40278388874, 14938.850611493746, 14953.476628317956, 14965.326560304813, 12210.816837747441, 12281.140320177501, 12288.447019884126, 12346.382680865921, 12366.752664946831, 13844.723105537832, 13904.0, 13907.930460347836, 14018.369173387018, 14268.785968210484, 5738.8278351649515, 5748.856278593069, 5760.769569217268, 5813.302403711497, 5839.708014599253, 965.3483898368573, 980.6910823090703, 981.8723565936383, 988.1403179234112, 988.8467287570438, 21647.89176054141, 22277.44306392321, 23591.11271098308, 24479.510409791703, 24584.262472125865, 1063.9308444951052, 1064.4571268653042, 1084.8752393474695, 1095.3427943234155, 1124.2074337591978, 11917.76164476723, 11972.64082077539, 12050.51797928073, 12101.0, 13031.543895963596, 210519.0, 214143.0, 214559.0, 215497.0, 215500.0, 48218.75890620524, 48247.27629085567, 48264.0, 48401.51598484041, 48949.265761013616, 1362.5707902011034, 1434.347371945783, 1445.2412483446276, 1445.898787084915, 1456.0535651826397, 20785.1685932561, 22099.226527071474, 23260.76739232586, 23735.52528949377, 24092.51814963726, 34920.30159396747, 45059.32411013903, 46056.53943460523, 46084.0, 46143.76928115338, 191532.0, 192824.0, 192949.0, 193041.0, 194096.0, 32662.83668581642, 33239.16902077467, 33285.33429331448, 33506.0, 34505.79229726947, 41043.384349235384, 41295.7935210322, 41509.79245103755, 41694.79152604217, 42629.36055959225, 28227.15318540447, 29521.85239073791, 30193.69806301909, 31181.376372472878, 32193.839030804695, 29086.56370154407, 30185.69814301829, 30275.848620756755, 30929.381412371178, 31845.840770795996, 33663.495047573815, 34606.30787384188, 34688.306233874675, 34731.13172170716, 36000.0, 28660.85669571639, 29873.0, 30304.0, 30538.847305763327, 31902.52146217762, 21910.780892190873, 24549.38626534351, 24862.37844053913, 24878.37804054913, 24978.0], "value": 16368.66544389326, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.48813982521864, 419.6474961032733, 420.8358740091363, 430.24921511961634, 441.47244043368175, 14424.855751442483, 15095.320710568023, 20056.29802956895, 20817.06323215457, 20857.895710521447, 21594.676079858815, 22377.10491580339, 22405.66391504129, 22413.43966400841, 22446.102155913744, 5776.104703770922, 5941.405859414067, 5947.226860508128, 5948.286205655328, 5952.613080149798, 5763.3948435414095, 5858.41415858415, 5859.912101318484, 5865.296164460271, 5867.735951882154, 5792.0, 5819.214406055171, 5819.82540523785, 6155.846103847417, 6474.352564743535, 6500.4799616030605, 6563.737450501974, 6565.93434065658, 6576.112224849632, 6580.407763301278, 6401.039844023434, 6407.423331900105, 6437.324080971524, 6457.031445283245, 6463.0, 26891.193264202106, 27700.584491232647, 28029.439411211864, 28071.0, 28156.296092597644, 1936.7094935759749, 1985.2852972929734, 1989.7612286525564, 1991.6514609943201, 1998.9505509607427, 17887.642247155116, 18475.983820889847, 18480.53798655031, 18501.629967400575, 18505.537361565934, 2291.690621766057, 2363.8818059096975, 2377.1679912030822, 2391.8804059797117, 2455.0, 106495.46752266267, 113116.0, 113339.43330283379, 113430.0, 113926.43036784846, 19345.806541934682, 19504.783230204914, 20208.19167233294, 20661.896690516453, 20774.480637984172, 37478.25043499115, 37558.0, 37753.0, 37767.93569543345, 37882.810585947445, 10366.118879895294, 10545.0, 10690.572377104983, 10703.1437485001, 10842.566297348176, 8318.0, 8780.868286975572, 8793.956030219808, 8874.689385871463, 8879.112088791198, 7576.4317676174505, 7613.809654758676, 7673.11759147694, 7680.078390593165, 7776.034222546429, 2163.8268938484885, 2174.8151407130254, 2181.9127234910743, 2194.4075099722986, 2251.178319913253, 923.9187310320024, 933.9486328251876, 960.4477425480377, 973.7030205787303, 983.4836710726782, 17990.65070119746, 18558.072096395128, 18696.25214991385, 18962.14670339838, 18994.0, 969.2730452160879, 973.0707174648194, 976.3848775271533, 981.4209616326259, 1027.291169093323, 10080.596776128872, 10183.643572474928, 10379.429131397694, 10637.68086957377, 10933.781324373467, 451709.0, 470796.0, 476400.0, 477724.0, 497739.0, 97586.51206743921, 101224.0, 101279.0, 101744.49127754314, 101789.49105254427, 1181.3148373943093, 1186.1519013904926, 1238.158052524292, 1241.2986662535818, 1241.85097788266, 17410.47768566945, 19200.327988520334, 19647.11587978573, 19861.503462413555, 20247.19011239534, 46604.0, 47109.0, 47404.76297618628, 48399.75800120977, 48993.285235018026, 59568.851737791745, 59697.0, 59861.70069149626, 59946.70026649839, 60343.69828150831, 10227.954409118058, 10362.585496580052, 10498.475076246004, 10514.053735163872, 10519.684409467729, 16630.417935372203, 17325.22036508335, 17803.02083385426, 17935.551611209303, 18086.90956545209, 13752.449902003807, 14489.49286775, 15181.772273416129, 15326.923365383102, 15502.302396391964, 13065.608031759062, 13199.67000824987, 13355.732885342044, 13411.32943352809, 13584.32078396096, 14460.783088253895, 14912.94398567298, 15002.774958375852, 15041.323140458924, 15062.548123556311, 15683.764743528627, 16198.757018644965, 16250.187490625658, 16345.591360216089, 16458.75311870299, 14320.355583998537, 14338.0, 14371.20958347301, 14438.133711977314, 14451.566453006426], "value": 11043.239589458914, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1258.3519487463955, 1311.90816642835, 1315.4277889118227, 1321.8803623448653, 1333.5199328241833, 10672.35965842049, 10887.891121088787, 11180.888191118087, 11227.101831853453, 11272.436378181079, 10884.23810333275, 11004.889951100487, 11006.119510439166, 11085.889141108586, 11092.500837462314, 2289.1301305503926, 2339.30990357844, 2339.883005849709, 2343.156463673085, 2350.71791385034, 2233.70961774969, 2313.9421514462106, 2318.5247024359965, 2320.8491448055906, 2323.6166032604683, 2263.8302127340435, 2263.909443622253, 2302.6200676888293, 2316.8030717389042, 2316.8494047886834, 2280.9657855132186, 2293.2203050962585, 2299.310206937912, 2318.4088057545387, 2328.2549584133, 2245.65192395179, 2246.887655617229, 2246.977625180539, 2247.3932038349717, 2248.6964259824877, 10694.679159625224, 10969.616063437821, 10978.670639880816, 10978.725531861768, 10981.505832237568, 5843.883122337572, 6004.6997650117755, 6014.428629280212, 6053.848653783647, 6067.089936509515, 3399.7280217582534, 3524.488949102366, 3580.4092324766384, 3589.569251689814, 3615.8011309377976, 1274.0953922714884, 1276.9680757981032, 1289.7098152915612, 1300.9089363744542, 1313.507434711983, 15210.46763363277, 15542.9222853885, 15701.214939253106, 15748.212589370485, 15786.210689465595, 4864.100141473838, 4912.140375434356, 4992.950070499322, 5013.5989120870245, 5031.77357018935, 11752.94123529394, 11844.881551184379, 11866.762664746657, 11909.047276217882, 11950.820737688942, 5769.74036168365, 5820.88358232833, 5868.413158684183, 5877.089051197071, 5958.582899197015, 5476.288082549323, 5500.669959802424, 5553.861153471195, 5601.131824567198, 5631.465010823965, 3891.1828516011387, 3950.249452603996, 4005.178938317638, 4027.335489644176, 4070.3487442009728, 1195.4022988505747, 1205.9095567832271, 1206.258151236983, 1225.185251807556, 1225.8835410635975, 798.3413683710962, 827.4580150001758, 838.6980686952692, 848.4739461533889, 869.3045563549135, 5678.17530178039, 5727.713614319267, 5828.242328497268, 5903.557233207526, 5928.081147422156, 607.0439058482907, 610.7404353149893, 615.559874689599, 627.802242293676, 628.2335550628226, 3542.220711443478, 4053.7162398632404, 4090.2637525245145, 4243.321068629066, 4303.849365272201, 12226.633201003984, 12816.679583010313, 12826.102172847812, 12849.871501285055, 12871.871281287067, 12584.37078146089, 12723.109382343147, 12733.554325598745, 12740.235585864877, 12784.6803829905, 7549.9245007549225, 8249.422540422232, 8638.654453821902, 8643.740687779376, 8648.1784230498, 5830.9416905832095, 6358.841028974312, 6439.839004024937, 6888.827779305558, 6939.826504337432, 12039.75920481603, 12328.0, 12387.0, 12442.875571244173, 12845.807312890502, 12520.686982825138, 12583.496660133858, 12594.559190428292, 12730.745385092432, 12818.294993775058, 9162.908370916206, 9222.123898229658, 9299.72100836976, 9304.395214311047, 9347.439153650803, 9651.372660777308, 9788.608455661693, 9794.951025244829, 9826.0, 9830.655927042519, 8785.51679657625, 8842.557872106498, 8886.422382545114, 8918.375713700238, 9189.954050229706, 8376.0, 8408.159184081544, 8447.45091569046, 8612.440191387539, 8681.826363472821, 6834.111565496453, 6965.616891071039, 6975.267596902252, 6987.266337034538, 6995.300469952964, 5585.068198133525, 5807.8548036299435, 5817.360090390139, 5916.763329466773, 5974.0, 5824.63121166534, 5887.116932460165, 5966.0, 6178.814635560941, 6291.748330066746], "value": 4977.353430381611, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.2198359314185, 395.4246571238847, 401.8633664554051, 406.0255387071029, 407.7227485309988, 6202.627842329463, 6232.127502149703, 6275.874482510347, 6291.779787707431, 6347.650879201642, 6043.277665865229, 6117.816465506042, 6164.684720695509, 6164.722587483563, 6168.105624684418, 4702.365180700613, 4809.855704328876, 4819.710817350952, 4847.175980083394, 4850.199717046683, 4829.855104346875, 4842.00738848537, 4850.126977144113, 4850.151223535885, 4852.636052296074, 4769.356136921506, 4769.475357710649, 4802.087603355369, 4804.399450068741, 4812.32627432158, 4806.3030860525205, 4813.122882075993, 4826.7827947742435, 4838.403326902114, 4842.685225460369, 4216.156768646252, 4216.936745948813, 4219.11398606293, 4220.3036498977635, 4221.810018549173, 6146.692665366714, 6152.507799376039, 6156.938430615682, 6160.507159427235, 6179.19670442844, 5503.724813759296, 5516.310461192351, 5523.1163013917985, 5526.723663816833, 5530.092118219248, 6521.217453905514, 6562.67186640666, 6566.113574667406, 6573.342665733437, 6574.520732835122, 4585.931211031837, 4589.105124500724, 4590.449146102455, 4594.65540084495, 4608.239640459354, 6553.2136143663065, 6865.794026179223, 6893.20728116268, 6938.618375989318, 6955.89566156508, 4502.347159661831, 4570.337301091389, 4580.083983203373, 4583.656225783079, 4596.149712303235, 4618.330342100377, 4624.884377890579, 4626.884327891829, 4631.004334068191, 4646.117237724821, 5322.520973112439, 5417.10617748075, 5434.91847622286, 5474.644148130438, 5483.917741233885, 6559.8032059038305, 6590.736370545221, 6609.702563384659, 6615.0, 6639.767608133692, 1625.2117722904381, 1643.8027436707432, 1644.7121753693295, 1648.4230519318144, 1652.7851379320853, 1072.1851392941421, 1092.956281748737, 1105.3257512917114, 1109.5617231193633, 1114.3481063577735, 5853.180554722342, 5859.150423188699, 5871.148683440877, 5884.6469211847425, 5890.882182356415, 6786.642671465726, 6817.284185160487, 6838.7264509420065, 6864.897026544606, 6879.449644028466, 5798.797042103506, 5830.280067380133, 5850.561207909339, 5852.268466441695, 5863.179154918314, 3585.0141211166615, 3609.7653652513027, 3610.422332426799, 3632.4369722693023, 3655.597884232732, 6529.575577587537, 6568.934310656928, 6571.934280657228, 6579.276279609239, 6600.768973085919, 6913.308669133147, 6915.861682766316, 6952.756653517103, 6960.269171736996, 6990.720371185197, 6544.574602650812, 6622.1722284714415, 6622.933770662232, 6649.833754156185, 6664.566803157779, 6755.594664320157, 6783.4573234142135, 6799.184097908283, 6806.18325800907, 6827.487938404739, 6669.566478178903, 6674.833129171615, 6696.292445426385, 6750.594964302158, 6758.189017317954, 6185.41238582334, 6576.934230657632, 6579.342065793382, 6584.8024559263295, 6618.900716489353, 4524.9547504524535, 4526.0, 4539.954600453953, 4546.272596384695, 4559.202139625486, 6658.766943156967, 6829.4877884157895, 6846.0, 6853.4859885507785, 6862.451003919575, 6630.005499175162, 6635.236947750877, 6650.534462587766, 6653.669266146693, 6655.667216639052, 6615.974523948796, 6621.801345959629, 6629.204495460575, 6634.649502001458, 6637.203535575762, 6453.677316134268, 6531.0, 6539.444147247537, 6564.409203171737, 6582.934170658232, 6626.376537748282, 6644.10304608891, 6671.733130674718, 6674.365935236145, 6717.227518835396, 6425.9036114457385, 6460.4508616766225, 6465.030245463218, 6477.546571739933, 6482.319356467503], "value": 4944.99809561521, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [817.8609636361817, 838.9412741108121, 841.3143288220101, 851.8679604661276, 854.8204876975835, 16966.23651935663, 17798.91100544497, 17838.732419013708, 19484.610307793835, 20893.791062089374, 18943.147558359873, 19037.61924761504, 19092.71360929587, 19207.61584768304, 19248.326308579166, 928.0811996123839, 960.8030353777493, 965.9565319560602, 967.4340510801154, 970.7864269860619, 962.821877952581, 971.130837900079, 974.6929717139114, 982.346739418286, 986.7779749556364, 1026.712520494263, 1030.0729343590754, 1030.8608337874402, 1032.6747074671455, 1034.0900007992993, 1019.093007223568, 1030.8969103089669, 1031.3760175094035, 1033.7880734449495, 1034.886162522122, 753.3521171792254, 757.3524636435878, 759.4835511851938, 760.627292626609, 762.0740799928059, 17210.655786884192, 17773.555661108447, 17864.821351786577, 17901.0, 18102.637947241114, 18293.54266143344, 18635.627287454176, 18668.533286667807, 18783.154758035922, 18810.153543090593, 14794.260286985715, 15035.097894126278, 15039.248037598076, 15044.323005464781, 15048.774268385983, 3413.2490852012515, 3438.6045604755523, 3442.9311413771834, 3578.5526809148855, 3590.263995880838, 83559.0, 83892.58053709753, 84366.57816710939, 84969.0, 85299.0, 13984.160950343012, 14778.852211477748, 15158.166300853338, 15297.770533442008, 15326.386944522093, 26405.47189056208, 26921.92312307486, 27631.861840690668, 28212.43575128527, 28379.57430638542, 7712.575808330484, 8092.069412017576, 8113.675452981933, 8122.309603683635, 8250.298724608476, 3807.428885667117, 3870.632289932452, 3877.922441551153, 3892.2020985697864, 3894.532656081232, 3721.776693398405, 3793.487879136281, 3794.8102594870697, 3809.923801523954, 4218.535961044283, 800.3477166109602, 815.9265666090081, 819.7458787775809, 820.0, 820.2986446588081, 639.763287583597, 655.9606423614598, 660.8612191439755, 661.1075048684334, 667.4193451697055, 10867.935092332431, 12010.819837702267, 12652.367381630882, 12941.935290323489, 12971.156874803108, 686.4748467422426, 704.7075463682514, 707.8088915992653, 715.1025463043846, 715.7924201981472, 5164.25118357836, 5231.555317797954, 5368.087425137736, 5394.622376433612, 5398.24424580559, 90032.5498372504, 92762.53618731863, 93996.0, 95257.52371238238, 98284.69725981604, 83355.58322208471, 84504.57747711222, 85313.0, 85538.57230713931, 85844.0, 66738.66630666815, 69216.38619751824, 70535.64732176306, 70805.2919470809, 70898.30178020569, 10709.143268538654, 10801.621943231949, 11483.25358851672, 11636.0, 12191.51233950632, 28745.0, 28987.0, 29022.0, 29398.11805645834, 29682.10953671393, 35974.460383094796, 36193.63806361903, 36406.0, 37487.501499820195, 43252.0, 16242.025478470858, 16712.74930876062, 17066.232019559397, 17191.226394812013, 17480.82519174792, 15579.221038948233, 15599.610009749847, 16188.190590470665, 16225.51323460298, 17397.826021740126, 16739.497815065566, 16813.327466901188, 16848.0, 18082.09589520545, 18329.90835045816, 17102.40141595088, 17424.128793560525, 17481.56404565969, 17539.649207016042, 18002.5499362517, 15596.14221217844, 16249.0, 16270.755938660694, 16332.591685207964, 16693.332266709196, 11742.823857641972, 12359.134860559674, 12481.750364992831, 12720.554780582635, 12745.769490338967, 12756.0, 13052.282124483245, 13132.212067275994, 13932.651683707989, 13968.720625587635], "value": 8150.903390094391, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 111.0, 109.0, 111.0, 111.0, 111.0, 109.0, 109.0, 109.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 126.0, 131.0, 189.0, 126.0, 120.0, 128.0, 128.0, 157.0, 121.0], "value": 138.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 164.0, 167.0, 162.0, 166.0, 168.0, 173.0, 165.0, 161.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 75.0, 121.0, 73.0, 74.0, 74.0, 73.0, 94.0, 74.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 107.0, 84.0, 81.0, 82.0, 111.0, 83.0, 81.0, 98.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 116.0, 115.0, 117.0, 117.0, 118.0, 114.0, 113.0, 121.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 151.0, 153.0, 150.0, 151.0, 151.0, 150.0, 149.0, 151.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 97.0, 99.0, 100.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 54.0, 54.0, 55.0, 55.0, 55.0, 55.0, 55.0, 61.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 57.0, 56.0, 56.0, 58.0, 57.0, 56.0, 57.0], "value": 56.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 85.0, 88.0, 95.0, 87.0, 88.0, 88.0, 113.0, 89.0], "value": 90.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 132.0, 143.0, 135.0, 136.0, 134.0, 132.0, 134.0, 141.0, 135.0], "value": 136.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 201.0, 199.0, 197.0, 201.0, 192.0, 184.0, 196.0, 196.0, 194.0], "value": 195.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 71.0, 70.0, 75.0, 72.0, 72.0, 72.0, 70.0, 70.0], "value": 71.9, "unit": "score"}]}]} 17:16:47 INFO - Return code: 0 17:16:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:16:47 INFO - # TBPL SUCCESS # 17:16:47 INFO - Running post-action listener: _resource_record_post_action 17:16:47 INFO - [mozharness: 2017-06-07 00:16:47.785767Z] Finished run-tests step (success) 17:16:47 INFO - Running post-run listener: _resource_record_post_run 17:16:47 INFO - Total resource usage - Wall time: 1252s; CPU: 13.0%; Read bytes: 4096; Write bytes: 426876928; Read time: 8; Write time: 319228 17:16:47 INFO - TinderboxPrint: CPU usage
12.7% 17:16:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 17:16:47 INFO - TinderboxPrint: I/O write bytes / time
426,876,928 / 319,228 17:16:47 INFO - TinderboxPrint: CPU idle
8,726.4 (87.3%) 17:16:47 INFO - TinderboxPrint: CPU user
1,211.3 (12.1%) 17:16:47 INFO - TinderboxPrint: Swap in / out
0 / 0 17:16:47 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 100208640; Read time: 0; Write time: 109524 17:16:47 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:16:47 INFO - run-tests - Wall time: 1235s; CPU: 13.0%; Read bytes: 0; Write bytes: 322273280; Read time: 0; Write time: 209340 17:16:48 INFO - Running post-run listener: _upload_blobber_files 17:16:48 INFO - Blob upload gear active. 17:16:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:16:48 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 17:16:48 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'] 17:16:48 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 17:16:48 INFO - (blobuploader) - INFO - Open directory for files ... 17:16:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:16:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:16:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:52 INFO - (blobuploader) - INFO - Done attempting. 17:16:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:16:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:16:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:52 INFO - (blobuploader) - INFO - Done attempting. 17:16:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:16:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:53 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:16:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:53 INFO - (blobuploader) - INFO - Done attempting. 17:16:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:16:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:16:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:54 INFO - (blobuploader) - INFO - Done attempting. 17:16:54 INFO - (blobuploader) - INFO - Iteration through files over. 17:16:54 INFO - Return code: 0 17:16:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:16:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:16:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f1001a6fc59a771b9f5830bf7d0c135dd5ed98180f4d67645428f4f96e0c4dcf3b476614a09f403fb32bfabb260c3052197c3c9240997ef942a637cae2e778cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5f363e30629a46390a4ef93a74247f1bc9875685883234a3ec28824e86f74c107ba4ef0c365dbc1f364978e2fa9bdf0945f9c9979822378ae6827bdd6219c75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d6b2df509f22910d0d80f15e3ad0d8d9db8720691465ed39022bd9d5d15358fb5c883d35d3b65e52e33be341dae0e73e3ba4a961de1060e105647d15ffbdf48", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/082825ab1427c0adb013f03e8d54af72109c98671d921b238ba04542518d77b399ebc282eb3f2917c8a7e149387408bd6f05a8d0520ad75e3f66c2c22fe490c2"} 17:16:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:16:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:16:54 INFO - Contents: 17:16:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f1001a6fc59a771b9f5830bf7d0c135dd5ed98180f4d67645428f4f96e0c4dcf3b476614a09f403fb32bfabb260c3052197c3c9240997ef942a637cae2e778cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5f363e30629a46390a4ef93a74247f1bc9875685883234a3ec28824e86f74c107ba4ef0c365dbc1f364978e2fa9bdf0945f9c9979822378ae6827bdd6219c75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d6b2df509f22910d0d80f15e3ad0d8d9db8720691465ed39022bd9d5d15358fb5c883d35d3b65e52e33be341dae0e73e3ba4a961de1060e105647d15ffbdf48", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/082825ab1427c0adb013f03e8d54af72109c98671d921b238ba04542518d77b399ebc282eb3f2917c8a7e149387408bd6f05a8d0520ad75e3f66c2c22fe490c2"} 17:16:54 INFO - Running post-run listener: copy_logs_to_upload_dir 17:16:54 INFO - Copying logs to upload dir... 17:16:54 INFO - mkdir: /builds/slave/test/build/upload/logs 17:16:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1316.484204 ========= master_lag: -0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2017-06-06 17:16:53.340519) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-06 17:16:53.345366) ========= 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=51fc86400edbde9650d2781a000001d0-1496789206.354608-759288938 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/f1001a6fc59a771b9f5830bf7d0c135dd5ed98180f4d67645428f4f96e0c4dcf3b476614a09f403fb32bfabb260c3052197c3c9240997ef942a637cae2e778cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5f363e30629a46390a4ef93a74247f1bc9875685883234a3ec28824e86f74c107ba4ef0c365dbc1f364978e2fa9bdf0945f9c9979822378ae6827bdd6219c75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d6b2df509f22910d0d80f15e3ad0d8d9db8720691465ed39022bd9d5d15358fb5c883d35d3b65e52e33be341dae0e73e3ba4a961de1060e105647d15ffbdf48", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/082825ab1427c0adb013f03e8d54af72109c98671d921b238ba04542518d77b399ebc282eb3f2917c8a7e149387408bd6f05a8d0520ad75e3f66c2c22fe490c2"} build_url:https://queue.taskcluster.net/v1/task/S83tIixKTre_UE7QzKwK7w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011317 build_url: 'https://queue.taskcluster.net/v1/task/S83tIixKTre_UE7QzKwK7w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f1001a6fc59a771b9f5830bf7d0c135dd5ed98180f4d67645428f4f96e0c4dcf3b476614a09f403fb32bfabb260c3052197c3c9240997ef942a637cae2e778cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5f363e30629a46390a4ef93a74247f1bc9875685883234a3ec28824e86f74c107ba4ef0c365dbc1f364978e2fa9bdf0945f9c9979822378ae6827bdd6219c75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d6b2df509f22910d0d80f15e3ad0d8d9db8720691465ed39022bd9d5d15358fb5c883d35d3b65e52e33be341dae0e73e3ba4a961de1060e105647d15ffbdf48", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/082825ab1427c0adb013f03e8d54af72109c98671d921b238ba04542518d77b399ebc282eb3f2917c8a7e149387408bd6f05a8d0520ad75e3f66c2c22fe490c2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-06 17:16:53.377167) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 17:16:53.377497) ========= 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=51fc86400edbde9650d2781a000001d0-1496789206.354608-759288938 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 17:16:53.459789) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-06 17:16:53.463140) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-06 17:16:53.463443) ========= ========= Total master_lag: 0.09 =========