builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-045 starttime: 1498321793.98 results: success (0) revision: c01aa84ded7eb0b3e691f8bcc5cd887c960a779e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-24 09:29:53.976630) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-24 09:29:53.977052) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-24 09:29:53.977335) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-24 09:29:54.021347) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-24 09:29:54.021614) ========= 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=4300f881736b422476174874000001bc-1498300844.368157-1155967031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-24 09:29:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2017-06-24 09:29:55 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109207 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-24 09:29:54.171796) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-24 09:29:54.172235) ========= 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=4300f881736b422476174874000001bc-1498300844.368157-1155967031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022729 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-24 09:29:54.235703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-24 09:29:54.240107) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c01aa84ded7eb0b3e691f8bcc5cd887c960a779e --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 c01aa84ded7eb0b3e691f8bcc5cd887c960a779e --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=4300f881736b422476174874000001bc-1498300844.368157-1155967031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-24 09:29:55,357 truncating revision to first 12 chars 2017-06-24 09:29:55,357 Setting DEBUG logging. 2017-06-24 09:29:55,357 attempt 1/10 2017-06-24 09:29:55,357 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c01aa84ded7e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-24 09:29:55,844 unpacking tar archive at: mozilla-central-c01aa84ded7e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.800788 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-24 09:29:55.057875) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-24 09:29:55.058185) ========= script_repo_revision: c01aa84ded7eb0b3e691f8bcc5cd887c960a779e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-24 09:29:55.058562) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-24 09:29:55.062873) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-24 09:29:55.073892) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-06-24 09:29:55.074218) ========= /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=4300f881736b422476174874000001bc-1498300844.368157-1155967031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:29:56 INFO - MultiFileLogger online at 20170624 09:29:56 in /builds/slave/test 09:29:56 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:29:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:29:56 INFO - {'append_to_log': False, 09:29:56 INFO - 'base_work_dir': '/builds/slave/test', 09:29:56 INFO - 'blob_upload_branch': 'Firefox', 09:29:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:29:56 INFO - 'branch': 'Firefox', 09:29:56 INFO - 'buildbot_json_path': 'buildprops.json', 09:29:56 INFO - 'config_files': ('talos/linux_config.py',), 09:29:56 INFO - 'default_actions': ('clobber', 09:29:56 INFO - 'read-buildbot-config', 09:29:56 INFO - 'download-and-extract', 09:29:56 INFO - 'populate-webroot', 09:29:56 INFO - 'create-virtualenv', 09:29:56 INFO - 'install', 09:29:56 INFO - 'setup-mitmproxy', 09:29:56 INFO - 'run-tests'), 09:29:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:29:56 INFO - 'download_minidump_stackwalk': True, 09:29:56 INFO - 'download_symbols': 'ondemand', 09:29:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:29:56 INFO - 'tooltool.py': '/tools/tooltool.py', 09:29:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:29:56 INFO - '/tools/misc-python/virtualenv.py')}, 09:29:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:29:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:29:56 INFO - 'gecko_profile': False, 09:29:56 INFO - 'gecko_profile_interval': 0, 09:29:56 INFO - 'installer_path': 'installer.exe', 09:29:56 INFO - 'log_level': 'info', 09:29:56 INFO - 'log_name': 'talos', 09:29:56 INFO - 'log_to_console': True, 09:29:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:29:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:29:56 INFO - 'opt_config_files': (), 09:29:56 INFO - 'pip_index': False, 09:29:56 INFO - 'suite': 'dromaeojs-e10s', 09:29:56 INFO - 'system_bits': '32', 09:29:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:29:56 INFO - 'title': 'talos-linux64-ix-045', 09:29:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:29:56 INFO - 'use_talos_json': True, 09:29:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:29:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:29:56 INFO - 'work_dir': 'build'} 09:29:56 INFO - [mozharness: 2017-06-24 16:29:56.294374Z] Running clobber step. 09:29:56 INFO - Running pre-action listener: _resource_record_pre_action 09:29:56 INFO - Running main action method: clobber 09:29:56 INFO - rmtree: /builds/slave/test/build 09:29:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:29:57 INFO - Running post-action listener: _resource_record_post_action 09:29:57 INFO - [mozharness: 2017-06-24 16:29:57.832054Z] Finished clobber step (success) 09:29:57 INFO - [mozharness: 2017-06-24 16:29:57.832153Z] Running read-buildbot-config step. 09:29:57 INFO - Running pre-action listener: _resource_record_pre_action 09:29:57 INFO - Running main action method: read_buildbot_config 09:29:57 INFO - Using buildbot properties: 09:29:57 INFO - { 09:29:57 INFO - "project": "", 09:29:57 INFO - "product": "firefox", 09:29:57 INFO - "who": "ffxbld@noreply.mozilla.org", 09:29:57 INFO - "installer_path": "public/build/target.tar.bz2", 09:29:57 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 09:29:57 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:29:57 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 09:29:57 INFO - "stage_platform": "linux64-stylosequential", 09:29:57 INFO - "basedir": "/builds/slave/test", 09:29:57 INFO - "buildnumber": 83, 09:29:57 INFO - "platform": "ubuntu64_hw_styloseq", 09:29:57 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:29:57 INFO - "slavebuilddir": "test", 09:29:57 INFO - "taskId": "WLpyZxseQd-BcgtibzYlXQ", 09:29:57 INFO - "branch": "mozilla-central", 09:29:57 INFO - "script_repo_revision": "production", 09:29:57 INFO - "revision": "c01aa84ded7eb0b3e691f8bcc5cd887c960a779e", 09:29:57 INFO - "slavename": "talos-linux64-ix-045", 09:29:57 INFO - "repo_path": "mozilla-central" 09:29:57 INFO - } 09:29:57 INFO - Finding installer, test and symbols from parent task. 09:29:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WLpyZxseQd-BcgtibzYlXQ'}, attempt #1 09:29:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WLpyZxseQd-BcgtibzYlXQ'}, attempt #1 09:29:58 INFO - Task dependencies: Yq6gCsErSKaHBZsfIUVQ6w 09:29:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yq6gCsErSKaHBZsfIUVQ6w'}, attempt #1 09:29:59 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Yq6gCsErSKaHBZsfIUVQ6w/artifacts/public/build/target.tar.bz2 09:29:59 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Yq6gCsErSKaHBZsfIUVQ6w/artifacts/public/build/test_packages.json 09:29:59 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Yq6gCsErSKaHBZsfIUVQ6w/artifacts/public/build/target.crashreporter-symbols.zip 09:29:59 INFO - Running post-action listener: _resource_record_post_action 09:29:59 INFO - [mozharness: 2017-06-24 16:29:59.180406Z] Finished read-buildbot-config step (success) 09:29:59 INFO - [mozharness: 2017-06-24 16:29:59.180626Z] Running download-and-extract step. 09:29:59 INFO - Running pre-action listener: _resource_record_pre_action 09:29:59 INFO - Running main action method: download_and_extract 09:29:59 INFO - mkdir: /builds/slave/test/build/tests 09:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:59 INFO - trying https://queue.taskcluster.net/v1/task/Yq6gCsErSKaHBZsfIUVQ6w/artifacts/public/build/target.test_packages.json 09:29:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Yq6gCsErSKaHBZsfIUVQ6w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:29:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yq6gCsErSKaHBZsfIUVQ6w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:29:59 INFO - Downloaded 989 bytes. 09:29:59 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:29:59 INFO - Using the following test package requirements: 09:29:59 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:29:59 INFO - u'common': [u'target.common.tests.zip'], 09:29:59 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:29:59 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:29:59 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:29:59 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:29:59 INFO - u'mozbase': [u'target.common.tests.zip'], 09:29:59 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:29:59 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:29:59 INFO - u'web-platform': [u'target.common.tests.zip', 09:29:59 INFO - u'target.web-platform.tests.tar.gz'], 09:29:59 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:29:59 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:29:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Yq6gCsErSKaHBZsfIUVQ6w/artifacts/public/build/target.common.tests.zip 09:29:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Yq6gCsErSKaHBZsfIUVQ6w/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:29:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Yq6gCsErSKaHBZsfIUVQ6w/artifacts/public/build/target.common.tests.zip into memory 09:30:00 INFO - Content-Length response header: 67750510 09:30:00 INFO - Bytes received: 67750510 09:30:11 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:30:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Yq6gCsErSKaHBZsfIUVQ6w/artifacts/public/build/target.common.tests.zip 09:30:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Yq6gCsErSKaHBZsfIUVQ6w/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:30:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Yq6gCsErSKaHBZsfIUVQ6w/artifacts/public/build/target.common.tests.zip into memory 09:30:13 INFO - Content-Length response header: 67750510 09:30:13 INFO - Bytes received: 67750510 09:30:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Yq6gCsErSKaHBZsfIUVQ6w/artifacts/public/build/target.talos.tests.zip 09:30:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Yq6gCsErSKaHBZsfIUVQ6w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:30:25 INFO - Fetch https://queue.taskcluster.net/v1/task/Yq6gCsErSKaHBZsfIUVQ6w/artifacts/public/build/target.talos.tests.zip into memory 09:30:25 INFO - Content-Length response header: 14441306 09:30:25 INFO - Bytes received: 14441306 09:30: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:30:26 INFO - trying https://queue.taskcluster.net/v1/task/Yq6gCsErSKaHBZsfIUVQ6w/artifacts/public/build/target.tar.bz2 09:30:26 INFO - Downloading https://queue.taskcluster.net/v1/task/Yq6gCsErSKaHBZsfIUVQ6w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:30:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yq6gCsErSKaHBZsfIUVQ6w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:30:27 INFO - Downloaded 61659372 bytes. 09:30:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Yq6gCsErSKaHBZsfIUVQ6w/artifacts/public/build/target.tar.bz2 09:30:27 INFO - mkdir: /builds/slave/test/properties 09:30:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:30:27 INFO - Writing to file /builds/slave/test/properties/build_url 09:30:27 INFO - Contents: 09:30:27 INFO - build_url:https://queue.taskcluster.net/v1/task/Yq6gCsErSKaHBZsfIUVQ6w/artifacts/public/build/target.tar.bz2 09:30:27 INFO - Running post-action listener: _resource_record_post_action 09:30:27 INFO - Running post-action listener: set_extra_try_arguments 09:30:27 INFO - [mozharness: 2017-06-24 16:30:27.208202Z] Finished download-and-extract step (success) 09:30:27 INFO - [mozharness: 2017-06-24 16:30:27.208298Z] Running populate-webroot step. 09:30:27 INFO - Running pre-action listener: _resource_record_pre_action 09:30:27 INFO - Running main action method: populate_webroot 09:30:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:30:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:30:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:30:27 INFO - '--tppagecycles', 09:30:27 INFO - '7'], 09:30:27 INFO - 'tests': ['tsvgm']}}, 09:30:27 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:30:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:30:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:30:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:30:27 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:30:27 INFO - 'talos_options': ['--disable-e10s'], 09:30:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:30:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:30:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:30:27 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:30:27 INFO - 'talos_options': ['--disable-e10s'], 09:30:27 INFO - 'tests': ['damp', 'tps']}, 09:30:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:30:27 INFO - 'tests': ['damp', 'tps']}, 09:30:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:30:27 INFO - 'tests': ['dromaeo_dom']}, 09:30:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:30:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:30:27 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:30:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:30:27 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:30:27 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:30:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:30:27 INFO - 'tests': ['a11yr', 09:30:27 INFO - 'ts_paint', 09:30:27 INFO - 'tpaint', 09:30:27 INFO - 'sessionrestore', 09:30:27 INFO - 'sessionrestore_no_auto_restore', 09:30:27 INFO - 'tabpaint']}, 09:30:27 INFO - 'other-e10s': {'tests': ['a11yr', 09:30:27 INFO - 'ts_paint', 09:30:27 INFO - 'tpaint', 09:30:27 INFO - 'sessionrestore', 09:30:27 INFO - 'sessionrestore_no_auto_restore', 09:30:27 INFO - 'tabpaint']}, 09:30:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:30:27 INFO - 'ts_paint', 09:30:27 INFO - 'tpaint', 09:30:27 INFO - 'sessionrestore', 09:30:27 INFO - 'sessionrestore_no_auto_restore', 09:30:27 INFO - 'tabpaint']}, 09:30:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:30:27 INFO - 'ts_paint', 09:30:27 INFO - 'tpaint', 09:30:27 INFO - 'sessionrestore', 09:30:27 INFO - 'sessionrestore_no_auto_restore', 09:30:27 INFO - 'tabpaint']}, 09:30:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:30:27 INFO - 'tests': ['a11yr', 09:30:27 INFO - 'ts_paint', 09:30:27 INFO - 'tpaint', 09:30:27 INFO - 'sessionrestore', 09:30:27 INFO - 'sessionrestore_no_auto_restore', 09:30:27 INFO - 'tabpaint']}, 09:30:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:30:27 INFO - 'tests': ['a11yr', 09:30:27 INFO - 'ts_paint', 09:30:27 INFO - 'tpaint', 09:30:27 INFO - 'sessionrestore', 09:30:27 INFO - 'sessionrestore_no_auto_restore', 09:30:27 INFO - 'tabpaint']}, 09:30:27 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:30:27 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:30:27 INFO - 'bloom_basic_ref']}, 09:30:27 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:30:27 INFO - 'talos_options': ['--mitmproxy', 09:30:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:30:27 INFO - '--firstNonBlankPaint'], 09:30:27 INFO - 'tests': ['quantum_pageload_google', 09:30:27 INFO - 'quantum_pageload_youtube', 09:30:27 INFO - 'quantum_pageload_amazon', 09:30:27 INFO - 'quantum_pageload_facebook']}, 09:30:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:30:27 INFO - 'tests': ['tsvgx', 09:30:27 INFO - 'tsvgr_opacity', 09:30:27 INFO - 'tart', 09:30:27 INFO - 'tscrollx', 09:30:27 INFO - 'cart', 09:30:27 INFO - 'tsvg_static']}, 09:30:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:30:27 INFO - 'tsvgr_opacity', 09:30:27 INFO - 'tart', 09:30:27 INFO - 'tscrollx', 09:30:27 INFO - 'cart', 09:30:27 INFO - 'tsvg_static']}, 09:30:27 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:30:27 INFO - 'talos_options': ['--disable-e10s'], 09:30:27 INFO - 'tests': ['tp5o']}, 09:30:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:30:27 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:30:27 INFO - 'talos_options': ['--disable-e10s', 09:30:27 INFO - '--xperf_path', 09:30:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:30:27 INFO - 'tests': ['tp5n']}, 09:30:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:30:27 INFO - 'talos_options': ['--xperf_path', 09:30:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:30:27 INFO - 'tests': ['tp5n']}}, 09:30:27 INFO - 'talos.zip': {'path': '', 09:30:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:30:27 INFO - Running post-action listener: _resource_record_post_action 09:30:27 INFO - [mozharness: 2017-06-24 16:30:27.223051Z] Finished populate-webroot step (success) 09:30:27 INFO - [mozharness: 2017-06-24 16:30:27.223141Z] Running create-virtualenv step. 09:30:27 INFO - Running pre-action listener: _resource_record_pre_action 09:30:27 INFO - Running main action method: create_virtualenv 09:30:27 INFO - Creating virtualenv /builds/slave/test/build/venv 09:30:27 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:30:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:30:27 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:30:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:30:27 INFO - Using real prefix '/usr' 09:30:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:30:27 INFO - Installing distribute.............................................................................................................................................................................................done. 09:30:29 INFO - Installing pip.................done. 09:30:29 INFO - Return code: 0 09:30:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:30:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:30:29 INFO - Reading from file tmpfile_stdout 09:30:29 INFO - Output received: 09:30:29 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:30:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:29 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 0x19813b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd140>, '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 0x1cfda40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfded0>, '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': '4300f881736b422476174874000001bc-1498300844.368157-1155967031', '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:30:29 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:30:29 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:30:29 INFO - Using env: {'DISPLAY': ':0', 09:30:29 INFO - 'HOME': '/home/cltbld', 09:30:29 INFO - 'LANG': 'en_US.UTF-8', 09:30:29 INFO - 'LANGUAGE': 'en_US:en', 09:30:29 INFO - 'LOGNAME': 'cltbld', 09:30:29 INFO - 'MAIL': '/var/mail/cltbld', 09:30:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:29 INFO - 'MOZ_NO_REMOTE': '1', 09:30:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:29 INFO - 'NO_EM_RESTART': '1', 09:30:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:30 INFO - 'PWD': '/builds/slave/test', 09:30:30 INFO - 'SHELL': '/bin/bash', 09:30:30 INFO - 'SHLVL': '1', 09:30:30 INFO - 'TERM': 'linux', 09:30:30 INFO - 'TMOUT': '86400', 09:30:30 INFO - 'USER': 'cltbld', 09:30:30 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498300844.368157-1155967031', 09:30:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:30 INFO - '_': '/tools/buildbot/bin/python'} 09:30:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:30 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:30:30 INFO - Cleaning up... 09:30:30 INFO - Return code: 0 09:30:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:30:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x19813b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd140>, '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 0x1cfda40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfded0>, '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': '4300f881736b422476174874000001bc-1498300844.368157-1155967031', '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:30:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:30:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:30:30 INFO - Using env: {'DISPLAY': ':0', 09:30:30 INFO - 'HOME': '/home/cltbld', 09:30:30 INFO - 'LANG': 'en_US.UTF-8', 09:30:30 INFO - 'LANGUAGE': 'en_US:en', 09:30:30 INFO - 'LOGNAME': 'cltbld', 09:30:30 INFO - 'MAIL': '/var/mail/cltbld', 09:30:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:30 INFO - 'MOZ_NO_REMOTE': '1', 09:30:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:30 INFO - 'NO_EM_RESTART': '1', 09:30:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:30 INFO - 'PWD': '/builds/slave/test', 09:30:30 INFO - 'SHELL': '/bin/bash', 09:30:30 INFO - 'SHLVL': '1', 09:30:30 INFO - 'TERM': 'linux', 09:30:30 INFO - 'TMOUT': '86400', 09:30:30 INFO - 'USER': 'cltbld', 09:30:30 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498300844.368157-1155967031', 09:30:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:30 INFO - '_': '/tools/buildbot/bin/python'} 09:30:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:30 INFO - Downloading/unpacking psutil>=3.1.1 09:30:30 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:30:30 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:30:30 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:30:30 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:30:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:30:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:30:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:30:31 INFO - Installing collected packages: psutil 09:30:31 INFO - Running setup.py install for psutil 09:30:31 INFO - building 'psutil._psutil_linux' extension 09:30:31 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:30:31 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:30:31 INFO - building 'psutil._psutil_posix' extension 09:30:31 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:30:32 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:30:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:30:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:30:32 INFO - Successfully installed psutil 09:30:32 INFO - Cleaning up... 09:30:32 INFO - Return code: 0 09:30:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:32 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 0x19813b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd140>, '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 0x1cfda40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfded0>, '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': '4300f881736b422476174874000001bc-1498300844.368157-1155967031', '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:30:32 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:30:32 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:30:32 INFO - Using env: {'DISPLAY': ':0', 09:30:32 INFO - 'HOME': '/home/cltbld', 09:30:32 INFO - 'LANG': 'en_US.UTF-8', 09:30:32 INFO - 'LANGUAGE': 'en_US:en', 09:30:32 INFO - 'LOGNAME': 'cltbld', 09:30:32 INFO - 'MAIL': '/var/mail/cltbld', 09:30:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:32 INFO - 'MOZ_NO_REMOTE': '1', 09:30:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:32 INFO - 'NO_EM_RESTART': '1', 09:30:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:32 INFO - 'PWD': '/builds/slave/test', 09:30:32 INFO - 'SHELL': '/bin/bash', 09:30:32 INFO - 'SHLVL': '1', 09:30:32 INFO - 'TERM': 'linux', 09:30:32 INFO - 'TMOUT': '86400', 09:30:32 INFO - 'USER': 'cltbld', 09:30:32 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498300844.368157-1155967031', 09:30:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:32 INFO - '_': '/tools/buildbot/bin/python'} 09:30:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:30:32 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:30:32 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:30:32 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:30:32 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:30:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:30:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:30:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:30:33 INFO - Installing collected packages: mozsystemmonitor 09:30:33 INFO - Running setup.py install for mozsystemmonitor 09:30:33 INFO - Successfully installed mozsystemmonitor 09:30:33 INFO - Cleaning up... 09:30:33 INFO - Return code: 0 09:30:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:30:33 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:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:33 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:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:33 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 0x19813b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd140>, '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 0x1cfda40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfded0>, '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': '4300f881736b422476174874000001bc-1498300844.368157-1155967031', '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:30:33 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:30:33 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:30:33 INFO - Using env: {'DISPLAY': ':0', 09:30:33 INFO - 'HOME': '/home/cltbld', 09:30:33 INFO - 'LANG': 'en_US.UTF-8', 09:30:33 INFO - 'LANGUAGE': 'en_US:en', 09:30:33 INFO - 'LOGNAME': 'cltbld', 09:30:33 INFO - 'MAIL': '/var/mail/cltbld', 09:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:33 INFO - 'MOZ_NO_REMOTE': '1', 09:30:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:33 INFO - 'NO_EM_RESTART': '1', 09:30:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:33 INFO - 'PWD': '/builds/slave/test', 09:30:33 INFO - 'SHELL': '/bin/bash', 09:30:33 INFO - 'SHLVL': '1', 09:30:33 INFO - 'TERM': 'linux', 09:30:33 INFO - 'TMOUT': '86400', 09:30:33 INFO - 'USER': 'cltbld', 09:30:33 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498300844.368157-1155967031', 09:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:33 INFO - '_': '/tools/buildbot/bin/python'} 09:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:33 INFO - Downloading/unpacking jsonschema==2.5.1 09:30:33 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:30:33 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:30:33 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:30:33 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:30:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:30:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:35 INFO - Downloading functools32-3.2.3-2.tar.gz 09:30:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:30:35 INFO - warning: no files found matching '*.txt' 09:30:35 INFO - no previously-included directories found matching 'build' 09:30:35 INFO - no previously-included directories found matching 'dist' 09:30:35 INFO - no previously-included directories found matching '.git*' 09:30:35 INFO - Installing collected packages: jsonschema, functools32 09:30:35 INFO - Running setup.py install for functools32 09:30:35 INFO - warning: no files found matching '*.txt' 09:30:35 INFO - no previously-included directories found matching 'build' 09:30:35 INFO - no previously-included directories found matching 'dist' 09:30:35 INFO - no previously-included directories found matching '.git*' 09:30:35 INFO - Successfully installed jsonschema functools32 09:30:35 INFO - Cleaning up... 09:30:35 INFO - Return code: 0 09:30:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:30:35 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:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:35 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:30:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:35 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 0x19813b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd140>, '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 0x1cfda40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfded0>, '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': '4300f881736b422476174874000001bc-1498300844.368157-1155967031', '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:30:35 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:30:35 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:30:35 INFO - Using env: {'DISPLAY': ':0', 09:30:35 INFO - 'HOME': '/home/cltbld', 09:30:35 INFO - 'LANG': 'en_US.UTF-8', 09:30:35 INFO - 'LANGUAGE': 'en_US:en', 09:30:35 INFO - 'LOGNAME': 'cltbld', 09:30:35 INFO - 'MAIL': '/var/mail/cltbld', 09:30:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:35 INFO - 'MOZ_NO_REMOTE': '1', 09:30:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:35 INFO - 'NO_EM_RESTART': '1', 09:30:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:35 INFO - 'PWD': '/builds/slave/test', 09:30:35 INFO - 'SHELL': '/bin/bash', 09:30:35 INFO - 'SHLVL': '1', 09:30:35 INFO - 'TERM': 'linux', 09:30:35 INFO - 'TMOUT': '86400', 09:30:35 INFO - 'USER': 'cltbld', 09:30:35 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498300844.368157-1155967031', 09:30:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:35 INFO - '_': '/tools/buildbot/bin/python'} 09:30:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:30:35 INFO - Cleaning up... 09:30:35 INFO - Return code: 0 09:30:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:30:35 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:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:35 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:30:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:35 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 0x19813b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd140>, '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 0x1cfda40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfded0>, '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': '4300f881736b422476174874000001bc-1498300844.368157-1155967031', '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:30:35 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:30:35 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:30:35 INFO - Using env: {'DISPLAY': ':0', 09:30:35 INFO - 'HOME': '/home/cltbld', 09:30:35 INFO - 'LANG': 'en_US.UTF-8', 09:30:35 INFO - 'LANGUAGE': 'en_US:en', 09:30:35 INFO - 'LOGNAME': 'cltbld', 09:30:35 INFO - 'MAIL': '/var/mail/cltbld', 09:30:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:35 INFO - 'MOZ_NO_REMOTE': '1', 09:30:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:35 INFO - 'NO_EM_RESTART': '1', 09:30:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:35 INFO - 'PWD': '/builds/slave/test', 09:30:35 INFO - 'SHELL': '/bin/bash', 09:30:35 INFO - 'SHLVL': '1', 09:30:35 INFO - 'TERM': 'linux', 09:30:35 INFO - 'TMOUT': '86400', 09:30:35 INFO - 'USER': 'cltbld', 09:30:35 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498300844.368157-1155967031', 09:30:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:35 INFO - '_': '/tools/buildbot/bin/python'} 09:30:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:35 INFO - Downloading/unpacking blobuploader==1.2.4 09:30:35 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:30:35 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:30:35 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:30:35 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:30:36 INFO - Downloading blobuploader-1.2.4.tar.gz 09:30:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:30:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:30:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:37 INFO - Downloading docopt-0.6.1.tar.gz 09:30:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:30:37 INFO - Installing collected packages: blobuploader, requests, docopt 09:30:37 INFO - Running setup.py install for blobuploader 09:30:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:30:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:30:37 INFO - Running setup.py install for requests 09:30:38 INFO - Running setup.py install for docopt 09:30:38 INFO - Successfully installed blobuploader requests docopt 09:30:38 INFO - Cleaning up... 09:30:38 INFO - Return code: 0 09:30:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:38 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 0x19813b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd140>, '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 0x1cfda40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfded0>, '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': '4300f881736b422476174874000001bc-1498300844.368157-1155967031', '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:30:38 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:30:38 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:30:38 INFO - Using env: {'DISPLAY': ':0', 09:30:38 INFO - 'HOME': '/home/cltbld', 09:30:38 INFO - 'LANG': 'en_US.UTF-8', 09:30:38 INFO - 'LANGUAGE': 'en_US:en', 09:30:38 INFO - 'LOGNAME': 'cltbld', 09:30:38 INFO - 'MAIL': '/var/mail/cltbld', 09:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:38 INFO - 'MOZ_NO_REMOTE': '1', 09:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:38 INFO - 'NO_EM_RESTART': '1', 09:30:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:38 INFO - 'PWD': '/builds/slave/test', 09:30:38 INFO - 'SHELL': '/bin/bash', 09:30:38 INFO - 'SHLVL': '1', 09:30:38 INFO - 'TERM': 'linux', 09:30:38 INFO - 'TMOUT': '86400', 09:30:38 INFO - 'USER': 'cltbld', 09:30:38 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498300844.368157-1155967031', 09:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:38 INFO - '_': '/tools/buildbot/bin/python'} 09:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:30:38 INFO - Running setup.py (path:/tmp/pip-zVlbw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:30:38 INFO - Running setup.py (path:/tmp/pip-FwzHUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:30:38 INFO - Running setup.py (path:/tmp/pip-gi_byw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:30:38 INFO - Running setup.py (path:/tmp/pip-TA6JFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:30:38 INFO - Running setup.py (path:/tmp/pip-JKFq4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:30:38 INFO - Running setup.py (path:/tmp/pip-jQzVmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:30:38 INFO - Running setup.py (path:/tmp/pip-J_G4vT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:30:38 INFO - Running setup.py (path:/tmp/pip-F3z596-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:30:38 INFO - Running setup.py (path:/tmp/pip-B7u04t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:30:39 INFO - Running setup.py (path:/tmp/pip-fTvQu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:30:39 INFO - Running setup.py (path:/tmp/pip-MQr2VD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:30:39 INFO - Running setup.py (path:/tmp/pip-zhgLMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:30:39 INFO - Running setup.py (path:/tmp/pip-NrdeIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:30:39 INFO - Running setup.py (path:/tmp/pip-eL338d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:39 INFO - Running setup.py (path:/tmp/pip-hJq9jB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:30:39 INFO - Running setup.py (path:/tmp/pip-jWIQ4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:30:39 INFO - Running setup.py (path:/tmp/pip-ni0y1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:30:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:30:39 INFO - Running setup.py install for manifestparser 09:30:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:30:39 INFO - Running setup.py install for mozcrash 09:30:39 INFO - Running setup.py install for mozdebug 09:30:39 INFO - Running setup.py install for mozdevice 09:30:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:30:40 INFO - Running setup.py install for mozfile 09:30:40 INFO - Running setup.py install for mozhttpd 09:30:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:30:40 INFO - Running setup.py install for mozinfo 09:30:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:30:40 INFO - Running setup.py install for mozInstall 09:30:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:30:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:30:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:30:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:30:40 INFO - Running setup.py install for mozleak 09:30:40 INFO - Running setup.py install for mozlog 09:30:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:30:40 INFO - Running setup.py install for moznetwork 09:30:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:30:40 INFO - Running setup.py install for mozprocess 09:30:40 INFO - Running setup.py install for mozprofile 09:30:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:30:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:30:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:30:40 INFO - Running setup.py install for mozrunner 09:30:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:30:41 INFO - Running setup.py install for mozscreenshot 09:30:41 INFO - Running setup.py install for moztest 09:30:41 INFO - Running setup.py install for mozversion 09:30:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:30:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:30:41 INFO - Cleaning up... 09:30:41 INFO - Return code: 0 09:30:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30: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:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30: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:30:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:41 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 0x19813b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd140>, '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 0x1cfda40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfded0>, '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': '4300f881736b422476174874000001bc-1498300844.368157-1155967031', '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:30:41 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:30:41 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:30:41 INFO - Using env: {'DISPLAY': ':0', 09:30:41 INFO - 'HOME': '/home/cltbld', 09:30:41 INFO - 'LANG': 'en_US.UTF-8', 09:30:41 INFO - 'LANGUAGE': 'en_US:en', 09:30:41 INFO - 'LOGNAME': 'cltbld', 09:30:41 INFO - 'MAIL': '/var/mail/cltbld', 09:30:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:41 INFO - 'MOZ_NO_REMOTE': '1', 09:30:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:41 INFO - 'NO_EM_RESTART': '1', 09:30:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:41 INFO - 'PWD': '/builds/slave/test', 09:30:41 INFO - 'SHELL': '/bin/bash', 09:30:41 INFO - 'SHLVL': '1', 09:30:41 INFO - 'TERM': 'linux', 09:30:41 INFO - 'TMOUT': '86400', 09:30:41 INFO - 'USER': 'cltbld', 09:30:41 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498300844.368157-1155967031', 09:30:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:41 INFO - '_': '/tools/buildbot/bin/python'} 09:30:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:30:41 INFO - Running setup.py (path:/tmp/pip-L8ViGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:30:41 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:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:30:41 INFO - Running setup.py (path:/tmp/pip-6Q4kYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:30:41 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:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:30:41 INFO - Running setup.py (path:/tmp/pip-_OcowB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:30:41 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:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:30:41 INFO - Running setup.py (path:/tmp/pip-nGErHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:30:41 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:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:30:41 INFO - Running setup.py (path:/tmp/pip-wDlon5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:30:41 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:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:30:42 INFO - Running setup.py (path:/tmp/pip-k19xiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:30:42 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:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:30:42 INFO - Running setup.py (path:/tmp/pip-H_tu5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:30:42 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:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:30:42 INFO - Running setup.py (path:/tmp/pip-Qpy9UG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:30:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:30:42 INFO - Running setup.py (path:/tmp/pip-9F7QEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:30:42 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:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:30:42 INFO - Running setup.py (path:/tmp/pip-JGXUgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:30:42 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:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:30:42 INFO - Running setup.py (path:/tmp/pip-WFc23t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:30:42 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:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:30:42 INFO - Running setup.py (path:/tmp/pip-1Ytw1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:30:42 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:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:30:42 INFO - Running setup.py (path:/tmp/pip-Diz0T5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:30:42 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:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:30:42 INFO - Running setup.py (path:/tmp/pip-9w_Bxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:30:42 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:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:42 INFO - Running setup.py (path:/tmp/pip-Wjhr16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:42 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:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:30:42 INFO - Running setup.py (path:/tmp/pip-pJuj33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:30:42 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:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:30:42 INFO - Running setup.py (path:/tmp/pip-5uyTt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:30:42 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:30:42 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:30:42 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:30:42 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:30:42 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:30:42 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:30:42 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:30:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:30:42 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:30:42 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:30:42 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:30:42 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:30:43 INFO - Downloading blessings-1.6.tar.gz 09:30:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:30:44 INFO - Installing collected packages: blessings 09:30:44 INFO - Running setup.py install for blessings 09:30:44 INFO - Successfully installed blessings 09:30:44 INFO - Cleaning up... 09:30:44 INFO - Return code: 0 09:30:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:30:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:30:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:30:44 INFO - Reading from file tmpfile_stdout 09:30:44 INFO - Current package versions: 09:30:44 INFO - argparse == 1.2.1 09:30:44 INFO - blessings == 1.6 09:30:44 INFO - blobuploader == 1.2.4 09:30:44 INFO - docopt == 0.6.1 09:30:44 INFO - functools32 == 3.2.3-2 09:30:44 INFO - jsonschema == 2.5.1 09:30:44 INFO - manifestparser == 1.1 09:30:44 INFO - mozInstall == 1.13 09:30:44 INFO - mozcrash == 1.0 09:30:44 INFO - mozdebug == 0.1 09:30:44 INFO - mozdevice == 0.51 09:30:44 INFO - mozfile == 1.2 09:30:44 INFO - mozhttpd == 0.7 09:30:44 INFO - mozinfo == 0.10 09:30:44 INFO - mozleak == 0.1 09:30:44 INFO - mozlog == 3.4 09:30:44 INFO - moznetwork == 0.27 09:30:44 INFO - mozprocess == 0.25 09:30:44 INFO - mozprofile == 0.28 09:30:44 INFO - mozrunner == 6.13 09:30:44 INFO - mozscreenshot == 0.1 09:30:44 INFO - mozsystemmonitor == 0.3 09:30:44 INFO - moztest == 0.8 09:30:44 INFO - mozversion == 1.4 09:30:44 INFO - psutil == 3.1.1 09:30:44 INFO - requests == 1.2.3 09:30:44 INFO - wsgiref == 0.1.2 09:30:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:44 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 0x19813b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd140>, '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 0x1cfda40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfded0>, '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': '4300f881736b422476174874000001bc-1498300844.368157-1155967031', '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:30:44 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:30:44 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:30:44 INFO - Using env: {'DISPLAY': ':0', 09:30:44 INFO - 'HOME': '/home/cltbld', 09:30:44 INFO - 'LANG': 'en_US.UTF-8', 09:30:44 INFO - 'LANGUAGE': 'en_US:en', 09:30:44 INFO - 'LOGNAME': 'cltbld', 09:30:44 INFO - 'MAIL': '/var/mail/cltbld', 09:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:44 INFO - 'MOZ_NO_REMOTE': '1', 09:30:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:44 INFO - 'NO_EM_RESTART': '1', 09:30:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:44 INFO - 'PWD': '/builds/slave/test', 09:30:44 INFO - 'SHELL': '/bin/bash', 09:30:44 INFO - 'SHLVL': '1', 09:30:44 INFO - 'TERM': 'linux', 09:30:44 INFO - 'TMOUT': '86400', 09:30:44 INFO - 'USER': 'cltbld', 09:30:44 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498300844.368157-1155967031', 09:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:44 INFO - '_': '/tools/buildbot/bin/python'} 09:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:44 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:30:44 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:30:44 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:30:44 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:30:44 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:30:44 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:30:44 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:30:44 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:30:44 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:30:44 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:45 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:30:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:30:45 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:30:45 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:30:45 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:30:45 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:30:45 INFO - Installing collected packages: marionette-driver 09:30:45 INFO - Running setup.py install for marionette-driver 09:30:45 INFO - Successfully installed marionette-driver 09:30:45 INFO - Cleaning up... 09:30:45 INFO - Return code: 0 09:30:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19813b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd140>, '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 0x1cfda40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfded0>, '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': '4300f881736b422476174874000001bc-1498300844.368157-1155967031', '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:30:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:30:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:30:45 INFO - Using env: {'DISPLAY': ':0', 09:30:45 INFO - 'HOME': '/home/cltbld', 09:30:45 INFO - 'LANG': 'en_US.UTF-8', 09:30:45 INFO - 'LANGUAGE': 'en_US:en', 09:30:45 INFO - 'LOGNAME': 'cltbld', 09:30:45 INFO - 'MAIL': '/var/mail/cltbld', 09:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:45 INFO - 'MOZ_NO_REMOTE': '1', 09:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:45 INFO - 'NO_EM_RESTART': '1', 09:30:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:45 INFO - 'PWD': '/builds/slave/test', 09:30:45 INFO - 'SHELL': '/bin/bash', 09:30:45 INFO - 'SHLVL': '1', 09:30:45 INFO - 'TERM': 'linux', 09:30:45 INFO - 'TMOUT': '86400', 09:30:45 INFO - 'USER': 'cltbld', 09:30:45 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498300844.368157-1155967031', 09:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:45 INFO - '_': '/tools/buildbot/bin/python'} 09:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:30:46 INFO - Cleaning up... 09:30:46 INFO - Return code: 0 09:30:46 INFO - Running post-action listener: _resource_record_post_action 09:30:46 INFO - Running post-action listener: _start_resource_monitoring 09:30:46 INFO - Starting resource monitoring. 09:30:46 INFO - [mozharness: 2017-06-24 16:30:46.205876Z] Finished create-virtualenv step (success) 09:30:46 INFO - [mozharness: 2017-06-24 16:30:46.206458Z] Running install step. 09:30:46 INFO - Running pre-action listener: _resource_record_pre_action 09:30:46 INFO - Running main action method: install 09:30:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:30:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:30:46 INFO - Reading from file tmpfile_stdout 09:30:46 INFO - Detecting whether we're running mozinstall >=1.0... 09:30:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:30:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:30:46 INFO - Reading from file tmpfile_stdout 09:30:46 INFO - Output received: 09:30:46 INFO - Usage: mozinstall [options] installer 09:30:46 INFO - Options: 09:30:46 INFO - -h, --help show this help message and exit 09:30:46 INFO - -d DEST, --destination=DEST 09:30:46 INFO - Directory to install application into. [default: 09:30:46 INFO - "/builds/slave/test"] 09:30:46 INFO - --app=APP Application being installed. [default: firefox] 09:30:46 INFO - mkdir: /builds/slave/test/build/application 09:30:46 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:30:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:31:04 INFO - Reading from file tmpfile_stdout 09:31:04 INFO - Output received: 09:31:04 INFO - /builds/slave/test/build/application/firefox/firefox 09:31:04 INFO - Running post-action listener: _resource_record_post_action 09:31:04 INFO - [mozharness: 2017-06-24 16:31:04.516257Z] Finished install step (success) 09:31:04 INFO - [mozharness: 2017-06-24 16:31:04.516535Z] Running setup-mitmproxy step. 09:31:04 INFO - Running pre-action listener: _resource_record_pre_action 09:31:04 INFO - Running main action method: setup_mitmproxy 09:31:04 INFO - Skipping: mitmproxy is not required 09:31:04 INFO - Running post-action listener: _resource_record_post_action 09:31:04 INFO - [mozharness: 2017-06-24 16:31:04.517692Z] Finished setup-mitmproxy step (success) 09:31:04 INFO - [mozharness: 2017-06-24 16:31:04.517913Z] Running run-tests step. 09:31:04 INFO - Running pre-action listener: _resource_record_pre_action 09:31:04 INFO - Running main action method: run_tests 09:31:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:31:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:31:04 INFO - Python 2.7.3 09:31:04 INFO - Return code: 0 09:31:04 INFO - grabbing minidump binary from tooltool 09:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:31:04 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd140>, '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 0x1cfda40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfded0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:31:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:31:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:31:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:31:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:31:04 INFO - Return code: 0 09:31:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:31:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:31:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:31:04 INFO - ENV: RUST_BACKTRACE is now 1 09:31:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:31:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:31:04 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/Yq6gCsErSKaHBZsfIUVQ6w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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:31:04 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/Yq6gCsErSKaHBZsfIUVQ6w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-045 --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:31:04 INFO - Using env: {'DISPLAY': ':0', 09:31:04 INFO - 'HOME': '/home/cltbld', 09:31:04 INFO - 'LANG': 'en_US.UTF-8', 09:31:04 INFO - 'LANGUAGE': 'en_US:en', 09:31:04 INFO - 'LOGNAME': 'cltbld', 09:31:04 INFO - 'MAIL': '/var/mail/cltbld', 09:31:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:31:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:31:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:04 INFO - 'MOZ_NO_REMOTE': '1', 09:31:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:31:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:04 INFO - 'NO_EM_RESTART': '1', 09:31:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:04 INFO - 'PWD': '/builds/slave/test', 09:31:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:31:04 INFO - 'RUST_BACKTRACE': '1', 09:31:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:31:04 INFO - 'SHELL': '/bin/bash', 09:31:04 INFO - 'SHLVL': '1', 09:31:04 INFO - 'TERM': 'linux', 09:31:04 INFO - 'TMOUT': '86400', 09:31:04 INFO - 'USER': 'cltbld', 09:31:04 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498300844.368157-1155967031', 09:31:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:04 INFO - '_': '/tools/buildbot/bin/python'} 09:31:04 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/Yq6gCsErSKaHBZsfIUVQ6w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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:31:04 INFO - mozversion application_buildid: 20170624154105 09:31:04 INFO - mozversion application_changeset: c01aa84ded7eb0b3e691f8bcc5cd887c960a779e 09:31:04 INFO - mozversion application_display_name: Nightly 09:31:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:31:04 INFO - mozversion application_name: Firefox 09:31:04 INFO - mozversion application_remotingname: firefox 09:31:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:31:04 INFO - mozversion application_vendor: Mozilla 09:31:04 INFO - mozversion application_version: 56.0a1 09:31:04 INFO - mozversion platform_buildid: 20170624154105 09:31:04 INFO - mozversion platform_changeset: c01aa84ded7eb0b3e691f8bcc5cd887c960a779e 09:31:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:31:04 INFO - mozversion platform_version: 56.0a1 09:31:04 INFO - using testdate: 1498321864 09:31:04 INFO - actual date: 1498321864 09:31:04 INFO - starting webserver on 'localhost:40892' 09:31:04 INFO - SUITE-START | Running 2 tests 09:31:04 INFO - TEST-START | dromaeo_css 09:31:04 INFO - operating with platform_type : linux_ 09:31:04 INFO - Initialising browser for dromaeo_css test... 09:31:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40892/getInfo.html -profile /tmp/tmp6rYLUI/profile 09:31:04 INFO - TEST-INFO | started process 26760 (/builds/slave/test/build/application/firefox/firefox http://localhost:40892/getInfo.html) 09:31:11 INFO - TEST-INFO | 26760: exit 0 09:31:11 INFO - Browser initialized. 09:31:11 INFO - Running cycle 1/1 for dromaeo_css test... 09:31:11 INFO - TEST-INFO | started process 26990 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6rYLUI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:31:23 INFO - PID 26990 | RSS: Main: 179908608 09:31:23 INFO - PID 26990 | 09:34:27 INFO - PID 26990 | Cycle 1(1): loaded http://localhost:40892/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40892/tests/dromaeo/cssquery-ext.html) 09:34:29 INFO - PID 26990 | RSS: Main: 184197120 09:34:29 INFO - PID 26990 | 09:37:31 INFO - PID 26990 | Cycle 1(1): loaded http://localhost:40892/tests/dromaeo/cssquery-ext.html (next: http://localhost:40892/tests/dromaeo/cssquery-jquery.html) 09:37:31 INFO - PID 26990 | RSS: Main: 183824384 09:37:31 INFO - PID 26990 | 09:40:33 INFO - PID 26990 | Cycle 1(1): loaded http://localhost:40892/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40892/tests/dromaeo/cssquery-mootools.html) 09:40:33 INFO - PID 26990 | RSS: Main: 186601472 09:40:33 INFO - PID 26990 | 09:43:35 INFO - PID 26990 | Cycle 1(1): loaded http://localhost:40892/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40892/tests/dromaeo/cssquery-prototype.html) 09:43:36 INFO - PID 26990 | RSS: Main: 184606720 09:43:36 INFO - PID 26990 | 09:46:38 INFO - PID 26990 | Cycle 1(1): loaded http://localhost:40892/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40892/tests/dromaeo/cssquery-yui.html) 09:46:39 INFO - PID 26990 | RSS: Main: 184832000 09:46:39 INFO - PID 26990 | 09:49:41 INFO - PID 26990 | Cycle 1(1): loaded http://localhost:40892/tests/dromaeo/cssquery-yui.html (next: http://localhost:40892/tests/dromaeo/cssquery-dojo.html) 09:49:41 INFO - PID 26990 | RSS: Main: 181841920 09:49:41 INFO - PID 26990 | 09:49:41 INFO - PID 26990 | __start_tp_report 09:49:41 INFO - PID 26990 | _x_x_mozilla_page_load 09:49:41 INFO - PID 26990 | _x_x_mozilla_page_load_details 09:49:41 INFO - PID 26990 | |i|pagename|runs| 09:49:41 INFO - PID 26990 | |0;dojo.html;3106.223444138965;3117.2206948262933;3145.24514116612;3145.2765863851314;3176.8411579421036;6028.125921741344;6131.743695907012;6132.722655450949;6137.193127861517;6145.2011238539035;6143.84965262158;6191.257049154096;6195.31851496335;6196.876062478759;6204.131421600968;5696.458836410535;5709.257796486451;5712.057510510761;5765.1352297155345;5794.855128621776;5527.364353099405;5624.887502249973;5697.886042279152;5717.656940583557;5734.713264336767;5586.91619625706;5637.689927054011;5641.12562552805;5661.631993920382;5668.773249070032;5662.462066103713;5665.235193248941;5669.291338582677;5670.68811215383;5673.26247587815;5570.442955704438;5606.719664016783;5642.238297829782;5661.2357331760095;5715.571332150105;6102.603330783485;6115.9694201529155;6139.8601398601395;6142.8057410146475;6192.969035154841;6648.501362397791;6678.866422671519;6693.5649182803445;6708.396244338033;6722.025306330604;6504.1869766279215;6621;6742.662866856637;6771.1874575050815;6774.864502709967;6081.756729730761;6125.662799505688;6134.926457743815;6139.737467782837;6141.6007959482495;6847;6868.62222577763;6892;6901.62041087735;6903.240643529208;6520.934790652128;6540.8364790880605;6544.411003009752;6564.310747371553;6585.9012114818315;6624;6643.5017373697165;6682.231543372477;6692.732290708414;6698.732050718014;6429.807105786834;6551.0500977358015;6562.934370656328;6621.569597976116;6667.933320666828;6310.7475700971445;6331.461825744771;6343.175387199634;6385.169927909342;6425;5356.732163391893;5385.946140538623;5391.946080539223;5400.891982160335;5439.129739241703;4549.863504094882;4558.908821823611;4570.588647021784;4580.312953057001;4584.564466375689;5783.739731712083;5790.507806836466;5801.361850196475;5807.622504537191;5814.767409303665;6483.578567393104;6572.474202063823;6584.835379115465;6587.440067594308;6683.331666833278;5792.189093526909;5795.710214489259;5798.043322851767;5812.215350927655;5862.530997520188;5843.620164689281;5878.382769809194;5908.468237858613;5917.852053698692;5928.110783382441;6443.83890402725;6443.96778016107;6448.167612431242;6470.935290647033;6486.643234622141;6458.095866578588;6507.6746162692625;6510.544261901621;6638.601683898982;6643.1031810704935;6466.127072845294;6497.350264973465;6500.6424646643;6523.445507131757;6536;6526.216853977553;6594.439472644879;6599.5050371223315;6610.239822420291;6641.738069766729;6744.123263975652;6753.054572359972;6764.3573860483175;6768.898466522907;6770.221424536241;6284.811455656338;6383.297837237993;6514.706838192198;6534.150560427114;6566.277709451861;6388.744450221939;6402.327755585597;6409.551331406943;6478.449331806849;6507.12153859223;6375.553711240169;6375.74497020114;6492;6492.285848556749;6511.38141876521;6608.43828274602;6617.338266173344;6620.205575330991;6620.933790662224;6637.971114477264;6401.7119229633845;6404.295527491879;6405.423511883952;6409.839754006187;6428.550001500037 09:49:41 INFO - PID 26990 | |1;ext.html;790.9920900790991;830.9127541608127;853.4111463090468;883.4346018548131;883.6907082521118;37714.24571508568;39046.804765976165;39182.41226381603;39291.41062884059;39327.80336098323;35972.460413093824;36250.093747656254;36305.27389452216;36390.27219455616;36427.63572364282;6771.966140169292;6853.657317134148;6863.794086177422;6896.931030689679;6933.098697169361;6822.556533825285;6852;6894.965525172367;6901.689423975933;6928.44572434204;6866;6867.484938629598;6876.518643694943;6894.034835123087;6901.896471552931;6808.557443766164;6854.931450685529;6860.5197636165485;6866.14173228349;6894.655267236643;6237.96881015592;6280.78017269398;6285.025820997753;6302.842428939267;6303.936960630381;32522.83738581292;32807.83596082004;36891.63108368935;37408;37424.43863342052;3555.2711694102645;3600.837962291703;3609.079684680416;3611.7291203159866;3612.3678356287805;29364.706352936624;29619.407611847644;29622;29629.555556666666;29712;3685.6682898538993;3700.40793473043;3724.5902950675404;3726.1988672435555;3775.0751065989007;186748;187297;188099;191111;191954.9999999986;47198.52801471941;47539.52460475351;47711.28433073506;48017.519824801304;48081.27878081831;49916.50083499191;50078.49921500738;50290.74854625703;50295;50338.24492632614;15204.543863684106;15453;15463.458778942908;15549.30028148736;15559.45541906028;12837.807432888514;12885.162464439969;12894.548690795777;12917.418716157796;12919.418626161845;14111.518290579546;14219.928900355431;14224.786628200585;14258.500952466615;14427.78358324626;5641.351244606923;5698.886022279531;5790.826275211751;5810.448007439287;5860.296764388216;984.6602921991902;987.0918754745508;999.9550020249106;1019.4494972714651;1033.9172866170838;22085.33743987683;22561.533500322428;22568.91495601173;23460.882695586413;23792.643110353358;1084.6258040975852;1093.8960798724108;1117.0728295514866;1117.7708569743183;1123.8707548631849;11818.940905295418;11852.703682407837;12108.152429330039;12115.956762898704;12199.817002744965;218777;219129;220197;220425;221003;45805.7709711456;45997.77001114973;46228.5377146231;46393.7680311603;46505.767471163104;1378.4555100735154;1412.0680350968516;1432.6060333408188;1443.826740791112;1446.0600609603841;21847.235346762787;22100.668489972984;23328;23468.295951121494;23808.880955595112;35721.64278357287;35982.46026309555;36021.81989090038;36041.459378109874;36099.639003610675;175046;175590;176339;176617;176772;31854.840725796224;32453.837730811196;32787.67212327846;33047.66952330542;33331.83334083411;40078.59921400749;40450.797746011085;40575.59424405718;41114;41231.58768412397;27367.72632273652;27387.31531711723;27612.585811212448;27815.443691126467;28728.983456736743;26976;27058;27189.86405067962;27957.161285161477;28213.576796348483;32012;33505.162370940925;33807.4928876072;34000.14999625029;34065;26821.195364138326;26854.731452686006;26999.038607004408;27110;27749.86125069362;23153.305400838002;24066.51866962616;24179.274621761375;24306.75693243045;24434.87782561147 09:49:41 INFO - PID 26990 | |2;jquery.html;560.8766071464279;565.6577770448881;571.6427232979388;581.9709014549271;589.5725598940769;21447.249346272863;22231.44421389466;22294.665580016313;22321.218757343497;22531.887340563273;24067.398315042134;25586.232413027592;25727;25874.482510349782;25959.870200649017;6459.09572659828;6613.93386066138;6616.735330586771;6619.139511863451;6627;6034.6120392309795;6483.384078512558;6541.247756507991;6543.770968016121;6547.214334279869;4048.5951404859575;4798.736069516175;6471.449926756231;6480.995445705923;6532.673366331688;6436.163298771176;6491.221053473566;6496.123023391852;6506.577072490297;6525.6737163142125;5989.580729348947;6013.308469525973;6023.759049638009;6050.122732203849;6059.424354686298;28451.857740711162;28760.712392876012;29316.560251596242;29416.264593385124;29436;1898.905054747271;1914.4926594452481;1942.5726340205133;1943.1255934829383;1943.7084437334372;17978.37075702357;18521.444356669323;18532.96137424882;18585.34951276699;18603.906980465148;2322.6296485073717;2328.836981411302;2396.101461951768;2397.7122745270503;2408.385861605297;126462;127763;128085.99999999907;128108.35945820305;128977.35511322384;13784.172949622855;14291.356888940023;14477.755947828104;14494.912881533926;15081;23462.7653723464;23479;23498.53002939966;23561;23623.29130126099;9381.29640276982;9573.760655983657;9601.903980960102;9709.077637624414;9716.125548700651;8607.569621518898;8665.81208944138;8696.04343522212;8726.912730872737;8833.734987950373;9011.27909767217;9013.864792028126;9086.681966131153;9240.610709912871;9276.443413395218;2644.761971422581;2687.543117670001;2694.811363204596;2771.8422366450322;2789.838798223311;917.1793988931964;917.3440989692402;933.4072863731444;979.9020097990286;983.3362480325894;17657.646847063243;17836.821631783518;18140.274389024555;18311.816881831277;18514.259429622663;959.467495539968;964.2816102004052;988.619381538113;995.9452230127413;996.6312464388078;9701.272404569545;9947.751306217258;10292.485375731183;12299.754004919852;14074.507392241223;480048;480230;483172;484494;489768;101501.49249253854;108115.83768324589;108343;108574;108863.45568272266;1194.4923407551755;1221.2855479544567;1260.4769020856425;1263.2546797389584;1266.860645329013;19048.80951190526;21051.684224736335;21228.150873965486;21331.36005919825;21333;46091;48538.757306214655;48659.51340486691;49264.50735492599;49550;61475;61702.38297617146;61720;61804.38195617986;61924.07113893205;12802.615921522369;12808.103432759617;12877.162984405984;12896.548620798227;12918.741625167631;13551.186928784304;13788.655283617989;16195;17432.30270789205;17673.469795906145;13487.865121348661;15234.781217502352;15436.45972390961;15541.922290388477;15560.221988900283;12813.103082784115;13430;13477.460901563827;13487.393067311797;14059.789103163255;14613.342399592257;14844.480443184437;14867.92566037163;14869.330880110638;14891.627709307353;11732.41337933117;11768.293902365886;11771.587994420153;11817.231879927776;11827.112966527717;13558.525451609541;14264.144151350953;14338.068025578305;14338.139711617336;14358.994870358974 09:49:41 INFO - PID 26990 | |3;mootools.html;1301.739652069586;1376.2843321472835;1382.9351399422444;1387.271682366758;1388.8055672205887;12667.176633518826;13176.802347964776;13193;13205.801912971314;13239;12867.871321286784;13212.273324967124;13317.800232996513;13362.799558006638;13385.39765710543;2546.337952132445;2587.2884956636885;2593.1313010141625;2601.9219423417326;2609.425926296212;2519.0427637497723;2584.4572639745675;2584.8578328191943;2585.0952166741677;2586.741325867408;2534.911278105267;2559.5648739714293;2574.3178057814694;2574.7425257474197;2580.3678098865803;2495.7878580320603;2507.5862482690336;2518.1941778630844;2520.193538067819;2522.1298651965044;2477.55404027275;2491.8504889706674;2499.700035995674;2504.0860086068456;2505.348609361561;12912.741745165138;13111;13178.472861085545;13184.86815131846;13249.403776830066;7141.39298159657;7412.518186317872;7413;7420.295071968154;7424.628768561551;4186.204621122008;4327.112941846914;4404.4054052702795;4414.823407063714;4418.734875907424;1597.9280932358072;1632.2002218912767;1633.746769250768;1674.2047527424497;1676.3294682127125;18266.178021989042;18874.52813679655;20168.49578760528;20182.09180586877;20405.79594204054;5395.298611180521;5501.367342755554;5865.178874957509;6157.568970172045;6189.473894718999;14337.85662143386;14405.3433855108;14462.638434039023;14480.565583032527;14487.49293774734;7098.077249957472;7173.031640728539;7211.350978411968;7212.567245965259;7213.89179162313;6847.828804279833;6912.205096413876;6928.203256625452;6929.41100006495;7055.576665400093;4779.450363208206;4840.273958906122;4945.282933974553;4945.307656928033;4954.603631709527;1283.0954177304977;1291.9354032298347;1302.856685764565;1314.18520517278;1322.8015797630433;891.2558014058204;898.6360523987795;906.1346414174448;922.4741897118578;938.2306508662967;6907.378335949788;6962.2341542430295;7228.63856807168;7337.816554586071;7340.706371745177;705.5519744961883;722.9457790665721;965.792354643755;986.5511192407438;999.3554157568328;4777.546133117417;4818.855434336975;4880.341153944243;4976.278439626234;5043.672161309503;16585.087820169767;17260.309587616353;17286.740698889527;17303.480895573153;17347.653046939242;17053.7441938371;17645.117744112744;17706.5573360667;17730.468085957444;17807.910960445115;9851.556679949419;10412.843807342895;10595.84106238407;10619.893801061891;10766.56933722658;7263.382612477999;7376.926230737624;7391.445641576795;7715;7792.064952205772;14987.625309367353;15385.153816540198;15488.225588720745;15600.297986590404;15792.92103539475;15402.46091386796;15572.84427155714;15895.125768082866;16130.596735081717;16179;9589.041095890356;9695.127438530566;9782;9797.608095676092;9860.85208721884;11911.463984120563;12004.459799309227;12096.153269271066;12228;12262.816057759319;8994.820103598022;9310.208632266062;9324;9730.659426920023;9849.113579777855;9203.263738900738;9545.665901693408;9666.854997174907;9772.706818795448;9781.510924453607;8324.791880203044;9125.361224714206;9462.148406643435;9468.95265523668;9475.763105922131;6184.567080304336;6216;6352.555321127476;6442.35576442352;6544.411003009752;6680.899786503303;6865.244823069358;6896.137982752156;6987.406070484066;7089.432845372255 09:49:41 INFO - PID 26990 | |4;prototype.html;487.3706789628052;495.4896456649652;512.3723438787483;521.0568870344676;526.7883867105656;6201.162843016192;6227.750889964396;6258.687065646716;6309.716062777175;6314.368563143684;6185.845353866155;6196.101565273033;6201.596896201744;6218.22272215973;6232.875342493158;5131.743412829363;5132.307138536287;5144.305518754958;5165.018646457161;5175.974120129404;5143.974280128594;5154.4072431670465;5161.17421212606;5162.457941916101;5169.663971841837;4768.90462190756;4943.851684449454;4949.034938187055;5142.971405718852;5163.432022477525;4917.582005529534;4926.802927882881;4935.185694360426;4948.87627809304;5006.599472042228;4425.7565833879125;4428.335749637548;4430.667699922518;4457.420535330419;4477.126960242754;6070.301915279755;6089.604175728564;6107.694615269219;6109.877802443926;6114.969425152845;5769.884602307972;5770.249867517238;5774.595778295521;5774.88450230993;5778.38205302516;6579.243387010507;6613.669316534202;6618.834529136762;6636.634985075819;6639.634820084893;4916.557509824133;4922.089413458521;4933.753312334369;4943.134951383529;4950.108980383529;6677.666116694146;6903.447724182053;6915.135608048994;6937.132858392701;7039.472039597;4779.139754844162;4974.27872958419;5011.448740638527;5014.749262536859;5045.722485263345;5031.84904452867;5069.949300506948;5073.847784566469;5079.5428411443145;5083.415407228216;5646.628416065262;5688.431156884279;5703.74333155009;5703.800366987219;5709.857253568694;6600.471962243009;6609.6695165241545;6609.900851487231;6612.371824676648;6625.867482650417;1751.5621094726318;1756.1658212349287;1759.155605309433;1762.4712586224082;1766.5053784940237;1142.2689478733616;1225.154643296123;1231.648980040702;1237.2761934268374;1262.0786825617167;5745.482906538432;5764.221830052889;5812.273465816773;5819.388964158702;5839.620424672383;6691.7323307068145;6722.764703235363;6771.8984215236815;6787.490938179656;6819.113515243086;5845.357010728816;5846.912296315559;5865.941340586625;5867.677277749679;5873.765049397976;3631.9636803631624;3642.453631955175;3644.362236608583;3647;3653.780773153619;6580.967095164494;6583.83540411484;6588.077669126326;6589.341065893373;6612.669366531654;6957.408620267232;6963.303669633097;6970;6973.825654358681;7006;6552.213734351908;6556.2788093310655;6571.310012448624;6571.934280657228;6577.218099592657;6786.491013174131;6797.490188236001;6801.557898736566;6814.274290283728;6820.863582728417;6085.020575380707;6713.395794378529;6726.663666816542;6735.158105236846;6753.628550429774;6493.642849643126;6513.348665133449;6520.445762110084;6531.967340163459;6535.771248006297;4984.900301993867;5007.39911210657;5007.974960125176;5031.9245211322595;5048.960831334991;6534.542582019213;6686.498512611476;6736.932630673827;6823.38589526945;6838.7264509419065;6449.1616089909885;6512.037023154358;6575.572587781779;6576.671166441754;6617;6508.772192973223;6524.771632992823;6554.2462616797775;6589.7364105435245;6621.238557565942;6421.5825971311715;6455.2576453708425;6469.353064693493;6496.9025464617125;6519.08732777421;6596.637184954873;6604;6614.404703576702;6629.635370054693;6642.43539299165;6384.712687928962;6404.71178796946;6421.743130274736;6429.32492088324;6477.643729594917 09:49:41 INFO - PID 26990 | |5;yui.html;849.4478588917207;868.6655637579534;872.097379212515;876.4960147914951;891.4294851295168;17705.911470442647;18060.277588896446;18235.088245587718;18351.357702480414;18368.540786480313;16518.504444866674;16523.752143717855;16580.088095154762;17325.7401138983;18938.242470301208;1026.5944951744075;1043.353121064937;1046.4296958157822;1050.3120456101228;1051.085555566658;1046.0637729232333;1054.5623566220047;1055.2244100586101;1057.471264367816;1059.7986382587321;1099.631623406156;1101.300674071962;1101.8237082066871;1103.3931337764197;1108.501174471487;1027.8509616105623;1087.190043417651;1091.9672409827679;1092.956281748729;1093.3877028863822;793.888855560222;794.285143370965;794.3803833010261;795.3915254830059;797.2027972027972;18521.351752688726;18651.533711657183;18665.720014199796;18688.53278668044;18707.812921870744;18532.536686582807;19527.80472195274;19573.021348932496;19718.70421943672;19868.900655496775;14295.78556321656;14878.553643390716;14896.329665165094;14906.925465372713;15089.39642414302;3555.9111022224392;3570.6429357064344;3577;3585.5697316322207;3593.694535964446;91618;96264;97073.51463242639;100887;102145;14436.711265774626;14827;15138.091714497166;15168.469103581321;15212.771808422882;26024.219273421826;27636.30909227245;27879.163625091278;28015.579766303523;28161.155165345073;7830.373570114377;7898.644560994769;7943.682252709827;7959.403044771665;8003.159668234868;3894.7468414552964;4011.3180759270995;4035.9192816143513;4043.81802818868;4046.1705350403095;4706.811727530929;4790.520947905251;4800.35195248644;4801.303810947393;4824.035192961352;886.189136939693;890.1098901098901;904.2268860124499;911.2436677557744;961.0293603460416;632.1024145713099;632.7342516143231;647.8833809914166;655.2039272284197;673.6295037729229;10869.619563315404;11441.942790286163;11675.12436567261;12043.759124817454;12462.43919023646;580.0481232429414;595.4402861310355;598.4763332084426;602.1569802276847;620.5811077522654;4878.902421951541;4953.876153096201;5057.342545469139;5133.12736834739;5219.164933610604;91955.5402222998;94962.52518737363;97433.5128324368;98715.50642246743;98762.06189690487;66781.66609166923;87228;87471;88198.55900720456;89588.5520572406;64347;73849.67676454573;73944.99999999892;76781.61609191919;76872;10759.246852720235;10838.620648277272;10952;11236.66290011301;11361;32380.83809580937;33453;33510.156941368456;34115.31769364649;34790.30419391547;43034.63114065127;43782.029808659325;43819;44427.11145777131;44516;16207.432739854048;16212.594685132966;16213.67572648564;16249.918750406172;16589.419370321983;17770.822291776916;17825;18498.445046648623;18504.907475462536;18684.25262989465;16726.33094676248;17073.914630426767;17108.315667373165;17159.056251906266;17557.297708091533;15804.68390632158;16193.02841829494;16494.25775840066;16512.174391280627;16516.256768445208;13934.372953216927;14663.780043299146;14899.925500372428;15002.324895379516;15156.469523567062;10055.949720251352;10262.332948358333;10351.534180962026;10382.42896640692;10499;12074.399122369812;12480.812787808009;12488.060661585318;12739.299338536099;12908.741825163632 09:49:41 INFO - PID 26990 | __end_tp_report 09:49:41 INFO - PID 26990 | __start_cc_report 09:49:41 INFO - PID 26990 | _x_x_mozilla_cycle_collect,371 09:49:41 INFO - PID 26990 | __end_cc_report 09:49:41 INFO - PID 26990 | __startTimestamp1498322981684__endTimestamp 09:49:41 INFO - PID 26990 | 09:49:41 INFO - PID 26990 | ------- Summary: start ------- 09:49:41 INFO - PID 26990 | Number of tests: 6 09:49:41 INFO - PID 26990 | 09:49:41 INFO - PID 26990 | [#0] dojo.html Cycles:165 Average:6113.44 Median:6385.17 stddev:721.83 (11.3%) stddev-sans-first:684.41 09:49:41 INFO - PID 26990 | Values: 3106.2 3117.2 3145.2 3145.3 3176.8 6028.1 6131.7 6132.7 6137.2 6145.2 6143.8 6191.3 6195.3 6196.9 6204.1 5696.5 5709.3 5712.1 5765.1 5794.9 5527.4 5624.9 5697.9 5717.7 5734.7 5586.9 5637.7 5641.1 5661.6 5668.8 5662.5 5665.2 5669.3 5670.7 5673.3 5570.4 5606.7 5642.2 5661.2 5715.6 6102.6 6116.0 6139.9 6142.8 6193.0 6648.5 6678.9 6693.6 6708.4 6722.0 6504.2 6621.0 6742.7 6771.2 6774.9 6081.8 6125.7 6134.9 6139.7 6141.6 6847.0 6868.6 6892.0 6901.6 6903.2 6520.9 6540.8 6544.4 6564.3 6585.9 6624.0 6643.5 6682.2 6692.7 6698.7 6429.8 6551.1 6562.9 6621.6 6667.9 6310.7 6331.5 6343.2 6385.2 6425.0 5356.7 5385.9 5391.9 5400.9 5439.1 4549.9 4558.9 4570.6 4580.3 4584.6 5783.7 5790.5 5801.4 5807.6 5814.8 6483.6 6572.5 6584.8 6587.4 6683.3 5792.2 5795.7 5798.0 5812.2 5862.5 5843.6 5878.4 5908.5 5917.9 5928.1 6443.8 6444.0 6448.2 6470.9 6486.6 6458.1 6507.7 6510.5 6638.6 6643.1 6466.1 6497.4 6500.6 6523.4 6536.0 6526.2 6594.4 6599.5 6610.2 6641.7 6744.1 6753.1 6764.4 6768.9 6770.2 6284.8 6383.3 6514.7 6534.2 6566.3 6388.7 6402.3 6409.6 6478.4 6507.1 6375.6 6375.7 6492.0 6492.3 6511.4 6608.4 6617.3 6620.2 6620.9 6638.0 6401.7 6404.3 6405.4 6409.8 6428.6 09:49:41 INFO - PID 26990 | 09:49:41 INFO - PID 26990 | [#1] ext.html Cycles:180 Average:35282.03 Median:33656.33 stddev:50764.49 (150.8%) stddev-sans-first:50840.84 09:49:41 INFO - PID 26990 | Values: 791.0 830.9 853.4 883.4 883.7 37714.2 39046.8 39182.4 39291.4 39327.8 35972.5 36250.1 36305.3 36390.3 36427.6 6772.0 6853.7 6863.8 6896.9 6933.1 6822.6 6852.0 6895.0 6901.7 6928.4 6866.0 6867.5 6876.5 6894.0 6901.9 6808.6 6854.9 6860.5 6866.1 6894.7 6238.0 6280.8 6285.0 6302.8 6303.9 32522.8 32807.8 36891.6 37408.0 37424.4 3555.3 3600.8 3609.1 3611.7 3612.4 29364.7 29619.4 29622.0 29629.6 29712.0 3685.7 3700.4 3724.6 3726.2 3775.1 186748.0 187297.0 188099.0 191111.0 191955.0 47198.5 47539.5 47711.3 48017.5 48081.3 49916.5 50078.5 50290.7 50295.0 50338.2 15204.5 15453.0 15463.5 15549.3 15559.5 12837.8 12885.2 12894.5 12917.4 12919.4 14111.5 14219.9 14224.8 14258.5 14427.8 5641.4 5698.9 5790.8 5810.4 5860.3 984.7 987.1 1000.0 1019.4 1033.9 22085.3 22561.5 22568.9 23460.9 23792.6 1084.6 1093.9 1117.1 1117.8 1123.9 11818.9 11852.7 12108.2 12116.0 12199.8 218777.0 219129.0 220197.0 220425.0 221003.0 45805.8 45997.8 46228.5 46393.8 46505.8 1378.5 1412.1 1432.6 1443.8 1446.1 21847.2 22100.7 23328.0 23468.3 23808.9 35721.6 35982.5 36021.8 36041.5 36099.6 175046.0 175590.0 176339.0 176617.0 176772.0 31854.8 32453.8 32787.7 33047.7 33331.8 40078.6 40450.8 40575.6 41114.0 41231.6 27367.7 27387.3 27612.6 27815.4 28729.0 26976.0 27058.0 27189.9 27957.2 28213.6 32012.0 33505.2 33807.5 34000.1 34065.0 26821.2 26854.7 26999.0 27110.0 27749.9 23153.3 24066.5 24179.3 24306.8 24434.9 09:49:41 INFO - PID 26990 | 09:49:41 INFO - PID 26990 | [#2] jquery.html Cycles:180 Average:32753.82 Median:2396.91 stddev:81023.01 (3380.3%) stddev-sans-first:81214.24 09:49:41 INFO - PID 26990 | Values: 560.9 565.7 571.6 582.0 589.6 21447.2 22231.4 22294.7 22321.2 22531.9 24067.4 25586.2 25727.0 25874.5 25959.9 6459.1 6613.9 6616.7 6619.1 6627.0 6034.6 6483.4 6541.2 6543.8 6547.2 4048.6 4798.7 6471.4 6481.0 6532.7 6436.2 6491.2 6496.1 6506.6 6525.7 5989.6 6013.3 6023.8 6050.1 6059.4 28451.9 28760.7 29316.6 29416.3 29436.0 1898.9 1914.5 1942.6 1943.1 1943.7 17978.4 18521.4 18533.0 18585.3 18603.9 2322.6 2328.8 2396.1 2397.7 2408.4 126462.0 127763.0 128086.0 128108.4 128977.4 13784.2 14291.4 14477.8 14494.9 15081.0 23462.8 23479.0 23498.5 23561.0 23623.3 9381.3 9573.8 9601.9 9709.1 9716.1 8607.6 8665.8 8696.0 8726.9 8833.7 9011.3 9013.9 9086.7 9240.6 9276.4 2644.8 2687.5 2694.8 2771.8 2789.8 917.2 917.3 933.4 979.9 983.3 17657.6 17836.8 18140.3 18311.8 18514.3 959.5 964.3 988.6 995.9 996.6 9701.3 9947.8 10292.5 12299.8 14074.5 480048.0 480230.0 483172.0 484494.0 489768.0 101501.5 108115.8 108343.0 108574.0 108863.5 1194.5 1221.3 1260.5 1263.3 1266.9 19048.8 21051.7 21228.2 21331.4 21333.0 46091.0 48538.8 48659.5 49264.5 49550.0 61475.0 61702.4 61720.0 61804.4 61924.1 12802.6 12808.1 12877.2 12896.5 12918.7 13551.2 13788.7 16195.0 17432.3 17673.5 13487.9 15234.8 15436.5 15541.9 15560.2 12813.1 13430.0 13477.5 13487.4 14059.8 14613.3 14844.5 14867.9 14869.3 14891.6 11732.4 11768.3 11771.6 11817.2 11827.1 13558.5 14264.1 14338.1 14338.1 14359.0 09:49:41 INFO - PID 26990 | 09:49:41 INFO - PID 26990 | [#3] mootools.html Cycles:180 Average:8005.36 Median:2590.21 stddev:5298.19 (204.5%) stddev-sans-first:5289.11 09:49:41 INFO - PID 26990 | Values: 1301.7 1376.3 1382.9 1387.3 1388.8 12667.2 13176.8 13193.0 13205.8 13239.0 12867.9 13212.3 13317.8 13362.8 13385.4 2546.3 2587.3 2593.1 2601.9 2609.4 2519.0 2584.5 2584.9 2585.1 2586.7 2534.9 2559.6 2574.3 2574.7 2580.4 2495.8 2507.6 2518.2 2520.2 2522.1 2477.6 2491.9 2499.7 2504.1 2505.3 12912.7 13111.0 13178.5 13184.9 13249.4 7141.4 7412.5 7413.0 7420.3 7424.6 4186.2 4327.1 4404.4 4414.8 4418.7 1597.9 1632.2 1633.7 1674.2 1676.3 18266.2 18874.5 20168.5 20182.1 20405.8 5395.3 5501.4 5865.2 6157.6 6189.5 14337.9 14405.3 14462.6 14480.6 14487.5 7098.1 7173.0 7211.4 7212.6 7213.9 6847.8 6912.2 6928.2 6929.4 7055.6 4779.5 4840.3 4945.3 4945.3 4954.6 1283.1 1291.9 1302.9 1314.2 1322.8 891.3 898.6 906.1 922.5 938.2 6907.4 6962.2 7228.6 7337.8 7340.7 705.6 722.9 965.8 986.6 999.4 4777.5 4818.9 4880.3 4976.3 5043.7 16585.1 17260.3 17286.7 17303.5 17347.7 17053.7 17645.1 17706.6 17730.5 17807.9 9851.6 10412.8 10595.8 10619.9 10766.6 7263.4 7376.9 7391.4 7715.0 7792.1 14987.6 15385.2 15488.2 15600.3 15792.9 15402.5 15572.8 15895.1 16130.6 16179.0 9589.0 9695.1 9782.0 9797.6 9860.9 11911.5 12004.5 12096.2 12228.0 12262.8 8994.8 9310.2 9324.0 9730.7 9849.1 9203.3 9545.7 9666.9 9772.7 9781.5 8324.8 9125.4 9462.1 9469.0 9475.8 6184.6 6216.0 6352.6 6442.4 6544.4 6680.9 6865.2 6896.1 6987.4 7089.4 09:49:41 INFO - PID 26990 | 09:49:41 INFO - PID 26990 | [#4] prototype.html Cycles:180 Average:5549.36 Median:6150.41 stddev:1555.98 (25.3%) stddev-sans-first:1513.24 09:49:41 INFO - PID 26990 | Values: 487.4 495.5 512.4 521.1 526.8 6201.2 6227.8 6258.7 6309.7 6314.4 6185.8 6196.1 6201.6 6218.2 6232.9 5131.7 5132.3 5144.3 5165.0 5176.0 5144.0 5154.4 5161.2 5162.5 5169.7 4768.9 4943.9 4949.0 5143.0 5163.4 4917.6 4926.8 4935.2 4948.9 5006.6 4425.8 4428.3 4430.7 4457.4 4477.1 6070.3 6089.6 6107.7 6109.9 6115.0 5769.9 5770.2 5774.6 5774.9 5778.4 6579.2 6613.7 6618.8 6636.6 6639.6 4916.6 4922.1 4933.8 4943.1 4950.1 6677.7 6903.4 6915.1 6937.1 7039.5 4779.1 4974.3 5011.4 5014.7 5045.7 5031.8 5069.9 5073.8 5079.5 5083.4 5646.6 5688.4 5703.7 5703.8 5709.9 6600.5 6609.7 6609.9 6612.4 6625.9 1751.6 1756.2 1759.2 1762.5 1766.5 1142.3 1225.2 1231.6 1237.3 1262.1 5745.5 5764.2 5812.3 5819.4 5839.6 6691.7 6722.8 6771.9 6787.5 6819.1 5845.4 5846.9 5865.9 5867.7 5873.8 3632.0 3642.5 3644.4 3647.0 3653.8 6581.0 6583.8 6588.1 6589.3 6612.7 6957.4 6963.3 6970.0 6973.8 7006.0 6552.2 6556.3 6571.3 6571.9 6577.2 6786.5 6797.5 6801.6 6814.3 6820.9 6085.0 6713.4 6726.7 6735.2 6753.6 6493.6 6513.3 6520.4 6532.0 6535.8 4984.9 5007.4 5008.0 5031.9 5049.0 6534.5 6686.5 6736.9 6823.4 6838.7 6449.2 6512.0 6575.6 6576.7 6617.0 6508.8 6524.8 6554.2 6589.7 6621.2 6421.6 6455.3 6469.4 6496.9 6519.1 6596.6 6604.0 6614.4 6629.6 6642.4 6384.7 6404.7 6421.7 6429.3 6477.6 09:49:41 INFO - PID 26990 | 09:49:41 INFO - PID 26990 | [#5] yui.html Cycles:180 Average:20027.88 Median:18698.17 stddev:26177.08 (140.0%) stddev-sans-first:26210.90 09:49:41 INFO - PID 26990 | Values: 849.4 868.7 872.1 876.5 891.4 17705.9 18060.3 18235.1 18351.4 18368.5 16518.5 16523.8 16580.1 17325.7 18938.2 1026.6 1043.4 1046.4 1050.3 1051.1 1046.1 1054.6 1055.2 1057.5 1059.8 1099.6 1101.3 1101.8 1103.4 1108.5 1027.9 1087.2 1092.0 1093.0 1093.4 793.9 794.3 794.4 795.4 797.2 18521.4 18651.5 18665.7 18688.5 18707.8 18532.5 19527.8 19573.0 19718.7 19868.9 14295.8 14878.6 14896.3 14906.9 15089.4 3555.9 3570.6 3577.0 3585.6 3593.7 91618.0 96264.0 97073.5 100887.0 102145.0 14436.7 14827.0 15138.1 15168.5 15212.8 26024.2 27636.3 27879.2 28015.6 28161.2 7830.4 7898.6 7943.7 7959.4 8003.2 3894.7 4011.3 4035.9 4043.8 4046.2 4706.8 4790.5 4800.4 4801.3 4824.0 886.2 890.1 904.2 911.2 961.0 632.1 632.7 647.9 655.2 673.6 10869.6 11441.9 11675.1 12043.8 12462.4 580.0 595.4 598.5 602.2 620.6 4878.9 4953.9 5057.3 5133.1 5219.2 91955.5 94962.5 97433.5 98715.5 98762.1 66781.7 87228.0 87471.0 88198.6 89588.6 64347.0 73849.7 73945.0 76781.6 76872.0 10759.2 10838.6 10952.0 11236.7 11361.0 32380.8 33453.0 33510.2 34115.3 34790.3 43034.6 43782.0 43819.0 44427.1 44516.0 16207.4 16212.6 16213.7 16249.9 16589.4 17770.8 17825.0 18498.4 18504.9 18684.3 16726.3 17073.9 17108.3 17159.1 17557.3 15804.7 16193.0 16494.3 16512.2 16516.3 13934.4 14663.8 14899.9 15002.3 15156.5 10055.9 10262.3 10351.5 10382.4 10499.0 12074.4 12480.8 12488.1 12739.3 12908.7 09:49:41 INFO - PID 26990 | -------- Summary: end -------- 09:49:41 INFO - PID 26990 | 09:49:42 INFO - TEST-INFO | 26990: exit 0 09:49:42 INFO - TEST-OK | dromaeo_css | took 1117439ms 09:49:42 INFO - TEST-START | kraken 09:49:42 INFO - operating with platform_type : linux_ 09:49:42 INFO - Initialising browser for kraken test... 09:49:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40892/getInfo.html -profile /tmp/tmp5tEN9v/profile 09:49:42 INFO - TEST-INFO | started process 27411 (/builds/slave/test/build/application/firefox/firefox http://localhost:40892/getInfo.html) 09:49:48 INFO - TEST-INFO | 27411: exit 0 09:49:48 INFO - Browser initialized. 09:49:48 INFO - Running cycle 1/1 for kraken test... 09:49:48 INFO - TEST-INFO | started process 27641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5tEN9v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:50:00 INFO - PID 27641 | RSS: Main: 172343296 09:50:00 INFO - PID 27641 | 09:50:02 INFO - PID 27641 | Cycle 1(1): loaded http://localhost:40892/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40892/tests/kraken/driver.html?testName=audio-beat-detection) 09:50:03 INFO - PID 27641 | RSS: Main: 175919104 09:50:03 INFO - PID 27641 | 09:50:06 INFO - PID 27641 | Cycle 1(1): loaded http://localhost:40892/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40892/tests/kraken/driver.html?testName=audio-dft) 09:50:06 INFO - PID 27641 | RSS: Main: 176705536 09:50:06 INFO - PID 27641 | 09:50:09 INFO - PID 27641 | Cycle 1(1): loaded http://localhost:40892/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40892/tests/kraken/driver.html?testName=audio-fft) 09:50:10 INFO - PID 27641 | RSS: Main: 171479040 09:50:10 INFO - PID 27641 | 09:50:12 INFO - PID 27641 | Cycle 1(1): loaded http://localhost:40892/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40892/tests/kraken/driver.html?testName=audio-oscillator) 09:50:13 INFO - PID 27641 | RSS: Main: 172535808 09:50:13 INFO - PID 27641 | 09:50:15 INFO - PID 27641 | Cycle 1(1): loaded http://localhost:40892/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40892/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:50:15 INFO - PID 27641 | RSS: Main: 172531712 09:50:15 INFO - PID 27641 | 09:50:19 INFO - PID 27641 | Cycle 1(1): loaded http://localhost:40892/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40892/tests/kraken/driver.html?testName=imaging-darkroom) 09:50:19 INFO - PID 27641 | RSS: Main: 176205824 09:50:19 INFO - PID 27641 | 09:50:23 INFO - PID 27641 | Cycle 1(1): loaded http://localhost:40892/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40892/tests/kraken/driver.html?testName=imaging-desaturate) 09:50:23 INFO - PID 27641 | RSS: Main: 177168384 09:50:23 INFO - PID 27641 | 09:50:26 INFO - PID 27641 | Cycle 1(1): loaded http://localhost:40892/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40892/tests/kraken/driver.html?testName=json-parse-financial) 09:50:27 INFO - PID 27641 | RSS: Main: 176685056 09:50:27 INFO - PID 27641 | 09:50:28 INFO - PID 27641 | Cycle 1(1): loaded http://localhost:40892/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40892/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:50:29 INFO - PID 27641 | RSS: Main: 176447488 09:50:29 INFO - PID 27641 | 09:50:31 INFO - PID 27641 | Cycle 1(1): loaded http://localhost:40892/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40892/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:50:31 INFO - PID 27641 | RSS: Main: 176271360 09:50:31 INFO - PID 27641 | 09:50:33 INFO - PID 27641 | Cycle 1(1): loaded http://localhost:40892/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40892/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:50:34 INFO - PID 27641 | RSS: Main: 176300032 09:50:34 INFO - PID 27641 | 09:50:37 INFO - PID 27641 | Cycle 1(1): loaded http://localhost:40892/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40892/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:50:37 INFO - PID 27641 | RSS: Main: 176029696 09:50:37 INFO - PID 27641 | 09:50:40 INFO - PID 27641 | Cycle 1(1): loaded http://localhost:40892/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40892/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:50:41 INFO - PID 27641 | RSS: Main: 176209920 09:50:41 INFO - PID 27641 | 09:50:43 INFO - PID 27641 | Cycle 1(1): loaded http://localhost:40892/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40892/tests/kraken/driver.html?testName=ai-astar) 09:50:43 INFO - PID 27641 | RSS: Main: 178139136 09:50:43 INFO - PID 27641 | 09:50:43 INFO - PID 27641 | __start_tp_report 09:50:43 INFO - PID 27641 | _x_x_mozilla_page_load 09:50:43 INFO - PID 27641 | _x_x_mozilla_page_load_details 09:50:43 INFO - PID 27641 | |i|pagename|runs| 09:50:43 INFO - PID 27641 | |0;ai-astar;101;107;108;106;113;109;109;110;110;111 09:50:43 INFO - PID 27641 | |1;audio-beat-detection;150;119;149;168;128;148;152;122;172;126 09:50:43 INFO - PID 27641 | |2;audio-dft;164;162;164;162;162;172;161;164;164;164 09:50:43 INFO - PID 27641 | |3;audio-fft;73;75;75;158;75;74;74;75;99;73 09:50:43 INFO - PID 27641 | |4;audio-oscillator;82;82;135;82;82;92;148;83;82;134 09:50:43 INFO - PID 27641 | |5;imaging-gaussian-blur;114;114;113;114;114;113;114;114;113;113 09:50:43 INFO - PID 27641 | |6;imaging-darkroom;150;150;149;150;150;149;150;150;149;152 09:50:43 INFO - PID 27641 | |7;imaging-desaturate;94;94;94;95;94;94;95;94;95;94 09:50:43 INFO - PID 27641 | |8;json-parse-financial;56;60;52;56;53;56;53;53;53;53 09:50:43 INFO - PID 27641 | |9;json-stringify-tinderbox;55;52;53;53;53;53;52;53;53;53 09:50:43 INFO - PID 27641 | |10;stanford-crypto-aes;77;78;77;78;77;77;77;83;77;77 09:50:43 INFO - PID 27641 | |11;stanford-crypto-ccm;143;133;128;130;129;130;128;126;130;165 09:50:43 INFO - PID 27641 | |12;stanford-crypto-pbkdf2;186;187;190;199;186;182;182;189;183;189 09:50:43 INFO - PID 27641 | |13;stanford-crypto-sha256-iterative;73;68;68;69;67;77;71;72;68;67 09:50:43 INFO - PID 27641 | __end_tp_report 09:50:43 INFO - PID 27641 | __start_cc_report 09:50:43 INFO - PID 27641 | _x_x_mozilla_cycle_collect,957 09:50:43 INFO - PID 27641 | __end_cc_report 09:50:43 INFO - PID 27641 | __startTimestamp1498323043544__endTimestamp 09:50:43 INFO - PID 27641 | 09:50:43 INFO - PID 27641 | ------- Summary: start ------- 09:50:43 INFO - PID 27641 | Number of tests: 14 09:50:43 INFO - PID 27641 | 09:50:43 INFO - PID 27641 | [#0] ai-astar Cycles:10 Average:108.40 Median:109.50 stddev:3.27 (3.0%) stddev-sans-first:2.11 09:50:43 INFO - PID 27641 | Values: 101.0 107.0 108.0 106.0 113.0 109.0 109.0 110.0 110.0 111.0 09:50:43 INFO - PID 27641 | 09:50:43 INFO - PID 27641 | [#1] audio-beat-detection Cycles:10 Average:143.40 Median:149.50 stddev:18.82 (12.6%) stddev-sans-first:19.81 09:50:43 INFO - PID 27641 | Values: 150.0 119.0 149.0 168.0 128.0 148.0 152.0 122.0 172.0 126.0 09:50:43 INFO - PID 27641 | 09:50:43 INFO - PID 27641 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:3.07 (1.9%) stddev-sans-first:3.26 09:50:43 INFO - PID 27641 | Values: 164.0 162.0 164.0 162.0 162.0 172.0 161.0 164.0 164.0 164.0 09:50:43 INFO - PID 27641 | 09:50:43 INFO - PID 27641 | [#3] audio-fft Cycles:10 Average:85.10 Median:75.00 stddev:26.78 (35.7%) stddev-sans-first:28.05 09:50:43 INFO - PID 27641 | Values: 73.0 75.0 75.0 158.0 75.0 74.0 74.0 75.0 99.0 73.0 09:50:43 INFO - PID 27641 | 09:50:43 INFO - PID 27641 | [#4] audio-oscillator Cycles:10 Average:100.20 Median:82.00 stddev:27.20 (33.2%) stddev-sans-first:28.04 09:50:43 INFO - PID 27641 | Values: 82.0 82.0 135.0 82.0 82.0 92.0 148.0 83.0 82.0 134.0 09:50:43 INFO - PID 27641 | 09:50:43 INFO - PID 27641 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:50:43 INFO - PID 27641 | Values: 114.0 114.0 113.0 114.0 114.0 113.0 114.0 114.0 113.0 113.0 09:50:43 INFO - PID 27641 | 09:50:43 INFO - PID 27641 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:150.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 09:50:43 INFO - PID 27641 | Values: 150.0 150.0 149.0 150.0 150.0 149.0 150.0 150.0 149.0 152.0 09:50:43 INFO - PID 27641 | 09:50:43 INFO - PID 27641 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 09:50:43 INFO - PID 27641 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 95.0 94.0 95.0 94.0 09:50:43 INFO - PID 27641 | 09:50:43 INFO - PID 27641 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.50 stddev:2.46 (4.5%) stddev-sans-first:2.55 09:50:43 INFO - PID 27641 | Values: 56.0 60.0 52.0 56.0 53.0 56.0 53.0 53.0 53.0 53.0 09:50:43 INFO - PID 27641 | 09:50:43 INFO - PID 27641 | [#9] json-stringify-tinderbox Cycles:10 Average:53.00 Median:53.00 stddev:0.82 (1.5%) stddev-sans-first:0.44 09:50:43 INFO - PID 27641 | Values: 55.0 52.0 53.0 53.0 53.0 53.0 52.0 53.0 53.0 53.0 09:50:43 INFO - PID 27641 | 09:50:43 INFO - PID 27641 | [#10] stanford-crypto-aes Cycles:10 Average:77.80 Median:77.00 stddev:1.87 (2.4%) stddev-sans-first:1.96 09:50:43 INFO - PID 27641 | Values: 77.0 78.0 77.0 78.0 77.0 77.0 77.0 83.0 77.0 77.0 09:50:43 INFO - PID 27641 | 09:50:43 INFO - PID 27641 | [#11] stanford-crypto-ccm Cycles:10 Average:134.20 Median:130.00 stddev:11.79 (9.1%) stddev-sans-first:12.07 09:50:43 INFO - PID 27641 | Values: 143.0 133.0 128.0 130.0 129.0 130.0 128.0 126.0 130.0 165.0 09:50:43 INFO - PID 27641 | 09:50:43 INFO - PID 27641 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.30 Median:188.00 stddev:5.03 (2.7%) stddev-sans-first:5.32 09:50:43 INFO - PID 27641 | Values: 186.0 187.0 190.0 199.0 186.0 182.0 182.0 189.0 183.0 189.0 09:50:43 INFO - PID 27641 | 09:50:43 INFO - PID 27641 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:3.23 (4.6%) stddev-sans-first:3.24 09:50:43 INFO - PID 27641 | Values: 73.0 68.0 68.0 69.0 67.0 77.0 71.0 72.0 68.0 67.0 09:50:43 INFO - PID 27641 | -------- Summary: end -------- 09:50:43 INFO - PID 27641 | 09:50:44 INFO - TEST-INFO | 27641: exit 0 09:50:44 INFO - TEST-OK | kraken | took 62006ms 09:50:44 INFO - SUITE-END | took 1179s 09:50:44 INFO - Completed test suite (00:19:39) 09:50:44 INFO - javascript benchmark 09:50:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8040.9283825004, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3106.223444138965, 3117.2206948262933, 3145.24514116612, 3145.2765863851314, 3176.8411579421036, 6028.125921741344, 6131.743695907012, 6132.722655450949, 6137.193127861517, 6145.2011238539035, 6143.84965262158, 6191.257049154096, 6195.31851496335, 6196.876062478759, 6204.131421600968, 5696.458836410535, 5709.257796486451, 5712.057510510761, 5765.1352297155345, 5794.855128621776, 5527.364353099405, 5624.887502249973, 5697.886042279152, 5717.656940583557, 5734.713264336767, 5586.91619625706, 5637.689927054011, 5641.12562552805, 5661.631993920382, 5668.773249070032, 5662.462066103713, 5665.235193248941, 5669.291338582677, 5670.68811215383, 5673.26247587815, 5570.442955704438, 5606.719664016783, 5642.238297829782, 5661.2357331760095, 5715.571332150105, 6102.603330783485, 6115.9694201529155, 6139.8601398601395, 6142.8057410146475, 6192.969035154841, 6648.501362397791, 6678.866422671519, 6693.5649182803445, 6708.396244338033, 6722.025306330604, 6504.1869766279215, 6621.0, 6742.662866856637, 6771.1874575050815, 6774.864502709967, 6081.756729730761, 6125.662799505688, 6134.926457743815, 6139.737467782837, 6141.6007959482495, 6847.0, 6868.62222577763, 6892.0, 6901.62041087735, 6903.240643529208, 6520.934790652128, 6540.8364790880605, 6544.411003009752, 6564.310747371553, 6585.9012114818315, 6624.0, 6643.5017373697165, 6682.231543372477, 6692.732290708414, 6698.732050718014, 6429.807105786834, 6551.0500977358015, 6562.934370656328, 6621.569597976116, 6667.933320666828, 6310.7475700971445, 6331.461825744771, 6343.175387199634, 6385.169927909342, 6425.0, 5356.732163391893, 5385.946140538623, 5391.946080539223, 5400.891982160335, 5439.129739241703, 4549.863504094882, 4558.908821823611, 4570.588647021784, 4580.312953057001, 4584.564466375689, 5783.739731712083, 5790.507806836466, 5801.361850196475, 5807.622504537191, 5814.767409303665, 6483.578567393104, 6572.474202063823, 6584.835379115465, 6587.440067594308, 6683.331666833278, 5792.189093526909, 5795.710214489259, 5798.043322851767, 5812.215350927655, 5862.530997520188, 5843.620164689281, 5878.382769809194, 5908.468237858613, 5917.852053698692, 5928.110783382441, 6443.83890402725, 6443.96778016107, 6448.167612431242, 6470.935290647033, 6486.643234622141, 6458.095866578588, 6507.6746162692625, 6510.544261901621, 6638.601683898982, 6643.1031810704935, 6466.127072845294, 6497.350264973465, 6500.6424646643, 6523.445507131757, 6536.0, 6526.216853977553, 6594.439472644879, 6599.5050371223315, 6610.239822420291, 6641.738069766729, 6744.123263975652, 6753.054572359972, 6764.3573860483175, 6768.898466522907, 6770.221424536241, 6284.811455656338, 6383.297837237993, 6514.706838192198, 6534.150560427114, 6566.277709451861, 6388.744450221939, 6402.327755585597, 6409.551331406943, 6478.449331806849, 6507.12153859223, 6375.553711240169, 6375.74497020114, 6492.0, 6492.285848556749, 6511.38141876521, 6608.43828274602, 6617.338266173344, 6620.205575330991, 6620.933790662224, 6637.971114477264, 6401.7119229633845, 6404.295527491879, 6405.423511883952, 6409.839754006187, 6428.550001500037], "value": 6059.118617063208, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [790.9920900790991, 830.9127541608127, 853.4111463090468, 883.4346018548131, 883.6907082521118, 37714.24571508568, 39046.804765976165, 39182.41226381603, 39291.41062884059, 39327.80336098323, 35972.460413093824, 36250.093747656254, 36305.27389452216, 36390.27219455616, 36427.63572364282, 6771.966140169292, 6853.657317134148, 6863.794086177422, 6896.931030689679, 6933.098697169361, 6822.556533825285, 6852.0, 6894.965525172367, 6901.689423975933, 6928.44572434204, 6866.0, 6867.484938629598, 6876.518643694943, 6894.034835123087, 6901.896471552931, 6808.557443766164, 6854.931450685529, 6860.5197636165485, 6866.14173228349, 6894.655267236643, 6237.96881015592, 6280.78017269398, 6285.025820997753, 6302.842428939267, 6303.936960630381, 32522.83738581292, 32807.83596082004, 36891.63108368935, 37408.0, 37424.43863342052, 3555.2711694102645, 3600.837962291703, 3609.079684680416, 3611.7291203159866, 3612.3678356287805, 29364.706352936624, 29619.407611847644, 29622.0, 29629.555556666666, 29712.0, 3685.6682898538993, 3700.40793473043, 3724.5902950675404, 3726.1988672435555, 3775.0751065989007, 186748.0, 187297.0, 188099.0, 191111.0, 191954.9999999986, 47198.52801471941, 47539.52460475351, 47711.28433073506, 48017.519824801304, 48081.27878081831, 49916.50083499191, 50078.49921500738, 50290.74854625703, 50295.0, 50338.24492632614, 15204.543863684106, 15453.0, 15463.458778942908, 15549.30028148736, 15559.45541906028, 12837.807432888514, 12885.162464439969, 12894.548690795777, 12917.418716157796, 12919.418626161845, 14111.518290579546, 14219.928900355431, 14224.786628200585, 14258.500952466615, 14427.78358324626, 5641.351244606923, 5698.886022279531, 5790.826275211751, 5810.448007439287, 5860.296764388216, 984.6602921991902, 987.0918754745508, 999.9550020249106, 1019.4494972714651, 1033.9172866170838, 22085.33743987683, 22561.533500322428, 22568.91495601173, 23460.882695586413, 23792.643110353358, 1084.6258040975852, 1093.8960798724108, 1117.0728295514866, 1117.7708569743183, 1123.8707548631849, 11818.940905295418, 11852.703682407837, 12108.152429330039, 12115.956762898704, 12199.817002744965, 218777.0, 219129.0, 220197.0, 220425.0, 221003.0, 45805.7709711456, 45997.77001114973, 46228.5377146231, 46393.7680311603, 46505.767471163104, 1378.4555100735154, 1412.0680350968516, 1432.6060333408188, 1443.826740791112, 1446.0600609603841, 21847.235346762787, 22100.668489972984, 23328.0, 23468.295951121494, 23808.880955595112, 35721.64278357287, 35982.46026309555, 36021.81989090038, 36041.459378109874, 36099.639003610675, 175046.0, 175590.0, 176339.0, 176617.0, 176772.0, 31854.840725796224, 32453.837730811196, 32787.67212327846, 33047.66952330542, 33331.83334083411, 40078.59921400749, 40450.797746011085, 40575.59424405718, 41114.0, 41231.58768412397, 27367.72632273652, 27387.31531711723, 27612.585811212448, 27815.443691126467, 28728.983456736743, 26976.0, 27058.0, 27189.86405067962, 27957.161285161477, 28213.576796348483, 32012.0, 33505.162370940925, 33807.4928876072, 34000.14999625029, 34065.0, 26821.195364138326, 26854.731452686006, 26999.038607004408, 27110.0, 27749.86125069362, 23153.305400838002, 24066.51866962616, 24179.274621761375, 24306.75693243045, 24434.87782561147], "value": 16047.959312903717, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.8766071464279, 565.6577770448881, 571.6427232979388, 581.9709014549271, 589.5725598940769, 21447.249346272863, 22231.44421389466, 22294.665580016313, 22321.218757343497, 22531.887340563273, 24067.398315042134, 25586.232413027592, 25727.0, 25874.482510349782, 25959.870200649017, 6459.09572659828, 6613.93386066138, 6616.735330586771, 6619.139511863451, 6627.0, 6034.6120392309795, 6483.384078512558, 6541.247756507991, 6543.770968016121, 6547.214334279869, 4048.5951404859575, 4798.736069516175, 6471.449926756231, 6480.995445705923, 6532.673366331688, 6436.163298771176, 6491.221053473566, 6496.123023391852, 6506.577072490297, 6525.6737163142125, 5989.580729348947, 6013.308469525973, 6023.759049638009, 6050.122732203849, 6059.424354686298, 28451.857740711162, 28760.712392876012, 29316.560251596242, 29416.264593385124, 29436.0, 1898.905054747271, 1914.4926594452481, 1942.5726340205133, 1943.1255934829383, 1943.7084437334372, 17978.37075702357, 18521.444356669323, 18532.96137424882, 18585.34951276699, 18603.906980465148, 2322.6296485073717, 2328.836981411302, 2396.101461951768, 2397.7122745270503, 2408.385861605297, 126462.0, 127763.0, 128085.99999999907, 128108.35945820305, 128977.35511322384, 13784.172949622855, 14291.356888940023, 14477.755947828104, 14494.912881533926, 15081.0, 23462.7653723464, 23479.0, 23498.53002939966, 23561.0, 23623.29130126099, 9381.29640276982, 9573.760655983657, 9601.903980960102, 9709.077637624414, 9716.125548700651, 8607.569621518898, 8665.81208944138, 8696.04343522212, 8726.912730872737, 8833.734987950373, 9011.27909767217, 9013.864792028126, 9086.681966131153, 9240.610709912871, 9276.443413395218, 2644.761971422581, 2687.543117670001, 2694.811363204596, 2771.8422366450322, 2789.838798223311, 917.1793988931964, 917.3440989692402, 933.4072863731444, 979.9020097990286, 983.3362480325894, 17657.646847063243, 17836.821631783518, 18140.274389024555, 18311.816881831277, 18514.259429622663, 959.467495539968, 964.2816102004052, 988.619381538113, 995.9452230127413, 996.6312464388078, 9701.272404569545, 9947.751306217258, 10292.485375731183, 12299.754004919852, 14074.507392241223, 480048.0, 480230.0, 483172.0, 484494.0, 489768.0, 101501.49249253854, 108115.83768324589, 108343.0, 108574.0, 108863.45568272266, 1194.4923407551755, 1221.2855479544567, 1260.4769020856425, 1263.2546797389584, 1266.860645329013, 19048.80951190526, 21051.684224736335, 21228.150873965486, 21331.36005919825, 21333.0, 46091.0, 48538.757306214655, 48659.51340486691, 49264.50735492599, 49550.0, 61475.0, 61702.38297617146, 61720.0, 61804.38195617986, 61924.07113893205, 12802.615921522369, 12808.103432759617, 12877.162984405984, 12896.548620798227, 12918.741625167631, 13551.186928784304, 13788.655283617989, 16195.0, 17432.30270789205, 17673.469795906145, 13487.865121348661, 15234.781217502352, 15436.45972390961, 15541.922290388477, 15560.221988900283, 12813.103082784115, 13430.0, 13477.460901563827, 13487.393067311797, 14059.789103163255, 14613.342399592257, 14844.480443184437, 14867.92566037163, 14869.330880110638, 14891.627709307353, 11732.41337933117, 11768.293902365886, 11771.587994420153, 11817.231879927776, 11827.112966527717, 13558.525451609541, 14264.144151350953, 14338.068025578305, 14338.139711617336, 14358.994870358974], "value": 11157.550336112765, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1301.739652069586, 1376.2843321472835, 1382.9351399422444, 1387.271682366758, 1388.8055672205887, 12667.176633518826, 13176.802347964776, 13193.0, 13205.801912971314, 13239.0, 12867.871321286784, 13212.273324967124, 13317.800232996513, 13362.799558006638, 13385.39765710543, 2546.337952132445, 2587.2884956636885, 2593.1313010141625, 2601.9219423417326, 2609.425926296212, 2519.0427637497723, 2584.4572639745675, 2584.8578328191943, 2585.0952166741677, 2586.741325867408, 2534.911278105267, 2559.5648739714293, 2574.3178057814694, 2574.7425257474197, 2580.3678098865803, 2495.7878580320603, 2507.5862482690336, 2518.1941778630844, 2520.193538067819, 2522.1298651965044, 2477.55404027275, 2491.8504889706674, 2499.700035995674, 2504.0860086068456, 2505.348609361561, 12912.741745165138, 13111.0, 13178.472861085545, 13184.86815131846, 13249.403776830066, 7141.39298159657, 7412.518186317872, 7413.0, 7420.295071968154, 7424.628768561551, 4186.204621122008, 4327.112941846914, 4404.4054052702795, 4414.823407063714, 4418.734875907424, 1597.9280932358072, 1632.2002218912767, 1633.746769250768, 1674.2047527424497, 1676.3294682127125, 18266.178021989042, 18874.52813679655, 20168.49578760528, 20182.09180586877, 20405.79594204054, 5395.298611180521, 5501.367342755554, 5865.178874957509, 6157.568970172045, 6189.473894718999, 14337.85662143386, 14405.3433855108, 14462.638434039023, 14480.565583032527, 14487.49293774734, 7098.077249957472, 7173.031640728539, 7211.350978411968, 7212.567245965259, 7213.89179162313, 6847.828804279833, 6912.205096413876, 6928.203256625452, 6929.41100006495, 7055.576665400093, 4779.450363208206, 4840.273958906122, 4945.282933974553, 4945.307656928033, 4954.603631709527, 1283.0954177304977, 1291.9354032298347, 1302.856685764565, 1314.18520517278, 1322.8015797630433, 891.2558014058204, 898.6360523987795, 906.1346414174448, 922.4741897118578, 938.2306508662967, 6907.378335949788, 6962.2341542430295, 7228.63856807168, 7337.816554586071, 7340.706371745177, 705.5519744961883, 722.9457790665721, 965.792354643755, 986.5511192407438, 999.3554157568328, 4777.546133117417, 4818.855434336975, 4880.341153944243, 4976.278439626234, 5043.672161309503, 16585.087820169767, 17260.309587616353, 17286.740698889527, 17303.480895573153, 17347.653046939242, 17053.7441938371, 17645.117744112744, 17706.5573360667, 17730.468085957444, 17807.910960445115, 9851.556679949419, 10412.843807342895, 10595.84106238407, 10619.893801061891, 10766.56933722658, 7263.382612477999, 7376.926230737624, 7391.445641576795, 7715.0, 7792.064952205772, 14987.625309367353, 15385.153816540198, 15488.225588720745, 15600.297986590404, 15792.92103539475, 15402.46091386796, 15572.84427155714, 15895.125768082866, 16130.596735081717, 16179.0, 9589.041095890356, 9695.127438530566, 9782.0, 9797.608095676092, 9860.85208721884, 11911.463984120563, 12004.459799309227, 12096.153269271066, 12228.0, 12262.816057759319, 8994.820103598022, 9310.208632266062, 9324.0, 9730.659426920023, 9849.113579777855, 9203.263738900738, 9545.665901693408, 9666.854997174907, 9772.706818795448, 9781.510924453607, 8324.791880203044, 9125.361224714206, 9462.148406643435, 9468.95265523668, 9475.763105922131, 6184.567080304336, 6216.0, 6352.555321127476, 6442.35576442352, 6544.411003009752, 6680.899786503303, 6865.244823069358, 6896.137982752156, 6987.406070484066, 7089.432845372255], "value": 5920.743341848614, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.3706789628052, 495.4896456649652, 512.3723438787483, 521.0568870344676, 526.7883867105656, 6201.162843016192, 6227.750889964396, 6258.687065646716, 6309.716062777175, 6314.368563143684, 6185.845353866155, 6196.101565273033, 6201.596896201744, 6218.22272215973, 6232.875342493158, 5131.743412829363, 5132.307138536287, 5144.305518754958, 5165.018646457161, 5175.974120129404, 5143.974280128594, 5154.4072431670465, 5161.17421212606, 5162.457941916101, 5169.663971841837, 4768.90462190756, 4943.851684449454, 4949.034938187055, 5142.971405718852, 5163.432022477525, 4917.582005529534, 4926.802927882881, 4935.185694360426, 4948.87627809304, 5006.599472042228, 4425.7565833879125, 4428.335749637548, 4430.667699922518, 4457.420535330419, 4477.126960242754, 6070.301915279755, 6089.604175728564, 6107.694615269219, 6109.877802443926, 6114.969425152845, 5769.884602307972, 5770.249867517238, 5774.595778295521, 5774.88450230993, 5778.38205302516, 6579.243387010507, 6613.669316534202, 6618.834529136762, 6636.634985075819, 6639.634820084893, 4916.557509824133, 4922.089413458521, 4933.753312334369, 4943.134951383529, 4950.108980383529, 6677.666116694146, 6903.447724182053, 6915.135608048994, 6937.132858392701, 7039.472039597, 4779.139754844162, 4974.27872958419, 5011.448740638527, 5014.749262536859, 5045.722485263345, 5031.84904452867, 5069.949300506948, 5073.847784566469, 5079.5428411443145, 5083.415407228216, 5646.628416065262, 5688.431156884279, 5703.74333155009, 5703.800366987219, 5709.857253568694, 6600.471962243009, 6609.6695165241545, 6609.900851487231, 6612.371824676648, 6625.867482650417, 1751.5621094726318, 1756.1658212349287, 1759.155605309433, 1762.4712586224082, 1766.5053784940237, 1142.2689478733616, 1225.154643296123, 1231.648980040702, 1237.2761934268374, 1262.0786825617167, 5745.482906538432, 5764.221830052889, 5812.273465816773, 5819.388964158702, 5839.620424672383, 6691.7323307068145, 6722.764703235363, 6771.8984215236815, 6787.490938179656, 6819.113515243086, 5845.357010728816, 5846.912296315559, 5865.941340586625, 5867.677277749679, 5873.765049397976, 3631.9636803631624, 3642.453631955175, 3644.362236608583, 3647.0, 3653.780773153619, 6580.967095164494, 6583.83540411484, 6588.077669126326, 6589.341065893373, 6612.669366531654, 6957.408620267232, 6963.303669633097, 6970.0, 6973.825654358681, 7006.0, 6552.213734351908, 6556.2788093310655, 6571.310012448624, 6571.934280657228, 6577.218099592657, 6786.491013174131, 6797.490188236001, 6801.557898736566, 6814.274290283728, 6820.863582728417, 6085.020575380707, 6713.395794378529, 6726.663666816542, 6735.158105236846, 6753.628550429774, 6493.642849643126, 6513.348665133449, 6520.445762110084, 6531.967340163459, 6535.771248006297, 4984.900301993867, 5007.39911210657, 5007.974960125176, 5031.9245211322595, 5048.960831334991, 6534.542582019213, 6686.498512611476, 6736.932630673827, 6823.38589526945, 6838.7264509419065, 6449.1616089909885, 6512.037023154358, 6575.572587781779, 6576.671166441754, 6617.0, 6508.772192973223, 6524.771632992823, 6554.2462616797775, 6589.7364105435245, 6621.238557565942, 6421.5825971311715, 6455.2576453708425, 6469.353064693493, 6496.9025464617125, 6519.08732777421, 6596.637184954873, 6604.0, 6614.404703576702, 6629.635370054693, 6642.43539299165, 6384.712687928962, 6404.71178796946, 6421.743130274736, 6429.32492088324, 6477.643729594917], "value": 5088.65651134656, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [849.4478588917207, 868.6655637579534, 872.097379212515, 876.4960147914951, 891.4294851295168, 17705.911470442647, 18060.277588896446, 18235.088245587718, 18351.357702480414, 18368.540786480313, 16518.504444866674, 16523.752143717855, 16580.088095154762, 17325.7401138983, 18938.242470301208, 1026.5944951744075, 1043.353121064937, 1046.4296958157822, 1050.3120456101228, 1051.085555566658, 1046.0637729232333, 1054.5623566220047, 1055.2244100586101, 1057.471264367816, 1059.7986382587321, 1099.631623406156, 1101.300674071962, 1101.8237082066871, 1103.3931337764197, 1108.501174471487, 1027.8509616105623, 1087.190043417651, 1091.9672409827679, 1092.956281748729, 1093.3877028863822, 793.888855560222, 794.285143370965, 794.3803833010261, 795.3915254830059, 797.2027972027972, 18521.351752688726, 18651.533711657183, 18665.720014199796, 18688.53278668044, 18707.812921870744, 18532.536686582807, 19527.80472195274, 19573.021348932496, 19718.70421943672, 19868.900655496775, 14295.78556321656, 14878.553643390716, 14896.329665165094, 14906.925465372713, 15089.39642414302, 3555.9111022224392, 3570.6429357064344, 3577.0, 3585.5697316322207, 3593.694535964446, 91618.0, 96264.0, 97073.51463242639, 100887.0, 102145.0, 14436.711265774626, 14827.0, 15138.091714497166, 15168.469103581321, 15212.771808422882, 26024.219273421826, 27636.30909227245, 27879.163625091278, 28015.579766303523, 28161.155165345073, 7830.373570114377, 7898.644560994769, 7943.682252709827, 7959.403044771665, 8003.159668234868, 3894.7468414552964, 4011.3180759270995, 4035.9192816143513, 4043.81802818868, 4046.1705350403095, 4706.811727530929, 4790.520947905251, 4800.35195248644, 4801.303810947393, 4824.035192961352, 886.189136939693, 890.1098901098901, 904.2268860124499, 911.2436677557744, 961.0293603460416, 632.1024145713099, 632.7342516143231, 647.8833809914166, 655.2039272284197, 673.6295037729229, 10869.619563315404, 11441.942790286163, 11675.12436567261, 12043.759124817454, 12462.43919023646, 580.0481232429414, 595.4402861310355, 598.4763332084426, 602.1569802276847, 620.5811077522654, 4878.902421951541, 4953.876153096201, 5057.342545469139, 5133.12736834739, 5219.164933610604, 91955.5402222998, 94962.52518737363, 97433.5128324368, 98715.50642246743, 98762.06189690487, 66781.66609166923, 87228.0, 87471.0, 88198.55900720456, 89588.5520572406, 64347.0, 73849.67676454573, 73944.99999999892, 76781.61609191919, 76872.0, 10759.246852720235, 10838.620648277272, 10952.0, 11236.66290011301, 11361.0, 32380.83809580937, 33453.0, 33510.156941368456, 34115.31769364649, 34790.30419391547, 43034.63114065127, 43782.029808659325, 43819.0, 44427.11145777131, 44516.0, 16207.432739854048, 16212.594685132966, 16213.67572648564, 16249.918750406172, 16589.419370321983, 17770.822291776916, 17825.0, 18498.445046648623, 18504.907475462536, 18684.25262989465, 16726.33094676248, 17073.914630426767, 17108.315667373165, 17159.056251906266, 17557.297708091533, 15804.68390632158, 16193.02841829494, 16494.25775840066, 16512.174391280627, 16516.256768445208, 13934.372953216927, 14663.780043299146, 14899.925500372428, 15002.324895379516, 15156.469523567062, 10055.949720251352, 10262.332948358333, 10351.534180962026, 10382.42896640692, 10499.0, 12074.399122369812, 12480.812787808009, 12488.060661585318, 12739.299338536099, 12908.741825163632], "value": 8268.65468197149, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 107.0, 108.0, 106.0, 113.0, 109.0, 109.0, 110.0, 110.0, 111.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 119.0, 149.0, 168.0, 128.0, 148.0, 152.0, 122.0, 172.0, 126.0], "value": 143.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 164.0, 162.0, 162.0, 172.0, 161.0, 164.0, 164.0, 164.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 75.0, 158.0, 75.0, 74.0, 74.0, 75.0, 99.0, 73.0], "value": 85.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 135.0, 82.0, 82.0, 92.0, 148.0, 83.0, 82.0, 134.0], "value": 100.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 114.0, 114.0, 113.0, 114.0, 114.0, 113.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 149.0, 150.0, 150.0, 149.0, 150.0, 150.0, 149.0, 152.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 60.0, 52.0, 56.0, 53.0, 56.0, 53.0, 53.0, 53.0, 53.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 53.0, 53.0, 53.0, 53.0, 52.0, 53.0, 53.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 77.0, 78.0, 77.0, 77.0, 77.0, 83.0, 77.0, 77.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 133.0, 128.0, 130.0, 129.0, 130.0, 128.0, 126.0, 130.0, 165.0], "value": 134.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 187.0, 190.0, 199.0, 186.0, 182.0, 182.0, 189.0, 183.0, 189.0], "value": 187.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 68.0, 68.0, 69.0, 67.0, 77.0, 71.0, 72.0, 68.0, 67.0], "value": 70.0, "unit": "score"}]}]} 09:50:44 INFO - Return code: 0 09:50:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:50:44 INFO - # TBPL SUCCESS # 09:50:44 INFO - Running post-action listener: _resource_record_post_action 09:50:44 INFO - [mozharness: 2017-06-24 16:50:44.886961Z] Finished run-tests step (success) 09:50:44 INFO - Running post-run listener: _resource_record_post_run 09:50:44 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 434225152; Read time: 20; Write time: 294832 09:50:44 INFO - TinderboxPrint: CPU usage
13.2% 09:50:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 09:50:44 INFO - TinderboxPrint: I/O write bytes / time
434,225,152 / 294,832 09:50:44 INFO - TinderboxPrint: CPU idle
8,289.2 (86.8%) 09:50:44 INFO - TinderboxPrint: CPU user
1,210.3 (12.7%) 09:50:44 INFO - TinderboxPrint: Swap in / out
0 / 0 09:50:44 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 105369600; Read time: 0; Write time: 94756 09:50:44 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:50:44 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 328855552; Read time: 0; Write time: 200076 09:50:45 INFO - Running post-run listener: _upload_blobber_files 09:50:45 INFO - Blob upload gear active. 09:50:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:50:45 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:50:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:50:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:50:45 INFO - (blobuploader) - INFO - Open directory for files ... 09:50:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:50:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:50:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:46 INFO - (blobuploader) - INFO - Done attempting. 09:50:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:50:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:50:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:49 INFO - (blobuploader) - INFO - Done attempting. 09:50:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:50:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:50:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:50 INFO - (blobuploader) - INFO - Done attempting. 09:50:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:50:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:50:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:51 INFO - (blobuploader) - INFO - Done attempting. 09:50:51 INFO - (blobuploader) - INFO - Iteration through files over. 09:50:51 INFO - Return code: 0 09:50:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:50:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:50:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43c0539ebcad41a7023cdbdcc40b90506ad340bc1c42d127d0ec03c76b75d541a42dc4f253702e27620a69d9f8caeceabada280a0440163673bc2b5125e2f27b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60e6872a4f980f0f34d78fe4a1bc355847ea1598e5982d3eca8b2a6129b254db93133808df76d51919b04d2adbc7e18e1a1347951db344664e50acd4644bf223", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/826c4ab80524f6d954057a74e18e7bbc464a1aeb93f71fba6d7780ca10ecfb58806c84878bb5712aff09d13e9ad8feed07c18995283400420ee2a71e4660cd60", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a1c1ad7b45c6d1c1d2212ced336b85ee005dc9d9953a267d9457039e6b7ba58e72064210e2264ef1252948056a36f23f06fbea7b4fa2b39ad832052e8e46985"} 09:50:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:50:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:50:51 INFO - Contents: 09:50:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43c0539ebcad41a7023cdbdcc40b90506ad340bc1c42d127d0ec03c76b75d541a42dc4f253702e27620a69d9f8caeceabada280a0440163673bc2b5125e2f27b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60e6872a4f980f0f34d78fe4a1bc355847ea1598e5982d3eca8b2a6129b254db93133808df76d51919b04d2adbc7e18e1a1347951db344664e50acd4644bf223", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/826c4ab80524f6d954057a74e18e7bbc464a1aeb93f71fba6d7780ca10ecfb58806c84878bb5712aff09d13e9ad8feed07c18995283400420ee2a71e4660cd60", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a1c1ad7b45c6d1c1d2212ced336b85ee005dc9d9953a267d9457039e6b7ba58e72064210e2264ef1252948056a36f23f06fbea7b4fa2b39ad832052e8e46985"} 09:50:51 INFO - Running post-run listener: copy_logs_to_upload_dir 09:50:51 INFO - Copying logs to upload dir... 09:50:51 INFO - mkdir: /builds/slave/test/build/upload/logs 09:50:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.364567 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-06-24 09:50:50.484720) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-24 09:50:50.492153) ========= 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=4300f881736b422476174874000001bc-1498300844.368157-1155967031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43c0539ebcad41a7023cdbdcc40b90506ad340bc1c42d127d0ec03c76b75d541a42dc4f253702e27620a69d9f8caeceabada280a0440163673bc2b5125e2f27b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60e6872a4f980f0f34d78fe4a1bc355847ea1598e5982d3eca8b2a6129b254db93133808df76d51919b04d2adbc7e18e1a1347951db344664e50acd4644bf223", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/826c4ab80524f6d954057a74e18e7bbc464a1aeb93f71fba6d7780ca10ecfb58806c84878bb5712aff09d13e9ad8feed07c18995283400420ee2a71e4660cd60", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a1c1ad7b45c6d1c1d2212ced336b85ee005dc9d9953a267d9457039e6b7ba58e72064210e2264ef1252948056a36f23f06fbea7b4fa2b39ad832052e8e46985"} build_url:https://queue.taskcluster.net/v1/task/Yq6gCsErSKaHBZsfIUVQ6w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011397 build_url: 'https://queue.taskcluster.net/v1/task/Yq6gCsErSKaHBZsfIUVQ6w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43c0539ebcad41a7023cdbdcc40b90506ad340bc1c42d127d0ec03c76b75d541a42dc4f253702e27620a69d9f8caeceabada280a0440163673bc2b5125e2f27b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60e6872a4f980f0f34d78fe4a1bc355847ea1598e5982d3eca8b2a6129b254db93133808df76d51919b04d2adbc7e18e1a1347951db344664e50acd4644bf223", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/826c4ab80524f6d954057a74e18e7bbc464a1aeb93f71fba6d7780ca10ecfb58806c84878bb5712aff09d13e9ad8feed07c18995283400420ee2a71e4660cd60", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a1c1ad7b45c6d1c1d2212ced336b85ee005dc9d9953a267d9457039e6b7ba58e72064210e2264ef1252948056a36f23f06fbea7b4fa2b39ad832052e8e46985"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-24 09:50:50.518864) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-24 09:50:50.519203) ========= 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=4300f881736b422476174874000001bc-1498300844.368157-1155967031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-24 09:50:50.600561) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-24 09:50:50.603892) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-24 09:50:50.604176) ========= ========= Total master_lag: 0.24 =========