builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-001 starttime: 1496765947.84 results: success (0) revision: c511ad826fe71ba2bb956d2e1c119e86d2266aba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-06 09:19:07.841869) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-06 09:19:07.842347) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-06 09:19:07.842664) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-06 09:19:07.885915) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 09:19:07.886257) ========= 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=8887e36bb8e381bfd44124ac000001a8-1496765856.808188-1575682196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-06 09:19:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 18.9M=0.001s 2017-06-06 09:19:08 (18.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137093 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 09:19:08.043860) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 09:19:08.044207) ========= 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=8887e36bb8e381bfd44124ac000001a8-1496765856.808188-1575682196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015188 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 09:19:08.106949) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-06 09:19:08.107375) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c511ad826fe71ba2bb956d2e1c119e86d2266aba --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 c511ad826fe71ba2bb956d2e1c119e86d2266aba --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=8887e36bb8e381bfd44124ac000001a8-1496765856.808188-1575682196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-06 09:19:08,435 truncating revision to first 12 chars 2017-06-06 09:19:08,435 Setting DEBUG logging. 2017-06-06 09:19:08,435 attempt 1/10 2017-06-06 09:19:08,435 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c511ad826fe7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-06 09:19:09,511 unpacking tar archive at: mozilla-central-c511ad826fe7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.394255 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-06 09:19:09.514855) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-06 09:19:09.515239) ========= script_repo_revision: c511ad826fe71ba2bb956d2e1c119e86d2266aba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-06 09:19:09.515676) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-06 09:19:09.516017) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-06 09:19:09.524551) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2017-06-06 09:19:09.524899) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1496765856.808188-1575682196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:19:09 INFO - MultiFileLogger online at 20170606 09:19:09 in /builds/slave/test 09:19:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:19:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:19:09 INFO - {'append_to_log': False, 09:19:09 INFO - 'base_work_dir': '/builds/slave/test', 09:19:09 INFO - 'blob_upload_branch': 'Firefox', 09:19:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:19:09 INFO - 'branch': 'Firefox', 09:19:09 INFO - 'buildbot_json_path': 'buildprops.json', 09:19:09 INFO - 'config_files': ('talos/linux_config.py',), 09:19:09 INFO - 'default_actions': ('clobber', 09:19:09 INFO - 'read-buildbot-config', 09:19:09 INFO - 'download-and-extract', 09:19:09 INFO - 'populate-webroot', 09:19:09 INFO - 'create-virtualenv', 09:19:09 INFO - 'install', 09:19:09 INFO - 'setup-mitmproxy', 09:19:09 INFO - 'run-tests'), 09:19:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:19:09 INFO - 'download_minidump_stackwalk': True, 09:19:09 INFO - 'download_symbols': 'ondemand', 09:19:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:19:09 INFO - 'tooltool.py': '/tools/tooltool.py', 09:19:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:19:09 INFO - '/tools/misc-python/virtualenv.py')}, 09:19:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:19:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:19:09 INFO - 'gecko_profile': False, 09:19:09 INFO - 'gecko_profile_interval': 0, 09:19:09 INFO - 'installer_path': 'installer.exe', 09:19:09 INFO - 'log_level': 'info', 09:19:09 INFO - 'log_name': 'talos', 09:19:09 INFO - 'log_to_console': True, 09:19:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:19:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:19:09 INFO - 'opt_config_files': (), 09:19:09 INFO - 'pip_index': False, 09:19:09 INFO - 'suite': 'dromaeojs-e10s', 09:19:09 INFO - 'system_bits': '32', 09:19:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:19:09 INFO - 'title': 'talos-linux64-ix-001', 09:19:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:19:09 INFO - 'use_talos_json': True, 09:19:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:19:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:19:09 INFO - 'work_dir': 'build'} 09:19:09 INFO - [mozharness: 2017-06-06 16:19:09.950620Z] Running clobber step. 09:19:09 INFO - Running pre-action listener: _resource_record_pre_action 09:19:09 INFO - Running main action method: clobber 09:19:09 INFO - rmtree: /builds/slave/test/build 09:19:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:19:11 INFO - Running post-action listener: _resource_record_post_action 09:19:11 INFO - [mozharness: 2017-06-06 16:19:11.506661Z] Finished clobber step (success) 09:19:11 INFO - [mozharness: 2017-06-06 16:19:11.506761Z] Running read-buildbot-config step. 09:19:11 INFO - Running pre-action listener: _resource_record_pre_action 09:19:11 INFO - Running main action method: read_buildbot_config 09:19:11 INFO - Using buildbot properties: 09:19:11 INFO - { 09:19:11 INFO - "project": "", 09:19:11 INFO - "product": "firefox", 09:19:11 INFO - "who": "ffxbld@noreply.mozilla.org", 09:19:11 INFO - "installer_path": "public/build/target.tar.bz2", 09:19:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 09:19:11 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:19:11 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 09:19:11 INFO - "stage_platform": "linux64-stylosequential", 09:19:11 INFO - "basedir": "/builds/slave/test", 09:19:11 INFO - "buildnumber": 49, 09:19:11 INFO - "platform": "ubuntu64_hw_styloseq", 09:19:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:19:11 INFO - "slavebuilddir": "test", 09:19:11 INFO - "taskId": "L1W3qekuTqGiZFMChJDITg", 09:19:11 INFO - "branch": "mozilla-central", 09:19:11 INFO - "script_repo_revision": "production", 09:19:11 INFO - "revision": "c511ad826fe71ba2bb956d2e1c119e86d2266aba", 09:19:11 INFO - "slavename": "talos-linux64-ix-001", 09:19:11 INFO - "repo_path": "mozilla-central" 09:19:11 INFO - } 09:19:11 INFO - Finding installer, test and symbols from parent task. 09:19:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L1W3qekuTqGiZFMChJDITg'}, attempt #1 09:19:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L1W3qekuTqGiZFMChJDITg'}, attempt #1 09:19:12 INFO - Task dependencies: ECGZ_RQZS4CyP3kbNjdMZw 09:19:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw'}, attempt #1 09:19:12 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.tar.bz2 09:19:12 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/test_packages.json 09:19:12 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.crashreporter-symbols.zip 09:19:12 INFO - Running post-action listener: _resource_record_post_action 09:19:12 INFO - [mozharness: 2017-06-06 16:19:12.865110Z] Finished read-buildbot-config step (success) 09:19:12 INFO - [mozharness: 2017-06-06 16:19:12.865331Z] Running download-and-extract step. 09:19:12 INFO - Running pre-action listener: _resource_record_pre_action 09:19:12 INFO - Running main action method: download_and_extract 09:19:12 INFO - mkdir: /builds/slave/test/build/tests 09:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:12 INFO - trying https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.test_packages.json 09:19:12 INFO - Downloading https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:19:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:19:13 INFO - Downloaded 989 bytes. 09:19:13 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:19:13 INFO - Using the following test package requirements: 09:19:13 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:19:13 INFO - u'common': [u'target.common.tests.zip'], 09:19:13 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:19:13 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:19:13 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:19:13 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:19:13 INFO - u'mozbase': [u'target.common.tests.zip'], 09:19:13 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:19:13 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:19:13 INFO - u'web-platform': [u'target.common.tests.zip', 09:19:13 INFO - u'target.web-platform.tests.tar.gz'], 09:19:13 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:19:13 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:19:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.common.tests.zip 09:19:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:19:13 INFO - Fetch https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.common.tests.zip into memory 09:19:15 INFO - Content-Length response header: 65103787 09:19:15 INFO - Bytes received: 65103787 09:19:26 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:19:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.common.tests.zip 09:19:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:19:26 INFO - Fetch https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.common.tests.zip into memory 09:19:28 INFO - Content-Length response header: 65103787 09:19:28 INFO - Bytes received: 65103787 09:19:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.talos.tests.zip 09:19:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:19:39 INFO - Fetch https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.talos.tests.zip into memory 09:19:41 INFO - Content-Length response header: 14447479 09:19:41 INFO - Bytes received: 14447479 09:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:41 INFO - trying https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.tar.bz2 09:19:41 INFO - Downloading https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:19:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:19:49 INFO - Downloaded 60499098 bytes. 09:19:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.tar.bz2 09:19:49 INFO - mkdir: /builds/slave/test/properties 09:19:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:19:49 INFO - Writing to file /builds/slave/test/properties/build_url 09:19:49 INFO - Contents: 09:19:49 INFO - build_url:https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.tar.bz2 09:19:49 INFO - Running post-action listener: _resource_record_post_action 09:19:49 INFO - Running post-action listener: set_extra_try_arguments 09:19:49 INFO - [mozharness: 2017-06-06 16:19:49.417606Z] Finished download-and-extract step (success) 09:19:49 INFO - [mozharness: 2017-06-06 16:19:49.417840Z] Running populate-webroot step. 09:19:49 INFO - Running pre-action listener: _resource_record_pre_action 09:19:49 INFO - Running main action method: populate_webroot 09:19:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:19:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:19:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:19:49 INFO - '--tppagecycles', 09:19:49 INFO - '7'], 09:19:49 INFO - 'tests': ['tsvgm']}}, 09:19:49 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:19:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:19:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:19:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:19:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:19:49 INFO - 'talos_options': ['--disable-e10s'], 09:19:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:19:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:19:49 INFO - 'talos_options': ['--disable-e10s'], 09:19:49 INFO - 'tests': ['damp', 'tps']}, 09:19:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:19:49 INFO - 'tests': ['damp', 'tps']}, 09:19:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:19:49 INFO - 'tests': ['dromaeo_dom']}, 09:19:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:19:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:19:49 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:19:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:19:49 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:19:49 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:19:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:19:49 INFO - 'tests': ['a11yr', 09:19:49 INFO - 'ts_paint', 09:19:49 INFO - 'tpaint', 09:19:49 INFO - 'sessionrestore', 09:19:49 INFO - 'sessionrestore_no_auto_restore', 09:19:49 INFO - 'tabpaint']}, 09:19:49 INFO - 'other-e10s': {'tests': ['a11yr', 09:19:49 INFO - 'ts_paint', 09:19:49 INFO - 'tpaint', 09:19:49 INFO - 'sessionrestore', 09:19:49 INFO - 'sessionrestore_no_auto_restore', 09:19:49 INFO - 'tabpaint']}, 09:19:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:19:49 INFO - 'ts_paint', 09:19:49 INFO - 'tpaint', 09:19:49 INFO - 'sessionrestore', 09:19:49 INFO - 'sessionrestore_no_auto_restore', 09:19:49 INFO - 'tabpaint']}, 09:19:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:19:49 INFO - 'ts_paint', 09:19:49 INFO - 'tpaint', 09:19:49 INFO - 'sessionrestore', 09:19:49 INFO - 'sessionrestore_no_auto_restore', 09:19:49 INFO - 'tabpaint']}, 09:19:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:19:49 INFO - 'tests': ['a11yr', 09:19:49 INFO - 'ts_paint', 09:19:49 INFO - 'tpaint', 09:19:49 INFO - 'sessionrestore', 09:19:49 INFO - 'sessionrestore_no_auto_restore', 09:19:49 INFO - 'tabpaint']}, 09:19:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:19:49 INFO - 'tests': ['a11yr', 09:19:49 INFO - 'ts_paint', 09:19:49 INFO - 'tpaint', 09:19:49 INFO - 'sessionrestore', 09:19:49 INFO - 'sessionrestore_no_auto_restore', 09:19:49 INFO - 'tabpaint']}, 09:19:49 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:19:49 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:19:49 INFO - 'bloom_basic_ref']}, 09:19:49 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 09:19:49 INFO - 'talos_options': ['--mitmproxy', 09:19:49 INFO - 'mitmproxy-recording-1.mp', 09:19:49 INFO - '--firstNonBlankPaint'], 09:19:49 INFO - 'tests': ['Quantum_1']}, 09:19:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:19:49 INFO - 'tests': ['tsvgx', 09:19:49 INFO - 'tsvgr_opacity', 09:19:49 INFO - 'tart', 09:19:49 INFO - 'tscrollx', 09:19:49 INFO - 'cart', 09:19:49 INFO - 'tsvg_static']}, 09:19:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:19:49 INFO - 'tsvgr_opacity', 09:19:49 INFO - 'tart', 09:19:49 INFO - 'tscrollx', 09:19:49 INFO - 'cart', 09:19:49 INFO - 'tsvg_static']}, 09:19:49 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:19:49 INFO - 'talos_options': ['--disable-e10s'], 09:19:49 INFO - 'tests': ['tp5o']}, 09:19:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:19:49 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:19:49 INFO - 'talos_options': ['--disable-e10s', 09:19:49 INFO - '--xperf_path', 09:19:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:49 INFO - 'tests': ['tp5n']}, 09:19:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:19:49 INFO - 'talos_options': ['--xperf_path', 09:19:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:49 INFO - 'tests': ['tp5n']}}, 09:19:49 INFO - 'talos.zip': {'path': '', 09:19:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:19:49 INFO - Running post-action listener: _resource_record_post_action 09:19:49 INFO - [mozharness: 2017-06-06 16:19:49.439398Z] Finished populate-webroot step (success) 09:19:49 INFO - [mozharness: 2017-06-06 16:19:49.439488Z] Running create-virtualenv step. 09:19:49 INFO - Running pre-action listener: _resource_record_pre_action 09:19:49 INFO - Running main action method: create_virtualenv 09:19:49 INFO - Creating virtualenv /builds/slave/test/build/venv 09:19:49 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:19:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:19:49 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:19:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:19:49 INFO - Using real prefix '/usr' 09:19:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:19:50 INFO - Installing distribute.............................................................................................................................................................................................done. 09:19:52 INFO - Installing pip.................done. 09:19:52 INFO - Return code: 0 09:19:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:19:52 INFO - Reading from file tmpfile_stdout 09:19:52 INFO - Output received: 09:19:52 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:19:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:19:52 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:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:52 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:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:52 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 0x290f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8a840>, '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 0x2c8b740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8bbd0>, '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': '8887e36bb8e381bfd44124ac000001a8-1496765856.808188-1575682196', '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:19:52 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:19:52 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:19:52 INFO - Using env: {'DISPLAY': ':0', 09:19:52 INFO - 'HOME': '/home/cltbld', 09:19:52 INFO - 'LANG': 'en_US.UTF-8', 09:19:52 INFO - 'LANGUAGE': 'en_US:en', 09:19:52 INFO - 'LOGNAME': 'cltbld', 09:19:52 INFO - 'MAIL': '/var/mail/cltbld', 09:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:52 INFO - 'MOZ_NO_REMOTE': '1', 09:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:52 INFO - 'NO_EM_RESTART': '1', 09:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:52 INFO - 'PWD': '/builds/slave/test', 09:19:52 INFO - 'SHELL': '/bin/bash', 09:19:52 INFO - 'SHLVL': '1', 09:19:52 INFO - 'TERM': 'linux', 09:19:52 INFO - 'TMOUT': '86400', 09:19:52 INFO - 'USER': 'cltbld', 09:19:52 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1496765856.808188-1575682196', 09:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:52 INFO - '_': '/tools/buildbot/bin/python'} 09:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:52 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:19:52 INFO - Cleaning up... 09:19:52 INFO - Return code: 0 09:19:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:19:52 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:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:52 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:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:52 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 0x290f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8a840>, '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 0x2c8b740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8bbd0>, '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': '8887e36bb8e381bfd44124ac000001a8-1496765856.808188-1575682196', '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:19:52 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:19:52 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:19:52 INFO - Using env: {'DISPLAY': ':0', 09:19:52 INFO - 'HOME': '/home/cltbld', 09:19:52 INFO - 'LANG': 'en_US.UTF-8', 09:19:52 INFO - 'LANGUAGE': 'en_US:en', 09:19:52 INFO - 'LOGNAME': 'cltbld', 09:19:52 INFO - 'MAIL': '/var/mail/cltbld', 09:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:52 INFO - 'MOZ_NO_REMOTE': '1', 09:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:52 INFO - 'NO_EM_RESTART': '1', 09:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:52 INFO - 'PWD': '/builds/slave/test', 09:19:52 INFO - 'SHELL': '/bin/bash', 09:19:52 INFO - 'SHLVL': '1', 09:19:52 INFO - 'TERM': 'linux', 09:19:52 INFO - 'TMOUT': '86400', 09:19:52 INFO - 'USER': 'cltbld', 09:19:52 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1496765856.808188-1575682196', 09:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:52 INFO - '_': '/tools/buildbot/bin/python'} 09:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:52 INFO - Downloading/unpacking psutil>=3.1.1 09:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:19:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:53 INFO - Installing collected packages: psutil 09:19:53 INFO - Running setup.py install for psutil 09:19:53 INFO - building 'psutil._psutil_linux' extension 09:19:53 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:19:54 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:19:54 INFO - building 'psutil._psutil_posix' extension 09:19:54 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:19:54 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:19:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:54 INFO - Successfully installed psutil 09:19:54 INFO - Cleaning up... 09:19:54 INFO - Return code: 0 09:19:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8a840>, '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 0x2c8b740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8bbd0>, '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': '8887e36bb8e381bfd44124ac000001a8-1496765856.808188-1575682196', '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:19:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:19:54 INFO - Using env: {'DISPLAY': ':0', 09:19:54 INFO - 'HOME': '/home/cltbld', 09:19:54 INFO - 'LANG': 'en_US.UTF-8', 09:19:54 INFO - 'LANGUAGE': 'en_US:en', 09:19:54 INFO - 'LOGNAME': 'cltbld', 09:19:54 INFO - 'MAIL': '/var/mail/cltbld', 09:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:54 INFO - 'MOZ_NO_REMOTE': '1', 09:19:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:54 INFO - 'NO_EM_RESTART': '1', 09:19:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:54 INFO - 'PWD': '/builds/slave/test', 09:19:54 INFO - 'SHELL': '/bin/bash', 09:19:54 INFO - 'SHLVL': '1', 09:19:54 INFO - 'TERM': 'linux', 09:19:54 INFO - 'TMOUT': '86400', 09:19:54 INFO - 'USER': 'cltbld', 09:19:54 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1496765856.808188-1575682196', 09:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:54 INFO - '_': '/tools/buildbot/bin/python'} 09:19:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:19:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:19:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:19:55 INFO - Installing collected packages: mozsystemmonitor 09:19:55 INFO - Running setup.py install for mozsystemmonitor 09:19:55 INFO - Successfully installed mozsystemmonitor 09:19:55 INFO - Cleaning up... 09:19:55 INFO - Return code: 0 09:19:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:19:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8a840>, '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 0x2c8b740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8bbd0>, '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': '8887e36bb8e381bfd44124ac000001a8-1496765856.808188-1575682196', '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:19:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:19:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:19:55 INFO - Using env: {'DISPLAY': ':0', 09:19:55 INFO - 'HOME': '/home/cltbld', 09:19:55 INFO - 'LANG': 'en_US.UTF-8', 09:19:55 INFO - 'LANGUAGE': 'en_US:en', 09:19:55 INFO - 'LOGNAME': 'cltbld', 09:19:55 INFO - 'MAIL': '/var/mail/cltbld', 09:19:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:55 INFO - 'MOZ_NO_REMOTE': '1', 09:19:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:55 INFO - 'NO_EM_RESTART': '1', 09:19:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:55 INFO - 'PWD': '/builds/slave/test', 09:19:55 INFO - 'SHELL': '/bin/bash', 09:19:55 INFO - 'SHLVL': '1', 09:19:55 INFO - 'TERM': 'linux', 09:19:55 INFO - 'TMOUT': '86400', 09:19:55 INFO - 'USER': 'cltbld', 09:19:55 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1496765856.808188-1575682196', 09:19:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:55 INFO - '_': '/tools/buildbot/bin/python'} 09:19:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:56 INFO - Downloading/unpacking jsonschema==2.5.1 09:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:19:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:57 INFO - Downloading functools32-3.2.3-2.tar.gz 09:19:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:19:57 INFO - warning: no files found matching '*.txt' 09:19:57 INFO - no previously-included directories found matching 'build' 09:19:57 INFO - no previously-included directories found matching 'dist' 09:19:57 INFO - no previously-included directories found matching '.git*' 09:19:57 INFO - Installing collected packages: jsonschema, functools32 09:19:57 INFO - Running setup.py install for functools32 09:19:57 INFO - warning: no files found matching '*.txt' 09:19:57 INFO - no previously-included directories found matching 'build' 09:19:57 INFO - no previously-included directories found matching 'dist' 09:19:57 INFO - no previously-included directories found matching '.git*' 09:19:57 INFO - Successfully installed jsonschema functools32 09:19:57 INFO - Cleaning up... 09:19:57 INFO - Return code: 0 09:19:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x290f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8a840>, '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 0x2c8b740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8bbd0>, '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': '8887e36bb8e381bfd44124ac000001a8-1496765856.808188-1575682196', '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:19:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:19:57 INFO - Using env: {'DISPLAY': ':0', 09:19:57 INFO - 'HOME': '/home/cltbld', 09:19:57 INFO - 'LANG': 'en_US.UTF-8', 09:19:57 INFO - 'LANGUAGE': 'en_US:en', 09:19:57 INFO - 'LOGNAME': 'cltbld', 09:19:57 INFO - 'MAIL': '/var/mail/cltbld', 09:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:57 INFO - 'MOZ_NO_REMOTE': '1', 09:19:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:57 INFO - 'NO_EM_RESTART': '1', 09:19:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:57 INFO - 'PWD': '/builds/slave/test', 09:19:57 INFO - 'SHELL': '/bin/bash', 09:19:57 INFO - 'SHLVL': '1', 09:19:57 INFO - 'TERM': 'linux', 09:19:57 INFO - 'TMOUT': '86400', 09:19:57 INFO - 'USER': 'cltbld', 09:19:57 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1496765856.808188-1575682196', 09:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:57 INFO - '_': '/tools/buildbot/bin/python'} 09:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:19:57 INFO - Cleaning up... 09:19:57 INFO - Return code: 0 09:19:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x290f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8a840>, '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 0x2c8b740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8bbd0>, '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': '8887e36bb8e381bfd44124ac000001a8-1496765856.808188-1575682196', '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:19:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:19:57 INFO - Using env: {'DISPLAY': ':0', 09:19:57 INFO - 'HOME': '/home/cltbld', 09:19:57 INFO - 'LANG': 'en_US.UTF-8', 09:19:57 INFO - 'LANGUAGE': 'en_US:en', 09:19:57 INFO - 'LOGNAME': 'cltbld', 09:19:57 INFO - 'MAIL': '/var/mail/cltbld', 09:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:57 INFO - 'MOZ_NO_REMOTE': '1', 09:19:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:57 INFO - 'NO_EM_RESTART': '1', 09:19:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:57 INFO - 'PWD': '/builds/slave/test', 09:19:57 INFO - 'SHELL': '/bin/bash', 09:19:57 INFO - 'SHLVL': '1', 09:19:57 INFO - 'TERM': 'linux', 09:19:57 INFO - 'TMOUT': '86400', 09:19:57 INFO - 'USER': 'cltbld', 09:19:57 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1496765856.808188-1575682196', 09:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:57 INFO - '_': '/tools/buildbot/bin/python'} 09:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:57 INFO - Downloading/unpacking blobuploader==1.2.4 09:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:59 INFO - Downloading blobuploader-1.2.4.tar.gz 09:19:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:19:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:19:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:59 INFO - Downloading docopt-0.6.1.tar.gz 09:19:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:19:59 INFO - Installing collected packages: blobuploader, requests, docopt 09:19:59 INFO - Running setup.py install for blobuploader 09:19:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:19:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:19:59 INFO - Running setup.py install for requests 09:20:00 INFO - Running setup.py install for docopt 09:20:00 INFO - Successfully installed blobuploader requests docopt 09:20:00 INFO - Cleaning up... 09:20:00 INFO - Return code: 0 09:20:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:00 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 0x290f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8a840>, '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 0x2c8b740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8bbd0>, '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': '8887e36bb8e381bfd44124ac000001a8-1496765856.808188-1575682196', '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:20:00 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:20:00 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:20:00 INFO - Using env: {'DISPLAY': ':0', 09:20:00 INFO - 'HOME': '/home/cltbld', 09:20:00 INFO - 'LANG': 'en_US.UTF-8', 09:20:00 INFO - 'LANGUAGE': 'en_US:en', 09:20:00 INFO - 'LOGNAME': 'cltbld', 09:20:00 INFO - 'MAIL': '/var/mail/cltbld', 09:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:00 INFO - 'MOZ_NO_REMOTE': '1', 09:20:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:00 INFO - 'NO_EM_RESTART': '1', 09:20:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:00 INFO - 'PWD': '/builds/slave/test', 09:20:00 INFO - 'SHELL': '/bin/bash', 09:20:00 INFO - 'SHLVL': '1', 09:20:00 INFO - 'TERM': 'linux', 09:20:00 INFO - 'TMOUT': '86400', 09:20:00 INFO - 'USER': 'cltbld', 09:20:00 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1496765856.808188-1575682196', 09:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:00 INFO - '_': '/tools/buildbot/bin/python'} 09:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:20:00 INFO - Running setup.py (path:/tmp/pip-X0eSJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:20:00 INFO - Running setup.py (path:/tmp/pip-gp2aSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:20:00 INFO - Running setup.py (path:/tmp/pip-eTxJSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:20:00 INFO - Running setup.py (path:/tmp/pip-2vV2q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:20:00 INFO - Running setup.py (path:/tmp/pip-8PdHvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:20:00 INFO - Running setup.py (path:/tmp/pip-Jd4I6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:20:00 INFO - Running setup.py (path:/tmp/pip-8dGqp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:20:00 INFO - Running setup.py (path:/tmp/pip-Z19yuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:20:01 INFO - Running setup.py (path:/tmp/pip-NoN2kS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:20:01 INFO - Running setup.py (path:/tmp/pip-qFobyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:20:01 INFO - Running setup.py (path:/tmp/pip-9jMpKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:20:01 INFO - Running setup.py (path:/tmp/pip-0_uUv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:20:01 INFO - Running setup.py (path:/tmp/pip-6WCqUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:20:01 INFO - Running setup.py (path:/tmp/pip-Y2xbB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:01 INFO - Running setup.py (path:/tmp/pip-s6dvhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:20:01 INFO - Running setup.py (path:/tmp/pip-dchy5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:20:01 INFO - Running setup.py (path:/tmp/pip-qhRxX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:20:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:20:01 INFO - Running setup.py install for manifestparser 09:20:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:20:01 INFO - Running setup.py install for mozcrash 09:20:01 INFO - Running setup.py install for mozdebug 09:20:01 INFO - Running setup.py install for mozdevice 09:20:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:20:02 INFO - Running setup.py install for mozfile 09:20:02 INFO - Running setup.py install for mozhttpd 09:20:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:20:02 INFO - Running setup.py install for mozinfo 09:20:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:20:02 INFO - Running setup.py install for mozInstall 09:20:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:20:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:20:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:20:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:20:02 INFO - Running setup.py install for mozleak 09:20:02 INFO - Running setup.py install for mozlog 09:20:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:20:02 INFO - Running setup.py install for moznetwork 09:20:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:20:02 INFO - Running setup.py install for mozprocess 09:20:02 INFO - Running setup.py install for mozprofile 09:20:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:20:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:20:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:20:03 INFO - Running setup.py install for mozrunner 09:20:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:20:03 INFO - Running setup.py install for mozscreenshot 09:20:03 INFO - Running setup.py install for moztest 09:20:03 INFO - Running setup.py install for mozversion 09:20:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:20:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:20:03 INFO - Cleaning up... 09:20:03 INFO - Return code: 0 09:20:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:20:03 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:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:03 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:20:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:03 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 0x290f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8a840>, '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 0x2c8b740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8bbd0>, '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': '8887e36bb8e381bfd44124ac000001a8-1496765856.808188-1575682196', '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:20:03 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:20:03 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:20:03 INFO - Using env: {'DISPLAY': ':0', 09:20:03 INFO - 'HOME': '/home/cltbld', 09:20:03 INFO - 'LANG': 'en_US.UTF-8', 09:20:03 INFO - 'LANGUAGE': 'en_US:en', 09:20:03 INFO - 'LOGNAME': 'cltbld', 09:20:03 INFO - 'MAIL': '/var/mail/cltbld', 09:20:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:03 INFO - 'MOZ_NO_REMOTE': '1', 09:20:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:03 INFO - 'NO_EM_RESTART': '1', 09:20:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:03 INFO - 'PWD': '/builds/slave/test', 09:20:03 INFO - 'SHELL': '/bin/bash', 09:20:03 INFO - 'SHLVL': '1', 09:20:03 INFO - 'TERM': 'linux', 09:20:03 INFO - 'TMOUT': '86400', 09:20:03 INFO - 'USER': 'cltbld', 09:20:03 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1496765856.808188-1575682196', 09:20:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:03 INFO - '_': '/tools/buildbot/bin/python'} 09:20:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:20:03 INFO - Running setup.py (path:/tmp/pip-pVwzA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:20:03 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:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:20:03 INFO - Running setup.py (path:/tmp/pip-5YJKp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:20:03 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:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:20:03 INFO - Running setup.py (path:/tmp/pip-mGROSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:20:03 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:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:20:03 INFO - Running setup.py (path:/tmp/pip-4X7syX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:20:03 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:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:20:03 INFO - Running setup.py (path:/tmp/pip-u9qhkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:20:04 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:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:20:04 INFO - Running setup.py (path:/tmp/pip-57OpwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:20:04 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:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:20:04 INFO - Running setup.py (path:/tmp/pip-4TZygx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:20:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:20:04 INFO - Running setup.py (path:/tmp/pip-yZuhhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:20:04 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:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:20:04 INFO - Running setup.py (path:/tmp/pip-uACk_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:20:04 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:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:20:04 INFO - Running setup.py (path:/tmp/pip-0DUTTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:20:04 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:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:20:04 INFO - Running setup.py (path:/tmp/pip-JQCxza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:20:04 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:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:20:04 INFO - Running setup.py (path:/tmp/pip-M_Qo4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:20:04 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:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:20:04 INFO - Running setup.py (path:/tmp/pip-E0h5WL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:20:04 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:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:20:04 INFO - Running setup.py (path:/tmp/pip-QpK8VH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:20:04 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:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:04 INFO - Running setup.py (path:/tmp/pip-kkSwOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:04 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:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:20:04 INFO - Running setup.py (path:/tmp/pip-hZl85F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:20:04 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:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:20:04 INFO - Running setup.py (path:/tmp/pip-UdMqFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:20:04 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:20:04 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:20:04 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:20:04 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:20:04 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:20:04 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:20:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:20:04 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:20:04 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:20:04 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:20:04 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:20:06 INFO - Downloading blessings-1.6.tar.gz 09:20:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:20:06 INFO - Installing collected packages: blessings 09:20:06 INFO - Running setup.py install for blessings 09:20:06 INFO - Successfully installed blessings 09:20:06 INFO - Cleaning up... 09:20:06 INFO - Return code: 0 09:20:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:20:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:20:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:20:06 INFO - Reading from file tmpfile_stdout 09:20:06 INFO - Current package versions: 09:20:06 INFO - argparse == 1.2.1 09:20:06 INFO - blessings == 1.6 09:20:06 INFO - blobuploader == 1.2.4 09:20:06 INFO - docopt == 0.6.1 09:20:06 INFO - functools32 == 3.2.3-2 09:20:06 INFO - jsonschema == 2.5.1 09:20:06 INFO - manifestparser == 1.1 09:20:06 INFO - mozInstall == 1.12 09:20:06 INFO - mozcrash == 1.0 09:20:06 INFO - mozdebug == 0.1 09:20:06 INFO - mozdevice == 0.51 09:20:06 INFO - mozfile == 1.2 09:20:06 INFO - mozhttpd == 0.7 09:20:06 INFO - mozinfo == 0.10 09:20:06 INFO - mozleak == 0.1 09:20:06 INFO - mozlog == 3.4 09:20:06 INFO - moznetwork == 0.27 09:20:06 INFO - mozprocess == 0.25 09:20:06 INFO - mozprofile == 0.28 09:20:06 INFO - mozrunner == 6.13 09:20:06 INFO - mozscreenshot == 0.1 09:20:06 INFO - mozsystemmonitor == 0.3 09:20:06 INFO - moztest == 0.8 09:20:06 INFO - mozversion == 1.4 09:20:06 INFO - psutil == 3.1.1 09:20:06 INFO - requests == 1.2.3 09:20:06 INFO - wsgiref == 0.1.2 09:20:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:20:06 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:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:06 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:20:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:06 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 0x290f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8a840>, '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 0x2c8b740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8bbd0>, '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': '8887e36bb8e381bfd44124ac000001a8-1496765856.808188-1575682196', '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:20:06 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:20:06 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:20:06 INFO - Using env: {'DISPLAY': ':0', 09:20:06 INFO - 'HOME': '/home/cltbld', 09:20:06 INFO - 'LANG': 'en_US.UTF-8', 09:20:06 INFO - 'LANGUAGE': 'en_US:en', 09:20:06 INFO - 'LOGNAME': 'cltbld', 09:20:06 INFO - 'MAIL': '/var/mail/cltbld', 09:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:06 INFO - 'MOZ_NO_REMOTE': '1', 09:20:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:06 INFO - 'NO_EM_RESTART': '1', 09:20:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:06 INFO - 'PWD': '/builds/slave/test', 09:20:06 INFO - 'SHELL': '/bin/bash', 09:20:06 INFO - 'SHLVL': '1', 09:20:06 INFO - 'TERM': 'linux', 09:20:06 INFO - 'TMOUT': '86400', 09:20:06 INFO - 'USER': 'cltbld', 09:20:06 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1496765856.808188-1575682196', 09:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:06 INFO - '_': '/tools/buildbot/bin/python'} 09:20:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:06 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:20:06 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:20:06 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:20:06 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:20:06 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:20:06 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:20:06 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:20:06 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:20:06 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:20:06 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:07 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:20:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:20:07 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:20:07 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:20:07 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:20:07 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:20:07 INFO - Installing collected packages: marionette-driver 09:20:07 INFO - Running setup.py install for marionette-driver 09:20:07 INFO - Successfully installed marionette-driver 09:20:07 INFO - Cleaning up... 09:20:08 INFO - Return code: 0 09:20:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:20:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:08 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 0x290f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8a840>, '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 0x2c8b740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8bbd0>, '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': '8887e36bb8e381bfd44124ac000001a8-1496765856.808188-1575682196', '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:20:08 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:20:08 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:20:08 INFO - Using env: {'DISPLAY': ':0', 09:20:08 INFO - 'HOME': '/home/cltbld', 09:20:08 INFO - 'LANG': 'en_US.UTF-8', 09:20:08 INFO - 'LANGUAGE': 'en_US:en', 09:20:08 INFO - 'LOGNAME': 'cltbld', 09:20:08 INFO - 'MAIL': '/var/mail/cltbld', 09:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:08 INFO - 'MOZ_NO_REMOTE': '1', 09:20:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:08 INFO - 'NO_EM_RESTART': '1', 09:20:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:08 INFO - 'PWD': '/builds/slave/test', 09:20:08 INFO - 'SHELL': '/bin/bash', 09:20:08 INFO - 'SHLVL': '1', 09:20:08 INFO - 'TERM': 'linux', 09:20:08 INFO - 'TMOUT': '86400', 09:20:08 INFO - 'USER': 'cltbld', 09:20:08 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1496765856.808188-1575682196', 09:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:08 INFO - '_': '/tools/buildbot/bin/python'} 09:20:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:20:08 INFO - Cleaning up... 09:20:08 INFO - Return code: 0 09:20:08 INFO - Running post-action listener: _resource_record_post_action 09:20:08 INFO - Running post-action listener: _start_resource_monitoring 09:20:08 INFO - Starting resource monitoring. 09:20:08 INFO - [mozharness: 2017-06-06 16:20:08.273905Z] Finished create-virtualenv step (success) 09:20:08 INFO - [mozharness: 2017-06-06 16:20:08.274375Z] Running install step. 09:20:08 INFO - Running pre-action listener: _resource_record_pre_action 09:20:08 INFO - Running main action method: install 09:20:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:20:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:20:08 INFO - Reading from file tmpfile_stdout 09:20:08 INFO - Detecting whether we're running mozinstall >=1.0... 09:20:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:20:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:20:08 INFO - Reading from file tmpfile_stdout 09:20:08 INFO - Output received: 09:20:08 INFO - Usage: mozinstall [options] installer 09:20:08 INFO - Options: 09:20:08 INFO - -h, --help show this help message and exit 09:20:08 INFO - -d DEST, --destination=DEST 09:20:08 INFO - Directory to install application into. [default: 09:20:08 INFO - "/builds/slave/test"] 09:20:08 INFO - --app=APP Application being installed. [default: firefox] 09:20:08 INFO - mkdir: /builds/slave/test/build/application 09:20:08 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:20:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:20:26 INFO - Reading from file tmpfile_stdout 09:20:26 INFO - Output received: 09:20:26 INFO - /builds/slave/test/build/application/firefox/firefox 09:20:26 INFO - Running post-action listener: _resource_record_post_action 09:20:26 INFO - [mozharness: 2017-06-06 16:20:26.032652Z] Finished install step (success) 09:20:26 INFO - [mozharness: 2017-06-06 16:20:26.032936Z] Running setup-mitmproxy step. 09:20:26 INFO - Running pre-action listener: _resource_record_pre_action 09:20:26 INFO - Running main action method: setup_mitmproxy 09:20:26 INFO - Skipping: mitmproxy is not required 09:20:26 INFO - Running post-action listener: _resource_record_post_action 09:20:26 INFO - [mozharness: 2017-06-06 16:20:26.034144Z] Finished setup-mitmproxy step (success) 09:20:26 INFO - [mozharness: 2017-06-06 16:20:26.034368Z] Running run-tests step. 09:20:26 INFO - Running pre-action listener: _resource_record_pre_action 09:20:26 INFO - Running main action method: run_tests 09:20:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:20:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:20:26 INFO - Python 2.7.3 09:20:26 INFO - Return code: 0 09:20:26 INFO - grabbing minidump binary from tooltool 09:20: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:20:26 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 0x2c8a840>, '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 0x2c8b740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8bbd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:20:26 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:20:26 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:20:26 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:20:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:20:26 INFO - Return code: 0 09:20:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:20:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:20:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:20:26 INFO - ENV: RUST_BACKTRACE is now 1 09:20:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:20:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:20:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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:20:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-001 --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:20:26 INFO - Using env: {'DISPLAY': ':0', 09:20:26 INFO - 'HOME': '/home/cltbld', 09:20:26 INFO - 'LANG': 'en_US.UTF-8', 09:20:26 INFO - 'LANGUAGE': 'en_US:en', 09:20:26 INFO - 'LOGNAME': 'cltbld', 09:20:26 INFO - 'MAIL': '/var/mail/cltbld', 09:20:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:20:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:20:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:26 INFO - 'MOZ_NO_REMOTE': '1', 09:20:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:20:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:26 INFO - 'NO_EM_RESTART': '1', 09:20:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:26 INFO - 'PWD': '/builds/slave/test', 09:20:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:20:26 INFO - 'RUST_BACKTRACE': '1', 09:20:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:20:26 INFO - 'SHELL': '/bin/bash', 09:20:26 INFO - 'SHLVL': '1', 09:20:26 INFO - 'TERM': 'linux', 09:20:26 INFO - 'TMOUT': '86400', 09:20:26 INFO - 'USER': 'cltbld', 09:20:26 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1496765856.808188-1575682196', 09:20:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:26 INFO - '_': '/tools/buildbot/bin/python'} 09:20:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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:20:26 INFO - mozversion application_buildid: 20170606153929 09:20:26 INFO - mozversion application_changeset: c511ad826fe71ba2bb956d2e1c119e86d2266aba 09:20:26 INFO - mozversion application_display_name: Nightly 09:20:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:20:26 INFO - mozversion application_name: Firefox 09:20:26 INFO - mozversion application_remotingname: firefox 09:20:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:20:26 INFO - mozversion application_vendor: Mozilla 09:20:26 INFO - mozversion application_version: 55.0a1 09:20:26 INFO - mozversion platform_buildid: 20170606153929 09:20:26 INFO - mozversion platform_changeset: c511ad826fe71ba2bb956d2e1c119e86d2266aba 09:20:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:20:26 INFO - mozversion platform_version: 55.0a1 09:20:26 INFO - using testdate: 1496766026 09:20:26 INFO - actual date: 1496766026 09:20:26 INFO - starting webserver on 'localhost:42320' 09:20:26 INFO - SUITE-START | Running 2 tests 09:20:26 INFO - TEST-START | dromaeo_css 09:20:26 INFO - operating with platform_type : linux_ 09:20:26 INFO - Initialising browser for dromaeo_css test... 09:20:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42320/getInfo.html -profile /tmp/tmpI1ykrC/profile 09:20:26 INFO - TEST-INFO | started process 12014 (/builds/slave/test/build/application/firefox/firefox http://localhost:42320/getInfo.html) 09:21:01 INFO - TEST-INFO | 12014: killed by SIGTERM 09:21:01 INFO - Browser initialized. 09:21:01 INFO - Running cycle 1/1 for dromaeo_css test... 09:21:01 INFO - TEST-INFO | started process 12243 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI1ykrC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:21:13 INFO - PID 12243 | RSS: Main: 200028160 09:21:13 INFO - PID 12243 | 09:24:14 INFO - PID 12243 | Cycle 1(1): loaded http://localhost:42320/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42320/tests/dromaeo/cssquery-ext.html) 09:24:15 INFO - PID 12243 | RSS: Main: 186236928 09:24:15 INFO - PID 12243 | 09:27:17 INFO - PID 12243 | Cycle 1(1): loaded http://localhost:42320/tests/dromaeo/cssquery-ext.html (next: http://localhost:42320/tests/dromaeo/cssquery-jquery.html) 09:27:18 INFO - PID 12243 | RSS: Main: 192462848 09:27:18 INFO - PID 12243 | 09:30:20 INFO - PID 12243 | Cycle 1(1): loaded http://localhost:42320/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42320/tests/dromaeo/cssquery-mootools.html) 09:30:20 INFO - PID 12243 | RSS: Main: 191090688 09:30:20 INFO - PID 12243 | 09:33:22 INFO - PID 12243 | Cycle 1(1): loaded http://localhost:42320/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42320/tests/dromaeo/cssquery-prototype.html) 09:33:23 INFO - PID 12243 | RSS: Main: 193138688 09:33:23 INFO - PID 12243 | 09:36:25 INFO - PID 12243 | Cycle 1(1): loaded http://localhost:42320/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42320/tests/dromaeo/cssquery-yui.html) 09:36:26 INFO - PID 12243 | RSS: Main: 192008192 09:36:26 INFO - PID 12243 | 09:39:28 INFO - PID 12243 | Cycle 1(1): loaded http://localhost:42320/tests/dromaeo/cssquery-yui.html (next: http://localhost:42320/tests/dromaeo/cssquery-dojo.html) 09:39:28 INFO - PID 12243 | RSS: Main: 192856064 09:39:28 INFO - PID 12243 | 09:39:28 INFO - PID 12243 | __start_tp_report 09:39:28 INFO - PID 12243 | _x_x_mozilla_page_load 09:39:28 INFO - PID 12243 | _x_x_mozilla_page_load_details 09:39:28 INFO - PID 12243 | |i|pagename|runs| 09:39:28 INFO - PID 12243 | |0;dojo.html;3074.292912630095;3100.7674424418174;3114.5172498262764;3117.142785733922;3117.7973431726937;5911.231539899818;5987.970060149699;6012.969935150323;6020.096985452179;6027.87944241116;5970.223870896777;5980.760769569223;5987.520998320135;6053.455189032986;6094.207752992105;5403.324584426947;5515.779368825252;5530.5299049580635;5551;5560.304961879765;5645.294338207724;5647.3505546862025;5649.378568357477;5654.406287339832;5668.603197776158;5449.64577302474;5511.889762204733;5531.197976293455;5548.44515548446;5562.638428502155;5539.806106786243;5555.30558680165;5556.277683901108;5585.134304182858;5622;5553.888922221573;5566.081596536566;5567.582431317627;5598.048331783566;5600.439956004408;6014.338422773491;6025.548083893726;6034.969825150846;6041.879162416771;6060.515158787286;6288.434040936338;6374.330695277022;6381.840453988688;6448.64532450715;6531.183602049744;6564.376384243537;6587.275399706076;6588.736450541973;6598;6602.867942641168;6019.578629495981;6094.146819445281;6096.96951515244;6098.756049758049;6101.450869421773;6473.546851720429;6554.279029306773;6607.867842643216;6728.697208625624;6742.865142697118;6379.872402552016;6404;6416.165898433267;6440.227172739301;6443.097966284724;6500.967495162588;6509.9023514647315;6522.641254731036;6538.084668146464;6549.901751473732;6256.906146407808;6342.778002769881;6474.870502589922;6511.576747511396;6513.902291465632;6319.58922670025;6389.904151437732;6463.935360646427;6479.773207937794;6490.928996715584;5279.1817268323475;5285.762140703678;5289.523942845162;5300.575953923677;5316.627836051517;4509.053098849213;4512.323151527297;4520.683552151318;4529.184746745552;4572.839950601713;5534.335879694462;5585.636933599303;5589.8602534936135;5702.6293290935955;5719.685417302088;6568.80293591193;6612.702428390734;6615.86768264632;6616.66916654175;6635.469162466991;5693.03218452864;5703.17303990919;5712.343080545707;5713.200151978726;5746.0519014363;5612.242347283146;5627;5709.172170035322;5776.33572139201;5811.476967072984;6346.143270658402;6366.586171898812;6372.776952806629;6376.043593460925;6383.680815959091;6281.497480201481;6489.8702025960165;6569.9343006569325;6577.671116444254;6589.769358072444;6198.659073750987;6230.43926046658;6282.937170628235;6299.433051025429;6320.241571011508;6114.054067497291;6188.9690551546955;6430.935690643034;6452.645104519296;6469.7412103515335;6338.778142764981;6430.099786030053;6437.356264373525;6447.871042579029;6468.482521398371;6279.120923070683;6350.523710721622;6366.3633636637815;6374.07575901501;6376.52176086786;6143.051335358963;6349.730053989313;6367.885620016571;6373.330800265905;6377.915754321869;6139.492138333381;6157.199564056644;6199.535034872312;6262.029385445263;6270.968645156745;6414.871702566016;6434.935650643433;6436.420722135031;6439.45264652491;6445.774397896051;6151.853328019096;6246.812595622138;6258.530610204162;6258.780942666985;6262.246570960138 09:39:28 INFO - PID 12243 | |1;ext.html;727.2218725963221;776.9261920117589;786.4416264452238;1148.580768019673;1154.1516985016005;36087.458688119696;36715.816420917894;36755.63244367555;36785.44821827672;36797.44803827945;38666;39036.804815975884;39064.60935390645;39110.608893911056;39157.60842391575;7196.532225405332;7336.96331518343;7368.263173682642;7496.400287976949;7498.4001279897475;7325.560466372035;7424.071991001125;7428.331450169484;7435.405167586607;7440.66517006736;7381.667824947864;7386.519876208056;7450.850982980364;7466.290702383265;7469.991551140608;7380.557166570023;7408.407327413794;7424.183339832641;7428.962855185717;7432.108147022338;7298.635068246566;7354.705811767523;7358.374538164262;7369.299916507923;7376.889346659805;36440.81779591085;36499.452508212395;36647.81676091629;36669.816650916575;36768.63231367679;3544.4151714967;3578.946315805265;3580.5524309461316;3582.8208589570677;3597.244578638489;28275.71724282772;28277.858610706815;28373.290667733265;28517.144485665463;28594;3577.2130131371055;3591.928161436783;3629.237860049393;3648.504113313555;3656.597774244831;138768.30615846958;138860;151341.2432937828;158158;159282;43015.92460188458;43224;43243.567564324585;43378.7831060849;43505.782471088074;44808.77595612001;44876.77561612171;44925;44986;45126.32310515279;15034.173120478259;15132.773008404884;15155.924220378827;15164.772528412082;15175;12419.44112514939;12424.75150497003;12430.016795968902;12434.12961092733;12452.252864828139;13439.865601344058;13516;13535.120217186048;13569.932150339382;13778.448862045607;5522.751476183581;5567.860803479945;5591.133374326986;5675.971620141955;5725.914111288334;959.7792507723124;999.9850002249972;1007.6825799873017;1010.8635334229932;1015.7054454208197;21658.35024949254;22309.55380892373;22730.43173920665;23073.423164421023;23092.4226894329;1072.5924148823553;1076.4617691154422;1082.6697857153486;1084.7410441751051;1092.3937214845678;11346.262492937933;11823.98992171333;11899.464524096436;12307.876921230853;12926.806097908539;196945;197834;198026;198232;198363;49059.26411103836;49372.50627493751;49537;49639.50360496421;49765.751171243915;1411.5200831717266;1455.6360909772557;1460.2114857976574;1470.7720303353212;1474.808274924253;21678.89160554187;22440;23511;23812.761872381747;24015.279541613778;35822.8208858954;35876;35939.28121437609;35978.4603230957;36054;165237;166733;167226;169194;169252;31520.684793151773;32325;32693.673063269063;32971.50542741813;33114.33771324512;39245.41131883081;39389.6061039386;40340.3948940772;40407;41751.373729393476;29789.5531567031;30350.544741829333;30583.006381702475;30760;30910.22724431907;29143.708562914948;30192.54711179378;30216.934919524494;31490.37019259556;31697.5245371315;33002.339953201285;33651.326973460884;33897.322053559285;34139;34394.31211375808;28715.712842871304;28877.566836497048;29386.559201611566;30145.246368840955;31107.68892311048;21478.67781983303;24291.271261862174;24368.951782906206;24435.51128977375;24630 09:39:28 INFO - PID 12243 | |2;jquery.html;417.4768386137482;426.1987463568491;431.357277656292;439.21380728495984;450.2031404414185;19929.900350498265;20607.484812879666;20663.483412914666;21745.782542174613;22333.776662233373;23879.5224095518;24389.63415548768;24482.755172448316;24483.510329793393;24501;6642.667866606675;6779.525433219676;6780.118584583997;6786;6805.353491418307;6310.9684451577905;6656.202825237183;6656.567323124005;6690.130283063195;6702.095217145696;6591.307912669173;6636.402723754861;6641.7048675508295;6646.1027761252335;6662.533622646417;6656.667166641649;6663.700133494004;6664.700088496029;6673.93326066738;6677.465802735769;6483.189601299838;6490.05894145351;6495.415412612888;6502.349765023507;6534.215894092692;27212.59181112285;27574.621268936473;27818.860905695543;27858.3035424114;27916;1928.9807101929082;1963.4207908666976;1971.1918113573508;1976.940691779249;1982.2170242754032;17751;18373.08134593265;18413.63172736551;18420;18456.53858653531;2303.1593468384085;2321.558903808271;2406.7111946566347;2410.6745589345564;2413.070967677439;109538;114507.42746286298;121040.39479802633;121247;121583;19420.611587768166;20213.898930505253;20501.872397018007;21069;21107.577848442947;38313.616863831565;39476.21047579032;39725.04124381366;39761.602383976366;39901.80049099794;10403.791924161475;10419.739506512245;10579.418132002813;10619.469026548642;10663.306885052447;8496.575171241413;8568.944322849424;8603.354748393895;8615.827683446296;8704.086070962585;10475.685729428129;10765.246432749633;10842.186835987333;11034.668959931216;11193.552257909592;3806.0711378764568;4075.291484748864;4146.315857883415;4194.706370554093;4206.305959516645;929.920956718673;943.5329511891657;1018.2871989607305;1021.2136654775929;1026.4559783314855;18400.35598754064;18581.90709046446;18664.253429862652;19497.317593884145;20376.592468150553;903.7198468474794;941.8257622339889;968.4092703450889;990.0643891522442;992.7964767222702;9180.281985795764;9604.471754053595;9785.657501987396;9807.656732014346;9908.25688073383;424389;428474;428791;429885;430958;92922.53538732398;93618.53190734003;95174;95531.52234238923;95795.52102239445;1161.8896204860525;1204.4519743516503;1215.0583297944163;1229.489761748864;1240.8573014103313;17613.471595852145;17980.64038719192;18244.635107298047;18265;18575.349862754738;45929;46155.30767038564;46906.296405554625;46949;46983.76508117574;60471;60751.65865877419;65957.67021164864;68170;68563.31436685569;10332.380057196593;10667;10788.784224315626;10794.73013174677;10837.67486975392;17419.041952692725;17504.649907002044;18300.176492057624;18452.81547184511;18701;13625.386857591235;13826.930865345608;14214.644633884236;14239.216843073731;14478.131312121306;13254.867451325363;13585.93207033998;13793.586192414243;13900.304984750925;14484.637884052983;13513.189208647513;13692;13896.096753710977;13928.721425571635;13947.37236824325;9723.36798108149;9818.901810981799;9920.156786673213;9949;9974.60101595928;12374.762523747553;12591;12645.241285522898;12677.746445071232;12690.365481726061 09:39:28 INFO - PID 12243 | |3;mootools.html;1207.7101495641045;1211.9151659383836;1221.7678641058199;1227.7851376009191;1231.9507219711209;10719.464026798658;11227.887721122786;11228.438578071105;11248;11586.884131158686;11225.66323010309;11355.318680879152;11418.54325826966;11434.942825285883;11449.141314401411;2288.7367952685445;2321.6517522371696;2329.429289823987;2334.533093381322;2338.684277622525;2258.2209137847417;2290.7365652949875;2293.816494680422;2300.7929286364224;2308.4690521180055;2225.187806450642;2253.3690566641285;2256.8533045352083;2259.29961711869;2264.5923733727923;2171.2292136291703;2186.5517568898417;2195.5828392605436;2204.470926977514;2207.4371035386034;1886.1135266424758;1936.6126774645127;2167.5773224221284;2218.3788539208886;2219.755826859044;10759;10913.454327283684;10922.344659320386;10927.726806829813;10949.726256843564;5926.822195334147;6158.692065396713;6160.476359509447;6165.445109940127;6166.660833654148;3511.9824400877833;3640.2537479816574;3697.334479793636;3719.256148770257;3729.4522773049152;1182.8048372018607;1206.8370769946032;1215.3740823475916;1226.4971361741732;1242.7017515796235;15533.533993980198;15583.844161558465;15595;15691.136987465685;15710.214489275491;5093.312402825572;5113.284140220372;5153.561947234527;5176.8964620707375;5253.632245742761;11968.162228644085;12110.333931633668;12160.756784864254;12220.083493738006;12234;6124.173236613;6271.216097987752;6278.968605156945;6281.685915704196;6287.434130928238;5805.158252053428;5821.505172060338;5829.067349224104;5848.356680765112;5873.3245676746865;3876.205377897524;3974.8012599370495;3987.182627561343;4038.838446462167;4045.959540404617;1158.9072874170047;1161.0769438296406;1164.7379339648512;1171.5255321594768;1177.4466000979526;787.6534324897142;818.6970820796224;827.185222555782;833.9416240863081;836.4813815434348;6274.717637706314;6520.836979075466;6583.374579415044;6652.800415987528;6760.222574403908;967.777411195429;970.9854352184723;975.7511834482161;975.853621956698;989.5893204320271;4160.625543701081;4240.872773816791;4271.893202669959;4312.719673221231;4345.174416860849;13634.522791702242;13640.727185456433;14417.495387661591;14418.639534011734;14425.78361324581;13852.238126902916;14097.295135243401;14147.29263536819;14212.573622791333;14261.500847470288;8668.575912514647;8910.910890891008;8920;8920.286377089817;8920.821583568293;6081.695915204134;6354.665071770261;6654.434373078343;6711.664416779239;6945;12623.368831558202;12712.237265764084;12883.80674289905;12977.286249256382;12980.610581682564;13076.411561479947;13079.149855259378;13268.668283292609;13390.598282051555;13431.26128062927;8822.161894620001;8950.418222815497;8956.641734330815;9110.453372797389;9256.305777066613;9913.553890075109;10108.545115469675;10118.241131915283;10129.848052279074;10144.644937427154;8391.370647201606;8566.828663426571;8645.438046526955;8716.43343182691;8722.258608018135;8311.709090181814;8348.833023339377;8373.706920258006;8557.61490732906;8705.782355441164;7319.59742214162;7384.593847338448;7403.074615673041;7407.62961851916;7442.702291908479;4921.803127874845;5518.365387980433;5720.17057526648;5795.3625101237985;6070.332263451105;5829.242198514166;6012.128241405059;6014.548908831943;6070.696465176812;6114.908276375769 09:39:28 INFO - PID 12243 | |4;prototype.html;396.8650658776016;405.36762650265587;411.1899557870995;411.99382009269846;414.8278464437259;6301.779437719681;6342.936570634292;6365.29981702013;6379.468927457412;6398.648074355914;5919.556033297509;6116.908246376308;6146.81559553213;6156.015037593986;6167.198264225655;4771.904561908777;4795.640326975482;4796.52034796521;4823.710577365352;4824;4811.326414302001;4826.107170173529;4836.443808961979;4841.782119804618;4885.656444477761;4708.529147085298;4754.334393184957;4769.403824521934;4787;4811.566958973692;4741.336212930175;4763.4998325175875;4793.281007848851;4807.831725889577;4820.156472617313;4215.072684009513;4221.873343799691;4228.154369126187;4231.767252801094;4243.702940794145;6117.296510901258;6124.142620033199;6135.907961380538;6151.323354431009;6153.2000839890525;5510.724463776795;5513.255710479114;5519.420460851633;5528.170774383834;5530.806421775259;6500.4474619657385;6504.219493660791;6554.836129096763;6579.671016449159;6592.30780768022;4585.4726706428855;4596.678232523725;4597.586217240431;4602.677812553123;4604.631629469668;6406.967965160145;6873.621950792754;6898.482613803984;6950.409215216712;6982.546134501241;4608.470025946992;4667.439907211156;4667.8366257181515;4679.204535229019;4691.7888695008805;4697.694649847817;4714.269288260325;4715.882102947385;4724.574788269072;4728.267118596623;5271.757868910592;5393.568514518829;5404.567634589223;5433.456654334614;5450.700211488406;6539.384246301517;6541.934580654132;6564.343565643493;6598.670066496656;6630.701618427182;1628.23472967705;1635.2069246415479;1637.6970260501846;1642.991785041067;1652.7603497492796;1057.8945002472435;1092.6448904106198;1113.6547670222258;1114.8773634900153;1120.3725913488472;5872.677002764889;5904.498117660047;5908.940910590839;5920.585559010828;5921.615095018896;6735.629540375228;6742.292059333798;6803.353681400259;6822.795316140524;6838.350356716104;5796.391378905154;5835.620684655484;5854.560907931922;5859.472647461749;5861.6002718423215;3582.5880023797595;3615.692666123409;3633.255182687543;3641.435577485494;3649.2701459708164;6591.373819487141;6601.636909969998;6620.635865027373;6622.966885165543;6631.706817170605;6960.617166055814;6974.58152510851;6980.511364204457;6987.1266091738535;7008.474364422688;6540.182477190351;6599.70301336441;6605.372489613479;6641.800745977628;6653.733850646016;6754.358335958076;6770.695318710768;6845.589264644137;6868.557602903446;6871.106756121872;6756.256811750605;6773.796786096425;6775;6780.1524809398825;6804.96597517029;6034.09488576717;6372.58578192416;6513.381228783258;6582.934170658232;6589.5173585942775;4652.953470465252;4657.673962822705;4658.627309815139;4660.207764679944;4671.11248862715;6778.593284402951;6840.41856442208;6848.828779280558;6864.38220560152;6875.759348422981;6321.431071203614;6560.967195163994;6569.638669873012;6580.762540736173;6626.701798418986;6527.3472652736245;6561.639109849004;6573.638449885302;6573.638449885302;6648.301928297459;6522.315156908646;6552.803415897531;6553.541252112306;6557.180352455943;6571.835704107436;6644.767433139817;6653.866922661617;6654.367835055662;6663;6675.899861501985;6440.13058237132;6441.774537891151;6444.355564443518;6460.903086453801;6494.9025764612625 09:39:28 INFO - PID 12243 | |5;yui.html;813.8250276190618;845.9788505287363;849.7535714642754;851.506126446661;867.9956600216996;16934.3226270949;17230.913845430772;17265.65468690627;18825.905870470662;20141;18871.905640471814;19008.334708285212;19151.90424047878;19161.041947902584;19190.808091919076;968.7432830299958;991.8264303746815;992.5632721602472;993.92545559083;996.8853581838109;976.6288810252095;989.2284018465608;993.6174572789492;995.2983146881431;1015.0154350280253;1059.8145324568209;1061.2783307350999;1061.8778840433372;1062.2511129653576;1062.6811956413046;1053.7523681934777;1054.2672842374552;1055.0504545908666;1056.9154467642647;1058.9046985771279;764.5947647746704;767.9308862202373;770.7803276066294;774.1561697749423;775.464929198851;16907.239174237187;17137.400190993256;17333.2200050998;17368.131593420403;17914.372996945174;18671.15979780913;18761.0619469026;18944.14751336193;19137.80862191374;19155.808441915542;15093.773593396108;15197.164155971417;15229.390824367012;15240.542783716506;15273;3482.721382289411;3520.612732599412;3542.1498840278405;3543.8228088595465;3777.943330850012;84452;84646.99999999939;85940;85979;86953;14215.50245741394;15208;15311.846881531264;15332.386704531917;15332.390099039663;26463.603045954325;27128.32179195536;27486.862565687443;27930.301742456602;27939.58090628642;7779.805504862311;8123;8156.265936065783;8190.221928916743;8196.795080123045;3677.8712745053795;3742.1767211214033;3744.475773391727;3751.756135851161;3751.9062023449633;4176.83292668296;4235.576442355801;4262.914741705211;4275.87172384829;4291.978540107342;850.5959669157224;873.921347078766;879.366855863777;879.9164079412445;881.3037700216885;575.3010092737344;587.917691523187;596.2308621877816;606.7481994972037;622.9034499652561;9701.70894873155;9873;10437.947810260901;10732.087772539422;10792.838107428395;572.940060887355;613.2739970829708;616.2266355723539;623.7692053940071;630.8359826445065;4366.19225443294;4390.868273951786;4405.9559404405545;4581.518940511265;4729.952700472952;91059.54470227606;91918;93234.53382733042;93387.06612933784;97612.51193744128;84545.57727211325;84598.77006149791;85600;86165.56917215374;86457;73857.89213161806;74056.62971685106;74084.25915740774;74150.25849741434;74450.627746862;8668.219860212612;8841.336899732418;9159.862602061108;9389.154976052188;9456.621735130519;30980.84509577528;31438.371232574762;31548.36903261876;31670.841645792545;31970.36059278755;56225;56505.15242271287;56977;57538.7123064382;57886;16394.5081647546;16693.248803803614;16801.663966720353;16902.830971690124;17116.828831711522;15132.621684457976;17667.823321766617;17982.460526184237;18418.907905460925;18508.629827403107;14960.92519537439;15009.399624014917;15087.170205638795;15158.545243642708;15407.768883466533;14828.851711482746;15241.628253457242;15322.080675159526;15616.687666246838;15618.765718514003;14004.859951400356;14257.786133207803;14305.785413219019;14521.636959075686;14614;8974.551272436222;9007.729768106705;9174.082591740773;9438.905610943802;9453.149216570266;10555.52500137511;11046.392448415414;11090.011393847231;11780.52877884875;11786.41067946582 09:39:28 INFO - PID 12243 | __end_tp_report 09:39:28 INFO - PID 12243 | __start_cc_report 09:39:28 INFO - PID 12243 | _x_x_mozilla_cycle_collect,384 09:39:28 INFO - PID 12243 | __end_cc_report 09:39:28 INFO - PID 12243 | __startTimestamp1496767168705__endTimestamp 09:39:28 INFO - PID 12243 | 09:39:28 INFO - PID 12243 | ------- Summary: start ------- 09:39:28 INFO - PID 12243 | Number of tests: 6 09:39:28 INFO - PID 12243 | 09:39:28 INFO - PID 12243 | [#0] dojo.html Cycles:165 Average:5981.57 Median:6199.54 stddev:692.92 (11.2%) stddev-sans-first:656.44 09:39:28 INFO - PID 12243 | Values: 3074.3 3100.8 3114.5 3117.1 3117.8 5911.2 5988.0 6013.0 6020.1 6027.9 5970.2 5980.8 5987.5 6053.5 6094.2 5403.3 5515.8 5530.5 5551.0 5560.3 5645.3 5647.4 5649.4 5654.4 5668.6 5449.6 5511.9 5531.2 5548.4 5562.6 5539.8 5555.3 5556.3 5585.1 5622.0 5553.9 5566.1 5567.6 5598.0 5600.4 6014.3 6025.5 6035.0 6041.9 6060.5 6288.4 6374.3 6381.8 6448.6 6531.2 6564.4 6587.3 6588.7 6598.0 6602.9 6019.6 6094.1 6097.0 6098.8 6101.5 6473.5 6554.3 6607.9 6728.7 6742.9 6379.9 6404.0 6416.2 6440.2 6443.1 6501.0 6509.9 6522.6 6538.1 6549.9 6256.9 6342.8 6474.9 6511.6 6513.9 6319.6 6389.9 6463.9 6479.8 6490.9 5279.2 5285.8 5289.5 5300.6 5316.6 4509.1 4512.3 4520.7 4529.2 4572.8 5534.3 5585.6 5589.9 5702.6 5719.7 6568.8 6612.7 6615.9 6616.7 6635.5 5693.0 5703.2 5712.3 5713.2 5746.1 5612.2 5627.0 5709.2 5776.3 5811.5 6346.1 6366.6 6372.8 6376.0 6383.7 6281.5 6489.9 6569.9 6577.7 6589.8 6198.7 6230.4 6282.9 6299.4 6320.2 6114.1 6189.0 6430.9 6452.6 6469.7 6338.8 6430.1 6437.4 6447.9 6468.5 6279.1 6350.5 6366.4 6374.1 6376.5 6143.1 6349.7 6367.9 6373.3 6377.9 6139.5 6157.2 6199.5 6262.0 6271.0 6414.9 6434.9 6436.4 6439.5 6445.8 6151.9 6246.8 6258.5 6258.8 6262.2 09:39:28 INFO - PID 12243 | 09:39:28 INFO - PID 12243 | [#1] ext.html Cycles:180 Average:33421.17 Median:33382.83 stddev:44611.44 (133.6%) stddev-sans-first:44669.04 09:39:28 INFO - PID 12243 | Values: 727.2 776.9 786.4 1148.6 1154.2 36087.5 36715.8 36755.6 36785.4 36797.4 38666.0 39036.8 39064.6 39110.6 39157.6 7196.5 7337.0 7368.3 7496.4 7498.4 7325.6 7424.1 7428.3 7435.4 7440.7 7381.7 7386.5 7450.9 7466.3 7470.0 7380.6 7408.4 7424.2 7429.0 7432.1 7298.6 7354.7 7358.4 7369.3 7376.9 36440.8 36499.5 36647.8 36669.8 36768.6 3544.4 3578.9 3580.6 3582.8 3597.2 28275.7 28277.9 28373.3 28517.1 28594.0 3577.2 3591.9 3629.2 3648.5 3656.6 138768.3 138860.0 151341.2 158158.0 159282.0 43015.9 43224.0 43243.6 43378.8 43505.8 44808.8 44876.8 44925.0 44986.0 45126.3 15034.2 15132.8 15155.9 15164.8 15175.0 12419.4 12424.8 12430.0 12434.1 12452.3 13439.9 13516.0 13535.1 13569.9 13778.4 5522.8 5567.9 5591.1 5676.0 5725.9 959.8 1000.0 1007.7 1010.9 1015.7 21658.4 22309.6 22730.4 23073.4 23092.4 1072.6 1076.5 1082.7 1084.7 1092.4 11346.3 11824.0 11899.5 12307.9 12926.8 196945.0 197834.0 198026.0 198232.0 198363.0 49059.3 49372.5 49537.0 49639.5 49765.8 1411.5 1455.6 1460.2 1470.8 1474.8 21678.9 22440.0 23511.0 23812.8 24015.3 35822.8 35876.0 35939.3 35978.5 36054.0 165237.0 166733.0 167226.0 169194.0 169252.0 31520.7 32325.0 32693.7 32971.5 33114.3 39245.4 39389.6 40340.4 40407.0 41751.4 29789.6 30350.5 30583.0 30760.0 30910.2 29143.7 30192.5 30216.9 31490.4 31697.5 33002.3 33651.3 33897.3 34139.0 34394.3 28715.7 28877.6 29386.6 30145.2 31107.7 21478.7 24291.3 24369.0 24435.5 24630.0 09:39:28 INFO - PID 12243 | 09:39:28 INFO - PID 12243 | [#2] jquery.html Cycles:180 Average:31063.88 Median:24483.13 stddev:71844.76 (293.4%) stddev-sans-first:72009.46 09:39:28 INFO - PID 12243 | Values: 417.5 426.2 431.4 439.2 450.2 19929.9 20607.5 20663.5 21745.8 22333.8 23879.5 24389.6 24482.8 24483.5 24501.0 6642.7 6779.5 6780.1 6786.0 6805.4 6311.0 6656.2 6656.6 6690.1 6702.1 6591.3 6636.4 6641.7 6646.1 6662.5 6656.7 6663.7 6664.7 6673.9 6677.5 6483.2 6490.1 6495.4 6502.3 6534.2 27212.6 27574.6 27818.9 27858.3 27916.0 1929.0 1963.4 1971.2 1976.9 1982.2 17751.0 18373.1 18413.6 18420.0 18456.5 2303.2 2321.6 2406.7 2410.7 2413.1 109538.0 114507.4 121040.4 121247.0 121583.0 19420.6 20213.9 20501.9 21069.0 21107.6 38313.6 39476.2 39725.0 39761.6 39901.8 10403.8 10419.7 10579.4 10619.5 10663.3 8496.6 8568.9 8603.4 8615.8 8704.1 10475.7 10765.2 10842.2 11034.7 11193.6 3806.1 4075.3 4146.3 4194.7 4206.3 929.9 943.5 1018.3 1021.2 1026.5 18400.4 18581.9 18664.3 19497.3 20376.6 903.7 941.8 968.4 990.1 992.8 9180.3 9604.5 9785.7 9807.7 9908.3 424389.0 428474.0 428791.0 429885.0 430958.0 92922.5 93618.5 95174.0 95531.5 95795.5 1161.9 1204.5 1215.1 1229.5 1240.9 17613.5 17980.6 18244.6 18265.0 18575.3 45929.0 46155.3 46906.3 46949.0 46983.8 60471.0 60751.7 65957.7 68170.0 68563.3 10332.4 10667.0 10788.8 10794.7 10837.7 17419.0 17504.6 18300.2 18452.8 18701.0 13625.4 13826.9 14214.6 14239.2 14478.1 13254.9 13585.9 13793.6 13900.3 14484.6 13513.2 13692.0 13896.1 13928.7 13947.4 9723.4 9818.9 9920.2 9949.0 9974.6 12374.8 12591.0 12645.2 12677.7 12690.4 09:39:28 INFO - PID 12243 | 09:39:28 INFO - PID 12243 | [#3] mootools.html Cycles:180 Average:6791.75 Median:3668.79 stddev:4340.43 (118.3%) stddev-sans-first:4332.32 09:39:28 INFO - PID 12243 | Values: 1207.7 1211.9 1221.8 1227.8 1232.0 10719.5 11227.9 11228.4 11248.0 11586.9 11225.7 11355.3 11418.5 11434.9 11449.1 2288.7 2321.7 2329.4 2334.5 2338.7 2258.2 2290.7 2293.8 2300.8 2308.5 2225.2 2253.4 2256.9 2259.3 2264.6 2171.2 2186.6 2195.6 2204.5 2207.4 1886.1 1936.6 2167.6 2218.4 2219.8 10759.0 10913.5 10922.3 10927.7 10949.7 5926.8 6158.7 6160.5 6165.4 6166.7 3512.0 3640.3 3697.3 3719.3 3729.5 1182.8 1206.8 1215.4 1226.5 1242.7 15533.5 15583.8 15595.0 15691.1 15710.2 5093.3 5113.3 5153.6 5176.9 5253.6 11968.2 12110.3 12160.8 12220.1 12234.0 6124.2 6271.2 6279.0 6281.7 6287.4 5805.2 5821.5 5829.1 5848.4 5873.3 3876.2 3974.8 3987.2 4038.8 4046.0 1158.9 1161.1 1164.7 1171.5 1177.4 787.7 818.7 827.2 833.9 836.5 6274.7 6520.8 6583.4 6652.8 6760.2 967.8 971.0 975.8 975.9 989.6 4160.6 4240.9 4271.9 4312.7 4345.2 13634.5 13640.7 14417.5 14418.6 14425.8 13852.2 14097.3 14147.3 14212.6 14261.5 8668.6 8910.9 8920.0 8920.3 8920.8 6081.7 6354.7 6654.4 6711.7 6945.0 12623.4 12712.2 12883.8 12977.3 12980.6 13076.4 13079.1 13268.7 13390.6 13431.3 8822.2 8950.4 8956.6 9110.5 9256.3 9913.6 10108.5 10118.2 10129.8 10144.6 8391.4 8566.8 8645.4 8716.4 8722.3 8311.7 8348.8 8373.7 8557.6 8705.8 7319.6 7384.6 7403.1 7407.6 7442.7 4921.8 5518.4 5720.2 5795.4 6070.3 5829.2 6012.1 6014.5 6070.7 6114.9 09:39:28 INFO - PID 12243 | 09:39:28 INFO - PID 12243 | [#4] prototype.html Cycles:180 Average:5462.66 Median:6141.36 stddev:1619.96 (26.4%) stddev-sans-first:1579.25 09:39:28 INFO - PID 12243 | Values: 396.9 405.4 411.2 412.0 414.8 6301.8 6342.9 6365.3 6379.5 6398.6 5919.6 6116.9 6146.8 6156.0 6167.2 4771.9 4795.6 4796.5 4823.7 4824.0 4811.3 4826.1 4836.4 4841.8 4885.7 4708.5 4754.3 4769.4 4787.0 4811.6 4741.3 4763.5 4793.3 4807.8 4820.2 4215.1 4221.9 4228.2 4231.8 4243.7 6117.3 6124.1 6135.9 6151.3 6153.2 5510.7 5513.3 5519.4 5528.2 5530.8 6500.4 6504.2 6554.8 6579.7 6592.3 4585.5 4596.7 4597.6 4602.7 4604.6 6407.0 6873.6 6898.5 6950.4 6982.5 4608.5 4667.4 4667.8 4679.2 4691.8 4697.7 4714.3 4715.9 4724.6 4728.3 5271.8 5393.6 5404.6 5433.5 5450.7 6539.4 6541.9 6564.3 6598.7 6630.7 1628.2 1635.2 1637.7 1643.0 1652.8 1057.9 1092.6 1113.7 1114.9 1120.4 5872.7 5904.5 5908.9 5920.6 5921.6 6735.6 6742.3 6803.4 6822.8 6838.4 5796.4 5835.6 5854.6 5859.5 5861.6 3582.6 3615.7 3633.3 3641.4 3649.3 6591.4 6601.6 6620.6 6623.0 6631.7 6960.6 6974.6 6980.5 6987.1 7008.5 6540.2 6599.7 6605.4 6641.8 6653.7 6754.4 6770.7 6845.6 6868.6 6871.1 6756.3 6773.8 6775.0 6780.2 6805.0 6034.1 6372.6 6513.4 6582.9 6589.5 4653.0 4657.7 4658.6 4660.2 4671.1 6778.6 6840.4 6848.8 6864.4 6875.8 6321.4 6561.0 6569.6 6580.8 6626.7 6527.3 6561.6 6573.6 6573.6 6648.3 6522.3 6552.8 6553.5 6557.2 6571.8 6644.8 6653.9 6654.4 6663.0 6675.9 6440.1 6441.8 6444.4 6460.9 6494.9 09:39:28 INFO - PID 12243 | 09:39:28 INFO - PID 12243 | [#5] yui.html Cycles:180 Average:19700.07 Median:3748.12 stddev:25619.88 (683.5%) stddev-sans-first:25652.50 09:39:28 INFO - PID 12243 | Values: 813.8 846.0 849.8 851.5 868.0 16934.3 17230.9 17265.7 18825.9 20141.0 18871.9 19008.3 19151.9 19161.0 19190.8 968.7 991.8 992.6 993.9 996.9 976.6 989.2 993.6 995.3 1015.0 1059.8 1061.3 1061.9 1062.3 1062.7 1053.8 1054.3 1055.1 1056.9 1058.9 764.6 767.9 770.8 774.2 775.5 16907.2 17137.4 17333.2 17368.1 17914.4 18671.2 18761.1 18944.1 19137.8 19155.8 15093.8 15197.2 15229.4 15240.5 15273.0 3482.7 3520.6 3542.1 3543.8 3777.9 84452.0 84647.0 85940.0 85979.0 86953.0 14215.5 15208.0 15311.8 15332.4 15332.4 26463.6 27128.3 27486.9 27930.3 27939.6 7779.8 8123.0 8156.3 8190.2 8196.8 3677.9 3742.2 3744.5 3751.8 3751.9 4176.8 4235.6 4262.9 4275.9 4292.0 850.6 873.9 879.4 879.9 881.3 575.3 587.9 596.2 606.7 622.9 9701.7 9873.0 10437.9 10732.1 10792.8 572.9 613.3 616.2 623.8 630.8 4366.2 4390.9 4406.0 4581.5 4730.0 91059.5 91918.0 93234.5 93387.1 97612.5 84545.6 84598.8 85600.0 86165.6 86457.0 73857.9 74056.6 74084.3 74150.3 74450.6 8668.2 8841.3 9159.9 9389.2 9456.6 30980.8 31438.4 31548.4 31670.8 31970.4 56225.0 56505.2 56977.0 57538.7 57886.0 16394.5 16693.2 16801.7 16902.8 17116.8 15132.6 17667.8 17982.5 18418.9 18508.6 14960.9 15009.4 15087.2 15158.5 15407.8 14828.9 15241.6 15322.1 15616.7 15618.8 14004.9 14257.8 14305.8 14521.6 14614.0 8974.6 9007.7 9174.1 9438.9 9453.1 10555.5 11046.4 11090.0 11780.5 11786.4 09:39:28 INFO - PID 12243 | -------- Summary: end -------- 09:39:28 INFO - PID 12243 | 09:39:29 INFO - TEST-INFO | 12243: exit 0 09:39:29 INFO - TEST-OK | dromaeo_css | took 1143362ms 09:39:29 INFO - TEST-START | kraken 09:39:29 INFO - operating with platform_type : linux_ 09:39:29 INFO - Initialising browser for kraken test... 09:39:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42320/getInfo.html -profile /tmp/tmpeiGavw/profile 09:39:29 INFO - TEST-INFO | started process 12664 (/builds/slave/test/build/application/firefox/firefox http://localhost:42320/getInfo.html) 09:40:04 INFO - TEST-INFO | 12664: killed by SIGTERM 09:40:04 INFO - Browser initialized. 09:40:04 INFO - Running cycle 1/1 for kraken test... 09:40:04 INFO - TEST-INFO | started process 12892 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeiGavw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:40:16 INFO - PID 12892 | RSS: Main: 199839744 09:40:16 INFO - PID 12892 | 09:40:19 INFO - PID 12892 | Cycle 1(1): loaded http://localhost:42320/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42320/tests/kraken/driver.html?testName=audio-beat-detection) 09:40:20 INFO - PID 12892 | RSS: Main: 200777728 09:40:20 INFO - PID 12892 | 09:40:22 INFO - PID 12892 | Cycle 1(1): loaded http://localhost:42320/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42320/tests/kraken/driver.html?testName=audio-dft) 09:40:23 INFO - PID 12892 | RSS: Main: 199032832 09:40:23 INFO - PID 12892 | 09:40:26 INFO - PID 12892 | Cycle 1(1): loaded http://localhost:42320/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42320/tests/kraken/driver.html?testName=audio-fft) 09:40:27 INFO - PID 12892 | RSS: Main: 189771776 09:40:27 INFO - PID 12892 | 09:40:29 INFO - PID 12892 | Cycle 1(1): loaded http://localhost:42320/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42320/tests/kraken/driver.html?testName=audio-oscillator) 09:40:29 INFO - PID 12892 | RSS: Main: 190566400 09:40:29 INFO - PID 12892 | 09:40:31 INFO - PID 12892 | Cycle 1(1): loaded http://localhost:42320/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42320/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:40:32 INFO - PID 12892 | RSS: Main: 190459904 09:40:32 INFO - PID 12892 | 09:40:35 INFO - PID 12892 | Cycle 1(1): loaded http://localhost:42320/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42320/tests/kraken/driver.html?testName=imaging-darkroom) 09:40:36 INFO - PID 12892 | RSS: Main: 191295488 09:40:36 INFO - PID 12892 | 09:40:39 INFO - PID 12892 | Cycle 1(1): loaded http://localhost:42320/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42320/tests/kraken/driver.html?testName=imaging-desaturate) 09:40:40 INFO - PID 12892 | RSS: Main: 190763008 09:40:40 INFO - PID 12892 | 09:40:43 INFO - PID 12892 | Cycle 1(1): loaded http://localhost:42320/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42320/tests/kraken/driver.html?testName=json-parse-financial) 09:40:43 INFO - PID 12892 | RSS: Main: 191340544 09:40:43 INFO - PID 12892 | 09:40:45 INFO - PID 12892 | Cycle 1(1): loaded http://localhost:42320/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42320/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:40:46 INFO - PID 12892 | RSS: Main: 191680512 09:40:46 INFO - PID 12892 | 09:40:47 INFO - PID 12892 | Cycle 1(1): loaded http://localhost:42320/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42320/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:40:48 INFO - PID 12892 | RSS: Main: 191533056 09:40:48 INFO - PID 12892 | 09:40:50 INFO - PID 12892 | Cycle 1(1): loaded http://localhost:42320/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42320/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:40:51 INFO - PID 12892 | RSS: Main: 191942656 09:40:51 INFO - PID 12892 | 09:40:54 INFO - PID 12892 | Cycle 1(1): loaded http://localhost:42320/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42320/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:40:54 INFO - PID 12892 | RSS: Main: 191782912 09:40:54 INFO - PID 12892 | 09:40:57 INFO - PID 12892 | Cycle 1(1): loaded http://localhost:42320/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42320/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:40:58 INFO - PID 12892 | RSS: Main: 191770624 09:40:58 INFO - PID 12892 | 09:41:00 INFO - PID 12892 | Cycle 1(1): loaded http://localhost:42320/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42320/tests/kraken/driver.html?testName=ai-astar) 09:41:00 INFO - PID 12892 | RSS: Main: 193155072 09:41:00 INFO - PID 12892 | 09:41:00 INFO - PID 12892 | __start_tp_report 09:41:00 INFO - PID 12892 | _x_x_mozilla_page_load 09:41:00 INFO - PID 12892 | _x_x_mozilla_page_load_details 09:41:00 INFO - PID 12892 | |i|pagename|runs| 09:41:00 INFO - PID 12892 | |0;ai-astar;103;110;111;110;109;112;111;111;112;112 09:41:00 INFO - PID 12892 | |1;audio-beat-detection;150;121;122;186;124;124;128;124;148;120 09:41:00 INFO - PID 12892 | |2;audio-dft;162;164;163;161;164;165;170;171;162;164 09:41:00 INFO - PID 12892 | |3;audio-fft;77;73;74;105;77;74;76;77;95;80 09:41:00 INFO - PID 12892 | |4;audio-oscillator;82;82;112;83;82;82;94;86;82;113 09:41:00 INFO - PID 12892 | |5;imaging-gaussian-blur;113;115;114;113;117;114;114;114;114;115 09:41:00 INFO - PID 12892 | |6;imaging-darkroom;151;155;151;151;152;151;150;150;152;150 09:41:00 INFO - PID 12892 | |7;imaging-desaturate;95;95;94;94;94;94;94;95;95;94 09:41:00 INFO - PID 12892 | |8;json-parse-financial;54;58;55;56;61;65;55;57;54;56 09:41:00 INFO - PID 12892 | |9;json-stringify-tinderbox;57;55;55;56;56;59;57;70;56;55 09:41:00 INFO - PID 12892 | |10;stanford-crypto-aes;89;88;88;86;86;87;87;89;110;89 09:41:00 INFO - PID 12892 | |11;stanford-crypto-ccm;129;134;131;131;140;127;138;140;136;135 09:41:00 INFO - PID 12892 | |12;stanford-crypto-pbkdf2;185;194;194;194;187;195;207;197;194;197 09:41:00 INFO - PID 12892 | |13;stanford-crypto-sha256-iterative;74;75;73;76;77;74;73;78;74;72 09:41:00 INFO - PID 12892 | __end_tp_report 09:41:00 INFO - PID 12892 | __start_cc_report 09:41:00 INFO - PID 12892 | _x_x_mozilla_cycle_collect,977 09:41:00 INFO - PID 12892 | __end_cc_report 09:41:00 INFO - PID 12892 | __startTimestamp1496767260626__endTimestamp 09:41:00 INFO - PID 12892 | 09:41:00 INFO - PID 12892 | ------- Summary: start ------- 09:41:00 INFO - PID 12892 | Number of tests: 14 09:41:00 INFO - PID 12892 | 09:41:00 INFO - PID 12892 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.69 (2.4%) stddev-sans-first:1.05 09:41:00 INFO - PID 12892 | Values: 103.0 110.0 111.0 110.0 109.0 112.0 111.0 111.0 112.0 112.0 09:41:00 INFO - PID 12892 | 09:41:00 INFO - PID 12892 | [#1] audio-beat-detection Cycles:10 Average:134.70 Median:126.00 stddev:21.07 (16.7%) stddev-sans-first:21.61 09:41:00 INFO - PID 12892 | Values: 150.0 121.0 122.0 186.0 124.0 124.0 128.0 124.0 148.0 120.0 09:41:00 INFO - PID 12892 | 09:41:00 INFO - PID 12892 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:3.34 (2.0%) stddev-sans-first:3.41 09:41:00 INFO - PID 12892 | Values: 162.0 164.0 163.0 161.0 164.0 165.0 170.0 171.0 162.0 164.0 09:41:00 INFO - PID 12892 | 09:41:00 INFO - PID 12892 | [#3] audio-fft Cycles:10 Average:80.80 Median:77.00 stddev:10.58 (13.7%) stddev-sans-first:11.13 09:41:00 INFO - PID 12892 | Values: 77.0 73.0 74.0 105.0 77.0 74.0 76.0 77.0 95.0 80.0 09:41:00 INFO - PID 12892 | 09:41:00 INFO - PID 12892 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:82.00 stddev:12.53 (15.3%) stddev-sans-first:12.97 09:41:00 INFO - PID 12892 | Values: 82.0 82.0 112.0 83.0 82.0 82.0 94.0 86.0 82.0 113.0 09:41:00 INFO - PID 12892 | 09:41:00 INFO - PID 12892 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:1.16 (1.0%) stddev-sans-first:1.13 09:41:00 INFO - PID 12892 | Values: 113.0 115.0 114.0 113.0 117.0 114.0 114.0 114.0 114.0 115.0 09:41:00 INFO - PID 12892 | 09:41:00 INFO - PID 12892 | [#6] imaging-darkroom Cycles:10 Average:151.30 Median:151.00 stddev:1.49 (1.0%) stddev-sans-first:1.58 09:41:00 INFO - PID 12892 | Values: 151.0 155.0 151.0 151.0 152.0 151.0 150.0 150.0 152.0 150.0 09:41:00 INFO - PID 12892 | 09:41:00 INFO - PID 12892 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:41:00 INFO - PID 12892 | Values: 95.0 95.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 94.0 09:41:00 INFO - PID 12892 | 09:41:00 INFO - PID 12892 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:56.50 stddev:3.48 (6.2%) stddev-sans-first:3.50 09:41:00 INFO - PID 12892 | Values: 54.0 58.0 55.0 56.0 61.0 65.0 55.0 57.0 54.0 56.0 09:41:00 INFO - PID 12892 | 09:41:00 INFO - PID 12892 | [#9] json-stringify-tinderbox Cycles:10 Average:57.60 Median:56.50 stddev:4.53 (8.0%) stddev-sans-first:4.80 09:41:00 INFO - PID 12892 | Values: 57.0 55.0 55.0 56.0 56.0 59.0 57.0 70.0 56.0 55.0 09:41:00 INFO - PID 12892 | 09:41:00 INFO - PID 12892 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:88.00 stddev:7.16 (8.1%) stddev-sans-first:7.58 09:41:00 INFO - PID 12892 | Values: 89.0 88.0 88.0 86.0 86.0 87.0 87.0 89.0 110.0 89.0 09:41:00 INFO - PID 12892 | 09:41:00 INFO - PID 12892 | [#11] stanford-crypto-ccm Cycles:10 Average:134.10 Median:135.50 stddev:4.53 (3.3%) stddev-sans-first:4.42 09:41:00 INFO - PID 12892 | Values: 129.0 134.0 131.0 131.0 140.0 127.0 138.0 140.0 136.0 135.0 09:41:00 INFO - PID 12892 | 09:41:00 INFO - PID 12892 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.40 Median:194.50 stddev:5.93 (3.0%) stddev-sans-first:5.22 09:41:00 INFO - PID 12892 | Values: 185.0 194.0 194.0 194.0 187.0 195.0 207.0 197.0 194.0 197.0 09:41:00 INFO - PID 12892 | 09:41:00 INFO - PID 12892 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.60 Median:74.50 stddev:1.90 (2.5%) stddev-sans-first:2.00 09:41:00 INFO - PID 12892 | Values: 74.0 75.0 73.0 76.0 77.0 74.0 73.0 78.0 74.0 72.0 09:41:00 INFO - PID 12892 | -------- Summary: end -------- 09:41:00 INFO - PID 12892 | 09:41:01 INFO - TEST-INFO | 12892: exit 0 09:41:01 INFO - TEST-OK | kraken | took 92184ms 09:41:01 INFO - SUITE-END | took 1235s 09:41:02 INFO - Completed test suite (00:20:36) 09:41:02 INFO - javascript benchmark 09:41:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7753.596230705409, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3074.292912630095, 3100.7674424418174, 3114.5172498262764, 3117.142785733922, 3117.7973431726937, 5911.231539899818, 5987.970060149699, 6012.969935150323, 6020.096985452179, 6027.87944241116, 5970.223870896777, 5980.760769569223, 5987.520998320135, 6053.455189032986, 6094.207752992105, 5403.324584426947, 5515.779368825252, 5530.5299049580635, 5551.0, 5560.304961879765, 5645.294338207724, 5647.3505546862025, 5649.378568357477, 5654.406287339832, 5668.603197776158, 5449.64577302474, 5511.889762204733, 5531.197976293455, 5548.44515548446, 5562.638428502155, 5539.806106786243, 5555.30558680165, 5556.277683901108, 5585.134304182858, 5622.0, 5553.888922221573, 5566.081596536566, 5567.582431317627, 5598.048331783566, 5600.439956004408, 6014.338422773491, 6025.548083893726, 6034.969825150846, 6041.879162416771, 6060.515158787286, 6288.434040936338, 6374.330695277022, 6381.840453988688, 6448.64532450715, 6531.183602049744, 6564.376384243537, 6587.275399706076, 6588.736450541973, 6598.0, 6602.867942641168, 6019.578629495981, 6094.146819445281, 6096.96951515244, 6098.756049758049, 6101.450869421773, 6473.546851720429, 6554.279029306773, 6607.867842643216, 6728.697208625624, 6742.865142697118, 6379.872402552016, 6404.0, 6416.165898433267, 6440.227172739301, 6443.097966284724, 6500.967495162588, 6509.9023514647315, 6522.641254731036, 6538.084668146464, 6549.901751473732, 6256.906146407808, 6342.778002769881, 6474.870502589922, 6511.576747511396, 6513.902291465632, 6319.58922670025, 6389.904151437732, 6463.935360646427, 6479.773207937794, 6490.928996715584, 5279.1817268323475, 5285.762140703678, 5289.523942845162, 5300.575953923677, 5316.627836051517, 4509.053098849213, 4512.323151527297, 4520.683552151318, 4529.184746745552, 4572.839950601713, 5534.335879694462, 5585.636933599303, 5589.8602534936135, 5702.6293290935955, 5719.685417302088, 6568.80293591193, 6612.702428390734, 6615.86768264632, 6616.66916654175, 6635.469162466991, 5693.03218452864, 5703.17303990919, 5712.343080545707, 5713.200151978726, 5746.0519014363, 5612.242347283146, 5627.0, 5709.172170035322, 5776.33572139201, 5811.476967072984, 6346.143270658402, 6366.586171898812, 6372.776952806629, 6376.043593460925, 6383.680815959091, 6281.497480201481, 6489.8702025960165, 6569.9343006569325, 6577.671116444254, 6589.769358072444, 6198.659073750987, 6230.43926046658, 6282.937170628235, 6299.433051025429, 6320.241571011508, 6114.054067497291, 6188.9690551546955, 6430.935690643034, 6452.645104519296, 6469.7412103515335, 6338.778142764981, 6430.099786030053, 6437.356264373525, 6447.871042579029, 6468.482521398371, 6279.120923070683, 6350.523710721622, 6366.3633636637815, 6374.07575901501, 6376.52176086786, 6143.051335358963, 6349.730053989313, 6367.885620016571, 6373.330800265905, 6377.915754321869, 6139.492138333381, 6157.199564056644, 6199.535034872312, 6262.029385445263, 6270.968645156745, 6414.871702566016, 6434.935650643433, 6436.420722135031, 6439.45264652491, 6445.774397896051, 6151.853328019096, 6246.812595622138, 6258.530610204162, 6258.780942666985, 6262.246570960138], "value": 5930.646574896157, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.2218725963221, 776.9261920117589, 786.4416264452238, 1148.580768019673, 1154.1516985016005, 36087.458688119696, 36715.816420917894, 36755.63244367555, 36785.44821827672, 36797.44803827945, 38666.0, 39036.804815975884, 39064.60935390645, 39110.608893911056, 39157.60842391575, 7196.532225405332, 7336.96331518343, 7368.263173682642, 7496.400287976949, 7498.4001279897475, 7325.560466372035, 7424.071991001125, 7428.331450169484, 7435.405167586607, 7440.66517006736, 7381.667824947864, 7386.519876208056, 7450.850982980364, 7466.290702383265, 7469.991551140608, 7380.557166570023, 7408.407327413794, 7424.183339832641, 7428.962855185717, 7432.108147022338, 7298.635068246566, 7354.705811767523, 7358.374538164262, 7369.299916507923, 7376.889346659805, 36440.81779591085, 36499.452508212395, 36647.81676091629, 36669.816650916575, 36768.63231367679, 3544.4151714967, 3578.946315805265, 3580.5524309461316, 3582.8208589570677, 3597.244578638489, 28275.71724282772, 28277.858610706815, 28373.290667733265, 28517.144485665463, 28594.0, 3577.2130131371055, 3591.928161436783, 3629.237860049393, 3648.504113313555, 3656.597774244831, 138768.30615846958, 138860.0, 151341.2432937828, 158158.0, 159282.0, 43015.92460188458, 43224.0, 43243.567564324585, 43378.7831060849, 43505.782471088074, 44808.77595612001, 44876.77561612171, 44925.0, 44986.0, 45126.32310515279, 15034.173120478259, 15132.773008404884, 15155.924220378827, 15164.772528412082, 15175.0, 12419.44112514939, 12424.75150497003, 12430.016795968902, 12434.12961092733, 12452.252864828139, 13439.865601344058, 13516.0, 13535.120217186048, 13569.932150339382, 13778.448862045607, 5522.751476183581, 5567.860803479945, 5591.133374326986, 5675.971620141955, 5725.914111288334, 959.7792507723124, 999.9850002249972, 1007.6825799873017, 1010.8635334229932, 1015.7054454208197, 21658.35024949254, 22309.55380892373, 22730.43173920665, 23073.423164421023, 23092.4226894329, 1072.5924148823553, 1076.4617691154422, 1082.6697857153486, 1084.7410441751051, 1092.3937214845678, 11346.262492937933, 11823.98992171333, 11899.464524096436, 12307.876921230853, 12926.806097908539, 196945.0, 197834.0, 198026.0, 198232.0, 198363.0, 49059.26411103836, 49372.50627493751, 49537.0, 49639.50360496421, 49765.751171243915, 1411.5200831717266, 1455.6360909772557, 1460.2114857976574, 1470.7720303353212, 1474.808274924253, 21678.89160554187, 22440.0, 23511.0, 23812.761872381747, 24015.279541613778, 35822.8208858954, 35876.0, 35939.28121437609, 35978.4603230957, 36054.0, 165237.0, 166733.0, 167226.0, 169194.0, 169252.0, 31520.684793151773, 32325.0, 32693.673063269063, 32971.50542741813, 33114.33771324512, 39245.41131883081, 39389.6061039386, 40340.3948940772, 40407.0, 41751.373729393476, 29789.5531567031, 30350.544741829333, 30583.006381702475, 30760.0, 30910.22724431907, 29143.708562914948, 30192.54711179378, 30216.934919524494, 31490.37019259556, 31697.5245371315, 33002.339953201285, 33651.326973460884, 33897.322053559285, 34139.0, 34394.31211375808, 28715.712842871304, 28877.566836497048, 29386.559201611566, 30145.246368840955, 31107.68892311048, 21478.67781983303, 24291.271261862174, 24368.951782906206, 24435.51128977375, 24630.0], "value": 16097.262166054528, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.4768386137482, 426.1987463568491, 431.357277656292, 439.21380728495984, 450.2031404414185, 19929.900350498265, 20607.484812879666, 20663.483412914666, 21745.782542174613, 22333.776662233373, 23879.5224095518, 24389.63415548768, 24482.755172448316, 24483.510329793393, 24501.0, 6642.667866606675, 6779.525433219676, 6780.118584583997, 6786.0, 6805.353491418307, 6310.9684451577905, 6656.202825237183, 6656.567323124005, 6690.130283063195, 6702.095217145696, 6591.307912669173, 6636.402723754861, 6641.7048675508295, 6646.1027761252335, 6662.533622646417, 6656.667166641649, 6663.700133494004, 6664.700088496029, 6673.93326066738, 6677.465802735769, 6483.189601299838, 6490.05894145351, 6495.415412612888, 6502.349765023507, 6534.215894092692, 27212.59181112285, 27574.621268936473, 27818.860905695543, 27858.3035424114, 27916.0, 1928.9807101929082, 1963.4207908666976, 1971.1918113573508, 1976.940691779249, 1982.2170242754032, 17751.0, 18373.08134593265, 18413.63172736551, 18420.0, 18456.53858653531, 2303.1593468384085, 2321.558903808271, 2406.7111946566347, 2410.6745589345564, 2413.070967677439, 109538.0, 114507.42746286298, 121040.39479802633, 121247.0, 121583.0, 19420.611587768166, 20213.898930505253, 20501.872397018007, 21069.0, 21107.577848442947, 38313.616863831565, 39476.21047579032, 39725.04124381366, 39761.602383976366, 39901.80049099794, 10403.791924161475, 10419.739506512245, 10579.418132002813, 10619.469026548642, 10663.306885052447, 8496.575171241413, 8568.944322849424, 8603.354748393895, 8615.827683446296, 8704.086070962585, 10475.685729428129, 10765.246432749633, 10842.186835987333, 11034.668959931216, 11193.552257909592, 3806.0711378764568, 4075.291484748864, 4146.315857883415, 4194.706370554093, 4206.305959516645, 929.920956718673, 943.5329511891657, 1018.2871989607305, 1021.2136654775929, 1026.4559783314855, 18400.35598754064, 18581.90709046446, 18664.253429862652, 19497.317593884145, 20376.592468150553, 903.7198468474794, 941.8257622339889, 968.4092703450889, 990.0643891522442, 992.7964767222702, 9180.281985795764, 9604.471754053595, 9785.657501987396, 9807.656732014346, 9908.25688073383, 424389.0, 428474.0, 428791.0, 429885.0, 430958.0, 92922.53538732398, 93618.53190734003, 95174.0, 95531.52234238923, 95795.52102239445, 1161.8896204860525, 1204.4519743516503, 1215.0583297944163, 1229.489761748864, 1240.8573014103313, 17613.471595852145, 17980.64038719192, 18244.635107298047, 18265.0, 18575.349862754738, 45929.0, 46155.30767038564, 46906.296405554625, 46949.0, 46983.76508117574, 60471.0, 60751.65865877419, 65957.67021164864, 68170.0, 68563.31436685569, 10332.380057196593, 10667.0, 10788.784224315626, 10794.73013174677, 10837.67486975392, 17419.041952692725, 17504.649907002044, 18300.176492057624, 18452.81547184511, 18701.0, 13625.386857591235, 13826.930865345608, 14214.644633884236, 14239.216843073731, 14478.131312121306, 13254.867451325363, 13585.93207033998, 13793.586192414243, 13900.304984750925, 14484.637884052983, 13513.189208647513, 13692.0, 13896.096753710977, 13928.721425571635, 13947.37236824325, 9723.36798108149, 9818.901810981799, 9920.156786673213, 9949.0, 9974.60101595928, 12374.762523747553, 12591.0, 12645.241285522898, 12677.746445071232, 12690.365481726061], "value": 11285.981139695614, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1207.7101495641045, 1211.9151659383836, 1221.7678641058199, 1227.7851376009191, 1231.9507219711209, 10719.464026798658, 11227.887721122786, 11228.438578071105, 11248.0, 11586.884131158686, 11225.66323010309, 11355.318680879152, 11418.54325826966, 11434.942825285883, 11449.141314401411, 2288.7367952685445, 2321.6517522371696, 2329.429289823987, 2334.533093381322, 2338.684277622525, 2258.2209137847417, 2290.7365652949875, 2293.816494680422, 2300.7929286364224, 2308.4690521180055, 2225.187806450642, 2253.3690566641285, 2256.8533045352083, 2259.29961711869, 2264.5923733727923, 2171.2292136291703, 2186.5517568898417, 2195.5828392605436, 2204.470926977514, 2207.4371035386034, 1886.1135266424758, 1936.6126774645127, 2167.5773224221284, 2218.3788539208886, 2219.755826859044, 10759.0, 10913.454327283684, 10922.344659320386, 10927.726806829813, 10949.726256843564, 5926.822195334147, 6158.692065396713, 6160.476359509447, 6165.445109940127, 6166.660833654148, 3511.9824400877833, 3640.2537479816574, 3697.334479793636, 3719.256148770257, 3729.4522773049152, 1182.8048372018607, 1206.8370769946032, 1215.3740823475916, 1226.4971361741732, 1242.7017515796235, 15533.533993980198, 15583.844161558465, 15595.0, 15691.136987465685, 15710.214489275491, 5093.312402825572, 5113.284140220372, 5153.561947234527, 5176.8964620707375, 5253.632245742761, 11968.162228644085, 12110.333931633668, 12160.756784864254, 12220.083493738006, 12234.0, 6124.173236613, 6271.216097987752, 6278.968605156945, 6281.685915704196, 6287.434130928238, 5805.158252053428, 5821.505172060338, 5829.067349224104, 5848.356680765112, 5873.3245676746865, 3876.205377897524, 3974.8012599370495, 3987.182627561343, 4038.838446462167, 4045.959540404617, 1158.9072874170047, 1161.0769438296406, 1164.7379339648512, 1171.5255321594768, 1177.4466000979526, 787.6534324897142, 818.6970820796224, 827.185222555782, 833.9416240863081, 836.4813815434348, 6274.717637706314, 6520.836979075466, 6583.374579415044, 6652.800415987528, 6760.222574403908, 967.777411195429, 970.9854352184723, 975.7511834482161, 975.853621956698, 989.5893204320271, 4160.625543701081, 4240.872773816791, 4271.893202669959, 4312.719673221231, 4345.174416860849, 13634.522791702242, 13640.727185456433, 14417.495387661591, 14418.639534011734, 14425.78361324581, 13852.238126902916, 14097.295135243401, 14147.29263536819, 14212.573622791333, 14261.500847470288, 8668.575912514647, 8910.910890891008, 8920.0, 8920.286377089817, 8920.821583568293, 6081.695915204134, 6354.665071770261, 6654.434373078343, 6711.664416779239, 6945.0, 12623.368831558202, 12712.237265764084, 12883.80674289905, 12977.286249256382, 12980.610581682564, 13076.411561479947, 13079.149855259378, 13268.668283292609, 13390.598282051555, 13431.26128062927, 8822.161894620001, 8950.418222815497, 8956.641734330815, 9110.453372797389, 9256.305777066613, 9913.553890075109, 10108.545115469675, 10118.241131915283, 10129.848052279074, 10144.644937427154, 8391.370647201606, 8566.828663426571, 8645.438046526955, 8716.43343182691, 8722.258608018135, 8311.709090181814, 8348.833023339377, 8373.706920258006, 8557.61490732906, 8705.782355441164, 7319.59742214162, 7384.593847338448, 7403.074615673041, 7407.62961851916, 7442.702291908479, 4921.803127874845, 5518.365387980433, 5720.17057526648, 5795.3625101237985, 6070.332263451105, 5829.242198514166, 6012.128241405059, 6014.548908831943, 6070.696465176812, 6114.908276375769], "value": 5103.940926450583, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.8650658776016, 405.36762650265587, 411.1899557870995, 411.99382009269846, 414.8278464437259, 6301.779437719681, 6342.936570634292, 6365.29981702013, 6379.468927457412, 6398.648074355914, 5919.556033297509, 6116.908246376308, 6146.81559553213, 6156.015037593986, 6167.198264225655, 4771.904561908777, 4795.640326975482, 4796.52034796521, 4823.710577365352, 4824.0, 4811.326414302001, 4826.107170173529, 4836.443808961979, 4841.782119804618, 4885.656444477761, 4708.529147085298, 4754.334393184957, 4769.403824521934, 4787.0, 4811.566958973692, 4741.336212930175, 4763.4998325175875, 4793.281007848851, 4807.831725889577, 4820.156472617313, 4215.072684009513, 4221.873343799691, 4228.154369126187, 4231.767252801094, 4243.702940794145, 6117.296510901258, 6124.142620033199, 6135.907961380538, 6151.323354431009, 6153.2000839890525, 5510.724463776795, 5513.255710479114, 5519.420460851633, 5528.170774383834, 5530.806421775259, 6500.4474619657385, 6504.219493660791, 6554.836129096763, 6579.671016449159, 6592.30780768022, 4585.4726706428855, 4596.678232523725, 4597.586217240431, 4602.677812553123, 4604.631629469668, 6406.967965160145, 6873.621950792754, 6898.482613803984, 6950.409215216712, 6982.546134501241, 4608.470025946992, 4667.439907211156, 4667.8366257181515, 4679.204535229019, 4691.7888695008805, 4697.694649847817, 4714.269288260325, 4715.882102947385, 4724.574788269072, 4728.267118596623, 5271.757868910592, 5393.568514518829, 5404.567634589223, 5433.456654334614, 5450.700211488406, 6539.384246301517, 6541.934580654132, 6564.343565643493, 6598.670066496656, 6630.701618427182, 1628.23472967705, 1635.2069246415479, 1637.6970260501846, 1642.991785041067, 1652.7603497492796, 1057.8945002472435, 1092.6448904106198, 1113.6547670222258, 1114.8773634900153, 1120.3725913488472, 5872.677002764889, 5904.498117660047, 5908.940910590839, 5920.585559010828, 5921.615095018896, 6735.629540375228, 6742.292059333798, 6803.353681400259, 6822.795316140524, 6838.350356716104, 5796.391378905154, 5835.620684655484, 5854.560907931922, 5859.472647461749, 5861.6002718423215, 3582.5880023797595, 3615.692666123409, 3633.255182687543, 3641.435577485494, 3649.2701459708164, 6591.373819487141, 6601.636909969998, 6620.635865027373, 6622.966885165543, 6631.706817170605, 6960.617166055814, 6974.58152510851, 6980.511364204457, 6987.1266091738535, 7008.474364422688, 6540.182477190351, 6599.70301336441, 6605.372489613479, 6641.800745977628, 6653.733850646016, 6754.358335958076, 6770.695318710768, 6845.589264644137, 6868.557602903446, 6871.106756121872, 6756.256811750605, 6773.796786096425, 6775.0, 6780.1524809398825, 6804.96597517029, 6034.09488576717, 6372.58578192416, 6513.381228783258, 6582.934170658232, 6589.5173585942775, 4652.953470465252, 4657.673962822705, 4658.627309815139, 4660.207764679944, 4671.11248862715, 6778.593284402951, 6840.41856442208, 6848.828779280558, 6864.38220560152, 6875.759348422981, 6321.431071203614, 6560.967195163994, 6569.638669873012, 6580.762540736173, 6626.701798418986, 6527.3472652736245, 6561.639109849004, 6573.638449885302, 6573.638449885302, 6648.301928297459, 6522.315156908646, 6552.803415897531, 6553.541252112306, 6557.180352455943, 6571.835704107436, 6644.767433139817, 6653.866922661617, 6654.367835055662, 6663.0, 6675.899861501985, 6440.13058237132, 6441.774537891151, 6444.355564443518, 6460.903086453801, 6494.9025764612625], "value": 4952.384053094617, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [813.8250276190618, 845.9788505287363, 849.7535714642754, 851.506126446661, 867.9956600216996, 16934.3226270949, 17230.913845430772, 17265.65468690627, 18825.905870470662, 20141.0, 18871.905640471814, 19008.334708285212, 19151.90424047878, 19161.041947902584, 19190.808091919076, 968.7432830299958, 991.8264303746815, 992.5632721602472, 993.92545559083, 996.8853581838109, 976.6288810252095, 989.2284018465608, 993.6174572789492, 995.2983146881431, 1015.0154350280253, 1059.8145324568209, 1061.2783307350999, 1061.8778840433372, 1062.2511129653576, 1062.6811956413046, 1053.7523681934777, 1054.2672842374552, 1055.0504545908666, 1056.9154467642647, 1058.9046985771279, 764.5947647746704, 767.9308862202373, 770.7803276066294, 774.1561697749423, 775.464929198851, 16907.239174237187, 17137.400190993256, 17333.2200050998, 17368.131593420403, 17914.372996945174, 18671.15979780913, 18761.0619469026, 18944.14751336193, 19137.80862191374, 19155.808441915542, 15093.773593396108, 15197.164155971417, 15229.390824367012, 15240.542783716506, 15273.0, 3482.721382289411, 3520.612732599412, 3542.1498840278405, 3543.8228088595465, 3777.943330850012, 84452.0, 84646.99999999939, 85940.0, 85979.0, 86953.0, 14215.50245741394, 15208.0, 15311.846881531264, 15332.386704531917, 15332.390099039663, 26463.603045954325, 27128.32179195536, 27486.862565687443, 27930.301742456602, 27939.58090628642, 7779.805504862311, 8123.0, 8156.265936065783, 8190.221928916743, 8196.795080123045, 3677.8712745053795, 3742.1767211214033, 3744.475773391727, 3751.756135851161, 3751.9062023449633, 4176.83292668296, 4235.576442355801, 4262.914741705211, 4275.87172384829, 4291.978540107342, 850.5959669157224, 873.921347078766, 879.366855863777, 879.9164079412445, 881.3037700216885, 575.3010092737344, 587.917691523187, 596.2308621877816, 606.7481994972037, 622.9034499652561, 9701.70894873155, 9873.0, 10437.947810260901, 10732.087772539422, 10792.838107428395, 572.940060887355, 613.2739970829708, 616.2266355723539, 623.7692053940071, 630.8359826445065, 4366.19225443294, 4390.868273951786, 4405.9559404405545, 4581.518940511265, 4729.952700472952, 91059.54470227606, 91918.0, 93234.53382733042, 93387.06612933784, 97612.51193744128, 84545.57727211325, 84598.77006149791, 85600.0, 86165.56917215374, 86457.0, 73857.89213161806, 74056.62971685106, 74084.25915740774, 74150.25849741434, 74450.627746862, 8668.219860212612, 8841.336899732418, 9159.862602061108, 9389.154976052188, 9456.621735130519, 30980.84509577528, 31438.371232574762, 31548.36903261876, 31670.841645792545, 31970.36059278755, 56225.0, 56505.15242271287, 56977.0, 57538.7123064382, 57886.0, 16394.5081647546, 16693.248803803614, 16801.663966720353, 16902.830971690124, 17116.828831711522, 15132.621684457976, 17667.823321766617, 17982.460526184237, 18418.907905460925, 18508.629827403107, 14960.92519537439, 15009.399624014917, 15087.170205638795, 15158.545243642708, 15407.768883466533, 14828.851711482746, 15241.628253457242, 15322.080675159526, 15616.687666246838, 15618.765718514003, 14004.859951400356, 14257.786133207803, 14305.785413219019, 14521.636959075686, 14614.0, 8974.551272436222, 9007.729768106705, 9174.082591740773, 9438.905610943802, 9453.149216570266, 10555.52500137511, 11046.392448415414, 11090.011393847231, 11780.52877884875, 11786.41067946582], "value": 7977.66726740144, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 111.0, 110.0, 109.0, 112.0, 111.0, 111.0, 112.0, 112.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 121.0, 122.0, 186.0, 124.0, 124.0, 128.0, 124.0, 148.0, 120.0], "value": 134.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 163.0, 161.0, 164.0, 165.0, 170.0, 171.0, 162.0, 164.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 74.0, 105.0, 77.0, 74.0, 76.0, 77.0, 95.0, 80.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 112.0, 83.0, 82.0, 82.0, 94.0, 86.0, 82.0, 113.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 113.0, 117.0, 114.0, 114.0, 114.0, 114.0, 115.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 155.0, 151.0, 151.0, 152.0, 151.0, 150.0, 150.0, 152.0, 150.0], "value": 151.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 58.0, 55.0, 56.0, 61.0, 65.0, 55.0, 57.0, 54.0, 56.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 56.0, 56.0, 59.0, 57.0, 70.0, 56.0, 55.0], "value": 57.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 88.0, 86.0, 86.0, 87.0, 87.0, 89.0, 110.0, 89.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 134.0, 131.0, 131.0, 140.0, 127.0, 138.0, 140.0, 136.0, 135.0], "value": 134.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 194.0, 194.0, 194.0, 187.0, 195.0, 207.0, 197.0, 194.0, 197.0], "value": 194.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 73.0, 76.0, 77.0, 74.0, 73.0, 78.0, 74.0, 72.0], "value": 74.6, "unit": "score"}]}]} 09:41:02 INFO - Return code: 0 09:41:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:41:02 INFO - # TBPL SUCCESS # 09:41:02 INFO - Running post-action listener: _resource_record_post_action 09:41:02 INFO - [mozharness: 2017-06-06 16:41:02.490213Z] Finished run-tests step (success) 09:41:02 INFO - Running post-run listener: _resource_record_post_run 09:41:02 INFO - Total resource usage - Wall time: 1254s; CPU: 13.0%; Read bytes: 4096; Write bytes: 433537024; Read time: 12; Write time: 306568 09:41:02 INFO - TinderboxPrint: CPU usage
12.7% 09:41:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:41:02 INFO - TinderboxPrint: I/O write bytes / time
433,537,024 / 306,568 09:41:02 INFO - TinderboxPrint: CPU idle
8,737.7 (87.3%) 09:41:02 INFO - TinderboxPrint: CPU user
1,215.1 (12.1%) 09:41:02 INFO - TinderboxPrint: Swap in / out
0 / 0 09:41:02 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105402368; Read time: 0; Write time: 71524 09:41:02 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:41:02 INFO - run-tests - Wall time: 1236s; CPU: 13.0%; Read bytes: 4096; Write bytes: 327733248; Read time: 12; Write time: 235024 09:41:03 INFO - Running post-run listener: _upload_blobber_files 09:41:03 INFO - Blob upload gear active. 09:41:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:41:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:41:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:41:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:41:03 INFO - (blobuploader) - INFO - Open directory for files ... 09:41:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:41:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:41:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:07 INFO - (blobuploader) - INFO - Done attempting. 09:41:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:41:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:41:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:08 INFO - (blobuploader) - INFO - Done attempting. 09:41:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:41:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:41:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:09 INFO - (blobuploader) - INFO - Done attempting. 09:41:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:41:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:41:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:09 INFO - (blobuploader) - INFO - Done attempting. 09:41:09 INFO - (blobuploader) - INFO - Iteration through files over. 09:41:09 INFO - Return code: 0 09:41:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:41:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:41:09 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa43efdefd740d85582934592c5095322e7bb7750debdde17c4c29f05dede803490da015647ca02a3702d37bdba440220ea10a26ff6a0ce0233cdb72010c1b76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58d8e1e94737f703cbe67bc625b2b7c3fc6ec878a513ea99aa4262cf8177ee2743301471d3fc78186b24639ebe0fa3b0f22d5476a1d5722b9e6b91a9c6f28c39", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d50c2f21ec9251757e8d4824e3fad7e7eba9f7aee8bf35cc8cc2c84c24540d6b1988bf23449c4201038c4bf1715a70e22d47fc86ce3c914244ef59ca5d11e55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec5826c6c727b75a1cc26a50c736f4afecaf8a93508c349ae36d58bde72cde919eba9950714a68fd9585fa1bb98312668130b2816d44936e46d66c06ed5fab43"} 09:41:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:41:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:41:09 INFO - Contents: 09:41:09 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa43efdefd740d85582934592c5095322e7bb7750debdde17c4c29f05dede803490da015647ca02a3702d37bdba440220ea10a26ff6a0ce0233cdb72010c1b76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58d8e1e94737f703cbe67bc625b2b7c3fc6ec878a513ea99aa4262cf8177ee2743301471d3fc78186b24639ebe0fa3b0f22d5476a1d5722b9e6b91a9c6f28c39", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d50c2f21ec9251757e8d4824e3fad7e7eba9f7aee8bf35cc8cc2c84c24540d6b1988bf23449c4201038c4bf1715a70e22d47fc86ce3c914244ef59ca5d11e55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec5826c6c727b75a1cc26a50c736f4afecaf8a93508c349ae36d58bde72cde919eba9950714a68fd9585fa1bb98312668130b2816d44936e46d66c06ed5fab43"} 09:41:09 INFO - Running post-run listener: copy_logs_to_upload_dir 09:41:09 INFO - Copying logs to upload dir... 09:41:09 INFO - mkdir: /builds/slave/test/build/upload/logs 09:41:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1319.994890 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2017-06-06 09:41:09.551269) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-06 09:41:09.554659) ========= 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=8887e36bb8e381bfd44124ac000001a8-1496765856.808188-1575682196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa43efdefd740d85582934592c5095322e7bb7750debdde17c4c29f05dede803490da015647ca02a3702d37bdba440220ea10a26ff6a0ce0233cdb72010c1b76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58d8e1e94737f703cbe67bc625b2b7c3fc6ec878a513ea99aa4262cf8177ee2743301471d3fc78186b24639ebe0fa3b0f22d5476a1d5722b9e6b91a9c6f28c39", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d50c2f21ec9251757e8d4824e3fad7e7eba9f7aee8bf35cc8cc2c84c24540d6b1988bf23449c4201038c4bf1715a70e22d47fc86ce3c914244ef59ca5d11e55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec5826c6c727b75a1cc26a50c736f4afecaf8a93508c349ae36d58bde72cde919eba9950714a68fd9585fa1bb98312668130b2816d44936e46d66c06ed5fab43"} build_url:https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011144 build_url: 'https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa43efdefd740d85582934592c5095322e7bb7750debdde17c4c29f05dede803490da015647ca02a3702d37bdba440220ea10a26ff6a0ce0233cdb72010c1b76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58d8e1e94737f703cbe67bc625b2b7c3fc6ec878a513ea99aa4262cf8177ee2743301471d3fc78186b24639ebe0fa3b0f22d5476a1d5722b9e6b91a9c6f28c39", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d50c2f21ec9251757e8d4824e3fad7e7eba9f7aee8bf35cc8cc2c84c24540d6b1988bf23449c4201038c4bf1715a70e22d47fc86ce3c914244ef59ca5d11e55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec5826c6c727b75a1cc26a50c736f4afecaf8a93508c349ae36d58bde72cde919eba9950714a68fd9585fa1bb98312668130b2816d44936e46d66c06ed5fab43"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-06 09:41:09.582400) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 09:41:09.582978) ========= 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=8887e36bb8e381bfd44124ac000001a8-1496765856.808188-1575682196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 09:41:09.664454) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-06 09:41:09.664798) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-06 09:41:09.665130) ========= ========= Total master_lag: 0.21 =========