builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-059 starttime: 1496680772.62 results: success (0) revision: cad53f061da634a16ea75887558301b77f65745d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-05 09:39:32.620535) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-05 09:39:32.621008) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-05 09:39:32.621282) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-05 09:39:32.639677) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 09:39:32.639944) ========= 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=3a3620fb28aea1604ab609ef000001d2-1496680772.246822-188740356 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-05 09:39:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 216M=0s 2017-06-05 09:39:33 (216 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.350747 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 09:39:33.004835) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 09:39:33.005182) ========= 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=3a3620fb28aea1604ab609ef000001d2-1496680772.246822-188740356 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023498 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 09:39:33.054834) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 09:39:33.058212) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cad53f061da634a16ea75887558301b77f65745d --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 cad53f061da634a16ea75887558301b77f65745d --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=3a3620fb28aea1604ab609ef000001d2-1496680772.246822-188740356 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-05 09:39:33,422 truncating revision to first 12 chars 2017-06-05 09:39:33,422 Setting DEBUG logging. 2017-06-05 09:39:33,422 attempt 1/10 2017-06-05 09:39:33,422 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cad53f061da6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-05 09:39:33,739 unpacking tar archive at: mozilla-central-cad53f061da6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.615258 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 09:39:33.685852) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-05 09:39:33.689282) ========= script_repo_revision: cad53f061da634a16ea75887558301b77f65745d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-05 09:39:33.689710) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-05 09:39:33.689968) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-05 09:39:33.700375) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2017-06-05 09:39:33.700754) ========= /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=3a3620fb28aea1604ab609ef000001d2-1496680772.246822-188740356 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:39:34 INFO - MultiFileLogger online at 20170605 09:39:34 in /builds/slave/test 09:39:34 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 09:39:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:39:34 INFO - {'append_to_log': False, 09:39:34 INFO - 'base_work_dir': '/builds/slave/test', 09:39:34 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:39:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:39:34 INFO - 'branch': 'Firefox-Non-PGO', 09:39:34 INFO - 'buildbot_json_path': 'buildprops.json', 09:39:34 INFO - 'config_files': ('talos/linux_config.py',), 09:39:34 INFO - 'default_actions': ('clobber', 09:39:34 INFO - 'read-buildbot-config', 09:39:34 INFO - 'download-and-extract', 09:39:34 INFO - 'populate-webroot', 09:39:34 INFO - 'create-virtualenv', 09:39:34 INFO - 'install', 09:39:34 INFO - 'setup-mitmproxy', 09:39:34 INFO - 'run-tests'), 09:39:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:39:34 INFO - 'download_minidump_stackwalk': True, 09:39:34 INFO - 'download_symbols': 'ondemand', 09:39:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:39:34 INFO - 'tooltool.py': '/tools/tooltool.py', 09:39:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:39:34 INFO - '/tools/misc-python/virtualenv.py')}, 09:39:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:39:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:39:34 INFO - 'gecko_profile': False, 09:39:34 INFO - 'gecko_profile_interval': 0, 09:39:34 INFO - 'installer_path': 'installer.exe', 09:39:34 INFO - 'log_level': 'info', 09:39:34 INFO - 'log_name': 'talos', 09:39:34 INFO - 'log_to_console': True, 09:39:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:39:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:39:34 INFO - 'opt_config_files': (), 09:39:34 INFO - 'pip_index': False, 09:39:34 INFO - 'suite': 'dromaeojs-e10s', 09:39:34 INFO - 'system_bits': '32', 09:39:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:39:34 INFO - 'title': 'talos-linux64-ix-059', 09:39:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:39:34 INFO - 'use_talos_json': True, 09:39:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:39:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:39:34 INFO - 'work_dir': 'build'} 09:39:34 INFO - [mozharness: 2017-06-05 16:39:34.160983Z] Running clobber step. 09:39:34 INFO - Running pre-action listener: _resource_record_pre_action 09:39:34 INFO - Running main action method: clobber 09:39:34 INFO - rmtree: /builds/slave/test/build 09:39:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:39:35 INFO - Running post-action listener: _resource_record_post_action 09:39:35 INFO - [mozharness: 2017-06-05 16:39:35.828933Z] Finished clobber step (success) 09:39:35 INFO - [mozharness: 2017-06-05 16:39:35.829034Z] Running read-buildbot-config step. 09:39:35 INFO - Running pre-action listener: _resource_record_pre_action 09:39:35 INFO - Running main action method: read_buildbot_config 09:39:35 INFO - Using buildbot properties: 09:39:35 INFO - { 09:39:35 INFO - "project": "", 09:39:35 INFO - "product": "firefox", 09:39:35 INFO - "who": "ryanvm@gmail.com", 09:39:35 INFO - "installer_path": "public/build/target.tar.bz2", 09:39:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:39:35 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:39:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:39:35 INFO - "stage_platform": "linux64", 09:39:35 INFO - "basedir": "/builds/slave/test", 09:39:35 INFO - "buildnumber": 656, 09:39:35 INFO - "platform": "ubuntu64_hw", 09:39:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:39:35 INFO - "slavebuilddir": "test", 09:39:35 INFO - "taskId": "IULxWrTkS0qKEktiUr8OCg", 09:39:35 INFO - "branch": "mozilla-central", 09:39:35 INFO - "script_repo_revision": "production", 09:39:35 INFO - "revision": "cad53f061da634a16ea75887558301b77f65745d", 09:39:35 INFO - "slavename": "talos-linux64-ix-059", 09:39:35 INFO - "repo_path": "mozilla-central" 09:39:35 INFO - } 09:39:35 INFO - Finding installer, test and symbols from parent task. 09:39:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IULxWrTkS0qKEktiUr8OCg'}, attempt #1 09:39:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IULxWrTkS0qKEktiUr8OCg'}, attempt #1 09:39:36 INFO - Task dependencies: XxZJaM4BSd6oD1oaJqCemw 09:39:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XxZJaM4BSd6oD1oaJqCemw'}, attempt #1 09:39:37 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/XxZJaM4BSd6oD1oaJqCemw/artifacts/public/build/target.tar.bz2 09:39:37 INFO - Set test_url: https://queue.taskcluster.net/v1/task/XxZJaM4BSd6oD1oaJqCemw/artifacts/public/build/test_packages.json 09:39:37 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/XxZJaM4BSd6oD1oaJqCemw/artifacts/public/build/target.crashreporter-symbols.zip 09:39:37 INFO - Running post-action listener: _resource_record_post_action 09:39:37 INFO - [mozharness: 2017-06-05 16:39:37.203912Z] Finished read-buildbot-config step (success) 09:39:37 INFO - [mozharness: 2017-06-05 16:39:37.204135Z] Running download-and-extract step. 09:39:37 INFO - Running pre-action listener: _resource_record_pre_action 09:39:37 INFO - Running main action method: download_and_extract 09:39:37 INFO - mkdir: /builds/slave/test/build/tests 09:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:37 INFO - trying https://queue.taskcluster.net/v1/task/XxZJaM4BSd6oD1oaJqCemw/artifacts/public/build/target.test_packages.json 09:39:37 INFO - Downloading https://queue.taskcluster.net/v1/task/XxZJaM4BSd6oD1oaJqCemw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:39:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XxZJaM4BSd6oD1oaJqCemw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:39:37 INFO - Downloaded 989 bytes. 09:39:37 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:39:37 INFO - Using the following test package requirements: 09:39:37 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:39:37 INFO - u'common': [u'target.common.tests.zip'], 09:39:37 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:39:37 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:39:37 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:39:37 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:39:37 INFO - u'mozbase': [u'target.common.tests.zip'], 09:39:37 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:39:37 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:39:37 INFO - u'web-platform': [u'target.common.tests.zip', 09:39:37 INFO - u'target.web-platform.tests.tar.gz'], 09:39:37 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:39:37 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:39:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XxZJaM4BSd6oD1oaJqCemw/artifacts/public/build/target.common.tests.zip 09:39:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XxZJaM4BSd6oD1oaJqCemw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:39:37 INFO - Fetch https://queue.taskcluster.net/v1/task/XxZJaM4BSd6oD1oaJqCemw/artifacts/public/build/target.common.tests.zip into memory 09:39:45 INFO - Content-Length response header: 65102989 09:39:45 INFO - Bytes received: 65102989 09:39:56 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:39:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XxZJaM4BSd6oD1oaJqCemw/artifacts/public/build/target.common.tests.zip 09:39:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XxZJaM4BSd6oD1oaJqCemw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:39:56 INFO - Fetch https://queue.taskcluster.net/v1/task/XxZJaM4BSd6oD1oaJqCemw/artifacts/public/build/target.common.tests.zip into memory 09:39:57 INFO - Content-Length response header: 65102989 09:39:57 INFO - Bytes received: 65102989 09:40:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XxZJaM4BSd6oD1oaJqCemw/artifacts/public/build/target.talos.tests.zip 09:40:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XxZJaM4BSd6oD1oaJqCemw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:40:09 INFO - Fetch https://queue.taskcluster.net/v1/task/XxZJaM4BSd6oD1oaJqCemw/artifacts/public/build/target.talos.tests.zip into memory 09:40:10 INFO - Content-Length response header: 14447425 09:40:10 INFO - Bytes received: 14447425 09:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:10 INFO - trying https://queue.taskcluster.net/v1/task/XxZJaM4BSd6oD1oaJqCemw/artifacts/public/build/target.tar.bz2 09:40:10 INFO - Downloading https://queue.taskcluster.net/v1/task/XxZJaM4BSd6oD1oaJqCemw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:40:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XxZJaM4BSd6oD1oaJqCemw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:40:11 INFO - Downloaded 58753492 bytes. 09:40:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XxZJaM4BSd6oD1oaJqCemw/artifacts/public/build/target.tar.bz2 09:40:11 INFO - mkdir: /builds/slave/test/properties 09:40:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:40:11 INFO - Writing to file /builds/slave/test/properties/build_url 09:40:11 INFO - Contents: 09:40:11 INFO - build_url:https://queue.taskcluster.net/v1/task/XxZJaM4BSd6oD1oaJqCemw/artifacts/public/build/target.tar.bz2 09:40:11 INFO - Running post-action listener: _resource_record_post_action 09:40:11 INFO - Running post-action listener: set_extra_try_arguments 09:40:11 INFO - [mozharness: 2017-06-05 16:40:11.952779Z] Finished download-and-extract step (success) 09:40:11 INFO - [mozharness: 2017-06-05 16:40:11.952876Z] Running populate-webroot step. 09:40:11 INFO - Running pre-action listener: _resource_record_pre_action 09:40:11 INFO - Running main action method: populate_webroot 09:40:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:40:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:40:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:40:11 INFO - '--tppagecycles', 09:40:11 INFO - '7'], 09:40:11 INFO - 'tests': ['tsvgm']}}, 09:40:11 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:40:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:40:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:40:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:40:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:40:11 INFO - 'talos_options': ['--disable-e10s'], 09:40:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:40:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:40:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:40:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:40:11 INFO - 'talos_options': ['--disable-e10s'], 09:40:11 INFO - 'tests': ['damp', 'tps']}, 09:40:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:40:11 INFO - 'tests': ['damp', 'tps']}, 09:40:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:40:11 INFO - 'tests': ['dromaeo_dom']}, 09:40:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:40:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:40:11 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:40:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:40:11 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:40:11 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:40:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:40:11 INFO - 'tests': ['a11yr', 09:40:11 INFO - 'ts_paint', 09:40:11 INFO - 'tpaint', 09:40:11 INFO - 'sessionrestore', 09:40:11 INFO - 'sessionrestore_no_auto_restore', 09:40:11 INFO - 'tabpaint']}, 09:40:11 INFO - 'other-e10s': {'tests': ['a11yr', 09:40:11 INFO - 'ts_paint', 09:40:11 INFO - 'tpaint', 09:40:11 INFO - 'sessionrestore', 09:40:11 INFO - 'sessionrestore_no_auto_restore', 09:40:11 INFO - 'tabpaint']}, 09:40:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:40:11 INFO - 'ts_paint', 09:40:11 INFO - 'tpaint', 09:40:11 INFO - 'sessionrestore', 09:40:11 INFO - 'sessionrestore_no_auto_restore', 09:40:11 INFO - 'tabpaint']}, 09:40:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:40:11 INFO - 'ts_paint', 09:40:11 INFO - 'tpaint', 09:40:11 INFO - 'sessionrestore', 09:40:11 INFO - 'sessionrestore_no_auto_restore', 09:40:11 INFO - 'tabpaint']}, 09:40:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:40:11 INFO - 'tests': ['a11yr', 09:40:11 INFO - 'ts_paint', 09:40:11 INFO - 'tpaint', 09:40:11 INFO - 'sessionrestore', 09:40:11 INFO - 'sessionrestore_no_auto_restore', 09:40:11 INFO - 'tabpaint']}, 09:40:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:40:11 INFO - 'tests': ['a11yr', 09:40:11 INFO - 'ts_paint', 09:40:11 INFO - 'tpaint', 09:40:11 INFO - 'sessionrestore', 09:40:11 INFO - 'sessionrestore_no_auto_restore', 09:40:11 INFO - 'tabpaint']}, 09:40:11 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:40:11 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:40:11 INFO - 'bloom_basic_ref']}, 09:40:11 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 09:40:11 INFO - 'talos_options': ['--mitmproxy', 09:40:11 INFO - 'mitmproxy-recording-1.mp', 09:40:11 INFO - '--firstNonBlankPaint'], 09:40:11 INFO - 'tests': ['Quantum_1']}, 09:40:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:40:11 INFO - 'tests': ['tsvgx', 09:40:11 INFO - 'tsvgr_opacity', 09:40:11 INFO - 'tart', 09:40:11 INFO - 'tscrollx', 09:40:11 INFO - 'cart', 09:40:11 INFO - 'tsvg_static']}, 09:40:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:40:11 INFO - 'tsvgr_opacity', 09:40:11 INFO - 'tart', 09:40:11 INFO - 'tscrollx', 09:40:11 INFO - 'cart', 09:40:11 INFO - 'tsvg_static']}, 09:40:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:40:11 INFO - 'talos_options': ['--disable-e10s'], 09:40:11 INFO - 'tests': ['tp5o']}, 09:40:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:40:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:40:11 INFO - 'talos_options': ['--disable-e10s', 09:40:11 INFO - '--xperf_path', 09:40:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:40:11 INFO - 'tests': ['tp5n']}, 09:40:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:40:11 INFO - 'talos_options': ['--xperf_path', 09:40:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:40:11 INFO - 'tests': ['tp5n']}}, 09:40:11 INFO - 'talos.zip': {'path': '', 09:40:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:40:11 INFO - Running post-action listener: _resource_record_post_action 09:40:11 INFO - [mozharness: 2017-06-05 16:40:11.967207Z] Finished populate-webroot step (success) 09:40:11 INFO - [mozharness: 2017-06-05 16:40:11.967304Z] Running create-virtualenv step. 09:40:11 INFO - Running pre-action listener: _resource_record_pre_action 09:40:11 INFO - Running main action method: create_virtualenv 09:40:11 INFO - Creating virtualenv /builds/slave/test/build/venv 09:40:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:40:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:40:11 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:40:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:40:12 INFO - Using real prefix '/usr' 09:40:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:40:12 INFO - Installing distribute.............................................................................................................................................................................................done. 09:40:14 INFO - Installing pip.................done. 09:40:14 INFO - Return code: 0 09:40:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:40:14 INFO - Reading from file tmpfile_stdout 09:40:14 INFO - Output received: 09:40:14 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:40:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:14 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 0x23603b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db840>, '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 0x26dc740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dcbd0>, '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': '3a3620fb28aea1604ab609ef000001d2-1496680772.246822-188740356', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:40:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:40:14 INFO - Using env: {'DISPLAY': ':0', 09:40:14 INFO - 'HOME': '/home/cltbld', 09:40:14 INFO - 'LANG': 'en_US.UTF-8', 09:40:14 INFO - 'LANGUAGE': 'en_US:en', 09:40:14 INFO - 'LOGNAME': 'cltbld', 09:40:14 INFO - 'MAIL': '/var/mail/cltbld', 09:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:14 INFO - 'MOZ_NO_REMOTE': '1', 09:40:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:14 INFO - 'NO_EM_RESTART': '1', 09:40:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:14 INFO - 'PWD': '/builds/slave/test', 09:40:14 INFO - 'SHELL': '/bin/bash', 09:40:14 INFO - 'SHLVL': '1', 09:40:14 INFO - 'TERM': 'linux', 09:40:14 INFO - 'TMOUT': '86400', 09:40:14 INFO - 'USER': 'cltbld', 09:40:14 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1496680772.246822-188740356', 09:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:14 INFO - '_': '/tools/buildbot/bin/python'} 09:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:40:14 INFO - Cleaning up... 09:40:15 INFO - Return code: 0 09:40:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:15 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 0x23603b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db840>, '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 0x26dc740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dcbd0>, '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': '3a3620fb28aea1604ab609ef000001d2-1496680772.246822-188740356', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:40:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:40:15 INFO - Using env: {'DISPLAY': ':0', 09:40:15 INFO - 'HOME': '/home/cltbld', 09:40:15 INFO - 'LANG': 'en_US.UTF-8', 09:40:15 INFO - 'LANGUAGE': 'en_US:en', 09:40:15 INFO - 'LOGNAME': 'cltbld', 09:40:15 INFO - 'MAIL': '/var/mail/cltbld', 09:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:15 INFO - 'MOZ_NO_REMOTE': '1', 09:40:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:15 INFO - 'NO_EM_RESTART': '1', 09:40:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:15 INFO - 'PWD': '/builds/slave/test', 09:40:15 INFO - 'SHELL': '/bin/bash', 09:40:15 INFO - 'SHLVL': '1', 09:40:15 INFO - 'TERM': 'linux', 09:40:15 INFO - 'TMOUT': '86400', 09:40:15 INFO - 'USER': 'cltbld', 09:40:15 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1496680772.246822-188740356', 09:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:15 INFO - '_': '/tools/buildbot/bin/python'} 09:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:15 INFO - Downloading/unpacking psutil>=3.1.1 09:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:40:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:40:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:40:16 INFO - Installing collected packages: psutil 09:40:16 INFO - Running setup.py install for psutil 09:40:16 INFO - building 'psutil._psutil_linux' extension 09:40:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:40:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:40:16 INFO - building 'psutil._psutil_posix' extension 09:40:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:40:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:40:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:40:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:40:16 INFO - Successfully installed psutil 09:40:16 INFO - Cleaning up... 09:40:16 INFO - Return code: 0 09:40:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:40:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:16 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 0x23603b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db840>, '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 0x26dc740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dcbd0>, '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': '3a3620fb28aea1604ab609ef000001d2-1496680772.246822-188740356', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:40:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:40:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:40:16 INFO - Using env: {'DISPLAY': ':0', 09:40:16 INFO - 'HOME': '/home/cltbld', 09:40:16 INFO - 'LANG': 'en_US.UTF-8', 09:40:16 INFO - 'LANGUAGE': 'en_US:en', 09:40:16 INFO - 'LOGNAME': 'cltbld', 09:40:16 INFO - 'MAIL': '/var/mail/cltbld', 09:40:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:16 INFO - 'MOZ_NO_REMOTE': '1', 09:40:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:16 INFO - 'NO_EM_RESTART': '1', 09:40:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:16 INFO - 'PWD': '/builds/slave/test', 09:40:16 INFO - 'SHELL': '/bin/bash', 09:40:16 INFO - 'SHLVL': '1', 09:40:16 INFO - 'TERM': 'linux', 09:40:16 INFO - 'TMOUT': '86400', 09:40:16 INFO - 'USER': 'cltbld', 09:40:16 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1496680772.246822-188740356', 09:40:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:16 INFO - '_': '/tools/buildbot/bin/python'} 09:40:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:40:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:40:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:40:18 INFO - Installing collected packages: mozsystemmonitor 09:40:18 INFO - Running setup.py install for mozsystemmonitor 09:40:18 INFO - Successfully installed mozsystemmonitor 09:40:18 INFO - Cleaning up... 09:40:18 INFO - Return code: 0 09:40:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:40:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:18 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 0x23603b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db840>, '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 0x26dc740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dcbd0>, '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': '3a3620fb28aea1604ab609ef000001d2-1496680772.246822-188740356', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:40:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:40:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:40:18 INFO - Using env: {'DISPLAY': ':0', 09:40:18 INFO - 'HOME': '/home/cltbld', 09:40:18 INFO - 'LANG': 'en_US.UTF-8', 09:40:18 INFO - 'LANGUAGE': 'en_US:en', 09:40:18 INFO - 'LOGNAME': 'cltbld', 09:40:18 INFO - 'MAIL': '/var/mail/cltbld', 09:40:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:18 INFO - 'MOZ_NO_REMOTE': '1', 09:40:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:18 INFO - 'NO_EM_RESTART': '1', 09:40:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:18 INFO - 'PWD': '/builds/slave/test', 09:40:18 INFO - 'SHELL': '/bin/bash', 09:40:18 INFO - 'SHLVL': '1', 09:40:18 INFO - 'TERM': 'linux', 09:40:18 INFO - 'TMOUT': '86400', 09:40:18 INFO - 'USER': 'cltbld', 09:40:18 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1496680772.246822-188740356', 09:40:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:18 INFO - '_': '/tools/buildbot/bin/python'} 09:40:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:18 INFO - Downloading/unpacking jsonschema==2.5.1 09:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:40:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:19 INFO - Downloading functools32-3.2.3-2.tar.gz 09:40:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:40:20 INFO - warning: no files found matching '*.txt' 09:40:20 INFO - no previously-included directories found matching 'build' 09:40:20 INFO - no previously-included directories found matching 'dist' 09:40:20 INFO - no previously-included directories found matching '.git*' 09:40:20 INFO - Installing collected packages: jsonschema, functools32 09:40:20 INFO - Running setup.py install for functools32 09:40:20 INFO - warning: no files found matching '*.txt' 09:40:20 INFO - no previously-included directories found matching 'build' 09:40:20 INFO - no previously-included directories found matching 'dist' 09:40:20 INFO - no previously-included directories found matching '.git*' 09:40:20 INFO - Successfully installed jsonschema functools32 09:40:20 INFO - Cleaning up... 09:40:20 INFO - Return code: 0 09:40:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:20 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 0x23603b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db840>, '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 0x26dc740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dcbd0>, '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': '3a3620fb28aea1604ab609ef000001d2-1496680772.246822-188740356', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:40:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:40:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:40:20 INFO - Using env: {'DISPLAY': ':0', 09:40:20 INFO - 'HOME': '/home/cltbld', 09:40:20 INFO - 'LANG': 'en_US.UTF-8', 09:40:20 INFO - 'LANGUAGE': 'en_US:en', 09:40:20 INFO - 'LOGNAME': 'cltbld', 09:40:20 INFO - 'MAIL': '/var/mail/cltbld', 09:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:20 INFO - 'MOZ_NO_REMOTE': '1', 09:40:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:20 INFO - 'NO_EM_RESTART': '1', 09:40:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:20 INFO - 'PWD': '/builds/slave/test', 09:40:20 INFO - 'SHELL': '/bin/bash', 09:40:20 INFO - 'SHLVL': '1', 09:40:20 INFO - 'TERM': 'linux', 09:40:20 INFO - 'TMOUT': '86400', 09:40:20 INFO - 'USER': 'cltbld', 09:40:20 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1496680772.246822-188740356', 09:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:20 INFO - '_': '/tools/buildbot/bin/python'} 09:40:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:40:20 INFO - Cleaning up... 09:40:20 INFO - Return code: 0 09:40:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:20 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 0x23603b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db840>, '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 0x26dc740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dcbd0>, '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': '3a3620fb28aea1604ab609ef000001d2-1496680772.246822-188740356', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:40:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:40:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:40:20 INFO - Using env: {'DISPLAY': ':0', 09:40:20 INFO - 'HOME': '/home/cltbld', 09:40:20 INFO - 'LANG': 'en_US.UTF-8', 09:40:20 INFO - 'LANGUAGE': 'en_US:en', 09:40:20 INFO - 'LOGNAME': 'cltbld', 09:40:20 INFO - 'MAIL': '/var/mail/cltbld', 09:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:20 INFO - 'MOZ_NO_REMOTE': '1', 09:40:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:20 INFO - 'NO_EM_RESTART': '1', 09:40:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:20 INFO - 'PWD': '/builds/slave/test', 09:40:20 INFO - 'SHELL': '/bin/bash', 09:40:20 INFO - 'SHLVL': '1', 09:40:20 INFO - 'TERM': 'linux', 09:40:20 INFO - 'TMOUT': '86400', 09:40:20 INFO - 'USER': 'cltbld', 09:40:20 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1496680772.246822-188740356', 09:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:20 INFO - '_': '/tools/buildbot/bin/python'} 09:40:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:20 INFO - Downloading/unpacking blobuploader==1.2.4 09:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:21 INFO - Downloading blobuploader-1.2.4.tar.gz 09:40:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:40:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:40:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:40:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:22 INFO - Downloading docopt-0.6.1.tar.gz 09:40:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:40:22 INFO - Installing collected packages: blobuploader, requests, docopt 09:40:22 INFO - Running setup.py install for blobuploader 09:40:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:40:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:40:22 INFO - Running setup.py install for requests 09:40:22 INFO - Running setup.py install for docopt 09:40:23 INFO - Successfully installed blobuploader requests docopt 09:40:23 INFO - Cleaning up... 09:40:23 INFO - Return code: 0 09:40:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:23 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 0x23603b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db840>, '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 0x26dc740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dcbd0>, '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': '3a3620fb28aea1604ab609ef000001d2-1496680772.246822-188740356', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:40:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:40:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:40:23 INFO - Using env: {'DISPLAY': ':0', 09:40:23 INFO - 'HOME': '/home/cltbld', 09:40:23 INFO - 'LANG': 'en_US.UTF-8', 09:40:23 INFO - 'LANGUAGE': 'en_US:en', 09:40:23 INFO - 'LOGNAME': 'cltbld', 09:40:23 INFO - 'MAIL': '/var/mail/cltbld', 09:40:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:23 INFO - 'MOZ_NO_REMOTE': '1', 09:40:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:23 INFO - 'NO_EM_RESTART': '1', 09:40:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:23 INFO - 'PWD': '/builds/slave/test', 09:40:23 INFO - 'SHELL': '/bin/bash', 09:40:23 INFO - 'SHLVL': '1', 09:40:23 INFO - 'TERM': 'linux', 09:40:23 INFO - 'TMOUT': '86400', 09:40:23 INFO - 'USER': 'cltbld', 09:40:23 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1496680772.246822-188740356', 09:40:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:23 INFO - '_': '/tools/buildbot/bin/python'} 09:40:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:40:23 INFO - Running setup.py (path:/tmp/pip-htMVTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:40:23 INFO - Running setup.py (path:/tmp/pip-A203cI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:40:23 INFO - Running setup.py (path:/tmp/pip-MTUk_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:40:23 INFO - Running setup.py (path:/tmp/pip-MO7GXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:40:23 INFO - Running setup.py (path:/tmp/pip-Ra5j10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:40:23 INFO - Running setup.py (path:/tmp/pip-HXXnNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:40:23 INFO - Running setup.py (path:/tmp/pip-js8YMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:40:23 INFO - Running setup.py (path:/tmp/pip-rIQffJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:40:23 INFO - Running setup.py (path:/tmp/pip-_9Eps1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:40:23 INFO - Running setup.py (path:/tmp/pip-5vTq5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:40:24 INFO - Running setup.py (path:/tmp/pip-asYyv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:40:24 INFO - Running setup.py (path:/tmp/pip-e7AYQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:40:24 INFO - Running setup.py (path:/tmp/pip-lSbXs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:40:24 INFO - Running setup.py (path:/tmp/pip-NDTYCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:24 INFO - Running setup.py (path:/tmp/pip-jRFOTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:40:24 INFO - Running setup.py (path:/tmp/pip-srDgZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:40:24 INFO - Running setup.py (path:/tmp/pip-9cDRE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:40:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:40:24 INFO - Running setup.py install for manifestparser 09:40:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:40:24 INFO - Running setup.py install for mozcrash 09:40:24 INFO - Running setup.py install for mozdebug 09:40:24 INFO - Running setup.py install for mozdevice 09:40:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:40:24 INFO - Running setup.py install for mozfile 09:40:25 INFO - Running setup.py install for mozhttpd 09:40:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:40:25 INFO - Running setup.py install for mozinfo 09:40:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:40:25 INFO - Running setup.py install for mozInstall 09:40:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:40:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:40:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:40:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:40:25 INFO - Running setup.py install for mozleak 09:40:25 INFO - Running setup.py install for mozlog 09:40:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:40:25 INFO - Running setup.py install for moznetwork 09:40:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:40:25 INFO - Running setup.py install for mozprocess 09:40:25 INFO - Running setup.py install for mozprofile 09:40:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:40:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:40:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:40:25 INFO - Running setup.py install for mozrunner 09:40:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:40:26 INFO - Running setup.py install for mozscreenshot 09:40:26 INFO - Running setup.py install for moztest 09:40:26 INFO - Running setup.py install for mozversion 09:40:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:40:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:40:26 INFO - Cleaning up... 09:40:26 INFO - Return code: 0 09:40:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:26 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 0x23603b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db840>, '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 0x26dc740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dcbd0>, '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': '3a3620fb28aea1604ab609ef000001d2-1496680772.246822-188740356', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:40:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:40:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:40:26 INFO - Using env: {'DISPLAY': ':0', 09:40:26 INFO - 'HOME': '/home/cltbld', 09:40:26 INFO - 'LANG': 'en_US.UTF-8', 09:40:26 INFO - 'LANGUAGE': 'en_US:en', 09:40:26 INFO - 'LOGNAME': 'cltbld', 09:40:26 INFO - 'MAIL': '/var/mail/cltbld', 09:40:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:26 INFO - 'MOZ_NO_REMOTE': '1', 09:40:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:26 INFO - 'NO_EM_RESTART': '1', 09:40:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:26 INFO - 'PWD': '/builds/slave/test', 09:40:26 INFO - 'SHELL': '/bin/bash', 09:40:26 INFO - 'SHLVL': '1', 09:40:26 INFO - 'TERM': 'linux', 09:40:26 INFO - 'TMOUT': '86400', 09:40:26 INFO - 'USER': 'cltbld', 09:40:26 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1496680772.246822-188740356', 09:40:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:26 INFO - '_': '/tools/buildbot/bin/python'} 09:40:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:40:26 INFO - Running setup.py (path:/tmp/pip-1ExejQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:40:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:40:26 INFO - Running setup.py (path:/tmp/pip-GRZNEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:40:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:40:26 INFO - Running setup.py (path:/tmp/pip-mVk9Q3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:40:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:40:26 INFO - Running setup.py (path:/tmp/pip-9s0qLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:40:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:40:26 INFO - Running setup.py (path:/tmp/pip-xNJdxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:40:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:40:26 INFO - Running setup.py (path:/tmp/pip-MHJwlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:40:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:40:26 INFO - Running setup.py (path:/tmp/pip-rqHcrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:40:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:40:27 INFO - Running setup.py (path:/tmp/pip-gGl4_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:40:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:40:27 INFO - Running setup.py (path:/tmp/pip-gzZXBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:40:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:40:27 INFO - Running setup.py (path:/tmp/pip-DbMc59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:40:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:40:27 INFO - Running setup.py (path:/tmp/pip-Jsh3Q3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:40:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:40:27 INFO - Running setup.py (path:/tmp/pip-4jhujq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:40:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:40:27 INFO - Running setup.py (path:/tmp/pip-LwjX5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:40:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:40:27 INFO - Running setup.py (path:/tmp/pip-3CP797-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:40:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:27 INFO - Running setup.py (path:/tmp/pip-wH68RU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:40:27 INFO - Running setup.py (path:/tmp/pip-DMZr8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:40:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:40:27 INFO - Running setup.py (path:/tmp/pip-DmFS0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:40:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:40:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:40:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:40:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:40:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:40:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:40:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:28 INFO - Downloading blessings-1.6.tar.gz 09:40:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:40:28 INFO - Installing collected packages: blessings 09:40:28 INFO - Running setup.py install for blessings 09:40:29 INFO - Successfully installed blessings 09:40:29 INFO - Cleaning up... 09:40:29 INFO - Return code: 0 09:40:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:40:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:40:29 INFO - Reading from file tmpfile_stdout 09:40:29 INFO - Current package versions: 09:40:29 INFO - argparse == 1.2.1 09:40:29 INFO - blessings == 1.6 09:40:29 INFO - blobuploader == 1.2.4 09:40:29 INFO - docopt == 0.6.1 09:40:29 INFO - functools32 == 3.2.3-2 09:40:29 INFO - jsonschema == 2.5.1 09:40:29 INFO - manifestparser == 1.1 09:40:29 INFO - mozInstall == 1.12 09:40:29 INFO - mozcrash == 1.0 09:40:29 INFO - mozdebug == 0.1 09:40:29 INFO - mozdevice == 0.51 09:40:29 INFO - mozfile == 1.2 09:40:29 INFO - mozhttpd == 0.7 09:40:29 INFO - mozinfo == 0.9 09:40:29 INFO - mozleak == 0.1 09:40:29 INFO - mozlog == 3.4 09:40:29 INFO - moznetwork == 0.27 09:40:29 INFO - mozprocess == 0.25 09:40:29 INFO - mozprofile == 0.28 09:40:29 INFO - mozrunner == 6.13 09:40:29 INFO - mozscreenshot == 0.1 09:40:29 INFO - mozsystemmonitor == 0.3 09:40:29 INFO - moztest == 0.8 09:40:29 INFO - mozversion == 1.4 09:40:29 INFO - psutil == 3.1.1 09:40:29 INFO - requests == 1.2.3 09:40:29 INFO - wsgiref == 0.1.2 09:40:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:29 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 0x23603b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db840>, '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 0x26dc740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dcbd0>, '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': '3a3620fb28aea1604ab609ef000001d2-1496680772.246822-188740356', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:40:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:40:29 INFO - Using env: {'DISPLAY': ':0', 09:40:29 INFO - 'HOME': '/home/cltbld', 09:40:29 INFO - 'LANG': 'en_US.UTF-8', 09:40:29 INFO - 'LANGUAGE': 'en_US:en', 09:40:29 INFO - 'LOGNAME': 'cltbld', 09:40:29 INFO - 'MAIL': '/var/mail/cltbld', 09:40:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:29 INFO - 'MOZ_NO_REMOTE': '1', 09:40:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:29 INFO - 'NO_EM_RESTART': '1', 09:40:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:29 INFO - 'PWD': '/builds/slave/test', 09:40:29 INFO - 'SHELL': '/bin/bash', 09:40:29 INFO - 'SHLVL': '1', 09:40:29 INFO - 'TERM': 'linux', 09:40:29 INFO - 'TMOUT': '86400', 09:40:29 INFO - 'USER': 'cltbld', 09:40:29 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1496680772.246822-188740356', 09:40:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:29 INFO - '_': '/tools/buildbot/bin/python'} 09:40:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:40:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:40:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:40:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:40:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:40:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:40:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:40:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:40:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:40:29 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:30 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:40:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:40:30 INFO - Installing collected packages: marionette-driver 09:40:30 INFO - Running setup.py install for marionette-driver 09:40:30 INFO - Successfully installed marionette-driver 09:40:30 INFO - Cleaning up... 09:40:30 INFO - Return code: 0 09:40:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:40:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:30 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 0x23603b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db840>, '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 0x26dc740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dcbd0>, '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': '3a3620fb28aea1604ab609ef000001d2-1496680772.246822-188740356', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:40:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:40:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:40:30 INFO - Using env: {'DISPLAY': ':0', 09:40:30 INFO - 'HOME': '/home/cltbld', 09:40:30 INFO - 'LANG': 'en_US.UTF-8', 09:40:30 INFO - 'LANGUAGE': 'en_US:en', 09:40:30 INFO - 'LOGNAME': 'cltbld', 09:40:30 INFO - 'MAIL': '/var/mail/cltbld', 09:40:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:30 INFO - 'MOZ_NO_REMOTE': '1', 09:40:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:30 INFO - 'NO_EM_RESTART': '1', 09:40:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:30 INFO - 'PWD': '/builds/slave/test', 09:40:30 INFO - 'SHELL': '/bin/bash', 09:40:30 INFO - 'SHLVL': '1', 09:40:30 INFO - 'TERM': 'linux', 09:40:30 INFO - 'TMOUT': '86400', 09:40:30 INFO - 'USER': 'cltbld', 09:40:30 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1496680772.246822-188740356', 09:40:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:30 INFO - '_': '/tools/buildbot/bin/python'} 09:40:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:40:31 INFO - Cleaning up... 09:40:31 INFO - Return code: 0 09:40:31 INFO - Running post-action listener: _resource_record_post_action 09:40:31 INFO - Running post-action listener: _start_resource_monitoring 09:40:31 INFO - Starting resource monitoring. 09:40:31 INFO - [mozharness: 2017-06-05 16:40:31.146982Z] Finished create-virtualenv step (success) 09:40:31 INFO - [mozharness: 2017-06-05 16:40:31.147469Z] Running install step. 09:40:31 INFO - Running pre-action listener: _resource_record_pre_action 09:40:31 INFO - Running main action method: install 09:40:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:40:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:40:31 INFO - Reading from file tmpfile_stdout 09:40:31 INFO - Detecting whether we're running mozinstall >=1.0... 09:40:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:40:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:40:31 INFO - Reading from file tmpfile_stdout 09:40:31 INFO - Output received: 09:40:31 INFO - Usage: mozinstall [options] installer 09:40:31 INFO - Options: 09:40:31 INFO - -h, --help show this help message and exit 09:40:31 INFO - -d DEST, --destination=DEST 09:40:31 INFO - Directory to install application into. [default: 09:40:31 INFO - "/builds/slave/test"] 09:40:31 INFO - --app=APP Application being installed. [default: firefox] 09:40:31 INFO - mkdir: /builds/slave/test/build/application 09:40:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:40:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:40:48 INFO - Reading from file tmpfile_stdout 09:40:48 INFO - Output received: 09:40:48 INFO - /builds/slave/test/build/application/firefox/firefox 09:40:48 INFO - Running post-action listener: _resource_record_post_action 09:40:48 INFO - [mozharness: 2017-06-05 16:40:48.574360Z] Finished install step (success) 09:40:48 INFO - [mozharness: 2017-06-05 16:40:48.574639Z] Running setup-mitmproxy step. 09:40:48 INFO - Running pre-action listener: _resource_record_pre_action 09:40:48 INFO - Running main action method: setup_mitmproxy 09:40:48 INFO - Skipping: mitmproxy is not required 09:40:48 INFO - Running post-action listener: _resource_record_post_action 09:40:48 INFO - [mozharness: 2017-06-05 16:40:48.575780Z] Finished setup-mitmproxy step (success) 09:40:48 INFO - [mozharness: 2017-06-05 16:40:48.576007Z] Running run-tests step. 09:40:48 INFO - Running pre-action listener: _resource_record_pre_action 09:40:48 INFO - Running main action method: run_tests 09:40:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:40:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:40:48 INFO - Python 2.7.3 09:40:48 INFO - Return code: 0 09:40:48 INFO - grabbing minidump binary from tooltool 09:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:48 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 0x26db840>, '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 0x26dc740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dcbd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:40:48 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:40:48 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:40:48 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:40:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:40:48 INFO - Return code: 0 09:40:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:40:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:40:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:40:48 INFO - ENV: RUST_BACKTRACE is now 1 09:40:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:40:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:40:48 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/XxZJaM4BSd6oD1oaJqCemw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:40:48 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/XxZJaM4BSd6oD1oaJqCemw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:40:48 INFO - Using env: {'DISPLAY': ':0', 09:40:48 INFO - 'HOME': '/home/cltbld', 09:40:48 INFO - 'LANG': 'en_US.UTF-8', 09:40:48 INFO - 'LANGUAGE': 'en_US:en', 09:40:48 INFO - 'LOGNAME': 'cltbld', 09:40:48 INFO - 'MAIL': '/var/mail/cltbld', 09:40:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:40:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:40:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:48 INFO - 'MOZ_NO_REMOTE': '1', 09:40:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:40:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:48 INFO - 'NO_EM_RESTART': '1', 09:40:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:48 INFO - 'PWD': '/builds/slave/test', 09:40:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:40:48 INFO - 'RUST_BACKTRACE': '1', 09:40:48 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:40:48 INFO - 'SHELL': '/bin/bash', 09:40:48 INFO - 'SHLVL': '1', 09:40:48 INFO - 'TERM': 'linux', 09:40:48 INFO - 'TMOUT': '86400', 09:40:48 INFO - 'USER': 'cltbld', 09:40:48 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1496680772.246822-188740356', 09:40:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:48 INFO - '_': '/tools/buildbot/bin/python'} 09:40:48 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/XxZJaM4BSd6oD1oaJqCemw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:40:48 INFO - mozversion application_buildid: 20170605160000 09:40:48 INFO - mozversion application_changeset: cad53f061da634a16ea75887558301b77f65745d 09:40:48 INFO - mozversion application_display_name: Nightly 09:40:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:40:48 INFO - mozversion application_name: Firefox 09:40:48 INFO - mozversion application_remotingname: firefox 09:40:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:40:48 INFO - mozversion application_vendor: Mozilla 09:40:48 INFO - mozversion application_version: 55.0a1 09:40:48 INFO - mozversion platform_buildid: 20170605160000 09:40:48 INFO - mozversion platform_changeset: cad53f061da634a16ea75887558301b77f65745d 09:40:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:40:48 INFO - mozversion platform_version: 55.0a1 09:40:48 INFO - using testdate: 1496680848 09:40:48 INFO - actual date: 1496680848 09:40:48 INFO - starting webserver on 'localhost:45425' 09:40:48 INFO - SUITE-START | Running 2 tests 09:40:48 INFO - TEST-START | dromaeo_css 09:40:48 INFO - operating with platform_type : linux_ 09:40:48 INFO - Initialising browser for dromaeo_css test... 09:40:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45425/getInfo.html -profile /tmp/tmpWKkF4M/profile 09:40:48 INFO - TEST-INFO | started process 13596 (/builds/slave/test/build/application/firefox/firefox http://localhost:45425/getInfo.html) 09:41:23 INFO - TEST-INFO | 13596: killed by SIGTERM 09:41:23 INFO - Browser initialized. 09:41:23 INFO - Running cycle 1/1 for dromaeo_css test... 09:41:23 INFO - TEST-INFO | started process 13802 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWKkF4M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:41:35 INFO - PID 13802 | RSS: Main: 188477440 09:41:35 INFO - PID 13802 | 09:44:35 INFO - PID 13802 | Cycle 1(1): loaded http://localhost:45425/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45425/tests/dromaeo/cssquery-ext.html) 09:44:37 INFO - PID 13802 | RSS: Main: 184606720 09:44:37 INFO - PID 13802 | 09:47:39 INFO - PID 13802 | Cycle 1(1): loaded http://localhost:45425/tests/dromaeo/cssquery-ext.html (next: http://localhost:45425/tests/dromaeo/cssquery-jquery.html) 09:47:39 INFO - PID 13802 | RSS: Main: 190029824 09:47:39 INFO - PID 13802 | 09:50:41 INFO - PID 13802 | Cycle 1(1): loaded http://localhost:45425/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45425/tests/dromaeo/cssquery-mootools.html) 09:50:42 INFO - PID 13802 | RSS: Main: 187117568 09:50:42 INFO - PID 13802 | 09:53:44 INFO - PID 13802 | Cycle 1(1): loaded http://localhost:45425/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45425/tests/dromaeo/cssquery-prototype.html) 09:53:44 INFO - PID 13802 | RSS: Main: 190459904 09:53:44 INFO - PID 13802 | 09:56:47 INFO - PID 13802 | Cycle 1(1): loaded http://localhost:45425/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45425/tests/dromaeo/cssquery-yui.html) 09:56:48 INFO - PID 13802 | RSS: Main: 188121088 09:56:48 INFO - PID 13802 | 09:59:49 INFO - PID 13802 | Cycle 1(1): loaded http://localhost:45425/tests/dromaeo/cssquery-yui.html (next: http://localhost:45425/tests/dromaeo/cssquery-dojo.html) 09:59:50 INFO - PID 13802 | RSS: Main: 189272064 09:59:50 INFO - PID 13802 | 09:59:50 INFO - PID 13802 | __start_tp_report 09:59:50 INFO - PID 13802 | _x_x_mozilla_page_load 09:59:50 INFO - PID 13802 | _x_x_mozilla_page_load_details 09:59:50 INFO - PID 13802 | |i|pagename|runs| 09:59:50 INFO - PID 13802 | |0;dojo.html;3064.126723883693;3068.2329417645587;3082.5992620959287;3094.9535756963637;3100.767442441816;5823.155642431845;5855.151003104547;5875.412458754128;5904.527637788978;5935.85160370991;5965.10523421487;5977.641341519501;6035.849103772408;6096.177016102824;6122.387761223876;5396.973015134939;5450.4549545045475;5487.259220005308;5488.862778430551;5619.6066275360745;5558.333000040001;5570.721463926808;5582.49757521823;5591.4688104630195;5595.580331475136;5466.753996070186;5488.69812160331;5496.038193316193;5506.256655351536;5549.361823390322;5483.122700367961;5537.1140617501405;5545.861353466155;5577.832665020056;5619.466150715675;5437.456254374571;5488.725563721798;5489.451054894518;5490.313710786152;5498.422665620133;5891.263592050994;5913.113033045035;5945.16767652529;5953.970230148865;5964.850878728066;6335.619862808247;6347.39699728525;6473.708683109271;6488.610683359014;6511.706973186218;6444;6445;6456.548041637087;6457.0637257597855;6463.870722585522;5975.581709280309;5978.760849566055;5982;5991.670458124801;5994.8501287467725;6497.4477169441125;6571;6578.177727784027;6658.7336506539195;6692.899606505906;6171.783987560414;6226.221722284715;6243.406876346739;6296.811095667137;6313.40022697843;6422;6430.196225471816;6430.839229019312;6436.806895793134;6446.709898054599;6342.5560210785725;6353.36466353361;6392.137061496732;6404.039394090923;6422.967885160544;6277.748890044347;6302.936970630327;6367.108604795332;6400.871982560323;6429.6142231466265;5195.142801437796;5201.219817027476;5217.765200565984;5244.108501554745;5248.212768084818;4443.311286750494;4446.577575130357;4449.666275029385;4467.321449017085;4483.349914262414;5450.127979523258;5507.7246137692955;5552.08390615552;5557.805476808292;5616.66300022;6340.397662222082;6443.806685799434;6450.161479007699;6450.870982580416;6466.1270728452;5524.33707955048;5529.4470552944385;5531.751071201806;5536.833894983157;5581.6371935824045;5565.499105080562;5589.804356847572;5628.296462942132;5632.070708333161;5635.830925072172;6160.10678451631;6182.227221597301;6269.090981807703;6272.40412160844;6332.968335158294;6384.968075159594;6457.289698133295;6458.128152699325;6460.25707043696;6466.418022378009;6171.876562468815;6213.565050446426;6234.875302494015;6244.313125556095;6244.843878903063;6204.038374052029;6252.343503932204;6254.530910181846;6313;6374.968125159345;6315.557910946373;6343.619382837044;6349.841253968688;6376.74493020274;6387.584806987531;6078.665673388006;6149.354317796746;6230.50155987529;6257.342978987141;6265.342139075331;6104.156010547632;6121.178620693132;6206.751729930933;6218.787336469526;6219.222597175353;6027.246594175728;6069.787557435468;6073.665948372882;6084.60450070744;6109.75560977556;6226.750929962751;6258.123862659322;6266.091416744638;6267.592606480564;6277.843053923506;6034.24571928509;6054.091886217103;6086.147939288415;6114.236541168587;6136.917362303726 09:59:50 INFO - PID 13802 | |1;ext.html;731.3381389842194;780.1652232111641;806.4153488720676;1115.4534278203678;1134.3704244144496;35779;37072.44391334129;37115.814420927854;37124.44313335302;37165.442518362215;38364.42453363195;38808.417873731916;38813;38899.61100389002;38904.22191556167;7163.928360716378;7253.455990800698;7366.852662946738;7380.74167404141;7434.442416818733;7266.527675701089;7348.228436014222;7362.963185184093;7376.594287314196;7380.667869945839;7309.269073092675;7324.853502929938;7386.335229829314;7389.5935723535185;7403.925960740405;7271.854562908765;7324.26757324266;7353.338199562065;7355.595442250701;7357.521761085566;7212.63936803163;7236.276372362774;7279.053723015974;7283.162436319838;7290.27097290272;35663.28673426543;35741.46387804185;35781.46327805085;35946;36047.27905441877;3406.5401170841865;3452.4476083826717;3452.5166476693284;3453.6546345365264;3465.3935561276926;28039.29901752452;28052.298692532644;28168.295792605142;28274.151775446768;28349.858250708614;3623.130448692295;3625.29306785177;3632.909177270563;3651.543557055368;3665.7617254878346;133637;136424.31787840996;146285;158469;159579;41321.900857435816;41826;41926.79036604858;41928.58071419247;41946.16107677829;44147.558524414984;44162.55837441584;45398.546014540094;46248.3062754059;46617.27061835045;14950.252487375588;15163.848361516244;15195.240237988057;15206.315715792816;15256.847431525764;12316.076294277966;12341.01271898246;12373.257604543756;12385.256884586954;12387;13832.239226842621;13913.443462261395;13917.652058698613;13969.088655176567;14051.648708782363;5551.8889622207325;5744.51171650406;5803.5357171426185;5852.4147585241135;5874.1776151338845;936.1901954809041;983.8179936711731;984.3454103021411;998.8901220865699;1003.227514813604;21750;22587.6791780186;22766.65850012251;22919.770802292096;22965.196218132285;1071.4856868703066;1071.59815069349;1073.511552243743;1076.4671487613682;1080.6433876820788;11351.602693905674;11903.106626410414;12149.817752733716;12256.44845981933;12871.42078606465;207198;208111;208180;208204;208412;48960.51039489631;49020.75489622529;49143.508564914606;49195.262071068966;49452.752736236085;1385.9930700346433;1417.9574612761633;1442.3509420760909;1445.8843292536571;1448.521987744042;21048.789512104682;21662.89168554147;23205.76794232036;23230.186943456898;23325.76674233304;35231.64768352284;35321.470177947864;35439.468407973385;35506.644933550335;35559.644403555634;172131;172356;172971;173143;173193;32058;32799.67200327966;33757;34089;34158;40374.39438408367;40650.79674601608;41279.380809287286;41309.173816524104;41541.584584153774;29149;29910;30547.2363190922;30588.929387471333;30589.54115688222;29258.414831703674;30141.698583014768;30370.54444183295;31895.362092758478;31990.36019279555;33967.49048764221;34353.14117147091;34984.47523287102;35033.29933401267;35275.29449410946;28858.83970743628;29160.7083929158;29751.70248297489;29929.70070299269;31007.68992310048;21152.25967091206;23759.267684215843;23849.284521464382;23895.880520597286;23974.880125599262 09:59:50 INFO - PID 13802 | |2;jquery.html;412.15713865145773;423.0821242972781;431.63958094990693;439.16996875904545;441.18821368681637;14309.427622895098;15090.924545377286;19695.606087878234;20481;20494.282700105497;20760.584788304226;21639.783602163974;21675.241366552174;21684.132634694593;21704.782952170473;5787.797427090063;5942.61373010753;5945.197398351233;5945.9108113378115;5946.881062378749;5800.680962547058;5868.706564671771;5878.617889837168;5879.617824841393;5889.85275368115;5826.82519524415;5834.124881267801;5852.76588936442;6237.157983672191;6550.70521826519;6438.259600145973;6480.773172938948;6495.188101487314;6495.31799161086;6500.512461565401;6348.904766428507;6356.586821856565;6365.29981702017;6382.936170638327;6397.776077837253;26148;26588.202353929413;26702.19893403201;26763.19710408691;26878.865605671846;1854.3973208707089;1941.1361943934955;1947.3476385410904;1976.5355141541727;1985.1563085688524;16889.15554222296;17156.485305440732;17181.484555463358;17283.567910802205;17300.307987680477;2317.1774020222915;2349.1660460536605;2424;2424.284835973392;2425.3087869957153;115158;115613;116848.41575792067;117646.41176794062;117843.99999999914;18290.451286461426;18888.81111188898;19211.423657290023;19295.51761205981;19299.614007719767;35648.82175589157;35727.4640880387;35746.821265894025;35781;36155;10316.896831031594;10433.947830260951;10458.843117353246;10545.525451354708;10606.734831629272;8627.094155113622;8667.479951202948;8678.088800675965;8701.260392866678;8751.518666473405;10192.388456692623;10205.214087534652;10213.182945364353;10400.27198096126;10467.633632822966;2077.0653206057336;2098.3495116513927;2111.4510227341;2120.300300900699;2202.6916231727573;943.0946291560042;952.3904601223909;973.7681832481916;978.848278516831;987.1510500969305;18207.90896045511;18210.27158913655;18314;18929.90535047316;19219.80780192208;986.6694657289745;1000.444753162002;1014.8224060789332;1024.7233247023262;1052.9105026072716;9917.206623470105;10024.398536087858;10601.946990265;10738.135075690223;10869.369594560721;425958;430732.23169421015;455271;460102;468520;90386.54806725924;93710.53144734232;96510;96777.5161124204;96930;1193.4868006757004;1195.121585634558;1245.875412458765;1246.8316777235138;1255.4664267686196;17068.402605908734;17274;18473.72289415687;19205.135768890155;19209.423717288504;48535;49888.25167622416;50089.24866126938;50785.23822142745;51514;60853.39146608477;62038.68980655249;62148.37851621607;62317.37682623116;62552.374476256475;9758.658446954607;10220.284580079324;10246.795064098826;10271.845922311022;10339.276250662682;16561.66876662484;17689.823101768816;17770.20034098443;17869.46391608254;17976.123820188706;14677.48628797987;14684.632884177981;14749.778753318924;14769.341518526768;14816.185109819064;12613.81079283793;12665.683357915757;12889.871101288867;12949.604323200238;13562.254076025518;13968.511102111377;14271.21508317011;14321.498747543787;14391;14423.42306307736;9825.115739583473;9842.21262299;9844.2124630028;9851.605935762489;9862.161716254199;13390.933045335101;13536.661583460493;13545.187288762705;13874.098183618033;13974.510892118727 09:59:50 INFO - PID 13802 | |3;mootools.html;1271.7138643805145;1330.8469526004505;1337.9697632822727;1344.6839992601742;1357.925314107724;10569.78860422792;11021.834672479908;11075.778484430306;11103.167262455328;11459;11213.607523736671;11309.49107290172;11424.828627570592;11456.51065361504;11501.079913606913;2300.3444018454784;2347.307544274443;2351.600227961242;2351.7648235176516;2355.3640517060385;2312.3294244669028;2388.8327817052814;2395.2933884504114;2396.508715713275;2403.927882163538;2254.0420321363436;2255.6278214094655;2282.669012993115;2303.7465878753324;2312.0867257433306;2257.864528128301;2283.1095872609694;2287.805536529397;2294.5755035318434;2303.9078436862505;2170.0994087453687;2176.738791345033;2180.7928246816527;2181.149351752818;2183.2467798609455;10864.945675271652;11083.778324433546;11083.944580277128;11102;11115.666530004113;6061.363556826514;6266.686665666698;6323.588966717149;6358.141650877119;6365.681715914186;3515.244222492151;3587.6232995535615;3689.594144644087;3705.6850167735774;3715.2198038411966;1263.9368031598383;1269.6952731344504;1290.8450985881755;1291.5027714329956;1300.5383089003362;14345.928270358685;14844.554663360008;15416.768748468781;15561;15622;5071.87320316995;5124;5241.764120614505;5245.160774276097;5260.342457192851;11856.17006809515;11967.102467314986;11983.64049078529;12045.457954392074;12049.457774400173;6017.819465416044;6144.662043587557;6148.78479253224;6153.815385538441;6164.815055548341;5700.8859822803315;5743.741531631086;5759.308882934075;5769.740361683735;5898.557608179403;4136.9331771607385;4184.4351012613515;4212.157568486315;4251.3622956556765;4271.402003719481;1196.7427003194355;1201.0123246027663;1218.9939050304693;1219.969500762488;1223.8470191226097;820.9917900821035;837.6398148796076;840.369722707969;852.1648784191403;881.6914080071923;5779.190913272145;5863.610566248135;6009.759609615567;6036.5170786336985;6123.601965872204;608.4037643109777;625.6777759453885;627.7489004398277;641.884460797061;645.2869579115104;3962.049108214008;3994.72036957416;4181.770002649822;4499.347594598765;4527.615152712056;13363.866361336262;14106;14173.149611023166;14207.289635518182;14220.217888016052;13901.860981390057;13938;14101;14125.081869678437;14159.292035398188;8384.8742268866;8938.10618938114;8989.595468204077;9013;9024.774380640536;5866.2960444746905;6619.834504137435;6672.466202703869;6928.648913462028;7233.312835280851;11957.282563046245;12148.696282593006;12195.51217951272;12247.632571022883;12428.937855310665;12935.417906194432;12991.610251692464;13006.219626822422;13070.346482675637;13216.603501894573;8937.865932010895;9053.094690530894;9088.136627020422;9124.17882390588;9125.406848554823;10354.534045968101;10427.113695335982;10478.056974872297;10486.895131048592;10495.212859035755;8690.565471726262;8699.608517616596;8878.245349145136;8924.732258032269;9186.402883812798;8562.48625082497;8571.142885711379;8704.60829262672;8751.562421879007;8938.37431379797;7138.750143744944;8173.509589424653;8271.33829293667;8275.462094963808;8292.626831792704;5478.91781623284;5566.22072909801;5634.464725851038;5637.2107904894165;5766.07742761173;5769.105788602773;6013.218281623361;6120.785772497941;6227.532935029801;6380.553361264667 09:59:50 INFO - PID 13802 | |4;prototype.html;391.36794077564724;401.32577270186084;411.1961116018185;412.544138726707;413.32008845449246;6084.543659225565;6234.251889773228;6261.15474410955;6269.9373006269925;6285.434310912017;5894.322152952412;5992.3108842483125;6003.499125218696;6003.909941350883;6008.218931538905;4710.952890471103;4760.190767569504;4762.880927976802;4763.857084287477;4765.332853400527;4742.05158968206;4791.448983366905;4797.7121372717575;4797.928031079537;4810.567048965592;4738.460000499851;4741;4745.311929770181;4754.762261886909;4757.26262429324;4747.335373047758;4763.285507173917;4776.713397196179;4781;4795.2087905495555;4176.582341765829;4181.707280490367;4189;4194.343234422417;4198.748075115473;5981.773736384031;5994.155698194226;6008.437806170427;6032.4570788629235;6041.335453100155;5415.83752487426;5427.48438898304;5430.891382172374;5434.3207099112615;5447.12845944647;6434;6451.741930322782;6460.289368169498;6462.159919210472;6468.8059358219325;4534.183846907556;4542.523035081335;4544.113897789933;4544.182047231497;4555.840545580889;6443.903341449882;6787.55880867747;6810.387065164109;6835.7949261521735;6855.5543889647015;4627.95372046282;4639.376218323628;4646.837360692427;4661.440627124767;4680.134175177603;4658.1848176568965;4659.394278743809;4671.948811517382;4689.390379250675;4694.319323698045;5193.350831146106;5375.489328513785;5385.434529374359;5410.756515956791;5433.755481003364;6471.285109446;6512.41388275048;6516.57642253252;6517.641529715816;6527.584793626389;1606.4538057060422;1608.1155364549452;1625.2198944506704;1625.8862679064878;1639.1230691580186;1052.321252791945;1094.5949998500446;1103.178132291448;1104.7679987202616;1115.1691989467736;5730.5129064030025;5735.483806457439;5735.942640573624;5748.166515855178;5750.6262092963825;6698.933010669928;6699.598024118569;6709.36261055199;6728.495362847708;6737.831554211086;5677.006523858308;5683.232763576947;5708.229389032511;5722.020488589434;5736.77052917887;3567.4113771227458;3572.696320812708;3575.213453040327;3580.838862251153;3581.8030008349792;6499.480041596756;6503.154589903283;6528.640924749185;6536.607803531708;6555.508336874754;6749.966250168718;6783.59298442095;6824.863502729918;6841.110655614738;6871.209810871714;6386.808395748135;6479.319671434526;6485.605594797141;6517.327895562797;6567.179102612174;6731.562448440835;6744.763933262312;6753.223379311442;6756.527043106936;6777.7799996001195;6282.340354262919;6669.899951500828;6689.2976237496305;6703.262641109572;6716.5634233774645;6434.678266086583;6476.773312934025;6505.544611877123;6542.34576542342;6547.836304092436;4591.127685739699;4593.563611456906;4596.9543553119875;4613.838515651936;4632.420947381577;6444.7744328948265;6662.433693136138;6683.498737594797;6707.698153583198;6723.033410287953;6538.215414150142;6539.901901471387;6560.278369379269;6575.375339342755;6596.835079122869;6487.156669632917;6491.156149700509;6503.902441463477;6561.901571476527;6567.9014814776865;6368.758092171982;6462.256840463407;6468.773592924225;6487.059376390492;6496.870062598816;6524.217093948757;6559.212894452697;6588.703508342041;6604.603723776589;6604.735810567524;6324.098823411892;6368.9044664330995;6396.48828093742;6423.7430502781235;6424.743010279536 09:59:50 INFO - PID 13802 | |5;yui.html;811.3509192645881;830.9210624990627;835.269139502935;841.9391566626049;858.8497013022721;15371.692566148684;15649.452269170568;15766.448174313902;17310.826891731078;18383.632327353444;17332;17615.383461578847;17977.550561235974;17986.550336241602;18016.729749053742;921.880155579777;948.2603569216022;952.2477242978074;954.0364232125569;957.310736269888;896.3949334199422;1002.8946960569144;1003.0972125087407;1004.7387679203387;1011.989880101197;1059.4120263253892;1060.4379678770265;1060.5068643080965;1061.2306078093397;1066.2855886556026;1054.1250761867632;1054.910332621728;1055.688571871296;1056.778076603914;1057.6404022632264;773.767869639106;773.7756050745277;774.1445702498714;774.9922500774976;775.255754475704;15530.378784848592;16012.919935400365;16152.111633860133;16161;16185.190740463047;18329.633407331778;18735.437936861916;18746.156422961;18805.341813036615;18887.244510219713;14681.192534410604;15292.158931258888;15296.541103766906;15335.769963450557;15451.459198928096;3419.12812232879;3452.482127680843;3462.4286992646184;3561.28774245152;3565.982170089133;87216.56391718001;87235;88911;89070.99999999935;89591.10408895893;14585;14750.04124731889;14848.554543363716;14863.628409289855;14898;26454.33864153373;26535.867320663274;27710.445791084065;27929.860350698524;27969.860150699114;7619.961900190464;7786.1435242123325;8143.267105960374;8213.671453141927;8250.669973201126;3723.497327860704;3824.4454554089502;3827.5406951166037;3831.63599458051;3845.307844588001;4143.233501802176;4207.978960105241;4212.72617279882;4227.091175397304;4278.764667943293;858.2233079063458;873.6505397840914;881.4402854187637;884.8274586455708;885.0883589902411;664.5049438168498;693.1405057728381;694.0768777525878;694.0838093716246;708.5819366573746;10767.97704218098;11738.823917641243;12375.62873113808;12620.368981550886;12889.355532223351;682.2597481732276;692.2005084127841;695.5374675840509;699.0388216202721;701.3967987530822;5432.718258331511;5533.22534845122;5869.911951320733;6219.626822390671;6309.968450157719;90123.54938225266;92332.53833730788;93511;93616;94413;77601.22398776053;80305;81043;81337;81390.59304703439;64475.35524644787;68049.65975170092;68664.3133568658;70625.2937470629;71580.64209678919;10713.196510261918;11155.944220278847;11571.942140289244;11742.941285293518;12234.143609947574;29429.85285073561;29748.55377169301;29775.70224297729;30069.248268793453;31159.221019474695;38291.23417531578;38367.42448863325;38401;38484.615153848106;39029.41455878107;17368.21843017042;17440.912795435943;17785.377511787025;17933.551661208574;17987;18416.539586510444;19600.50998724986;19647.115879785157;19757.50606234798;19845.106970186087;17165.828341716424;17307.653846923244;17539.298428063245;17636.911815441355;17866.91066544659;17211.655766884844;17472.475825725247;17583.824161758217;17731.911340443214;17929.462116136536;17361.47915562535;17466.650666986843;17607;17646.294148233927;17876;11431.771364572496;12202.572909948109;12205.145639805483;12285.508579656713;12611.117221794386;12932.482700691868;13134.59665942649;13963.371648276056;14725.263736813331;14739.705205895607 09:59:50 INFO - PID 13802 | __end_tp_report 09:59:50 INFO - PID 13802 | __start_cc_report 09:59:50 INFO - PID 13802 | _x_x_mozilla_cycle_collect,370 09:59:50 INFO - PID 13802 | __end_cc_report 09:59:50 INFO - PID 13802 | __startTimestamp1496681990078__endTimestamp 09:59:50 INFO - PID 13802 | 09:59:50 INFO - PID 13802 | ------- Summary: start ------- 09:59:50 INFO - PID 13802 | Number of tests: 6 09:59:50 INFO - PID 13802 | 09:59:50 INFO - PID 13802 | [#0] dojo.html Cycles:165 Average:5895.73 Median:6104.16 stddev:677.89 (11.1%) stddev-sans-first:642.54 09:59:50 INFO - PID 13802 | Values: 3064.1 3068.2 3082.6 3095.0 3100.8 5823.2 5855.2 5875.4 5904.5 5935.9 5965.1 5977.6 6035.8 6096.2 6122.4 5397.0 5450.5 5487.3 5488.9 5619.6 5558.3 5570.7 5582.5 5591.5 5595.6 5466.8 5488.7 5496.0 5506.3 5549.4 5483.1 5537.1 5545.9 5577.8 5619.5 5437.5 5488.7 5489.5 5490.3 5498.4 5891.3 5913.1 5945.2 5954.0 5964.9 6335.6 6347.4 6473.7 6488.6 6511.7 6444.0 6445.0 6456.5 6457.1 6463.9 5975.6 5978.8 5982.0 5991.7 5994.9 6497.4 6571.0 6578.2 6658.7 6692.9 6171.8 6226.2 6243.4 6296.8 6313.4 6422.0 6430.2 6430.8 6436.8 6446.7 6342.6 6353.4 6392.1 6404.0 6423.0 6277.7 6302.9 6367.1 6400.9 6429.6 5195.1 5201.2 5217.8 5244.1 5248.2 4443.3 4446.6 4449.7 4467.3 4483.3 5450.1 5507.7 5552.1 5557.8 5616.7 6340.4 6443.8 6450.2 6450.9 6466.1 5524.3 5529.4 5531.8 5536.8 5581.6 5565.5 5589.8 5628.3 5632.1 5635.8 6160.1 6182.2 6269.1 6272.4 6333.0 6385.0 6457.3 6458.1 6460.3 6466.4 6171.9 6213.6 6234.9 6244.3 6244.8 6204.0 6252.3 6254.5 6313.0 6375.0 6315.6 6343.6 6349.8 6376.7 6387.6 6078.7 6149.4 6230.5 6257.3 6265.3 6104.2 6121.2 6206.8 6218.8 6219.2 6027.2 6069.8 6073.7 6084.6 6109.8 6226.8 6258.1 6266.1 6267.6 6277.8 6034.2 6054.1 6086.1 6114.2 6136.9 09:59:50 INFO - PID 13802 | 09:59:50 INFO - PID 13802 | [#1] ext.html Cycles:180 Average:33737.68 Median:18902.79 stddev:45954.94 (243.1%) stddev-sans-first:46017.02 09:59:50 INFO - PID 13802 | Values: 731.3 780.2 806.4 1115.5 1134.4 35779.0 37072.4 37115.8 37124.4 37165.4 38364.4 38808.4 38813.0 38899.6 38904.2 7163.9 7253.5 7366.9 7380.7 7434.4 7266.5 7348.2 7363.0 7376.6 7380.7 7309.3 7324.9 7386.3 7389.6 7403.9 7271.9 7324.3 7353.3 7355.6 7357.5 7212.6 7236.3 7279.1 7283.2 7290.3 35663.3 35741.5 35781.5 35946.0 36047.3 3406.5 3452.4 3452.5 3453.7 3465.4 28039.3 28052.3 28168.3 28274.2 28349.9 3623.1 3625.3 3632.9 3651.5 3665.8 133637.0 136424.3 146285.0 158469.0 159579.0 41321.9 41826.0 41926.8 41928.6 41946.2 44147.6 44162.6 45398.5 46248.3 46617.3 14950.3 15163.8 15195.2 15206.3 15256.8 12316.1 12341.0 12373.3 12385.3 12387.0 13832.2 13913.4 13917.7 13969.1 14051.6 5551.9 5744.5 5803.5 5852.4 5874.2 936.2 983.8 984.3 998.9 1003.2 21750.0 22587.7 22766.7 22919.8 22965.2 1071.5 1071.6 1073.5 1076.5 1080.6 11351.6 11903.1 12149.8 12256.4 12871.4 207198.0 208111.0 208180.0 208204.0 208412.0 48960.5 49020.8 49143.5 49195.3 49452.8 1386.0 1418.0 1442.4 1445.9 1448.5 21048.8 21662.9 23205.8 23230.2 23325.8 35231.6 35321.5 35439.5 35506.6 35559.6 172131.0 172356.0 172971.0 173143.0 173193.0 32058.0 32799.7 33757.0 34089.0 34158.0 40374.4 40650.8 41279.4 41309.2 41541.6 29149.0 29910.0 30547.2 30588.9 30589.5 29258.4 30141.7 30370.5 31895.4 31990.4 33967.5 34353.1 34984.5 35033.3 35275.3 28858.8 29160.7 29751.7 29929.7 31007.7 21152.3 23759.3 23849.3 23895.9 23974.9 09:59:50 INFO - PID 13802 | 09:59:50 INFO - PID 13802 | [#2] jquery.html Cycles:180 Average:31125.77 Median:2115.88 stddev:74965.46 (3543.0%) stddev-sans-first:75140.29 09:59:50 INFO - PID 13802 | Values: 412.2 423.1 431.6 439.2 441.2 14309.4 15090.9 19695.6 20481.0 20494.3 20760.6 21639.8 21675.2 21684.1 21704.8 5787.8 5942.6 5945.2 5945.9 5946.9 5800.7 5868.7 5878.6 5879.6 5889.9 5826.8 5834.1 5852.8 6237.2 6550.7 6438.3 6480.8 6495.2 6495.3 6500.5 6348.9 6356.6 6365.3 6382.9 6397.8 26148.0 26588.2 26702.2 26763.2 26878.9 1854.4 1941.1 1947.3 1976.5 1985.2 16889.2 17156.5 17181.5 17283.6 17300.3 2317.2 2349.2 2424.0 2424.3 2425.3 115158.0 115613.0 116848.4 117646.4 117844.0 18290.5 18888.8 19211.4 19295.5 19299.6 35648.8 35727.5 35746.8 35781.0 36155.0 10316.9 10433.9 10458.8 10545.5 10606.7 8627.1 8667.5 8678.1 8701.3 8751.5 10192.4 10205.2 10213.2 10400.3 10467.6 2077.1 2098.3 2111.5 2120.3 2202.7 943.1 952.4 973.8 978.8 987.2 18207.9 18210.3 18314.0 18929.9 19219.8 986.7 1000.4 1014.8 1024.7 1052.9 9917.2 10024.4 10601.9 10738.1 10869.4 425958.0 430732.2 455271.0 460102.0 468520.0 90386.5 93710.5 96510.0 96777.5 96930.0 1193.5 1195.1 1245.9 1246.8 1255.5 17068.4 17274.0 18473.7 19205.1 19209.4 48535.0 49888.3 50089.2 50785.2 51514.0 60853.4 62038.7 62148.4 62317.4 62552.4 9758.7 10220.3 10246.8 10271.8 10339.3 16561.7 17689.8 17770.2 17869.5 17976.1 14677.5 14684.6 14749.8 14769.3 14816.2 12613.8 12665.7 12889.9 12949.6 13562.3 13968.5 14271.2 14321.5 14391.0 14423.4 9825.1 9842.2 9844.2 9851.6 9862.2 13390.9 13536.7 13545.2 13874.1 13974.5 09:59:50 INFO - PID 13802 | 09:59:50 INFO - PID 13802 | [#3] mootools.html Cycles:180 Average:6790.93 Median:3551.43 stddev:4282.95 (120.6%) stddev-sans-first:4274.88 09:59:50 INFO - PID 13802 | Values: 1271.7 1330.8 1338.0 1344.7 1357.9 10569.8 11021.8 11075.8 11103.2 11459.0 11213.6 11309.5 11424.8 11456.5 11501.1 2300.3 2347.3 2351.6 2351.8 2355.4 2312.3 2388.8 2395.3 2396.5 2403.9 2254.0 2255.6 2282.7 2303.7 2312.1 2257.9 2283.1 2287.8 2294.6 2303.9 2170.1 2176.7 2180.8 2181.1 2183.2 10864.9 11083.8 11083.9 11102.0 11115.7 6061.4 6266.7 6323.6 6358.1 6365.7 3515.2 3587.6 3689.6 3705.7 3715.2 1263.9 1269.7 1290.8 1291.5 1300.5 14345.9 14844.6 15416.8 15561.0 15622.0 5071.9 5124.0 5241.8 5245.2 5260.3 11856.2 11967.1 11983.6 12045.5 12049.5 6017.8 6144.7 6148.8 6153.8 6164.8 5700.9 5743.7 5759.3 5769.7 5898.6 4136.9 4184.4 4212.2 4251.4 4271.4 1196.7 1201.0 1219.0 1220.0 1223.8 821.0 837.6 840.4 852.2 881.7 5779.2 5863.6 6009.8 6036.5 6123.6 608.4 625.7 627.7 641.9 645.3 3962.0 3994.7 4181.8 4499.3 4527.6 13363.9 14106.0 14173.1 14207.3 14220.2 13901.9 13938.0 14101.0 14125.1 14159.3 8384.9 8938.1 8989.6 9013.0 9024.8 5866.3 6619.8 6672.5 6928.6 7233.3 11957.3 12148.7 12195.5 12247.6 12428.9 12935.4 12991.6 13006.2 13070.3 13216.6 8937.9 9053.1 9088.1 9124.2 9125.4 10354.5 10427.1 10478.1 10486.9 10495.2 8690.6 8699.6 8878.2 8924.7 9186.4 8562.5 8571.1 8704.6 8751.6 8938.4 7138.8 8173.5 8271.3 8275.5 8292.6 5478.9 5566.2 5634.5 5637.2 5766.1 5769.1 6013.2 6120.8 6227.5 6380.6 09:59:50 INFO - PID 13802 | 09:59:50 INFO - PID 13802 | [#4] prototype.html Cycles:180 Average:5392.90 Median:6006.06 stddev:1592.61 (26.5%) stddev-sans-first:1552.21 09:59:50 INFO - PID 13802 | Values: 391.4 401.3 411.2 412.5 413.3 6084.5 6234.3 6261.2 6269.9 6285.4 5894.3 5992.3 6003.5 6003.9 6008.2 4711.0 4760.2 4762.9 4763.9 4765.3 4742.1 4791.4 4797.7 4797.9 4810.6 4738.5 4741.0 4745.3 4754.8 4757.3 4747.3 4763.3 4776.7 4781.0 4795.2 4176.6 4181.7 4189.0 4194.3 4198.7 5981.8 5994.2 6008.4 6032.5 6041.3 5415.8 5427.5 5430.9 5434.3 5447.1 6434.0 6451.7 6460.3 6462.2 6468.8 4534.2 4542.5 4544.1 4544.2 4555.8 6443.9 6787.6 6810.4 6835.8 6855.6 4628.0 4639.4 4646.8 4661.4 4680.1 4658.2 4659.4 4671.9 4689.4 4694.3 5193.4 5375.5 5385.4 5410.8 5433.8 6471.3 6512.4 6516.6 6517.6 6527.6 1606.5 1608.1 1625.2 1625.9 1639.1 1052.3 1094.6 1103.2 1104.8 1115.2 5730.5 5735.5 5735.9 5748.2 5750.6 6698.9 6699.6 6709.4 6728.5 6737.8 5677.0 5683.2 5708.2 5722.0 5736.8 3567.4 3572.7 3575.2 3580.8 3581.8 6499.5 6503.2 6528.6 6536.6 6555.5 6750.0 6783.6 6824.9 6841.1 6871.2 6386.8 6479.3 6485.6 6517.3 6567.2 6731.6 6744.8 6753.2 6756.5 6777.8 6282.3 6669.9 6689.3 6703.3 6716.6 6434.7 6476.8 6505.5 6542.3 6547.8 4591.1 4593.6 4597.0 4613.8 4632.4 6444.8 6662.4 6683.5 6707.7 6723.0 6538.2 6539.9 6560.3 6575.4 6596.8 6487.2 6491.2 6503.9 6561.9 6567.9 6368.8 6462.3 6468.8 6487.1 6496.9 6524.2 6559.2 6588.7 6604.6 6604.7 6324.1 6368.9 6396.5 6423.7 6424.7 09:59:50 INFO - PID 13802 | 09:59:50 INFO - PID 13802 | [#5] yui.html Cycles:180 Average:19384.42 Median:27123.16 stddev:24362.61 (89.8%) stddev-sans-first:24391.03 09:59:50 INFO - PID 13802 | Values: 811.4 830.9 835.3 841.9 858.8 15371.7 15649.5 15766.4 17310.8 18383.6 17332.0 17615.4 17977.6 17986.6 18016.7 921.9 948.3 952.2 954.0 957.3 896.4 1002.9 1003.1 1004.7 1012.0 1059.4 1060.4 1060.5 1061.2 1066.3 1054.1 1054.9 1055.7 1056.8 1057.6 773.8 773.8 774.1 775.0 775.3 15530.4 16012.9 16152.1 16161.0 16185.2 18329.6 18735.4 18746.2 18805.3 18887.2 14681.2 15292.2 15296.5 15335.8 15451.5 3419.1 3452.5 3462.4 3561.3 3566.0 87216.6 87235.0 88911.0 89071.0 89591.1 14585.0 14750.0 14848.6 14863.6 14898.0 26454.3 26535.9 27710.4 27929.9 27969.9 7620.0 7786.1 8143.3 8213.7 8250.7 3723.5 3824.4 3827.5 3831.6 3845.3 4143.2 4208.0 4212.7 4227.1 4278.8 858.2 873.7 881.4 884.8 885.1 664.5 693.1 694.1 694.1 708.6 10768.0 11738.8 12375.6 12620.4 12889.4 682.3 692.2 695.5 699.0 701.4 5432.7 5533.2 5869.9 6219.6 6310.0 90123.5 92332.5 93511.0 93616.0 94413.0 77601.2 80305.0 81043.0 81337.0 81390.6 64475.4 68049.7 68664.3 70625.3 71580.6 10713.2 11155.9 11571.9 11742.9 12234.1 29429.9 29748.6 29775.7 30069.2 31159.2 38291.2 38367.4 38401.0 38484.6 39029.4 17368.2 17440.9 17785.4 17933.6 17987.0 18416.5 19600.5 19647.1 19757.5 19845.1 17165.8 17307.7 17539.3 17636.9 17866.9 17211.7 17472.5 17583.8 17731.9 17929.5 17361.5 17466.7 17607.0 17646.3 17876.0 11431.8 12202.6 12205.1 12285.5 12611.1 12932.5 13134.6 13963.4 14725.3 14739.7 09:59:50 INFO - PID 13802 | -------- Summary: end -------- 09:59:50 INFO - PID 13802 | 09:59:51 INFO - TEST-INFO | 13802: exit 0 09:59:51 INFO - TEST-OK | dromaeo_css | took 1142157ms 09:59:51 INFO - TEST-START | kraken 09:59:51 INFO - operating with platform_type : linux_ 09:59:51 INFO - Initialising browser for kraken test... 09:59:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45425/getInfo.html -profile /tmp/tmpyeL4oC/profile 09:59:51 INFO - TEST-INFO | started process 14214 (/builds/slave/test/build/application/firefox/firefox http://localhost:45425/getInfo.html) 10:00:25 INFO - TEST-INFO | 14214: killed by SIGTERM 10:00:25 INFO - Browser initialized. 10:00:25 INFO - Running cycle 1/1 for kraken test... 10:00:25 INFO - TEST-INFO | started process 14420 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyeL4oC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:00:37 INFO - PID 14420 | RSS: Main: 187478016 10:00:37 INFO - PID 14420 | 10:00:40 INFO - PID 14420 | Cycle 1(1): loaded http://localhost:45425/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45425/tests/kraken/driver.html?testName=audio-beat-detection) 10:00:41 INFO - PID 14420 | RSS: Main: 191266816 10:00:41 INFO - PID 14420 | 10:00:43 INFO - PID 14420 | Cycle 1(1): loaded http://localhost:45425/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45425/tests/kraken/driver.html?testName=audio-dft) 10:00:44 INFO - PID 14420 | RSS: Main: 190222336 10:00:44 INFO - PID 14420 | 10:00:47 INFO - PID 14420 | Cycle 1(1): loaded http://localhost:45425/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45425/tests/kraken/driver.html?testName=audio-fft) 10:00:47 INFO - PID 14420 | RSS: Main: 185208832 10:00:47 INFO - PID 14420 | 10:00:49 INFO - PID 14420 | Cycle 1(1): loaded http://localhost:45425/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45425/tests/kraken/driver.html?testName=audio-oscillator) 10:00:50 INFO - PID 14420 | RSS: Main: 185913344 10:00:50 INFO - PID 14420 | 10:00:52 INFO - PID 14420 | Cycle 1(1): loaded http://localhost:45425/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45425/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:00:53 INFO - PID 14420 | RSS: Main: 186621952 10:00:53 INFO - PID 14420 | 10:00:56 INFO - PID 14420 | Cycle 1(1): loaded http://localhost:45425/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45425/tests/kraken/driver.html?testName=imaging-darkroom) 10:00:56 INFO - PID 14420 | RSS: Main: 187604992 10:00:56 INFO - PID 14420 | 10:01:00 INFO - PID 14420 | Cycle 1(1): loaded http://localhost:45425/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45425/tests/kraken/driver.html?testName=imaging-desaturate) 10:01:01 INFO - PID 14420 | RSS: Main: 186642432 10:01:01 INFO - PID 14420 | 10:01:03 INFO - PID 14420 | Cycle 1(1): loaded http://localhost:45425/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45425/tests/kraken/driver.html?testName=json-parse-financial) 10:01:04 INFO - PID 14420 | RSS: Main: 187666432 10:01:04 INFO - PID 14420 | 10:01:06 INFO - PID 14420 | Cycle 1(1): loaded http://localhost:45425/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45425/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:01:06 INFO - PID 14420 | RSS: Main: 187527168 10:01:06 INFO - PID 14420 | 10:01:08 INFO - PID 14420 | Cycle 1(1): loaded http://localhost:45425/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45425/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:01:09 INFO - PID 14420 | RSS: Main: 187228160 10:01:09 INFO - PID 14420 | 10:01:11 INFO - PID 14420 | Cycle 1(1): loaded http://localhost:45425/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45425/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:01:12 INFO - PID 14420 | RSS: Main: 187981824 10:01:12 INFO - PID 14420 | 10:01:14 INFO - PID 14420 | Cycle 1(1): loaded http://localhost:45425/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45425/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:01:15 INFO - PID 14420 | RSS: Main: 187420672 10:01:15 INFO - PID 14420 | 10:01:18 INFO - PID 14420 | Cycle 1(1): loaded http://localhost:45425/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45425/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:01:19 INFO - PID 14420 | RSS: Main: 187633664 10:01:19 INFO - PID 14420 | 10:01:20 INFO - PID 14420 | Cycle 1(1): loaded http://localhost:45425/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45425/tests/kraken/driver.html?testName=ai-astar) 10:01:21 INFO - PID 14420 | RSS: Main: 188620800 10:01:21 INFO - PID 14420 | 10:01:21 INFO - PID 14420 | __start_tp_report 10:01:21 INFO - PID 14420 | _x_x_mozilla_page_load 10:01:21 INFO - PID 14420 | _x_x_mozilla_page_load_details 10:01:21 INFO - PID 14420 | |i|pagename|runs| 10:01:21 INFO - PID 14420 | |0;ai-astar;104;113;114;110;111;113;111;112;111;114 10:01:21 INFO - PID 14420 | |1;audio-beat-detection;146;120;122;184;125;123;123;124;144;129 10:01:21 INFO - PID 14420 | |2;audio-dft;164;164;164;163;162;164;168;170;167;163 10:01:21 INFO - PID 14420 | |3;audio-fft;76;78;75;112;75;78;79;75;103;75 10:01:21 INFO - PID 14420 | |4;audio-oscillator;82;82;107;82;85;81;98;83;82;104 10:01:21 INFO - PID 14420 | |5;imaging-gaussian-blur;114;113;113;114;114;115;114;113;114;115 10:01:21 INFO - PID 14420 | |6;imaging-darkroom;150;151;150;152;150;150;149;150;149;151 10:01:21 INFO - PID 14420 | |7;imaging-desaturate;95;100;96;96;96;94;94;95;94;94 10:01:21 INFO - PID 14420 | |8;json-parse-financial;53;54;53;55;54;55;55;54;53;54 10:01:21 INFO - PID 14420 | |9;json-stringify-tinderbox;57;57;56;56;55;56;56;56;56;56 10:01:21 INFO - PID 14420 | |10;stanford-crypto-aes;89;87;87;86;87;88;90;88;113;93 10:01:21 INFO - PID 14420 | |11;stanford-crypto-ccm;131;138;132;134;129;132;132;131;131;142 10:01:21 INFO - PID 14420 | |12;stanford-crypto-pbkdf2;212;199;193;198;195;196;196;185;183;193 10:01:21 INFO - PID 14420 | |13;stanford-crypto-sha256-iterative;78;75;73;74;72;70;71;75;71;74 10:01:21 INFO - PID 14420 | __end_tp_report 10:01:21 INFO - PID 14420 | __start_cc_report 10:01:21 INFO - PID 14420 | _x_x_mozilla_cycle_collect,1008 10:01:21 INFO - PID 14420 | __end_cc_report 10:01:21 INFO - PID 14420 | __startTimestamp1496682081173__endTimestamp 10:01:21 INFO - PID 14420 | 10:01:21 INFO - PID 14420 | ------- Summary: start ------- 10:01:21 INFO - PID 14420 | Number of tests: 14 10:01:21 INFO - PID 14420 | 10:01:21 INFO - PID 14420 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.50 stddev:2.91 (2.6%) stddev-sans-first:1.45 10:01:21 INFO - PID 14420 | Values: 104.0 113.0 114.0 110.0 111.0 113.0 111.0 112.0 111.0 114.0 10:01:21 INFO - PID 14420 | 10:01:21 INFO - PID 14420 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:127.00 stddev:19.81 (15.6%) stddev-sans-first:20.53 10:01:21 INFO - PID 14420 | Values: 146.0 120.0 122.0 184.0 125.0 123.0 123.0 124.0 144.0 129.0 10:01:21 INFO - PID 14420 | 10:01:21 INFO - PID 14420 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.00 stddev:2.56 (1.6%) stddev-sans-first:2.69 10:01:21 INFO - PID 14420 | Values: 164.0 164.0 164.0 163.0 162.0 164.0 168.0 170.0 167.0 163.0 10:01:21 INFO - PID 14420 | 10:01:21 INFO - PID 14420 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.50 stddev:13.38 (17.7%) stddev-sans-first:13.97 10:01:21 INFO - PID 14420 | Values: 76.0 78.0 75.0 112.0 75.0 78.0 79.0 75.0 103.0 75.0 10:01:21 INFO - PID 14420 | 10:01:21 INFO - PID 14420 | [#4] audio-oscillator Cycles:10 Average:88.60 Median:82.00 stddev:10.22 (12.5%) stddev-sans-first:10.56 10:01:21 INFO - PID 14420 | Values: 82.0 82.0 107.0 82.0 85.0 81.0 98.0 83.0 82.0 104.0 10:01:21 INFO - PID 14420 | 10:01:21 INFO - PID 14420 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 10:01:21 INFO - PID 14420 | Values: 114.0 113.0 113.0 114.0 114.0 115.0 114.0 113.0 114.0 115.0 10:01:21 INFO - PID 14420 | 10:01:21 INFO - PID 14420 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:150.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 10:01:21 INFO - PID 14420 | Values: 150.0 151.0 150.0 152.0 150.0 150.0 149.0 150.0 149.0 151.0 10:01:21 INFO - PID 14420 | 10:01:21 INFO - PID 14420 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:1.84 (1.9%) stddev-sans-first:1.94 10:01:21 INFO - PID 14420 | Values: 95.0 100.0 96.0 96.0 96.0 94.0 94.0 95.0 94.0 94.0 10:01:21 INFO - PID 14420 | 10:01:21 INFO - PID 14420 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.78 10:01:21 INFO - PID 14420 | Values: 53.0 54.0 53.0 55.0 54.0 55.0 55.0 54.0 53.0 54.0 10:01:21 INFO - PID 14420 | 10:01:21 INFO - PID 14420 | [#9] json-stringify-tinderbox Cycles:10 Average:56.10 Median:56.00 stddev:0.57 (1.0%) stddev-sans-first:0.50 10:01:21 INFO - PID 14420 | Values: 57.0 57.0 56.0 56.0 55.0 56.0 56.0 56.0 56.0 56.0 10:01:21 INFO - PID 14420 | 10:01:21 INFO - PID 14420 | [#10] stanford-crypto-aes Cycles:10 Average:90.80 Median:88.00 stddev:8.05 (9.2%) stddev-sans-first:8.51 10:01:21 INFO - PID 14420 | Values: 89.0 87.0 87.0 86.0 87.0 88.0 90.0 88.0 113.0 93.0 10:01:21 INFO - PID 14420 | 10:01:21 INFO - PID 14420 | [#11] stanford-crypto-ccm Cycles:10 Average:133.20 Median:132.00 stddev:3.91 (3.0%) stddev-sans-first:4.07 10:01:21 INFO - PID 14420 | Values: 131.0 138.0 132.0 134.0 129.0 132.0 132.0 131.0 131.0 142.0 10:01:21 INFO - PID 14420 | 10:01:21 INFO - PID 14420 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.00 Median:196.00 stddev:7.94 (4.1%) stddev-sans-first:5.56 10:01:21 INFO - PID 14420 | Values: 212.0 199.0 193.0 198.0 195.0 196.0 196.0 185.0 183.0 193.0 10:01:21 INFO - PID 14420 | 10:01:21 INFO - PID 14420 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:74.00 stddev:2.41 (3.3%) stddev-sans-first:1.86 10:01:21 INFO - PID 14420 | Values: 78.0 75.0 73.0 74.0 72.0 70.0 71.0 75.0 71.0 74.0 10:01:21 INFO - PID 14420 | -------- Summary: end -------- 10:01:21 INFO - PID 14420 | 10:01:22 INFO - TEST-INFO | 14420: exit 0 10:01:22 INFO - TEST-OK | kraken | took 91352ms 10:01:22 INFO - SUITE-END | took 1233s 10:01:22 INFO - Completed test suite (00:20:34) 10:01:22 INFO - javascript benchmark 10:01:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7704.306799235738, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3064.126723883693, 3068.2329417645587, 3082.5992620959287, 3094.9535756963637, 3100.767442441816, 5823.155642431845, 5855.151003104547, 5875.412458754128, 5904.527637788978, 5935.85160370991, 5965.10523421487, 5977.641341519501, 6035.849103772408, 6096.177016102824, 6122.387761223876, 5396.973015134939, 5450.4549545045475, 5487.259220005308, 5488.862778430551, 5619.6066275360745, 5558.333000040001, 5570.721463926808, 5582.49757521823, 5591.4688104630195, 5595.580331475136, 5466.753996070186, 5488.69812160331, 5496.038193316193, 5506.256655351536, 5549.361823390322, 5483.122700367961, 5537.1140617501405, 5545.861353466155, 5577.832665020056, 5619.466150715675, 5437.456254374571, 5488.725563721798, 5489.451054894518, 5490.313710786152, 5498.422665620133, 5891.263592050994, 5913.113033045035, 5945.16767652529, 5953.970230148865, 5964.850878728066, 6335.619862808247, 6347.39699728525, 6473.708683109271, 6488.610683359014, 6511.706973186218, 6444.0, 6445.0, 6456.548041637087, 6457.0637257597855, 6463.870722585522, 5975.581709280309, 5978.760849566055, 5982.0, 5991.670458124801, 5994.8501287467725, 6497.4477169441125, 6571.0, 6578.177727784027, 6658.7336506539195, 6692.899606505906, 6171.783987560414, 6226.221722284715, 6243.406876346739, 6296.811095667137, 6313.40022697843, 6422.0, 6430.196225471816, 6430.839229019312, 6436.806895793134, 6446.709898054599, 6342.5560210785725, 6353.36466353361, 6392.137061496732, 6404.039394090923, 6422.967885160544, 6277.748890044347, 6302.936970630327, 6367.108604795332, 6400.871982560323, 6429.6142231466265, 5195.142801437796, 5201.219817027476, 5217.765200565984, 5244.108501554745, 5248.212768084818, 4443.311286750494, 4446.577575130357, 4449.666275029385, 4467.321449017085, 4483.349914262414, 5450.127979523258, 5507.7246137692955, 5552.08390615552, 5557.805476808292, 5616.66300022, 6340.397662222082, 6443.806685799434, 6450.161479007699, 6450.870982580416, 6466.1270728452, 5524.33707955048, 5529.4470552944385, 5531.751071201806, 5536.833894983157, 5581.6371935824045, 5565.499105080562, 5589.804356847572, 5628.296462942132, 5632.070708333161, 5635.830925072172, 6160.10678451631, 6182.227221597301, 6269.090981807703, 6272.40412160844, 6332.968335158294, 6384.968075159594, 6457.289698133295, 6458.128152699325, 6460.25707043696, 6466.418022378009, 6171.876562468815, 6213.565050446426, 6234.875302494015, 6244.313125556095, 6244.843878903063, 6204.038374052029, 6252.343503932204, 6254.530910181846, 6313.0, 6374.968125159345, 6315.557910946373, 6343.619382837044, 6349.841253968688, 6376.74493020274, 6387.584806987531, 6078.665673388006, 6149.354317796746, 6230.50155987529, 6257.342978987141, 6265.342139075331, 6104.156010547632, 6121.178620693132, 6206.751729930933, 6218.787336469526, 6219.222597175353, 6027.246594175728, 6069.787557435468, 6073.665948372882, 6084.60450070744, 6109.75560977556, 6226.750929962751, 6258.123862659322, 6266.091416744638, 6267.592606480564, 6277.843053923506, 6034.24571928509, 6054.091886217103, 6086.147939288415, 6114.236541168587, 6136.917362303726], "value": 5846.292248869573, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.3381389842194, 780.1652232111641, 806.4153488720676, 1115.4534278203678, 1134.3704244144496, 35779.0, 37072.44391334129, 37115.814420927854, 37124.44313335302, 37165.442518362215, 38364.42453363195, 38808.417873731916, 38813.0, 38899.61100389002, 38904.22191556167, 7163.928360716378, 7253.455990800698, 7366.852662946738, 7380.74167404141, 7434.442416818733, 7266.527675701089, 7348.228436014222, 7362.963185184093, 7376.594287314196, 7380.667869945839, 7309.269073092675, 7324.853502929938, 7386.335229829314, 7389.5935723535185, 7403.925960740405, 7271.854562908765, 7324.26757324266, 7353.338199562065, 7355.595442250701, 7357.521761085566, 7212.63936803163, 7236.276372362774, 7279.053723015974, 7283.162436319838, 7290.27097290272, 35663.28673426543, 35741.46387804185, 35781.46327805085, 35946.0, 36047.27905441877, 3406.5401170841865, 3452.4476083826717, 3452.5166476693284, 3453.6546345365264, 3465.3935561276926, 28039.29901752452, 28052.298692532644, 28168.295792605142, 28274.151775446768, 28349.858250708614, 3623.130448692295, 3625.29306785177, 3632.909177270563, 3651.543557055368, 3665.7617254878346, 133637.0, 136424.31787840996, 146285.0, 158469.0, 159579.0, 41321.900857435816, 41826.0, 41926.79036604858, 41928.58071419247, 41946.16107677829, 44147.558524414984, 44162.55837441584, 45398.546014540094, 46248.3062754059, 46617.27061835045, 14950.252487375588, 15163.848361516244, 15195.240237988057, 15206.315715792816, 15256.847431525764, 12316.076294277966, 12341.01271898246, 12373.257604543756, 12385.256884586954, 12387.0, 13832.239226842621, 13913.443462261395, 13917.652058698613, 13969.088655176567, 14051.648708782363, 5551.8889622207325, 5744.51171650406, 5803.5357171426185, 5852.4147585241135, 5874.1776151338845, 936.1901954809041, 983.8179936711731, 984.3454103021411, 998.8901220865699, 1003.227514813604, 21750.0, 22587.6791780186, 22766.65850012251, 22919.770802292096, 22965.196218132285, 1071.4856868703066, 1071.59815069349, 1073.511552243743, 1076.4671487613682, 1080.6433876820788, 11351.602693905674, 11903.106626410414, 12149.817752733716, 12256.44845981933, 12871.42078606465, 207198.0, 208111.0, 208180.0, 208204.0, 208412.0, 48960.51039489631, 49020.75489622529, 49143.508564914606, 49195.262071068966, 49452.752736236085, 1385.9930700346433, 1417.9574612761633, 1442.3509420760909, 1445.8843292536571, 1448.521987744042, 21048.789512104682, 21662.89168554147, 23205.76794232036, 23230.186943456898, 23325.76674233304, 35231.64768352284, 35321.470177947864, 35439.468407973385, 35506.644933550335, 35559.644403555634, 172131.0, 172356.0, 172971.0, 173143.0, 173193.0, 32058.0, 32799.67200327966, 33757.0, 34089.0, 34158.0, 40374.39438408367, 40650.79674601608, 41279.380809287286, 41309.173816524104, 41541.584584153774, 29149.0, 29910.0, 30547.2363190922, 30588.929387471333, 30589.54115688222, 29258.414831703674, 30141.698583014768, 30370.54444183295, 31895.362092758478, 31990.36019279555, 33967.49048764221, 34353.14117147091, 34984.47523287102, 35033.29933401267, 35275.29449410946, 28858.83970743628, 29160.7083929158, 29751.70248297489, 29929.70070299269, 31007.68992310048, 21152.25967091206, 23759.267684215843, 23849.284521464382, 23895.880520597286, 23974.880125599262], "value": 16067.439705498415, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.15713865145773, 423.0821242972781, 431.63958094990693, 439.16996875904545, 441.18821368681637, 14309.427622895098, 15090.924545377286, 19695.606087878234, 20481.0, 20494.282700105497, 20760.584788304226, 21639.783602163974, 21675.241366552174, 21684.132634694593, 21704.782952170473, 5787.797427090063, 5942.61373010753, 5945.197398351233, 5945.9108113378115, 5946.881062378749, 5800.680962547058, 5868.706564671771, 5878.617889837168, 5879.617824841393, 5889.85275368115, 5826.82519524415, 5834.124881267801, 5852.76588936442, 6237.157983672191, 6550.70521826519, 6438.259600145973, 6480.773172938948, 6495.188101487314, 6495.31799161086, 6500.512461565401, 6348.904766428507, 6356.586821856565, 6365.29981702017, 6382.936170638327, 6397.776077837253, 26148.0, 26588.202353929413, 26702.19893403201, 26763.19710408691, 26878.865605671846, 1854.3973208707089, 1941.1361943934955, 1947.3476385410904, 1976.5355141541727, 1985.1563085688524, 16889.15554222296, 17156.485305440732, 17181.484555463358, 17283.567910802205, 17300.307987680477, 2317.1774020222915, 2349.1660460536605, 2424.0, 2424.284835973392, 2425.3087869957153, 115158.0, 115613.0, 116848.41575792067, 117646.41176794062, 117843.99999999914, 18290.451286461426, 18888.81111188898, 19211.423657290023, 19295.51761205981, 19299.614007719767, 35648.82175589157, 35727.4640880387, 35746.821265894025, 35781.0, 36155.0, 10316.896831031594, 10433.947830260951, 10458.843117353246, 10545.525451354708, 10606.734831629272, 8627.094155113622, 8667.479951202948, 8678.088800675965, 8701.260392866678, 8751.518666473405, 10192.388456692623, 10205.214087534652, 10213.182945364353, 10400.27198096126, 10467.633632822966, 2077.0653206057336, 2098.3495116513927, 2111.4510227341, 2120.300300900699, 2202.6916231727573, 943.0946291560042, 952.3904601223909, 973.7681832481916, 978.848278516831, 987.1510500969305, 18207.90896045511, 18210.27158913655, 18314.0, 18929.90535047316, 19219.80780192208, 986.6694657289745, 1000.444753162002, 1014.8224060789332, 1024.7233247023262, 1052.9105026072716, 9917.206623470105, 10024.398536087858, 10601.946990265, 10738.135075690223, 10869.369594560721, 425958.0, 430732.23169421015, 455271.0, 460102.0, 468520.0, 90386.54806725924, 93710.53144734232, 96510.0, 96777.5161124204, 96930.0, 1193.4868006757004, 1195.121585634558, 1245.875412458765, 1246.8316777235138, 1255.4664267686196, 17068.402605908734, 17274.0, 18473.72289415687, 19205.135768890155, 19209.423717288504, 48535.0, 49888.25167622416, 50089.24866126938, 50785.23822142745, 51514.0, 60853.39146608477, 62038.68980655249, 62148.37851621607, 62317.37682623116, 62552.374476256475, 9758.658446954607, 10220.284580079324, 10246.795064098826, 10271.845922311022, 10339.276250662682, 16561.66876662484, 17689.823101768816, 17770.20034098443, 17869.46391608254, 17976.123820188706, 14677.48628797987, 14684.632884177981, 14749.778753318924, 14769.341518526768, 14816.185109819064, 12613.81079283793, 12665.683357915757, 12889.871101288867, 12949.604323200238, 13562.254076025518, 13968.511102111377, 14271.21508317011, 14321.498747543787, 14391.0, 14423.42306307736, 9825.115739583473, 9842.21262299, 9844.2124630028, 9851.605935762489, 9862.161716254199, 13390.933045335101, 13536.661583460493, 13545.187288762705, 13874.098183618033, 13974.510892118727], "value": 10833.454117965211, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1271.7138643805145, 1330.8469526004505, 1337.9697632822727, 1344.6839992601742, 1357.925314107724, 10569.78860422792, 11021.834672479908, 11075.778484430306, 11103.167262455328, 11459.0, 11213.607523736671, 11309.49107290172, 11424.828627570592, 11456.51065361504, 11501.079913606913, 2300.3444018454784, 2347.307544274443, 2351.600227961242, 2351.7648235176516, 2355.3640517060385, 2312.3294244669028, 2388.8327817052814, 2395.2933884504114, 2396.508715713275, 2403.927882163538, 2254.0420321363436, 2255.6278214094655, 2282.669012993115, 2303.7465878753324, 2312.0867257433306, 2257.864528128301, 2283.1095872609694, 2287.805536529397, 2294.5755035318434, 2303.9078436862505, 2170.0994087453687, 2176.738791345033, 2180.7928246816527, 2181.149351752818, 2183.2467798609455, 10864.945675271652, 11083.778324433546, 11083.944580277128, 11102.0, 11115.666530004113, 6061.363556826514, 6266.686665666698, 6323.588966717149, 6358.141650877119, 6365.681715914186, 3515.244222492151, 3587.6232995535615, 3689.594144644087, 3705.6850167735774, 3715.2198038411966, 1263.9368031598383, 1269.6952731344504, 1290.8450985881755, 1291.5027714329956, 1300.5383089003362, 14345.928270358685, 14844.554663360008, 15416.768748468781, 15561.0, 15622.0, 5071.87320316995, 5124.0, 5241.764120614505, 5245.160774276097, 5260.342457192851, 11856.17006809515, 11967.102467314986, 11983.64049078529, 12045.457954392074, 12049.457774400173, 6017.819465416044, 6144.662043587557, 6148.78479253224, 6153.815385538441, 6164.815055548341, 5700.8859822803315, 5743.741531631086, 5759.308882934075, 5769.740361683735, 5898.557608179403, 4136.9331771607385, 4184.4351012613515, 4212.157568486315, 4251.3622956556765, 4271.402003719481, 1196.7427003194355, 1201.0123246027663, 1218.9939050304693, 1219.969500762488, 1223.8470191226097, 820.9917900821035, 837.6398148796076, 840.369722707969, 852.1648784191403, 881.6914080071923, 5779.190913272145, 5863.610566248135, 6009.759609615567, 6036.5170786336985, 6123.601965872204, 608.4037643109777, 625.6777759453885, 627.7489004398277, 641.884460797061, 645.2869579115104, 3962.049108214008, 3994.72036957416, 4181.770002649822, 4499.347594598765, 4527.615152712056, 13363.866361336262, 14106.0, 14173.149611023166, 14207.289635518182, 14220.217888016052, 13901.860981390057, 13938.0, 14101.0, 14125.081869678437, 14159.292035398188, 8384.8742268866, 8938.10618938114, 8989.595468204077, 9013.0, 9024.774380640536, 5866.2960444746905, 6619.834504137435, 6672.466202703869, 6928.648913462028, 7233.312835280851, 11957.282563046245, 12148.696282593006, 12195.51217951272, 12247.632571022883, 12428.937855310665, 12935.417906194432, 12991.610251692464, 13006.219626822422, 13070.346482675637, 13216.603501894573, 8937.865932010895, 9053.094690530894, 9088.136627020422, 9124.17882390588, 9125.406848554823, 10354.534045968101, 10427.113695335982, 10478.056974872297, 10486.895131048592, 10495.212859035755, 8690.565471726262, 8699.608517616596, 8878.245349145136, 8924.732258032269, 9186.402883812798, 8562.48625082497, 8571.142885711379, 8704.60829262672, 8751.562421879007, 8938.37431379797, 7138.750143744944, 8173.509589424653, 8271.33829293667, 8275.462094963808, 8292.626831792704, 5478.91781623284, 5566.22072909801, 5634.464725851038, 5637.2107904894165, 5766.07742761173, 5769.105788602773, 6013.218281623361, 6120.785772497941, 6227.532935029801, 6380.553361264667], "value": 5098.430403819055, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.36794077564724, 401.32577270186084, 411.1961116018185, 412.544138726707, 413.32008845449246, 6084.543659225565, 6234.251889773228, 6261.15474410955, 6269.9373006269925, 6285.434310912017, 5894.322152952412, 5992.3108842483125, 6003.499125218696, 6003.909941350883, 6008.218931538905, 4710.952890471103, 4760.190767569504, 4762.880927976802, 4763.857084287477, 4765.332853400527, 4742.05158968206, 4791.448983366905, 4797.7121372717575, 4797.928031079537, 4810.567048965592, 4738.460000499851, 4741.0, 4745.311929770181, 4754.762261886909, 4757.26262429324, 4747.335373047758, 4763.285507173917, 4776.713397196179, 4781.0, 4795.2087905495555, 4176.582341765829, 4181.707280490367, 4189.0, 4194.343234422417, 4198.748075115473, 5981.773736384031, 5994.155698194226, 6008.437806170427, 6032.4570788629235, 6041.335453100155, 5415.83752487426, 5427.48438898304, 5430.891382172374, 5434.3207099112615, 5447.12845944647, 6434.0, 6451.741930322782, 6460.289368169498, 6462.159919210472, 6468.8059358219325, 4534.183846907556, 4542.523035081335, 4544.113897789933, 4544.182047231497, 4555.840545580889, 6443.903341449882, 6787.55880867747, 6810.387065164109, 6835.7949261521735, 6855.5543889647015, 4627.95372046282, 4639.376218323628, 4646.837360692427, 4661.440627124767, 4680.134175177603, 4658.1848176568965, 4659.394278743809, 4671.948811517382, 4689.390379250675, 4694.319323698045, 5193.350831146106, 5375.489328513785, 5385.434529374359, 5410.756515956791, 5433.755481003364, 6471.285109446, 6512.41388275048, 6516.57642253252, 6517.641529715816, 6527.584793626389, 1606.4538057060422, 1608.1155364549452, 1625.2198944506704, 1625.8862679064878, 1639.1230691580186, 1052.321252791945, 1094.5949998500446, 1103.178132291448, 1104.7679987202616, 1115.1691989467736, 5730.5129064030025, 5735.483806457439, 5735.942640573624, 5748.166515855178, 5750.6262092963825, 6698.933010669928, 6699.598024118569, 6709.36261055199, 6728.495362847708, 6737.831554211086, 5677.006523858308, 5683.232763576947, 5708.229389032511, 5722.020488589434, 5736.77052917887, 3567.4113771227458, 3572.696320812708, 3575.213453040327, 3580.838862251153, 3581.8030008349792, 6499.480041596756, 6503.154589903283, 6528.640924749185, 6536.607803531708, 6555.508336874754, 6749.966250168718, 6783.59298442095, 6824.863502729918, 6841.110655614738, 6871.209810871714, 6386.808395748135, 6479.319671434526, 6485.605594797141, 6517.327895562797, 6567.179102612174, 6731.562448440835, 6744.763933262312, 6753.223379311442, 6756.527043106936, 6777.7799996001195, 6282.340354262919, 6669.899951500828, 6689.2976237496305, 6703.262641109572, 6716.5634233774645, 6434.678266086583, 6476.773312934025, 6505.544611877123, 6542.34576542342, 6547.836304092436, 4591.127685739699, 4593.563611456906, 4596.9543553119875, 4613.838515651936, 4632.420947381577, 6444.7744328948265, 6662.433693136138, 6683.498737594797, 6707.698153583198, 6723.033410287953, 6538.215414150142, 6539.901901471387, 6560.278369379269, 6575.375339342755, 6596.835079122869, 6487.156669632917, 6491.156149700509, 6503.902441463477, 6561.901571476527, 6567.9014814776865, 6368.758092171982, 6462.256840463407, 6468.773592924225, 6487.059376390492, 6496.870062598816, 6524.217093948757, 6559.212894452697, 6588.703508342041, 6604.603723776589, 6604.735810567524, 6324.098823411892, 6368.9044664330995, 6396.48828093742, 6423.7430502781235, 6424.743010279536], "value": 4892.464344878481, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [811.3509192645881, 830.9210624990627, 835.269139502935, 841.9391566626049, 858.8497013022721, 15371.692566148684, 15649.452269170568, 15766.448174313902, 17310.826891731078, 18383.632327353444, 17332.0, 17615.383461578847, 17977.550561235974, 17986.550336241602, 18016.729749053742, 921.880155579777, 948.2603569216022, 952.2477242978074, 954.0364232125569, 957.310736269888, 896.3949334199422, 1002.8946960569144, 1003.0972125087407, 1004.7387679203387, 1011.989880101197, 1059.4120263253892, 1060.4379678770265, 1060.5068643080965, 1061.2306078093397, 1066.2855886556026, 1054.1250761867632, 1054.910332621728, 1055.688571871296, 1056.778076603914, 1057.6404022632264, 773.767869639106, 773.7756050745277, 774.1445702498714, 774.9922500774976, 775.255754475704, 15530.378784848592, 16012.919935400365, 16152.111633860133, 16161.0, 16185.190740463047, 18329.633407331778, 18735.437936861916, 18746.156422961, 18805.341813036615, 18887.244510219713, 14681.192534410604, 15292.158931258888, 15296.541103766906, 15335.769963450557, 15451.459198928096, 3419.12812232879, 3452.482127680843, 3462.4286992646184, 3561.28774245152, 3565.982170089133, 87216.56391718001, 87235.0, 88911.0, 89070.99999999935, 89591.10408895893, 14585.0, 14750.04124731889, 14848.554543363716, 14863.628409289855, 14898.0, 26454.33864153373, 26535.867320663274, 27710.445791084065, 27929.860350698524, 27969.860150699114, 7619.961900190464, 7786.1435242123325, 8143.267105960374, 8213.671453141927, 8250.669973201126, 3723.497327860704, 3824.4454554089502, 3827.5406951166037, 3831.63599458051, 3845.307844588001, 4143.233501802176, 4207.978960105241, 4212.72617279882, 4227.091175397304, 4278.764667943293, 858.2233079063458, 873.6505397840914, 881.4402854187637, 884.8274586455708, 885.0883589902411, 664.5049438168498, 693.1405057728381, 694.0768777525878, 694.0838093716246, 708.5819366573746, 10767.97704218098, 11738.823917641243, 12375.62873113808, 12620.368981550886, 12889.355532223351, 682.2597481732276, 692.2005084127841, 695.5374675840509, 699.0388216202721, 701.3967987530822, 5432.718258331511, 5533.22534845122, 5869.911951320733, 6219.626822390671, 6309.968450157719, 90123.54938225266, 92332.53833730788, 93511.0, 93616.0, 94413.0, 77601.22398776053, 80305.0, 81043.0, 81337.0, 81390.59304703439, 64475.35524644787, 68049.65975170092, 68664.3133568658, 70625.2937470629, 71580.64209678919, 10713.196510261918, 11155.944220278847, 11571.942140289244, 11742.941285293518, 12234.143609947574, 29429.85285073561, 29748.55377169301, 29775.70224297729, 30069.248268793453, 31159.221019474695, 38291.23417531578, 38367.42448863325, 38401.0, 38484.615153848106, 39029.41455878107, 17368.21843017042, 17440.912795435943, 17785.377511787025, 17933.551661208574, 17987.0, 18416.539586510444, 19600.50998724986, 19647.115879785157, 19757.50606234798, 19845.106970186087, 17165.828341716424, 17307.653846923244, 17539.298428063245, 17636.911815441355, 17866.91066544659, 17211.655766884844, 17472.475825725247, 17583.824161758217, 17731.911340443214, 17929.462116136536, 17361.47915562535, 17466.650666986843, 17607.0, 17646.294148233927, 17876.0, 11431.771364572496, 12202.572909948109, 12205.145639805483, 12285.508579656713, 12611.117221794386, 12932.482700691868, 13134.59665942649, 13963.371648276056, 14725.263736813331, 14739.705205895607], "value": 8237.838185333421, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 114.0, 110.0, 111.0, 113.0, 111.0, 112.0, 111.0, 114.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 120.0, 122.0, 184.0, 125.0, 123.0, 123.0, 124.0, 144.0, 129.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 164.0, 163.0, 162.0, 164.0, 168.0, 170.0, 167.0, 163.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 75.0, 112.0, 75.0, 78.0, 79.0, 75.0, 103.0, 75.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 107.0, 82.0, 85.0, 81.0, 98.0, 83.0, 82.0, 104.0], "value": 88.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 114.0, 114.0, 115.0, 114.0, 113.0, 114.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 152.0, 150.0, 150.0, 149.0, 150.0, 149.0, 151.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 100.0, 96.0, 96.0, 96.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 55.0, 54.0, 55.0, 55.0, 54.0, 53.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 56.0, 55.0, 56.0, 56.0, 56.0, 56.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 87.0, 86.0, 87.0, 88.0, 90.0, 88.0, 113.0, 93.0], "value": 90.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 138.0, 132.0, 134.0, 129.0, 132.0, 132.0, 131.0, 131.0, 142.0], "value": 133.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [212.0, 199.0, 193.0, 198.0, 195.0, 196.0, 196.0, 185.0, 183.0, 193.0], "value": 195.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 73.0, 74.0, 72.0, 70.0, 71.0, 75.0, 71.0, 74.0], "value": 73.3, "unit": "score"}]}]} 10:01:22 INFO - Return code: 0 10:01:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:01:23 INFO - # TBPL SUCCESS # 10:01:23 INFO - Running post-action listener: _resource_record_post_action 10:01:23 INFO - [mozharness: 2017-06-05 17:01:23.038147Z] Finished run-tests step (success) 10:01:23 INFO - Running post-run listener: _resource_record_post_run 10:01:23 INFO - Total resource usage - Wall time: 1251s; CPU: 13.0%; Read bytes: 4096; Write bytes: 426999808; Read time: 12; Write time: 307616 10:01:23 INFO - TinderboxPrint: CPU usage
12.6% 10:01:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:01:23 INFO - TinderboxPrint: I/O write bytes / time
426,999,808 / 307,616 10:01:23 INFO - TinderboxPrint: CPU idle
8,721.7 (87.3%) 10:01:23 INFO - TinderboxPrint: CPU user
1,209.3 (12.1%) 10:01:23 INFO - TinderboxPrint: Swap in / out
0 / 0 10:01:23 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 102301696; Read time: 0; Write time: 125952 10:01:23 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:01:23 INFO - run-tests - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 324698112; Read time: 0; Write time: 181664 10:01:23 INFO - Running post-run listener: _upload_blobber_files 10:01:23 INFO - Blob upload gear active. 10:01:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:01:23 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 10:01:23 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'] 10:01:23 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 10:01:24 INFO - (blobuploader) - INFO - Open directory for files ... 10:01:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:01:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:01:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:01:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:01:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:01:24 INFO - (blobuploader) - INFO - Done attempting. 10:01:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:01:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:01:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:01:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:01:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:01:30 INFO - (blobuploader) - INFO - Done attempting. 10:01:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:01:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:01:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:01:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:01:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:01:31 INFO - (blobuploader) - INFO - Done attempting. 10:01:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:01:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:01:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:01:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:01:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:01:32 INFO - (blobuploader) - INFO - Done attempting. 10:01:32 INFO - (blobuploader) - INFO - Iteration through files over. 10:01:32 INFO - Return code: 0 10:01:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:01:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:01:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d67a2e3c2f0fdc2b50bcad36e2e64a415c821023fb4c55336b6c4af721dae64a816cef9614d930b5136e3a834d4972ea1d5ca3e5e1b71e3f3beb4d902a963d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ad833b2637a80cb33c302d58180c3da08ee081a407daa6329346f7207120438698e7dcdfc007619fbfb4d254993e4226d6121d24f5059f62fe5808f791811e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/09416486ee40893c701c31a7cf4a979c33903782591469fb6bac9a8a8144d773ca4a916026ee8574c6c5fe6486b650769866009362d44ebae71d233409a0b6e9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/09dded15b2cb77a290a3203522323ff9f67563f73c58371032d797eea08abf1ab178cadf2df759195dc430ed91d8905ed1392c416e224e25c387bc14581b1ed1"} 10:01:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:01:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:01:32 INFO - Contents: 10:01:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d67a2e3c2f0fdc2b50bcad36e2e64a415c821023fb4c55336b6c4af721dae64a816cef9614d930b5136e3a834d4972ea1d5ca3e5e1b71e3f3beb4d902a963d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ad833b2637a80cb33c302d58180c3da08ee081a407daa6329346f7207120438698e7dcdfc007619fbfb4d254993e4226d6121d24f5059f62fe5808f791811e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/09416486ee40893c701c31a7cf4a979c33903782591469fb6bac9a8a8144d773ca4a916026ee8574c6c5fe6486b650769866009362d44ebae71d233409a0b6e9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/09dded15b2cb77a290a3203522323ff9f67563f73c58371032d797eea08abf1ab178cadf2df759195dc430ed91d8905ed1392c416e224e25c387bc14581b1ed1"} 10:01:32 INFO - Running post-run listener: copy_logs_to_upload_dir 10:01:32 INFO - Copying logs to upload dir... 10:01:32 INFO - mkdir: /builds/slave/test/build/upload/logs 10:01:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1318.871192 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2017-06-05 10:01:32.584763) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-05 10:01:32.589728) ========= 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=3a3620fb28aea1604ab609ef000001d2-1496680772.246822-188740356 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/5d67a2e3c2f0fdc2b50bcad36e2e64a415c821023fb4c55336b6c4af721dae64a816cef9614d930b5136e3a834d4972ea1d5ca3e5e1b71e3f3beb4d902a963d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ad833b2637a80cb33c302d58180c3da08ee081a407daa6329346f7207120438698e7dcdfc007619fbfb4d254993e4226d6121d24f5059f62fe5808f791811e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/09416486ee40893c701c31a7cf4a979c33903782591469fb6bac9a8a8144d773ca4a916026ee8574c6c5fe6486b650769866009362d44ebae71d233409a0b6e9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/09dded15b2cb77a290a3203522323ff9f67563f73c58371032d797eea08abf1ab178cadf2df759195dc430ed91d8905ed1392c416e224e25c387bc14581b1ed1"} build_url:https://queue.taskcluster.net/v1/task/XxZJaM4BSd6oD1oaJqCemw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011182 build_url: 'https://queue.taskcluster.net/v1/task/XxZJaM4BSd6oD1oaJqCemw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d67a2e3c2f0fdc2b50bcad36e2e64a415c821023fb4c55336b6c4af721dae64a816cef9614d930b5136e3a834d4972ea1d5ca3e5e1b71e3f3beb4d902a963d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ad833b2637a80cb33c302d58180c3da08ee081a407daa6329346f7207120438698e7dcdfc007619fbfb4d254993e4226d6121d24f5059f62fe5808f791811e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/09416486ee40893c701c31a7cf4a979c33903782591469fb6bac9a8a8144d773ca4a916026ee8574c6c5fe6486b650769866009362d44ebae71d233409a0b6e9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/09dded15b2cb77a290a3203522323ff9f67563f73c58371032d797eea08abf1ab178cadf2df759195dc430ed91d8905ed1392c416e224e25c387bc14581b1ed1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-05 10:01:32.617197) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 10:01:32.617601) ========= 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=3a3620fb28aea1604ab609ef000001d2-1496680772.246822-188740356 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 10:01:32.698945) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-05 10:01:32.702408) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-05 10:01:32.702792) ========= ========= Total master_lag: 0.16 =========