builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-061 starttime: 1496838348.97 results: success (0) revision: f6320f91851c2cede08b0fb54a6d0525b870310e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-07 05:25:48.965335) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-07 05:25:48.965816) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-07 05:25:48.966110) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-07 05:25:48.994217) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:25:48.994517) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1496837189.3640-988924461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-07 05:25:49-- 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% 46.4M=0s 2017-06-07 05:25:49 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.269389 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:25:49.277678) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:25:49.281165) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1496837189.3640-988924461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017234 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:25:49.330909) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:25:49.331255) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f6320f91851c2cede08b0fb54a6d0525b870310e --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 f6320f91851c2cede08b0fb54a6d0525b870310e --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=516f8d7ca085b4d087ab0a71000001a4-1496837189.3640-988924461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-07 05:25:49,581 truncating revision to first 12 chars 2017-06-07 05:25:49,581 Setting DEBUG logging. 2017-06-07 05:25:49,581 attempt 1/10 2017-06-07 05:25:49,581 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f6320f91851c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-07 05:25:50,099 unpacking tar archive at: mozilla-central-f6320f91851c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.832817 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:25:50.179759) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-07 05:25:50.183089) ========= script_repo_revision: f6320f91851c2cede08b0fb54a6d0525b870310e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-07 05:25:50.183484) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-07 05:25:50.183807) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-07 05:25:50.193590) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 21 secs) (at 2017-06-07 05:25:50.193943) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1496837189.3640-988924461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:25:50 INFO - MultiFileLogger online at 20170607 05:25:50 in /builds/slave/test 05:25:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 05:25:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:25:50 INFO - {'append_to_log': False, 05:25:50 INFO - 'base_work_dir': '/builds/slave/test', 05:25:50 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:25:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:25:50 INFO - 'branch': 'Firefox-Non-PGO', 05:25:50 INFO - 'buildbot_json_path': 'buildprops.json', 05:25:50 INFO - 'config_files': ('talos/linux_config.py',), 05:25:50 INFO - 'default_actions': ('clobber', 05:25:50 INFO - 'read-buildbot-config', 05:25:50 INFO - 'download-and-extract', 05:25:50 INFO - 'populate-webroot', 05:25:50 INFO - 'create-virtualenv', 05:25:50 INFO - 'install', 05:25:50 INFO - 'setup-mitmproxy', 05:25:50 INFO - 'run-tests'), 05:25:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:25:50 INFO - 'download_minidump_stackwalk': True, 05:25:50 INFO - 'download_symbols': 'ondemand', 05:25:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:25:50 INFO - 'tooltool.py': '/tools/tooltool.py', 05:25:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:25:50 INFO - '/tools/misc-python/virtualenv.py')}, 05:25:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:25:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:25:50 INFO - 'gecko_profile': False, 05:25:50 INFO - 'gecko_profile_interval': 0, 05:25:50 INFO - 'installer_path': 'installer.exe', 05:25:50 INFO - 'log_level': 'info', 05:25:50 INFO - 'log_name': 'talos', 05:25:50 INFO - 'log_to_console': True, 05:25:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:25:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:25:50 INFO - 'opt_config_files': (), 05:25:50 INFO - 'pip_index': False, 05:25:50 INFO - 'suite': 'dromaeojs-e10s', 05:25:50 INFO - 'system_bits': '32', 05:25:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:25:50 INFO - 'title': 'talos-linux64-ix-061', 05:25:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:25:50 INFO - 'use_talos_json': True, 05:25:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:25:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:25:50 INFO - 'work_dir': 'build'} 05:25:50 INFO - [mozharness: 2017-06-07 12:25:50.544520Z] Running clobber step. 05:25:50 INFO - Running pre-action listener: _resource_record_pre_action 05:25:50 INFO - Running main action method: clobber 05:25:50 INFO - rmtree: /builds/slave/test/build 05:25:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:25:52 INFO - Running post-action listener: _resource_record_post_action 05:25:52 INFO - [mozharness: 2017-06-07 12:25:52.082952Z] Finished clobber step (success) 05:25:52 INFO - [mozharness: 2017-06-07 12:25:52.083053Z] Running read-buildbot-config step. 05:25:52 INFO - Running pre-action listener: _resource_record_pre_action 05:25:52 INFO - Running main action method: read_buildbot_config 05:25:52 INFO - Using buildbot properties: 05:25:52 INFO - { 05:25:52 INFO - "project": "", 05:25:52 INFO - "product": "firefox", 05:25:52 INFO - "who": "cbook@mozilla.com", 05:25:52 INFO - "installer_path": "public/build/target.tar.bz2", 05:25:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:25:52 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:25:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:25:52 INFO - "stage_platform": "linux64", 05:25:52 INFO - "basedir": "/builds/slave/test", 05:25:52 INFO - "buildnumber": 895, 05:25:52 INFO - "platform": "ubuntu64_hw", 05:25:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:25:52 INFO - "slavebuilddir": "test", 05:25:52 INFO - "taskId": "NhpfUYnpRs6tsPj-kIhslA", 05:25:52 INFO - "branch": "mozilla-central", 05:25:52 INFO - "script_repo_revision": "production", 05:25:52 INFO - "revision": "f6320f91851c2cede08b0fb54a6d0525b870310e", 05:25:52 INFO - "slavename": "talos-linux64-ix-061", 05:25:52 INFO - "repo_path": "mozilla-central" 05:25:52 INFO - } 05:25:52 INFO - Finding installer, test and symbols from parent task. 05:25:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NhpfUYnpRs6tsPj-kIhslA'}, attempt #1 05:25:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NhpfUYnpRs6tsPj-kIhslA'}, attempt #1 05:25:53 INFO - Task dependencies: U6KszMJcRYqxSDY968A7nA 05:25:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U6KszMJcRYqxSDY968A7nA'}, attempt #1 05:25:53 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/U6KszMJcRYqxSDY968A7nA/artifacts/public/build/target.tar.bz2 05:25:53 INFO - Set test_url: https://queue.taskcluster.net/v1/task/U6KszMJcRYqxSDY968A7nA/artifacts/public/build/test_packages.json 05:25:53 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/U6KszMJcRYqxSDY968A7nA/artifacts/public/build/target.crashreporter-symbols.zip 05:25:53 INFO - Running post-action listener: _resource_record_post_action 05:25:53 INFO - [mozharness: 2017-06-07 12:25:53.518595Z] Finished read-buildbot-config step (success) 05:25:53 INFO - [mozharness: 2017-06-07 12:25:53.518818Z] Running download-and-extract step. 05:25:53 INFO - Running pre-action listener: _resource_record_pre_action 05:25:53 INFO - Running main action method: download_and_extract 05:25:53 INFO - mkdir: /builds/slave/test/build/tests 05:25: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')]} 05:25:53 INFO - trying https://queue.taskcluster.net/v1/task/U6KszMJcRYqxSDY968A7nA/artifacts/public/build/target.test_packages.json 05:25:53 INFO - Downloading https://queue.taskcluster.net/v1/task/U6KszMJcRYqxSDY968A7nA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:25:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U6KszMJcRYqxSDY968A7nA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:25:54 INFO - Downloaded 989 bytes. 05:25:54 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:25:54 INFO - Using the following test package requirements: 05:25:54 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:25:54 INFO - u'common': [u'target.common.tests.zip'], 05:25:54 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:25:54 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:25:54 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:25:54 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:25:54 INFO - u'mozbase': [u'target.common.tests.zip'], 05:25:54 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:25:54 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:25:54 INFO - u'web-platform': [u'target.common.tests.zip', 05:25:54 INFO - u'target.web-platform.tests.tar.gz'], 05:25:54 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:25:54 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:25:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U6KszMJcRYqxSDY968A7nA/artifacts/public/build/target.common.tests.zip 05:25:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U6KszMJcRYqxSDY968A7nA/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:25:54 INFO - Fetch https://queue.taskcluster.net/v1/task/U6KszMJcRYqxSDY968A7nA/artifacts/public/build/target.common.tests.zip into memory 05:26:23 INFO - Content-Length response header: 65110290 05:26:23 INFO - Bytes received: 65110290 05:26:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:26:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U6KszMJcRYqxSDY968A7nA/artifacts/public/build/target.common.tests.zip 05:26:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U6KszMJcRYqxSDY968A7nA/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:26:34 INFO - Fetch https://queue.taskcluster.net/v1/task/U6KszMJcRYqxSDY968A7nA/artifacts/public/build/target.common.tests.zip into memory 05:26:35 INFO - Content-Length response header: 65110290 05:26:35 INFO - Bytes received: 65110290 05:26:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U6KszMJcRYqxSDY968A7nA/artifacts/public/build/target.talos.tests.zip 05:26:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U6KszMJcRYqxSDY968A7nA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:26:47 INFO - Fetch https://queue.taskcluster.net/v1/task/U6KszMJcRYqxSDY968A7nA/artifacts/public/build/target.talos.tests.zip into memory 05:26:48 INFO - Content-Length response header: 14447563 05:26:48 INFO - Bytes received: 14447563 05:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:49 INFO - trying https://queue.taskcluster.net/v1/task/U6KszMJcRYqxSDY968A7nA/artifacts/public/build/target.tar.bz2 05:26:49 INFO - Downloading https://queue.taskcluster.net/v1/task/U6KszMJcRYqxSDY968A7nA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:26:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U6KszMJcRYqxSDY968A7nA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:26:51 INFO - Downloaded 58632586 bytes. 05:26:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U6KszMJcRYqxSDY968A7nA/artifacts/public/build/target.tar.bz2 05:26:51 INFO - mkdir: /builds/slave/test/properties 05:26:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:26:51 INFO - Writing to file /builds/slave/test/properties/build_url 05:26:51 INFO - Contents: 05:26:51 INFO - build_url:https://queue.taskcluster.net/v1/task/U6KszMJcRYqxSDY968A7nA/artifacts/public/build/target.tar.bz2 05:26:51 INFO - Running post-action listener: _resource_record_post_action 05:26:51 INFO - Running post-action listener: set_extra_try_arguments 05:26:51 INFO - [mozharness: 2017-06-07 12:26:51.154053Z] Finished download-and-extract step (success) 05:26:51 INFO - [mozharness: 2017-06-07 12:26:51.154242Z] Running populate-webroot step. 05:26:51 INFO - Running pre-action listener: _resource_record_pre_action 05:26:51 INFO - Running main action method: populate_webroot 05:26:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:26:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:26:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:26:51 INFO - '--tppagecycles', 05:26:51 INFO - '7'], 05:26:51 INFO - 'tests': ['tsvgm']}}, 05:26:51 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:26:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:26:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:26:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:26:51 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:26:51 INFO - 'talos_options': ['--disable-e10s'], 05:26:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:26:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:26:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:26:51 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:26:51 INFO - 'talos_options': ['--disable-e10s'], 05:26:51 INFO - 'tests': ['damp', 'tps']}, 05:26:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:26:51 INFO - 'tests': ['damp', 'tps']}, 05:26:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:26:51 INFO - 'tests': ['dromaeo_dom']}, 05:26:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:26:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:26:51 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:26:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:26:51 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:26:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:26:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:26:51 INFO - 'tests': ['a11yr', 05:26:51 INFO - 'ts_paint', 05:26:51 INFO - 'tpaint', 05:26:51 INFO - 'sessionrestore', 05:26:51 INFO - 'sessionrestore_no_auto_restore', 05:26:51 INFO - 'tabpaint']}, 05:26:51 INFO - 'other-e10s': {'tests': ['a11yr', 05:26:51 INFO - 'ts_paint', 05:26:51 INFO - 'tpaint', 05:26:51 INFO - 'sessionrestore', 05:26:51 INFO - 'sessionrestore_no_auto_restore', 05:26:51 INFO - 'tabpaint']}, 05:26:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:26:51 INFO - 'ts_paint', 05:26:51 INFO - 'tpaint', 05:26:51 INFO - 'sessionrestore', 05:26:51 INFO - 'sessionrestore_no_auto_restore', 05:26:51 INFO - 'tabpaint']}, 05:26:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:26:51 INFO - 'ts_paint', 05:26:51 INFO - 'tpaint', 05:26:51 INFO - 'sessionrestore', 05:26:51 INFO - 'sessionrestore_no_auto_restore', 05:26:51 INFO - 'tabpaint']}, 05:26:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:26:51 INFO - 'tests': ['a11yr', 05:26:51 INFO - 'ts_paint', 05:26:51 INFO - 'tpaint', 05:26:51 INFO - 'sessionrestore', 05:26:51 INFO - 'sessionrestore_no_auto_restore', 05:26:51 INFO - 'tabpaint']}, 05:26:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:26:51 INFO - 'tests': ['a11yr', 05:26:51 INFO - 'ts_paint', 05:26:51 INFO - 'tpaint', 05:26:51 INFO - 'sessionrestore', 05:26:51 INFO - 'sessionrestore_no_auto_restore', 05:26:51 INFO - 'tabpaint']}, 05:26:51 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:26:51 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:26:51 INFO - 'bloom_basic_ref']}, 05:26:51 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 05:26:51 INFO - 'talos_options': ['--mitmproxy', 05:26:51 INFO - 'mitmproxy-recording-1.mp', 05:26:51 INFO - '--firstNonBlankPaint'], 05:26:51 INFO - 'tests': ['Quantum_1']}, 05:26:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:26:51 INFO - 'tests': ['tsvgx', 05:26:51 INFO - 'tsvgr_opacity', 05:26:51 INFO - 'tart', 05:26:51 INFO - 'tscrollx', 05:26:51 INFO - 'cart', 05:26:51 INFO - 'tsvg_static']}, 05:26:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:26:51 INFO - 'tsvgr_opacity', 05:26:51 INFO - 'tart', 05:26:51 INFO - 'tscrollx', 05:26:51 INFO - 'cart', 05:26:51 INFO - 'tsvg_static']}, 05:26:51 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:26:51 INFO - 'talos_options': ['--disable-e10s'], 05:26:51 INFO - 'tests': ['tp5o']}, 05:26:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:26:51 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:26:51 INFO - 'talos_options': ['--disable-e10s', 05:26:51 INFO - '--xperf_path', 05:26:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:26:51 INFO - 'tests': ['tp5n']}, 05:26:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:26:51 INFO - 'talos_options': ['--xperf_path', 05:26:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:26:51 INFO - 'tests': ['tp5n']}}, 05:26:51 INFO - 'talos.zip': {'path': '', 05:26:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:26:51 INFO - Running post-action listener: _resource_record_post_action 05:26:51 INFO - [mozharness: 2017-06-07 12:26:51.176645Z] Finished populate-webroot step (success) 05:26:51 INFO - [mozharness: 2017-06-07 12:26:51.176740Z] Running create-virtualenv step. 05:26:51 INFO - Running pre-action listener: _resource_record_pre_action 05:26:51 INFO - Running main action method: create_virtualenv 05:26:51 INFO - Creating virtualenv /builds/slave/test/build/venv 05:26:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:26:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:26:51 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:26:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:26:51 INFO - Using real prefix '/usr' 05:26:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:26:51 INFO - Installing distribute.............................................................................................................................................................................................done. 05:26:53 INFO - Installing pip.................done. 05:26:53 INFO - Return code: 0 05:26:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:26:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:26:53 INFO - Reading from file tmpfile_stdout 05:26:53 INFO - Output received: 05:26:53 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:26:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:26: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')]} 05:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26: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')]} 05:26:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:53 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 0x260a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29889a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2986140>, '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 0x2986a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2986ed0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1496837189.3640-988924461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:26:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:26:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:26:53 INFO - Using env: {'DISPLAY': ':0', 05:26:53 INFO - 'HOME': '/home/cltbld', 05:26:53 INFO - 'LANG': 'en_US.UTF-8', 05:26:53 INFO - 'LANGUAGE': 'en_US:en', 05:26:53 INFO - 'LOGNAME': 'cltbld', 05:26:53 INFO - 'MAIL': '/var/mail/cltbld', 05:26:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:53 INFO - 'MOZ_NO_REMOTE': '1', 05:26:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:53 INFO - 'NO_EM_RESTART': '1', 05:26:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:53 INFO - 'PWD': '/builds/slave/test', 05:26:53 INFO - 'SHELL': '/bin/bash', 05:26:53 INFO - 'SHLVL': '1', 05:26:53 INFO - 'TERM': 'linux', 05:26:53 INFO - 'TMOUT': '86400', 05:26:53 INFO - 'USER': 'cltbld', 05:26:53 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1496837189.3640-988924461', 05:26:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:53 INFO - '_': '/tools/buildbot/bin/python'} 05:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:26:54 INFO - Cleaning up... 05:26:54 INFO - Return code: 0 05:26:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x260a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29889a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2986140>, '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 0x2986a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2986ed0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1496837189.3640-988924461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:26:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:26:54 INFO - Using env: {'DISPLAY': ':0', 05:26:54 INFO - 'HOME': '/home/cltbld', 05:26:54 INFO - 'LANG': 'en_US.UTF-8', 05:26:54 INFO - 'LANGUAGE': 'en_US:en', 05:26:54 INFO - 'LOGNAME': 'cltbld', 05:26:54 INFO - 'MAIL': '/var/mail/cltbld', 05:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:54 INFO - 'MOZ_NO_REMOTE': '1', 05:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:54 INFO - 'NO_EM_RESTART': '1', 05:26:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:54 INFO - 'PWD': '/builds/slave/test', 05:26:54 INFO - 'SHELL': '/bin/bash', 05:26:54 INFO - 'SHLVL': '1', 05:26:54 INFO - 'TERM': 'linux', 05:26:54 INFO - 'TMOUT': '86400', 05:26:54 INFO - 'USER': 'cltbld', 05:26:54 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1496837189.3640-988924461', 05:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:54 INFO - '_': '/tools/buildbot/bin/python'} 05:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:54 INFO - Downloading/unpacking psutil>=3.1.1 05:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:26:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:26:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:26:55 INFO - Installing collected packages: psutil 05:26:55 INFO - Running setup.py install for psutil 05:26:55 INFO - building 'psutil._psutil_linux' extension 05:26:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:26:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:26:55 INFO - building 'psutil._psutil_posix' extension 05:26:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:26:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:26:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:26:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:26:56 INFO - Successfully installed psutil 05:26:56 INFO - Cleaning up... 05:26:56 INFO - Return code: 0 05:26:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29889a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2986140>, '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 0x2986a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2986ed0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1496837189.3640-988924461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:26:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:26:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:26:56 INFO - Using env: {'DISPLAY': ':0', 05:26:56 INFO - 'HOME': '/home/cltbld', 05:26:56 INFO - 'LANG': 'en_US.UTF-8', 05:26:56 INFO - 'LANGUAGE': 'en_US:en', 05:26:56 INFO - 'LOGNAME': 'cltbld', 05:26:56 INFO - 'MAIL': '/var/mail/cltbld', 05:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:56 INFO - 'MOZ_NO_REMOTE': '1', 05:26:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:56 INFO - 'NO_EM_RESTART': '1', 05:26:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:56 INFO - 'PWD': '/builds/slave/test', 05:26:56 INFO - 'SHELL': '/bin/bash', 05:26:56 INFO - 'SHLVL': '1', 05:26:56 INFO - 'TERM': 'linux', 05:26:56 INFO - 'TMOUT': '86400', 05:26:56 INFO - 'USER': 'cltbld', 05:26:56 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1496837189.3640-988924461', 05:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:56 INFO - '_': '/tools/buildbot/bin/python'} 05:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:26:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:26:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:26:57 INFO - Installing collected packages: mozsystemmonitor 05:26:57 INFO - Running setup.py install for mozsystemmonitor 05:26:57 INFO - Successfully installed mozsystemmonitor 05:26:57 INFO - Cleaning up... 05:26:57 INFO - Return code: 0 05:26:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:57 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 0x260a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29889a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2986140>, '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 0x2986a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2986ed0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1496837189.3640-988924461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:26:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:26:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:26:57 INFO - Using env: {'DISPLAY': ':0', 05:26:57 INFO - 'HOME': '/home/cltbld', 05:26:57 INFO - 'LANG': 'en_US.UTF-8', 05:26:57 INFO - 'LANGUAGE': 'en_US:en', 05:26:57 INFO - 'LOGNAME': 'cltbld', 05:26:57 INFO - 'MAIL': '/var/mail/cltbld', 05:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:57 INFO - 'MOZ_NO_REMOTE': '1', 05:26:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:57 INFO - 'NO_EM_RESTART': '1', 05:26:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:57 INFO - 'PWD': '/builds/slave/test', 05:26:57 INFO - 'SHELL': '/bin/bash', 05:26:57 INFO - 'SHLVL': '1', 05:26:57 INFO - 'TERM': 'linux', 05:26:57 INFO - 'TMOUT': '86400', 05:26:57 INFO - 'USER': 'cltbld', 05:26:57 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1496837189.3640-988924461', 05:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:57 INFO - '_': '/tools/buildbot/bin/python'} 05:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:57 INFO - Downloading/unpacking jsonschema==2.5.1 05:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:26:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:59 INFO - Downloading functools32-3.2.3-2.tar.gz 05:26:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:26:59 INFO - warning: no files found matching '*.txt' 05:26:59 INFO - no previously-included directories found matching 'build' 05:26:59 INFO - no previously-included directories found matching 'dist' 05:26:59 INFO - no previously-included directories found matching '.git*' 05:26:59 INFO - Installing collected packages: jsonschema, functools32 05:26:59 INFO - Running setup.py install for functools32 05:26:59 INFO - warning: no files found matching '*.txt' 05:26:59 INFO - no previously-included directories found matching 'build' 05:26:59 INFO - no previously-included directories found matching 'dist' 05:26:59 INFO - no previously-included directories found matching '.git*' 05:26:59 INFO - Successfully installed jsonschema functools32 05:26:59 INFO - Cleaning up... 05:26:59 INFO - Return code: 0 05:26:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:59 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 0x260a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29889a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2986140>, '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 0x2986a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2986ed0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1496837189.3640-988924461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:26:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:26:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:26:59 INFO - Using env: {'DISPLAY': ':0', 05:26:59 INFO - 'HOME': '/home/cltbld', 05:26:59 INFO - 'LANG': 'en_US.UTF-8', 05:26:59 INFO - 'LANGUAGE': 'en_US:en', 05:26:59 INFO - 'LOGNAME': 'cltbld', 05:26:59 INFO - 'MAIL': '/var/mail/cltbld', 05:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:59 INFO - 'MOZ_NO_REMOTE': '1', 05:26:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:59 INFO - 'NO_EM_RESTART': '1', 05:26:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:59 INFO - 'PWD': '/builds/slave/test', 05:26:59 INFO - 'SHELL': '/bin/bash', 05:26:59 INFO - 'SHLVL': '1', 05:26:59 INFO - 'TERM': 'linux', 05:26:59 INFO - 'TMOUT': '86400', 05:26:59 INFO - 'USER': 'cltbld', 05:26:59 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1496837189.3640-988924461', 05:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:59 INFO - '_': '/tools/buildbot/bin/python'} 05:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:26:59 INFO - Cleaning up... 05:26:59 INFO - Return code: 0 05:26:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:59 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 0x260a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29889a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2986140>, '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 0x2986a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2986ed0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1496837189.3640-988924461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:26:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:26:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:26:59 INFO - Using env: {'DISPLAY': ':0', 05:26:59 INFO - 'HOME': '/home/cltbld', 05:26:59 INFO - 'LANG': 'en_US.UTF-8', 05:26:59 INFO - 'LANGUAGE': 'en_US:en', 05:26:59 INFO - 'LOGNAME': 'cltbld', 05:26:59 INFO - 'MAIL': '/var/mail/cltbld', 05:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:59 INFO - 'MOZ_NO_REMOTE': '1', 05:26:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:59 INFO - 'NO_EM_RESTART': '1', 05:26:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:59 INFO - 'PWD': '/builds/slave/test', 05:26:59 INFO - 'SHELL': '/bin/bash', 05:26:59 INFO - 'SHLVL': '1', 05:26:59 INFO - 'TERM': 'linux', 05:26:59 INFO - 'TMOUT': '86400', 05:26:59 INFO - 'USER': 'cltbld', 05:26:59 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1496837189.3640-988924461', 05:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:59 INFO - '_': '/tools/buildbot/bin/python'} 05:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:59 INFO - Downloading/unpacking blobuploader==1.2.4 05:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:00 INFO - Downloading blobuploader-1.2.4.tar.gz 05:27:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:27:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:27:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:01 INFO - Downloading docopt-0.6.1.tar.gz 05:27:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:27:01 INFO - Installing collected packages: blobuploader, requests, docopt 05:27:01 INFO - Running setup.py install for blobuploader 05:27:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:27:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:27:01 INFO - Running setup.py install for requests 05:27:01 INFO - Running setup.py install for docopt 05:27:01 INFO - Successfully installed blobuploader requests docopt 05:27:01 INFO - Cleaning up... 05:27:02 INFO - Return code: 0 05:27:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:02 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 0x260a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29889a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2986140>, '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 0x2986a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2986ed0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1496837189.3640-988924461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:27:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:27:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:27:02 INFO - Using env: {'DISPLAY': ':0', 05:27:02 INFO - 'HOME': '/home/cltbld', 05:27:02 INFO - 'LANG': 'en_US.UTF-8', 05:27:02 INFO - 'LANGUAGE': 'en_US:en', 05:27:02 INFO - 'LOGNAME': 'cltbld', 05:27:02 INFO - 'MAIL': '/var/mail/cltbld', 05:27:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:02 INFO - 'MOZ_NO_REMOTE': '1', 05:27:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:02 INFO - 'NO_EM_RESTART': '1', 05:27:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:02 INFO - 'PWD': '/builds/slave/test', 05:27:02 INFO - 'SHELL': '/bin/bash', 05:27:02 INFO - 'SHLVL': '1', 05:27:02 INFO - 'TERM': 'linux', 05:27:02 INFO - 'TMOUT': '86400', 05:27:02 INFO - 'USER': 'cltbld', 05:27:02 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1496837189.3640-988924461', 05:27:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:02 INFO - '_': '/tools/buildbot/bin/python'} 05:27:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:27:02 INFO - Running setup.py (path:/tmp/pip-d3ts4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:27:02 INFO - Running setup.py (path:/tmp/pip-ubisRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:27:02 INFO - Running setup.py (path:/tmp/pip-WTZ2VC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:27:02 INFO - Running setup.py (path:/tmp/pip-18ttnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:27:02 INFO - Running setup.py (path:/tmp/pip-BRlvso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:27:02 INFO - Running setup.py (path:/tmp/pip-Ith_Aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:27:02 INFO - Running setup.py (path:/tmp/pip-VupsuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:27:02 INFO - Running setup.py (path:/tmp/pip-UbXxzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:27:02 INFO - Running setup.py (path:/tmp/pip-Vlhs6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:27:02 INFO - Running setup.py (path:/tmp/pip-J7DM0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:27:02 INFO - Running setup.py (path:/tmp/pip-3BwWvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:27:03 INFO - Running setup.py (path:/tmp/pip-NfCUQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:27:03 INFO - Running setup.py (path:/tmp/pip-oWnPFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:27:03 INFO - Running setup.py (path:/tmp/pip-75zoio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:03 INFO - Running setup.py (path:/tmp/pip-jFe70J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:27:03 INFO - Running setup.py (path:/tmp/pip-6llxuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:27:03 INFO - Running setup.py (path:/tmp/pip-vqmDMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:27:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:27:03 INFO - Running setup.py install for manifestparser 05:27:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:27:03 INFO - Running setup.py install for mozcrash 05:27:03 INFO - Running setup.py install for mozdebug 05:27:03 INFO - Running setup.py install for mozdevice 05:27:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:27:03 INFO - Running setup.py install for mozfile 05:27:03 INFO - Running setup.py install for mozhttpd 05:27:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:27:04 INFO - Running setup.py install for mozinfo 05:27:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:27:04 INFO - Running setup.py install for mozInstall 05:27:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:27:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:27:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:27:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:27:04 INFO - Running setup.py install for mozleak 05:27:04 INFO - Running setup.py install for mozlog 05:27:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:27:04 INFO - Running setup.py install for moznetwork 05:27:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:27:04 INFO - Running setup.py install for mozprocess 05:27:04 INFO - Running setup.py install for mozprofile 05:27:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:27:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:27:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:27:04 INFO - Running setup.py install for mozrunner 05:27:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:27:04 INFO - Running setup.py install for mozscreenshot 05:27:05 INFO - Running setup.py install for moztest 05:27:05 INFO - Running setup.py install for mozversion 05:27:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:27:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:27:05 INFO - Cleaning up... 05:27:05 INFO - Return code: 0 05:27:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:05 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 0x260a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29889a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2986140>, '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 0x2986a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2986ed0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1496837189.3640-988924461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:27:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:27:05 INFO - Using env: {'DISPLAY': ':0', 05:27:05 INFO - 'HOME': '/home/cltbld', 05:27:05 INFO - 'LANG': 'en_US.UTF-8', 05:27:05 INFO - 'LANGUAGE': 'en_US:en', 05:27:05 INFO - 'LOGNAME': 'cltbld', 05:27:05 INFO - 'MAIL': '/var/mail/cltbld', 05:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:05 INFO - 'MOZ_NO_REMOTE': '1', 05:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:05 INFO - 'NO_EM_RESTART': '1', 05:27:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:05 INFO - 'PWD': '/builds/slave/test', 05:27:05 INFO - 'SHELL': '/bin/bash', 05:27:05 INFO - 'SHLVL': '1', 05:27:05 INFO - 'TERM': 'linux', 05:27:05 INFO - 'TMOUT': '86400', 05:27:05 INFO - 'USER': 'cltbld', 05:27:05 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1496837189.3640-988924461', 05:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:05 INFO - '_': '/tools/buildbot/bin/python'} 05:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:27:05 INFO - Running setup.py (path:/tmp/pip-CSviGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:27:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:27:05 INFO - Running setup.py (path:/tmp/pip-3e0XpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:27:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:27:05 INFO - Running setup.py (path:/tmp/pip-wpuXas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:27:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:27:05 INFO - Running setup.py (path:/tmp/pip-i2UeHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:27:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:27:05 INFO - Running setup.py (path:/tmp/pip-tYROht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:27:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:27:05 INFO - Running setup.py (path:/tmp/pip-YOfz_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:27:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:27:05 INFO - Running setup.py (path:/tmp/pip-8_kepk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:27:05 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)) 05:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:27:05 INFO - Running setup.py (path:/tmp/pip-Q3tAtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:27:06 INFO - Running setup.py (path:/tmp/pip-4221Kj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:27:06 INFO - Running setup.py (path:/tmp/pip-2SS1M3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:27:06 INFO - Running setup.py (path:/tmp/pip-aBLqaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:27:06 INFO - Running setup.py (path:/tmp/pip-9Gu9P9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:27:06 INFO - Running setup.py (path:/tmp/pip-ybEaWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:27:06 INFO - Running setup.py (path:/tmp/pip-nedagi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:06 INFO - Running setup.py (path:/tmp/pip-SDOTeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:27:06 INFO - Running setup.py (path:/tmp/pip-hhyUou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:27:06 INFO - Running setup.py (path:/tmp/pip-bUHq_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:27:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:07 INFO - Downloading blessings-1.6.tar.gz 05:27:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:27:07 INFO - Installing collected packages: blessings 05:27:07 INFO - Running setup.py install for blessings 05:27:07 INFO - Successfully installed blessings 05:27:07 INFO - Cleaning up... 05:27:07 INFO - Return code: 0 05:27:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:27:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:27:08 INFO - Reading from file tmpfile_stdout 05:27:08 INFO - Current package versions: 05:27:08 INFO - argparse == 1.2.1 05:27:08 INFO - blessings == 1.6 05:27:08 INFO - blobuploader == 1.2.4 05:27:08 INFO - docopt == 0.6.1 05:27:08 INFO - functools32 == 3.2.3-2 05:27:08 INFO - jsonschema == 2.5.1 05:27:08 INFO - manifestparser == 1.1 05:27:08 INFO - mozInstall == 1.12 05:27:08 INFO - mozcrash == 1.0 05:27:08 INFO - mozdebug == 0.1 05:27:08 INFO - mozdevice == 0.51 05:27:08 INFO - mozfile == 1.2 05:27:08 INFO - mozhttpd == 0.7 05:27:08 INFO - mozinfo == 0.10 05:27:08 INFO - mozleak == 0.1 05:27:08 INFO - mozlog == 3.4 05:27:08 INFO - moznetwork == 0.27 05:27:08 INFO - mozprocess == 0.25 05:27:08 INFO - mozprofile == 0.28 05:27:08 INFO - mozrunner == 6.13 05:27:08 INFO - mozscreenshot == 0.1 05:27:08 INFO - mozsystemmonitor == 0.3 05:27:08 INFO - moztest == 0.8 05:27:08 INFO - mozversion == 1.4 05:27:08 INFO - psutil == 3.1.1 05:27:08 INFO - requests == 1.2.3 05:27:08 INFO - wsgiref == 0.1.2 05:27:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:08 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 0x260a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29889a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2986140>, '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 0x2986a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2986ed0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1496837189.3640-988924461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:27:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:27:08 INFO - Using env: {'DISPLAY': ':0', 05:27:08 INFO - 'HOME': '/home/cltbld', 05:27:08 INFO - 'LANG': 'en_US.UTF-8', 05:27:08 INFO - 'LANGUAGE': 'en_US:en', 05:27:08 INFO - 'LOGNAME': 'cltbld', 05:27:08 INFO - 'MAIL': '/var/mail/cltbld', 05:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:08 INFO - 'MOZ_NO_REMOTE': '1', 05:27:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:08 INFO - 'NO_EM_RESTART': '1', 05:27:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:08 INFO - 'PWD': '/builds/slave/test', 05:27:08 INFO - 'SHELL': '/bin/bash', 05:27:08 INFO - 'SHLVL': '1', 05:27:08 INFO - 'TERM': 'linux', 05:27:08 INFO - 'TMOUT': '86400', 05:27:08 INFO - 'USER': 'cltbld', 05:27:08 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1496837189.3640-988924461', 05:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:08 INFO - '_': '/tools/buildbot/bin/python'} 05:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:27:08 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:09 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:27:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:27:09 INFO - Installing collected packages: marionette-driver 05:27:09 INFO - Running setup.py install for marionette-driver 05:27:09 INFO - Successfully installed marionette-driver 05:27:09 INFO - Cleaning up... 05:27:09 INFO - Return code: 0 05:27:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:27:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:09 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 0x260a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29889a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2986140>, '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 0x2986a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2986ed0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1496837189.3640-988924461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:27:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:27:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:27:09 INFO - Using env: {'DISPLAY': ':0', 05:27:09 INFO - 'HOME': '/home/cltbld', 05:27:09 INFO - 'LANG': 'en_US.UTF-8', 05:27:09 INFO - 'LANGUAGE': 'en_US:en', 05:27:09 INFO - 'LOGNAME': 'cltbld', 05:27:09 INFO - 'MAIL': '/var/mail/cltbld', 05:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:09 INFO - 'MOZ_NO_REMOTE': '1', 05:27:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:09 INFO - 'NO_EM_RESTART': '1', 05:27:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:09 INFO - 'PWD': '/builds/slave/test', 05:27:09 INFO - 'SHELL': '/bin/bash', 05:27:09 INFO - 'SHLVL': '1', 05:27:09 INFO - 'TERM': 'linux', 05:27:09 INFO - 'TMOUT': '86400', 05:27:09 INFO - 'USER': 'cltbld', 05:27:09 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1496837189.3640-988924461', 05:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:09 INFO - '_': '/tools/buildbot/bin/python'} 05:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:27:09 INFO - Cleaning up... 05:27:09 INFO - Return code: 0 05:27:09 INFO - Running post-action listener: _resource_record_post_action 05:27:09 INFO - Running post-action listener: _start_resource_monitoring 05:27:10 INFO - Starting resource monitoring. 05:27:10 INFO - [mozharness: 2017-06-07 12:27:10.013196Z] Finished create-virtualenv step (success) 05:27:10 INFO - [mozharness: 2017-06-07 12:27:10.013705Z] Running install step. 05:27:10 INFO - Running pre-action listener: _resource_record_pre_action 05:27:10 INFO - Running main action method: install 05:27:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:27:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:27:10 INFO - Reading from file tmpfile_stdout 05:27:10 INFO - Detecting whether we're running mozinstall >=1.0... 05:27:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:27:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:27:10 INFO - Reading from file tmpfile_stdout 05:27:10 INFO - Output received: 05:27:10 INFO - Usage: mozinstall [options] installer 05:27:10 INFO - Options: 05:27:10 INFO - -h, --help show this help message and exit 05:27:10 INFO - -d DEST, --destination=DEST 05:27:10 INFO - Directory to install application into. [default: 05:27:10 INFO - "/builds/slave/test"] 05:27:10 INFO - --app=APP Application being installed. [default: firefox] 05:27:10 INFO - mkdir: /builds/slave/test/build/application 05:27:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:27:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:27:27 INFO - Reading from file tmpfile_stdout 05:27:27 INFO - Output received: 05:27:27 INFO - /builds/slave/test/build/application/firefox/firefox 05:27:27 INFO - Running post-action listener: _resource_record_post_action 05:27:27 INFO - [mozharness: 2017-06-07 12:27:27.309297Z] Finished install step (success) 05:27:27 INFO - [mozharness: 2017-06-07 12:27:27.309580Z] Running setup-mitmproxy step. 05:27:27 INFO - Running pre-action listener: _resource_record_pre_action 05:27:27 INFO - Running main action method: setup_mitmproxy 05:27:27 INFO - Skipping: mitmproxy is not required 05:27:27 INFO - Running post-action listener: _resource_record_post_action 05:27:27 INFO - [mozharness: 2017-06-07 12:27:27.310716Z] Finished setup-mitmproxy step (success) 05:27:27 INFO - [mozharness: 2017-06-07 12:27:27.310936Z] Running run-tests step. 05:27:27 INFO - Running pre-action listener: _resource_record_pre_action 05:27:27 INFO - Running main action method: run_tests 05:27:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:27:27 INFO - Python 2.7.3 05:27:27 INFO - Return code: 0 05:27:27 INFO - grabbing minidump binary from tooltool 05:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:27 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 0x2986140>, '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 0x2986a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2986ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:27:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:27:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:27:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:27:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:27:27 INFO - Return code: 0 05:27:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:27:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:27:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:27:27 INFO - ENV: RUST_BACKTRACE is now 1 05:27:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:27:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:27:27 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/U6KszMJcRYqxSDY968A7nA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:27:27 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/U6KszMJcRYqxSDY968A7nA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:27:27 INFO - Using env: {'DISPLAY': ':0', 05:27:27 INFO - 'HOME': '/home/cltbld', 05:27:27 INFO - 'LANG': 'en_US.UTF-8', 05:27:27 INFO - 'LANGUAGE': 'en_US:en', 05:27:27 INFO - 'LOGNAME': 'cltbld', 05:27:27 INFO - 'MAIL': '/var/mail/cltbld', 05:27:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:27:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:27:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:27 INFO - 'MOZ_NO_REMOTE': '1', 05:27:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:27:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:27 INFO - 'NO_EM_RESTART': '1', 05:27:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:27 INFO - 'PWD': '/builds/slave/test', 05:27:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:27:27 INFO - 'RUST_BACKTRACE': '1', 05:27:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:27:27 INFO - 'SHELL': '/bin/bash', 05:27:27 INFO - 'SHLVL': '1', 05:27:27 INFO - 'TERM': 'linux', 05:27:27 INFO - 'TMOUT': '86400', 05:27:27 INFO - 'USER': 'cltbld', 05:27:27 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1496837189.3640-988924461', 05:27:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:27 INFO - '_': '/tools/buildbot/bin/python'} 05:27:27 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/U6KszMJcRYqxSDY968A7nA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:27:27 INFO - mozversion application_buildid: 20170607113307 05:27:27 INFO - mozversion application_changeset: f6320f91851c2cede08b0fb54a6d0525b870310e 05:27:27 INFO - mozversion application_display_name: Nightly 05:27:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:27:27 INFO - mozversion application_name: Firefox 05:27:27 INFO - mozversion application_remotingname: firefox 05:27:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:27:27 INFO - mozversion application_vendor: Mozilla 05:27:27 INFO - mozversion application_version: 55.0a1 05:27:27 INFO - mozversion platform_buildid: 20170607113307 05:27:27 INFO - mozversion platform_changeset: f6320f91851c2cede08b0fb54a6d0525b870310e 05:27:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:27:27 INFO - mozversion platform_version: 55.0a1 05:27:27 INFO - using testdate: 1496838447 05:27:27 INFO - actual date: 1496838447 05:27:27 INFO - starting webserver on 'localhost:57560' 05:27:27 INFO - SUITE-START | Running 2 tests 05:27:27 INFO - TEST-START | dromaeo_css 05:27:27 INFO - operating with platform_type : linux_ 05:27:27 INFO - Initialising browser for dromaeo_css test... 05:27:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57560/getInfo.html -profile /tmp/tmpGNbAGJ/profile 05:27:27 INFO - TEST-INFO | started process 509 (/builds/slave/test/build/application/firefox/firefox http://localhost:57560/getInfo.html) 05:28:02 INFO - TEST-INFO | 509: killed by SIGTERM 05:28:02 INFO - Browser initialized. 05:28:02 INFO - Running cycle 1/1 for dromaeo_css test... 05:28:02 INFO - TEST-INFO | started process 721 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGNbAGJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:28:14 INFO - PID 721 | RSS: Main: 183713792 05:28:14 INFO - PID 721 | 05:31:15 INFO - PID 721 | Cycle 1(1): loaded http://localhost:57560/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57560/tests/dromaeo/cssquery-ext.html) 05:31:16 INFO - PID 721 | RSS: Main: 180371456 05:31:16 INFO - PID 721 | 05:34:18 INFO - PID 721 | Cycle 1(1): loaded http://localhost:57560/tests/dromaeo/cssquery-ext.html (next: http://localhost:57560/tests/dromaeo/cssquery-jquery.html) 05:34:19 INFO - PID 721 | RSS: Main: 185188352 05:34:19 INFO - PID 721 | 05:37:20 INFO - PID 721 | Cycle 1(1): loaded http://localhost:57560/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57560/tests/dromaeo/cssquery-mootools.html) 05:37:21 INFO - PID 721 | RSS: Main: 183197696 05:37:21 INFO - PID 721 | 05:40:23 INFO - PID 721 | Cycle 1(1): loaded http://localhost:57560/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57560/tests/dromaeo/cssquery-prototype.html) 05:40:23 INFO - PID 721 | RSS: Main: 187944960 05:40:23 INFO - PID 721 | 05:43:26 INFO - PID 721 | Cycle 1(1): loaded http://localhost:57560/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57560/tests/dromaeo/cssquery-yui.html) 05:43:27 INFO - PID 721 | RSS: Main: 186966016 05:43:27 INFO - PID 721 | 05:46:28 INFO - PID 721 | Cycle 1(1): loaded http://localhost:57560/tests/dromaeo/cssquery-yui.html (next: http://localhost:57560/tests/dromaeo/cssquery-dojo.html) 05:46:29 INFO - PID 721 | RSS: Main: 187117568 05:46:29 INFO - PID 721 | 05:46:29 INFO - PID 721 | __start_tp_report 05:46:29 INFO - PID 721 | _x_x_mozilla_page_load 05:46:29 INFO - PID 721 | _x_x_mozilla_page_load_details 05:46:29 INFO - PID 721 | |i|pagename|runs| 05:46:29 INFO - PID 721 | |0;dojo.html;3056.465118604244;3060.9999999999995;3103.7827352085365;3120.828354440506;3126.7811253212285;5749.568782341331;5757.136429535562;5829.6502209867385;5957.136215248792;5963.910541341883;5725.055365864638;5760.423957604237;5828.970855145729;5854.092615644571;5870.61840980336;5316.627836051478;5374.865628359284;5407.5133238008575;5417.891642167155;5468.425815289397;5510.779568817243;5530.5022547970675;5541.944580554204;5555.2222688823595;5557.055300598908;5242.947570524322;5303.284056652341;5386.946130538723;5452.6455780374545;5463.535599474029;5268.710220937885;5275.841724748264;5309.867253318659;5323.414424413311;5340.786368545254;5294.285271488338;5320.840374788762;5343.679379237258;5348.384935732402;5359.624826262163;5672.574556908248;5756.079027355603;5764.971175144139;5780.855478613026;5787.623804452739;6261.27995280544;6321.336259692758;6327.873442531123;6357.396047375492;6370.585911915757;6333.7466501339895;6353.30113687494;6356.555041147121;6360.300366959631;6419.903701444482;5771.624844385102;5939.613925094855;5969.880602388015;5980.760769569256;5985.431384018511;6338.841528961812;6354.682265886687;6464.612123272619;6477.902831457532;6482.935170648328;6024.819255422344;6033.939660603338;6035.245594300713;6099.024156134997;6134.141220229171;6163.19878415812;6198.597091189058;6215;6291.716872740646;6330.018847078618;6253.093301471261;6303.527235457359;6317.747290108344;6352.968235158887;6358.77744278948;6081;6123.648682309606;6129.175413489998;6197.411245931629;6338.714757835908;5202.557782588522;5208.817691380784;5238.790448382022;5239.345081864767;5249.816256431007;4441.067375851043;4447.155040542287;4464.330350447459;4475.619572336323;4500.887477813016;5024.869404384058;5087.923681144785;5150.536451719363;5164.173732202829;5164.767585458663;6206.472449841814;6256.249250090018;6272.341404152589;6287.96856015717;6312.116303717483;5173.586113110942;5181.248718935733;5181.948180518222;5203.167493201146;5205.29728486657;5430.91853622196;5557.861053473695;5594.496495315359;5624.131040359616;5628.212050312959;6013.6692481913915;6125.632272693312;6196.845078873064;6223.564350495512;6261.467775238973;6370.426661600478;6390.5526613136635;6399.840003999937;6406.135171751754;6415.743370265323;6168.784092556739;6182.412670796267;6187.041008643668;6194.81415557534;6199.3490683477585;6066.332703402534;6133.969330153321;6171.475424588781;6242.531810114168;6275.937240627718;6341.492680585634;6343.936560634519;6347.5556711029785;6357.237131544244;6365.267994180728;6024.819255422344;6125.601835880653;6129.908051379144;6219.067139929047;6226.159468471698;5969.074793407029;6049.667268300285;6067.939320606737;6088.391160883876;6091;6004.909926351195;6046.425589568984;6047.455728984412;6049.78825741097;6090.665013424305;6123.877522449615;6130.2030736004035;6135.263768347827;6139.662318572521;6153.907691384543;5856.882862342814;5911.142884281841;5955.970220148872;5957.851053723692;6074.635521868702 05:46:29 INFO - PID 721 | |1;ext.html;633.9239291285044;684.5003147702178;701.5720410549566;1244.8381710377644;1299.6166130991357;37686.81156594217;38926.80536597313;38946.41580376293;39005.82982510522;39014;36769.264614707754;37029.07427314318;37141;37219.06952326187;37301.62698373015;6929.203141638713;7080.64596770162;7097.53865998711;7277.053982982205;7288.0525531680805;7182.281771822802;7319.780406587811;7320.304571065767;7324.194338622748;7334.779956601311;7290.380317673004;7330.523515971471;7344.559326440431;7346.449016323797;7358.816029599249;7251.601161936092;7274.781756547312;7290;7305.086864141982;7308.6711098000715;7232.312930271616;7260.237675044097;7278.745243916491;7290.59901705406;7314.378277846389;34916.65083349159;35091;35184.64815351839;35190.64809351899;35203.471947920545;3406.812625305607;3477.5826900771817;3482;3485.5468789057513;3488.773229740059;26967.730322696916;27112.45775084487;27120.32199195016;27178.32054198641;27427.862860685567;3205.3108581655056;3206.9358612827614;3221.1463962050075;3233.288676491168;3249.041532747845;129377;133948.33025834907;160660.19669901577;160910;161220;36910.63089369072;37121.25757484835;37140.81429592835;37213.813930930715;37248.255034899696;39285;39420.80289598534;39540.60459395369;50460;51642.483575163766;13408.798868016987;13544.661383465493;13603.863961360457;13613.11514751538;13634.590962271148;10720.303180293256;10913.072388847037;10941.4529273536;10969.396683182502;11014.559417623206;13853.238071906142;13889.861101389059;14027.85972140286;14038.578842634737;14053.78919316211;5777.740001699934;5778.913316300259;5819;5870.295564532284;5901.232839730807;999.5801763259303;1007.6674697349857;1010.0555980158429;1012.9392236465835;1019.0675531888387;21537.24619638305;22169.22407715722;22729;22833.771662283165;23557.7644223559;1093.1200383691046;1102.1472011915105;1105.7622611138643;1112.2158877990996;1143.8970492655535;11723.179377443668;12199.573014944433;12505.124641275024;12534.373281336078;12604.432800523999;206554;207005;207480;208243;208498;45527;46447.30329045067;46508.53491465042;46623;46641.5335846644;1390.3395886953615;1396.76255036644;1411.9294035298194;1416.2281556551704;1446.927653617315;21131.8943405282;21750.238741643967;23058.50359180011;23209.651855222524;23277;34731.30537389289;34879.82560087285;34904.12739681528;35098.64901350954;35237.11907202341;168959.15520422318;169670;169698;170190;170615;33364.49953250655;33660.66339336575;34065.31869362648;34147;34266.31467370688;40087.59912400955;40314.395284070175;40725;41147;41153.38269925894;29070;30572.388552228385;31099;31151.84424077865;31421.371572568878;30136;30166.698333017266;30303.242418939702;30427;31677;33243.833780830944;34656.306873862886;34760.13099672528;34775.65224347724;34957.82521087378;28584.57077146176;29243.41513169767;29978.25054373658;30580.847095765268;31160.53259201159;22064.558708826054;24453.755462445148;24542.754572454047;24592.65588363893;24658.753412465645 05:46:29 INFO - PID 721 | |2;jquery.html;402.11534623827566;415.5325259083531;417.9874603761887;425.4490434886822;429.9938144741305;19383.709244361347;20013.19947202112;20026.198952041937;22425;23242.070317187292;23092.307230783063;23689.407764805845;23691.644625330635;23693.052277908908;23708.5258294834;5649.49154576088;5796.536277097822;5813.854653633672;5825.825225243249;5831.970840145815;5818.912716309259;5898.056310990242;5909.970450147744;5913.349531551526;5935.821925342247;5685.744141513642;5725.425507985296;5772.624779389326;5777.826665200029;5809.854753631151;5717.171010203518;5734.4265573442735;5751.626144300607;5752.597318187729;5758.62568933018;5167;5168.689878607295;5190.117679994372;5228.633995620308;5231.2937753403185;25443.872780636164;25568.48863022748;25604;25746;25807;1756.130715295924;1763.2329936477672;1789.2574581548643;1827.8172182781748;1854.6754317994296;16735.91632041844;16783.160841957975;16917.49247522576;16938.153092345332;16941.237644306035;2143.8070573648292;2205.9558808823895;2207.0289072808073;2211.9447013824624;2212.8782916939563;108953.45523272413;113939;119794.40102799518;125043;128101;11598.826017609743;11697.532098716127;11740.647780566425;11881.930626243508;12130.150889437655;16671.583210419594;16818.411355602497;16835.242414091394;16850.32598696063;16856.915715421343;8907.73276801697;8979.191872731355;9077.863832042525;9120.81758364829;9220.815583688289;8876.245519130945;8963.596638151299;8991.14584114508;9102.362834601647;9111.04334044929;7724.8455030900195;7726.188750181263;7797.181295963842;7812.92187078122;8006.15935326794;1943.5724140689026;1969.7636283645768;1989.9801001989795;1991.2731852873596;2202.8237740981003;920.2545937790411;933.2347475070512;944.8535477001076;970.2529052629436;972.4359871274644;18582;18860.434186974413;18863.151158197914;19555;20527.4868128295;927.5408672706918;943.7593413679468;994.229472159068;1020.3010937507682;1022.381459217163;10183.083522483012;10348.534315955649;10966.396848173268;11454.541818327174;11489.138314626436;440756;440916;440931;444604;450804;98201;102478;102721.48639256756;103123;103137.48431257796;1147.9540818367173;1163.6101905861462;1216.4221994552693;1217.7077501399601;1220.3471142938486;18641;20545.58908821845;20897.686534701686;21114.15543378248;21148.894255528623;48205.75897120492;48780.756096219295;49209.50790492193;49299.50700493093;49361.012779744924;61114.38885611265;61394.69302653458;62047.6897615509;62386.68806655938;62751.37248627455;15844.68310633804;16243.431479898147;16349.509514714578;16368.672626547164;16454.34182632729;18120.093995299918;18154.54613634617;18319.908400457913;18384.448466546026;18429.72355414643;14743.778843317574;14809.33357998871;14853.925730371278;14893.47872824446;14989.175595342362;12788.680282992627;13099.148555343872;13430.19418834873;13447.798283025566;13564.93217533906;13913.165210087427;14412.567622971328;14672.119672819665;14913.701725965202;14918.627034324229;14609.707805843611;14691.853081469477;14700.77948830747;14804.185769782765;14824.62938426548;14555;14589.905757068474;14659.267036648338;14684.559463216121;14712.97009209345 05:46:29 INFO - PID 721 | |3;mootools.html;1292.7737645911964;1341.8725221103998;1348.1776116568897;1348.6156445413055;1350.5408161225187;10296.17630589553;10773.084287835523;10884.23810333277;10903.563857445703;11170.050545703605;10948.835767463494;11033.558657653704;11051.72370690733;11135.05352045077;11179.217454778169;2290.4731911660288;2322.63999080142;2338.6258198688215;2341.4146463384154;2346.5424242272766;2289.839711220215;2309.064828744353;2338.7193536775612;2340.578695834749;2341.95316093678;2236.932892013242;2241.1371621925514;2270.648049552322;2276.089564174327;2282.1441959265276;2192.75879653238;2216.2575537195057;2235.58641651295;2236.944076398087;2237.742659594151;1929.1318906491995;2000.5898790747863;2163.469949862294;2163.8485306028583;2240.675102110185;10894.782104357868;10954.616588419367;10966.506507207116;10976.176786741027;10992.395418251994;5806.477417032445;6019.789307374221;6032;6061.42416470439;6071.635701857903;3459.446488561818;3568.946465803015;3637.1089083174793;3643.5627724672945;3650.8357123929486;1184.6268425445958;1185.7035741064733;1195.07381779121;1211.3761412872377;1243.7263801963554;14042.36809343582;14053.227072511008;14142.575722728334;14185.787213191707;14217.85782142186;4872.537108974641;4923.507649235048;4994.725290109079;5086.872828179326;5091.847244582668;10994.780104398027;11027.283226590245;11032.779344413068;11079.944600277107;11143.944280278547;5611.2144299798065;5889.146073819358;5894.233749612608;5902.6458412495385;5913.408659134138;5397.73011349431;5493.148561972901;5508.614396992172;5514.255575497336;5518.806841760519;3854.5759966403675;3955.485786847749;3988.501437320335;4084.4281800547947;4086.244044851712;1114.8383484394717;1116.916231282657;1117.1453837814079;1125.555405614794;1131.3381671722134;812.4150611559668;846.4540371460373;847.4025811802665;853.5902766671908;874.9212570868525;5677.630953987978;5921.348651648315;5924.229850119457;5933.169356290123;6062.302835174011;506.3366989244102;513.9408967968657;539.9784008639689;544.4065968094795;546.5217934307481;3298.5217143514055;4266.445362102969;4467.955320446754;4514.909701805946;4648.302754586839;13013.414396352187;13586.456541738418;13589;13593.184408935496;13594.184348939096;12945.093843431057;13315.800262996063;13411.329433528284;13436.261005644588;13477.663058423617;8223.21879421454;8373.958130209432;8383.622736976851;8386.748397548083;8398.328133749286;6398.424141827258;6495.902561461677;6832.829179270558;6954.3393377629045;6959.582425054513;12185.756284874431;12422.937885310877;12434.067444941486;12447.190932589352;12516.561920332744;12435;12444.377781110727;12541.811872821732;12664;12683.492660293485;8394.11861754507;8583;8612.827743445221;8645.783855403664;8647.82704345897;9383;9500.667476638284;9759.170470510086;10078.445685487368;10142.847857282295;8623.611937462703;8626.051134375088;8647.264982476308;8672.78318042054;8891.644334226818;8346.332293416634;8350.749477515685;8396.790080248044;8427.62075706607;8507.447015943944;7674.961625191839;7782.377409807315;7786.727464538714;7795.376369890509;7904.960475197588;5119.257707632298;5784.363719990882;5825.79609713658;5900;6071.058985857199;5675.091985282335;5703.20155178267;5840.415958404125;5866.178734977192;6065.484433822998 05:46:29 INFO - PID 721 | |4;prototype.html;358.66464855360226;361.21075450141444;366.35155774279525;376.775818388059;382.40917782026764;6267.589792296731;6280;6303.086052522382;6340.809775706724;6355.237371515419;6105.572609917308;6112.908306375408;6136.969315153429;6142.969285153568;6150.815475535741;4518.367428559996;4665.6967297125575;4677.88305292367;4688.835890743825;4712.599429048535;4677.8830529236875;4705.011947491014;4707.505711900252;4713.670043096985;4723.622110231173;4602.746848923308;4622.537746225385;4635.791389387486;4638.55933686301;4643.2802915548145;4635.374224479686;4639.605633521155;4650.883727906812;4661.065657752063;4666.883327916796;4016.15660711251;4021.175658989929;4025.772139497452;4031.879043628696;4044.3326851069537;6064.484518815906;6067.75610999744;6076.665783381913;6078.498958442617;6079.483243924272;5338.91991620126;5345.144776835727;5348.973255133699;5359.5444387227135;5374.6237763356585;6447.903281450782;6480.4491618212505;6486.578372405778;6487.124238227826;6493.448056915168;4338.566143385668;4373.868783936487;4383.232934236496;4391.209582275221;4400.6259467945265;6416.871662566769;6741.224759152711;6813.911653008205;6815.693293801742;6880.58716477008;4488.259437192892;4503.392042074343;4508.684392092588;4515.412996310459;4521.050579378368;4546.772661366918;4547.2042392581825;4548.5906268436;4552.339910712994;4581.5647513486165;5155.175171972466;5274.129768588216;5318;5338.172583249602;5365.6244062916;6448.967755161194;6452.838679033061;6503.439174598157;6510.209692334551;6513.641749703717;1573.40210719928;1584.128729198959;1586.0008194837178;1589.173629712543;1592.33122088723;1010.3382284603597;1048.7692707604315;1051.7791263834526;1060.5015642647943;1069.8020866139789;5399.757010934517;5400.405955344909;5412.864678382994;5421.647592906448;5423.454315520058;6575.210974682973;6603.933960660428;6619.404253617101;6622.139121914121;6694.09629699994;5330.78772309495;5346.492083252085;5361.705106219118;5377.300950876439;5380.139177731622;3480.443129099332;3535.3106144301614;3557.3418917500344;3557.875474358385;3575.910602234913;6454.419102280724;6486.416222539994;6505;6529.216494020748;6560.639164845884;6813.148356455443;6835.658217089126;6835.863282734417;6838.521303508806;6891.655417229119;6435.710393032325;6455.709493072729;6463.159789227464;6537.70580323877;6559.212894452697;6652.700628471827;6666.266710661726;6668.866622667422;6673.099131617169;6680.164979377578;6580.374864387875;6589.4728421725185;6645.235797883305;6649.534532582673;6681.465482761465;6170.969145154246;6511.218653761579;6534.346565343428;6541.215054193527;6556.311587283267;4513.458384993691;4515.2549829277805;4524.343970124248;4530.139273538017;4534.727916325031;6582.124094633006;6721.327867213239;6740.404944096656;6768.578598494174;6788.524803263922;6517.631297427593;6538.411542961157;6546.607203567611;6546.901796473152;6564.5076619252795;6516.446102081376;6519.934800651933;6522.445592124723;6532.477401807749;6571.211454625475;6405.327440618668;6475.870482590416;6479.384458476437;6486.643234622141;6499.3175716549085;6565.737370505126;6572;6576.2766095728475;6594.505412094016;6620.3710647488415;6297.338779428277;6348.9047664286;6352.174217351715;6354.76082163992;6363.236411630634 05:46:29 INFO - PID 721 | |5;yui.html;829.1584042197175;850.6469815026765;852.4970267542153;857.9699710510133;867.522862425666;16607.16964151792;16832.915835420838;16895.155242237885;18384;19191.42425727227;16818.83181168188;17021.319147234128;17189.226484808183;17271.568210794736;17294.394696185635;967.274544091931;995.7908839143752;999.2605471950741;1000.194843151263;1000.324780772979;897.5512243878061;985.5909797434092;1013.5742987945081;1013.6553571785591;1014.7666036811538;1040.5941682743735;1042.8227201375785;1045.007243119036;1045.4877110216016;1046.4035499765098;1030.340582027503;1036.9896301036968;1038.0242571982312;1038.5534220285274;1038.8805287391895;765.1239330966013;765.1812560560203;769.0540635018958;769.8306372598075;769.9230076992312;16846.747298790528;16865.241064152142;17068.48794536166;17079.573010674834;17204.91397543017;17970.820291797176;18143.364982225557;18327.725084123747;18399.35602253928;18430.815691843043;14156.433742650283;14356.353964071643;14383.065100768521;14411.495597654137;14416.63958401038;3328.983355083233;3415.077928959167;3423.9315213695836;3428.4857271409237;3433.073070271013;88215.55892220497;90623.54688226583;90912.09087909169;90959.54520227357;92351;14019.71960560783;14620.707585848224;14645.853541464661;14709.852901471062;14788.630284242765;21546.353609391743;21664;24956.625650615257;25446.618300725502;25684.871575642002;7543.660535275926;7763.573003484863;7981.441299109007;7986.361091112697;8086.555239461768;3551.911202219965;3622.058264851105;3630.9818450908106;3652.433872749728;3652.4886515887265;3967.1867267210155;4071.4707088078953;4102.979485102555;4105.261053010487;4709.081729062868;875.2123089219754;886.9733907982642;891.4027601506876;891.839468895605;892.7991201979632;671.7447369999369;676.4926305271047;681.6148875885109;693.143967200507;696.2967402923084;9919.60852848663;10372.481375931173;10844.376980587129;10917.617883374203;11398.772024559463;643.9517036222209;650.1418128070901;673.7035704290097;689.6034780001519;691.0843132848895;4404.911901761947;4870.951290487121;4881.048195601895;5047.772850221749;5144.6913185209005;80941.59529202316;82818.58590707008;82882;84981.15018849733;85621;69233.65383173153;70119.94820077703;70928.64535677392;72314.63842680753;73390.26609733941;63473.36526634767;63888.36111638917;64289.35710642927;64521.67739161368;68562.65718671375;9787.119159275699;10433.373997560171;10553.683389498327;10600.522976465923;10700.143988480748;29631.555526666685;29991.70008299889;30172.24569385783;30614.693853061184;31144.844275778476;36967.81516092402;37572;37818;38322.808385959004;38652;14372.640683982983;14406.20765857846;14976;15010.099394036393;15128.167950762374;16091.919540402692;16403.83596164023;16724.080175590458;16833.41083062087;17312.48062558125;15167.544973650809;15349.07905525672;15371.538853834403;15435;15610.765838512205;14879.181645009628;15245.695086098438;15647.217639118226;15693;15942.760858586898;15088.094714317176;15629.374825006873;15711.764323534928;15994.12032338186;16017.038977661377;9695.757606059622;9856.359336643096;10001.949990250003;10121.848172277274;10326.741831454274;11456.828147577626;11607.361595112012;11839.940800295943;11858.40707964581;12273.386330683608 05:46:29 INFO - PID 721 | __end_tp_report 05:46:29 INFO - PID 721 | __start_cc_report 05:46:29 INFO - PID 721 | _x_x_mozilla_cycle_collect,384 05:46:29 INFO - PID 721 | __end_cc_report 05:46:29 INFO - PID 721 | __startTimestamp1496839589185__endTimestamp 05:46:29 INFO - PID 721 | 05:46:29 INFO - PID 721 | ------- Summary: start ------- 05:46:29 INFO - PID 721 | Number of tests: 6 05:46:29 INFO - PID 721 | 05:46:29 INFO - PID 721 | [#0] dojo.html Cycles:165 Average:5779.89 Median:6024.82 stddev:668.17 (11.1%) stddev-sans-first:635.15 05:46:29 INFO - PID 721 | Values: 3056.5 3061.0 3103.8 3120.8 3126.8 5749.6 5757.1 5829.7 5957.1 5963.9 5725.1 5760.4 5829.0 5854.1 5870.6 5316.6 5374.9 5407.5 5417.9 5468.4 5510.8 5530.5 5541.9 5555.2 5557.1 5242.9 5303.3 5386.9 5452.6 5463.5 5268.7 5275.8 5309.9 5323.4 5340.8 5294.3 5320.8 5343.7 5348.4 5359.6 5672.6 5756.1 5765.0 5780.9 5787.6 6261.3 6321.3 6327.9 6357.4 6370.6 6333.7 6353.3 6356.6 6360.3 6419.9 5771.6 5939.6 5969.9 5980.8 5985.4 6338.8 6354.7 6464.6 6477.9 6482.9 6024.8 6033.9 6035.2 6099.0 6134.1 6163.2 6198.6 6215.0 6291.7 6330.0 6253.1 6303.5 6317.7 6353.0 6358.8 6081.0 6123.6 6129.2 6197.4 6338.7 5202.6 5208.8 5238.8 5239.3 5249.8 4441.1 4447.2 4464.3 4475.6 4500.9 5024.9 5087.9 5150.5 5164.2 5164.8 6206.5 6256.2 6272.3 6288.0 6312.1 5173.6 5181.2 5181.9 5203.2 5205.3 5430.9 5557.9 5594.5 5624.1 5628.2 6013.7 6125.6 6196.8 6223.6 6261.5 6370.4 6390.6 6399.8 6406.1 6415.7 6168.8 6182.4 6187.0 6194.8 6199.3 6066.3 6134.0 6171.5 6242.5 6275.9 6341.5 6343.9 6347.6 6357.2 6365.3 6024.8 6125.6 6129.9 6219.1 6226.2 5969.1 6049.7 6067.9 6088.4 6091.0 6004.9 6046.4 6047.5 6049.8 6090.7 6123.9 6130.2 6135.3 6139.7 6153.9 5856.9 5911.1 5956.0 5957.9 6074.6 05:46:29 INFO - PID 721 | 05:46:29 INFO - PID 721 | [#1] ext.html Cycles:180 Average:33348.71 Median:18246.44 stddev:45851.77 (251.3%) stddev-sans-first:45914.59 05:46:29 INFO - PID 721 | Values: 633.9 684.5 701.6 1244.8 1299.6 37686.8 38926.8 38946.4 39005.8 39014.0 36769.3 37029.1 37141.0 37219.1 37301.6 6929.2 7080.6 7097.5 7277.1 7288.1 7182.3 7319.8 7320.3 7324.2 7334.8 7290.4 7330.5 7344.6 7346.4 7358.8 7251.6 7274.8 7290.0 7305.1 7308.7 7232.3 7260.2 7278.7 7290.6 7314.4 34916.7 35091.0 35184.6 35190.6 35203.5 3406.8 3477.6 3482.0 3485.5 3488.8 26967.7 27112.5 27120.3 27178.3 27427.9 3205.3 3206.9 3221.1 3233.3 3249.0 129377.0 133948.3 160660.2 160910.0 161220.0 36910.6 37121.3 37140.8 37213.8 37248.3 39285.0 39420.8 39540.6 50460.0 51642.5 13408.8 13544.7 13603.9 13613.1 13634.6 10720.3 10913.1 10941.5 10969.4 11014.6 13853.2 13889.9 14027.9 14038.6 14053.8 5777.7 5778.9 5819.0 5870.3 5901.2 999.6 1007.7 1010.1 1012.9 1019.1 21537.2 22169.2 22729.0 22833.8 23557.8 1093.1 1102.1 1105.8 1112.2 1143.9 11723.2 12199.6 12505.1 12534.4 12604.4 206554.0 207005.0 207480.0 208243.0 208498.0 45527.0 46447.3 46508.5 46623.0 46641.5 1390.3 1396.8 1411.9 1416.2 1446.9 21131.9 21750.2 23058.5 23209.7 23277.0 34731.3 34879.8 34904.1 35098.6 35237.1 168959.2 169670.0 169698.0 170190.0 170615.0 33364.5 33660.7 34065.3 34147.0 34266.3 40087.6 40314.4 40725.0 41147.0 41153.4 29070.0 30572.4 31099.0 31151.8 31421.4 30136.0 30166.7 30303.2 30427.0 31677.0 33243.8 34656.3 34760.1 34775.7 34957.8 28584.6 29243.4 29978.3 30580.8 31160.5 22064.6 24453.8 24542.8 24592.7 24658.8 05:46:29 INFO - PID 721 | 05:46:29 INFO - PID 721 | [#2] jquery.html Cycles:180 Average:30898.76 Median:21005.92 stddev:74485.31 (354.6%) stddev-sans-first:74659.07 05:46:29 INFO - PID 721 | Values: 402.1 415.5 418.0 425.4 430.0 19383.7 20013.2 20026.2 22425.0 23242.1 23092.3 23689.4 23691.6 23693.1 23708.5 5649.5 5796.5 5813.9 5825.8 5832.0 5818.9 5898.1 5910.0 5913.3 5935.8 5685.7 5725.4 5772.6 5777.8 5809.9 5717.2 5734.4 5751.6 5752.6 5758.6 5167.0 5168.7 5190.1 5228.6 5231.3 25443.9 25568.5 25604.0 25746.0 25807.0 1756.1 1763.2 1789.3 1827.8 1854.7 16735.9 16783.2 16917.5 16938.2 16941.2 2143.8 2206.0 2207.0 2211.9 2212.9 108953.5 113939.0 119794.4 125043.0 128101.0 11598.8 11697.5 11740.6 11881.9 12130.2 16671.6 16818.4 16835.2 16850.3 16856.9 8907.7 8979.2 9077.9 9120.8 9220.8 8876.2 8963.6 8991.1 9102.4 9111.0 7724.8 7726.2 7797.2 7812.9 8006.2 1943.6 1969.8 1990.0 1991.3 2202.8 920.3 933.2 944.9 970.3 972.4 18582.0 18860.4 18863.2 19555.0 20527.5 927.5 943.8 994.2 1020.3 1022.4 10183.1 10348.5 10966.4 11454.5 11489.1 440756.0 440916.0 440931.0 444604.0 450804.0 98201.0 102478.0 102721.5 103123.0 103137.5 1148.0 1163.6 1216.4 1217.7 1220.3 18641.0 20545.6 20897.7 21114.2 21148.9 48205.8 48780.8 49209.5 49299.5 49361.0 61114.4 61394.7 62047.7 62386.7 62751.4 15844.7 16243.4 16349.5 16368.7 16454.3 18120.1 18154.5 18319.9 18384.4 18429.7 14743.8 14809.3 14853.9 14893.5 14989.2 12788.7 13099.1 13430.2 13447.8 13564.9 13913.2 14412.6 14672.1 14913.7 14918.6 14609.7 14691.9 14700.8 14804.2 14824.6 14555.0 14589.9 14659.3 14684.6 14713.0 05:46:29 INFO - PID 721 | 05:46:29 INFO - PID 721 | [#3] mootools.html Cycles:180 Average:6554.91 Median:3640.34 stddev:4097.52 (112.6%) stddev-sans-first:4089.93 05:46:29 INFO - PID 721 | Values: 1292.8 1341.9 1348.2 1348.6 1350.5 10296.2 10773.1 10884.2 10903.6 11170.1 10948.8 11033.6 11051.7 11135.1 11179.2 2290.5 2322.6 2338.6 2341.4 2346.5 2289.8 2309.1 2338.7 2340.6 2342.0 2236.9 2241.1 2270.6 2276.1 2282.1 2192.8 2216.3 2235.6 2236.9 2237.7 1929.1 2000.6 2163.5 2163.8 2240.7 10894.8 10954.6 10966.5 10976.2 10992.4 5806.5 6019.8 6032.0 6061.4 6071.6 3459.4 3568.9 3637.1 3643.6 3650.8 1184.6 1185.7 1195.1 1211.4 1243.7 14042.4 14053.2 14142.6 14185.8 14217.9 4872.5 4923.5 4994.7 5086.9 5091.8 10994.8 11027.3 11032.8 11079.9 11143.9 5611.2 5889.1 5894.2 5902.6 5913.4 5397.7 5493.1 5508.6 5514.3 5518.8 3854.6 3955.5 3988.5 4084.4 4086.2 1114.8 1116.9 1117.1 1125.6 1131.3 812.4 846.5 847.4 853.6 874.9 5677.6 5921.3 5924.2 5933.2 6062.3 506.3 513.9 540.0 544.4 546.5 3298.5 4266.4 4468.0 4514.9 4648.3 13013.4 13586.5 13589.0 13593.2 13594.2 12945.1 13315.8 13411.3 13436.3 13477.7 8223.2 8374.0 8383.6 8386.7 8398.3 6398.4 6495.9 6832.8 6954.3 6959.6 12185.8 12422.9 12434.1 12447.2 12516.6 12435.0 12444.4 12541.8 12664.0 12683.5 8394.1 8583.0 8612.8 8645.8 8647.8 9383.0 9500.7 9759.2 10078.4 10142.8 8623.6 8626.1 8647.3 8672.8 8891.6 8346.3 8350.7 8396.8 8427.6 8507.4 7675.0 7782.4 7786.7 7795.4 7905.0 5119.3 5784.4 5825.8 5900.0 6071.1 5675.1 5703.2 5840.4 5866.2 6065.5 05:46:29 INFO - PID 721 | 05:46:29 INFO - PID 721 | [#4] prototype.html Cycles:180 Average:5339.34 Median:6109.24 stddev:1616.70 (26.5%) stddev-sans-first:1577.43 05:46:29 INFO - PID 721 | Values: 358.7 361.2 366.4 376.8 382.4 6267.6 6280.0 6303.1 6340.8 6355.2 6105.6 6112.9 6137.0 6143.0 6150.8 4518.4 4665.7 4677.9 4688.8 4712.6 4677.9 4705.0 4707.5 4713.7 4723.6 4602.7 4622.5 4635.8 4638.6 4643.3 4635.4 4639.6 4650.9 4661.1 4666.9 4016.2 4021.2 4025.8 4031.9 4044.3 6064.5 6067.8 6076.7 6078.5 6079.5 5338.9 5345.1 5349.0 5359.5 5374.6 6447.9 6480.4 6486.6 6487.1 6493.4 4338.6 4373.9 4383.2 4391.2 4400.6 6416.9 6741.2 6813.9 6815.7 6880.6 4488.3 4503.4 4508.7 4515.4 4521.1 4546.8 4547.2 4548.6 4552.3 4581.6 5155.2 5274.1 5318.0 5338.2 5365.6 6449.0 6452.8 6503.4 6510.2 6513.6 1573.4 1584.1 1586.0 1589.2 1592.3 1010.3 1048.8 1051.8 1060.5 1069.8 5399.8 5400.4 5412.9 5421.6 5423.5 6575.2 6603.9 6619.4 6622.1 6694.1 5330.8 5346.5 5361.7 5377.3 5380.1 3480.4 3535.3 3557.3 3557.9 3575.9 6454.4 6486.4 6505.0 6529.2 6560.6 6813.1 6835.7 6835.9 6838.5 6891.7 6435.7 6455.7 6463.2 6537.7 6559.2 6652.7 6666.3 6668.9 6673.1 6680.2 6580.4 6589.5 6645.2 6649.5 6681.5 6171.0 6511.2 6534.3 6541.2 6556.3 4513.5 4515.3 4524.3 4530.1 4534.7 6582.1 6721.3 6740.4 6768.6 6788.5 6517.6 6538.4 6546.6 6546.9 6564.5 6516.4 6519.9 6522.4 6532.5 6571.2 6405.3 6475.9 6479.4 6486.6 6499.3 6565.7 6572.0 6576.3 6594.5 6620.4 6297.3 6348.9 6352.2 6354.8 6363.2 05:46:29 INFO - PID 721 | 05:46:29 INFO - PID 721 | [#5] yui.html Cycles:180 Average:18164.30 Median:27658.21 stddev:23025.98 (83.3%) stddev-sans-first:23053.78 05:46:29 INFO - PID 721 | Values: 829.2 850.6 852.5 858.0 867.5 16607.2 16832.9 16895.2 18384.0 19191.4 16818.8 17021.3 17189.2 17271.6 17294.4 967.3 995.8 999.3 1000.2 1000.3 897.6 985.6 1013.6 1013.7 1014.8 1040.6 1042.8 1045.0 1045.5 1046.4 1030.3 1037.0 1038.0 1038.6 1038.9 765.1 765.2 769.1 769.8 769.9 16846.7 16865.2 17068.5 17079.6 17204.9 17970.8 18143.4 18327.7 18399.4 18430.8 14156.4 14356.4 14383.1 14411.5 14416.6 3329.0 3415.1 3423.9 3428.5 3433.1 88215.6 90623.5 90912.1 90959.5 92351.0 14019.7 14620.7 14645.9 14709.9 14788.6 21546.4 21664.0 24956.6 25446.6 25684.9 7543.7 7763.6 7981.4 7986.4 8086.6 3551.9 3622.1 3631.0 3652.4 3652.5 3967.2 4071.5 4103.0 4105.3 4709.1 875.2 887.0 891.4 891.8 892.8 671.7 676.5 681.6 693.1 696.3 9919.6 10372.5 10844.4 10917.6 11398.8 644.0 650.1 673.7 689.6 691.1 4404.9 4871.0 4881.0 5047.8 5144.7 80941.6 82818.6 82882.0 84981.2 85621.0 69233.7 70119.9 70928.6 72314.6 73390.3 63473.4 63888.4 64289.4 64521.7 68562.7 9787.1 10433.4 10553.7 10600.5 10700.1 29631.6 29991.7 30172.2 30614.7 31144.8 36967.8 37572.0 37818.0 38322.8 38652.0 14372.6 14406.2 14976.0 15010.1 15128.2 16091.9 16403.8 16724.1 16833.4 17312.5 15167.5 15349.1 15371.5 15435.0 15610.8 14879.2 15245.7 15647.2 15693.0 15942.8 15088.1 15629.4 15711.8 15994.1 16017.0 9695.8 9856.4 10001.9 10121.8 10326.7 11456.8 11607.4 11839.9 11858.4 12273.4 05:46:29 INFO - PID 721 | -------- Summary: end -------- 05:46:29 INFO - PID 721 | 05:46:30 INFO - TEST-INFO | 721: exit 0 05:46:30 INFO - TEST-OK | dromaeo_css | took 1142500ms 05:46:30 INFO - TEST-START | kraken 05:46:30 INFO - operating with platform_type : linux_ 05:46:30 INFO - Initialising browser for kraken test... 05:46:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57560/getInfo.html -profile /tmp/tmpgHe43n/profile 05:46:30 INFO - TEST-INFO | started process 1210 (/builds/slave/test/build/application/firefox/firefox http://localhost:57560/getInfo.html) 05:47:05 INFO - TEST-INFO | 1210: killed by SIGTERM 05:47:05 INFO - Browser initialized. 05:47:05 INFO - Running cycle 1/1 for kraken test... 05:47:05 INFO - TEST-INFO | started process 1429 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgHe43n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:47:17 INFO - PID 1429 | RSS: Main: 183861248 05:47:17 INFO - PID 1429 | 05:47:19 INFO - PID 1429 | Cycle 1(1): loaded http://localhost:57560/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57560/tests/kraken/driver.html?testName=audio-beat-detection) 05:47:20 INFO - PID 1429 | RSS: Main: 188653568 05:47:20 INFO - PID 1429 | 05:47:23 INFO - PID 1429 | Cycle 1(1): loaded http://localhost:57560/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57560/tests/kraken/driver.html?testName=audio-dft) 05:47:23 INFO - PID 1429 | RSS: Main: 187592704 05:47:23 INFO - PID 1429 | 05:47:26 INFO - PID 1429 | Cycle 1(1): loaded http://localhost:57560/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57560/tests/kraken/driver.html?testName=audio-fft) 05:47:27 INFO - PID 1429 | RSS: Main: 183234560 05:47:27 INFO - PID 1429 | 05:47:29 INFO - PID 1429 | Cycle 1(1): loaded http://localhost:57560/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57560/tests/kraken/driver.html?testName=audio-oscillator) 05:47:30 INFO - PID 1429 | RSS: Main: 184467456 05:47:30 INFO - PID 1429 | 05:47:32 INFO - PID 1429 | Cycle 1(1): loaded http://localhost:57560/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57560/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:47:32 INFO - PID 1429 | RSS: Main: 184451072 05:47:32 INFO - PID 1429 | 05:47:35 INFO - PID 1429 | Cycle 1(1): loaded http://localhost:57560/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57560/tests/kraken/driver.html?testName=imaging-darkroom) 05:47:36 INFO - PID 1429 | RSS: Main: 185548800 05:47:36 INFO - PID 1429 | 05:47:39 INFO - PID 1429 | Cycle 1(1): loaded http://localhost:57560/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57560/tests/kraken/driver.html?testName=imaging-desaturate) 05:47:40 INFO - PID 1429 | RSS: Main: 184729600 05:47:40 INFO - PID 1429 | 05:47:43 INFO - PID 1429 | Cycle 1(1): loaded http://localhost:57560/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57560/tests/kraken/driver.html?testName=json-parse-financial) 05:47:44 INFO - PID 1429 | RSS: Main: 185548800 05:47:44 INFO - PID 1429 | 05:47:45 INFO - PID 1429 | Cycle 1(1): loaded http://localhost:57560/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57560/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:47:46 INFO - PID 1429 | RSS: Main: 185647104 05:47:46 INFO - PID 1429 | 05:47:48 INFO - PID 1429 | Cycle 1(1): loaded http://localhost:57560/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57560/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:47:48 INFO - PID 1429 | RSS: Main: 185544704 05:47:48 INFO - PID 1429 | 05:47:50 INFO - PID 1429 | Cycle 1(1): loaded http://localhost:57560/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57560/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:47:51 INFO - PID 1429 | RSS: Main: 186343424 05:47:51 INFO - PID 1429 | 05:47:54 INFO - PID 1429 | Cycle 1(1): loaded http://localhost:57560/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57560/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:47:54 INFO - PID 1429 | RSS: Main: 184991744 05:47:54 INFO - PID 1429 | 05:47:57 INFO - PID 1429 | Cycle 1(1): loaded http://localhost:57560/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57560/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:47:58 INFO - PID 1429 | RSS: Main: 185868288 05:47:58 INFO - PID 1429 | 05:48:00 INFO - PID 1429 | Cycle 1(1): loaded http://localhost:57560/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57560/tests/kraken/driver.html?testName=ai-astar) 05:48:00 INFO - PID 1429 | RSS: Main: 186888192 05:48:00 INFO - PID 1429 | 05:48:00 INFO - PID 1429 | __start_tp_report 05:48:00 INFO - PID 1429 | _x_x_mozilla_page_load 05:48:00 INFO - PID 1429 | _x_x_mozilla_page_load_details 05:48:00 INFO - PID 1429 | |i|pagename|runs| 05:48:00 INFO - PID 1429 | |0;ai-astar;100;109;111;109;110;110;112;111;110;110 05:48:00 INFO - PID 1429 | |1;audio-beat-detection;148;121;123;167;121;121;123;124;143;121 05:48:00 INFO - PID 1429 | |2;audio-dft;163;166;163;163;163;164;167;170;166;166 05:48:00 INFO - PID 1429 | |3;audio-fft;74;73;75;110;75;77;81;76;98;75 05:48:00 INFO - PID 1429 | |4;audio-oscillator;90;84;108;87;83;86;100;84;89;101 05:48:00 INFO - PID 1429 | |5;imaging-gaussian-blur;117;118;115;115;113;113;114;113;113;115 05:48:00 INFO - PID 1429 | |6;imaging-darkroom;150;150;151;151;151;152;151;150;149;151 05:48:00 INFO - PID 1429 | |7;imaging-desaturate;95;95;94;95;95;94;99;96;100;96 05:48:00 INFO - PID 1429 | |8;json-parse-financial;52;52;56;54;57;54;54;53;54;54 05:48:00 INFO - PID 1429 | |9;json-stringify-tinderbox;56;57;56;55;55;55;58;56;57;55 05:48:00 INFO - PID 1429 | |10;stanford-crypto-aes;86;96;86;84;85;82;86;83;106;84 05:48:00 INFO - PID 1429 | |11;stanford-crypto-ccm;138;137;141;139;128;136;134;130;135;139 05:48:00 INFO - PID 1429 | |12;stanford-crypto-pbkdf2;194;198;187;190;191;188;198;188;182;187 05:48:00 INFO - PID 1429 | |13;stanford-crypto-sha256-iterative;74;72;72;73;71;84;72;71;69;76 05:48:00 INFO - PID 1429 | __end_tp_report 05:48:00 INFO - PID 1429 | __start_cc_report 05:48:00 INFO - PID 1429 | _x_x_mozilla_cycle_collect,982 05:48:00 INFO - PID 1429 | __end_cc_report 05:48:00 INFO - PID 1429 | __startTimestamp1496839680653__endTimestamp 05:48:00 INFO - PID 1429 | 05:48:00 INFO - PID 1429 | ------- Summary: start ------- 05:48:00 INFO - PID 1429 | Number of tests: 14 05:48:00 INFO - PID 1429 | 05:48:00 INFO - PID 1429 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:3.36 (3.1%) stddev-sans-first:0.97 05:48:00 INFO - PID 1429 | Values: 100.0 109.0 111.0 109.0 110.0 110.0 112.0 111.0 110.0 110.0 05:48:00 INFO - PID 1429 | 05:48:00 INFO - PID 1429 | [#1] audio-beat-detection Cycles:10 Average:131.20 Median:123.50 stddev:16.01 (13.0%) stddev-sans-first:15.78 05:48:00 INFO - PID 1429 | Values: 148.0 121.0 123.0 167.0 121.0 121.0 123.0 124.0 143.0 121.0 05:48:00 INFO - PID 1429 | 05:48:00 INFO - PID 1429 | [#2] audio-dft Cycles:10 Average:165.10 Median:166.00 stddev:2.33 (1.4%) stddev-sans-first:2.35 05:48:00 INFO - PID 1429 | Values: 163.0 166.0 163.0 163.0 163.0 164.0 167.0 170.0 166.0 166.0 05:48:00 INFO - PID 1429 | 05:48:00 INFO - PID 1429 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.50 stddev:12.43 (16.5%) stddev-sans-first:12.89 05:48:00 INFO - PID 1429 | Values: 74.0 73.0 75.0 110.0 75.0 77.0 81.0 76.0 98.0 75.0 05:48:00 INFO - PID 1429 | 05:48:00 INFO - PID 1429 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:85.00 stddev:8.68 (10.2%) stddev-sans-first:9.19 05:48:00 INFO - PID 1429 | Values: 90.0 84.0 108.0 87.0 83.0 86.0 100.0 84.0 89.0 101.0 05:48:00 INFO - PID 1429 | 05:48:00 INFO - PID 1429 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:115.00 stddev:1.78 (1.5%) stddev-sans-first:1.66 05:48:00 INFO - PID 1429 | Values: 117.0 118.0 115.0 115.0 113.0 113.0 114.0 113.0 113.0 115.0 05:48:00 INFO - PID 1429 | 05:48:00 INFO - PID 1429 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.84 (0.6%) stddev-sans-first:0.87 05:48:00 INFO - PID 1429 | Values: 150.0 150.0 151.0 151.0 151.0 152.0 151.0 150.0 149.0 151.0 05:48:00 INFO - PID 1429 | 05:48:00 INFO - PID 1429 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.00 stddev:2.02 (2.1%) stddev-sans-first:2.12 05:48:00 INFO - PID 1429 | Values: 95.0 95.0 94.0 95.0 95.0 94.0 99.0 96.0 100.0 96.0 05:48:00 INFO - PID 1429 | 05:48:00 INFO - PID 1429 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:1.56 (2.9%) stddev-sans-first:1.48 05:48:00 INFO - PID 1429 | Values: 52.0 52.0 56.0 54.0 57.0 54.0 54.0 53.0 54.0 54.0 05:48:00 INFO - PID 1429 | 05:48:00 INFO - PID 1429 | [#9] json-stringify-tinderbox Cycles:10 Average:56.00 Median:56.00 stddev:1.05 (1.9%) stddev-sans-first:1.12 05:48:00 INFO - PID 1429 | Values: 56.0 57.0 56.0 55.0 55.0 55.0 58.0 56.0 57.0 55.0 05:48:00 INFO - PID 1429 | 05:48:00 INFO - PID 1429 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:85.50 stddev:7.47 (8.7%) stddev-sans-first:7.89 05:48:00 INFO - PID 1429 | Values: 86.0 96.0 86.0 84.0 85.0 82.0 86.0 83.0 106.0 84.0 05:48:00 INFO - PID 1429 | 05:48:00 INFO - PID 1429 | [#11] stanford-crypto-ccm Cycles:10 Average:135.70 Median:137.50 stddev:4.11 (3.0%) stddev-sans-first:4.28 05:48:00 INFO - PID 1429 | Values: 138.0 137.0 141.0 139.0 128.0 136.0 134.0 130.0 135.0 139.0 05:48:00 INFO - PID 1429 | 05:48:00 INFO - PID 1429 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.30 Median:190.50 stddev:5.10 (2.7%) stddev-sans-first:5.23 05:48:00 INFO - PID 1429 | Values: 194.0 198.0 187.0 190.0 191.0 188.0 198.0 188.0 182.0 187.0 05:48:00 INFO - PID 1429 | 05:48:00 INFO - PID 1429 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:72.50 stddev:4.17 (5.7%) stddev-sans-first:4.42 05:48:00 INFO - PID 1429 | Values: 74.0 72.0 72.0 73.0 71.0 84.0 72.0 71.0 69.0 76.0 05:48:00 INFO - PID 1429 | -------- Summary: end -------- 05:48:00 INFO - PID 1429 | 05:48:01 INFO - TEST-INFO | 1429: exit 0 05:48:01 INFO - TEST-OK | kraken | took 91772ms 05:48:01 INFO - SUITE-END | took 1234s 05:48:02 INFO - Completed test suite (00:20:34) 05:48:02 INFO - javascript benchmark 05:48:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7496.865052080875, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3056.465118604244, 3060.9999999999995, 3103.7827352085365, 3120.828354440506, 3126.7811253212285, 5749.568782341331, 5757.136429535562, 5829.6502209867385, 5957.136215248792, 5963.910541341883, 5725.055365864638, 5760.423957604237, 5828.970855145729, 5854.092615644571, 5870.61840980336, 5316.627836051478, 5374.865628359284, 5407.5133238008575, 5417.891642167155, 5468.425815289397, 5510.779568817243, 5530.5022547970675, 5541.944580554204, 5555.2222688823595, 5557.055300598908, 5242.947570524322, 5303.284056652341, 5386.946130538723, 5452.6455780374545, 5463.535599474029, 5268.710220937885, 5275.841724748264, 5309.867253318659, 5323.414424413311, 5340.786368545254, 5294.285271488338, 5320.840374788762, 5343.679379237258, 5348.384935732402, 5359.624826262163, 5672.574556908248, 5756.079027355603, 5764.971175144139, 5780.855478613026, 5787.623804452739, 6261.27995280544, 6321.336259692758, 6327.873442531123, 6357.396047375492, 6370.585911915757, 6333.7466501339895, 6353.30113687494, 6356.555041147121, 6360.300366959631, 6419.903701444482, 5771.624844385102, 5939.613925094855, 5969.880602388015, 5980.760769569256, 5985.431384018511, 6338.841528961812, 6354.682265886687, 6464.612123272619, 6477.902831457532, 6482.935170648328, 6024.819255422344, 6033.939660603338, 6035.245594300713, 6099.024156134997, 6134.141220229171, 6163.19878415812, 6198.597091189058, 6215.0, 6291.716872740646, 6330.018847078618, 6253.093301471261, 6303.527235457359, 6317.747290108344, 6352.968235158887, 6358.77744278948, 6081.0, 6123.648682309606, 6129.175413489998, 6197.411245931629, 6338.714757835908, 5202.557782588522, 5208.817691380784, 5238.790448382022, 5239.345081864767, 5249.816256431007, 4441.067375851043, 4447.155040542287, 4464.330350447459, 4475.619572336323, 4500.887477813016, 5024.869404384058, 5087.923681144785, 5150.536451719363, 5164.173732202829, 5164.767585458663, 6206.472449841814, 6256.249250090018, 6272.341404152589, 6287.96856015717, 6312.116303717483, 5173.586113110942, 5181.248718935733, 5181.948180518222, 5203.167493201146, 5205.29728486657, 5430.91853622196, 5557.861053473695, 5594.496495315359, 5624.131040359616, 5628.212050312959, 6013.6692481913915, 6125.632272693312, 6196.845078873064, 6223.564350495512, 6261.467775238973, 6370.426661600478, 6390.5526613136635, 6399.840003999937, 6406.135171751754, 6415.743370265323, 6168.784092556739, 6182.412670796267, 6187.041008643668, 6194.81415557534, 6199.3490683477585, 6066.332703402534, 6133.969330153321, 6171.475424588781, 6242.531810114168, 6275.937240627718, 6341.492680585634, 6343.936560634519, 6347.5556711029785, 6357.237131544244, 6365.267994180728, 6024.819255422344, 6125.601835880653, 6129.908051379144, 6219.067139929047, 6226.159468471698, 5969.074793407029, 6049.667268300285, 6067.939320606737, 6088.391160883876, 6091.0, 6004.909926351195, 6046.425589568984, 6047.455728984412, 6049.78825741097, 6090.665013424305, 6123.877522449615, 6130.2030736004035, 6135.263768347827, 6139.662318572521, 6153.907691384543, 5856.882862342814, 5911.142884281841, 5955.970220148872, 5957.851053723692, 6074.635521868702], "value": 5732.161808713458, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.9239291285044, 684.5003147702178, 701.5720410549566, 1244.8381710377644, 1299.6166130991357, 37686.81156594217, 38926.80536597313, 38946.41580376293, 39005.82982510522, 39014.0, 36769.264614707754, 37029.07427314318, 37141.0, 37219.06952326187, 37301.62698373015, 6929.203141638713, 7080.64596770162, 7097.53865998711, 7277.053982982205, 7288.0525531680805, 7182.281771822802, 7319.780406587811, 7320.304571065767, 7324.194338622748, 7334.779956601311, 7290.380317673004, 7330.523515971471, 7344.559326440431, 7346.449016323797, 7358.816029599249, 7251.601161936092, 7274.781756547312, 7290.0, 7305.086864141982, 7308.6711098000715, 7232.312930271616, 7260.237675044097, 7278.745243916491, 7290.59901705406, 7314.378277846389, 34916.65083349159, 35091.0, 35184.64815351839, 35190.64809351899, 35203.471947920545, 3406.812625305607, 3477.5826900771817, 3482.0, 3485.5468789057513, 3488.773229740059, 26967.730322696916, 27112.45775084487, 27120.32199195016, 27178.32054198641, 27427.862860685567, 3205.3108581655056, 3206.9358612827614, 3221.1463962050075, 3233.288676491168, 3249.041532747845, 129377.0, 133948.33025834907, 160660.19669901577, 160910.0, 161220.0, 36910.63089369072, 37121.25757484835, 37140.81429592835, 37213.813930930715, 37248.255034899696, 39285.0, 39420.80289598534, 39540.60459395369, 50460.0, 51642.483575163766, 13408.798868016987, 13544.661383465493, 13603.863961360457, 13613.11514751538, 13634.590962271148, 10720.303180293256, 10913.072388847037, 10941.4529273536, 10969.396683182502, 11014.559417623206, 13853.238071906142, 13889.861101389059, 14027.85972140286, 14038.578842634737, 14053.78919316211, 5777.740001699934, 5778.913316300259, 5819.0, 5870.295564532284, 5901.232839730807, 999.5801763259303, 1007.6674697349857, 1010.0555980158429, 1012.9392236465835, 1019.0675531888387, 21537.24619638305, 22169.22407715722, 22729.0, 22833.771662283165, 23557.7644223559, 1093.1200383691046, 1102.1472011915105, 1105.7622611138643, 1112.2158877990996, 1143.8970492655535, 11723.179377443668, 12199.573014944433, 12505.124641275024, 12534.373281336078, 12604.432800523999, 206554.0, 207005.0, 207480.0, 208243.0, 208498.0, 45527.0, 46447.30329045067, 46508.53491465042, 46623.0, 46641.5335846644, 1390.3395886953615, 1396.76255036644, 1411.9294035298194, 1416.2281556551704, 1446.927653617315, 21131.8943405282, 21750.238741643967, 23058.50359180011, 23209.651855222524, 23277.0, 34731.30537389289, 34879.82560087285, 34904.12739681528, 35098.64901350954, 35237.11907202341, 168959.15520422318, 169670.0, 169698.0, 170190.0, 170615.0, 33364.49953250655, 33660.66339336575, 34065.31869362648, 34147.0, 34266.31467370688, 40087.59912400955, 40314.395284070175, 40725.0, 41147.0, 41153.38269925894, 29070.0, 30572.388552228385, 31099.0, 31151.84424077865, 31421.371572568878, 30136.0, 30166.698333017266, 30303.242418939702, 30427.0, 31677.0, 33243.833780830944, 34656.306873862886, 34760.13099672528, 34775.65224347724, 34957.82521087378, 28584.57077146176, 29243.41513169767, 29978.25054373658, 30580.847095765268, 31160.53259201159, 22064.558708826054, 24453.755462445148, 24542.754572454047, 24592.65588363893, 24658.753412465645], "value": 15829.23011472209, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.11534623827566, 415.5325259083531, 417.9874603761887, 425.4490434886822, 429.9938144741305, 19383.709244361347, 20013.19947202112, 20026.198952041937, 22425.0, 23242.070317187292, 23092.307230783063, 23689.407764805845, 23691.644625330635, 23693.052277908908, 23708.5258294834, 5649.49154576088, 5796.536277097822, 5813.854653633672, 5825.825225243249, 5831.970840145815, 5818.912716309259, 5898.056310990242, 5909.970450147744, 5913.349531551526, 5935.821925342247, 5685.744141513642, 5725.425507985296, 5772.624779389326, 5777.826665200029, 5809.854753631151, 5717.171010203518, 5734.4265573442735, 5751.626144300607, 5752.597318187729, 5758.62568933018, 5167.0, 5168.689878607295, 5190.117679994372, 5228.633995620308, 5231.2937753403185, 25443.872780636164, 25568.48863022748, 25604.0, 25746.0, 25807.0, 1756.130715295924, 1763.2329936477672, 1789.2574581548643, 1827.8172182781748, 1854.6754317994296, 16735.91632041844, 16783.160841957975, 16917.49247522576, 16938.153092345332, 16941.237644306035, 2143.8070573648292, 2205.9558808823895, 2207.0289072808073, 2211.9447013824624, 2212.8782916939563, 108953.45523272413, 113939.0, 119794.40102799518, 125043.0, 128101.0, 11598.826017609743, 11697.532098716127, 11740.647780566425, 11881.930626243508, 12130.150889437655, 16671.583210419594, 16818.411355602497, 16835.242414091394, 16850.32598696063, 16856.915715421343, 8907.73276801697, 8979.191872731355, 9077.863832042525, 9120.81758364829, 9220.815583688289, 8876.245519130945, 8963.596638151299, 8991.14584114508, 9102.362834601647, 9111.04334044929, 7724.8455030900195, 7726.188750181263, 7797.181295963842, 7812.92187078122, 8006.15935326794, 1943.5724140689026, 1969.7636283645768, 1989.9801001989795, 1991.2731852873596, 2202.8237740981003, 920.2545937790411, 933.2347475070512, 944.8535477001076, 970.2529052629436, 972.4359871274644, 18582.0, 18860.434186974413, 18863.151158197914, 19555.0, 20527.4868128295, 927.5408672706918, 943.7593413679468, 994.229472159068, 1020.3010937507682, 1022.381459217163, 10183.083522483012, 10348.534315955649, 10966.396848173268, 11454.541818327174, 11489.138314626436, 440756.0, 440916.0, 440931.0, 444604.0, 450804.0, 98201.0, 102478.0, 102721.48639256756, 103123.0, 103137.48431257796, 1147.9540818367173, 1163.6101905861462, 1216.4221994552693, 1217.7077501399601, 1220.3471142938486, 18641.0, 20545.58908821845, 20897.686534701686, 21114.15543378248, 21148.894255528623, 48205.75897120492, 48780.756096219295, 49209.50790492193, 49299.50700493093, 49361.012779744924, 61114.38885611265, 61394.69302653458, 62047.6897615509, 62386.68806655938, 62751.37248627455, 15844.68310633804, 16243.431479898147, 16349.509514714578, 16368.672626547164, 16454.34182632729, 18120.093995299918, 18154.54613634617, 18319.908400457913, 18384.448466546026, 18429.72355414643, 14743.778843317574, 14809.33357998871, 14853.925730371278, 14893.47872824446, 14989.175595342362, 12788.680282992627, 13099.148555343872, 13430.19418834873, 13447.798283025566, 13564.93217533906, 13913.165210087427, 14412.567622971328, 14672.119672819665, 14913.701725965202, 14918.627034324229, 14609.707805843611, 14691.853081469477, 14700.77948830747, 14804.185769782765, 14824.62938426548, 14555.0, 14589.905757068474, 14659.267036648338, 14684.559463216121, 14712.97009209345], "value": 10581.109194165263, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1292.7737645911964, 1341.8725221103998, 1348.1776116568897, 1348.6156445413055, 1350.5408161225187, 10296.17630589553, 10773.084287835523, 10884.23810333277, 10903.563857445703, 11170.050545703605, 10948.835767463494, 11033.558657653704, 11051.72370690733, 11135.05352045077, 11179.217454778169, 2290.4731911660288, 2322.63999080142, 2338.6258198688215, 2341.4146463384154, 2346.5424242272766, 2289.839711220215, 2309.064828744353, 2338.7193536775612, 2340.578695834749, 2341.95316093678, 2236.932892013242, 2241.1371621925514, 2270.648049552322, 2276.089564174327, 2282.1441959265276, 2192.75879653238, 2216.2575537195057, 2235.58641651295, 2236.944076398087, 2237.742659594151, 1929.1318906491995, 2000.5898790747863, 2163.469949862294, 2163.8485306028583, 2240.675102110185, 10894.782104357868, 10954.616588419367, 10966.506507207116, 10976.176786741027, 10992.395418251994, 5806.477417032445, 6019.789307374221, 6032.0, 6061.42416470439, 6071.635701857903, 3459.446488561818, 3568.946465803015, 3637.1089083174793, 3643.5627724672945, 3650.8357123929486, 1184.6268425445958, 1185.7035741064733, 1195.07381779121, 1211.3761412872377, 1243.7263801963554, 14042.36809343582, 14053.227072511008, 14142.575722728334, 14185.787213191707, 14217.85782142186, 4872.537108974641, 4923.507649235048, 4994.725290109079, 5086.872828179326, 5091.847244582668, 10994.780104398027, 11027.283226590245, 11032.779344413068, 11079.944600277107, 11143.944280278547, 5611.2144299798065, 5889.146073819358, 5894.233749612608, 5902.6458412495385, 5913.408659134138, 5397.73011349431, 5493.148561972901, 5508.614396992172, 5514.255575497336, 5518.806841760519, 3854.5759966403675, 3955.485786847749, 3988.501437320335, 4084.4281800547947, 4086.244044851712, 1114.8383484394717, 1116.916231282657, 1117.1453837814079, 1125.555405614794, 1131.3381671722134, 812.4150611559668, 846.4540371460373, 847.4025811802665, 853.5902766671908, 874.9212570868525, 5677.630953987978, 5921.348651648315, 5924.229850119457, 5933.169356290123, 6062.302835174011, 506.3366989244102, 513.9408967968657, 539.9784008639689, 544.4065968094795, 546.5217934307481, 3298.5217143514055, 4266.445362102969, 4467.955320446754, 4514.909701805946, 4648.302754586839, 13013.414396352187, 13586.456541738418, 13589.0, 13593.184408935496, 13594.184348939096, 12945.093843431057, 13315.800262996063, 13411.329433528284, 13436.261005644588, 13477.663058423617, 8223.21879421454, 8373.958130209432, 8383.622736976851, 8386.748397548083, 8398.328133749286, 6398.424141827258, 6495.902561461677, 6832.829179270558, 6954.3393377629045, 6959.582425054513, 12185.756284874431, 12422.937885310877, 12434.067444941486, 12447.190932589352, 12516.561920332744, 12435.0, 12444.377781110727, 12541.811872821732, 12664.0, 12683.492660293485, 8394.11861754507, 8583.0, 8612.827743445221, 8645.783855403664, 8647.82704345897, 9383.0, 9500.667476638284, 9759.170470510086, 10078.445685487368, 10142.847857282295, 8623.611937462703, 8626.051134375088, 8647.264982476308, 8672.78318042054, 8891.644334226818, 8346.332293416634, 8350.749477515685, 8396.790080248044, 8427.62075706607, 8507.447015943944, 7674.961625191839, 7782.377409807315, 7786.727464538714, 7795.376369890509, 7904.960475197588, 5119.257707632298, 5784.363719990882, 5825.79609713658, 5900.0, 6071.058985857199, 5675.091985282335, 5703.20155178267, 5840.415958404125, 5866.178734977192, 6065.484433822998], "value": 4921.292973375954, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.66464855360226, 361.21075450141444, 366.35155774279525, 376.775818388059, 382.40917782026764, 6267.589792296731, 6280.0, 6303.086052522382, 6340.809775706724, 6355.237371515419, 6105.572609917308, 6112.908306375408, 6136.969315153429, 6142.969285153568, 6150.815475535741, 4518.367428559996, 4665.6967297125575, 4677.88305292367, 4688.835890743825, 4712.599429048535, 4677.8830529236875, 4705.011947491014, 4707.505711900252, 4713.670043096985, 4723.622110231173, 4602.746848923308, 4622.537746225385, 4635.791389387486, 4638.55933686301, 4643.2802915548145, 4635.374224479686, 4639.605633521155, 4650.883727906812, 4661.065657752063, 4666.883327916796, 4016.15660711251, 4021.175658989929, 4025.772139497452, 4031.879043628696, 4044.3326851069537, 6064.484518815906, 6067.75610999744, 6076.665783381913, 6078.498958442617, 6079.483243924272, 5338.91991620126, 5345.144776835727, 5348.973255133699, 5359.5444387227135, 5374.6237763356585, 6447.903281450782, 6480.4491618212505, 6486.578372405778, 6487.124238227826, 6493.448056915168, 4338.566143385668, 4373.868783936487, 4383.232934236496, 4391.209582275221, 4400.6259467945265, 6416.871662566769, 6741.224759152711, 6813.911653008205, 6815.693293801742, 6880.58716477008, 4488.259437192892, 4503.392042074343, 4508.684392092588, 4515.412996310459, 4521.050579378368, 4546.772661366918, 4547.2042392581825, 4548.5906268436, 4552.339910712994, 4581.5647513486165, 5155.175171972466, 5274.129768588216, 5318.0, 5338.172583249602, 5365.6244062916, 6448.967755161194, 6452.838679033061, 6503.439174598157, 6510.209692334551, 6513.641749703717, 1573.40210719928, 1584.128729198959, 1586.0008194837178, 1589.173629712543, 1592.33122088723, 1010.3382284603597, 1048.7692707604315, 1051.7791263834526, 1060.5015642647943, 1069.8020866139789, 5399.757010934517, 5400.405955344909, 5412.864678382994, 5421.647592906448, 5423.454315520058, 6575.210974682973, 6603.933960660428, 6619.404253617101, 6622.139121914121, 6694.09629699994, 5330.78772309495, 5346.492083252085, 5361.705106219118, 5377.300950876439, 5380.139177731622, 3480.443129099332, 3535.3106144301614, 3557.3418917500344, 3557.875474358385, 3575.910602234913, 6454.419102280724, 6486.416222539994, 6505.0, 6529.216494020748, 6560.639164845884, 6813.148356455443, 6835.658217089126, 6835.863282734417, 6838.521303508806, 6891.655417229119, 6435.710393032325, 6455.709493072729, 6463.159789227464, 6537.70580323877, 6559.212894452697, 6652.700628471827, 6666.266710661726, 6668.866622667422, 6673.099131617169, 6680.164979377578, 6580.374864387875, 6589.4728421725185, 6645.235797883305, 6649.534532582673, 6681.465482761465, 6170.969145154246, 6511.218653761579, 6534.346565343428, 6541.215054193527, 6556.311587283267, 4513.458384993691, 4515.2549829277805, 4524.343970124248, 4530.139273538017, 4534.727916325031, 6582.124094633006, 6721.327867213239, 6740.404944096656, 6768.578598494174, 6788.524803263922, 6517.631297427593, 6538.411542961157, 6546.607203567611, 6546.901796473152, 6564.5076619252795, 6516.446102081376, 6519.934800651933, 6522.445592124723, 6532.477401807749, 6571.211454625475, 6405.327440618668, 6475.870482590416, 6479.384458476437, 6486.643234622141, 6499.3175716549085, 6565.737370505126, 6572.0, 6576.2766095728475, 6594.505412094016, 6620.3710647488415, 6297.338779428277, 6348.9047664286, 6352.174217351715, 6354.76082163992, 6363.236411630634], "value": 4820.243438868122, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [829.1584042197175, 850.6469815026765, 852.4970267542153, 857.9699710510133, 867.522862425666, 16607.16964151792, 16832.915835420838, 16895.155242237885, 18384.0, 19191.42425727227, 16818.83181168188, 17021.319147234128, 17189.226484808183, 17271.568210794736, 17294.394696185635, 967.274544091931, 995.7908839143752, 999.2605471950741, 1000.194843151263, 1000.324780772979, 897.5512243878061, 985.5909797434092, 1013.5742987945081, 1013.6553571785591, 1014.7666036811538, 1040.5941682743735, 1042.8227201375785, 1045.007243119036, 1045.4877110216016, 1046.4035499765098, 1030.340582027503, 1036.9896301036968, 1038.0242571982312, 1038.5534220285274, 1038.8805287391895, 765.1239330966013, 765.1812560560203, 769.0540635018958, 769.8306372598075, 769.9230076992312, 16846.747298790528, 16865.241064152142, 17068.48794536166, 17079.573010674834, 17204.91397543017, 17970.820291797176, 18143.364982225557, 18327.725084123747, 18399.35602253928, 18430.815691843043, 14156.433742650283, 14356.353964071643, 14383.065100768521, 14411.495597654137, 14416.63958401038, 3328.983355083233, 3415.077928959167, 3423.9315213695836, 3428.4857271409237, 3433.073070271013, 88215.55892220497, 90623.54688226583, 90912.09087909169, 90959.54520227357, 92351.0, 14019.71960560783, 14620.707585848224, 14645.853541464661, 14709.852901471062, 14788.630284242765, 21546.353609391743, 21664.0, 24956.625650615257, 25446.618300725502, 25684.871575642002, 7543.660535275926, 7763.573003484863, 7981.441299109007, 7986.361091112697, 8086.555239461768, 3551.911202219965, 3622.058264851105, 3630.9818450908106, 3652.433872749728, 3652.4886515887265, 3967.1867267210155, 4071.4707088078953, 4102.979485102555, 4105.261053010487, 4709.081729062868, 875.2123089219754, 886.9733907982642, 891.4027601506876, 891.839468895605, 892.7991201979632, 671.7447369999369, 676.4926305271047, 681.6148875885109, 693.143967200507, 696.2967402923084, 9919.60852848663, 10372.481375931173, 10844.376980587129, 10917.617883374203, 11398.772024559463, 643.9517036222209, 650.1418128070901, 673.7035704290097, 689.6034780001519, 691.0843132848895, 4404.911901761947, 4870.951290487121, 4881.048195601895, 5047.772850221749, 5144.6913185209005, 80941.59529202316, 82818.58590707008, 82882.0, 84981.15018849733, 85621.0, 69233.65383173153, 70119.94820077703, 70928.64535677392, 72314.63842680753, 73390.26609733941, 63473.36526634767, 63888.36111638917, 64289.35710642927, 64521.67739161368, 68562.65718671375, 9787.119159275699, 10433.373997560171, 10553.683389498327, 10600.522976465923, 10700.143988480748, 29631.555526666685, 29991.70008299889, 30172.24569385783, 30614.693853061184, 31144.844275778476, 36967.81516092402, 37572.0, 37818.0, 38322.808385959004, 38652.0, 14372.640683982983, 14406.20765857846, 14976.0, 15010.099394036393, 15128.167950762374, 16091.919540402692, 16403.83596164023, 16724.080175590458, 16833.41083062087, 17312.48062558125, 15167.544973650809, 15349.07905525672, 15371.538853834403, 15435.0, 15610.765838512205, 14879.181645009628, 15245.695086098438, 15647.217639118226, 15693.0, 15942.760858586898, 15088.094714317176, 15629.374825006873, 15711.764323534928, 15994.12032338186, 16017.038977661377, 9695.757606059622, 9856.359336643096, 10001.949990250003, 10121.848172277274, 10326.741831454274, 11456.828147577626, 11607.361595112012, 11839.940800295943, 11858.40707964581, 12273.386330683608], "value": 7794.527933134386, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 109.0, 111.0, 109.0, 110.0, 110.0, 112.0, 111.0, 110.0, 110.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 121.0, 123.0, 167.0, 121.0, 121.0, 123.0, 124.0, 143.0, 121.0], "value": 131.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 163.0, 163.0, 163.0, 164.0, 167.0, 170.0, 166.0, 166.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 75.0, 110.0, 75.0, 77.0, 81.0, 76.0, 98.0, 75.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 84.0, 108.0, 87.0, 83.0, 86.0, 100.0, 84.0, 89.0, 101.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 115.0, 115.0, 113.0, 113.0, 114.0, 113.0, 113.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 151.0, 151.0, 152.0, 151.0, 150.0, 149.0, 151.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 99.0, 96.0, 100.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 56.0, 54.0, 57.0, 54.0, 54.0, 53.0, 54.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 55.0, 55.0, 55.0, 58.0, 56.0, 57.0, 55.0], "value": 56.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 96.0, 86.0, 84.0, 85.0, 82.0, 86.0, 83.0, 106.0, 84.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 141.0, 139.0, 128.0, 136.0, 134.0, 130.0, 135.0, 139.0], "value": 135.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 198.0, 187.0, 190.0, 191.0, 188.0, 198.0, 188.0, 182.0, 187.0], "value": 190.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 72.0, 73.0, 71.0, 84.0, 72.0, 71.0, 69.0, 76.0], "value": 73.4, "unit": "score"}]}]} 05:48:02 INFO - Return code: 0 05:48:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:48:02 INFO - # TBPL SUCCESS # 05:48:02 INFO - Running post-action listener: _resource_record_post_action 05:48:02 INFO - [mozharness: 2017-06-07 12:48:02.524481Z] Finished run-tests step (success) 05:48:02 INFO - Running post-run listener: _resource_record_post_run 05:48:02 INFO - Total resource usage - Wall time: 1252s; CPU: 13.0%; Read bytes: 4096; Write bytes: 425283584; Read time: 12; Write time: 218880 05:48:02 INFO - TinderboxPrint: CPU usage
12.6% 05:48:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:48:02 INFO - TinderboxPrint: I/O write bytes / time
425,283,584 / 218,880 05:48:02 INFO - TinderboxPrint: CPU idle
8,731.1 (87.4%) 05:48:02 INFO - TinderboxPrint: CPU user
1,208.5 (12.1%) 05:48:02 INFO - TinderboxPrint: Swap in / out
0 / 0 05:48:02 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 101666816; Read time: 0; Write time: 66168 05:48:02 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:48:02 INFO - run-tests - Wall time: 1235s; CPU: 13.0%; Read bytes: 0; Write bytes: 323219456; Read time: 0; Write time: 152672 05:48:03 INFO - Running post-run listener: _upload_blobber_files 05:48:03 INFO - Blob upload gear active. 05:48:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:48:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:48:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:48:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:48:03 INFO - (blobuploader) - INFO - Open directory for files ... 05:48:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:48:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:48:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:48:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:48:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:48:04 INFO - (blobuploader) - INFO - Done attempting. 05:48:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:48:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:48:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:48:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:48:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:48:05 INFO - (blobuploader) - INFO - Done attempting. 05:48:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:48:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:48:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:48:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:48:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:48:10 INFO - (blobuploader) - INFO - Done attempting. 05:48:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:48:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:48:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:48:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:48:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:48:11 INFO - (blobuploader) - INFO - Done attempting. 05:48:11 INFO - (blobuploader) - INFO - Iteration through files over. 05:48:11 INFO - Return code: 0 05:48:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:48:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:48:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/209ba4f7a41e26365806c6760602317b180916b03c2c0b46c08c0347610fef01ec476c802fcb9a19b444e344d91913bafae017956f80ed0915a38e01b09708e9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c39ea7a2a0b371ae0db445c011e47f8353469c74c35308a0b00944974b16df790e369be32a41d4e86ef33852a007792359a947cc377728a3d2f7459e3c465121", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f58d9fb56059975d05225a5d4cc0790baedca50165271fc326a9d2d00b8c9c01369e23176b64b7be9c167edaa2e8d8e7839c0a943770f6d3efd3d820f9461f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1251544958ef59183829772a29c6a6ace5517874b8d77f87ca924304126875622461458b437c5b135ad70d67c8592ec24262db9e1138f74ef8fd78a659b95189"} 05:48:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:48:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:48:11 INFO - Contents: 05:48:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/209ba4f7a41e26365806c6760602317b180916b03c2c0b46c08c0347610fef01ec476c802fcb9a19b444e344d91913bafae017956f80ed0915a38e01b09708e9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c39ea7a2a0b371ae0db445c011e47f8353469c74c35308a0b00944974b16df790e369be32a41d4e86ef33852a007792359a947cc377728a3d2f7459e3c465121", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f58d9fb56059975d05225a5d4cc0790baedca50165271fc326a9d2d00b8c9c01369e23176b64b7be9c167edaa2e8d8e7839c0a943770f6d3efd3d820f9461f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1251544958ef59183829772a29c6a6ace5517874b8d77f87ca924304126875622461458b437c5b135ad70d67c8592ec24262db9e1138f74ef8fd78a659b95189"} 05:48:11 INFO - Running post-run listener: copy_logs_to_upload_dir 05:48:11 INFO - Copying logs to upload dir... 05:48:11 INFO - mkdir: /builds/slave/test/build/upload/logs 05:48:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1341.237095 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 21 secs) (at 2017-06-07 05:48:11.458141) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-07 05:48:11.463396) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1496837189.3640-988924461 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/209ba4f7a41e26365806c6760602317b180916b03c2c0b46c08c0347610fef01ec476c802fcb9a19b444e344d91913bafae017956f80ed0915a38e01b09708e9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c39ea7a2a0b371ae0db445c011e47f8353469c74c35308a0b00944974b16df790e369be32a41d4e86ef33852a007792359a947cc377728a3d2f7459e3c465121", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f58d9fb56059975d05225a5d4cc0790baedca50165271fc326a9d2d00b8c9c01369e23176b64b7be9c167edaa2e8d8e7839c0a943770f6d3efd3d820f9461f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1251544958ef59183829772a29c6a6ace5517874b8d77f87ca924304126875622461458b437c5b135ad70d67c8592ec24262db9e1138f74ef8fd78a659b95189"} build_url:https://queue.taskcluster.net/v1/task/U6KszMJcRYqxSDY968A7nA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011352 build_url: 'https://queue.taskcluster.net/v1/task/U6KszMJcRYqxSDY968A7nA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/209ba4f7a41e26365806c6760602317b180916b03c2c0b46c08c0347610fef01ec476c802fcb9a19b444e344d91913bafae017956f80ed0915a38e01b09708e9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c39ea7a2a0b371ae0db445c011e47f8353469c74c35308a0b00944974b16df790e369be32a41d4e86ef33852a007792359a947cc377728a3d2f7459e3c465121", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f58d9fb56059975d05225a5d4cc0790baedca50165271fc326a9d2d00b8c9c01369e23176b64b7be9c167edaa2e8d8e7839c0a943770f6d3efd3d820f9461f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1251544958ef59183829772a29c6a6ace5517874b8d77f87ca924304126875622461458b437c5b135ad70d67c8592ec24262db9e1138f74ef8fd78a659b95189"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-07 05:48:11.495474) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:48:11.495872) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1496837189.3640-988924461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:48:11.575968) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-07 05:48:11.576300) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-07 05:48:11.576632) ========= ========= Total master_lag: 0.19 =========